Unable to connect to peers for IBD on master #2280
Description
On master IBD gets stuck trying to ask for blocks from peers:
[I] calvin@nixos ~/b/b/btcd (master)> ./btcd --datadir=. --logdir=.
2024-11-29 15:01:28.614 [INF] BTCD: RPC service is disabled
2024-11-29 15:01:28.614 [INF] BTCD: Version 0.24.2-beta
2024-11-29 15:01:28.614 [INF] BTCD: Loading block database from 'mainnet/blocks_ffldb'
2024-11-29 15:01:28.649 [INF] BTCD: Block database loaded
2024-11-29 15:01:28.650 [INF] INDX: Committed filter index is enabled
2024-11-29 15:01:28.650 [INF] CHAN: Pre-alloacting for 251 MiB
2024-11-29 15:01:28.651 [INF] INDX: Catching up indexes from height -1 to 0
2024-11-29 15:01:28.651 [INF] INDX: Indexes caught up to height 0
2024-11-29 15:01:28.651 [INF] CHAN: Chain state (height 0, hash 000000000019d6689c085ae165831e934ff763ae46a2a6c172b3f1b60a8ce26f, totaltx 1, work 4295032833)
2024-11-29 15:01:28.651 [INF] AMGR: Loaded 0 addresses from file 'mainnet/peers.json'
2024-11-29 15:01:28.651 [INF] CMGR: Server listening on [::]:8333
2024-11-29 15:01:28.651 [INF] CMGR: Server listening on 0.0.0.0:8333
2024-11-29 15:01:28.673 [INF] CMGR: 37 addresses found from DNS seed seed.btc.petertodd.net
2024-11-29 15:01:28.673 [INF] CMGR: 37 addresses found from DNS seed seed.bitcoin.jonasschnelli.ch
2024-11-29 15:01:28.673 [INF] CMGR: 39 addresses found from DNS seed seed.bitcoin.sipa.be
2024-11-29 15:01:28.960 [INF] CMGR: 36 addresses found from DNS seed dnsseed.bitcoin.dashjr.org
2024-11-29 15:01:29.142 [INF] CMGR: 31 addresses found from DNS seed dnsseed.bluematt.me
2024-11-29 15:01:29.477 [INF] CMGR: 31 addresses found from DNS seed seed.bitcoin.wiz.biz
2024-11-29 15:01:29.708 [INF] CMGR: 40 addresses found from DNS seed seed.bitnodes.io
2024-11-29 15:01:30.945 [INF] CMGR: 36 addresses found from DNS seed seed.bitcoin.sprovoost.nl
2024-11-29 15:01:33.734 [INF] SYNC: New valid peer 34.97.86.22:8333 (outbound) (/Satoshi:25.1.0/)
2024-11-29 15:01:33.734 [INF] SYNC: Syncing to block height 872435 from peer 34.97.86.22:8333
2024-11-29 15:01:33.734 [INF] SYNC: Downloading headers for blocks 1 to 11111 from peer 34.97.86.22:8333
2024-11-29 15:01:34.012 [INF] SYNC: New valid peer 172.232.24.124:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:01:35.840 [INF] SYNC: New valid peer 35.203.55.159:8333 (outbound) (/Satoshi:25.1.0/)
2024-11-29 15:01:39.771 [INF] SYNC: New valid peer 54.154.212.14:8333 (outbound) (/Satoshi:25.0.0/)
2024-11-29 15:02:04.043 [INF] SYNC: New valid peer 170.187.181.251:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:02:04.367 [INF] SYNC: Lost peer 172.232.24.124:8333 (outbound)
2024-11-29 15:02:05.411 [INF] SYNC: New valid peer 172.104.230.162:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:02:09.856 [INF] SYNC: New valid peer 172.236.224.188:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:02:33.732 [INF] SYNC: Lost peer 34.97.86.22:8333 (outbound)
2024-11-29 15:02:33.732 [INF] SYNC: Syncing to block height 872431 from peer 172.104.230.162:8333
2024-11-29 15:02:33.732 [INF] SYNC: Downloading headers for blocks 1 to 11111 from peer 172.104.230.162:8333
2024-11-29 15:02:34.433 [INF] SYNC: Lost peer 170.187.181.251:8333 (outbound)
2024-11-29 15:02:35.249 [INF] SYNC: New valid peer 172.234.244.36:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:02:35.833 [INF] SYNC: Lost peer 35.203.55.159:8333 (outbound)
2024-11-29 15:02:36.035 [INF] SYNC: New valid peer 172.232.190.148:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:02:36.078 [INF] SYNC: New valid peer 172.232.181.71:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:02:39.770 [INF] SYNC: Lost peer 54.154.212.14:8333 (outbound)
2024-11-29 15:02:40.126 [INF] SYNC: Lost peer 172.236.224.188:8333 (outbound)
2024-11-29 15:02:40.904 [INF] SYNC: New valid peer 45.79.22.235:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:02:43.569 [INF] SYNC: New valid peer 172.105.64.85:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:03:03.989 [INF] SYNC: Lost peer 172.104.230.162:8333 (outbound)
2024-11-29 15:03:03.989 [INF] SYNC: Syncing to block height 872431 from peer 172.105.64.85:8333
2024-11-29 15:03:03.989 [INF] SYNC: Downloading headers for blocks 1 to 11111 from peer 172.105.64.85:8333
2024-11-29 15:03:04.336 [INF] SYNC: New valid peer 194.195.254.224:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:03:04.738 [INF] SYNC: New valid peer 23.239.29.142:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:03:05.485 [INF] SYNC: Lost peer 172.234.244.36:8333 (outbound)
2024-11-29 15:03:05.586 [INF] SYNC: New valid peer 50.116.17.199:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:03:06.269 [INF] SYNC: Lost peer 172.232.190.148:8333 (outbound)
2024-11-29 15:03:06.322 [INF] SYNC: Lost peer 172.232.181.71:8333 (outbound)
2024-11-29 15:03:06.773 [INF] SYNC: New valid peer 139.162.150.197:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:03:11.256 [INF] SYNC: Lost peer 45.79.22.235:8333 (outbound)
2024-11-29 15:03:11.767 [INF] SYNC: New valid peer 172.104.136.78:8333 (outbound) (/Satoshi:27.0.0/)
With logging set to debug
[N] calvin@nixos ~/b/b/btcd (master)> ./btcd --datadir=. --logdir=. -d=debug
2024-11-29 15:01:18.651 [INF] BTCD: RPC service is disabled
2024-11-29 15:01:18.651 [INF] BTCD: Version 0.24.2-beta
2024-11-29 15:01:18.651 [INF] BTCD: Loading block database from 'mainnet/blocks_ffldb'
2024-11-29 15:01:18.687 [INF] BTCD: Block database loaded
2024-11-29 15:01:18.688 [INF] INDX: Committed filter index is enabled
2024-11-29 15:01:18.688 [INF] CHAN: Pre-alloacting for 251 MiB
2024-11-29 15:01:18.689 [INF] CHAN: Loading block index...
2024-11-29 15:01:18.689 [DBG] INDX: Current committed filter index tip (height 0, hash 000000000019d6689c085ae165831e934ff763ae46a2a6c172b3f1b60a8ce26f)
2024-11-29 15:01:18.689 [DBG] CHAN: UTXO state consistent at (0:000000000019d6689c085ae165831e934ff763ae46a2a6c172b3f1b60a8ce26f)
2024-11-29 15:01:18.689 [INF] CHAN: Chain state (height 0, hash 000000000019d6689c085ae165831e934ff763ae46a2a6c172b3f1b60a8ce26f, totaltx 1, work 4295032833)
2024-11-29 15:01:18.695 [INF] AMGR: Loaded 1783 addresses from file 'mainnet/peers.json'
2024-11-29 15:01:18.695 [DBG] CMGR: Attempting to connect to 40.68.160.140:8333 (reqid 8)
2024-11-29 15:01:18.695 [INF] CMGR: Server listening on [::]:8333
2024-11-29 15:01:18.695 [INF] CMGR: Server listening on 0.0.0.0:8333
2024-11-29 15:01:18.695 [DBG] CMGR: Attempting to connect to 2.137.147.10:8333 (reqid 3)
2024-11-29 15:01:18.695 [DBG] CMGR: Attempting to connect to 203.11.72.11:8333 (reqid 5)
2024-11-29 15:01:18.695 [DBG] CMGR: Attempting to connect to [2001:558:600c:31:408e:953b:b3b9:9ec1]:8333 (reqid 4)
2024-11-29 15:01:18.695 [DBG] CMGR: Attempting to connect to 34.125.88.170:8333 (reqid 6)
2024-11-29 15:01:18.695 [DBG] CMGR: Attempting to connect to 66.228.54.42:8333 (reqid 1)
2024-11-29 15:01:18.695 [DBG] CMGR: Failed to connect to [2001:558:600c:31:408e:953b:b3b9:9ec1]:8333 (reqid 4): dial tcp [2001:558:600c:31:408e:953b:b3b9:9ec1]:8333: connect: network is unreachable
2024-11-29 15:01:18.695 [DBG] CMGR: Canceling: [2001:558:600c:31:408e:953b:b3b9:9ec1]:8333 (reqid 4)
2024-11-29 15:01:18.695 [DBG] CMGR: Attempting to connect to [2a00:1768:2001:27::ef6a]:8333 (reqid 2)
2024-11-29 15:01:18.695 [DBG] CMGR: Attempting to connect to 172.236.116.238:8333 (reqid 9)
2024-11-29 15:01:18.695 [DBG] CMGR: Failed to connect to [2a00:1768:2001:27::ef6a]:8333 (reqid 2): dial tcp [2a00:1768:2001:27::ef6a]:8333: connect: network is unreachable
2024-11-29 15:01:18.695 [DBG] CMGR: Canceling: [2a00:1768:2001:27::ef6a]:8333 (reqid 2)
2024-11-29 15:01:18.695 [DBG] CMGR: Attempting to connect to 66.228.54.112:8333 (reqid 7)
2024-11-29 15:01:18.695 [DBG] CMGR: Attempting to connect to 66.228.50.64:8333 (reqid 10)
2024-11-29 15:01:18.717 [INF] CMGR: 36 addresses found from DNS seed dnsseed.bitcoin.dashjr.org
2024-11-29 15:01:18.717 [INF] CMGR: 37 addresses found from DNS seed seed.bitcoin.jonasschnelli.ch
2024-11-29 15:01:18.835 [DBG] CMGR: Connected to 34.125.88.170:8333 (reqid 6)
2024-11-29 15:01:18.835 [DBG] PEER: Sending version (agent /btcwire:0.5.0/btcd:0.24.2/, pver 70016, block 0) to 34.125.88.170:8333 (outbound)
2024-11-29 15:01:18.862 [DBG] CMGR: Connected to 66.228.50.64:8333 (reqid 10)
2024-11-29 15:01:18.862 [DBG] PEER: Sending version (agent /btcwire:0.5.0/btcd:0.24.2/, pver 70016, block 0) to 66.228.50.64:8333 (outbound)
2024-11-29 15:01:18.868 [DBG] CMGR: Connected to 66.228.54.112:8333 (reqid 7)
2024-11-29 15:01:18.868 [DBG] PEER: Sending version (agent /btcwire:0.5.0/btcd:0.24.2/, pver 70016, block 0) to 66.228.54.112:8333 (outbound)
2024-11-29 15:01:18.869 [DBG] CMGR: Connected to 66.228.54.42:8333 (reqid 1)
2024-11-29 15:01:18.869 [DBG] PEER: Sending version (agent /btcwire:0.5.0/btcd:0.24.2/, pver 70016, block 0) to 66.228.54.42:8333 (outbound)
2024-11-29 15:01:18.881 [DBG] CMGR: Connected to 172.236.116.238:8333 (reqid 9)
2024-11-29 15:01:18.881 [DBG] PEER: Sending version (agent /btcwire:0.5.0/btcd:0.24.2/, pver 70016, block 0) to 172.236.116.238:8333 (outbound)
2024-11-29 15:01:18.897 [DBG] CMGR: Connected to 203.11.72.11:8333 (reqid 5)
2024-11-29 15:01:18.897 [DBG] PEER: Sending version (agent /btcwire:0.5.0/btcd:0.24.2/, pver 70016, block 0) to 203.11.72.11:8333 (outbound)
2024-11-29 15:01:18.938 [DBG] CMGR: Connected to 40.68.160.140:8333 (reqid 8)
2024-11-29 15:01:18.938 [DBG] PEER: Sending version (agent /btcwire:0.5.0/btcd:0.24.2/, pver 70016, block 0) to 40.68.160.140:8333 (outbound)
2024-11-29 15:01:19.022 [DBG] CMGR: Connected to 2.137.147.10:8333 (reqid 3)
2024-11-29 15:01:19.023 [DBG] PEER: Sending version (agent /btcwire:0.5.0/btcd:0.24.2/, pver 70016, block 0) to 2.137.147.10:8333 (outbound)
2024-11-29 15:01:19.030 [DBG] PEER: Received version (agent /Satoshi:27.0.0/, pver 70016, block 872431) from 66.228.50.64:8333 (outbound)
2024-11-29 15:01:19.030 [DBG] PEER: Negotiated protocol version 70016 for peer 66.228.50.64:8333 (outbound)
2024-11-29 15:01:19.030 [DBG] CHAN: Added time sample of -1s (total: 1)
2024-11-29 15:01:19.030 [DBG] PEER: Sending sendaddrv2 to 66.228.50.64:8333 (outbound)
2024-11-29 15:01:19.030 [DBG] PEER: Sending verack to 66.228.50.64:8333 (outbound)
2024-11-29 15:01:19.030 [DBG] PEER: Received verack from 66.228.50.64:8333 (outbound)
2024-11-29 15:01:19.030 [DBG] PEER: Connected to 66.228.50.64:8333
2024-11-29 15:01:19.030 [DBG] SRVR: New peer 66.228.50.64:8333 (outbound)
2024-11-29 15:01:19.030 [INF] SYNC: New valid peer 66.228.50.64:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:01:19.030 [INF] SYNC: Syncing to block height 872431 from peer 66.228.50.64:8333
2024-11-29 15:01:19.030 [INF] SYNC: Downloading headers for blocks 1 to 11111 from peer 66.228.50.64:8333
2024-11-29 15:01:19.030 [DBG] PEER: Sending getheaders (locator 000000000019d6689c085ae165831e934ff763ae46a2a6c172b3f1b60a8ce26f, stop 0000000069e244f73d78e8fd29ba2fd2ed618bd6fa2ee92559f542fdb26e7c1d) to 66.228.50.64:8333 (outbound)
2024-11-29 15:01:19.040 [DBG] PEER: Received version (agent /Satoshi:27.0.0/, pver 70016, block 872431) from 66.228.54.112:8333 (outbound)
2024-11-29 15:01:19.040 [DBG] PEER: Negotiated protocol version 70016 for peer 66.228.54.112:8333 (outbound)
2024-11-29 15:01:19.040 [DBG] CHAN: Added time sample of -1s (total: 2)
2024-11-29 15:01:19.040 [DBG] PEER: Sending sendaddrv2 to 66.228.54.112:8333 (outbound)
2024-11-29 15:01:19.040 [DBG] PEER: Sending verack to 66.228.54.112:8333 (outbound)
2024-11-29 15:01:19.040 [DBG] PEER: Received verack from 66.228.54.112:8333 (outbound)
2024-11-29 15:01:19.040 [DBG] PEER: Connected to 66.228.54.112:8333
2024-11-29 15:01:19.040 [DBG] SRVR: New peer 66.228.54.112:8333 (outbound)
2024-11-29 15:01:19.040 [INF] SYNC: New valid peer 66.228.54.112:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:01:19.044 [DBG] PEER: Received version (agent /Satoshi:27.0.0/, pver 70016, block 872431) from 66.228.54.42:8333 (outbound)
2024-11-29 15:01:19.044 [DBG] PEER: Negotiated protocol version 70016 for peer 66.228.54.42:8333 (outbound)
2024-11-29 15:01:19.044 [DBG] CHAN: Added time sample of -1s (total: 3)
2024-11-29 15:01:19.044 [DBG] PEER: Sending sendaddrv2 to 66.228.54.42:8333 (outbound)
2024-11-29 15:01:19.044 [DBG] PEER: Sending verack to 66.228.54.42:8333 (outbound)
2024-11-29 15:01:19.044 [DBG] PEER: Received verack from 66.228.54.42:8333 (outbound)
2024-11-29 15:01:19.044 [DBG] PEER: Connected to 66.228.54.42:8333
2024-11-29 15:01:19.044 [DBG] SRVR: New peer 66.228.54.42:8333 (outbound)
2024-11-29 15:01:19.044 [INF] SYNC: New valid peer 66.228.54.42:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:01:19.067 [DBG] PEER: Received version (agent /Satoshi:27.0.0/, pver 70016, block 872431) from 172.236.116.238:8333 (outbound)
2024-11-29 15:01:19.067 [DBG] PEER: Negotiated protocol version 70016 for peer 172.236.116.238:8333 (outbound)
2024-11-29 15:01:19.067 [DBG] CHAN: Added time sample of -1s (total: 4)
2024-11-29 15:01:19.067 [DBG] PEER: Sending sendaddrv2 to 172.236.116.238:8333 (outbound)
2024-11-29 15:01:19.067 [DBG] PEER: Sending verack to 172.236.116.238:8333 (outbound)
2024-11-29 15:01:19.068 [DBG] PEER: Received verack from 172.236.116.238:8333 (outbound)
2024-11-29 15:01:19.068 [DBG] PEER: Connected to 172.236.116.238:8333
2024-11-29 15:01:19.068 [DBG] SRVR: New peer 172.236.116.238:8333 (outbound)
2024-11-29 15:01:19.068 [INF] SYNC: New valid peer 172.236.116.238:8333 (outbound) (/Satoshi:27.0.0/)
2024-11-29 15:01:19.168 [DBG] PEER: Received version (agent /Satoshi:25.1.0/, pver 70016, block 872435) from 34.125.88.170:8333 (outbound)
2024-11-29 15:01:19.168 [DBG] PEER: Negotiated protocol version 70016 for peer 34.125.88.170:8333 (outbound)
2024-11-29 15:01:19.168 [DBG] CHAN: Added time sample of 0s (total: 5)
2024-11-29 15:01:19.168 [DBG] CHAN: New time offset: -1s
2024-11-29 15:01:19.168 [DBG] PEER: Sending sendaddrv2 to 34.125.88.170:8333 (outbound)
2024-11-29 15:01:19.168 [DBG] PEER: Sending verack to 34.125.88.170:8333 (outbound)
2024-11-29 15:01:19.168 [DBG] PEER: Received verack from 34.125.88.170:8333 (outbound)
2024-11-29 15:01:19.168 [DBG] PEER: Connected to 34.125.88.170:8333
2024-11-29 15:01:19.168 [DBG] SRVR: New peer 34.125.88.170:8333 (outbound)
2024-11-29 15:01:19.168 [INF] SYNC: New valid peer 34.125.88.170:8333 (outbound) (/Satoshi:25.1.0/)
2024-11-29 15:01:19.183 [DBG] PEER: Received version (agent /Satoshi:28.0.0/, pver 70016, block 872435) from 40.68.160.140:8333 (outbound)