{"level":"warn","ts":"2026-04-22T13:40:50.997316Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-04-22T13:40:50.998224Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-04-22T13:40:50.998249Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.204.45.53:2380","--initial-cluster=controller-1=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53:2380","--name=controller-1","--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","--watch-progress-notify-interval=5s"]} {"level":"info","ts":"2026-04-22T13:40:50.998412Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-04-22T13:40:50.998438Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T13:40:50.998460Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-04-22T13:40:50.998533Z","caller":"embed/etcd.go:544","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-22T13:40:50.999744Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-04-22T13:40:51.001445Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller-1","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.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller-1=https://199.204.45.53: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,"feature-gates":"InitialCorruptCheck=true","initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","discovery-token":"","discovery-endpoints":"","discovery-dial-timeout":"2s","discovery-request-timeout":"5s","discovery-keepalive-time":"2s","discovery-keepalive-timeout":"6s","discovery-insecure-transport":true,"discovery-insecure-skip-tls-verify":false,"discovery-cert":"","discovery-key":"","discovery-cacert":"","discovery-user":"","downgrade-check-interval":"5s","max-learners":1,"v2-deprecation":"write-only"} {"level":"info","ts":"2026-04-22T13:40:51.002998Z","logger":"bbolt","caller":"backend/backend.go:203","msg":"Opening db file (/var/lib/etcd/member/snap/db) with mode -rw------- and with options: {Timeout: 0s, NoGrowSync: false, NoFreelistSync: true, PreLoadFreelist: false, FreelistType: hashmap, ReadOnly: false, MmapFlags: 8000, InitialMmapSize: 10737418240, PageSize: 0, NoSync: false, OpenFile: 0x0, Mlock: false, Logger: 0xc000604118}"} {"level":"info","ts":"2026-04-22T13:40:51.011008Z","logger":"bbolt","caller":"bbolt@v1.4.2/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"} {"level":"info","ts":"2026-04-22T13:40:51.011087Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.203103ms"} {"level":"info","ts":"2026-04-22T13:40:51.011126Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-04-22T13:40:51.011138Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-04-22T13:40:51.011189Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-04-22T13:40:51.019536Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-04-22T13:40:51.019619Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-04-22T13:40:51.019647Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-04-22T13:40:51.019710Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T13:40:51.019750Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-04-22T13:40:51.019761Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T13:40:51.019771Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-04-22T13:40:51.019811Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-04-22T13:40:51.025201Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T13:40:51.028450Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T13:40:51.030635Z","caller":"storage/quota.go:93","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-22T13:40:51.031190Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T13:40:51.031403Z","caller":"embed/etcd.go:766","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-22T13:40:51.031364Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T13:40:51.031508Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-22T13:40:51.031592Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-22T13:40:51.031778Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T13:40:51.031818Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T13:40:51.031892Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T13:40:51.032722Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T13:40:51.032799Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T13:40:51.033121Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-04-22T13:40:51.033375Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-04-22T13:40:51.720731Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T13:40:51.720799Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T13:40:51.720860Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-04-22T13:40:51.720874Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"c47ca1a7b1fe506b has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-22T13:40:51.721239Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-04-22T13:40:51.722537Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-22T13:40:51.722563Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"c47ca1a7b1fe506b has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-22T13:40:51.722579Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-04-22T13:40:51.722589Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-22T13:40:51.723533Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:controller-1 ClientURLs:[https://199.204.45.53:2379]}","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T13:40:51.723563Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T13:40:51.723544Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T13:40:51.723667Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-04-22T13:40:51.723799Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T13:40:51.723836Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T13:40:51.725034Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.6"} {"level":"info","ts":"2026-04-22T13:40:51.725212Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-04-22T13:40:51.725309Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-04-22T13:40:51.725414Z","caller":"version/monitor.go:116","msg":"cluster version differs from storage version.","cluster-version":"3.6.0","storage-version":"3.5.0"} {"level":"info","ts":"2026-04-22T13:40:51.725492Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-04-22T13:40:51.725809Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-04-22T13:40:51.731097Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-04-22T13:40:51.731247Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-22T13:40:51.732851Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-04-22T13:40:51.736303Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-22T13:40:51.736596Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57758","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.736938Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57776","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.739739Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57796","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.751484Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57826","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.766285Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57852","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.793440Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57868","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.807385Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57898","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.814237Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57914","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.825916Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57930","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.835625Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57958","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.844655Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57982","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.854679Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57992","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.861601Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58006","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.873797Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58016","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.887759Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58040","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.896024Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58056","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.903563Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58064","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.917372Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58078","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.930876Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58108","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.944081Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58132","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.952074Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58168","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:51.960828Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58178","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.004880Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58190","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.013768Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58218","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.021102Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58250","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.030182Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58276","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.040388Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58282","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.051602Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58296","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.060344Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58310","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.071192Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58348","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.081019Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58352","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.094046Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58374","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.104600Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58410","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.115722Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58416","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.123805Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58440","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.135969Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58448","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.148636Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58454","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.156908Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58482","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.181038Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58504","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.194582Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58528","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.202174Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58562","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.210670Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58578","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.219259Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58582","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.230655Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58604","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.242072Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58610","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.253536Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58638","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.277981Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58654","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.288535Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58668","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.296923Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58676","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.305866Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58692","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.315952Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58724","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.325784Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58760","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.337331Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58766","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.356928Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58790","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.367277Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58808","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.380571Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58828","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.398259Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58852","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.433780Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58872","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.444826Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58890","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.453191Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58902","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:40:52.503558Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58922","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-22T13:41:05.608539Z","caller":"traceutil/trace.go:172","msg":"trace[979807686] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"131.196613ms","start":"2026-04-22T13:41:05.477311Z","end":"2026-04-22T13:41:05.608508Z","steps":["trace[979807686] 'process raft request' (duration: 130.975012ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:41:15.831937Z","caller":"traceutil/trace.go:172","msg":"trace[1827853119] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"167.569375ms","start":"2026-04-22T13:41:15.664353Z","end":"2026-04-22T13:41:15.831922Z","steps":["trace[1827853119] 'process raft request' (duration: 167.453789ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:41:24.118010Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131) learners=(3251445098001113527)"} {"level":"info","ts":"2026-04-22T13:41:24.118228Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"2d1f7416f90aa1b7","added-peer-peer-urls":["https://199.204.45.233:2380"],"added-peer-is-learner":true} {"level":"info","ts":"2026-04-22T13:41:24.118257Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:24.118278Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:24.119140Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:24.119749Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:24.119794Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:24.119810Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:24.119865Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7","remote-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-04-22T13:41:24.119894Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:24.120239Z","caller":"etcdserver/server.go:1752","msg":"applied a configuration change through raft","local-member-id":"c47ca1a7b1fe506b","raft-conf-change":"ConfChangeAddLearnerNode","raft-conf-change-node-id":"2d1f7416f90aa1b7"} {"level":"error","ts":"2026-04-22T13:41:24.170843Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-22T13:41:24.672595Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-22T13:41:25.175231Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-22T13:41:25.674533Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-22T13:41:26.178473Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-22T13:41:26.673400Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"info","ts":"2026-04-22T13:41:26.796506Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"c47ca1a7b1fe506b","to":"2d1f7416f90aa1b7","stream-type":"stream Message"} {"level":"info","ts":"2026-04-22T13:41:26.796596Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:26.796658Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:26.800889Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"c47ca1a7b1fe506b","to":"2d1f7416f90aa1b7","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-04-22T13:41:26.800951Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:26.832334Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:26.834965Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:26.836098Z","caller":"etcdserver/server.go:1838","msg":"sending merged snapshot","from":"c47ca1a7b1fe506b","to":"2d1f7416f90aa1b7","bytes":811013,"size":"811 kB"} {"level":"info","ts":"2026-04-22T13:41:26.836206Z","caller":"rafthttp/snapshot_sender.go:82","msg":"sending database snapshot","snapshot-index":502,"remote-peer-id":"2d1f7416f90aa1b7","bytes":811013,"size":"811 kB"} {"level":"info","ts":"2026-04-22T13:41:26.846798Z","caller":"etcdserver/snapshot_merge.go:64","msg":"sent database snapshot to writer","bytes":802816,"size":"803 kB"} {"level":"info","ts":"2026-04-22T13:41:26.855967Z","caller":"rafthttp/snapshot_sender.go:131","msg":"sent database snapshot","snapshot-index":502,"remote-peer-id":"2d1f7416f90aa1b7","bytes":811013,"size":"811 kB"} {"level":"warn","ts":"2026-04-22T13:41:26.871507Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:41:26.871543Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7","error":"EOF"} {"level":"info","ts":"2026-04-22T13:41:26.883201Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"c47ca1a7b1fe506b","to":"2d1f7416f90aa1b7","stream-type":"stream MsgApp v2"} {"level":"warn","ts":"2026-04-22T13:41:26.883232Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:26.883241Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:26.887792Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"c47ca1a7b1fe506b","to":"2d1f7416f90aa1b7","stream-type":"stream Message"} {"level":"warn","ts":"2026-04-22T13:41:26.887828Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:26.887845Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:26.932357Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:26.936020Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:27.176799Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"c47ca1a7b1fe506b switched to configuration voters=(3251445098001113527 14158369070163841131)"} {"level":"info","ts":"2026-04-22T13:41:27.177434Z","caller":"membership/cluster.go:550","msg":"promote member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","promoted-member-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:27.177670Z","caller":"etcdserver/server.go:1752","msg":"applied a configuration change through raft","local-member-id":"c47ca1a7b1fe506b","raft-conf-change":"ConfChangeAddNode","raft-conf-change-node-id":"2d1f7416f90aa1b7"} {"level":"info","ts":"2026-04-22T13:41:27.398723Z","caller":"etcdserver/server.go:2246","msg":"skip compaction since there is an inflight snapshot"} {"level":"info","ts":"2026-04-22T13:41:41.228699Z","caller":"etcdserver/server.go:2246","msg":"skip compaction since there is an inflight snapshot"} {"level":"info","ts":"2026-04-22T13:41:41.229268Z","caller":"traceutil/trace.go:172","msg":"trace[610357029] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"234.796097ms","start":"2026-04-22T13:41:40.994055Z","end":"2026-04-22T13:41:41.228851Z","steps":["trace[610357029] 'process raft request' (duration: 234.14528ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:41:47.032236Z","caller":"traceutil/trace.go:172","msg":"trace[553576704] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"227.494006ms","start":"2026-04-22T13:41:46.804720Z","end":"2026-04-22T13:41:47.032214Z","steps":["trace[553576704] 'process raft request' (duration: 227.374901ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:41:56.857013Z","caller":"etcdserver/server.go:1856","msg":"sent merged snapshot","from":"c47ca1a7b1fe506b","to":"2d1f7416f90aa1b7","bytes":811013,"size":"811 kB","took":"30.020909829s"} {"level":"info","ts":"2026-04-22T13:42:02.025313Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"c47ca1a7b1fe506b switched to configuration voters=(3251445098001113527 14158369070163841131) learners=(15380581267863204865)"} {"level":"info","ts":"2026-04-22T13:42:02.025815Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"d572cd2c5e037401","added-peer-peer-urls":["https://199.204.45.38:2380"],"added-peer-is-learner":true} {"level":"info","ts":"2026-04-22T13:42:02.025897Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:02.025941Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:02.026166Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:02.032461Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:02.035181Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:02.035460Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401","remote-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-04-22T13:42:02.035728Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:02.035583Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"warn","ts":"2026-04-22T13:42:02.041241Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.38:33660","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:42:02.052457Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.38:33672","server-name":"","error":"EOF"} {"level":"error","ts":"2026-04-22T13:42:02.087050Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/etcdhttp.(*peerMemberPromoteHandler).ServeHTTP\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/etcdhttp/peer.go:140\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":"warn","ts":"2026-04-22T13:42:02.087167Z","caller":"etcdhttp/peer.go:152","msg":"failed to promote a member","member-id":"d572cd2c5e037401","error":"etcdserver: can only promote a learner member which is in sync with leader"} {"level":"error","ts":"2026-04-22T13:42:02.579373Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-22T13:42:03.081675Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-22T13:42:03.585770Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/etcdhttp.(*peerMemberPromoteHandler).ServeHTTP\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/etcdhttp/peer.go:140\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":"warn","ts":"2026-04-22T13:42:03.585886Z","caller":"etcdhttp/peer.go:152","msg":"failed to promote a member","member-id":"d572cd2c5e037401","error":"etcdserver: can only promote a learner member which is in sync with leader"} {"level":"warn","ts":"2026-04-22T13:42:03.758635Z","caller":"etcdserver/cluster_util.go:259","msg":"failed to reach the peer URL","address":"https://199.204.45.38:2380/version","remote-member-id":"d572cd2c5e037401","error":"Get \"https://199.204.45.38:2380/version\": dial tcp 199.204.45.38:2380: connect: connection refused"} {"level":"warn","ts":"2026-04-22T13:42:03.758736Z","caller":"etcdserver/cluster_util.go:160","msg":"failed to get version","remote-member-id":"d572cd2c5e037401","error":"Get \"https://199.204.45.38:2380/version\": dial tcp 199.204.45.38:2380: connect: connection refused"} {"level":"error","ts":"2026-04-22T13:42:04.079457Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-22T13:42:04.586816Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/etcdhttp.(*peerMemberPromoteHandler).ServeHTTP\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/etcdhttp/peer.go:140\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":"warn","ts":"2026-04-22T13:42:04.586914Z","caller":"etcdhttp/peer.go:152","msg":"failed to promote a member","member-id":"d572cd2c5e037401","error":"etcdserver: can only promote a learner member which is in sync with leader"} {"level":"info","ts":"2026-04-22T13:42:04.843064Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:04.850827Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"c47ca1a7b1fe506b","to":"d572cd2c5e037401","stream-type":"stream Message"} {"level":"info","ts":"2026-04-22T13:42:04.850885Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:04.851517Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:04.854188Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"c47ca1a7b1fe506b","to":"d572cd2c5e037401","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-04-22T13:42:04.854223Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:04.854587Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:04.858904Z","caller":"etcdserver/server.go:1838","msg":"sending merged snapshot","from":"c47ca1a7b1fe506b","to":"d572cd2c5e037401","bytes":1122858,"size":"1.1 MB"} {"level":"info","ts":"2026-04-22T13:42:04.859176Z","caller":"rafthttp/snapshot_sender.go:82","msg":"sending database snapshot","snapshot-index":692,"remote-peer-id":"d572cd2c5e037401","bytes":1122858,"size":"1.1 MB"} {"level":"info","ts":"2026-04-22T13:42:04.862697Z","caller":"etcdserver/snapshot_merge.go:64","msg":"sent database snapshot to writer","bytes":1114112,"size":"1.1 MB"} {"level":"info","ts":"2026-04-22T13:42:04.870562Z","caller":"rafthttp/snapshot_sender.go:131","msg":"sent database snapshot","snapshot-index":692,"remote-peer-id":"d572cd2c5e037401","bytes":1122858,"size":"1.1 MB"} {"level":"warn","ts":"2026-04-22T13:42:04.881633Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:42:04.881682Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401","error":"EOF"} {"level":"info","ts":"2026-04-22T13:42:04.897382Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"c47ca1a7b1fe506b","to":"d572cd2c5e037401","stream-type":"stream Message"} {"level":"warn","ts":"2026-04-22T13:42:04.897426Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:04.897447Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:04.898125Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"c47ca1a7b1fe506b","to":"d572cd2c5e037401","stream-type":"stream MsgApp v2"} {"level":"warn","ts":"2026-04-22T13:42:04.898156Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:04.898180Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:04.947719Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:04.951847Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"c47ca1a7b1fe506b","remote-peer-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:05.082042Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"c47ca1a7b1fe506b switched to configuration voters=(3251445098001113527 14158369070163841131 15380581267863204865)"} {"level":"info","ts":"2026-04-22T13:42:05.082309Z","caller":"membership/cluster.go:550","msg":"promote member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","promoted-member-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:05.082368Z","caller":"etcdserver/server.go:1752","msg":"applied a configuration change through raft","local-member-id":"c47ca1a7b1fe506b","raft-conf-change":"ConfChangeAddNode","raft-conf-change-node-id":"d572cd2c5e037401"} {"level":"info","ts":"2026-04-22T13:42:07.764543Z","caller":"etcdserver/server.go:2246","msg":"skip compaction since there is an inflight snapshot"} {"level":"info","ts":"2026-04-22T13:42:14.996874Z","caller":"traceutil/trace.go:172","msg":"trace[867556898] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"107.377904ms","start":"2026-04-22T13:42:14.889473Z","end":"2026-04-22T13:42:14.996851Z","steps":["trace[867556898] 'process raft request' (duration: 107.197719ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:15.562680Z","caller":"etcdserver/server.go:2246","msg":"skip compaction since there is an inflight snapshot"} {"level":"info","ts":"2026-04-22T13:42:32.594879Z","caller":"etcdserver/server.go:2246","msg":"skip compaction since there is an inflight snapshot"} {"level":"info","ts":"2026-04-22T13:42:34.871568Z","caller":"etcdserver/server.go:1856","msg":"sent merged snapshot","from":"c47ca1a7b1fe506b","to":"d572cd2c5e037401","bytes":1122858,"size":"1.1 MB","took":"30.012657898s"} {"level":"warn","ts":"2026-04-22T13:42:44.997218Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898748069827192,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T13:42:45.248458Z","caller":"traceutil/trace.go:172","msg":"trace[1785279041] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"1.10647254s","start":"2026-04-22T13:42:44.141942Z","end":"2026-04-22T13:42:45.248415Z","steps":["trace[1785279041] 'process raft request' (duration: 1.106257354s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.249332Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.141915Z","time spent":"1.106839973s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:42:45.257231Z","caller":"traceutil/trace.go:172","msg":"trace[1727093734] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:998; }","duration":"760.891025ms","start":"2026-04-22T13:42:44.496308Z","end":"2026-04-22T13:42:45.257199Z","steps":["trace[1727093734] 'read index received' (duration: 760.881455ms)","trace[1727093734] 'applied index is now lower than readState.Index' (duration: 7.27µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:42:45.257494Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"761.124322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:45.257951Z","caller":"traceutil/trace.go:172","msg":"trace[676454095] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:927; }","duration":"761.627868ms","start":"2026-04-22T13:42:44.496301Z","end":"2026-04-22T13:42:45.257929Z","steps":["trace[676454095] 'agreement among raft nodes before linearized reading' (duration: 761.030199ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:45.257977Z","caller":"traceutil/trace.go:172","msg":"trace[761738383] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"1.114095636s","start":"2026-04-22T13:42:44.143854Z","end":"2026-04-22T13:42:45.257950Z","steps":["trace[761738383] 'process raft request' (duration: 1.113792566s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.258006Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.496269Z","time spent":"761.723711ms","remote":"127.0.0.1:58122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/pods\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:42:45.258116Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.143835Z","time spent":"1.114210609s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:42:45.259162Z","caller":"traceutil/trace.go:172","msg":"trace[1558449712] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"1.095199151s","start":"2026-04-22T13:42:44.163946Z","end":"2026-04-22T13:42:45.259145Z","steps":["trace[1558449712] 'process raft request' (duration: 1.094788308s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.259264Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.163910Z","time spent":"1.095298595s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:42:45.259463Z","caller":"traceutil/trace.go:172","msg":"trace[535697236] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"1.107723929s","start":"2026-04-22T13:42:44.151679Z","end":"2026-04-22T13:42:45.259402Z","steps":["trace[535697236] 'process raft request' (duration: 1.106844961s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.259528Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.151643Z","time spent":"1.107857042s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:42:45.260071Z","caller":"traceutil/trace.go:172","msg":"trace[997035783] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"1.116072856s","start":"2026-04-22T13:42:44.143972Z","end":"2026-04-22T13:42:45.260045Z","steps":["trace[997035783] 'process raft request' (duration: 1.113816838s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.260217Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.143966Z","time spent":"1.116201761s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:42:45.260530Z","caller":"traceutil/trace.go:172","msg":"trace[1043514247] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"917.229513ms","start":"2026-04-22T13:42:44.343276Z","end":"2026-04-22T13:42:45.260505Z","steps":["trace[1043514247] 'process raft request' (duration: 917.13021ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:45.261918Z","caller":"traceutil/trace.go:172","msg":"trace[1505248501] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"1.033754149s","start":"2026-04-22T13:42:44.228156Z","end":"2026-04-22T13:42:45.261911Z","steps":["trace[1505248501] 'process raft request' (duration: 1.030812518s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.261983Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.228126Z","time spent":"1.03383304s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T13:42:45.262023Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.343254Z","time spent":"918.675707ms","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:42:45.261834Z","caller":"traceutil/trace.go:172","msg":"trace[2058040959] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"1.095622913s","start":"2026-04-22T13:42:44.166194Z","end":"2026-04-22T13:42:45.261817Z","steps":["trace[2058040959] 'process raft request' (duration: 1.09259293s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.262956Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.166171Z","time spent":"1.096757179s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:42:45.265320Z","caller":"traceutil/trace.go:172","msg":"trace[382627576] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"1.103345762s","start":"2026-04-22T13:42:44.161937Z","end":"2026-04-22T13:42:45.265282Z","steps":["trace[382627576] 'process raft request' (duration: 1.096727478s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.265503Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.161923Z","time spent":"1.103503757s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:42:45.261872Z","caller":"traceutil/trace.go:172","msg":"trace[862494820] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"1.091446954s","start":"2026-04-22T13:42:44.170417Z","end":"2026-04-22T13:42:45.261864Z","steps":["trace[862494820] 'process raft request' (duration: 1.088422621s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.265828Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.170407Z","time spent":"1.095365125s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:42:45.261896Z","caller":"traceutil/trace.go:172","msg":"trace[1740320771] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"1.081339902s","start":"2026-04-22T13:42:44.180549Z","end":"2026-04-22T13:42:45.261889Z","steps":["trace[1740320771] 'process raft request' (duration: 1.078348259s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.265967Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.180516Z","time spent":"1.085433777s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:42:45.266064Z","caller":"traceutil/trace.go:172","msg":"trace[612798344] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"1.018268749s","start":"2026-04-22T13:42:44.247781Z","end":"2026-04-22T13:42:45.266049Z","steps":["trace[612798344] 'process raft request' (duration: 1.011255993s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.266097Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.247757Z","time spent":"1.018325671s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T13:42:45.275431Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"153.15097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:45.275746Z","caller":"traceutil/trace.go:172","msg":"trace[460847797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:939; }","duration":"153.483761ms","start":"2026-04-22T13:42:45.122239Z","end":"2026-04-22T13:42:45.275723Z","steps":["trace[460847797] 'agreement among raft nodes before linearized reading' (duration: 153.085458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.275997Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"747.246581ms","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-22T13:42:45.276043Z","caller":"traceutil/trace.go:172","msg":"trace[1438481757] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:939; }","duration":"747.288642ms","start":"2026-04-22T13:42:44.528740Z","end":"2026-04-22T13:42:45.276029Z","steps":["trace[1438481757] 'agreement among raft nodes before linearized reading' (duration: 746.170628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.275478Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"545.098934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T13:42:45.276245Z","caller":"traceutil/trace.go:172","msg":"trace[265380632] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:939; }","duration":"545.89416ms","start":"2026-04-22T13:42:44.730340Z","end":"2026-04-22T13:42:45.276234Z","steps":["trace[265380632] 'agreement among raft nodes before linearized reading' (duration: 544.95654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.276343Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.730310Z","time spent":"546.012262ms","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:42:45.276626Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"545.28233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-22T13:42:45.276727Z","caller":"traceutil/trace.go:172","msg":"trace[1726488312] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:939; }","duration":"545.396154ms","start":"2026-04-22T13:42:44.731309Z","end":"2026-04-22T13:42:45.276705Z","steps":["trace[1726488312] 'agreement among raft nodes before linearized reading' (duration: 543.63835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:45.276797Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:44.731298Z","time spent":"545.485466ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.53\" limit:1 "} {"level":"info","ts":"2026-04-22T13:42:45.878081Z","caller":"traceutil/trace.go:172","msg":"trace[1777609610] transaction","detail":"{read_only:false; number_of_response:1; response_revision:983; }","duration":"108.536716ms","start":"2026-04-22T13:42:45.769511Z","end":"2026-04-22T13:42:45.878048Z","steps":["trace[1777609610] 'process raft request' (duration: 108.35117ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:50.605837Z","caller":"traceutil/trace.go:172","msg":"trace[1390528111] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"141.271785ms","start":"2026-04-22T13:42:50.464542Z","end":"2026-04-22T13:42:50.605813Z","steps":["trace[1390528111] 'process raft request' (duration: 141.014818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:51.487485Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"d572cd2c5e037401","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"166.073532ms"} {"level":"warn","ts":"2026-04-22T13:42:51.487584Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"2d1f7416f90aa1b7","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"166.182546ms"} {"level":"warn","ts":"2026-04-22T13:42:51.591124Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"469.752462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:51.591200Z","caller":"traceutil/trace.go:172","msg":"trace[2100962340] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1038; }","duration":"469.840435ms","start":"2026-04-22T13:42:51.121346Z","end":"2026-04-22T13:42:51.591187Z","steps":["trace[2100962340] 'range keys from in-memory index tree' (duration: 468.702189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:51.591229Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:51.121318Z","time spent":"469.904716ms","remote":"127.0.0.1:57780","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-22T13:42:51.591763Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"103.738231ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:42:51.592027Z","caller":"traceutil/trace.go:172","msg":"trace[1743206514] linearizableReadLoop","detail":"{readStateIndex:1195; appliedIndex:1194; }","duration":"232.520385ms","start":"2026-04-22T13:42:51.359491Z","end":"2026-04-22T13:42:51.592012Z","steps":["trace[1743206514] 'read index received' (duration: 231.333929ms)","trace[1743206514] 'applied index is now lower than readState.Index' (duration: 1.185236ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:42:51.592634Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"232.936337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T13:42:51.592741Z","caller":"traceutil/trace.go:172","msg":"trace[268382178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1039; }","duration":"233.243926ms","start":"2026-04-22T13:42:51.359474Z","end":"2026-04-22T13:42:51.592718Z","steps":["trace[268382178] 'agreement among raft nodes before linearized reading' (duration: 232.591957ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:51.593189Z","caller":"traceutil/trace.go:172","msg":"trace[811824965] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"216.709479ms","start":"2026-04-22T13:42:51.376456Z","end":"2026-04-22T13:42:51.593166Z","steps":["trace[811824965] 'process raft request' (duration: 215.721549ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:52.177569Z","caller":"traceutil/trace.go:172","msg":"trace[1598036300] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"226.571165ms","start":"2026-04-22T13:42:51.950974Z","end":"2026-04-22T13:42:52.177546Z","steps":["trace[1598036300] 'process raft request' (duration: 226.43243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:52.596543Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898748069827376,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T13:42:53.097550Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898748069827376,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T13:42:53.477088Z","caller":"traceutil/trace.go:172","msg":"trace[1384268668] linearizableReadLoop","detail":"{readStateIndex:1206; appliedIndex:1207; }","duration":"1.381002352s","start":"2026-04-22T13:42:52.096048Z","end":"2026-04-22T13:42:53.477051Z","steps":["trace[1384268668] 'read index received' (duration: 1.380986752s)","trace[1384268668] 'applied index is now lower than readState.Index' (duration: 12.47µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:42:53.477302Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.381219149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:53.477329Z","caller":"traceutil/trace.go:172","msg":"trace[1051043227] range","detail":"{range_begin:/registry/prioritylevelconfigurations; range_end:; response_count:0; response_revision:1050; }","duration":"1.381279021s","start":"2026-04-22T13:42:52.096042Z","end":"2026-04-22T13:42:53.477321Z","steps":["trace[1051043227] 'agreement among raft nodes before linearized reading' (duration: 1.381155487s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:53.477365Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:52.096019Z","time spent":"1.381337183s","remote":"127.0.0.1:58664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations\" limit:1 "} {"level":"info","ts":"2026-04-22T13:42:53.480152Z","caller":"traceutil/trace.go:172","msg":"trace[1353708426] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"1.397187898s","start":"2026-04-22T13:42:52.082939Z","end":"2026-04-22T13:42:53.480127Z","steps":["trace[1353708426] 'process raft request' (duration: 1.395350073s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:53.480653Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:52.082891Z","time spent":"1.397369312s","remote":"127.0.0.1:57946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:42:53.977338Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898748069827382,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T13:42:53.982150Z","caller":"traceutil/trace.go:172","msg":"trace[52165585] linearizableReadLoop","detail":"{readStateIndex:1208; appliedIndex:1208; }","duration":"504.946699ms","start":"2026-04-22T13:42:53.477176Z","end":"2026-04-22T13:42:53.982123Z","steps":["trace[52165585] 'read index received' (duration: 504.935739ms)","trace[52165585] 'applied index is now lower than readState.Index' (duration: 8.74µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:42:53.982358Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.454218426s","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-22T13:42:53.982454Z","caller":"traceutil/trace.go:172","msg":"trace[1797937458] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1051; }","duration":"1.454315639s","start":"2026-04-22T13:42:52.528091Z","end":"2026-04-22T13:42:53.982407Z","steps":["trace[1797937458] 'agreement among raft nodes before linearized reading' (duration: 1.454165884s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:53.982432Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.197232846s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:53.982551Z","caller":"traceutil/trace.go:172","msg":"trace[617050418] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions; range_end:; response_count:0; response_revision:1051; }","duration":"1.197382611s","start":"2026-04-22T13:42:52.785143Z","end":"2026-04-22T13:42:53.982526Z","steps":["trace[617050418] 'agreement among raft nodes before linearized reading' (duration: 1.197132993s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:53.982633Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:52.785119Z","time spent":"1.197497455s","remote":"127.0.0.1:57858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:42:53.982659Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.860869181s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:53.982709Z","caller":"traceutil/trace.go:172","msg":"trace[1928106294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1052; }","duration":"1.860939472s","start":"2026-04-22T13:42:52.121758Z","end":"2026-04-22T13:42:53.982698Z","steps":["trace[1928106294] 'agreement among raft nodes before linearized reading' (duration: 1.860574322s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:53.982758Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:52.121746Z","time spent":"1.861003964s","remote":"127.0.0.1:57780","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-22T13:42:53.982803Z","caller":"traceutil/trace.go:172","msg":"trace[760816684] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"1.522416929s","start":"2026-04-22T13:42:52.460332Z","end":"2026-04-22T13:42:53.982749Z","steps":["trace[760816684] 'process raft request' (duration: 1.521869863s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:53.982942Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:52.460309Z","time spent":"1.522555175s","remote":"127.0.0.1:57892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T13:42:53.982934Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.524126391s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lj8hx\" limit:1 ","response":"range_response_count:1 size:18521"} {"level":"info","ts":"2026-04-22T13:42:53.983032Z","caller":"traceutil/trace.go:172","msg":"trace[2114721155] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lj8hx; range_end:; response_count:1; response_revision:1052; }","duration":"1.524234764s","start":"2026-04-22T13:42:52.458782Z","end":"2026-04-22T13:42:53.983017Z","steps":["trace[2114721155] 'agreement among raft nodes before linearized reading' (duration: 1.523530533s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:53.983116Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:52.458739Z","time spent":"1.524362768s","remote":"127.0.0.1:58122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18545,"request content":"key:\"/registry/pods/kube-system/cilium-lj8hx\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:42:54.002985Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.32291382s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:54.003071Z","caller":"traceutil/trace.go:172","msg":"trace[22987887] range","detail":"{range_begin:/registry/resourcequotas; range_end:; response_count:0; response_revision:1052; }","duration":"1.323009132s","start":"2026-04-22T13:42:52.680042Z","end":"2026-04-22T13:42:54.003051Z","steps":["trace[22987887] 'agreement among raft nodes before linearized reading' (duration: 1.302287514s)","trace[22987887] 'range keys from in-memory index tree' (duration: 20.571264ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:42:54.003113Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:52.680009Z","time spent":"1.323094345s","remote":"127.0.0.1:57918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas\" limit:1 "} {"level":"info","ts":"2026-04-22T13:42:54.063731Z","caller":"traceutil/trace.go:172","msg":"trace[1981703518] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"442.615221ms","start":"2026-04-22T13:42:53.621078Z","end":"2026-04-22T13:42:54.063693Z","steps":["trace[1981703518] 'process raft request' (duration: 442.523999ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:54.063857Z","caller":"traceutil/trace.go:172","msg":"trace[834260440] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"505.132198ms","start":"2026-04-22T13:42:53.558699Z","end":"2026-04-22T13:42:54.063831Z","steps":["trace[834260440] 'process raft request' (duration: 504.508679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:54.063969Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:53.621049Z","time spent":"442.793977ms","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":495,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:42:54.064021Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:53.558663Z","time spent":"505.287103ms","remote":"127.0.0.1:58784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:42:54.226879Z","caller":"traceutil/trace.go:172","msg":"trace[515566386] linearizableReadLoop","detail":"{readStateIndex:1210; appliedIndex:1212; }","duration":"244.611243ms","start":"2026-04-22T13:42:53.982235Z","end":"2026-04-22T13:42:54.226846Z","steps":["trace[515566386] 'read index received' (duration: 244.599983ms)","trace[515566386] 'applied index is now lower than readState.Index' (duration: 8.67µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:42:54.227105Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"604.244585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T13:42:54.227155Z","caller":"traceutil/trace.go:172","msg":"trace[386582729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1054; }","duration":"604.334328ms","start":"2026-04-22T13:42:53.622810Z","end":"2026-04-22T13:42:54.227145Z","steps":["trace[386582729] 'agreement among raft nodes before linearized reading' (duration: 604.061781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:54.227190Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:53.622797Z","time spent":"604.38656ms","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:42:54.227191Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"662.981879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:54.227296Z","caller":"traceutil/trace.go:172","msg":"trace[783545236] range","detail":"{range_begin:/registry/runtimeclasses; range_end:; response_count:0; response_revision:1054; }","duration":"663.128873ms","start":"2026-04-22T13:42:53.564148Z","end":"2026-04-22T13:42:54.227277Z","steps":["trace[783545236] 'agreement among raft nodes before linearized reading' (duration: 662.881526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:54.227362Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:53.564126Z","time spent":"663.225966ms","remote":"127.0.0.1:58418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses\" limit:1 "} {"level":"info","ts":"2026-04-22T13:42:54.227467Z","caller":"traceutil/trace.go:172","msg":"trace[2029699733] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"238.431339ms","start":"2026-04-22T13:42:53.989018Z","end":"2026-04-22T13:42:54.227449Z","steps":["trace[2029699733] 'process raft request' (duration: 237.970006ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:54.227926Z","caller":"traceutil/trace.go:172","msg":"trace[1785133286] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"227.923575ms","start":"2026-04-22T13:42:53.999984Z","end":"2026-04-22T13:42:54.227907Z","steps":["trace[1785133286] 'process raft request' (duration: 227.224124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:54.727854Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898748069827389,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T13:42:55.228229Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898748069827389,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T13:42:55.492367Z","caller":"traceutil/trace.go:172","msg":"trace[1822829047] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"1.307104898s","start":"2026-04-22T13:42:54.185128Z","end":"2026-04-22T13:42:55.492232Z","steps":["trace[1822829047] 'process raft request' (duration: 1.307055557s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:55.492690Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:54.185088Z","time spent":"1.307452439s","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:42:55.670193Z","caller":"traceutil/trace.go:172","msg":"trace[2014882365] linearizableReadLoop","detail":"{readStateIndex:1215; appliedIndex:1217; }","duration":"1.443192632s","start":"2026-04-22T13:42:54.226971Z","end":"2026-04-22T13:42:55.670163Z","steps":["trace[2014882365] 'read index received' (duration: 1.443183641s)","trace[2014882365] 'applied index is now lower than readState.Index' (duration: 7.33µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:42:55.670376Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.667171411s","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-22T13:42:55.670416Z","caller":"traceutil/trace.go:172","msg":"trace[647435844] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1059; }","duration":"1.667245043s","start":"2026-04-22T13:42:54.003160Z","end":"2026-04-22T13:42:55.670405Z","steps":["trace[647435844] 'agreement among raft nodes before linearized reading' (duration: 1.66714566s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:55.670445Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.635724566s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-04-22T13:42:55.670492Z","caller":"traceutil/trace.go:172","msg":"trace[941073253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1059; }","duration":"1.635779237s","start":"2026-04-22T13:42:54.034701Z","end":"2026-04-22T13:42:55.670480Z","steps":["trace[941073253] 'agreement among raft nodes before linearized reading' (duration: 1.63554664s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:55.670542Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:54.034674Z","time spent":"1.63585809s","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":466,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:42:55.670589Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.593036506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:55.670689Z","caller":"traceutil/trace.go:172","msg":"trace[237844210] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:1059; }","duration":"1.5931569s","start":"2026-04-22T13:42:54.077508Z","end":"2026-04-22T13:42:55.670665Z","steps":["trace[237844210] 'agreement among raft nodes before linearized reading' (duration: 1.592977414s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:55.670645Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.686214788s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:55.671205Z","caller":"traceutil/trace.go:172","msg":"trace[885231538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"1.686799316s","start":"2026-04-22T13:42:53.984379Z","end":"2026-04-22T13:42:55.671179Z","steps":["trace[885231538] 'agreement among raft nodes before linearized reading' (duration: 1.686124405s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:55.671280Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:53.984363Z","time spent":"1.686903089s","remote":"127.0.0.1:57768","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-22T13:42:55.670747Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:54.077474Z","time spent":"1.593262904s","remote":"127.0.0.1:58234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:42:56.170800Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898748069827392,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T13:42:56.241159Z","caller":"traceutil/trace.go:172","msg":"trace[1993973649] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"2.007996268s","start":"2026-04-22T13:42:54.233127Z","end":"2026-04-22T13:42:56.241123Z","steps":["trace[1993973649] 'process raft request' (duration: 2.007574655s)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.241212Z","caller":"traceutil/trace.go:172","msg":"trace[1678547771] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"2.007116331s","start":"2026-04-22T13:42:54.234027Z","end":"2026-04-22T13:42:56.241143Z","steps":["trace[1678547771] 'process raft request' (duration: 2.007028619s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:56.241370Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:54.233079Z","time spent":"2.008198254s","remote":"127.0.0.1:57892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":708,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T13:42:56.241409Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:54.233940Z","time spent":"2.00739105s","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:42:56.399079Z","caller":"traceutil/trace.go:172","msg":"trace[1229406507] linearizableReadLoop","detail":"{readStateIndex:1217; appliedIndex:1219; }","duration":"728.772643ms","start":"2026-04-22T13:42:55.670279Z","end":"2026-04-22T13:42:56.399051Z","steps":["trace[1229406507] 'read index received' (duration: 728.759842ms)","trace[1229406507] 'applied index is now lower than readState.Index' (duration: 10.561µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:42:56.399183Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.834502184s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:42:56.399215Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.666620325s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-22T13:42:56.399243Z","caller":"traceutil/trace.go:172","msg":"trace[364458369] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices; range_end:; response_count:0; response_revision:1061; }","duration":"1.834580826s","start":"2026-04-22T13:42:54.564645Z","end":"2026-04-22T13:42:56.399226Z","steps":["trace[364458369] 'agreement among raft nodes before linearized reading' (duration: 1.834457733s)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.399270Z","caller":"traceutil/trace.go:172","msg":"trace[194549561] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:1061; }","duration":"1.666674836s","start":"2026-04-22T13:42:54.732577Z","end":"2026-04-22T13:42:56.399252Z","steps":["trace[194549561] 'agreement among raft nodes before linearized reading' (duration: 1.6664786s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:56.399302Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:54.732510Z","time spent":"1.666783138s","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.53\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:42:56.399299Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:54.564621Z","time spent":"1.834664829s","remote":"127.0.0.1:58910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":29,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:42:56.399379Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.164085661s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lj8hx\" limit:1 ","response":"range_response_count:1 size:18619"} {"level":"info","ts":"2026-04-22T13:42:56.399423Z","caller":"traceutil/trace.go:172","msg":"trace[840778357] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lj8hx; range_end:; response_count:1; response_revision:1062; }","duration":"2.164131663s","start":"2026-04-22T13:42:54.235279Z","end":"2026-04-22T13:42:56.399410Z","steps":["trace[840778357] 'agreement among raft nodes before linearized reading' (duration: 2.163937817s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:56.399459Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:54.235252Z","time spent":"2.164196895s","remote":"127.0.0.1:58122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18643,"request content":"key:\"/registry/pods/kube-system/cilium-lj8hx\" limit:1 "} {"level":"info","ts":"2026-04-22T13:42:56.399804Z","caller":"traceutil/trace.go:172","msg":"trace[821779567] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"724.65653ms","start":"2026-04-22T13:42:55.675130Z","end":"2026-04-22T13:42:56.399786Z","steps":["trace[821779567] 'process raft request' (duration: 723.95174ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.399880Z","caller":"traceutil/trace.go:172","msg":"trace[645098064] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"328.432637ms","start":"2026-04-22T13:42:56.071432Z","end":"2026-04-22T13:42:56.399864Z","steps":["trace[645098064] 'process raft request' (duration: 327.795928ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.399907Z","caller":"traceutil/trace.go:172","msg":"trace[751040295] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"317.00219ms","start":"2026-04-22T13:42:56.082889Z","end":"2026-04-22T13:42:56.399891Z","steps":["trace[751040295] 'process raft request' (duration: 316.633379ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.399911Z","caller":"traceutil/trace.go:172","msg":"trace[1327574944] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"312.492586ms","start":"2026-04-22T13:42:56.087401Z","end":"2026-04-22T13:42:56.399894Z","steps":["trace[1327574944] 'process raft request' (duration: 312.450245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:56.399922Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:55.675097Z","time spent":"724.754684ms","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":426,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:42:56.399975Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:56.071381Z","time spent":"328.527319ms","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:42:56.399987Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:56.082841Z","time spent":"317.104634ms","remote":"127.0.0.1:57946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:42:56.400033Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:56.087368Z","time spent":"312.60199ms","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":676,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:42:56.437565Z","caller":"traceutil/trace.go:172","msg":"trace[889079814] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"191.56657ms","start":"2026-04-22T13:42:56.245965Z","end":"2026-04-22T13:42:56.437532Z","steps":["trace[889079814] 'process raft request' (duration: 191.438307ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.567673Z","caller":"traceutil/trace.go:172","msg":"trace[348374987] linearizableReadLoop","detail":"{readStateIndex:1223; appliedIndex:1224; }","duration":"168.459318ms","start":"2026-04-22T13:42:56.399180Z","end":"2026-04-22T13:42:56.567639Z","steps":["trace[348374987] 'read index received' (duration: 168.449128ms)","trace[348374987] 'applied index is now lower than readState.Index' (duration: 8.34µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:42:56.568018Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"702.741052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:56.568077Z","caller":"traceutil/trace.go:172","msg":"trace[885968915] range","detail":"{range_begin:/registry/resourceslices; range_end:; response_count:0; response_revision:1066; }","duration":"702.799044ms","start":"2026-04-22T13:42:55.865266Z","end":"2026-04-22T13:42:56.568065Z","steps":["trace[885968915] 'agreement among raft nodes before linearized reading' (duration: 702.708561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:56.568123Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:55.865250Z","time spent":"702.864076ms","remote":"127.0.0.1:58904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":29,"request content":"key:\"/registry/resourceslices\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:42:56.568111Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"886.546774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:42:56.568191Z","caller":"traceutil/trace.go:172","msg":"trace[220868832] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1066; }","duration":"886.646587ms","start":"2026-04-22T13:42:55.681528Z","end":"2026-04-22T13:42:56.568175Z","steps":["trace[220868832] 'agreement among raft nodes before linearized reading' (duration: 886.493782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:56.568252Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:42:55.681503Z","time spent":"886.74116ms","remote":"127.0.0.1:57780","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-22T13:42:56.567875Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"893.066747ms","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-22T13:42:56.568569Z","caller":"traceutil/trace.go:172","msg":"trace[47204073] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1066; }","duration":"893.782858ms","start":"2026-04-22T13:42:55.674748Z","end":"2026-04-22T13:42:56.568531Z","steps":["trace[47204073] 'agreement among raft nodes before linearized reading' (duration: 893.017656ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.568918Z","caller":"traceutil/trace.go:172","msg":"trace[2038901223] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"149.756557ms","start":"2026-04-22T13:42:56.419147Z","end":"2026-04-22T13:42:56.568904Z","steps":["trace[2038901223] 'process raft request' (duration: 149.688385ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.575071Z","caller":"traceutil/trace.go:172","msg":"trace[168144545] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"134.070974ms","start":"2026-04-22T13:42:56.440958Z","end":"2026-04-22T13:42:56.575029Z","steps":["trace[168144545] 'process raft request' (duration: 133.890299ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.575418Z","caller":"traceutil/trace.go:172","msg":"trace[2086439040] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"109.238732ms","start":"2026-04-22T13:42:56.466158Z","end":"2026-04-22T13:42:56.575397Z","steps":["trace[2086439040] 'process raft request' (duration: 108.789169ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.748318Z","caller":"traceutil/trace.go:172","msg":"trace[1942215833] linearizableReadLoop","detail":"{readStateIndex:1230; appliedIndex:1231; }","duration":"168.280403ms","start":"2026-04-22T13:42:56.580015Z","end":"2026-04-22T13:42:56.748296Z","steps":["trace[1942215833] 'read index received' (duration: 168.273513ms)","trace[1942215833] 'applied index is now lower than readState.Index' (duration: 5.95µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:42:56.748611Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"168.578102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" limit:1 ","response":"range_response_count:1 size:460"} {"level":"info","ts":"2026-04-22T13:42:56.748664Z","caller":"traceutil/trace.go:172","msg":"trace[1218945836] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1072; }","duration":"168.644754ms","start":"2026-04-22T13:42:56.580007Z","end":"2026-04-22T13:42:56.748652Z","steps":["trace[1218945836] 'agreement among raft nodes before linearized reading' (duration: 168.410246ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.752319Z","caller":"traceutil/trace.go:172","msg":"trace[1961267092] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"120.813443ms","start":"2026-04-22T13:42:56.631496Z","end":"2026-04-22T13:42:56.752310Z","steps":["trace[1961267092] 'process raft request' (duration: 120.786502ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:42:56.752348Z","caller":"traceutil/trace.go:172","msg":"trace[1752427024] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"159.978299ms","start":"2026-04-22T13:42:56.592358Z","end":"2026-04-22T13:42:56.752337Z","steps":["trace[1752427024] 'process raft request' (duration: 159.874866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:42:56.821663Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"236.396902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" limit:1 ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-22T13:42:56.821823Z","caller":"traceutil/trace.go:172","msg":"trace[112099136] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:1075; }","duration":"236.564808ms","start":"2026-04-22T13:42:56.585242Z","end":"2026-04-22T13:42:56.821807Z","steps":["trace[112099136] 'agreement among raft nodes before linearized reading' (duration: 236.231468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:43:01.532058Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39928","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:01.551017Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39962","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:01.578869Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39994","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:01.625128Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40028","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:01.650914Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40050","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:01.669972Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40066","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:01.764207Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40092","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:01.856891Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40106","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:01.991597Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40128","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.010666Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40132","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.036138Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40166","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.086053Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40172","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.109099Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40188","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.151613Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40204","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.176351Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40222","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.199055Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40240","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.215813Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40248","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.233847Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40260","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.281994Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40286","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-22T13:43:02.441313Z","caller":"traceutil/trace.go:172","msg":"trace[418605605] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"130.614023ms","start":"2026-04-22T13:43:02.310667Z","end":"2026-04-22T13:43:02.441281Z","steps":["trace[418605605] 'process raft request' (duration: 130.353516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:43:02.446404Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40304","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.460537Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40314","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.478516Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40336","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:02.493026Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40344","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:07.925475Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34750","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:10.975168Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34754","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:11.004768Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34782","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:11.018747Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34806","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:11.432365Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34838","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:33.543904Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53976","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:33.567588Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40766","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:33.583580Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40780","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:33.605914Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40814","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:43:33.622805Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40838","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-22T13:43:40.802648Z","caller":"traceutil/trace.go:172","msg":"trace[84221206] transaction","detail":"{read_only:false; response_revision:1511; number_of_response:1; }","duration":"112.546566ms","start":"2026-04-22T13:43:40.690078Z","end":"2026-04-22T13:43:40.802625Z","steps":["trace[84221206] 'process raft request' (duration: 112.373961ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:45.238079Z","caller":"traceutil/trace.go:172","msg":"trace[1065837599] linearizableReadLoop","detail":"{readStateIndex:1767; appliedIndex:1767; }","duration":"287.906262ms","start":"2026-04-22T13:43:44.950144Z","end":"2026-04-22T13:43:45.238050Z","steps":["trace[1065837599] 'read index received' (duration: 287.901172ms)","trace[1065837599] 'applied index is now lower than readState.Index' (duration: 4.08µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:43:45.238874Z","caller":"traceutil/trace.go:172","msg":"trace[959189886] transaction","detail":"{read_only:false; response_revision:1526; number_of_response:1; }","duration":"329.933517ms","start":"2026-04-22T13:43:44.908916Z","end":"2026-04-22T13:43:45.238850Z","steps":["trace[959189886] 'process raft request' (duration: 329.362143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:43:45.239041Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:43:44.908897Z","time spent":"330.07067ms","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":427,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:43:45.239371Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"114.526209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:43:45.239404Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"289.259606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T13:43:45.239481Z","caller":"traceutil/trace.go:172","msg":"trace[563092618] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1526; }","duration":"114.651762ms","start":"2026-04-22T13:43:45.124814Z","end":"2026-04-22T13:43:45.239466Z","steps":["trace[563092618] 'agreement among raft nodes before linearized reading' (duration: 114.478468ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:45.239486Z","caller":"traceutil/trace.go:172","msg":"trace[1554499561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1526; }","duration":"289.348748ms","start":"2026-04-22T13:43:44.950126Z","end":"2026-04-22T13:43:45.239475Z","steps":["trace[1554499561] 'agreement among raft nodes before linearized reading' (duration: 288.050196ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:45.898972Z","caller":"traceutil/trace.go:172","msg":"trace[40276753] transaction","detail":"{read_only:false; response_revision:1529; number_of_response:1; }","duration":"100.540723ms","start":"2026-04-22T13:43:45.798407Z","end":"2026-04-22T13:43:45.898948Z","steps":["trace[40276753] 'process raft request' (duration: 100.369039ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:47.410194Z","caller":"traceutil/trace.go:172","msg":"trace[997297588] transaction","detail":"{read_only:false; response_revision:1533; number_of_response:1; }","duration":"157.066589ms","start":"2026-04-22T13:43:47.253103Z","end":"2026-04-22T13:43:47.410169Z","steps":["trace[997297588] 'process raft request' (duration: 156.856974ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:47.488734Z","caller":"traceutil/trace.go:172","msg":"trace[1895887330] linearizableReadLoop","detail":"{readStateIndex:1775; appliedIndex:1776; }","duration":"182.092905ms","start":"2026-04-22T13:43:47.306608Z","end":"2026-04-22T13:43:47.488701Z","steps":["trace[1895887330] 'read index received' (duration: 182.085155ms)","trace[1895887330] 'applied index is now lower than readState.Index' (duration: 6.39µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:43:47.488989Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"182.362183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T13:43:47.489046Z","caller":"traceutil/trace.go:172","msg":"trace[562670056] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1533; }","duration":"182.438674ms","start":"2026-04-22T13:43:47.306589Z","end":"2026-04-22T13:43:47.489027Z","steps":["trace[562670056] 'agreement among raft nodes before linearized reading' (duration: 182.23062ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:47.489009Z","caller":"traceutil/trace.go:172","msg":"trace[1013943605] transaction","detail":"{read_only:false; response_revision:1534; number_of_response:1; }","duration":"149.566455ms","start":"2026-04-22T13:43:47.339419Z","end":"2026-04-22T13:43:47.488986Z","steps":["trace[1013943605] 'process raft request' (duration: 149.405531ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:47.652607Z","caller":"traceutil/trace.go:172","msg":"trace[4232075] linearizableReadLoop","detail":"{readStateIndex:1777; appliedIndex:1778; }","duration":"124.354293ms","start":"2026-04-22T13:43:47.528236Z","end":"2026-04-22T13:43:47.652590Z","steps":["trace[4232075] 'read index received' (duration: 124.349023ms)","trace[4232075] 'applied index is now lower than readState.Index' (duration: 4.53µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:43:47.652731Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"124.506567ms","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-22T13:43:47.652761Z","caller":"traceutil/trace.go:172","msg":"trace[228915415] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1535; }","duration":"124.555479ms","start":"2026-04-22T13:43:47.528197Z","end":"2026-04-22T13:43:47.652752Z","steps":["trace[228915415] 'agreement among raft nodes before linearized reading' (duration: 124.482087ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:47.652989Z","caller":"traceutil/trace.go:172","msg":"trace[1073419598] transaction","detail":"{read_only:false; response_revision:1536; number_of_response:1; }","duration":"157.449569ms","start":"2026-04-22T13:43:47.495521Z","end":"2026-04-22T13:43:47.652971Z","steps":["trace[1073419598] 'process raft request' (duration: 157.236594ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:49.558863Z","caller":"traceutil/trace.go:172","msg":"trace[1048348531] transaction","detail":"{read_only:false; response_revision:1544; number_of_response:1; }","duration":"137.631259ms","start":"2026-04-22T13:43:49.421208Z","end":"2026-04-22T13:43:49.558839Z","steps":["trace[1048348531] 'process raft request' (duration: 137.473185ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:50.150953Z","caller":"traceutil/trace.go:172","msg":"trace[1683446914] transaction","detail":"{read_only:false; response_revision:1547; number_of_response:1; }","duration":"173.107646ms","start":"2026-04-22T13:43:49.977794Z","end":"2026-04-22T13:43:50.150902Z","steps":["trace[1683446914] 'process raft request' (duration: 172.83305ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:51.105986Z","caller":"traceutil/trace.go:172","msg":"trace[1275744494] linearizableReadLoop","detail":"{readStateIndex:1793; appliedIndex:1793; }","duration":"102.28231ms","start":"2026-04-22T13:43:51.003674Z","end":"2026-04-22T13:43:51.105956Z","steps":["trace[1275744494] 'read index received' (duration: 102.274948ms)","trace[1275744494] 'applied index is now lower than readState.Index' (duration: 6.172µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:43:51.106283Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"102.576876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" limit:1 ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-04-22T13:43:51.106327Z","caller":"traceutil/trace.go:172","msg":"trace[1839883547] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1548; }","duration":"102.652708ms","start":"2026-04-22T13:43:51.003663Z","end":"2026-04-22T13:43:51.106315Z","steps":["trace[1839883547] 'agreement among raft nodes before linearized reading' (duration: 102.410662ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:51.106409Z","caller":"traceutil/trace.go:172","msg":"trace[1629772664] transaction","detail":"{read_only:false; response_revision:1549; number_of_response:1; }","duration":"118.384943ms","start":"2026-04-22T13:43:50.988004Z","end":"2026-04-22T13:43:51.106389Z","steps":["trace[1629772664] 'process raft request' (duration: 118.178648ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:51.315147Z","caller":"traceutil/trace.go:172","msg":"trace[24612911] transaction","detail":"{read_only:false; response_revision:1550; number_of_response:1; }","duration":"191.856609ms","start":"2026-04-22T13:43:51.123274Z","end":"2026-04-22T13:43:51.315131Z","steps":["trace[24612911] 'process raft request' (duration: 191.745866ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:51.615847Z","caller":"traceutil/trace.go:172","msg":"trace[1978582473] transaction","detail":"{read_only:false; response_revision:1552; number_of_response:1; }","duration":"214.748185ms","start":"2026-04-22T13:43:51.401085Z","end":"2026-04-22T13:43:51.615833Z","steps":["trace[1978582473] 'process raft request' (duration: 214.634603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:43:51.684938Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"119.461356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-04-22T13:43:51.685011Z","caller":"traceutil/trace.go:172","msg":"trace[385041957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1552; }","duration":"119.573709ms","start":"2026-04-22T13:43:51.565423Z","end":"2026-04-22T13:43:51.684996Z","steps":["trace[385041957] 'agreement among raft nodes before linearized reading' (duration: 119.309913ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:43:55.630757Z","caller":"traceutil/trace.go:172","msg":"trace[213077388] linearizableReadLoop","detail":"{readStateIndex:1815; appliedIndex:1815; }","duration":"102.351529ms","start":"2026-04-22T13:43:55.528376Z","end":"2026-04-22T13:43:55.630728Z","steps":["trace[213077388] 'read index received' (duration: 102.344639ms)","trace[213077388] 'applied index is now lower than readState.Index' (duration: 5.46µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:43:55.630981Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"102.573934ms","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-22T13:43:55.631042Z","caller":"traceutil/trace.go:172","msg":"trace[1109746857] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1567; }","duration":"102.651448ms","start":"2026-04-22T13:43:55.528369Z","end":"2026-04-22T13:43:55.631020Z","steps":["trace[1109746857] 'agreement among raft nodes before linearized reading' (duration: 102.472313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:43:58.593380Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"d572cd2c5e037401","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"73.28875ms"} {"level":"warn","ts":"2026-04-22T13:43:58.593487Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"2d1f7416f90aa1b7","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"73.413543ms"} {"level":"info","ts":"2026-04-22T13:43:58.594582Z","caller":"traceutil/trace.go:172","msg":"trace[820188292] transaction","detail":"{read_only:false; response_revision:1580; number_of_response:1; }","duration":"274.093589ms","start":"2026-04-22T13:43:58.320466Z","end":"2026-04-22T13:43:58.594560Z","steps":["trace[820188292] 'process raft request' (duration: 273.878084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:43:58.991724Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898748069828149,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T13:43:59.480103Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"d572cd2c5e037401","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"686.585026ms"} {"level":"warn","ts":"2026-04-22T13:43:59.480189Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"2d1f7416f90aa1b7","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"686.684529ms"} {"level":"info","ts":"2026-04-22T13:43:59.480625Z","caller":"traceutil/trace.go:172","msg":"trace[294816155] linearizableReadLoop","detail":"{readStateIndex:1830; appliedIndex:1830; }","duration":"989.029646ms","start":"2026-04-22T13:43:58.491571Z","end":"2026-04-22T13:43:59.480601Z","steps":["trace[294816155] 'read index received' (duration: 989.021245ms)","trace[294816155] 'applied index is now lower than readState.Index' (duration: 6.961µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:43:59.981180Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898748069828153,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T13:44:00.099132Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"d572cd2c5e037401","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"418.914132ms"} {"level":"warn","ts":"2026-04-22T13:44:00.099168Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.607578939s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:44:00.099257Z","caller":"traceutil/trace.go:172","msg":"trace[640081552] range","detail":"{range_begin:/registry/volumeattachments; range_end:; response_count:0; response_revision:1580; }","duration":"1.607675481s","start":"2026-04-22T13:43:58.491554Z","end":"2026-04-22T13:44:00.099230Z","steps":["trace[640081552] 'agreement among raft nodes before linearized reading' (duration: 989.162598ms)","trace[640081552] 'range keys from in-memory index tree' (duration: 618.382819ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:44:00.099304Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:43:58.491518Z","time spent":"1.607773924s","remote":"127.0.0.1:58550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":31,"response count":0,"response size":29,"request content":"key:\"/registry/volumeattachments\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:44:00.101423Z","caller":"etcdserver/v3_server.go:888","msg":"ignored out-of-date read index response; local node read indexes queueing up and waiting to be in sync with leader","sent-request-id":5794898748069828153,"received-request-id":5794898748069828149} {"level":"warn","ts":"2026-04-22T13:44:00.099203Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"2d1f7416f90aa1b7","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"418.995985ms"} {"level":"warn","ts":"2026-04-22T13:44:00.102130Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"621.289428ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:44:00.102428Z","caller":"traceutil/trace.go:172","msg":"trace[1076968146] transaction","detail":"{read_only:false; response_revision:1585; number_of_response:1; }","duration":"654.466597ms","start":"2026-04-22T13:43:59.447944Z","end":"2026-04-22T13:44:00.102410Z","steps":["trace[1076968146] 'process raft request' (duration: 654.423056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:44:00.102521Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:43:59.447910Z","time spent":"654.564008ms","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":537,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:44:00.102922Z","caller":"traceutil/trace.go:172","msg":"trace[1420599837] transaction","detail":"{read_only:false; response_revision:1584; number_of_response:1; }","duration":"837.528964ms","start":"2026-04-22T13:43:59.265332Z","end":"2026-04-22T13:44:00.102861Z","steps":["trace[1420599837] 'process raft request' (duration: 837.000981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:44:00.102997Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:43:59.265297Z","time spent":"837.665927ms","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:44:00.103163Z","caller":"traceutil/trace.go:172","msg":"trace[1007525415] linearizableReadLoop","detail":"{readStateIndex:1831; appliedIndex:1835; }","duration":"622.473346ms","start":"2026-04-22T13:43:59.480680Z","end":"2026-04-22T13:44:00.103153Z","steps":["trace[1007525415] 'read index received' (duration: 622.468916ms)","trace[1007525415] 'applied index is now lower than readState.Index' (duration: 3.69µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:44:00.103486Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"982.476187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:44:00.103543Z","caller":"traceutil/trace.go:172","msg":"trace[1438232990] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1585; }","duration":"982.544079ms","start":"2026-04-22T13:43:59.120988Z","end":"2026-04-22T13:44:00.103532Z","steps":["trace[1438232990] 'agreement among raft nodes before linearized reading' (duration: 982.452166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:44:00.103575Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:43:59.120963Z","time spent":"982.606729ms","remote":"127.0.0.1:57780","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-22T13:44:00.104148Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.575728449s","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-22T13:44:00.104902Z","caller":"traceutil/trace.go:172","msg":"trace[63938621] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1585; }","duration":"1.576662412s","start":"2026-04-22T13:43:58.528199Z","end":"2026-04-22T13:44:00.104862Z","steps":["trace[63938621] 'agreement among raft nodes before linearized reading' (duration: 1.575692679s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:44:00.105206Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.609326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-04-22T13:44:00.105242Z","caller":"traceutil/trace.go:172","msg":"trace[1054361835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1585; }","duration":"109.650047ms","start":"2026-04-22T13:43:59.995585Z","end":"2026-04-22T13:44:00.105235Z","steps":["trace[1054361835] 'agreement among raft nodes before linearized reading' (duration: 109.233577ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:44:04.905200Z","caller":"traceutil/trace.go:172","msg":"trace[1323950175] transaction","detail":"{read_only:false; response_revision:1604; number_of_response:1; }","duration":"114.306436ms","start":"2026-04-22T13:44:04.790872Z","end":"2026-04-22T13:44:04.905179Z","steps":["trace[1323950175] 'process raft request' (duration: 114.184853ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:44:06.286142Z","caller":"traceutil/trace.go:172","msg":"trace[1982993012] transaction","detail":"{read_only:false; response_revision:1606; number_of_response:1; }","duration":"114.245618ms","start":"2026-04-22T13:44:06.171878Z","end":"2026-04-22T13:44:06.286123Z","steps":["trace[1982993012] 'process raft request' (duration: 114.116655ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:44:06.925743Z","caller":"traceutil/trace.go:172","msg":"trace[1680486287] linearizableReadLoop","detail":"{readStateIndex:1863; appliedIndex:1864; }","duration":"248.887202ms","start":"2026-04-22T13:44:06.676825Z","end":"2026-04-22T13:44:06.925712Z","steps":["trace[1680486287] 'read index received' (duration: 248.874432ms)","trace[1680486287] 'applied index is now lower than readState.Index' (duration: 11.29µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:44:06.925916Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"249.044886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:44:06.926001Z","caller":"traceutil/trace.go:172","msg":"trace[1916691870] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters; range_end:; response_count:0; response_revision:1609; }","duration":"249.165629ms","start":"2026-04-22T13:44:06.676818Z","end":"2026-04-22T13:44:06.925984Z","steps":["trace[1916691870] 'agreement among raft nodes before linearized reading' (duration: 248.996225ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:44:06.926055Z","caller":"traceutil/trace.go:172","msg":"trace[1210086948] transaction","detail":"{read_only:false; response_revision:1610; number_of_response:1; }","duration":"241.893159ms","start":"2026-04-22T13:44:06.684139Z","end":"2026-04-22T13:44:06.926032Z","steps":["trace[1210086948] 'process raft request' (duration: 241.719175ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:44:07.952585Z","caller":"traceutil/trace.go:172","msg":"trace[1016159684] linearizableReadLoop","detail":"{readStateIndex:1867; appliedIndex:1868; }","duration":"120.125166ms","start":"2026-04-22T13:44:07.832435Z","end":"2026-04-22T13:44:07.952560Z","steps":["trace[1016159684] 'read index received' (duration: 120.120206ms)","trace[1016159684] 'applied index is now lower than readState.Index' (duration: 4.02µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:44:07.952731Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"120.288761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:44:07.952764Z","caller":"traceutil/trace.go:172","msg":"trace[1879752822] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes; range_end:; response_count:0; response_revision:1612; }","duration":"120.335252ms","start":"2026-04-22T13:44:07.832417Z","end":"2026-04-22T13:44:07.952753Z","steps":["trace[1879752822] 'agreement among raft nodes before linearized reading' (duration: 120.25724ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:44:08.432667Z","caller":"traceutil/trace.go:172","msg":"trace[1700160797] transaction","detail":"{read_only:false; response_revision:1615; number_of_response:1; }","duration":"140.114422ms","start":"2026-04-22T13:44:08.292535Z","end":"2026-04-22T13:44:08.432649Z","steps":["trace[1700160797] 'process raft request' (duration: 139.985649ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:44:08.770428Z","caller":"traceutil/trace.go:172","msg":"trace[1884940239] linearizableReadLoop","detail":"{readStateIndex:1872; appliedIndex:1872; }","duration":"241.587589ms","start":"2026-04-22T13:44:08.528787Z","end":"2026-04-22T13:44:08.770375Z","steps":["trace[1884940239] 'read index received' (duration: 241.581869ms)","trace[1884940239] 'applied index is now lower than readState.Index' (duration: 4.83µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:44:08.770565Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"241.755254ms","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-22T13:44:08.770595Z","caller":"traceutil/trace.go:172","msg":"trace[731909368] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1616; }","duration":"241.807755ms","start":"2026-04-22T13:44:08.528778Z","end":"2026-04-22T13:44:08.770586Z","steps":["trace[731909368] 'agreement among raft nodes before linearized reading' (duration: 241.727613ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:44:08.770806Z","caller":"traceutil/trace.go:172","msg":"trace[866327593] transaction","detail":"{read_only:false; response_revision:1617; number_of_response:1; }","duration":"332.637467ms","start":"2026-04-22T13:44:08.438141Z","end":"2026-04-22T13:44:08.770778Z","steps":["trace[866327593] 'process raft request' (duration: 332.450352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:44:08.771228Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:44:08.438118Z","time spent":"333.000574ms","remote":"127.0.0.1:58294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:44:10.676680Z","caller":"traceutil/trace.go:172","msg":"trace[549813121] transaction","detail":"{read_only:false; response_revision:1622; number_of_response:1; }","duration":"237.415612ms","start":"2026-04-22T13:44:10.439249Z","end":"2026-04-22T13:44:10.676664Z","steps":["trace[549813121] 'process raft request' (duration: 237.30183ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:44:10.740874Z","caller":"traceutil/trace.go:172","msg":"trace[838150673] linearizableReadLoop","detail":"{readStateIndex:1878; appliedIndex:1879; }","duration":"266.89949ms","start":"2026-04-22T13:44:10.473952Z","end":"2026-04-22T13:44:10.740851Z","steps":["trace[838150673] 'read index received' (duration: 266.89412ms)","trace[838150673] 'applied index is now lower than readState.Index' (duration: 4.62µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:44:10.742058Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"268.082867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-04-22T13:44:10.742104Z","caller":"traceutil/trace.go:172","msg":"trace[1506591147] transaction","detail":"{read_only:false; response_revision:1623; number_of_response:1; }","duration":"282.168502ms","start":"2026-04-22T13:44:10.459910Z","end":"2026-04-22T13:44:10.742079Z","steps":["trace[1506591147] 'process raft request' (duration: 281.181039ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:44:10.742151Z","caller":"traceutil/trace.go:172","msg":"trace[1541203276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1622; }","duration":"268.202761ms","start":"2026-04-22T13:44:10.473931Z","end":"2026-04-22T13:44:10.742133Z","steps":["trace[1541203276] 'agreement among raft nodes before linearized reading' (duration: 267.082435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:44:10.800741Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"271.971998ms","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-22T13:44:10.800805Z","caller":"traceutil/trace.go:172","msg":"trace[975875203] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1625; }","duration":"272.05107ms","start":"2026-04-22T13:44:10.528743Z","end":"2026-04-22T13:44:10.800794Z","steps":["trace[975875203] 'agreement among raft nodes before linearized reading' (duration: 271.953128ms)"],"step_count":1}