{"level":"warn","ts":"2026-10-21T11:35:12.121146Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-10-21T11:35:12.121287Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-10-21T11:35:12.121299Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.34: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://162.253.55.34:2380","--initial-cluster=controller-1=https://162.253.55.214:2380,controller-2=https://162.253.55.34:2380","--initial-cluster-state=existing","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.34:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.34:2380","--name=controller-2","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--watch-progress-notify-interval=5s"]} {"level":"info","ts":"2026-10-21T11:35:12.121375Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-10-21T11:35:12.121394Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-21T11:35:12.121404Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.34:2380"]} {"level":"info","ts":"2026-10-21T11:35:12.121427Z","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-10-21T11:35:12.121839Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.34:2379"]} {"level":"info","ts":"2026-10-21T11:35:12.122166Z","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-2","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.34:2380"],"listen-peer-urls":["https://162.253.55.34:2380"],"advertise-client-urls":["https://162.253.55.34:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.34:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller-1=https://162.253.55.214:2380,controller-2=https://162.253.55.34:2380","initial-cluster-state":"existing","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"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-10-21T11:35:12.122928Z","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: 0xc0002060f0}"} {"level":"info","ts":"2026-10-21T11:35:12.129152Z","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-10-21T11:35:12.129198Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.358377ms"} {"level":"info","ts":"2026-10-21T11:35:12.129221Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-10-21T11:35:12.129238Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-10-21T11:35:12.146834Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://162.253.55.34:2380","host":"162.253.55.34:2380","resolved-addr":"162.253.55.34:2380"} {"level":"info","ts":"2026-10-21T11:35:12.146894Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://162.253.55.214:2380","host":"162.253.55.214:2380","resolved-addr":"162.253.55.214:2380"} {"level":"info","ts":"2026-10-21T11:35:12.149678Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-10-21T11:35:12.158083Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-10-21T11:35:12.158148Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"28650bddaae87402","cluster-id":"dfe59afaaa064e4a"} {"level":"info","ts":"2026-10-21T11:35:12.158183Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-10-21T11:35:12.158311Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"28650bddaae87402 switched to configuration voters=()"} {"level":"info","ts":"2026-10-21T11:35:12.158375Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"28650bddaae87402 became follower at term 0"} {"level":"info","ts":"2026-10-21T11:35:12.158391Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft 28650bddaae87402 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"warn","ts":"2026-10-21T11:35:12.169054Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-21T11:35:12.171418Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-21T11:35:12.175447Z","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-10-21T11:35:12.176062Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.176085Z","caller":"rafthttp/transport.go:286","msg":"added new remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828","remote-peer-urls":["https://162.253.55.214:2380"]} {"level":"info","ts":"2026-10-21T11:35:12.176100Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.176114Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.176687Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.177053Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.177182Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.177634Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.177332Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828","remote-peer-urls":["https://162.253.55.214:2380"]} {"level":"info","ts":"2026-10-21T11:35:12.177729Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"28650bddaae87402","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-21T11:35:12.177632Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.177940Z","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-10-21T11:35:12.178242Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"162.253.55.34:2380"} {"level":"info","ts":"2026-10-21T11:35:12.178282Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"162.253.55.34:2380"} {"level":"info","ts":"2026-10-21T11:35:12.178494Z","caller":"etcdserver/server.go:499","msg":"starting initial election tick advance","election-ticks":10} {"level":"info","ts":"2026-10-21T11:35:12.179277Z","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-10-21T11:35:12.179448Z","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-10-21T11:35:12.179467Z","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-10-21T11:35:12.180902Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"28650bddaae87402","initial-advertise-peer-urls":["https://162.253.55.34:2380"],"listen-peer-urls":["https://162.253.55.34:2380"],"advertise-client-urls":["https://162.253.55.34:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.34:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-21T11:35:12.180289Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"28650bddaae87402","to":"86f12f2ae020828","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-10-21T11:35:12.181534Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.181919Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.181526Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"28650bddaae87402","to":"86f12f2ae020828","stream-type":"stream Message"} {"level":"info","ts":"2026-10-21T11:35:12.181951Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.181607Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1116","msg":"28650bddaae87402 [term: 0] received a MsgHeartbeat message with higher term from 86f12f2ae020828 [term: 2]"} {"level":"info","ts":"2026-10-21T11:35:12.182010Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"28650bddaae87402 became follower at term 2"} {"level":"info","ts":"2026-10-21T11:35:12.182074Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: 28650bddaae87402 elected leader 86f12f2ae020828 at term 2"} {"level":"info","ts":"2026-10-21T11:35:12.181693Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-21T11:35:12.189646Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.192783Z","caller":"rafthttp/http.go:258","msg":"receiving database snapshot","local-member-id":"28650bddaae87402","remote-snapshot-sender-id":"86f12f2ae020828","incoming-snapshot-index":459,"incoming-snapshot-message-size-bytes":8189,"incoming-snapshot-message-size":"8.2 kB"} {"level":"info","ts":"2026-10-21T11:35:12.196392Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.203257Z","caller":"snap/db.go:65","msg":"saved database snapshot to disk","path":"/var/lib/etcd/member/snap/00000000000001cb.snap.db","bytes":733184,"size":"733 kB"} {"level":"info","ts":"2026-10-21T11:35:12.203293Z","caller":"rafthttp/http.go:287","msg":"received and saved database snapshot","local-member-id":"28650bddaae87402","remote-snapshot-sender-id":"86f12f2ae020828","incoming-snapshot-index":459,"incoming-snapshot-size-bytes":733184,"incoming-snapshot-size":"733 kB","download-took":"10.5976ms"} {"level":"info","ts":"2026-10-21T11:35:12.203417Z","logger":"raft","caller":"v3@v3.6.0/log.go:465","msg":"log [committed=0, applied=0, applying=0, unstable.offset=1, unstable.offsetInProgress=1, len(unstable.Entries)=0] starts to restore snapshot [index: 459, term: 2]"} {"level":"info","ts":"2026-10-21T11:35:12.203505Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"28650bddaae87402 switched to configuration voters=(607725308229060648) learners=(2910745780847932418)"} {"level":"info","ts":"2026-10-21T11:35:12.203533Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1935","msg":"28650bddaae87402 [commit: 459, lastindex: 459, lastterm: 2] restored snapshot [index: 459, term: 2]"} {"level":"info","ts":"2026-10-21T11:35:12.203544Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1844","msg":"28650bddaae87402 [commit: 459] restored snapshot [index: 459, term: 2]"} {"level":"info","ts":"2026-10-21T11:35:12.203629Z","caller":"etcdserver/server.go:1007","msg":"applying snapshot","current-snapshot-index":0,"current-applied-index":0,"incoming-leader-snapshot-index":459,"incoming-leader-snapshot-term":2} {"level":"info","ts":"2026-10-21T11:35:12.209526Z","caller":"etcdserver/raft.go:276","msg":"applied incoming Raft snapshot","snapshot-index":459} {"level":"info","ts":"2026-10-21T11:35:12.209785Z","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: 0xc000078260}"} {"level":"info","ts":"2026-10-21T11:35:12.210218Z","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-10-21T11:35:12.210254Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"516.468µs"} {"level":"info","ts":"2026-10-21T11:35:12.210453Z","caller":"etcdserver/server.go:1055","msg":"restoring lease store"} {"level":"info","ts":"2026-10-21T11:35:12.211902Z","caller":"etcdserver/server.go:1059","msg":"restored lease store"} {"level":"info","ts":"2026-10-21T11:35:12.211926Z","caller":"etcdserver/server.go:1062","msg":"restoring mvcc store"} {"level":"info","ts":"2026-10-21T11:35:12.219540Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":435} {"level":"info","ts":"2026-10-21T11:35:12.219625Z","caller":"etcdserver/server.go:1070","msg":"restored mvcc store","consistent-index":459} {"level":"info","ts":"2026-10-21T11:35:12.219661Z","caller":"etcdserver/server.go:1090","msg":"restoring alarm store"} {"level":"info","ts":"2026-10-21T11:35:12.219740Z","caller":"etcdserver/server.go:1078","msg":"closing old backend file"} {"level":"info","ts":"2026-10-21T11:35:12.223025Z","caller":"etcdserver/server.go:1096","msg":"restored alarm store"} {"level":"info","ts":"2026-10-21T11:35:12.223063Z","caller":"etcdserver/server.go:1099","msg":"restoring auth store"} {"level":"info","ts":"2026-10-21T11:35:12.223092Z","caller":"etcdserver/server.go:1103","msg":"restored auth store"} {"level":"info","ts":"2026-10-21T11:35:12.223103Z","caller":"etcdserver/server.go:1106","msg":"restoring v2 store"} {"level":"info","ts":"2026-10-21T11:35:12.223826Z","caller":"etcdserver/server.go:1115","msg":"restored v2 store"} {"level":"info","ts":"2026-10-21T11:35:12.223872Z","caller":"etcdserver/server.go:1119","msg":"restoring cluster configuration"} {"level":"info","ts":"2026-10-21T11:35:12.223939Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-10-21T11:35:12.223981Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"dfe59afaaa064e4a","local-member-id":"28650bddaae87402","recovered-remote-peer-id":"28650bddaae87402","recovered-remote-peer-urls":["https://162.253.55.34:2380"],"recovered-remote-peer-is-learner":true} {"level":"info","ts":"2026-10-21T11:35:12.224000Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"dfe59afaaa064e4a","local-member-id":"28650bddaae87402","recovered-remote-peer-id":"86f12f2ae020828","recovered-remote-peer-urls":["https://162.253.55.214:2380"],"recovered-remote-peer-is-learner":false} {"level":"info","ts":"2026-10-21T11:35:12.224019Z","caller":"membership/cluster.go:307","msg":"set cluster version from store","cluster-version":"3.6"} {"level":"info","ts":"2026-10-21T11:35:12.224029Z","caller":"etcdserver/server.go:1123","msg":"restored cluster configuration"} {"level":"info","ts":"2026-10-21T11:35:12.224042Z","caller":"etcdserver/server.go:1124","msg":"removing old peers from network"} {"level":"info","ts":"2026-10-21T11:35:12.224068Z","caller":"rafthttp/peer.go:316","msg":"stopping remote peer","remote-peer-id":"86f12f2ae020828"} {"level":"warn","ts":"2026-10-21T11:35:12.224141Z","caller":"rafthttp/stream.go:285","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.224174Z","caller":"rafthttp/stream.go:293","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"86f12f2ae020828"} {"level":"warn","ts":"2026-10-21T11:35:12.224218Z","caller":"rafthttp/stream.go:285","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.224243Z","caller":"rafthttp/stream.go:293","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.224304Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"warn","ts":"2026-10-21T11:35:12.224464Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828","error":"context canceled"} {"level":"warn","ts":"2026-10-21T11:35:12.224502Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"86f12f2ae020828","error":"failed to read 86f12f2ae020828 on stream MsgApp v2 (context canceled)"} {"level":"info","ts":"2026-10-21T11:35:12.224530Z","caller":"rafthttp/stream.go:441","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.225370Z","caller":"etcdserver/server.go:1080","msg":"closed old backend file"} {"level":"warn","ts":"2026-10-21T11:35:12.225422Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828","error":"context canceled"} {"level":"info","ts":"2026-10-21T11:35:12.225447Z","caller":"rafthttp/stream.go:441","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.225508Z","caller":"rafthttp/peer.go:321","msg":"stopped remote peer","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.225525Z","caller":"rafthttp/transport.go:354","msg":"removed remote peer","local-member-id":"28650bddaae87402","removed-remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.225538Z","caller":"etcdserver/server.go:1129","msg":"removed old peers from network"} {"level":"info","ts":"2026-10-21T11:35:12.225568Z","caller":"etcdserver/server.go:1130","msg":"adding peers from new cluster configuration"} {"level":"info","ts":"2026-10-21T11:35:12.225600Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.225630Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.225808Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.225861Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828","remote-peer-urls":["https://162.253.55.214:2380"]} {"level":"info","ts":"2026-10-21T11:35:12.225882Z","caller":"etcdserver/server.go:1139","msg":"added peers from new cluster configuration"} {"level":"info","ts":"2026-10-21T11:35:12.225909Z","caller":"etcdserver/server.go:1015","msg":"applied snapshot","current-snapshot-index":459,"current-applied-index":459,"incoming-leader-snapshot-index":459,"incoming-leader-snapshot-term":2} {"level":"info","ts":"2026-10-21T11:35:12.225977Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.225997Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.226011Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.226239Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.237140Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.237190Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.237944Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.242834Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"28650bddaae87402","to":"86f12f2ae020828","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-10-21T11:35:12.242869Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.250530Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"28650bddaae87402","to":"86f12f2ae020828","stream-type":"stream Message"} {"level":"info","ts":"2026-10-21T11:35:12.250566Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"86f12f2ae020828"} {"level":"info","ts":"2026-10-21T11:35:12.386700Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"28650bddaae87402 switched to configuration voters=(607725308229060648 2910745780847932418)"} {"level":"info","ts":"2026-10-21T11:35:12.386972Z","caller":"membership/cluster.go:550","msg":"promote member","cluster-id":"dfe59afaaa064e4a","local-member-id":"28650bddaae87402","promoted-member-id":"28650bddaae87402"} {"level":"warn","ts":"2026-10-21T11:35:19.179674Z","caller":"etcdserver/server.go:1814","msg":"failed to publish local member to cluster through raft","local-member-id":"28650bddaae87402","local-member-attributes":"{Name:controller-2 ClientURLs:[https://162.253.55.34:2379]}","publish-timeout":"7s","error":"etcdserver: request timed out, possibly due to connection lost"} {"level":"info","ts":"2026-10-21T11:35:19.204330Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"28650bddaae87402","local-member-attributes":"{Name:controller-2 ClientURLs:[https://162.253.55.34:2379]}","cluster-id":"dfe59afaaa064e4a","publish-timeout":"7s"} {"level":"info","ts":"2026-10-21T11:35:19.204377Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-21T11:35:19.204441Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-21T11:35:19.204800Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-21T11:35:19.206140Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-21T11:35:19.205711Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-10-21T11:35:19.205905Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-10-21T11:35:19.206454Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-10-21T11:35:19.209457Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-21T11:35:19.209670Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45796","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.210012Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45820","server-name":"","error":"EOF"} {"level":"info","ts":"2026-10-21T11:35:19.212617Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.34:2379"} {"level":"warn","ts":"2026-10-21T11:35:19.213703Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45844","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.221528Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"162.253.55.34:55508","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.229935Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"162.253.55.34:55544","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.230518Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"162.253.55.34:55520","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.232549Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"162.253.55.34:55582","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.232996Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40244","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.233251Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"162.253.55.34:55598","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.233748Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"162.253.55.34:55558","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.237125Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"162.253.55.34:55536","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.239249Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"162.253.55.34:55570","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.281856Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40294","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.293070Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40306","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.303644Z","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-10-21T11:35:19.314153Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40352","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.324421Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40370","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.335107Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40398","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.347510Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40406","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.374633Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40438","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.386277Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40456","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.399160Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40462","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.411225Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40464","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.423269Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40488","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.434954Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40494","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.444352Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40502","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.453075Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40518","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.462156Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40540","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.505228Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40550","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.515657Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40566","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.526588Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40582","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.543094Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40608","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.560574Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40648","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.568812Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40656","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.583107Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40680","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.596644Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40690","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.608723Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40708","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.621444Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40726","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.645572Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40754","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.657933Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40770","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.669735Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40804","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.681885Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40816","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.698513Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40846","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.730251Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40858","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.739880Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.747690Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40894","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.761458Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40902","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.780703Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40930","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.792391Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40932","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.803080Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40956","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.812589Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40966","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.823448Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40984","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.834456Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41012","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.850643Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41020","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.859744Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41042","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.870193Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41056","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.881922Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41066","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.890495Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41092","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.904394Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41102","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.915269Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41106","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.925813Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41124","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.964716Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41148","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.975740Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41170","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:19.986976Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41196","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:20.046752Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41216","server-name":"","error":"EOF"} {"level":"info","ts":"2026-10-21T11:35:27.131364Z","caller":"traceutil/trace.go:172","msg":"trace[401295576] linearizableReadLoop","detail":"{readStateIndex:505; appliedIndex:506; }","duration":"199.805413ms","start":"2026-10-21T11:35:26.931534Z","end":"2026-10-21T11:35:27.131340Z","steps":["trace[401295576] 'read index received' (duration: 199.799203ms)","trace[401295576] 'applied index is now lower than readState.Index' (duration: 5.43µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:35:27.131520Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"199.959956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/controller-2\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:35:27.131654Z","caller":"traceutil/trace.go:172","msg":"trace[634056923] range","detail":"{range_begin:/registry/csinodes/controller-2; range_end:; response_count:0; response_revision:476; }","duration":"200.110009ms","start":"2026-10-21T11:35:26.931515Z","end":"2026-10-21T11:35:27.131625Z","steps":["trace[634056923] 'agreement among raft nodes before linearized reading' (duration: 199.906545ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T11:35:30.527434Z","caller":"traceutil/trace.go:172","msg":"trace[1665682484] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"171.637823ms","start":"2026-10-21T11:35:30.355782Z","end":"2026-10-21T11:35:30.527420Z","steps":["trace[1665682484] 'process raft request' (duration: 171.563552ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T11:35:30.528003Z","caller":"traceutil/trace.go:172","msg":"trace[2128282967] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:529; }","duration":"115.712723ms","start":"2026-10-21T11:35:30.412281Z","end":"2026-10-21T11:35:30.527994Z","steps":["trace[2128282967] 'read index received' (duration: 115.710633ms)","trace[2128282967] 'applied index is now lower than readState.Index' (duration: 1.68µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:35:30.528160Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"115.870005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" limit:1 ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-10-21T11:35:30.528185Z","caller":"traceutil/trace.go:172","msg":"trace[1452416919] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:498; }","duration":"115.911086ms","start":"2026-10-21T11:35:30.412269Z","end":"2026-10-21T11:35:30.528180Z","steps":["trace[1452416919] 'agreement among raft nodes before linearized reading' (duration: 115.789824ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T11:35:30.528653Z","caller":"traceutil/trace.go:172","msg":"trace[1401150070] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"164.318018ms","start":"2026-10-21T11:35:30.364308Z","end":"2026-10-21T11:35:30.528626Z","steps":["trace[1401150070] 'process raft request' (duration: 164.165246ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:35:47.980002Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"162.253.55.128:52588","server-name":"","error":"EOF"} {"level":"info","ts":"2026-10-21T11:35:48.627566Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"28650bddaae87402 switched to configuration voters=(607725308229060648 2910745780847932418) learners=(11928678482179313416)"} {"level":"info","ts":"2026-10-21T11:35:48.627727Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"dfe59afaaa064e4a","local-member-id":"28650bddaae87402","added-peer-id":"a58b2de0f224cf08","added-peer-peer-urls":["https://162.253.55.128:2380"],"added-peer-is-learner":true} {"level":"info","ts":"2026-10-21T11:35:48.627766Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:48.627796Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:48.628261Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:48.628312Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08","remote-peer-urls":["https://162.253.55.128:2380"]} {"level":"info","ts":"2026-10-21T11:35:48.627967Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:48.628080Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:48.628551Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:48.628656Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"warn","ts":"2026-10-21T11:35:48.689106Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"162.253.55.128:52668","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:50.691109Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"162.253.55.128:52708","server-name":"","error":"EOF"} {"level":"info","ts":"2026-10-21T11:35:51.266435Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:51.266496Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:51.266981Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:51.275193Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"28650bddaae87402","to":"a58b2de0f224cf08","stream-type":"stream Message"} {"level":"info","ts":"2026-10-21T11:35:51.275254Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"28650bddaae87402","to":"a58b2de0f224cf08","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-10-21T11:35:51.275282Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:51.275266Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"warn","ts":"2026-10-21T11:35:51.314437Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:35:51.314494Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08","error":"EOF"} {"level":"info","ts":"2026-10-21T11:35:51.332530Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"28650bddaae87402","to":"a58b2de0f224cf08","stream-type":"stream MsgApp v2"} {"level":"warn","ts":"2026-10-21T11:35:51.332570Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:51.332588Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:51.341242Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"28650bddaae87402","to":"a58b2de0f224cf08","stream-type":"stream Message"} {"level":"warn","ts":"2026-10-21T11:35:51.341281Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:51.341311Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:51.342163Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:51.344191Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"28650bddaae87402","remote-peer-id":"a58b2de0f224cf08"} {"level":"info","ts":"2026-10-21T11:35:51.700815Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"28650bddaae87402 switched to configuration voters=(607725308229060648 2910745780847932418 11928678482179313416)"} {"level":"info","ts":"2026-10-21T11:35:51.701007Z","caller":"membership/cluster.go:550","msg":"promote member","cluster-id":"dfe59afaaa064e4a","local-member-id":"28650bddaae87402","promoted-member-id":"a58b2de0f224cf08"} {"level":"warn","ts":"2026-10-21T11:36:34.063198Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-21T11:36:34.372521Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"810.333621ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:34.372615Z","caller":"traceutil/trace.go:172","msg":"trace[1990580053] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:854; }","duration":"810.431353ms","start":"2026-10-21T11:36:33.562161Z","end":"2026-10-21T11:36:34.372593Z","steps":["trace[1990580053] 'agreement among raft nodes before linearized reading' (duration: 810.27106ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T11:36:34.373010Z","caller":"traceutil/trace.go:172","msg":"trace[984933953] linearizableReadLoop","detail":"{readStateIndex:925; appliedIndex:926; }","duration":"810.054385ms","start":"2026-10-21T11:36:33.562202Z","end":"2026-10-21T11:36:34.372256Z","steps":["trace[984933953] 'read index received' (duration: 810.046515ms)","trace[984933953] 'applied index is now lower than readState.Index' (duration: 6.73µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:34.411958Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"195.16886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-21T11:36:34.412231Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"333.881424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-21T11:36:34.412394Z","caller":"traceutil/trace.go:172","msg":"trace[1228533523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:871; }","duration":"334.043018ms","start":"2026-10-21T11:36:34.078332Z","end":"2026-10-21T11:36:34.412375Z","steps":["trace[1228533523] 'agreement among raft nodes before linearized reading' (duration: 333.6797ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:34.412626Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:34.078316Z","time spent":"334.290493ms","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:34.412883Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"643.913158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:34.412936Z","caller":"traceutil/trace.go:172","msg":"trace[1437640282] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations; range_end:; response_count:0; response_revision:871; }","duration":"643.972409ms","start":"2026-10-21T11:36:33.768953Z","end":"2026-10-21T11:36:34.412925Z","steps":["trace[1437640282] 'agreement among raft nodes before linearized reading' (duration: 643.895568ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:34.412961Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:33.768934Z","time spent":"644.020941ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 "} {"level":"info","ts":"2026-10-21T11:36:34.412047Z","caller":"traceutil/trace.go:172","msg":"trace[1632896343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:871; }","duration":"195.265952ms","start":"2026-10-21T11:36:34.216764Z","end":"2026-10-21T11:36:34.412030Z","steps":["trace[1632896343] 'agreement among raft nodes before linearized reading' (duration: 195.128889ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T11:36:35.849909Z","caller":"traceutil/trace.go:172","msg":"trace[1832510177] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"133.924493ms","start":"2026-10-21T11:36:35.715947Z","end":"2026-10-21T11:36:35.849872Z","steps":["trace[1832510177] 'process raft request' (duration: 133.773979ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:36.636356Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"557.197819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:36.636441Z","caller":"traceutil/trace.go:172","msg":"trace[57857140] range","detail":"{range_begin:/registry/services/endpoints; range_end:; response_count:0; response_revision:941; }","duration":"557.298771ms","start":"2026-10-21T11:36:36.079123Z","end":"2026-10-21T11:36:36.636422Z","steps":["trace[57857140] 'range keys from in-memory index tree' (duration: 555.617735ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:36.636505Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:36.079106Z","time spent":"557.389973ms","remote":"127.0.0.1:40478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":32,"response count":0,"response size":28,"request content":"key:\"/registry/services/endpoints\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:36.636618Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"419.391561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:36.636719Z","caller":"traceutil/trace.go:172","msg":"trace[1595583419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:941; }","duration":"419.497283ms","start":"2026-10-21T11:36:36.217201Z","end":"2026-10-21T11:36:36.636698Z","steps":["trace[1595583419] 'range keys from in-memory index tree' (duration: 417.463069ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:36.636777Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:36.217189Z","time spent":"419.574905ms","remote":"127.0.0.1:45806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-21T11:36:40.915434Z","caller":"traceutil/trace.go:172","msg":"trace[2129060515] linearizableReadLoop","detail":"{readStateIndex:1176; appliedIndex:1176; }","duration":"354.079925ms","start":"2026-10-21T11:36:40.561335Z","end":"2026-10-21T11:36:40.915415Z","steps":["trace[2129060515] 'read index received' (duration: 354.074945ms)","trace[2129060515] 'applied index is now lower than readState.Index' (duration: 4.01µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:40.915623Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"354.301921ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:40.916155Z","caller":"traceutil/trace.go:172","msg":"trace[846916745] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:988; }","duration":"354.836242ms","start":"2026-10-21T11:36:40.561299Z","end":"2026-10-21T11:36:40.916135Z","steps":["trace[846916745] 'agreement among raft nodes before linearized reading' (duration: 354.279271ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T11:36:41.681970Z","caller":"traceutil/trace.go:172","msg":"trace[394129280] transaction","detail":"{read_only:false; number_of_response:1; response_revision:993; }","duration":"885.783268ms","start":"2026-10-21T11:36:40.796169Z","end":"2026-10-21T11:36:41.681952Z","steps":["trace[394129280] 'process raft request' (duration: 885.577904ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:41.682386Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:40.796148Z","time spent":"885.912341ms","remote":"127.0.0.1:40282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":88,"response count":0,"response size":5202,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-21T11:36:41.718539Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464510,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-21T11:36:41.819446Z","caller":"traceutil/trace.go:172","msg":"trace[718246447] linearizableReadLoop","detail":"{readStateIndex:1185; appliedIndex:1185; }","duration":"601.702877ms","start":"2026-10-21T11:36:41.217725Z","end":"2026-10-21T11:36:41.819428Z","steps":["trace[718246447] 'read index received' (duration: 601.697317ms)","trace[718246447] 'applied index is now lower than readState.Index' (duration: 4.48µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:41.819873Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"602.131885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:41.819940Z","caller":"traceutil/trace.go:172","msg":"trace[996967786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:995; }","duration":"602.205257ms","start":"2026-10-21T11:36:41.217720Z","end":"2026-10-21T11:36:41.819925Z","steps":["trace[996967786] 'agreement among raft nodes before linearized reading' (duration: 602.096275ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:41.819966Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:41.217699Z","time spent":"602.262658ms","remote":"127.0.0.1:45806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-21T11:36:41.820098Z","caller":"traceutil/trace.go:172","msg":"trace[1356655392] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"293.728633ms","start":"2026-10-21T11:36:41.526356Z","end":"2026-10-21T11:36:41.820085Z","steps":["trace[1356655392] 'process raft request' (duration: 293.669892ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:41.861540Z","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":8359421284499464515,"received-request-id":8359421284499464510} {"level":"info","ts":"2026-10-21T11:36:41.861937Z","caller":"traceutil/trace.go:172","msg":"trace[1968291190] transaction","detail":"{read_only:false; number_of_response:1; response_revision:999; }","duration":"173.630441ms","start":"2026-10-21T11:36:41.688281Z","end":"2026-10-21T11:36:41.861911Z","steps":["trace[1968291190] 'process raft request' (duration: 173.503819ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T11:36:41.862006Z","caller":"traceutil/trace.go:172","msg":"trace[1797436131] transaction","detail":"{read_only:false; number_of_response:1; response_revision:999; }","duration":"165.886877ms","start":"2026-10-21T11:36:41.696112Z","end":"2026-10-21T11:36:41.861999Z","steps":["trace[1797436131] 'process raft request' (duration: 165.687863ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T11:36:41.862174Z","caller":"traceutil/trace.go:172","msg":"trace[805787267] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"148.563733ms","start":"2026-10-21T11:36:41.713605Z","end":"2026-10-21T11:36:41.862169Z","steps":["trace[805787267] 'process raft request' (duration: 148.208724ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:42.055782Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"582.362695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:42.055855Z","caller":"traceutil/trace.go:172","msg":"trace[1478364332] range","detail":"{range_begin:/registry/validatingwebhookconfigurations; range_end:; response_count:0; response_revision:1001; }","duration":"582.442837ms","start":"2026-10-21T11:36:41.473394Z","end":"2026-10-21T11:36:42.055837Z","steps":["trace[1478364332] 'agreement among raft nodes before linearized reading' (duration: 416.232046ms)","trace[1478364332] 'range keys from in-memory index tree' (duration: 166.107079ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:42.055844Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"493.711456ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-21T11:36:42.055905Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:41.473374Z","time spent":"582.521728ms","remote":"127.0.0.1:41058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations\" limit:1 "} {"level":"info","ts":"2026-10-21T11:36:42.055946Z","caller":"traceutil/trace.go:172","msg":"trace[1277453149] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1001; }","duration":"493.829449ms","start":"2026-10-21T11:36:41.562096Z","end":"2026-10-21T11:36:42.055926Z","steps":["trace[1277453149] 'agreement among raft nodes before linearized reading' (duration: 327.522566ms)","trace[1277453149] 'range keys from in-memory index tree' (duration: 166.16465ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:42.056114Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"165.778301ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-10-21T11:36:42.390269Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464517,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-21T11:36:42.778659Z","caller":"traceutil/trace.go:172","msg":"trace[1112874872] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1005; }","duration":"907.192011ms","start":"2026-10-21T11:36:41.871441Z","end":"2026-10-21T11:36:42.778633Z","steps":["trace[1112874872] 'process raft request' (duration: 907.083769ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:42.779056Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:41.871421Z","time spent":"907.393785ms","remote":"127.0.0.1:40282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":99,"response count":0,"response size":10411,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-21T11:36:42.891174Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464517,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-21T11:36:43.307395Z","caller":"traceutil/trace.go:172","msg":"trace[1062277891] linearizableReadLoop","detail":"{readStateIndex:1198; appliedIndex:1201; }","duration":"1.417869718s","start":"2026-10-21T11:36:41.889494Z","end":"2026-10-21T11:36:43.307364Z","steps":["trace[1062277891] 'read index received' (duration: 1.417864028s)","trace[1062277891] 'applied index is now lower than readState.Index' (duration: 4.22µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:43.307569Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.486832012s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:43.307598Z","caller":"traceutil/trace.go:172","msg":"trace[1797984617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1005; }","duration":"1.486877662s","start":"2026-10-21T11:36:41.820712Z","end":"2026-10-21T11:36:43.307590Z","steps":["trace[1797984617] 'agreement among raft nodes before linearized reading' (duration: 1.486796161s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.307628Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:41.820699Z","time spent":"1.486921813s","remote":"127.0.0.1:45828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-21T11:36:43.308155Z","caller":"traceutil/trace.go:172","msg":"trace[1980290070] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"1.149043597s","start":"2026-10-21T11:36:42.159089Z","end":"2026-10-21T11:36:43.308132Z","steps":["trace[1980290070] 'process raft request' (duration: 1.148799463s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.308281Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:42.159067Z","time spent":"1.1491446s","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":676,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-21T11:36:43.324797Z","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":8359421284499464519,"received-request-id":8359421284499464517} {"level":"warn","ts":"2026-10-21T11:36:43.336555Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"842.682616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-10-21T11:36:43.336618Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.260301357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.34\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-10-21T11:36:43.336665Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"744.754877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:43.336694Z","caller":"traceutil/trace.go:172","msg":"trace[1253196663] range","detail":"{range_begin:/registry/masterleases/162.253.55.34; range_end:; response_count:1; response_revision:1012; }","duration":"1.260389898s","start":"2026-10-21T11:36:42.076285Z","end":"2026-10-21T11:36:43.336675Z","steps":["trace[1253196663] 'agreement among raft nodes before linearized reading' (duration: 1.260146543s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.336750Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:42.076274Z","time spent":"1.26046743s","remote":"127.0.0.1:40248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.34\" limit:1 "} {"level":"info","ts":"2026-10-21T11:36:43.336673Z","caller":"traceutil/trace.go:172","msg":"trace[607513429] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1012; }","duration":"842.812339ms","start":"2026-10-21T11:36:42.493833Z","end":"2026-10-21T11:36:43.336645Z","steps":["trace[607513429] 'agreement among raft nodes before linearized reading' (duration: 842.559174ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.336816Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.329749847s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-21T11:36:43.336892Z","caller":"traceutil/trace.go:172","msg":"trace[1467308170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1012; }","duration":"1.329829739s","start":"2026-10-21T11:36:42.007049Z","end":"2026-10-21T11:36:43.336879Z","steps":["trace[1467308170] 'agreement among raft nodes before linearized reading' (duration: 1.329653905s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.336941Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:42.007025Z","time spent":"1.32990382s","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:43.337017Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.025194083s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:43.337057Z","caller":"traceutil/trace.go:172","msg":"trace[2086647481] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1012; }","duration":"1.025231454s","start":"2026-10-21T11:36:42.311816Z","end":"2026-10-21T11:36:43.337048Z","steps":["trace[2086647481] 'agreement among raft nodes before linearized reading' (duration: 1.025176053s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.336881Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:42.493813Z","time spent":"843.047634ms","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:43.337069Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"820.303866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-21T11:36:43.337102Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.394269157s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:496"} {"level":"info","ts":"2026-10-21T11:36:43.337122Z","caller":"traceutil/trace.go:172","msg":"trace[489721773] range","detail":"{range_begin:/registry/controllerrevisions; range_end:; response_count:0; response_revision:1012; }","duration":"820.355397ms","start":"2026-10-21T11:36:42.516754Z","end":"2026-10-21T11:36:43.337109Z","steps":["trace[489721773] 'agreement among raft nodes before linearized reading' (duration: 820.272756ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T11:36:43.337137Z","caller":"traceutil/trace.go:172","msg":"trace[464645763] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1012; }","duration":"1.394305948s","start":"2026-10-21T11:36:41.942821Z","end":"2026-10-21T11:36:43.337127Z","steps":["trace[464645763] 'agreement among raft nodes before linearized reading' (duration: 1.394208056s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.337159Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:42.516733Z","time spent":"820.415928ms","remote":"127.0.0.1:41048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":33,"response count":0,"response size":28,"request content":"key:\"/registry/controllerrevisions\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:43.337183Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:41.942798Z","time spent":"1.394376009s","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:43.337209Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"830.230654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-10-21T11:36:43.337243Z","caller":"traceutil/trace.go:172","msg":"trace[526017394] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1012; }","duration":"830.262235ms","start":"2026-10-21T11:36:42.506974Z","end":"2026-10-21T11:36:43.337236Z","steps":["trace[526017394] 'agreement among raft nodes before linearized reading' (duration: 830.215934ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.337266Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:42.506962Z","time spent":"830.298435ms","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:43.337277Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"754.108094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-75968c57df-q57mq\" limit:1 ","response":"range_response_count:1 size:5390"} {"level":"info","ts":"2026-10-21T11:36:43.337306Z","caller":"traceutil/trace.go:172","msg":"trace[1385860806] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-75968c57df-q57mq; range_end:; response_count:1; response_revision:1012; }","duration":"754.134444ms","start":"2026-10-21T11:36:42.583162Z","end":"2026-10-21T11:36:43.337297Z","steps":["trace[1385860806] 'agreement among raft nodes before linearized reading' (duration: 753.565692ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.337328Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:42.583150Z","time spent":"754.172875ms","remote":"127.0.0.1:40500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":5413,"request content":"key:\"/registry/pods/kube-system/cilium-operator-75968c57df-q57mq\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:43.337079Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:42.311796Z","time spent":"1.025278115s","remote":"127.0.0.1:45806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-21T11:36:43.336706Z","caller":"traceutil/trace.go:172","msg":"trace[1069903070] range","detail":"{range_begin:/registry/podtemplates; range_end:; response_count:0; response_revision:1012; }","duration":"744.787858ms","start":"2026-10-21T11:36:42.591904Z","end":"2026-10-21T11:36:43.336691Z","steps":["trace[1069903070] 'agreement among raft nodes before linearized reading' (duration: 744.736287ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.337169Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.19438021s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-10-21T11:36:43.337533Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:42.591891Z","time spent":"745.626605ms","remote":"127.0.0.1:40430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates\" limit:1 "} {"level":"info","ts":"2026-10-21T11:36:43.337556Z","caller":"traceutil/trace.go:172","msg":"trace[977613459] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1012; }","duration":"1.194758628s","start":"2026-10-21T11:36:42.142782Z","end":"2026-10-21T11:36:43.337541Z","steps":["trace[977613459] 'agreement among raft nodes before linearized reading' (duration: 1.194314469s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.337604Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:42.142760Z","time spent":"1.194829909s","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:43.336595Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"774.903762ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:43.338335Z","caller":"traceutil/trace.go:172","msg":"trace[409906655] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1012; }","duration":"776.654959ms","start":"2026-10-21T11:36:42.561664Z","end":"2026-10-21T11:36:43.338319Z","steps":["trace[409906655] 'agreement among raft nodes before linearized reading' (duration: 774.867001ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:43.554693Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43906","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:36:44.173519Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464547,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-21T11:36:44.674419Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464547,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-21T11:36:45.077202Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"515.154714ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:45.077293Z","caller":"traceutil/trace.go:172","msg":"trace[1331788854] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1029; }","duration":"515.272577ms","start":"2026-10-21T11:36:44.562001Z","end":"2026-10-21T11:36:45.077274Z","steps":["trace[1331788854] 'range keys from in-memory index tree' (duration: 515.043873ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:45.078102Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"178.702041ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-10-21T11:36:45.175325Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464547,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-21T11:36:45.676198Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464547,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-21T11:36:46.164334Z","caller":"traceutil/trace.go:172","msg":"trace[1777681350] linearizableReadLoop","detail":"{readStateIndex:1248; appliedIndex:1249; }","duration":"2.491496419s","start":"2026-10-21T11:36:43.672809Z","end":"2026-10-21T11:36:46.164305Z","steps":["trace[1777681350] 'read index received' (duration: 2.491488179s)","trace[1777681350] 'applied index is now lower than readState.Index' (duration: 6.28µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:46.664767Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464551,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-21T11:36:47.165737Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464551,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-21T11:36:47.216860Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.999896799s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-10-21T11:36:47.216939Z","caller":"traceutil/trace.go:172","msg":"trace[1638515885] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999990351s","start":"2026-10-21T11:36:45.216932Z","end":"2026-10-21T11:36:47.216922Z","steps":["trace[1638515885] 'agreement among raft nodes before linearized reading' (duration: 1.999894129s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:47.217010Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:45.216908Z","time spent":"2.000092143s","remote":"127.0.0.1:45806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-21T11:36:47.666104Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464551,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-21T11:36:47.748333Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"4.075507157s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:47.748390Z","caller":"traceutil/trace.go:172","msg":"trace[608248497] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:1038; }","duration":"4.075569478s","start":"2026-10-21T11:36:43.672804Z","end":"2026-10-21T11:36:47.748373Z","steps":["trace[608248497] 'agreement among raft nodes before linearized reading' (duration: 2.491623051s)","trace[608248497] 'range keys from in-memory index tree' (duration: 1.583854595s)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:47.748426Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:43.672775Z","time spent":"4.075642379s","remote":"127.0.0.1:40360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":28,"request content":"key:\"/registry/secrets\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:47.749112Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.584551609s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-10-21T11:36:48.167070Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464551,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-21T11:36:48.580352Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.415574825s","expected-duration":"1s"} {"level":"warn","ts":"2026-10-21T11:36:48.580846Z","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":8359421284499464551,"received-request-id":8359421284499464547} {"level":"warn","ts":"2026-10-21T11:36:48.668101Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464551,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-21T11:36:48.944619Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"363.574237ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-21T11:36:48.945235Z","caller":"traceutil/trace.go:172","msg":"trace[1189001185] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1041; }","duration":"5.251654492s","start":"2026-10-21T11:36:43.693544Z","end":"2026-10-21T11:36:48.945199Z","steps":["trace[1189001185] 'process raft request' (duration: 5.251285944s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:48.945580Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:43.693522Z","time spent":"5.251920238s","remote":"127.0.0.1:40282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":103,"response count":0,"response size":188531,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-21T11:36:48.945141Z","caller":"traceutil/trace.go:172","msg":"trace[1385820668] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"5.30259671s","start":"2026-10-21T11:36:43.642516Z","end":"2026-10-21T11:36:48.945113Z","steps":["trace[1385820668] 'process raft request' (duration: 4.938447491s)","trace[1385820668] 'compare' (duration: 363.329683ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:48.946253Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:43.642491Z","time spent":"5.303686372s","remote":"127.0.0.1:40500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18506,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-21T11:36:49.211404Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"266.187322ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-21T11:36:49.211962Z","caller":"traceutil/trace.go:172","msg":"trace[15613758] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1044; }","duration":"4.962781002s","start":"2026-10-21T11:36:44.249155Z","end":"2026-10-21T11:36:49.211936Z","steps":["trace[15613758] 'process raft request' (duration: 4.962424885s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.212294Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:44.249135Z","time spent":"4.962981925s","remote":"127.0.0.1:40282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":103,"response count":0,"response size":188531,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-21T11:36:49.213162Z","caller":"traceutil/trace.go:172","msg":"trace[92829863] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1256; }","duration":"3.048417397s","start":"2026-10-21T11:36:46.164400Z","end":"2026-10-21T11:36:49.212818Z","steps":["trace[92829863] 'read index received' (duration: 2.815957634s)","trace[92829863] 'applied index is now lower than readState.Index' (duration: 232.457443ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:49.218281Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.99988486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-10-21T11:36:49.218343Z","caller":"traceutil/trace.go:172","msg":"trace[1624912834] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999968833s","start":"2026-10-21T11:36:47.218359Z","end":"2026-10-21T11:36:49.218328Z","steps":["trace[1624912834] 'agreement among raft nodes before linearized reading' (duration: 1.9998826s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.218390Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:47.218343Z","time spent":"2.000038604s","remote":"127.0.0.1:45828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-21T11:36:49.324234Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"111.51628ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-10-21T11:36:49.324293Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.878789733s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-21T11:36:49.324291Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"4.410606755s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:49.324365Z","caller":"traceutil/trace.go:172","msg":"trace[1834253226] range","detail":"{range_begin:/registry/statefulsets; range_end:; response_count:0; response_revision:1054; }","duration":"3.878862774s","start":"2026-10-21T11:36:45.445482Z","end":"2026-10-21T11:36:49.324345Z","steps":["trace[1834253226] 'agreement among raft nodes before linearized reading' (duration: 3.767518089s)","trace[1834253226] 'range keys from in-memory index tree' (duration: 111.228313ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:49.324322Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"4.175344866s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattributesclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-21T11:36:49.324401Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"5.057094731s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-21T11:36:49.324424Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"5.533535284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:49.324423Z","caller":"traceutil/trace.go:172","msg":"trace[783336584] range","detail":"{range_begin:/registry/volumeattributesclasses; range_end:; response_count:0; response_revision:1054; }","duration":"4.175446418s","start":"2026-10-21T11:36:45.148955Z","end":"2026-10-21T11:36:49.324401Z","steps":["trace[783336584] 'agreement among raft nodes before linearized reading' (duration: 4.06401654s)","trace[783336584] 'range keys from in-memory index tree' (duration: 111.303774ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T11:36:49.324441Z","caller":"traceutil/trace.go:172","msg":"trace[1855757811] range","detail":"{range_begin:/registry/csinodes; range_end:; response_count:0; response_revision:1054; }","duration":"5.057121951s","start":"2026-10-21T11:36:44.267300Z","end":"2026-10-21T11:36:49.324422Z","steps":["trace[1855757811] 'agreement among raft nodes before linearized reading' (duration: 4.945850857s)","trace[1855757811] 'range keys from in-memory index tree' (duration: 111.228623ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T11:36:49.324495Z","caller":"traceutil/trace.go:172","msg":"trace[1565579850] range","detail":"{range_begin:/registry/endpointslices; range_end:; response_count:0; response_revision:1054; }","duration":"5.533600825s","start":"2026-10-21T11:36:43.790880Z","end":"2026-10-21T11:36:49.324481Z","steps":["trace[1565579850] 'agreement among raft nodes before linearized reading' (duration: 5.422366082s)","trace[1565579850] 'range keys from in-memory index tree' (duration: 111.157162ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:49.324507Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:45.148936Z","time spent":"4.175558629s","remote":"127.0.0.1:40900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattributesclasses\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.324517Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:44.267285Z","time spent":"5.057220294s","remote":"127.0.0.1:40914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":22,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.324527Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:43.790854Z","time spent":"5.533663996s","remote":"127.0.0.1:40630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/endpointslices\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.324546Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.543177946s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-10-21T11:36:49.324578Z","caller":"traceutil/trace.go:172","msg":"trace[1322315284] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1054; }","duration":"3.543204727s","start":"2026-10-21T11:36:45.781360Z","end":"2026-10-21T11:36:49.324565Z","steps":["trace[1322315284] 'agreement among raft nodes before linearized reading' (duration: 3.431629897s)","trace[1322315284] 'range keys from in-memory index tree' (duration: 111.429547ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:49.324602Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:45.781342Z","time spent":"3.543253797s","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"info","ts":"2026-10-21T11:36:49.324470Z","caller":"traceutil/trace.go:172","msg":"trace[1096982932] range","detail":"{range_begin:/registry/runtimeclasses; range_end:; response_count:0; response_revision:1054; }","duration":"4.410731668s","start":"2026-10-21T11:36:44.913634Z","end":"2026-10-21T11:36:49.324366Z","steps":["trace[1096982932] 'agreement among raft nodes before linearized reading' (duration: 4.299500485s)","trace[1096982932] 'range keys from in-memory index tree' (duration: 111.07775ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:49.324401Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:45.445439Z","time spent":"3.878954306s","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.324367Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"4.24701852s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:49.325785Z","caller":"traceutil/trace.go:172","msg":"trace[1236688361] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1054; }","duration":"4.248424279s","start":"2026-10-21T11:36:45.077342Z","end":"2026-10-21T11:36:49.325766Z","steps":["trace[1236688361] 'agreement among raft nodes before linearized reading' (duration: 4.135803177s)","trace[1236688361] 'range keys from in-memory index tree' (duration: 111.210293ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:49.324668Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.966204805s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:496"} {"level":"info","ts":"2026-10-21T11:36:49.326028Z","caller":"traceutil/trace.go:172","msg":"trace[1938412383] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1054; }","duration":"3.967565754s","start":"2026-10-21T11:36:45.358440Z","end":"2026-10-21T11:36:49.326005Z","steps":["trace[1938412383] 'agreement among raft nodes before linearized reading' (duration: 3.854568884s)","trace[1938412383] 'range keys from in-memory index tree' (duration: 111.487589ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:49.326101Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:45.358419Z","time spent":"3.967667375s","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.324322Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"5.272412612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:49.326250Z","caller":"traceutil/trace.go:172","msg":"trace[1191043923] range","detail":"{range_begin:/registry/validatingadmissionpolicies; range_end:; response_count:0; response_revision:1054; }","duration":"5.274348812s","start":"2026-10-21T11:36:44.051890Z","end":"2026-10-21T11:36:49.326239Z","steps":["trace[1191043923] 'agreement among raft nodes before linearized reading' (duration: 5.16127118s)","trace[1191043923] 'range keys from in-memory index tree' (duration: 111.113991ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:49.326280Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:44.051869Z","time spent":"5.274402293s","remote":"127.0.0.1:41076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":28,"request content":"key:\"/registry/validatingadmissionpolicies\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.325002Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:44.913613Z","time spent":"4.411368341s","remote":"127.0.0.1:40732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses\" limit:1 "} {"level":"info","ts":"2026-10-21T11:36:49.373026Z","caller":"traceutil/trace.go:172","msg":"trace[912871731] linearizableReadLoop","detail":"{readStateIndex:1273; appliedIndex:1274; }","duration":"159.795665ms","start":"2026-10-21T11:36:49.213214Z","end":"2026-10-21T11:36:49.373009Z","steps":["trace[912871731] 'read index received' (duration: 159.787805ms)","trace[912871731] 'applied index is now lower than readState.Index' (duration: 7.21µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:36:49.373403Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.8941183s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:49.373566Z","caller":"traceutil/trace.go:172","msg":"trace[882728450] range","detail":"{range_begin:/registry/validatingadmissionpolicies; range_end:; response_count:0; response_revision:1059; }","duration":"1.894246863s","start":"2026-10-21T11:36:47.479251Z","end":"2026-10-21T11:36:49.373498Z","steps":["trace[882728450] 'agreement among raft nodes before linearized reading' (duration: 1.894049969s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.373623Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:47.479233Z","time spent":"1.894377975s","remote":"127.0.0.1:41076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":28,"request content":"key:\"/registry/validatingadmissionpolicies\" limit:1 "} {"level":"info","ts":"2026-10-21T11:36:49.373728Z","caller":"traceutil/trace.go:172","msg":"trace[725093958] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"152.033674ms","start":"2026-10-21T11:36:49.221675Z","end":"2026-10-21T11:36:49.373709Z","steps":["trace[725093958] 'process raft request' (duration: 151.558294ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.373811Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.843006219s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-21T11:36:49.373864Z","caller":"traceutil/trace.go:172","msg":"trace[210879315] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1060; }","duration":"2.84306082s","start":"2026-10-21T11:36:46.530786Z","end":"2026-10-21T11:36:49.373847Z","steps":["trace[210879315] 'agreement among raft nodes before linearized reading' (duration: 2.84259095s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.373905Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:46.530762Z","time spent":"2.843129381s","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.374006Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.893399416s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:49.374101Z","caller":"traceutil/trace.go:172","msg":"trace[718480545] range","detail":"{range_begin:/registry/clusterroles; range_end:; response_count:0; response_revision:1060; }","duration":"2.893493128s","start":"2026-10-21T11:36:46.480594Z","end":"2026-10-21T11:36:49.374087Z","steps":["trace[718480545] 'agreement among raft nodes before linearized reading' (duration: 2.892794093s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.374143Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:46.480575Z","time spent":"2.89355533s","remote":"127.0.0.1:40790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.374146Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.238136428s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:49.374209Z","caller":"traceutil/trace.go:172","msg":"trace[674400044] range","detail":"{range_begin:/registry/jobs; range_end:; response_count:0; response_revision:1060; }","duration":"1.238203209s","start":"2026-10-21T11:36:48.135990Z","end":"2026-10-21T11:36:49.374193Z","steps":["trace[674400044] 'agreement among raft nodes before linearized reading' (duration: 1.237382482s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.374252Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:48.135976Z","time spent":"1.23826666s","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/jobs\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.374436Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.665597831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-21T11:36:49.374497Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.507293509s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:49.374513Z","caller":"traceutil/trace.go:172","msg":"trace[1977820806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1060; }","duration":"2.665672762s","start":"2026-10-21T11:36:46.708826Z","end":"2026-10-21T11:36:49.374499Z","steps":["trace[1977820806] 'agreement among raft nodes before linearized reading' (duration: 2.664562819s)"],"step_count":1} {"level":"info","ts":"2026-10-21T11:36:49.374527Z","caller":"traceutil/trace.go:172","msg":"trace[46072104] range","detail":"{range_begin:/registry/csinodes; range_end:; response_count:0; response_revision:1060; }","duration":"1.507323061s","start":"2026-10-21T11:36:47.867194Z","end":"2026-10-21T11:36:49.374517Z","steps":["trace[46072104] 'agreement among raft nodes before linearized reading' (duration: 1.506206678s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.374551Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:47.867171Z","time spent":"1.507374381s","remote":"127.0.0.1:40914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":22,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.374555Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:46.708813Z","time spent":"2.665730673s","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.374378Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"917.705252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-21T11:36:49.374335Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"702.34359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:49.374686Z","caller":"traceutil/trace.go:172","msg":"trace[1781885240] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices; range_end:; response_count:0; response_revision:1060; }","duration":"702.688577ms","start":"2026-10-21T11:36:48.671974Z","end":"2026-10-21T11:36:49.374663Z","steps":["trace[1781885240] 'agreement among raft nodes before linearized reading' (duration: 701.38797ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.374799Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:48.671951Z","time spent":"702.831879ms","remote":"127.0.0.1:41202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 "} {"level":"info","ts":"2026-10-21T11:36:49.374629Z","caller":"traceutil/trace.go:172","msg":"trace[1030617457] range","detail":"{range_begin:/registry/rolebindings; range_end:; response_count:0; response_revision:1060; }","duration":"917.957307ms","start":"2026-10-21T11:36:48.456654Z","end":"2026-10-21T11:36:49.374611Z","steps":["trace[1030617457] 'agreement among raft nodes before linearized reading' (duration: 916.69026ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.374990Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.957647237s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-21T11:36:49.375027Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.903845771s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-10-21T11:36:49.375012Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:48.456631Z","time spent":"918.362675ms","remote":"127.0.0.1:40778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":28,"request content":"key:\"/registry/rolebindings\" limit:1 "} {"level":"info","ts":"2026-10-21T11:36:49.375097Z","caller":"traceutil/trace.go:172","msg":"trace[343318004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1060; }","duration":"1.903913782s","start":"2026-10-21T11:36:47.471165Z","end":"2026-10-21T11:36:49.375079Z","steps":["trace[343318004] 'agreement among raft nodes before linearized reading' (duration: 1.902187577s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.375142Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:47.471144Z","time spent":"1.903987983s","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-10-21T11:36:49.375045Z","caller":"traceutil/trace.go:172","msg":"trace[1500856222] range","detail":"{range_begin:/registry/ingress; range_end:; response_count:0; response_revision:1060; }","duration":"1.957700788s","start":"2026-10-21T11:36:47.417330Z","end":"2026-10-21T11:36:49.375031Z","steps":["trace[1500856222] 'agreement among raft nodes before linearized reading' (duration: 1.956044184s)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:49.375324Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:36:47.417310Z","time spent":"1.957999125s","remote":"127.0.0.1:40654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":28,"request content":"key:\"/registry/ingress\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:36:49.393674Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"167.393662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:36:49.393733Z","caller":"traceutil/trace.go:172","msg":"trace[1323856687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1063; }","duration":"167.471033ms","start":"2026-10-21T11:36:49.226248Z","end":"2026-10-21T11:36:49.393719Z","steps":["trace[1323856687] 'agreement among raft nodes before linearized reading' (duration: 167.357951ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:36:56.352531Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39338","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:36:56.384086Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39348","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:36:56.399502Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39360","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:36:56.418509Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39378","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-10-21T11:36:56.701527Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39386","server-name":"","error":"EOF"} {"level":"info","ts":"2026-10-21T11:37:02.929297Z","caller":"traceutil/trace.go:172","msg":"trace[1100030237] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"195.308681ms","start":"2026-10-21T11:37:02.733950Z","end":"2026-10-21T11:37:02.929258Z","steps":["trace[1100030237] 'process raft request' (duration: 195.105987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:37:06.407990Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8359421284499464754,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-21T11:37:06.562206Z","caller":"traceutil/trace.go:172","msg":"trace[940903815] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"815.490416ms","start":"2026-10-21T11:37:05.746692Z","end":"2026-10-21T11:37:06.562182Z","steps":["trace[940903815] 'process raft request' (duration: 815.136739ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:37:06.562328Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:37:05.746669Z","time spent":"815.596478ms","remote":"127.0.0.1:40500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4553,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-21T11:37:06.570516Z","caller":"traceutil/trace.go:172","msg":"trace[1686506177] linearizableReadLoop","detail":"{readStateIndex:1506; appliedIndex:1506; }","duration":"662.786327ms","start":"2026-10-21T11:37:05.907708Z","end":"2026-10-21T11:37:06.570494Z","steps":["trace[1686506177] 'read index received' (duration: 662.780646ms)","trace[1686506177] 'applied index is now lower than readState.Index' (duration: 4.651µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:37:06.570724Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"663.003101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-21T11:37:06.570815Z","caller":"traceutil/trace.go:172","msg":"trace[442020661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1274; }","duration":"663.103783ms","start":"2026-10-21T11:37:05.907697Z","end":"2026-10-21T11:37:06.570801Z","steps":["trace[442020661] 'agreement among raft nodes before linearized reading' (duration: 662.90157ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:37:06.570853Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:37:05.907683Z","time spent":"663.160764ms","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:37:06.572174Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"524.412353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-21T11:37:06.572217Z","caller":"traceutil/trace.go:172","msg":"trace[1591320754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1274; }","duration":"524.457814ms","start":"2026-10-21T11:37:06.047748Z","end":"2026-10-21T11:37:06.572206Z","steps":["trace[1591320754] 'agreement among raft nodes before linearized reading' (duration: 524.332762ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:37:06.572243Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:37:06.047736Z","time spent":"524.499495ms","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-10-21T11:37:06.572548Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"355.214996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:37:06.572587Z","caller":"traceutil/trace.go:172","msg":"trace[418752823] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1274; }","duration":"355.252847ms","start":"2026-10-21T11:37:06.217325Z","end":"2026-10-21T11:37:06.572577Z","steps":["trace[418752823] 'agreement among raft nodes before linearized reading' (duration: 355.191046ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:37:06.572616Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:37:06.217312Z","time spent":"355.293288ms","remote":"127.0.0.1:45806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-21T11:37:06.572653Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"422.245947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-21T11:37:06.572719Z","caller":"traceutil/trace.go:172","msg":"trace[2126124954] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1274; }","duration":"422.311928ms","start":"2026-10-21T11:37:06.150393Z","end":"2026-10-21T11:37:06.572705Z","steps":["trace[2126124954] 'agreement among raft nodes before linearized reading' (duration: 422.147425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T11:37:06.572752Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-10-21T11:37:06.150382Z","time spent":"422.363259ms","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"info","ts":"2026-10-21T11:37:11.034770Z","caller":"traceutil/trace.go:172","msg":"trace[149978740] linearizableReadLoop","detail":"{readStateIndex:1559; appliedIndex:1559; }","duration":"112.573987ms","start":"2026-10-21T11:37:10.922178Z","end":"2026-10-21T11:37:11.034752Z","steps":["trace[149978740] 'read index received' (duration: 112.569087ms)","trace[149978740] 'applied index is now lower than readState.Index' (duration: 3.7µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T11:37:11.034913Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"112.695989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T11:37:11.034990Z","caller":"traceutil/trace.go:172","msg":"trace[708032068] range","detail":"{range_begin:/registry/cronjobs; range_end:; response_count:0; response_revision:1324; }","duration":"112.802431ms","start":"2026-10-21T11:37:10.922172Z","end":"2026-10-21T11:37:11.034974Z","steps":["trace[708032068] 'agreement among raft nodes before linearized reading' (duration: 112.651998ms)"],"step_count":1}