{"level":"warn","ts":"2026-04-20T17:39:35.960432Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-20T17:39:35.960518Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250: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.250:2380","--initial-cluster=controller-1=https://199.19.213.47:2380,controller-2=https://199.204.45.250:2380","--initial-cluster-state=existing","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250:2380","--name=controller-2","--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-04-20T17:39:35.960591Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-20T17:39:35.960603Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]}
{"level":"info","ts":"2026-04-20T17:39:35.960623Z","caller":"embed/etcd.go:528","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-04-20T17:39:35.961019Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]}
{"level":"info","ts":"2026-04-20T17:39:35.961096Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.5.21","git-sha":"a17edfd","go-version":"go1.23.7","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller-2","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.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller-1=https://199.19.213.47:2380,controller-2=https://199.204.45.250:2380","initial-cluster-state":"existing","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-04-20T17:39:35.965288Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.895201ms"}
{"level":"info","ts":"2026-04-20T17:39:35.981930Z","caller":"netutil/netutil.go:112","msg":"resolved URL Host","url":"https://199.204.45.250:2380","host":"199.204.45.250:2380","resolved-addr":"199.204.45.250:2380"}
{"level":"info","ts":"2026-04-20T17:39:35.981973Z","caller":"netutil/netutil.go:112","msg":"resolved URL Host","url":"https://199.19.213.47:2380","host":"199.19.213.47:2380","resolved-addr":"199.19.213.47:2380"}
{"level":"info","ts":"2026-04-20T17:39:35.991980Z","caller":"etcdserver/raft.go:506","msg":"starting local member","local-member-id":"ba268a16d9fd836a","cluster-id":"cb5c24893c5cbfa7"}
{"level":"info","ts":"2026-04-20T17:39:35.992137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a switched to configuration voters=()"}
{"level":"info","ts":"2026-04-20T17:39:35.992212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a became follower at term 0"}
{"level":"info","ts":"2026-04-20T17:39:35.992265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba268a16d9fd836a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"warn","ts":"2026-04-20T17:39:36.000219Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-20T17:39:36.001705Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-20T17:39:36.001744Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0}
{"level":"info","ts":"2026-04-20T17:39:36.004519Z","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-04-20T17:39:36.005930Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.005953Z","caller":"rafthttp/transport.go:286","msg":"added new remote peer","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf","remote-peer-urls":["https://199.19.213.47:2380"]}
{"level":"info","ts":"2026-04-20T17:39:36.006099Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.006184Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.006732Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.012560Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.012593Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf","remote-peer-urls":["https://199.19.213.47:2380"]}
{"level":"info","ts":"2026-04-20T17:39:36.012588Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.012618Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"ba268a16d9fd836a","local-server-version":"3.5.21","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-20T17:39:36.012629Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.012627Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.012902Z","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-04-20T17:39:36.012986Z","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-04-20T17:39:36.012996Z","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-04-20T17:39:36.013124Z","caller":"etcdserver/server.go:775","msg":"starting initial election tick advance","election-ticks":10}
{"level":"info","ts":"2026-04-20T17:39:36.014346Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
{"level":"info","ts":"2026-04-20T17:39:36.017681Z","caller":"embed/etcd.go:762","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-04-20T17:39:36.018277Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"199.204.45.250:2380"}
{"level":"info","ts":"2026-04-20T17:39:36.018301Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"199.204.45.250:2380"}
{"level":"info","ts":"2026-04-20T17:39:36.018621Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"ba268a16d9fd836a","to":"944e7e1987ec6eaf","stream-type":"stream Message"}
{"level":"info","ts":"2026-04-20T17:39:36.018651Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.018667Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.018723Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"ba268a16d9fd836a","to":"944e7e1987ec6eaf","stream-type":"stream MsgApp v2"}
{"level":"info","ts":"2026-04-20T17:39:36.018773Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.019367Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"ba268a16d9fd836a","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-20T17:39:36.019418Z","caller":"embed/etcd.go:908","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-20T17:39:36.022059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a [term: 0] received a MsgHeartbeat message with higher term from 944e7e1987ec6eaf [term: 2]"}
{"level":"info","ts":"2026-04-20T17:39:36.022081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a became follower at term 2"}
{"level":"info","ts":"2026-04-20T17:39:36.022091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba268a16d9fd836a elected leader 944e7e1987ec6eaf at term 2"}
{"level":"info","ts":"2026-04-20T17:39:36.022888Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.027985Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"ba268a16d9fd836a","remote-peer-id":"944e7e1987ec6eaf"}
{"level":"info","ts":"2026-04-20T17:39:36.039832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a switched to configuration voters=(10686617613916466863)"}
{"level":"info","ts":"2026-04-20T17:39:36.039985Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cb5c24893c5cbfa7","local-member-id":"ba268a16d9fd836a","added-peer-id":"944e7e1987ec6eaf","added-peer-peer-urls":["https://199.19.213.47:2380"],"added-peer-is-learner":false}
{"level":"info","ts":"2026-04-20T17:39:36.040107Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"cb5c24893c5cbfa7","local-member-id":"ba268a16d9fd836a","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T17:39:36.040161Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T17:39:36.063585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a switched to configuration voters=(10686617613916466863) learners=(13413560370920784746)"}
{"level":"info","ts":"2026-04-20T17:39:36.063711Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cb5c24893c5cbfa7","local-member-id":"ba268a16d9fd836a","added-peer-id":"ba268a16d9fd836a","added-peer-peer-urls":["https://199.204.45.250:2380"],"added-peer-is-learner":true}
{"level":"info","ts":"2026-04-20T17:39:36.063906Z","caller":"etcdserver/server.go:2144","msg":"published local member to cluster through raft","local-member-id":"ba268a16d9fd836a","local-member-attributes":"{Name:controller-2 ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/ba268a16d9fd836a/attributes","cluster-id":"cb5c24893c5cbfa7","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-20T17:39:36.063933Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T17:39:36.064126Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T17:39:36.064478Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-20T17:39:36.064676Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-20T17:39:36.065861Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
{"level":"info","ts":"2026-04-20T17:39:36.066418Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
{"level":"info","ts":"2026-04-20T17:39:36.067652Z","caller":"embed/serve.go:275","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-20T17:39:36.068774Z","caller":"embed/serve.go:275","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"}
{"level":"info","ts":"2026-04-20T17:39:36.356948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a switched to configuration voters=(10686617613916466863 13413560370920784746)"}
{"level":"info","ts":"2026-04-20T17:39:36.357034Z","caller":"membership/cluster.go:537","msg":"promote member","cluster-id":"cb5c24893c5cbfa7","local-member-id":"ba268a16d9fd836a","promoted-member-id":"ba268a16d9fd836a"}
{"level":"warn","ts":"2026-04-20T17:40:00.724687Z","caller":"embed/config_logging.go:170","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.215:44954","server-name":"","error":"EOF"}
{"level":"info","ts":"2026-04-20T17:40:01.211071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a switched to configuration voters=(10686617613916466863 13413560370920784746) learners=(2141847962335176548)"}
{"level":"info","ts":"2026-04-20T17:40:01.211153Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cb5c24893c5cbfa7","local-member-id":"ba268a16d9fd836a","added-peer-id":"1db95f5fade1e764","added-peer-peer-urls":["https://199.19.213.215:2380"],"added-peer-is-learner":true}
{"level":"info","ts":"2026-04-20T17:40:01.211176Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:01.211193Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"ba268a16d9fd836a","remote-peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:01.212009Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"ba268a16d9fd836a","remote-peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:01.214773Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"ba268a16d9fd836a","remote-peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:01.215628Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:01.215949Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"ba268a16d9fd836a","remote-peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:01.215980Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"ba268a16d9fd836a","remote-peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:01.215972Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"ba268a16d9fd836a","remote-peer-id":"1db95f5fade1e764","remote-peer-urls":["https://199.19.213.215:2380"]}
{"level":"info","ts":"2026-04-20T17:40:01.216224Z","caller":"etcdserver/server.go:2021","msg":"applied a configuration change through raft","local-member-id":"ba268a16d9fd836a","raft-conf-change":"ConfChangeAddLearnerNode","raft-conf-change-node-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:03.105097Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"ba268a16d9fd836a","to":"1db95f5fade1e764","stream-type":"stream MsgApp v2"}
{"level":"info","ts":"2026-04-20T17:40:03.105164Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:03.105189Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"ba268a16d9fd836a","remote-peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:03.113448Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"ba268a16d9fd836a","to":"1db95f5fade1e764","stream-type":"stream Message"}
{"level":"info","ts":"2026-04-20T17:40:03.113512Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"ba268a16d9fd836a","remote-peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:03.117882Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"ba268a16d9fd836a","remote-peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:03.130131Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"ba268a16d9fd836a","remote-peer-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:03.279584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a switched to configuration voters=(2141847962335176548 10686617613916466863 13413560370920784746)"}
{"level":"info","ts":"2026-04-20T17:40:03.279698Z","caller":"membership/cluster.go:537","msg":"promote member","cluster-id":"cb5c24893c5cbfa7","local-member-id":"ba268a16d9fd836a","promoted-member-id":"1db95f5fade1e764"}
{"level":"info","ts":"2026-04-20T17:40:17.940102Z","caller":"traceutil/trace.go:171","msg":"trace[1636630604] linearizableReadLoop","detail":"{readStateIndex:719; appliedIndex:719; }","duration":"102.659839ms","start":"2026-04-20T17:40:17.837418Z","end":"2026-04-20T17:40:17.940078Z","steps":["trace[1636630604] 'read index received'  (duration: 102.654419ms)","trace[1636630604] 'applied index is now lower than readState.Index'  (duration: 4.22µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T17:40:17.940247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.81329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-20T17:40:17.940305Z","caller":"traceutil/trace.go:171","msg":"trace[1998340240] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:669; }","duration":"102.890241ms","start":"2026-04-20T17:40:17.837400Z","end":"2026-04-20T17:40:17.940290Z","steps":["trace[1998340240] 'agreement among raft nodes before linearized reading'  (duration: 102.76711ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:42.981257Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9469554528457833105,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T17:40:43.481433Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9469554528457833105,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T17:40:43.573499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a [logterm: 2, index: 900, vote: 0] cast MsgPreVote for 1db95f5fade1e764 [logterm: 2, index: 900] at term 2"}
{"level":"info","ts":"2026-04-20T17:40:43.593297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a is starting a new election at term 2"}
{"level":"info","ts":"2026-04-20T17:40:43.593400Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a became pre-candidate at term 2"}
{"level":"info","ts":"2026-04-20T17:40:43.593421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a received MsgPreVoteResp from ba268a16d9fd836a at term 2"}
{"level":"info","ts":"2026-04-20T17:40:43.593449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a [logterm: 2, index: 900] sent MsgPreVote request to 1db95f5fade1e764 at term 2"}
{"level":"info","ts":"2026-04-20T17:40:43.593465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a [logterm: 2, index: 900] sent MsgPreVote request to 944e7e1987ec6eaf at term 2"}
{"level":"info","ts":"2026-04-20T17:40:43.593481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba268a16d9fd836a lost leader 944e7e1987ec6eaf at term 2"}
{"level":"info","ts":"2026-04-20T17:40:43.672422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a became follower at term 2"}
{"level":"info","ts":"2026-04-20T17:40:43.672533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba268a16d9fd836a elected leader 944e7e1987ec6eaf at term 2"}
{"level":"warn","ts":"2026-04-20T17:40:43.672758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.191813355s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"","error":"etcdserver: leader changed"}
{"level":"info","ts":"2026-04-20T17:40:43.672870Z","caller":"traceutil/trace.go:171","msg":"trace[866396233] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; }","duration":"1.191978486s","start":"2026-04-20T17:40:42.480871Z","end":"2026-04-20T17:40:43.672849Z","steps":["trace[866396233] 'agreement among raft nodes before linearized reading'  (duration: 1.191846555s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:43.672951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:42.480854Z","time spent":"1.192083968s","remote":"127.0.0.1:47004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":0,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"info","ts":"2026-04-20T17:40:43.673896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a [logterm: 2, index: 903, vote: 0] ignored MsgVote from 1db95f5fade1e764 [logterm: 2, index: 900] at term 2: lease is not expired (remaining ticks: 10)"}
{"level":"info","ts":"2026-04-20T17:40:43.673959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a [term: 2] received a MsgPreVoteResp message with higher term from 1db95f5fade1e764 [term: 3]"}
{"level":"info","ts":"2026-04-20T17:40:43.673973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a became follower at term 3"}
{"level":"info","ts":"2026-04-20T17:40:43.673981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba268a16d9fd836a lost leader 944e7e1987ec6eaf at term 3"}
{"level":"warn","ts":"2026-04-20T17:40:44.173064Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9469554528457833106,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T17:40:44.173164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a no leader at term 3; dropping index reading msg"}
{"level":"info","ts":"2026-04-20T17:40:44.592810Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a is starting a new election at term 3"}
{"level":"info","ts":"2026-04-20T17:40:44.592892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a became pre-candidate at term 3"}
{"level":"info","ts":"2026-04-20T17:40:44.592912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a received MsgPreVoteResp from ba268a16d9fd836a at term 3"}
{"level":"info","ts":"2026-04-20T17:40:44.592936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a [logterm: 2, index: 903] sent MsgPreVote request to 1db95f5fade1e764 at term 3"}
{"level":"info","ts":"2026-04-20T17:40:44.592951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a [logterm: 2, index: 903] sent MsgPreVote request to 944e7e1987ec6eaf at term 3"}
{"level":"info","ts":"2026-04-20T17:40:44.594176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a received MsgPreVoteResp rejection from 944e7e1987ec6eaf at term 3"}
{"level":"info","ts":"2026-04-20T17:40:44.594233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a has received 1 MsgPreVoteResp votes and 1 vote rejections"}
{"level":"info","ts":"2026-04-20T17:40:44.594252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a received MsgPreVoteResp from 1db95f5fade1e764 at term 3"}
{"level":"info","ts":"2026-04-20T17:40:44.594267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a has received 2 MsgPreVoteResp votes and 1 vote rejections"}
{"level":"info","ts":"2026-04-20T17:40:44.594284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a became candidate at term 4"}
{"level":"info","ts":"2026-04-20T17:40:44.594300Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a received MsgVoteResp from ba268a16d9fd836a at term 4"}
{"level":"info","ts":"2026-04-20T17:40:44.594332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a [logterm: 2, index: 903] sent MsgVote request to 1db95f5fade1e764 at term 4"}
{"level":"info","ts":"2026-04-20T17:40:44.594346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a [logterm: 2, index: 903] sent MsgVote request to 944e7e1987ec6eaf at term 4"}
{"level":"info","ts":"2026-04-20T17:40:44.597153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a received MsgVoteResp rejection from 944e7e1987ec6eaf at term 4"}
{"level":"info","ts":"2026-04-20T17:40:44.597193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a has received 1 MsgVoteResp votes and 1 vote rejections"}
{"level":"info","ts":"2026-04-20T17:40:44.597895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a received MsgVoteResp from 1db95f5fade1e764 at term 4"}
{"level":"info","ts":"2026-04-20T17:40:44.597932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a has received 2 MsgVoteResp votes and 1 vote rejections"}
{"level":"info","ts":"2026-04-20T17:40:44.597955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba268a16d9fd836a became leader at term 4"}
{"level":"info","ts":"2026-04-20T17:40:44.597972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba268a16d9fd836a elected leader ba268a16d9fd836a at term 4"}
{"level":"warn","ts":"2026-04-20T17:40:44.598118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.696017423s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"etcdserver: leader changed"}
{"level":"warn","ts":"2026-04-20T17:40:44.598125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.849527212s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"","error":"etcdserver: leader changed"}
{"level":"info","ts":"2026-04-20T17:40:44.598173Z","caller":"traceutil/trace.go:171","msg":"trace[566323979] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.696121354s","start":"2026-04-20T17:40:42.902033Z","end":"2026-04-20T17:40:44.598155Z","steps":["trace[566323979] 'agreement among raft nodes before linearized reading'  (duration: 1.696049413s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:44.598246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:42.902014Z","time spent":"1.696221105s","remote":"127.0.0.1:46480","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-04-20T17:40:44.598204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.966277079s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"","error":"etcdserver: leader changed"}
{"level":"warn","ts":"2026-04-20T17:40:44.598172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.552156615s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"","error":"etcdserver: leader changed"}
{"level":"info","ts":"2026-04-20T17:40:44.598317Z","caller":"traceutil/trace.go:171","msg":"trace[169156319] range","detail":"{range_begin:; range_end:; }","duration":"1.552312516s","start":"2026-04-20T17:40:43.045992Z","end":"2026-04-20T17:40:44.598305Z","steps":["trace[169156319] 'agreement among raft nodes before linearized reading'  (duration: 1.552154195s)"],"step_count":1}
{"level":"info","ts":"2026-04-20T17:40:44.598325Z","caller":"traceutil/trace.go:171","msg":"trace[1039757554] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; }","duration":"1.96647167s","start":"2026-04-20T17:40:42.631829Z","end":"2026-04-20T17:40:44.598301Z","steps":["trace[1039757554] 'agreement among raft nodes before linearized reading'  (duration: 1.966311889s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:44.598386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:42.631806Z","time spent":"1.966562661s","remote":"127.0.0.1:46850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":0,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"error","ts":"2026-04-20T17:40:44.598387Z","caller":"etcdhttp/health.go:370","msg":"Health check error","path":"/readyz","reason":"[+]serializable_read ok\n[-]linearizable_read failed: etcdserver: leader changed\n[+]non_learner ok\n[+]data_corruption ok\n","status-code":503,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver/api/etcdhttp.(*CheckRegistry).installRootHttpEndpoint.newHealthHandler.func2\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/etcdhttp/health.go:370\nnet/http.HandlerFunc.ServeHTTP\n\tnet/http/server.go:2220\nnet/http.(*ServeMux).ServeHTTP\n\tnet/http/server.go:2747\nnet/http.serverHandler.ServeHTTP\n\tnet/http/server.go:3210\nnet/http.(*conn).serve\n\tnet/http/server.go:2092"}
{"level":"info","ts":"2026-04-20T17:40:44.598180Z","caller":"traceutil/trace.go:171","msg":"trace[92222579] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"1.849645963s","start":"2026-04-20T17:40:42.748520Z","end":"2026-04-20T17:40:44.598166Z","steps":["trace[92222579] 'agreement among raft nodes before linearized reading'  (duration: 1.849562842s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:44.598497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:42.748497Z","time spent":"1.849983726s","remote":"127.0.0.1:46794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "}
{"level":"info","ts":"2026-04-20T17:40:44.601338Z","caller":"etcdserver/v3_server.go:912","msg":"first commit in current term: resending ReadIndex request"}
{"level":"warn","ts":"2026-04-20T17:40:44.605057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.300776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-04-20T17:40:44.605118Z","caller":"traceutil/trace.go:171","msg":"trace[1359046760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:836; }","duration":"884.401697ms","start":"2026-04-20T17:40:43.720706Z","end":"2026-04-20T17:40:44.605108Z","steps":["trace[1359046760] 'agreement among raft nodes before linearized reading'  (duration: 884.276206ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:44.605144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:43.720686Z","time spent":"884.451657ms","remote":"127.0.0.1:46794","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-cp-lock\" limit:1 "}
{"level":"warn","ts":"2026-04-20T17:40:44.605207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.296478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T17:40:44.605263Z","caller":"traceutil/trace.go:171","msg":"trace[654947423] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:836; }","duration":"923.417569ms","start":"2026-04-20T17:40:43.681831Z","end":"2026-04-20T17:40:44.605248Z","steps":["trace[654947423] 'agreement among raft nodes before linearized reading'  (duration: 923.294678ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:44.605303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:43.681813Z","time spent":"923.479359ms","remote":"127.0.0.1:46602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":12,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"info","ts":"2026-04-20T17:40:44.623712Z","caller":"traceutil/trace.go:171","msg":"trace[612532816] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"771.800703ms","start":"2026-04-20T17:40:43.851897Z","end":"2026-04-20T17:40:44.623697Z","steps":["trace[612532816] 'process raft request'  (duration: 771.766203ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T17:40:44.623919Z","caller":"traceutil/trace.go:171","msg":"trace[227241462] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"942.073262ms","start":"2026-04-20T17:40:43.681831Z","end":"2026-04-20T17:40:44.623904Z","steps":["trace[227241462] 'process raft request'  (duration: 941.675138ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T17:40:44.624053Z","caller":"traceutil/trace.go:171","msg":"trace[387966359] transaction","detail":"{read_only:false; response_revision:838; number_of_response:1; }","duration":"942.184203ms","start":"2026-04-20T17:40:43.681863Z","end":"2026-04-20T17:40:44.624047Z","steps":["trace[387966359] 'process raft request'  (duration: 941.707239ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:44.624096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:43.681848Z","time spent":"942.224403ms","remote":"127.0.0.1:47038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" value_size:909 >> failure:<>"}
{"level":"warn","ts":"2026-04-20T17:40:44.624116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:43.851875Z","time spent":"771.884824ms","remote":"127.0.0.1:46794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":537,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/controller-2\" mod_revision:757 > success:<request_put:<key:\"/registry/leases/kube-node-lease/controller-2\" value_size:484 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/controller-2\" > >"}
{"level":"info","ts":"2026-04-20T17:40:44.624247Z","caller":"traceutil/trace.go:171","msg":"trace[1513011035] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"938.186737ms","start":"2026-04-20T17:40:43.686054Z","end":"2026-04-20T17:40:44.624241Z","steps":["trace[1513011035] 'process raft request'  (duration: 937.561001ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:44.624287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:43.686042Z","time spent":"938.223647ms","remote":"127.0.0.1:46536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" mod_revision:833 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" value_size:6782 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" > >"}
{"level":"info","ts":"2026-04-20T17:40:44.624421Z","caller":"traceutil/trace.go:171","msg":"trace[1880959284] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"938.004494ms","start":"2026-04-20T17:40:43.686411Z","end":"2026-04-20T17:40:44.624416Z","steps":["trace[1880959284] 'process raft request'  (duration: 937.231898ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:44.624458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:43.686395Z","time spent":"938.045006ms","remote":"127.0.0.1:46536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" mod_revision:832 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" value_size:9025 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" > >"}
{"level":"warn","ts":"2026-04-20T17:40:44.624490Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:43.681812Z","time spent":"942.158172ms","remote":"127.0.0.1:47038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" value_size:915 >> failure:<>"}
{"level":"warn","ts":"2026-04-20T17:40:50.546229Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9469554528457833153,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T17:40:50.844922Z","caller":"traceutil/trace.go:171","msg":"trace[384997354] linearizableReadLoop","detail":"{readStateIndex:975; appliedIndex:975; }","duration":"798.96743ms","start":"2026-04-20T17:40:50.045913Z","end":"2026-04-20T17:40:50.844881Z","steps":["trace[384997354] 'read index received'  (duration: 798.95981ms)","trace[384997354] 'applied index is now lower than readState.Index'  (duration: 6.3µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T17:40:50.845080Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.140191ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T17:40:50.845132Z","caller":"traceutil/trace.go:171","msg":"trace[1143757084] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:878; }","duration":"799.212342ms","start":"2026-04-20T17:40:50.045907Z","end":"2026-04-20T17:40:50.845120Z","steps":["trace[1143757084] 'agreement among raft nodes before linearized reading'  (duration: 799.122871ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:51.345343Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9469554528457833154,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T17:40:51.732204Z","caller":"traceutil/trace.go:171","msg":"trace[1943309632] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"752.214336ms","start":"2026-04-20T17:40:50.979977Z","end":"2026-04-20T17:40:51.732191Z","steps":["trace[1943309632] 'process raft request'  (duration: 752.158135ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:51.732321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:50.979953Z","time spent":"752.299356ms","remote":"127.0.0.1:46794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-zjy5m4qienmmbtxvgklj3tgz6i\" mod_revision:823 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-zjy5m4qienmmbtxvgklj3tgz6i\" value_size:604 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-zjy5m4qienmmbtxvgklj3tgz6i\" > >"}
{"level":"info","ts":"2026-04-20T17:40:51.732466Z","caller":"traceutil/trace.go:171","msg":"trace[2044011708] linearizableReadLoop","detail":"{readStateIndex:976; appliedIndex:978; }","duration":"887.445724ms","start":"2026-04-20T17:40:50.845012Z","end":"2026-04-20T17:40:51.732458Z","steps":["trace[2044011708] 'read index received'  (duration: 886.908649ms)","trace[2044011708] 'applied index is now lower than readState.Index'  (duration: 536.405µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T17:40:51.732573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.01444109s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:510"}
{"level":"info","ts":"2026-04-20T17:40:51.732599Z","caller":"traceutil/trace.go:171","msg":"trace[829464258] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:882; }","duration":"1.01450347s","start":"2026-04-20T17:40:50.718090Z","end":"2026-04-20T17:40:51.732593Z","steps":["trace[829464258] 'agreement among raft nodes before linearized reading'  (duration: 1.01442845s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:51.732619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:50.718075Z","time spent":"1.01453869s","remote":"127.0.0.1:46794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":534,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "}
{"level":"warn","ts":"2026-04-20T17:40:51.732694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.327711365s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-04-20T17:40:51.734472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.0785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T17:40:51.734507Z","caller":"traceutil/trace.go:171","msg":"trace[1419164579] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:882; }","duration":"844.204601ms","start":"2026-04-20T17:40:50.890295Z","end":"2026-04-20T17:40:51.734500Z","steps":["trace[1419164579] 'agreement among raft nodes before linearized reading'  (duration: 844.0979ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:51.734527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:50.890277Z","time spent":"844.243832ms","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T17:40:51.734755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.336436ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T17:40:51.734813Z","caller":"traceutil/trace.go:171","msg":"trace[280412982] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:882; }","duration":"689.413766ms","start":"2026-04-20T17:40:51.045385Z","end":"2026-04-20T17:40:51.734798Z","steps":["trace[280412982] 'agreement among raft nodes before linearized reading'  (duration: 689.319706ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:51.734976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.455755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T17:40:51.735004Z","caller":"traceutil/trace.go:171","msg":"trace[1541318803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:882; }","duration":"832.507545ms","start":"2026-04-20T17:40:50.902489Z","end":"2026-04-20T17:40:51.734997Z","steps":["trace[1541318803] 'agreement among raft nodes before linearized reading'  (duration: 832.289833ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:51.735169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.911827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" limit:1 ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-04-20T17:40:51.735212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:50.902479Z","time spent":"832.725647ms","remote":"127.0.0.1:46480","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-04-20T17:40:51.735249Z","caller":"traceutil/trace.go:171","msg":"trace[1580155678] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:882; }","duration":"714.038389ms","start":"2026-04-20T17:40:51.021194Z","end":"2026-04-20T17:40:51.735232Z","steps":["trace[1580155678] 'agreement among raft nodes before linearized reading'  (duration: 713.902768ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:51.735299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:51.021177Z","time spent":"714.113181ms","remote":"127.0.0.1:46504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.250\" limit:1 "}
{"level":"info","ts":"2026-04-20T17:40:51.735946Z","caller":"traceutil/trace.go:171","msg":"trace[704644192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:882; }","duration":"1.327831356s","start":"2026-04-20T17:40:50.404921Z","end":"2026-04-20T17:40:51.732752Z","steps":["trace[704644192] 'agreement among raft nodes before linearized reading'  (duration: 1.327680484s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:51.736030Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:50.404906Z","time spent":"1.331106906s","remote":"127.0.0.1:46794","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-cp-lock\" limit:1 "}
{"level":"info","ts":"2026-04-20T17:40:52.093146Z","caller":"traceutil/trace.go:171","msg":"trace[1774578762] linearizableReadLoop","detail":"{readStateIndex:979; appliedIndex:979; }","duration":"356.81297ms","start":"2026-04-20T17:40:51.736305Z","end":"2026-04-20T17:40:52.093117Z","steps":["trace[1774578762] 'read index received'  (duration: 356.80566ms)","trace[1774578762] 'applied index is now lower than readState.Index'  (duration: 5.75µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T17:40:52.093812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.471396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T17:40:52.093865Z","caller":"traceutil/trace.go:171","msg":"trace[17491453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:882; }","duration":"357.604608ms","start":"2026-04-20T17:40:51.736248Z","end":"2026-04-20T17:40:52.093852Z","steps":["trace[17491453] 'agreement among raft nodes before linearized reading'  (duration: 357.491456ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:52.093902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:51.736237Z","time spent":"357.655068ms","remote":"127.0.0.1:46464","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-04-20T17:40:52.094818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:51.736158Z","time spent":"358.658067ms","remote":"127.0.0.1:46504","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-04-20T17:40:52.110965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.571432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:483"}
{"level":"warn","ts":"2026-04-20T17:40:52.111017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.880317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-04-20T17:40:52.111052Z","caller":"traceutil/trace.go:171","msg":"trace[1446526819] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:882; }","duration":"245.696754ms","start":"2026-04-20T17:40:51.865340Z","end":"2026-04-20T17:40:52.111037Z","steps":["trace[1446526819] 'agreement among raft nodes before linearized reading'  (duration: 245.541102ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T17:40:52.111096Z","caller":"traceutil/trace.go:171","msg":"trace[628867286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:882; }","duration":"307.009009ms","start":"2026-04-20T17:40:51.804070Z","end":"2026-04-20T17:40:52.111079Z","steps":["trace[628867286] 'agreement among raft nodes before linearized reading'  (duration: 306.874338ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:52.111140Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:51.804050Z","time spent":"307.081179ms","remote":"127.0.0.1:46794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "}
{"level":"info","ts":"2026-04-20T17:40:52.355306Z","caller":"traceutil/trace.go:171","msg":"trace[1975347870] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:980; }","duration":"244.500269ms","start":"2026-04-20T17:40:52.110788Z","end":"2026-04-20T17:40:52.355288Z","steps":["trace[1975347870] 'read index received'  (duration: 244.495509ms)","trace[1975347870] 'applied index is now lower than readState.Index'  (duration: 3.84µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T17:40:52.355543Z","caller":"traceutil/trace.go:171","msg":"trace[158018793] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"259.506565ms","start":"2026-04-20T17:40:52.096014Z","end":"2026-04-20T17:40:52.355521Z","steps":["trace[158018793] 'process raft request'  (duration: 259.347724ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:52.355604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.491423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T17:40:52.355653Z","caller":"traceutil/trace.go:171","msg":"trace[1497217998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:883; }","duration":"250.612824ms","start":"2026-04-20T17:40:52.105027Z","end":"2026-04-20T17:40:52.355640Z","steps":["trace[1497217998] 'agreement among raft nodes before linearized reading'  (duration: 250.443023ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:53.401739Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9469554528457833166,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T17:40:53.902472Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9469554528457833166,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T17:40:54.028125Z","caller":"traceutil/trace.go:171","msg":"trace[1754266994] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"1.235222494s","start":"2026-04-20T17:40:52.792881Z","end":"2026-04-20T17:40:54.028104Z","steps":["trace[1754266994] 'process raft request'  (duration: 1.235122053s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:54.028247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:52.792867Z","time spent":"1.235328545s","remote":"127.0.0.1:46566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":795,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/cilium-2nsps.18a8217813d56364\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-2nsps.18a8217813d56364\" value_size:719 lease:246182491603057359 >> failure:<>"}
{"level":"info","ts":"2026-04-20T17:40:54.029090Z","caller":"traceutil/trace.go:171","msg":"trace[218623381] linearizableReadLoop","detail":"{readStateIndex:985; appliedIndex:986; }","duration":"1.128048684s","start":"2026-04-20T17:40:52.901026Z","end":"2026-04-20T17:40:54.029074Z","steps":["trace[218623381] 'read index received'  (duration: 1.128044154s)","trace[218623381] 'applied index is now lower than readState.Index'  (duration: 3.53µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T17:40:54.029268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.128231396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T17:40:54.029301Z","caller":"traceutil/trace.go:171","msg":"trace[1093064651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:887; }","duration":"1.128293117s","start":"2026-04-20T17:40:52.900999Z","end":"2026-04-20T17:40:54.029292Z","steps":["trace[1093064651] 'agreement among raft nodes before linearized reading'  (duration: 1.128158016s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:54.029935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:52.900982Z","time spent":"1.128939344s","remote":"127.0.0.1:46464","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-04-20T17:40:54.530174Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9469554528457833170,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T17:40:55.031258Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9469554528457833170,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T17:40:55.532296Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9469554528457833170,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T17:40:55.540205Z","caller":"traceutil/trace.go:171","msg":"trace[841060881] linearizableReadLoop","detail":"{readStateIndex:986; appliedIndex:987; }","duration":"1.511045266s","start":"2026-04-20T17:40:54.029132Z","end":"2026-04-20T17:40:55.540178Z","steps":["trace[841060881] 'read index received'  (duration: 1.511036556s)","trace[841060881] 'applied index is now lower than readState.Index'  (duration: 6.56µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T17:40:55.540345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.494917399s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2nsps\" limit:1 ","response":"range_response_count:1 size:18163"}
{"level":"warn","ts":"2026-04-20T17:40:55.540341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.495442924s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T17:40:55.540378Z","caller":"traceutil/trace.go:171","msg":"trace[158997092] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2nsps; range_end:; response_count:1; response_revision:888; }","duration":"2.494957019s","start":"2026-04-20T17:40:53.045412Z","end":"2026-04-20T17:40:55.540369Z","steps":["trace[158997092] 'agreement among raft nodes before linearized reading'  (duration: 2.494861508s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:55.540406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:53.045360Z","time spent":"2.495038849s","remote":"127.0.0.1:46708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18187,"request content":"key:\"/registry/pods/kube-system/cilium-2nsps\" limit:1 "}
{"level":"info","ts":"2026-04-20T17:40:55.540400Z","caller":"traceutil/trace.go:171","msg":"trace[317961553] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:888; }","duration":"2.495511194s","start":"2026-04-20T17:40:53.044869Z","end":"2026-04-20T17:40:55.540380Z","steps":["trace[317961553] 'agreement among raft nodes before linearized reading'  (duration: 2.495414804s)"],"step_count":1}
{"level":"info","ts":"2026-04-20T17:40:55.541024Z","caller":"traceutil/trace.go:171","msg":"trace[2099023679] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"657.847259ms","start":"2026-04-20T17:40:54.883158Z","end":"2026-04-20T17:40:55.541006Z","steps":["trace[2099023679] 'process raft request'  (duration: 657.806368ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:55.541171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:54.883128Z","time spent":"657.969579ms","remote":"127.0.0.1:46794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":537,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/controller-2\" mod_revision:841 > success:<request_put:<key:\"/registry/leases/kube-node-lease/controller-2\" value_size:484 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/controller-2\" > >"}
{"level":"info","ts":"2026-04-20T17:40:55.541220Z","caller":"traceutil/trace.go:171","msg":"trace[328787695] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"1.508691653s","start":"2026-04-20T17:40:54.032507Z","end":"2026-04-20T17:40:55.541198Z","steps":["trace[328787695] 'process raft request'  (duration: 1.508419341s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:55.541370Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:54.032480Z","time spent":"1.508805074s","remote":"127.0.0.1:46566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":697,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/cilium-2nsps.18a8217815687b10\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-2nsps.18a8217815687b10\" value_size:621 lease:246182491603057359 >> failure:<>"}
{"level":"warn","ts":"2026-04-20T17:40:55.543276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.464678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T17:40:55.543309Z","caller":"traceutil/trace.go:171","msg":"trace[1823302985] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:891; }","duration":"315.547348ms","start":"2026-04-20T17:40:55.227754Z","end":"2026-04-20T17:40:55.543301Z","steps":["trace[1823302985] 'agreement among raft nodes before linearized reading'  (duration: 315.481668ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:55.543289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.069468918s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-20T17:40:55.543368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.173509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:510"}
{"level":"info","ts":"2026-04-20T17:40:55.543390Z","caller":"traceutil/trace.go:171","msg":"trace[255722466] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:891; }","duration":"118.230009ms","start":"2026-04-20T17:40:55.425154Z","end":"2026-04-20T17:40:55.543384Z","steps":["trace[255722466] 'agreement among raft nodes before linearized reading'  (duration: 118.191349ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:55.543371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15766322s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:483"}
{"level":"info","ts":"2026-04-20T17:40:55.543368Z","caller":"traceutil/trace.go:171","msg":"trace[1490160801] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:891; }","duration":"1.069603039s","start":"2026-04-20T17:40:54.473746Z","end":"2026-04-20T17:40:55.543349Z","steps":["trace[1490160801] 'agreement among raft nodes before linearized reading'  (duration: 1.069461988s)"],"step_count":1}
{"level":"info","ts":"2026-04-20T17:40:55.543500Z","caller":"traceutil/trace.go:171","msg":"trace[820375230] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:891; }","duration":"1.157781401s","start":"2026-04-20T17:40:54.385655Z","end":"2026-04-20T17:40:55.543436Z","steps":["trace[820375230] 'agreement among raft nodes before linearized reading'  (duration: 1.157626789s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:55.543542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:54.385636Z","time spent":"1.157896061s","remote":"127.0.0.1:46794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":507,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "}
{"level":"warn","ts":"2026-04-20T17:40:55.543581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.356011713s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"}
{"level":"warn","ts":"2026-04-20T17:40:55.543625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.504658038s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T17:40:55.543663Z","caller":"traceutil/trace.go:171","msg":"trace[1829264906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:891; }","duration":"1.356131543s","start":"2026-04-20T17:40:54.187514Z","end":"2026-04-20T17:40:55.543646Z","steps":["trace[1829264906] 'agreement among raft nodes before linearized reading'  (duration: 1.356007402s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:55.543695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.138898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T17:40:55.543720Z","caller":"traceutil/trace.go:171","msg":"trace[416073677] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:891; }","duration":"957.193269ms","start":"2026-04-20T17:40:54.586520Z","end":"2026-04-20T17:40:55.543713Z","steps":["trace[416073677] 'agreement among raft nodes before linearized reading'  (duration: 957.151569ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T17:40:55.543722Z","caller":"traceutil/trace.go:171","msg":"trace[1591700457] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:891; }","duration":"1.504781109s","start":"2026-04-20T17:40:54.038917Z","end":"2026-04-20T17:40:55.543698Z","steps":["trace[1591700457] 'agreement among raft nodes before linearized reading'  (duration: 1.504641758s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T17:40:55.543724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:54.187488Z","time spent":"1.356221134s","remote":"127.0.0.1:46794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "}
{"level":"warn","ts":"2026-04-20T17:40:55.543744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:54.586503Z","time spent":"957.232059ms","remote":"127.0.0.1:46684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":2,"response size":31,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T17:40:55.543769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:54.038903Z","time spent":"1.504855449s","remote":"127.0.0.1:46480","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-04-20T17:40:55.543334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:55.227736Z","time spent":"315.591489ms","remote":"127.0.0.1:46580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T17:40:55.544232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T17:40:54.473725Z","time spent":"1.070483726s","remote":"127.0.0.1:46714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T17:40:56.081446Z","caller":"etcdserver/raft.go:427","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"944e7e1987ec6eaf","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"30.988249ms"}
{"level":"warn","ts":"2026-04-20T17:40:56.081569Z","caller":"etcdserver/raft.go:427","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"1db95f5fade1e764","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"31.16361ms"}
{"level":"info","ts":"2026-04-20T17:41:00.275440Z","caller":"traceutil/trace.go:171","msg":"trace[1500316359] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"183.580183ms","start":"2026-04-20T17:41:00.091846Z","end":"2026-04-20T17:41:00.275426Z","steps":["trace[1500316359] 'process raft request'  (duration: 183.492002ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T17:41:00.276944Z","caller":"traceutil/trace.go:171","msg":"trace[712444827] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"162.048384ms","start":"2026-04-20T17:41:00.114872Z","end":"2026-04-20T17:41:00.276921Z","steps":["trace[712444827] 'process raft request'  (duration: 161.583129ms)"],"step_count":1}