{"level":"warn","ts":"2026-03-14T01:25:13.99671Z","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-14T01:25:13.996792Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.140: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://162.253.55.140:2380","--initial-cluster=instance=https://162.253.55.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.140: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-14T01:25:13.996852Z","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-14T01:25:13.99686Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]}
{"level":"info","ts":"2026-03-14T01:25:13.996876Z","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-14T01:25:13.997566Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"]}
{"level":"info","ts":"2026-03-14T01:25:13.997645Z","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://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.140: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-14T01:25:14.003198Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.186813ms"}
{"level":"info","ts":"2026-03-14T01:25:14.009948Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"}
{"level":"info","ts":"2026-03-14T01:25:14.010027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-14T01:25:14.010053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"}
{"level":"info","ts":"2026-03-14T01:25:14.010389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf809824ab95ac81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-14T01:25:14.010398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"}
{"level":"info","ts":"2026-03-14T01:25:14.010437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"}
{"level":"warn","ts":"2026-03-14T01:25:14.027235Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-14T01:25:14.02888Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-14T01:25:14.030851Z","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-14T01:25:14.033282Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf809824ab95ac81","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-14T01:25:14.033498Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf809824ab95ac81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-14T01:25:14.033669Z","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-14T01:25:14.033929Z","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-14T01:25:14.034051Z","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-14T01:25:14.038359Z","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-14T01:25:14.038582Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"}
{"level":"info","ts":"2026-03-14T01:25:14.038727Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"}
{"level":"info","ts":"2026-03-14T01:25:14.03875Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf809824ab95ac81","initial-advertise-peer-urls":["https://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-14T01:25:14.038816Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-14T01:25:14.039219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"}
{"level":"info","ts":"2026-03-14T01:25:14.039374Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","added-peer-id":"cf809824ab95ac81","added-peer-peer-urls":["https://162.253.55.140:2380"]}
{"level":"info","ts":"2026-03-14T01:25:14.511261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-14T01:25:14.511329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-14T01:25:14.511368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"}
{"level":"info","ts":"2026-03-14T01:25:14.511397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"}
{"level":"info","ts":"2026-03-14T01:25:14.511408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"}
{"level":"info","ts":"2026-03-14T01:25:14.511429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"}
{"level":"info","ts":"2026-03-14T01:25:14.511443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"}
{"level":"info","ts":"2026-03-14T01:25:14.512787Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf809824ab95ac81","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.140:2379]}","request-path":"/0/members/cf809824ab95ac81/attributes","cluster-id":"6f89f5fbef18dc61","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-14T01:25:14.51307Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-14T01:25:14.513213Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-14T01:25:14.513226Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:25:14.514191Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-14T01:25:14.514306Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-14T01:25:14.515747Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:25:14.51593Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:25:14.515976Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:25:14.516967Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"}
{"level":"info","ts":"2026-03-14T01:25:14.517926Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-03-14T01:25:19.444417Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388975130156292,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-14T01:25:19.945538Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388975130156292,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-14T01:25:20.446184Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388975130156292,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-14T01:25:20.947188Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388975130156292,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-14T01:25:21.268477Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.38973926s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-14T01:25:21.268995Z","caller":"traceutil/trace.go:171","msg":"trace[1705774711] linearizableReadLoop","detail":"{readStateIndex:221; appliedIndex:220; }","duration":"2.32563188s","start":"2026-03-14T01:25:18.943337Z","end":"2026-03-14T01:25:21.268969Z","steps":["trace[1705774711] 'read index received'  (duration: 2.325329508s)","trace[1705774711] 'applied index is now lower than readState.Index'  (duration: 301.232µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:25:21.269078Z","caller":"traceutil/trace.go:171","msg":"trace[854148107] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"2.390456855s","start":"2026-03-14T01:25:18.878582Z","end":"2026-03-14T01:25:21.269039Z","steps":["trace[854148107] 'process raft request'  (duration: 2.390230573s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:21.269171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.325822482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:25:21.269241Z","caller":"traceutil/trace.go:171","msg":"trace[1201850816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:216; }","duration":"2.325979143s","start":"2026-03-14T01:25:18.94325Z","end":"2026-03-14T01:25:21.269229Z","steps":["trace[1201850816] 'agreement among raft nodes before linearized reading'  (duration: 2.325868822s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:21.269277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:18.943216Z","time spent":"2.326052693s","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-14T01:25:21.269588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.892332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:25:21.269658Z","caller":"traceutil/trace.go:171","msg":"trace[1359090915] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:216; }","duration":"914.009053ms","start":"2026-03-14T01:25:20.355629Z","end":"2026-03-14T01:25:21.269638Z","steps":["trace[1359090915] 'agreement among raft nodes before linearized reading'  (duration: 913.890762ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:21.269721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:20.355611Z","time spent":"914.100103ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-14T01:25:21.269852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.272657137s","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-14T01:25:21.269913Z","caller":"traceutil/trace.go:171","msg":"trace[1391501159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:216; }","duration":"1.272780167s","start":"2026-03-14T01:25:19.997114Z","end":"2026-03-14T01:25:21.269894Z","steps":["trace[1391501159] 'agreement among raft nodes before linearized reading'  (duration: 1.272374815s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:21.269952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:19.997095Z","time spent":"1.272849037s","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-14T01:25:21.270017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.264284975s","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-14T01:25:21.270226Z","caller":"traceutil/trace.go:171","msg":"trace[167818947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:216; }","duration":"1.264625997s","start":"2026-03-14T01:25:20.005539Z","end":"2026-03-14T01:25:21.270165Z","steps":["trace[167818947] 'agreement among raft nodes before linearized reading'  (duration: 1.264011033s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:21.270379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:20.005528Z","time spent":"1.264811558s","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-14T01:25:21.270684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:18.878554Z","time spent":"2.390613826s","remote":"127.0.0.1:33006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:211 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3969 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-14T01:25:22.128115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.249467ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388975130156296 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:25:22.128236Z","caller":"traceutil/trace.go:171","msg":"trace[1687936383] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"854.58337ms","start":"2026-03-14T01:25:21.273619Z","end":"2026-03-14T01:25:22.128202Z","steps":["trace[1687936383] 'process raft request'  (duration: 290.029781ms)","trace[1687936383] 'compare'  (duration: 564.059546ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:25:22.128372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:21.273596Z","time spent":"854.71042ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<>"}
{"level":"info","ts":"2026-03-14T01:25:22.128449Z","caller":"traceutil/trace.go:171","msg":"trace[1982459074] transaction","detail":"{read_only:false; response_revision:220; number_of_response:1; }","duration":"853.356372ms","start":"2026-03-14T01:25:21.275073Z","end":"2026-03-14T01:25:22.12843Z","steps":["trace[1982459074] 'process raft request'  (duration: 853.320192ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:22.128546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:21.275062Z","time spent":"853.438013ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:210 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-14T01:25:22.128487Z","caller":"traceutil/trace.go:171","msg":"trace[1483196683] linearizableReadLoop","detail":"{readStateIndex:222; appliedIndex:221; }","duration":"853.840196ms","start":"2026-03-14T01:25:21.274563Z","end":"2026-03-14T01:25:22.128403Z","steps":["trace[1483196683] 'read index received'  (duration: 290.296693ms)","trace[1483196683] 'applied index is now lower than readState.Index'  (duration: 563.532113ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:25:22.128766Z","caller":"traceutil/trace.go:171","msg":"trace[320050178] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"853.933596ms","start":"2026-03-14T01:25:21.274823Z","end":"2026-03-14T01:25:22.128756Z","steps":["trace[320050178] 'process raft request'  (duration: 853.389252ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:22.128814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:21.2748Z","time spent":"853.994616ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<>"}
{"level":"info","ts":"2026-03-14T01:25:22.128892Z","caller":"traceutil/trace.go:171","msg":"trace[1258659080] transaction","detail":"{read_only:false; response_revision:219; number_of_response:1; }","duration":"853.942557ms","start":"2026-03-14T01:25:21.274943Z","end":"2026-03-14T01:25:22.128885Z","steps":["trace[1258659080] 'process raft request'  (duration: 853.399683ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:22.128885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.269669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-38egql\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:25:22.12894Z","caller":"traceutil/trace.go:171","msg":"trace[1605415325] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-38egql; range_end:; response_count:0; response_revision:220; }","duration":"854.39073ms","start":"2026-03-14T01:25:21.274534Z","end":"2026-03-14T01:25:22.128925Z","steps":["trace[1605415325] 'agreement among raft nodes before linearized reading'  (duration: 854.111827ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:22.12894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:21.274932Z","time spent":"853.984407ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:209 > 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-14T01:25:22.129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:21.27452Z","time spent":"854.46863ms","remote":"127.0.0.1:32946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-38egql\" "}
{"level":"warn","ts":"2026-03-14T01:25:22.681168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.249119ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388975130156300 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:25:22.681507Z","caller":"traceutil/trace.go:171","msg":"trace[553020381] linearizableReadLoop","detail":"{readStateIndex:226; appliedIndex:225; }","duration":"548.412437ms","start":"2026-03-14T01:25:22.133046Z","end":"2026-03-14T01:25:22.681458Z","steps":["trace[553020381] 'read index received'  (duration: 156.845897ms)","trace[553020381] 'applied index is now lower than readState.Index'  (duration: 391.56374ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:25:22.681522Z","caller":"traceutil/trace.go:171","msg":"trace[305047119] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"752.050773ms","start":"2026-03-14T01:25:21.929416Z","end":"2026-03-14T01:25:22.681467Z","steps":["trace[305047119] 'process raft request'  (duration: 360.418222ms)","trace[305047119] 'compare'  (duration: 390.930807ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:25:22.68176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:22.134155Z","time spent":"547.601654ms","remote":"127.0.0.1:32932","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-14T01:25:22.681865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:21.929383Z","time spent":"752.344735ms","remote":"127.0.0.1:33012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>"}
{"level":"warn","ts":"2026-03-14T01:25:22.682003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.74278ms","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-14T01:25:22.682152Z","caller":"traceutil/trace.go:171","msg":"trace[1858349878] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:221; }","duration":"549.075491ms","start":"2026-03-14T01:25:22.133003Z","end":"2026-03-14T01:25:22.682078Z","steps":["trace[1858349878] 'agreement among raft nodes before linearized reading'  (duration: 548.552598ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:22.682282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:22.132985Z","time spent":"549.230622ms","remote":"127.0.0.1:33048","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-03-14T01:25:22.68239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.952805ms","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-14T01:25:22.682501Z","caller":"traceutil/trace.go:171","msg":"trace[1349039382] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:223; }","duration":"548.112366ms","start":"2026-03-14T01:25:22.134365Z","end":"2026-03-14T01:25:22.682477Z","steps":["trace[1349039382] 'agreement among raft nodes before linearized reading'  (duration: 547.820724ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:22.682564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:22.134357Z","time spent":"548.197496ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-14T01:25:22.682571Z","caller":"traceutil/trace.go:171","msg":"trace[637319250] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"502.341567ms","start":"2026-03-14T01:25:22.180208Z","end":"2026-03-14T01:25:22.682549Z","steps":["trace[637319250] 'process raft request'  (duration: 501.838964ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:22.6827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:22.180188Z","time spent":"502.435707ms","remote":"127.0.0.1:33012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3917 >> failure:<>"}
{"level":"info","ts":"2026-03-14T01:25:22.683046Z","caller":"traceutil/trace.go:171","msg":"trace[98151618] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"547.968405ms","start":"2026-03-14T01:25:22.13506Z","end":"2026-03-14T01:25:22.683028Z","steps":["trace[98151618] 'process raft request'  (duration: 546.329025ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:22.683143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:22.135049Z","time spent":"548.062366ms","remote":"127.0.0.1:32946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/kube-system/bootstrap-token-38egql\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/kube-system/bootstrap-token-38egql\" value_size:617 >> failure:<>"}
{"level":"warn","ts":"2026-03-14T01:25:22.683488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.947511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:25:22.683533Z","caller":"traceutil/trace.go:171","msg":"trace[1396267557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:223; }","duration":"549.025981ms","start":"2026-03-14T01:25:22.134495Z","end":"2026-03-14T01:25:22.683521Z","steps":["trace[1396267557] 'agreement among raft nodes before linearized reading'  (duration: 548.954161ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:22.683566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:22.134478Z","time spent":"549.081251ms","remote":"127.0.0.1:32854","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-03-14T01:25:23.547025Z","caller":"traceutil/trace.go:171","msg":"trace[276320850] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"250.638871ms","start":"2026-03-14T01:25:23.296356Z","end":"2026-03-14T01:25:23.546995Z","steps":["trace[276320850] 'process raft request'  (duration: 241.462675ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:46.815376Z","caller":"traceutil/trace.go:171","msg":"trace[735392675] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"109.453431ms","start":"2026-03-14T01:25:46.705652Z","end":"2026-03-14T01:25:46.815105Z","steps":["trace[735392675] 'process raft request'  (duration: 109.239584ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:48.284045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:47.62207Z","time spent":"661.9649ms","remote":"127.0.0.1:32884","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-14T01:25:48.80042Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388975130156929,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-14T01:25:49.811536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.744982ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388975130156930 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.140\" mod_revision:463 > success:<request_put:<key:\"/registry/masterleases/162.253.55.140\" value_size:67 lease:3207016938275381118 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.140\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:25:49.812005Z","caller":"traceutil/trace.go:171","msg":"trace[963359979] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:542; }","duration":"1.511700861s","start":"2026-03-14T01:25:48.300285Z","end":"2026-03-14T01:25:49.811986Z","steps":["trace[963359979] 'read index received'  (duration: 958.393721ms)","trace[963359979] 'applied index is now lower than readState.Index'  (duration: 553.30605ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:25:49.812245Z","caller":"traceutil/trace.go:171","msg":"trace[1997760930] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"1.524167445s","start":"2026-03-14T01:25:48.288064Z","end":"2026-03-14T01:25:49.812231Z","steps":["trace[1997760930] 'process raft request'  (duration: 1.523645937s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:49.812429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:48.288036Z","time spent":"1.524284429s","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:516 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-14T01:25:49.812416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.512115535s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"}
{"level":"info","ts":"2026-03-14T01:25:49.812461Z","caller":"traceutil/trace.go:171","msg":"trace[2145015424] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"1.523228223s","start":"2026-03-14T01:25:48.289174Z","end":"2026-03-14T01:25:49.812402Z","steps":["trace[2145015424] 'process raft request'  (duration: 1.522771817s)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:49.812498Z","caller":"traceutil/trace.go:171","msg":"trace[166148201] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:523; }","duration":"1.51224945s","start":"2026-03-14T01:25:48.300231Z","end":"2026-03-14T01:25:49.81248Z","steps":["trace[166148201] 'agreement among raft nodes before linearized reading'  (duration: 1.512097855s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:49.812503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221927712s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-14T01:25:49.812539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:48.300215Z","time spent":"1.512317022s","remote":"127.0.0.1:33006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4398,"request content":"key:\"/registry/minions/instance\" "}
{"level":"info","ts":"2026-03-14T01:25:49.812561Z","caller":"traceutil/trace.go:171","msg":"trace[879702796] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"1.221995774s","start":"2026-03-14T01:25:48.590537Z","end":"2026-03-14T01:25:49.812532Z","steps":["trace[879702796] 'agreement among raft nodes before linearized reading'  (duration: 1.221915881s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:49.812586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:48.590521Z","time spent":"1.222060286s","remote":"127.0.0.1:32854","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-03-14T01:25:49.812603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:48.289148Z","time spent":"1.523375668s","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:517 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-14T01:25:49.812748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.187091ms","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-14T01:25:49.812781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.031561ms","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-14T01:25:49.813Z","caller":"traceutil/trace.go:171","msg":"trace[1305286063] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:523; }","duration":"957.432908ms","start":"2026-03-14T01:25:48.855474Z","end":"2026-03-14T01:25:49.812907Z","steps":["trace[1305286063] 'agreement among raft nodes before linearized reading'  (duration: 957.022685ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:49.81304Z","caller":"traceutil/trace.go:171","msg":"trace[1461579831] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:523; }","duration":"961.32153ms","start":"2026-03-14T01:25:48.851697Z","end":"2026-03-14T01:25:49.813019Z","steps":["trace[1461579831] 'agreement among raft nodes before linearized reading'  (duration: 961.00131ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:49.81243Z","caller":"traceutil/trace.go:171","msg":"trace[1506083779] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"1.52666323s","start":"2026-03-14T01:25:48.285743Z","end":"2026-03-14T01:25:49.812406Z","steps":["trace[1506083779] 'process raft request'  (duration: 972.918574ms)","trace[1506083779] 'compare'  (duration: 552.473873ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:25:49.813085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:48.855444Z","time spent":"957.627495ms","remote":"127.0.0.1:33048","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-03-14T01:25:49.813156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:48.285725Z","time spent":"1.527379083s","remote":"127.0.0.1:32884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.140\" mod_revision:463 > success:<request_put:<key:\"/registry/masterleases/162.253.55.140\" value_size:67 lease:3207016938275381118 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.140\" > >"}
{"level":"warn","ts":"2026-03-14T01:25:49.813105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:48.851669Z","time spent":"961.421103ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-14T01:25:50.319757Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388975130156937,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-14T01:25:50.572545Z","caller":"traceutil/trace.go:171","msg":"trace[1289831665] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"754.482713ms","start":"2026-03-14T01:25:49.818038Z","end":"2026-03-14T01:25:50.572521Z","steps":["trace[1289831665] 'process raft request'  (duration: 754.324988ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:50.572798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:49.81801Z","time spent":"754.69989ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:520 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-14T01:25:50.644681Z","caller":"traceutil/trace.go:171","msg":"trace[684221775] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"825.723243ms","start":"2026-03-14T01:25:49.818943Z","end":"2026-03-14T01:25:50.644667Z","steps":["trace[684221775] 'process raft request'  (duration: 825.543277ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:50.64477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:49.818925Z","time spent":"825.802696ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:519 > 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-14T01:25:50.644809Z","caller":"traceutil/trace.go:171","msg":"trace[443039968] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:545; }","duration":"825.722423ms","start":"2026-03-14T01:25:49.819057Z","end":"2026-03-14T01:25:50.64478Z","steps":["trace[443039968] 'read index received'  (duration: 753.290653ms)","trace[443039968] 'applied index is now lower than readState.Index'  (duration: 72.4299ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:25:50.644915Z","caller":"traceutil/trace.go:171","msg":"trace[1865942644] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"823.522099ms","start":"2026-03-14T01:25:49.821356Z","end":"2026-03-14T01:25:50.644878Z","steps":["trace[1865942644] 'process raft request'  (duration: 823.26342ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:50.644983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.792137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:25:50.645019Z","caller":"traceutil/trace.go:171","msg":"trace[1707062370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:526; }","duration":"823.87004ms","start":"2026-03-14T01:25:49.821138Z","end":"2026-03-14T01:25:50.645008Z","steps":["trace[1707062370] 'agreement among raft nodes before linearized reading'  (duration: 823.792358ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:50.644996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.935309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-03-14T01:25:50.645054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:49.821126Z","time spent":"823.920412ms","remote":"127.0.0.1:32854","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-03-14T01:25:50.645061Z","caller":"traceutil/trace.go:171","msg":"trace[1700198513] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:526; }","duration":"826.049333ms","start":"2026-03-14T01:25:49.818996Z","end":"2026-03-14T01:25:50.645046Z","steps":["trace[1700198513] 'agreement among raft nodes before linearized reading'  (duration: 825.921499ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:50.645104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:49.818949Z","time spent":"826.141158ms","remote":"127.0.0.1:33052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"warn","ts":"2026-03-14T01:25:50.645106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:49.821344Z","time spent":"823.657134ms","remote":"127.0.0.1:33006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4567,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:420 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4533 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-14T01:25:56.546581Z","caller":"traceutil/trace.go:171","msg":"trace[1554096928] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"703.879541ms","start":"2026-03-14T01:25:55.842678Z","end":"2026-03-14T01:25:56.546557Z","steps":["trace[1554096928] 'process raft request'  (duration: 703.722496ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:56.546783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:55.842663Z","time spent":"703.992124ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:555 > 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-14T01:25:56.6414Z","caller":"traceutil/trace.go:171","msg":"trace[1451429683] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"798.473756ms","start":"2026-03-14T01:25:55.842902Z","end":"2026-03-14T01:25:56.641376Z","steps":["trace[1451429683] 'process raft request'  (duration: 798.072294ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:56.64156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:55.84289Z","time spent":"798.578799ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:554 > 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-14T01:25:57.545707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.113349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zc5pv\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-03-14T01:25:57.54579Z","caller":"traceutil/trace.go:171","msg":"trace[453030822] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zc5pv; range_end:; response_count:1; response_revision:565; }","duration":"289.232692ms","start":"2026-03-14T01:25:57.256539Z","end":"2026-03-14T01:25:57.545771Z","steps":["trace[453030822] 'range keys from in-memory index tree'  (duration: 288.962443ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:57.98271Z","caller":"traceutil/trace.go:171","msg":"trace[121531613] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:588; }","duration":"391.686745ms","start":"2026-03-14T01:25:57.590998Z","end":"2026-03-14T01:25:57.982685Z","steps":["trace[121531613] 'read index received'  (duration: 391.445677ms)","trace[121531613] 'applied index is now lower than readState.Index'  (duration: 240.158µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:25:57.98284Z","caller":"traceutil/trace.go:171","msg":"trace[1902318074] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"421.158426ms","start":"2026-03-14T01:25:57.561671Z","end":"2026-03-14T01:25:57.98283Z","steps":["trace[1902318074] 'process raft request'  (duration: 420.866997ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:57.98295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:57.561638Z","time spent":"421.231628ms","remote":"127.0.0.1:33012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-zc5pv\" mod_revision:512 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-zc5pv\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-zc5pv\" > >"}
{"level":"warn","ts":"2026-03-14T01:25:57.983078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.073816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:25:57.983144Z","caller":"traceutil/trace.go:171","msg":"trace[86400574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"392.19343ms","start":"2026-03-14T01:25:57.590936Z","end":"2026-03-14T01:25:57.983129Z","steps":["trace[86400574] 'agreement among raft nodes before linearized reading'  (duration: 392.096427ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:57.983174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:57.590909Z","time spent":"392.260672ms","remote":"127.0.0.1:32854","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-03-14T01:25:57.983176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.081218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-14T01:25:57.983268Z","caller":"traceutil/trace.go:171","msg":"trace[15562603] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:566; }","duration":"361.226123ms","start":"2026-03-14T01:25:57.622023Z","end":"2026-03-14T01:25:57.983249Z","steps":["trace[15562603] 'agreement among raft nodes before linearized reading'  (duration: 361.030658ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:57.983321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:57.622011Z","time spent":"361.301176ms","remote":"127.0.0.1:32884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.140\" "}
{"level":"warn","ts":"2026-03-14T01:25:58.798238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.844782ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388975130157025 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:2c819ce9f2909fe0>","response":"size:40"}
{"level":"info","ts":"2026-03-14T01:25:58.798399Z","caller":"traceutil/trace.go:171","msg":"trace[321696342] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:589; }","duration":"246.169041ms","start":"2026-03-14T01:25:58.552209Z","end":"2026-03-14T01:25:58.798378Z","steps":["trace[321696342] 'read index received'  (duration: 75.892µs)","trace[321696342] 'applied index is now lower than readState.Index'  (duration: 246.091529ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:25:58.798488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:57.984293Z","time spent":"814.190907ms","remote":"127.0.0.1:32884","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-14T01:25:58.798737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.524941ms","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-14T01:25:58.798769Z","caller":"traceutil/trace.go:171","msg":"trace[1637475858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:566; }","duration":"246.609104ms","start":"2026-03-14T01:25:58.552148Z","end":"2026-03-14T01:25:58.798757Z","steps":["trace[1637475858] 'agreement among raft nodes before linearized reading'  (duration: 246.523462ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:58.799261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.261102ms","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-14T01:25:58.799382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.741912ms","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-14T01:25:58.799409Z","caller":"traceutil/trace.go:171","msg":"trace[825635836] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:566; }","duration":"153.490129ms","start":"2026-03-14T01:25:58.645886Z","end":"2026-03-14T01:25:58.799376Z","steps":["trace[825635836] 'agreement among raft nodes before linearized reading'  (duration: 153.146519ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:58.79943Z","caller":"traceutil/trace.go:171","msg":"trace[39895139] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:566; }","duration":"130.863555ms","start":"2026-03-14T01:25:58.668553Z","end":"2026-03-14T01:25:58.799416Z","steps":["trace[39895139] 'agreement among raft nodes before linearized reading'  (duration: 130.667699ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:59.435555Z","caller":"traceutil/trace.go:171","msg":"trace[862588570] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"634.801512ms","start":"2026-03-14T01:25:58.800724Z","end":"2026-03-14T01:25:59.435526Z","steps":["trace[862588570] 'process raft request'  (duration: 618.969658ms)","trace[862588570] 'compare'  (duration: 15.707991ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:25:59.435937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:58.800707Z","time spent":"635.143053ms","remote":"127.0.0.1:32884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.140\" mod_revision:521 > success:<request_put:<key:\"/registry/masterleases/162.253.55.140\" value_size:67 lease:3207016938275381216 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.140\" > >"}
{"level":"info","ts":"2026-03-14T01:25:59.439282Z","caller":"traceutil/trace.go:171","msg":"trace[863754869] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"634.721668ms","start":"2026-03-14T01:25:58.804543Z","end":"2026-03-14T01:25:59.439265Z","steps":["trace[863754869] 'process raft request'  (duration: 634.657417ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:59.439299Z","caller":"traceutil/trace.go:171","msg":"trace[1784513512] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"635.237004ms","start":"2026-03-14T01:25:58.804031Z","end":"2026-03-14T01:25:59.439268Z","steps":["trace[1784513512] 'process raft request'  (duration: 635.012897ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:59.439377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:58.804523Z","time spent":"634.80878ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:558 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-14T01:25:59.439441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:58.804016Z","time spent":"635.345666ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:562 > 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-14T01:25:59.439383Z","caller":"traceutil/trace.go:171","msg":"trace[1120306004] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"635.208172ms","start":"2026-03-14T01:25:58.804155Z","end":"2026-03-14T01:25:59.439363Z","steps":["trace[1120306004] 'process raft request'  (duration: 635.010997ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:59.440552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:58.80413Z","time spent":"636.362027ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:559 > 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-14T01:25:59.439699Z","caller":"traceutil/trace.go:171","msg":"trace[317087003] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"634.929865ms","start":"2026-03-14T01:25:58.804746Z","end":"2026-03-14T01:25:59.439675Z","steps":["trace[317087003] 'process raft request'  (duration: 634.486891ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:59.440824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:58.804724Z","time spent":"635.970785ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:560 > 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-14T01:26:00.76886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.191276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:26:00.769429Z","caller":"traceutil/trace.go:171","msg":"trace[1384015703] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"179.812425ms","start":"2026-03-14T01:26:00.58959Z","end":"2026-03-14T01:26:00.769402Z","steps":["trace[1384015703] 'range keys from in-memory index tree'  (duration: 179.099143ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:26:01.664727Z","caller":"traceutil/trace.go:171","msg":"trace[692947366] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"213.020196ms","start":"2026-03-14T01:26:01.451685Z","end":"2026-03-14T01:26:01.664705Z","steps":["trace[692947366] 'process raft request'  (duration: 212.670376ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:26:01.664854Z","caller":"traceutil/trace.go:171","msg":"trace[1771337920] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"212.778989ms","start":"2026-03-14T01:26:01.452045Z","end":"2026-03-14T01:26:01.664824Z","steps":["trace[1771337920] 'process raft request'  (duration: 212.374068ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:26:01.664974Z","caller":"traceutil/trace.go:171","msg":"trace[1091015162] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"215.747206ms","start":"2026-03-14T01:26:01.449198Z","end":"2026-03-14T01:26:01.664945Z","steps":["trace[1091015162] 'process raft request'  (duration: 214.942302ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:26:52.106417Z","caller":"traceutil/trace.go:171","msg":"trace[580903610] linearizableReadLoop","detail":"{readStateIndex:898; appliedIndex:897; }","duration":"181.24366ms","start":"2026-03-14T01:26:51.925143Z","end":"2026-03-14T01:26:52.106387Z","steps":["trace[580903610] 'read index received'  (duration: 181.23223ms)","trace[580903610] 'applied index is now lower than readState.Index'  (duration: 9.65µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:26:52.106422Z","caller":"traceutil/trace.go:171","msg":"trace[247989173] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"186.488744ms","start":"2026-03-14T01:26:51.919907Z","end":"2026-03-14T01:26:52.106396Z","steps":["trace[247989173] 'process raft request'  (duration: 186.367152ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:52.106619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.460033ms","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-14T01:26:52.106678Z","caller":"traceutil/trace.go:171","msg":"trace[454799716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:863; }","duration":"181.558306ms","start":"2026-03-14T01:26:51.925109Z","end":"2026-03-14T01:26:52.106667Z","steps":["trace[454799716] 'agreement among raft nodes before linearized reading'  (duration: 181.391293ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:52.106707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.070479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5401"}
{"level":"info","ts":"2026-03-14T01:26:52.106752Z","caller":"traceutil/trace.go:171","msg":"trace[1407718148] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:863; }","duration":"180.14419ms","start":"2026-03-14T01:26:51.926596Z","end":"2026-03-14T01:26:52.10674Z","steps":["trace[1407718148] 'agreement among raft nodes before linearized reading'  (duration: 179.967527ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:26:52.211904Z","caller":"traceutil/trace.go:171","msg":"trace[1941460609] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"100.859437ms","start":"2026-03-14T01:26:52.111022Z","end":"2026-03-14T01:26:52.211881Z","steps":["trace[1941460609] 'process raft request'  (duration: 80.866631ms)","trace[1941460609] 'compare'  (duration: 19.897125ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:27:30.140721Z","caller":"traceutil/trace.go:171","msg":"trace[2077038996] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"173.025664ms","start":"2026-03-14T01:27:29.967663Z","end":"2026-03-14T01:27:30.140688Z","steps":["trace[2077038996] 'process raft request'  (duration: 106.287493ms)","trace[2077038996] 'compare'  (duration: 66.60211ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:27:32.17876Z","caller":"traceutil/trace.go:171","msg":"trace[1773723520] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"152.869703ms","start":"2026-03-14T01:27:32.025861Z","end":"2026-03-14T01:27:32.17873Z","steps":["trace[1773723520] 'process raft request'  (duration: 152.607769ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:27:32.317489Z","caller":"traceutil/trace.go:171","msg":"trace[2007472906] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"132.65614ms","start":"2026-03-14T01:27:32.184809Z","end":"2026-03-14T01:27:32.317465Z","steps":["trace[2007472906] 'process raft request'  (duration: 73.849756ms)","trace[2007472906] 'compare'  (duration: 58.676621ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:27:32.5232Z","caller":"traceutil/trace.go:171","msg":"trace[864860825] linearizableReadLoop","detail":"{readStateIndex:1058; appliedIndex:1057; }","duration":"109.485878ms","start":"2026-03-14T01:27:32.413675Z","end":"2026-03-14T01:27:32.523161Z","steps":["trace[864860825] 'read index received'  (duration: 36.457912ms)","trace[864860825] 'applied index is now lower than readState.Index'  (duration: 73.026336ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:27:32.523351Z","caller":"traceutil/trace.go:171","msg":"trace[722397588] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"162.646525ms","start":"2026-03-14T01:27:32.360627Z","end":"2026-03-14T01:27:32.523273Z","steps":["trace[722397588] 'process raft request'  (duration: 89.580869ms)","trace[722397588] 'compare'  (duration: 72.748671ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:27:32.523488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.777321ms","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-14T01:27:32.523535Z","caller":"traceutil/trace.go:171","msg":"trace[1594680968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1013; }","duration":"109.899044ms","start":"2026-03-14T01:27:32.413621Z","end":"2026-03-14T01:27:32.52352Z","steps":["trace[1594680968] 'agreement among raft nodes before linearized reading'  (duration: 109.674171ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:27:38.221427Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388975130158219,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-14T01:27:38.300542Z","caller":"traceutil/trace.go:171","msg":"trace[1588638867] linearizableReadLoop","detail":"{readStateIndex:1077; appliedIndex:1076; }","duration":"579.662752ms","start":"2026-03-14T01:27:37.720845Z","end":"2026-03-14T01:27:38.300508Z","steps":["trace[1588638867] 'read index received'  (duration: 579.261737ms)","trace[1588638867] 'applied index is now lower than readState.Index'  (duration: 398.255µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:27:38.300582Z","caller":"traceutil/trace.go:171","msg":"trace[107304053] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"582.58919ms","start":"2026-03-14T01:27:37.717948Z","end":"2026-03-14T01:27:38.300538Z","steps":["trace[107304053] 'process raft request'  (duration: 582.276756ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:27:38.300788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:27:37.717919Z","time spent":"582.756543ms","remote":"127.0.0.1:32884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.140\" mod_revision:996 > success:<request_put:<key:\"/registry/masterleases/162.253.55.140\" value_size:67 lease:3207016938275382408 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.140\" > >"}
{"level":"warn","ts":"2026-03-14T01:27:38.300803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.929625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-approver\" ","response":"range_response_count:1 size:700"}
{"level":"info","ts":"2026-03-14T01:27:38.300867Z","caller":"traceutil/trace.go:171","msg":"trace[1614481616] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-approver; range_end:; response_count:1; response_revision:1030; }","duration":"580.037677ms","start":"2026-03-14T01:27:37.720811Z","end":"2026-03-14T01:27:38.300849Z","steps":["trace[1614481616] 'agreement among raft nodes before linearized reading'  (duration: 579.865445ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:27:38.300848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.169961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver\" ","response":"range_response_count:1 size:724"}
{"level":"warn","ts":"2026-03-14T01:27:38.300904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:27:37.720797Z","time spent":"580.098408ms","remote":"127.0.0.1:33132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":1,"response size":723,"request content":"key:\"/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-approver\" "}
{"level":"info","ts":"2026-03-14T01:27:38.300936Z","caller":"traceutil/trace.go:171","msg":"trace[689216009] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver; range_end:; response_count:1; response_revision:1030; }","duration":"507.289373ms","start":"2026-03-14T01:27:37.793623Z","end":"2026-03-14T01:27:38.300913Z","steps":["trace[689216009] 'agreement among raft nodes before linearized reading'  (duration: 507.122241ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:27:38.300988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:27:37.793611Z","time spent":"507.364964ms","remote":"127.0.0.1:33132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":747,"request content":"key:\"/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver\" "}
{"level":"warn","ts":"2026-03-14T01:27:38.301249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.651515ms","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-03-14T01:27:38.301285Z","caller":"traceutil/trace.go:171","msg":"trace[128954357] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1030; }","duration":"410.743096ms","start":"2026-03-14T01:27:37.890533Z","end":"2026-03-14T01:27:38.301276Z","steps":["trace[128954357] 'agreement among raft nodes before linearized reading'  (duration: 410.602945ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:27:38.301313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:27:37.890498Z","time spent":"410.808187ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-14T01:27:38.436377Z","caller":"traceutil/trace.go:171","msg":"trace[2104422415] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"130.082137ms","start":"2026-03-14T01:27:38.306267Z","end":"2026-03-14T01:27:38.436349Z","steps":["trace[2104422415] 'process raft request'  (duration: 120.596413ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:27:38.436674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.784394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver\" ","response":"range_response_count:1 size:724"}
{"level":"info","ts":"2026-03-14T01:27:38.436751Z","caller":"traceutil/trace.go:171","msg":"trace[718365713] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver; range_end:; response_count:1; response_revision:1032; }","duration":"129.907686ms","start":"2026-03-14T01:27:38.306825Z","end":"2026-03-14T01:27:38.436733Z","steps":["trace[718365713] 'agreement among raft nodes before linearized reading'  (duration: 129.737034ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:27:40.71701Z","caller":"traceutil/trace.go:171","msg":"trace[1217427441] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"107.995264ms","start":"2026-03-14T01:27:40.608979Z","end":"2026-03-14T01:27:40.716974Z","steps":["trace[1217427441] 'process raft request'  (duration: 61.024437ms)","trace[1217427441] 'compare'  (duration: 46.657212ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:27:54.764472Z","caller":"traceutil/trace.go:171","msg":"trace[631380511] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1126; }","duration":"133.390408ms","start":"2026-03-14T01:27:54.631053Z","end":"2026-03-14T01:27:54.764443Z","steps":["trace[631380511] 'read index received'  (duration: 123.060603ms)","trace[631380511] 'applied index is now lower than readState.Index'  (duration: 10.328445ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:27:54.764478Z","caller":"traceutil/trace.go:171","msg":"trace[318408259] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"159.600433ms","start":"2026-03-14T01:27:54.604851Z","end":"2026-03-14T01:27:54.764451Z","steps":["trace[318408259] 'process raft request'  (duration: 149.375419ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:27:54.764691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.071915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:cloud-provider\" ","response":"range_response_count:1 size:625"}
{"level":"info","ts":"2026-03-14T01:27:54.764735Z","caller":"traceutil/trace.go:171","msg":"trace[268204058] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:cloud-provider; range_end:; response_count:1; response_revision:1077; }","duration":"114.160145ms","start":"2026-03-14T01:27:54.650561Z","end":"2026-03-14T01:27:54.764721Z","steps":["trace[268204058] 'agreement among raft nodes before linearized reading'  (duration: 114.052294ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:27:54.764756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.675981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:618"}
{"level":"warn","ts":"2026-03-14T01:27:54.764798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.984987ms","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-14T01:27:54.764844Z","caller":"traceutil/trace.go:171","msg":"trace[739131005] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:1077; }","duration":"133.808432ms","start":"2026-03-14T01:27:54.631011Z","end":"2026-03-14T01:27:54.764819Z","steps":["trace[739131005] 'agreement among raft nodes before linearized reading'  (duration: 133.58542ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:27:54.76488Z","caller":"traceutil/trace.go:171","msg":"trace[1993451417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1077; }","duration":"101.101578ms","start":"2026-03-14T01:27:54.663757Z","end":"2026-03-14T01:27:54.764859Z","steps":["trace[1993451417] 'agreement among raft nodes before linearized reading'  (duration: 100.892005ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:28:00.701968Z","caller":"traceutil/trace.go:171","msg":"trace[2043339392] linearizableReadLoop","detail":"{readStateIndex:1146; appliedIndex:1145; }","duration":"110.545627ms","start":"2026-03-14T01:28:00.591395Z","end":"2026-03-14T01:28:00.701941Z","steps":["trace[2043339392] 'read index received'  (duration: 24.991023ms)","trace[2043339392] 'applied index is now lower than readState.Index'  (duration: 85.553354ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:28:00.70211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.6924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:28:00.702089Z","caller":"traceutil/trace.go:171","msg":"trace[2141110942] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"134.831881ms","start":"2026-03-14T01:28:00.567213Z","end":"2026-03-14T01:28:00.702045Z","steps":["trace[2141110942] 'process raft request'  (duration: 98.03125ms)","trace[2141110942] 'compare'  (duration: 36.595849ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:28:00.702169Z","caller":"traceutil/trace.go:171","msg":"trace[607731548] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1095; }","duration":"110.789931ms","start":"2026-03-14T01:28:00.591363Z","end":"2026-03-14T01:28:00.702152Z","steps":["trace[607731548] 'agreement among raft nodes before linearized reading'  (duration: 110.679608ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:28:00.978111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.762657ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388975130159269 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1091 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:28:00.978198Z","caller":"traceutil/trace.go:171","msg":"trace[1809411606] linearizableReadLoop","detail":"{readStateIndex:1148; appliedIndex:1147; }","duration":"160.884338ms","start":"2026-03-14T01:28:00.817303Z","end":"2026-03-14T01:28:00.978188Z","steps":["trace[1809411606] 'read index received'  (duration: 10.943219ms)","trace[1809411606] 'applied index is now lower than readState.Index'  (duration: 149.940239ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:28:00.978268Z","caller":"traceutil/trace.go:171","msg":"trace[1427313321] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"182.261178ms","start":"2026-03-14T01:28:00.795964Z","end":"2026-03-14T01:28:00.978225Z","steps":["trace[1427313321] 'process raft request'  (duration: 32.314159ms)","trace[1427313321] 'compare'  (duration: 149.671386ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:28:00.9783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.995509ms","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-14T01:28:00.978321Z","caller":"traceutil/trace.go:171","msg":"trace[1105495347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1097; }","duration":"161.037069ms","start":"2026-03-14T01:28:00.817276Z","end":"2026-03-14T01:28:00.978313Z","steps":["trace[1105495347] 'agreement among raft nodes before linearized reading'  (duration: 160.938678ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:28:02.826592Z","caller":"traceutil/trace.go:171","msg":"trace[1385106690] linearizableReadLoop","detail":"{readStateIndex:1150; appliedIndex:1149; }","duration":"154.253934ms","start":"2026-03-14T01:28:02.672314Z","end":"2026-03-14T01:28:02.826568Z","steps":["trace[1385106690] 'read index received'  (duration: 154.141823ms)","trace[1385106690] 'applied index is now lower than readState.Index'  (duration: 110.651µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:28:02.82669Z","caller":"traceutil/trace.go:171","msg":"trace[640318556] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"201.452174ms","start":"2026-03-14T01:28:02.625219Z","end":"2026-03-14T01:28:02.826671Z","steps":["trace[640318556] 'process raft request'  (duration: 201.197802ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:28:02.826886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.558818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zc5pv\" ","response":"range_response_count:1 size:18525"}
{"level":"warn","ts":"2026-03-14T01:28:02.826904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.26222ms","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-14T01:28:02.82693Z","caller":"traceutil/trace.go:171","msg":"trace[484114584] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zc5pv; range_end:; response_count:1; response_revision:1099; }","duration":"154.658389ms","start":"2026-03-14T01:28:02.672259Z","end":"2026-03-14T01:28:02.826918Z","steps":["trace[484114584] 'agreement among raft nodes before linearized reading'  (duration: 154.433807ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:28:02.827015Z","caller":"traceutil/trace.go:171","msg":"trace[965810187] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1099; }","duration":"120.36363ms","start":"2026-03-14T01:28:02.70658Z","end":"2026-03-14T01:28:02.826944Z","steps":["trace[965810187] 'agreement among raft nodes before linearized reading'  (duration: 120.183068ms)"],"step_count":1}