0

I've been trying different things to get Geth to get a fully sync'd Geth node for the past two weeks on a host with 4 cores, 16G of memory and 2TB SSD, to no avail. The only time I get close to being sync'd is just after I restart the process. See output and log info below. Should I abort mission and go with Parity or is there something I'm missing in Geth that's causing me to get close but never fully sync'd.

Output and log stuff:

INFO [02-19|20:11:23.257] Starting Geth on Ethereum mainnet... 
INFO [02-19|20:11:23.262] Maximum peer count                       ETH=150 LES=0 total=150
INFO [02-19|20:11:23.269] Set global gas cap                       cap=25000000
INFO [02-19|20:11:23.269] Allocated trie memory caches             clean=511.00MiB dirty=512.00MiB
INFO [02-19|20:11:23.269] Allocated cache and file handles         database=/mnt/crypto/ETH/geth/chaindata cache=1024.00MiB handles=524288
INFO [02-19|20:11:38.091] Opened ancient database                  database=/mnt/crypto/ETH/geth/chaindata/ancient
INFO [02-19|20:11:38.114] Initialised chain configuration          config="{ChainID: 1 Homestead: 1150000 DAO: 1920000 DAOSupport: true EIP150: 2463000 EIP155: 2675000 EIP158: 2675000 Byzantium: 4370000 Constantinople: 7280000 Petersburg: 7280000 Istanbul: 9069000, Muir Glacier: 9200000, YOLO v2: <nil>, Engine: ethash}"
INFO [02-19|20:11:38.114] Disk storage enabled for ethash caches   dir=/mnt/crypto/ETH/geth/ethash count=3
INFO [02-19|20:11:38.114] Disk storage enabled for ethash DAGs     dir=/mnt/crypto/ETH             count=2
INFO [02-19|20:11:38.124] Initialising Ethereum protocol           versions="[65 64 63]" network=1 dbversion=8
INFO [02-19|20:11:38.197] Loaded most recent local header          number=11889061 hash="948768…9124c0" td=21245373141955636570615 age=7h24m54s
INFO [02-19|20:11:38.197] Loaded most recent local full block      number=0        hash="d4e567…cb8fa3" td=17179869184             age=51y10mo2w
INFO [02-19|20:11:38.197] Loaded most recent local fast block      number=11889061 hash="948768…9124c0" td=21245373141955636570615 age=7h24m54s
.
.
.
TRACE[02-19|20:11:39.401] Registering sync peer                    peer=fa214cc47819d8b8
WARN [02-19|20:11:39.704] Dropping unsynced node during fast sync  id=fa214cc47819d8b8 conn=inbound addr=46.101.214.11:34310 type=ethereumjs-devp2p/v2...
TRACE[02-19|20:11:39.704] Unregistering sync peer                  peer=fa214cc47819d8b8
TRACE[02-19|20:11:40.475] Registering sync peer                    peer=a7606cd5f7c75c15
INFO [02-19|20:11:41.003] New local node record                    seq=160 id=31a6e9b2f27cf521 ip=73.75.107.58 udp=30303 tcp=30303
INFO [02-19|20:11:41.345] Mapped network port                      proto=udp extport=30303 intport=30303 interface="UPNP IGDv1-IP1"
INFO [02-19|20:11:41.845] Mapped network port                      proto=tcp extport=30303 intport=30303 interface="UPNP IGDv1-IP1"
TRACE[02-19|20:11:41.904] Registering sync peer                    peer=71563f2370599df6
DEBUG[02-19|20:11:41.904] Relaxed downloader QoS values            rtt=20s confidence=0.500 ttl=1m0s
TRACE[02-19|20:11:41.905] Unregistering sync peer                  peer=71563f2370599df6
TRACE[02-19|20:11:42.250] Registering sync peer                    peer=f29be8351bde01d5
DEBUG[02-19|20:11:42.250] Relaxed downloader QoS values            rtt=20s confidence=0.250 ttl=1m0s
TRACE[02-19|20:11:42.544] Unregistering sync peer                  peer=f29be8351bde01d5
TRACE[02-19|20:11:46.104] Registering sync peer                    peer=87ee84815193f4ed
DEBUG[02-19|20:11:46.104] Relaxed downloader QoS values            rtt=20s confidence=0.125 ttl=1m0s
INFO [02-19|20:11:46.232] Initializing fast sync bloom             items=2319826 errorrate=0.000 elapsed=8.000s
TRACE[02-19|20:11:46.643] Registering sync peer                    peer=55d8d808c0df1b71
DEBUG[02-19|20:11:46.643] Relaxed downloader QoS values            rtt=20s confidence=0.100 ttl=1m0s
TRACE[02-19|20:11:47.746] Registering sync peer                    peer=7df342806b2afe82
DEBUG[02-19|20:11:47.746] Relaxed downloader QoS values            rtt=20s confidence=0.100 ttl=1m0s
TRACE[02-19|20:11:47.949] Registering sync peer                    peer=2bca3d609c4e2869
DEBUG[02-19|20:11:47.949] Relaxed downloader QoS values            rtt=20s confidence=0.100 ttl=1m0s
INFO [02-19|20:11:47.959] Block synchronisation started 
DEBUG[02-19|20:11:47.959] Synchronising with the network           peer=7df342806b2afe82 eth=65 head="499127…494735" td=21256040513457356514235 mode=fast
DEBUG[02-19|20:11:47.960] Retrieving remote chain head             peer=7df342806b2afe82
TRACE[02-19|20:11:48.043] Unregistering sync peer                  peer=7df342806b2afe82
WARN [02-19|20:11:48.340] Dropping unsynced node during fast sync  id=2bca3d609c4e2869 conn=inbound addr=54.180.92.77:34340  type=OpenEthereum/v3.1.1-...
TRACE[02-19|20:11:48.341] Unregistering sync peer                  peer=2bca3d609c4e2869
INFO [02-19|20:11:48.751] Looking for peers                        peercount=3 tried=27 static=0
TRACE[02-19|20:11:51.009] Registering sync peer                    peer=c67684d76212f522
DEBUG[02-19|20:11:51.009] Relaxed downloader QoS values            rtt=20s confidence=0.100 ttl=1m0s
TRACE[02-19|20:11:51.201] Registering sync peer                    peer=fb7f46b2ab038ada
DEBUG[02-19|20:11:51.201] Relaxed downloader QoS values            rtt=20s confidence=0.100 ttl=1m0s
TRACE[02-19|20:11:53.458] Registering sync peer                    peer=7b3e2b8504e4b574
DEBUG[02-19|20:11:53.458] Relaxed downloader QoS values            rtt=20s confidence=0.100 ttl=1m0s
TRACE[02-19|20:11:53.494] Unregistering sync peer                  peer=7b3e2b8504e4b574
INFO [02-19|20:11:54.233] Initializing fast sync bloom             items=3647482 errorrate=0.000 elapsed=16.001s
TRACE[02-19|20:11:55.296] Registering sync peer                    peer=8f271810db9c4a99
DEBUG[02-19|20:11:55.296] Relaxed downloader QoS values            rtt=20s confidence=0.100 ttl=1m0s
TRACE[02-19|20:11:55.521] Unregistering sync peer                  peer=8f271810db9c4a99
TRACE[02-19|20:11:57.264] Registering sync peer                    peer=6df3953c63ae022b
DEBUG[02-19|20:11:57.264] Relaxed downloader QoS values            rtt=20s confidence=0.100 ttl=1m0s
WARN [02-19|20:11:57.390] Dropping unsynced node during fast sync  id=6df3953c63ae022b conn=dyndial addr=176.9.122.147:31313 type=Geth/v1.9.25-unstabl...
TRACE[02-19|20:11:57.390] Unregistering sync peer                  peer=6df3953c63ae022b
TRACE[02-19|20:11:57.907] Registering sync peer                    peer=6d6e693574aad7e7
DEBUG[02-19|20:11:57.918] Relaxed downloader QoS values            rtt=20s confidence=0.100 ttl=1m0s
WARN [02-19|20:11:58.059] Dropping unsynced node during fast sync  id=6d6e693574aad7e7 conn=dyndial addr=176.9.122.147:31318 type=Geth/v1.9.25-unstabl...
TRACE[02-19|20:11:58.059] Unregistering sync peer                  peer=6d6e693574aad7e7
DEBUG[02-19|20:11:58.238] Recalculated downloader QoS values       rtt=20s confidence=0.550 ttl=1m0s
TRACE[02-19|20:11:58.463] Registering sync peer                    peer=1a0ccf9c1b9b0ca1
DEBUG[02-19|20:11:58.464] Relaxed downloader QoS values            rtt=20s confidence=0.458 ttl=1m0s
INFO [02-19|20:11:58.872] Looking for peers                        peercount=6 tried=43 static=0
INFO [02-19|20:12:02.233] Initializing fast sync bloom             items=5916557 errorrate=0.000 elapsed=24.001s
TRACE[02-19|20:12:02.499] Registering sync peer                    peer=9744de51c28106ee
DEBUG[02-19|20:12:02.499] Relaxed downloader QoS values            rtt=20s confidence=0.393 ttl=1m0s
WARN [02-19|20:12:02.839] Dropping unsynced node during fast sync  id=9744de51c28106ee conn=inbound addr=161.117.183.196:52392 type=
TRACE[02-19|20:12:02.839] Unregistering sync peer                  peer=9744de51c28106ee
TRACE[02-19|20:12:03.513] Registering sync peer                    peer=66ce18f76d218308
DEBUG[02-19|20:12:03.513] Relaxed downloader QoS values            rtt=20s confidence=0.337 ttl=1m0s
TRACE[02-19|20:12:08.668] Registering sync peer                    peer=6db2c966dbb81655
DEBUG[02-19|20:12:08.668] Relaxed downloader QoS values            rtt=20s confidence=0.295 ttl=1m0s
INFO [02-19|20:12:08.894] Looking for peers                        peercount=9 tried=48 static=0
INFO [02-19|20:12:10.235] Initializing fast sync bloom             items=8195763 errorrate=0.000 elapsed=32.002s
TRACE[02-19|20:12:10.784] Registering sync peer                    peer=7fa1f7238ea996c0
DEBUG[02-19|20:12:10.784] Relaxed downloader QoS values            rtt=20s confidence=0.262 ttl=1m0s
TRACE[02-19|20:12:12.263] Registering sync peer                    peer=3e191848b80e9de3
WARN [02-19|20:12:12.665] Dropping unsynced node during fast sync  id=3e191848b80e9de3 conn=dyndial addr=62.1.195.239:30303    type=Geth/v1.9.25-stable-...
TRACE[02-19|20:12:12.665] Unregistering sync peer                  peer=3e191848b80e9de3
TRACE[02-19|20:12:13.121] Registering sync peer                    peer=7b282204f79e27a4
TRACE[02-19|20:12:18.089] Registering sync peer                    peer=6b0eca453415ac68
INFO [02-19|20:12:18.236] Initializing fast sync bloom             items=10581548 errorrate=0.000 elapsed=40.003s
.
.
.
DEBUG[02-19|20:12:47.961] Synchronising with the network           peer=ed04927bac5b4927 eth=65 head="2dcf08…15ad35" td=21256083028275477632939 mode=fast
DEBUG[02-19|20:12:47.961] Retrieving remote chain head             peer=ed04927bac5b4927
DEBUG[02-19|20:12:48.085] Looking for common ancestor              peer=ed04927bac5b4927 local=11889061 remote=11891121
TRACE[02-19|20:12:48.085] Span searching for common ancestor       peer=ed04927bac5b4927 count=12 from=11890944 skip=15
TRACE[02-19|20:12:48.210] Binary searching for common ancestor     peer=ed04927bac5b4927 start=11799061 end=11891121
TRACE[02-19|20:12:48.800] Unregistering sync peer                  peer=0871bc203f99ab8e
TRACE[02-19|20:12:48.935] Registering sync peer                    peer=ba64fb600c19962b
INFO [02-19|20:12:49.436] Looking for peers                        peercount=20 tried=54 static=0
INFO [02-19|20:12:50.243] Initializing fast sync bloom             items=19532753 errorrate=0.000 elapsed=1m12.010s
TRACE[02-19|20:12:50.282] Registering sync peer                    peer=4dab877e938eaa59
TRACE[02-19|20:12:50.457] Registering sync peer                    peer=a695c3bf17261508
DEBUG[02-19|20:12:51.014] Found common ancestor                    peer=ed04927bac5b4927 number=11889061 hash="948768…9124c0"
INFO [02-19|20:12:51.015] Disabling direct-ancient mode            origin=11889061 ancient=11337727
DEBUG[02-19|20:12:51.015] Downloading block bodies                 origin=11889062
DEBUG[02-19|20:12:51.015] Downloading transaction receipts         origin=11889062
DEBUG[02-19|20:12:51.015] Directing header downloads               peer=ed04927bac5b4927 origin=11889062
TRACE[02-19|20:12:51.015] Fetching skeleton headers                peer=ed04927bac5b4927 count=192 from=11889062
TRACE[02-19|20:12:51.037] State sync starting                      root="d1996a…dedf8b"
TRACE[02-19|20:12:51.037] Requesting batch of state data           peer=35ca0e4508c2b4b3 nodes=1 codes=0 root="d1996a…dedf8b"
DEBUG[02-19|20:12:51.186] Filling up skeleton                      from=11889062
TRACE[02-19|20:12:51.286] Requesting new batch of data             peer=e8aca8a26847f0a0 type=headers                 from=11889062
TRACE[02-19|20:12:51.286] Requesting new batch of data             peer=d85c13abccf0612a type=headers                 from=11889254
TRACE[02-19|20:12:51.286] Requesting new batch of data             peer=ed04927bac5b4927 type=headers                 from=11889446
TRACE[02-19|20:12:51.286] Requesting new batch of data             peer=ba64fb600c19962b type=headers                 from=11889638
TRACE[02-19|20:12:51.287] Requesting new batch of data             peer=1a0ccf9c1b9b0ca1 type=headers                 from=11889830
TRACE[02-19|20:12:51.287] Requesting new batch of data             peer=6db2c966dbb81655 type=headers                 from=11890022
TRACE[02-19|20:12:51.287] Requesting new batch of data             peer=f0c29db91fe13ecf type=headers                 from=11890214
TRACE[02-19|20:12:51.287] Requesting new batch of data             peer=87ee84815193f4ed type=headers                 from=11890406
TRACE[02-19|20:12:51.287] Requesting new batch of data             peer=c67684d76212f522 type=headers                 from=11890598
TRACE[02-19|20:12:51.287] Requesting new batch of data             peer=0e6d0f98ee089e4d type=headers                 from=11890790
TRACE[02-19|20:12:51.326] Skeleton filling not accepted            peer=6db2c966dbb81655 from=11890022
TRACE[02-19|20:12:51.326] Failed to deliver retrieved data         peer=6db2c966dbb81655 type=headers                 err="delivery not accepted"
TRACE[02-19|20:12:51.326] Requesting new batch of data             peer=a695c3bf17261508 type=headers                 from=11890022
TRACE[02-19|20:12:51.384] Received node data response              peer=35ca0e4508c2b4b3 count=1   dropped=false timeout=false
TRACE[02-19|20:12:51.384] Skeleton filling not accepted            peer=a695c3bf17261508 from=11890022
TRACE[02-19|20:12:51.384] Failed to deliver retrieved data         peer=a695c3bf17261508 type=headers                 err="delivery not accepted"
TRACE[02-19|20:12:51.384] Requesting new batch of data             peer=7b282204f79e27a4 type=headers                 from=11890022
TRACE[02-19|20:12:51.426] Peer throughput measurements updated     peer=ba64fb600c19962b hps=138.762 bps=0.000 rps=0.000 sps=0.000 miss=0 rtt=18.013836612s
TRACE[02-19|20:12:51.426] Delivered new batch of data              peer=ba64fb600c19962b type=headers                 count=192
TRACE[02-19|20:12:51.452] Peer throughput measurements updated     peer=ed04927bac5b4927 hps=116.593 bps=0.000 rps=0.000 sps=0.000 miss=0 rtt=18.016467546s
TRACE[02-19|20:12:51.452] Delivered new batch of data              peer=ed04927bac5b4927 type=headers                 count=192
TRACE[02-19|20:12:51.470] Peer throughput measurements updated     peer=d85c13abccf0612a hps=105.686 bps=0.000 rps=0.000 sps=0.000 miss=0 rtt=18.018166953s
TRACE[02-19|20:12:51.470] Delivered new batch of data              peer=d85c13abccf0612a type=headers                 count=192
TRACE[02-19|20:12:51.473] Peer throughput measurements updated     peer=0e6d0f98ee089e4d hps=103.864 bps=0.000 rps=0.000 sps=0.000 miss=0 rtt=18.01848572s
TRACE[02-19|20:12:51.473] Delivered new batch of data              peer=0e6d0f98ee089e4d type=headers                 count=192
TRACE[02-19|20:12:51.489] Peer throughput measurements updated     peer=87ee84815193f4ed hps=95.970  bps=0.000 rps=0.000 sps=0.000 miss=0 rtt=18.020006262s
TRACE[02-19|20:12:51.489] Delivered new batch of data              peer=87ee84815193f4ed type=headers                 count=192
TRACE[02-19|20:12:51.571] Skeleton filling not accepted            peer=7b282204f79e27a4 from=11890022
TRACE[02-19|20:12:51.571] Failed to deliver retrieved data         peer=7b282204f79e27a4 type=headers                 err="delivery not accepted"
TRACE[02-19|20:12:51.571] Requesting new batch of data             peer=ba64fb600c19962b type=headers                 from=11890022
TRACE[02-19|20:12:51.588] Peer throughput measurements updated     peer=f0c29db91fe13ecf hps=64.118  bps=0.000 rps=0.000 sps=0.000 miss=0 rtt=18.029944915s
TRACE[02-19|20:12:51.588] Delivered new batch of data              peer=f0c29db91fe13ecf type=headers                 count=192
.
.
.
TRACE[02-19|20:13:04.822] Requesting batch of state data           peer=ae4e91501aa39748 nodes=10  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:04.822] Received node data response              peer=ba64fb600c19962b count=1     dropped=false timeout=false
TRACE[02-19|20:13:04.851] All headers delayed, waiting             peer=ed04927bac5b4927
TRACE[02-19|20:13:05.137] Peer throughput measurements updated     peer=ba64fb600c19962b hps=249.914 bps=21.056 rps=8.605  sps=0.383  miss=0 rtt=5.56449265s
TRACE[02-19|20:13:05.137] Requesting batch of state data           peer=ba64fb600c19962b nodes=6   codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:05.137] Received node data response              peer=1a0ccf9c1b9b0ca1 count=30    dropped=false timeout=false
TRACE[02-19|20:13:05.996] Peer throughput measurements updated     peer=35ca0e4508c2b4b3 hps=0.000   bps=0.258  rps=0.241  sps=3.204  miss=0 rtt=12.880478551s
TRACE[02-19|20:13:05.997] Delivered new batch of data              peer=35ca0e4508c2b4b3 type=bodies                  count=5:5
INFO [02-19|20:13:06.244] Initializing fast sync bloom             items=23537476 errorrate=0.000 elapsed=1m28.012s
TRACE[02-19|20:13:07.852] Fetching full headers                    peer=ed04927bac5b4927 count=192   from=11891123
TRACE[02-19|20:13:07.987] All headers delayed, waiting             peer=ed04927bac5b4927
TRACE[02-19|20:13:08.357] Registering sync peer                    peer=f23ac6da7c02f84a
TRACE[02-19|20:13:08.364] Unregistering sync peer                  peer=f23ac6da7c02f84a
TRACE[02-19|20:13:09.455] Registering sync peer                    peer=8d1da4c5bc682f8f
TRACE[02-19|20:13:09.456] Unregistering sync peer                  peer=8d1da4c5bc682f8f
TRACE[02-19|20:13:10.988] Fetching full headers                    peer=ed04927bac5b4927 count=192   from=11891123
.
.
.
TRACE[02-19|20:13:15.769] Peer throughput measurements updated     peer=1a0ccf9c1b9b0ca1 hps=50.606  bps=3.471  rps=0.617  sps=4.628  miss=0 rtt=9.200469466s
TRACE[02-19|20:13:15.769] Requesting batch of state data           peer=1a0ccf9c1b9b0ca1 nodes=63  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:15.769] Requesting batch of state data           peer=3bd606dde89f9b11 nodes=18  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:15.769] Requesting batch of state data           peer=e91e0dfbdf48ba87 nodes=18  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:15.769] Requesting batch of state data           peer=9389d89f480cbf56 nodes=18  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:15.769] Requesting batch of state data           peer=673c415a2d1cd095 nodes=18  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:15.770] Requesting batch of state data           peer=17790fc7027657ed nodes=18  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:15.770] Requesting batch of state data           peer=94b82260db33e63d nodes=18  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:15.770] Requesting batch of state data           peer=adad89061e0d7664 nodes=18  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:15.770] Requesting batch of state data           peer=7df342806b2afe82 nodes=18  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:15.770] Requesting batch of state data           peer=025e63c51edfcd84 nodes=18  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:15.770] Received node data response              peer=df7554e30373e7a9 count=23    dropped=false timeout=false
TRACE[02-19|20:13:17.314] Fetching full headers                    peer=ed04927bac5b4927 count=192   from=11891123
TRACE[02-19|20:13:17.433] Scheduling new headers                   peer=ed04927bac5b4927 count=1     from=11891123
TRACE[02-19|20:13:17.433] Fetching full headers                    peer=ed04927bac5b4927 count=192   from=11891124
INFO [02-19|20:13:17.440] Imported new block headers               count=1     elapsed=6.985ms   number=11891123 hash="5af6e8…3638ae"
TRACE[02-19|20:13:17.555] All headers delayed, waiting             peer=ed04927bac5b4927
TRACE[02-19|20:13:20.353] Registering sync peer                    peer=4d151e475927fee1
TRACE[02-19|20:13:20.556] Fetching full headers                    peer=ed04927bac5b4927 count=192   from=11891124
TRACE[02-19|20:13:20.687] All headers delayed, waiting             peer=ed04927bac5b4927
WARN [02-19|20:13:21.870] Dropping unsynced node during fast sync  id=025e63c51edfcd84 conn=inbound addr=167.71.38.163:40818   type=Geth/v1.9.25-stable-...
TRACE[02-19|20:13:21.870] Unregistering sync peer                  peer=025e63c51edfcd84
INFO [02-19|20:13:22.248] Initializing fast sync bloom             items=27733548 errorrate=0.000 elapsed=1m44.016s
TRACE[02-19|20:13:22.389] Registering sync peer                    peer=55978a8915af9028
WARN [02-19|20:13:22.450] Dropping unsynced node during fast sync  id=55978a8915af9028 conn=inbound addr=107.179.160.186:41124 type=Geth/v1.9.25-stable-...
TRACE[02-19|20:13:22.450] Unregistering sync peer                  peer=55978a8915af9028
TRACE[02-19|20:13:23.248] Peer throughput measurements updated     peer=7b2169d70a8c2aca hps=39.618  bps=1.673  rps=0.780  sps=0.347  miss=0 rtt=14.407791521s
TRACE[02-19|20:13:23.248] Delivered new batch of data              peer=7b2169d70a8c2aca type=bodies                  count=32:32
TRACE[02-19|20:13:23.306] Registering sync peer                    peer=cbbb5a2608aab49b
TRACE[02-19|20:13:23.688] Fetching full headers                    peer=ed04927bac5b4927 count=192   from=11891124
TRACE[02-19|20:13:23.824] All headers delayed, waiting             peer=ed04927bac5b4927
WARN [02-19|20:13:23.921] Dropping unsynced node during fast sync  id=cbbb5a2608aab49b conn=inbound addr=141.98.252.170:64925  type=OpenEthereum/v3.1.1-...
TRACE[02-19|20:13:23.922] Unregistering sync peer                  peer=cbbb5a2608aab49b
TRACE[02-19|20:13:23.935] Peer throughput measurements updated     peer=df7554e30373e7a9 hps=0.000   bps=0.521  rps=1.314  sps=4.431  miss=0 rtt=10.140487125s
TRACE[02-19|20:13:23.935] Requesting batch of state data           peer=df7554e30373e7a9 nodes=60  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:23.935] Requesting batch of state data           peer=4d151e475927fee1 nodes=19  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:23.935] Received node data response              peer=4dab877e938eaa59 count=2     dropped=false timeout=false
TRACE[02-19|20:13:24.316] Registering sync peer                    peer=8bcf2ae98fa038f4
TRACE[02-19|20:13:24.677] Peer throughput measurements updated     peer=4dab877e938eaa59 hps=0.000   bps=2.185  rps=0.591  sps=0.242  miss=0 rtt=12.290420647s
TRACE[02-19|20:13:24.677] Requesting batch of state data           peer=8bcf2ae98fa038f4 nodes=21  codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:24.677] Requesting batch of state data           peer=4dab877e938eaa59 nodes=4   codes=0 root="d1996a…dedf8b"
TRACE[02-19|20:13:24.678] Received node data response              peer=f0c29db91fe13ecf count=30    dropped=false timeout=false
TRACE[02-19|20:13:25.298] Registering sync peer                    peer=f50cb5ced45b332e
TRACE[02-19|20:13:26.278] Registering sync peer                    peer=60571152a7cdbef6
TRACE[02-19|20:13:26.279] Unregistering sync peer                  peer=60571152a7cdbef6
TRACE[02-19|20:13:26.824] Fetching full headers                    peer=ed04927bac5b4927 count=192   from=11891124
TRACE[02-19|20:13:26.961] All headers delayed, waiting             peer=ed04927bac5b4927
TRACE[02-19|20:13:26.984] Registering sync peer                    peer=0c8e87cb71076c34
TRACE[02-19|20:13:27.381] Registering sync peer                    peer=f2be2d18b30fbe0f
TRACE[02-19|20:13:27.391] Unregistering sync peer                  peer=f2be2d18b30fbe0f
TRACE[02-19|20:13:27.443] Registering sync peer                    peer=7b3e2b8504e4b574
TRACE[02-19|20:13:29.050] Registering sync peer                    peer=0e281c21f3f6c237
TRACE[02-19|20:13:29.962] Fetching full headers                    peer=ed04927bac5b4927 count=192   from=11891124
TRACE[02-19|20:13:30.096] All headers delayed, waiting             peer=ed04927bac5b4927
INFO [02-19|20:13:30.248] Initializing fast sync bloom             items=29870002 errorrate=0.000 elapsed=1m52.016s
DEBUG[02-19|20:13:30.524] Recalculated downloader QoS values       rtt=13.307922626s confidence=0.977 ttl=40.866392076s
TRACE[02-19|20:13:30.603] Registering sync peer                    peer=79c1e9ed4c07d24d
DEBUG[02-19|20:13:32.715] Stalling delivery, dropping              peer=93108d5041d91749 type=receipts
DEBUG[02-19|20:13:32.715] Stalling delivery, dropping              peer=93108d5041d91749 type=bodies
TRACE[02-19|20:13:32.715] Unregistering sync peer                  peer=93108d5041d91749
TRACE[02-19|20:13:32.715] Unregistering sync peer                  peer=93108d5041d91749
ERROR[02-19|20:13:32.715] Failed to unregister sync peer           peer=93108d5041d91749 err="peer is not registered"
TRACE[02-19|20:13:32.715] Requesting new batch of data             peer=ba64fb600c19962b type=bodies                  count=2     from=11889071
ERROR[02-19|20:13:32.715] Peer removal failed                      peer=93108d5041d91749 err="peer is not registered"
TRACE[02-19|20:13:32.718] Requesting new batch of data             peer=87ee84815193f4ed type=receipts                count=2     from=11889085
TRACE[02-19|20:13:32.854] Peer throughput measurements updated     peer=ba64fb600c19962b hps=249.914 bps=20.439 rps=8.605  sps=0.383  miss=0 rtt=5.021472003s
TRACE[02-19|20:13:32.854] Delivered new batch of data              peer=ba64fb600c19962b type=bodies                  count=2:2
DEBUG[02-19|20:13:32.855] Inserting fast-sync blocks               items=14       firstnum=11889071 firsthash="15ba08…c23869" lastnumn=11889084 lasthash="90bfe7…d35b8c"
TRACE[02-19|20:13:32.879] Peer throughput measurements updated     peer=87ee84815193f4ed hps=95.970  bps=16.888 rps=17.133 sps=0.000  miss=0 rtt=5.501062424s
TRACE[02-19|20:13:32.879] Delivered new batch of data              peer=87ee84815193f4ed type=receipts                count=2
INFO [02-19|20:13:32.900] Imported new block receipts              count=14    elapsed=44.306ms  number=11889084 hash="90bfe7…d35b8c" age=7h21m24s  size=1.46MiB
DEBUG[02-19|20:13:32.912] Inserting fast-sync blocks               items=530      firstnum=11889085 firsthash="4ccf80…86d0bf" lastnumn=11889614 lasthash="016df2…68f9b5"
TRACE[02-19|20:13:32.916] Requesting new batch of data             peer=87ee84815193f4ed type=receipts                count=206   from=11889615
TRACE[02-19|20:13:32.916] Requesting new batch of data             peer=ba64fb600c19962b type=receipts                count=35    from=11889925
TRACE[02-19|20:13:32.917] Requesting new batch of data             peer=ba64fb600c19962b type=bodies                  count=115   from=11889634
TRACE[02-19|20:13:33.100] Fetching full headers                    peer=ed04927bac5b4927 count=192   from=11891124

IPC stuff

> admin.nodeInfo
{
  .
  .
  .
  name: "Geth/v1.9.25-stable-e7872729/linux-amd64/go1.15.6",
  ports: {
    discovery: 30303,
    listener: 30303
  },
.
.
.
> eth.syncing.knownStates - eth.syncing.pulledStates
0
> eth.syncing.highestBlock - eth.syncing.currentBlock
2051
> eth.syncing.knownStates - eth.syncing.pulledStates
0
> eth.syncing.highestBlock - eth.syncing.currentBlock
2051
> eth.syncing.knownStates - eth.syncing.pulledStates
0
> eth.syncing.highestBlock - eth.syncing.currentBlock
2052
> eth.syncing.knownStates - eth.syncing.pulledStates
0
> eth.syncing.highestBlock - eth.syncing.currentBlock
2052
> eth.syncing.knownStates - eth.syncing.pulledStates
0
> eth.syncing.highestBlock - eth.syncing.currentBlock
2052
> eth.syncing.highestBlock - eth.syncing.currentBlock
2053
> eth.syncing.knownStates - eth.syncing.pulledStates
0
> eth.syncing.highestBlock - eth.syncing.currentBlock
2053
> eth.syncing.knownStates - eth.syncing.pulledStates
0
> 

Eventually I get to a point where my states are no longer updating and the blocks update very infrequently.

.
.
> eth.syncing.highestBlock - eth.syncing.currentBlock
2053
> eth.syncing.knownStates - eth.syncing.pulledStates
0
> eth.syncing.knownStates - eth.syncing.pulledStates
4258
> eth.syncing.highestBlock - eth.syncing.currentBlock
192
> eth.syncing.knownStates - eth.syncing.pulledStates
4258
> eth.syncing.highestBlock - eth.syncing.currentBlock
152
> eth.syncing.knownStates - eth.syncing.pulledStates
4258
> eth.syncing.highestBlock - eth.syncing.currentBlock
152
> eth.syncing.knownStates - eth.syncing.pulledStates
4258
> eth.syncing.highestBlock - eth.syncing.currentBlock
152
> eth.syncing.knownStates - eth.syncing.pulledStates
4258
> eth.syncing.highestBlock - eth.syncing.currentBlock
66
> eth.syncing.knownStates - eth.syncing.pulledStates
5384
> eth.syncing.highestBlock - eth.syncing.currentBlock
67
> eth.syncing.knownStates - eth.syncing.pulledStates
5384
> eth.syncing.highestBlock - eth.syncing.currentBlock
68
> eth.syncing.knownStates - eth.syncing.pulledStates
5127
> eth.syncing.highestBlock - eth.syncing.currentBlock
69
> eth.syncing.knownStates - eth.syncing.pulledStates
5127
> eth.syncing.highestBlock - eth.syncing.currentBlock
70
> eth.syncing.knownStates - eth.syncing.pulledStates
6105
> 

Any info or suggestions would be most helpful. Is this a thing with the Ethereum blockchain being difficult to sync? Are there any configuration issues that are obvious from the log and other output? Should I be using another client?

Your Answer

By clicking “Post Your Answer”, you agree to our terms of service, privacy policy and cookie policy

Browse other questions tagged or ask your own question.