Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Full Sync fails on block 3804607 with BAD BLOCK ERROR: invalid gas used #17261

Closed
rapidddenis opened this issue Jul 27, 2018 · 17 comments

Comments

@rapidddenis
Copy link

commented Jul 27, 2018

System information

Geth version: 1.8.12-stable-37685930
OS & Version: Ubuntu 18.04

Expected behaviour

Syncing

Actual behaviour

Looping through peers on block 3804607 with BAD BLOCK ERROR: invalid gas used (remote: 1329607 local: 1541792)
2 attempts - same block, same error

Steps to reproduce the behaviour

sudo geth remove db
sudo geth --cache 11000 --syncmode full

Logs:

nuc@nuc-desktop:~/Downloads/geth-alltools-linux-amd64-1.8.12-37685930$ sudo ./geth --datadir /media/nuc/970_EVO_500GB/ethereum_full --ethash.dagdir /media/nuc/970_EVO_500GB/etash --cache 11000 --syncmode full --verbosity 4
WARN [07-27|11:29:57.533] Sanitizing cache to Go's GC limits       provided=11000 updated=10539
DEBUG[07-27|11:29:57.533] Sanitizing Go's GC trigger               percent=20
INFO [07-27|11:29:57.534] Maximum peer count                       ETH=25 LES=0 total=25
DEBUG[07-27|11:29:57.534] FS scan times                            list=21.399µs set=574ns diff=1.352µs
INFO [07-27|11:29:57.534] Starting peer-to-peer node               instance=Geth/v1.8.12-stable-37685930/linux-amd64/go1.10.3
INFO [07-27|11:29:57.535] Allocated cache and file handles         database=/media/nuc/970_EVO_500GB/ethereum_full/geth/chaindata cache=7904 handles=512
INFO [07-27|11:29:58.433] Initialised chain configuration          config="{ChainID: 1 Homestead: 1150000 DAO: 1920000 DAOSupport: true EIP150: 2463000 EIP155: 2675000 EIP158: 2675000 Byzantium: 4370000 Constantinople: <nil> Engine: ethash}"
INFO [07-27|11:29:58.433] Disk storage enabled for ethash caches   dir=/media/nuc/970_EVO_500GB/ethereum_full/geth/ethash count=3
INFO [07-27|11:29:58.433] Disk storage enabled for ethash DAGs     dir=/media/nuc/970_EVO_500GB/etash                     count=2
INFO [07-27|11:29:58.433] Initialising Ethereum protocol           versions="[63 62]" network=1
INFO [07-27|11:29:58.434] Loaded most recent local header          number=3804606 hash=143bf8…1d4ceb td=308945085210269579135
INFO [07-27|11:29:58.434] Loaded most recent local full block      number=3804606 hash=143bf8…1d4ceb td=308945085210269579135
INFO [07-27|11:29:58.434] Loaded most recent local fast block      number=3804606 hash=143bf8…1d4ceb td=308945085210269579135
DEBUG[07-27|11:29:58.434] Reinjecting stale transactions           count=0
INFO [07-27|11:29:58.434] Loaded local transaction journal         transactions=0 dropped=0
INFO [07-27|11:29:58.434] Regenerated local transaction journal    transactions=0 accounts=0
DEBUG[07-27|11:29:58.434] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
INFO [07-27|11:29:58.435] Starting P2P networking 
DEBUG[07-27|11:30:00.536] Couldn't add port mapping                proto=udp extport=30303 intport=30303 interface="UPnP or NAT-PMP" err="no UPnP or NAT-PMP router discovered"
DEBUG[07-27|11:30:00.586] Found seed node in database              id=0157c546c7aa5fdd addr=109.74.145.30:30303 age=13h21m42.586096527s
DEBUG[07-27|11:30:00.586] Found seed node in database              id=0ff2a447bba5d480 addr=158.176.80.125:21001 age=7m58.586231584s
DEBUG[07-27|11:30:00.586] Found seed node in database              id=1c91110aade6ff79 addr=198.13.53.61:30303   age=23h50m13.586317303s
DEBUG[07-27|11:30:00.586] Found seed node in database              id=2abbdaa74271090d addr=35.231.159.91:30203  age=13h18m22.586397297s
DEBUG[07-27|11:30:00.586] Found seed node in database              id=33346f7f5a75f035 addr=209.95.50.38:30303   age=17h2m20.58647166s
DEBUG[07-27|11:30:00.586] Found seed node in database              id=3c35a71ef1183e01 addr=61.93.86.52:42786    age=13h16m1.58654646s
DEBUG[07-27|11:30:00.586] Found seed node in database              id=42adfce33b5b3fad addr=107.191.55.239:30303 age=1m43.586617385s
DEBUG[07-27|11:30:00.586] Found seed node in database              id=56e46bf5d7e5ea6a addr=87.27.111.252:30388  age=21.586678835s
DEBUG[07-27|11:30:00.586] Found seed node in database              id=58b8de8ad7511da0 addr=165.227.110.208:52018 age=13h19m10.586758065s
DEBUG[07-27|11:30:00.586] Found seed node in database              id=6d02095f6c9bfec5 addr=79.124.60.137:30304   age=16h37m34.586843663s
DEBUG[07-27|11:30:00.586] Found seed node in database              id=71db5bf92068dc0f addr=45.32.25.222:28568    age=95h43m23.586917814s
DEBUG[07-27|11:30:00.586] Found seed node in database              id=7330457c47a5f0ca addr=208.110.82.27:30303   age=22h18m49.587006077s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=816dd9221305ffd5 addr=188.166.92.252:30303  age=13h21m4.587088771s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=8078e94e6d095f3b addr=54.249.40.1:30303     age=13h21m58.587160161s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=8a39fbb1da23a4b1 addr=139.99.96.124:30303   age=13h15m46.587238077s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=8b0a1055cc828d7b addr=52.91.220.81:30303    age=13h19m19.587311498s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=907b441b72168c7e addr=195.201.108.21:30388  age=13h43m48.587392307s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=973b8ede32f2910a addr=188.166.174.80:30303  age=19h0m43.587468489s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=9f980d5d8b8d68a3 addr=212.235.185.26:30303  age=13h44m16.587547319s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=b1a1dfd6c3f3a9b9 addr=104.231.36.186:30303  age=2m21.587614466s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=ba89fcb07d69bb4b addr=91.220.87.112:30303   age=23h38m34.587695409s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=c1dc615f3f2fd659 addr=52.29.177.6:30303     age=17h37m59.587770163s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=cac779ddbd1d870e addr=144.202.93.36:30303   age=15h27m5.587844698s
DEBUG[07-27|11:30:00.587] Found seed node in database              id=de852073c2826cb7 addr=37.228.134.75:30303   age=21h55m34.587963985s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=e5c592ed3b5c9118 addr=107.155.29.148:40205  age=3m14.588026277s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=f1fe503fbd8ac12e addr=54.36.172.47:30303    age=13h24m28.588102979s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=f67ff136680d7e5d addr=139.99.195.162:30303  age=93h13m28.588183075s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=06481b11cb97707c addr=34.239.74.84:20202    age=13h27m18.588272907s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=13fdfa447bb21a1f addr=66.42.39.95:30303     age=13h29m52.588361984s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=31339c823c6cf109 addr=50.2.39.93:30303      age=13h23m35.588443591s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=a979fb575495b8d6 addr=52.16.188.185:30303   age=425744h30m0.588564815s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=3f1d12044546b763 addr=13.93.211.84:30303    age=425744h30m0.588667108s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=78de8a0916848093 addr=191.235.84.50:30303   age=2m35.588731779s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=158f8aab45f6d19c addr=13.75.154.138:30303   age=7m14.58879532s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=1118980bf48b0a36 addr=52.74.57.123:30303    age=425744h30m0.588894023s
DEBUG[07-27|11:30:00.588] Found seed node in database              id=979b7fa28feeb35a addr=5.1.83.226:30303      age=425744h30m0.589000784s
INFO [07-27|11:30:00.589] UDP listener up                          self=enode://40862f30b21f17085d198512c3e173c522da023c22af12d4e8ef31f0691cece68f5e6fd2801fe38925c380bb75199e979e911607e3aa2f8fdf3b275165133941@[::]:30303
DEBUG[07-27|11:30:00.589] Couldn't add port mapping                proto=tcp extport=30303 intport=30303 interface="UPnP or NAT-PMP" err="no UPnP or NAT-PMP router discovered"
INFO [07-27|11:30:00.589] RLPx listener up                         self=enode://40862f30b21f17085d198512c3e173c522da023c22af12d4e8ef31f0691cece68f5e6fd2801fe38925c380bb75199e979e911607e3aa2f8fdf3b275165133941@[::]:30303
DEBUG[07-27|11:30:00.589] InProc registered                        service=&{node:0xc42031c780} namespace=admin
DEBUG[07-27|11:30:00.589] InProc registered                        service=&{node:0xc42031c780} namespace=admin
DEBUG[07-27|11:30:00.590] InProc registered                        service="&{mu:{state:0 sema:0} cpuW:<nil> cpuFile: traceW:<nil> traceFile:}" namespace=debug
DEBUG[07-27|11:30:00.590] InProc registered                        service=&{node:0xc42031c780}                                                 namespace=debug
DEBUG[07-27|11:30:00.590] InProc registered                        service=&{stack:0xc42031c780}                                                namespace=web3
DEBUG[07-27|11:30:00.590] InProc registered                        service=&{b:0xc420a49f10}                                                    namespace=eth
DEBUG[07-27|11:30:00.591] InProc registered                        service=&{b:0xc420a49f10}                                                    namespace=eth
DEBUG[07-27|11:30:00.591] InProc registered                        service="&{b:0xc420a49f10 nonceLock:0xc42352e430}"                           namespace=eth
DEBUG[07-27|11:30:00.591] InProc registered                        service=&{b:0xc420a49f10}                                                    namespace=txpool
DEBUG[07-27|11:30:00.591] InProc registered                        service=&{b:0xc420a49f10}                                                    namespace=debug
DEBUG[07-27|11:30:00.591] InProc registered                        service=&{b:0xc420a49f10}                                                    namespace=debug
DEBUG[07-27|11:30:00.591] InProc registered                        service=&{am:0xc420222000}                                                   namespace=eth
DEBUG[07-27|11:30:00.592] InProc registered                        service="&{am:0xc420222000 nonceLock:0xc42352e430 b:0xc420a49f10}"           namespace=personal
DEBUG[07-27|11:30:00.592] InProc registered                        service=&{e:0xc42039a8c0}                                                    namespace=eth
DEBUG[07-27|11:30:00.592] InProc registered                        service="&{e:0xc42039a8c0 agent:0xc423431800}"                               namespace=eth
DEBUG[07-27|11:30:00.592] InProc registered                        service="&{d:0xc420225040 mux:0xc42020f560 installSyncSubscription:0xc42352b080 uninstallSyncSubscription:0xc42352b0e0}" namespace=eth
DEBUG[07-27|11:30:00.592] InProc registered                        service=&{e:0xc42039a8c0}                                                                                                namespace=miner
DEBUG[07-27|11:30:00.592] InProc registered                        service="&{backend:0xc420a49f10 mux:0xc42020f560 quit:<nil> chainDb:0xc4202f2fd0 events:0xc422b55f40 filtersMu:{state:0 sema:0} filters:map[]}" namespace=eth
DEBUG[07-27|11:30:00.592] InProc registered                        service=&{eth:0xc42039a8c0}                                                                                                                     namespace=admin
DEBUG[07-27|11:30:00.592] InProc registered                        service=&{eth:0xc42039a8c0}                                                                                                                     namespace=debug
DEBUG[07-27|11:30:00.593] InProc registered                        service="&{config:0x17b3900 eth:0xc42039a8c0}"                                                                                                  namespace=debug
DEBUG[07-27|11:30:00.593] InProc registered                        service="&{net:0xc42031cf00 networkVersion:1}"                                                                                                  namespace=net
DEBUG[07-27|11:30:00.593] IPC registered                           namespace=admin
DEBUG[07-27|11:30:00.593] IPC registered                           namespace=admin
DEBUG[07-27|11:30:00.593] IPC registered                           namespace=debug
DEBUG[07-27|11:30:00.593] IPC registered                           namespace=debug
DEBUG[07-27|11:30:00.593] IPC registered                           namespace=web3
DEBUG[07-27|11:30:00.593] IPC registered                           namespace=eth
DEBUG[07-27|11:30:00.593] IPC registered                           namespace=eth
DEBUG[07-27|11:30:00.593] IPC registered                           namespace=eth
DEBUG[07-27|11:30:00.593] IPC registered                           namespace=txpool
DEBUG[07-27|11:30:00.593] IPC registered                           namespace=debug
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=debug
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=eth
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=personal
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=eth
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=eth
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=eth
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=miner
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=eth
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=admin
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=debug
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=debug
DEBUG[07-27|11:30:00.594] IPC registered                           namespace=net
INFO [07-27|11:30:00.594] IPC endpoint opened                      url=/media/nuc/970_EVO_500GB/ethereum_full/geth.ipc
DEBUG[07-27|11:30:00.596] Found seed node in database              id=18ae57c64bc90b72 addr=104.207.131.199:30303 age=5m35.596398509s
DEBUG[07-27|11:30:00.596] Found seed node in database              id=242d1e9e2f79d48f addr=139.99.42.14:30303    age=13h17m6.596528819s
DEBUG[07-27|11:30:00.596] Found seed node in database              id=2c6073fa7e1a6252 addr=206.189.112.116:30303 age=13h28m33.5966236s
DEBUG[07-27|11:30:00.596] Found seed node in database              id=36b6d97d13c68854 addr=79.124.60.137:30303   age=13h44m18.596707712s
DEBUG[07-27|11:30:00.596] Found seed node in database              id=3d9ca5956b38557a addr=167.99.246.145:21003  age=24h28m53.596788756s
DEBUG[07-27|11:30:00.596] Found seed node in database              id=4112a84ecb75a41a addr=52.78.67.74:30303     age=13h21m47.596884441s
DEBUG[07-27|11:30:00.596] Found seed node in database              id=4d46fb9f2b7c8982 addr=18.236.107.138:30303  age=1m18.596930265s
DEBUG[07-27|11:30:00.596] Found seed node in database              id=505a27e2aae09c4c addr=46.105.132.1:30350    age=13h20m43.596992391s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=56e46bf5d7e5ea6a addr=87.27.111.252:30388   age=21.597036082s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=579f786d4e2830bb addr=35.237.72.48:21002    age=24h55m46.597087336s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=583f0f3cabc41c9d addr=188.165.223.160:30303 age=24h33m39.597140993s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=6640f33ccaca0557 addr=212.237.38.185:30305  age=13h16m48.597203115s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=759281ee02e2f481 addr=68.232.175.244:31337  age=13h20m46.597265418s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=816dd9221305ffd5 addr=188.166.92.252:30303  age=13h21m4.597343284s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=87af4a616c2fe949 addr=54.36.109.160:30303   age=19h41m16.597389446s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=907b441b72168c7e addr=195.201.108.21:30388  age=13h43m48.597436909s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=92dee4ca1ed4b2ec addr=54.38.6.19:30303      age=18h45m23.597479279s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=9b65f365aff76a78 addr=104.196.183.246:28568 age=6m48.597518993s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=a4f5a8d202c5f029 addr=144.217.247.91:30303  age=13h18m31.597565754s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=aa0c0df7af3a2499 addr=37.187.136.70:30303   age=86h26m34.597614238s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=ba89fcb07d69bb4b addr=91.220.87.112:30303   age=23h38m34.597660291s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=beb0a599846b943c addr=175.209.38.148:30301  age=21h22m32.597704642s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=c1dc615f3f2fd659 addr=52.29.177.6:30303     age=17h37m59.597748344s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=cac779ddbd1d870e addr=144.202.93.36:30303   age=15h27m5.597798441s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=cfe7af1d387aec82 addr=167.99.12.88:30303    age=13h25m3.597844658s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=de852073c2826cb7 addr=37.228.134.75:30303   age=21h55m34.597892508s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=e2636323bd5aaa04 addr=139.99.122.101:10110  age=13h23m51.59794082s
DEBUG[07-27|11:30:00.597] Found seed node in database              id=e92dbae21bbb88fb addr=159.100.253.141:30303 age=20h37m15.597986541s
DEBUG[07-27|11:30:00.598] Found seed node in database              id=ed2652e0dc8aa994 addr=167.99.140.24:52018   age=19.598021573s
DEBUG[07-27|11:30:00.598] Found seed node in database              id=eec9968d7ebaae4b addr=82.196.15.42:30303    age=13h30m29.598065255s
DEBUG[07-27|11:30:00.598] Found seed node in database              id=a979fb575495b8d6 addr=52.16.188.185:30303   age=425744h30m0.598109667s
DEBUG[07-27|11:30:00.598] Found seed node in database              id=3f1d12044546b763 addr=13.93.211.84:30303    age=425744h30m0.598150787s
DEBUG[07-27|11:30:00.598] Found seed node in database              id=78de8a0916848093 addr=191.235.84.50:30303   age=2m35.598183892s
DEBUG[07-27|11:30:00.598] Found seed node in database              id=158f8aab45f6d19c addr=13.75.154.138:30303   age=7m14.598220379s
DEBUG[07-27|11:30:00.598] Found seed node in database              id=1118980bf48b0a36 addr=52.74.57.123:30303    age=425744h30m0.598260533s
DEBUG[07-27|11:30:00.598] Found seed node in database              id=979b7fa28feeb35a addr=5.1.83.226:30303      age=425744h30m0.598309117
DEBUG[07-27|11:30:02.262] Bad discv4 packet                        addr=142.161.95.139:30303  err="bad hash"
DEBUG[07-27|11:30:06.676] NTP sanity check done                    drift=-13.345849ms
DEBUG[07-27|11:30:11.789] Adding p2p peer                          name=Geth/v1.7.3-stable-4... addr=13.124.249.93:30303   peers=1
DEBUG[07-27|11:30:11.789] Ethereum peer connected                  id=8d05afcc6c4361c9 conn=dyndial name=Geth/v1.7.3-stable-4bb3c89d/linux-amd64/go1.9
DEBUG[07-27|11:30:12.222] Ethereum handshake failed                id=8d05afcc6c4361c9 conn=dyndial err="Genesis block mismatch - cf78612bd29acdf2 (!= d4e56740f876aef8)"
DEBUG[07-27|11:30:12.223] Removing p2p peer                        id=8d05afcc6c4361c9 conn=dyndial duration=433.719ms peers=0 req=true err="subprotocol error"
DEBUG[07-27|11:30:13.473] Bad discv4 packet                        addr=142.161.95.139:30303  err="bad hash"
DEBUG[07-27|11:30:18.434] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[07-27|11:30:20.618] Bad discv4 packet                        addr=150.109.12.33:30306   err="bad hash"
DEBUG[07-27|11:30:29.230] IP exceeds bucket limit                  ip=35.177.146.81
DEBUG[07-27|11:30:37.310] Adding p2p peer                          name=Pirl/v1.8.1-premium-...                       addr=45.76.164.191:30303   peers=1
DEBUG[07-27|11:30:37.310] Ethereum peer connected                  id=12f23d0a3b29789b conn=dyndial name=Pirl/v1.8.1-premium-masternode-stablev3-824f23e3/linux-amd64/go1.10
DEBUG[07-27|11:30:37.521] Ethereum handshake failed                id=12f23d0a3b29789b conn=dyndial err="Genesis block mismatch - 29a742ba74d89fc2 (!= d4e56740f876aef8)"
DEBUG[07-27|11:30:37.521] Removing p2p peer                        id=12f23d0a3b29789b conn=dyndial duration=210.831ms peers=0 req=true err="subprotocol error"
DEBUG[07-27|11:30:38.434] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[07-27|11:30:38.719] Bad discv4 packet                        addr=142.161.95.139:30303  err="bad hash"
DEBUG[07-27|11:30:52.773] Adding p2p peer                          name=Geth/v1.8.11-stable-...                                             addr=136.243.61.76:30304   peers=1
DEBUG[07-27|11:30:52.773] Ethereum peer connected                  id=1fff397a0abee52d conn=dyndial name=Geth/v1.8.11-stable-dea1ce05/linux-amd64/go1.10
DEBUG[07-27|11:30:52.892] Ethereum handshake failed                id=1fff397a0abee52d conn=dyndial err="Genesis block mismatch - 56b364107fb505ae (!= d4e56740f876aef8)"
DEBUG[07-27|11:30:52.892] Removing p2p peer                        id=1fff397a0abee52d conn=dyndial duration=118.573ms peers=0 req=true err="subprotocol error"
DEBUG[07-27|11:30:53.568] Bad discv4 packet                        addr=69.164.215.14:30303   err="bad hash"
DEBUG[07-27|11:30:56.510] Adding p2p peer                          name=Geth/v0.1.1-akroma-5...                                             addr=185.205.209.9:30303   peers=1
DEBUG[07-27|11:30:56.510] Ethereum peer connected                  id=ae006d6b5d478950 conn=dyndial name=Geth/v0.1.1-akroma-5fa3ee8c/linux-amd64/go1.10.1
DEBUG[07-27|11:30:56.707] Ethereum handshake failed                id=ae006d6b5d478950 conn=dyndial err="Genesis block mismatch - 679ee3d5213ddab6 (!= d4e56740f876aef8)"
DEBUG[07-27|11:30:56.707] Removing p2p peer                        id=ae006d6b5d478950 conn=dyndial duration=197.219ms peers=0 req=true err="subprotocol error"
DEBUG[07-27|11:30:58.435] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[07-27|11:30:58.627] Adding p2p peer                          name=Ethereum(J)/v1.6.3/L...                                             addr=69.164.215.14:30303   peers=1
DEBUG[07-27|11:30:58.628] Ethereum peer connected                  id=2d11cfe93f8caf5a conn=dyndial name=Ethereum(J)/v1.6.3/Linux/Release/Java/Dev
DEBUG[07-27|11:30:58.628] Ethereum handshake failed                id=2d11cfe93f8caf5a conn=dyndial err="Genesis block mismatch - 41941023680923e0 (!= d4e56740f876aef8)"
DEBUG[07-27|11:30:58.628] Removing p2p peer                        id=2d11cfe93f8caf5a conn=dyndial duration=949.974µs peers=0 req=false err="Genesis block mismatch - 41941023680923e0 (!= d4e56740f876aef8)"
DEBUG[07-27|11:31:09.178] Adding p2p peer                          name=Geth/v5.4.0-4851b12/...                                             addr=61.100.188.82:30304   peers=1
DEBUG[07-27|11:31:09.178] Ethereum peer connected                  id=f3296c74c049a08d conn=dyndial name=Geth/v5.4.0-4851b12/linux/go1.9.6/komid-full
DEBUG[07-27|11:31:09.544] Fetching batch of headers                id=f3296c74c049a08d conn=dyndial count=1 fromnum=1920000 skip=0 reverse=false
INFO [07-27|11:31:10.589] Block synchronisation started 
DEBUG[07-27|11:31:10.590] Synchronising with the network           peer=f3296c74c049a08d eth=63 head=2b6f57…073446 td=358427258055027435671 mode=full
DEBUG[07-27|11:31:10.590] Retrieving remote chain height           peer=f3296c74c049a08d
DEBUG[07-27|11:31:10.590] Fetching batch of headers                id=f3296c74c049a08d conn=dyndial count=1 fromhash=2b6f57…073446 skip=0 reverse=false
DEBUG[07-27|11:31:16.053] Verified to be on the other side of the DAO fork, dropping id=f3296c74c049a08d conn=dyndial
DEBUG[07-27|11:31:16.053] Ethereum message handling failed         id=f3296c74c049a08d conn=dyndial err="bad DAO pro-fork extra-data"
DEBUG[07-27|11:31:16.053] Removing Ethereum peer                   peer=f3296c74c049a08d
DEBUG[07-27|11:31:16.053] Synchronisation terminated               elapsed=5.463705431s
WARN [07-27|11:31:16.054] Synchronisation failed, retrying         err="block download canceled (requested)"
DEBUG[07-27|11:31:16.054] Removing p2p peer                        id=f3296c74c049a08d conn=dyndial duration=6.876s    peers=0 req=false err="useless peer"
DEBUG[07-27|11:31:16.409] Adding p2p peer                          name=Geth/v1.8.4-stable-6...                                             addr=54.37.83.153:30303    peers=1
DEBUG[07-27|11:31:16.410] Ethereum peer connected                  id=b060a5ac50f6a681 conn=dyndial name=Geth/v1.8.4-stable-6b54f497/linux-amd64/go1.10
DEBUG[07-27|11:31:16.583] Ethereum handshake failed                id=b060a5ac50f6a681 conn=dyndial err="Genesis block mismatch - a8b55f2dcde87270 (!= d4e56740f876aef8)"
DEBUG[07-27|11:31:16.583] Removing p2p peer                        id=b060a5ac50f6a681 conn=dyndial duration=173.695ms peers=0 req=true  err="subprotocol error"
DEBUG[07-27|11:31:18.435] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[07-27|11:31:21.631] IP exceeds bucket limit                  ip=58.82.237.10
DEBUG[07-27|11:31:27.173] Adding p2p peer                          name=Parity/v1.11.7-stabl...                                             addr=178.128.252.30:30304  peers=1
DEBUG[07-27|11:31:27.173] Ethereum peer connected                  id=24f1e0f6e4b4d3bf conn=dyndial name=Parity/v1.11.7-stable-085035f-20180717/x86_64-linux-gnu/rustc1.27.1
DEBUG[07-27|11:31:27.211] Ethereum handshake failed                id=24f1e0f6e4b4d3bf conn=dyndial err=EOF
DEBUG[07-27|11:31:27.211] Removing p2p peer                        id=24f1e0f6e4b4d3bf conn=dyndial duration=37.974ms  peers=0 req=false err=EOF
DEBUG[07-27|11:31:32.950] Adding p2p peer                          name=Parity/v1.10.6-unsta...                                             addr=18.206.159.150:30303  peers=1
DEBUG[07-27|11:31:32.950] Ethereum peer connected                  id=40cb20f40924360a conn=dyndial name=Parity/v1.10.6-unstable-bc0d134-20180605/x86_64-linux-gnu/rustc1.26.2
DEBUG[07-27|11:31:33.103] Adding p2p peer                          name=Geth/v1.8.12-stable-...                                               addr=18.191.124.161:30399  peers=2
DEBUG[07-27|11:31:33.103] Ethereum peer connected                  id=5683c1465d3d3bd0 conn=dyndial name=Geth/v1.8.12-stable-37685930/linux-amd64/go1.10
DEBUG[07-27|11:31:33.123] Ethereum handshake failed                id=40cb20f40924360a conn=dyndial err="Genesis block mismatch - 39f02c003dde5b07 (!= d4e56740f876aef8)"
DEBUG[07-27|11:31:33.123] Removing p2p peer                        id=40cb20f40924360a conn=dyndial duration=173.836ms peers=1 req=false err="Genesis block mismatch - 39f02c003dde5b07 (!= d4e56740f876aef8)"
DEBUG[07-27|11:31:33.290] Ethereum handshake failed                id=5683c1465d3d3bd0 conn=dyndial err="Genesis block mismatch - d39d4123fc97324e (!= d4e56740f876aef8)"
DEBUG[07-27|11:31:33.291] Removing p2p peer                        id=5683c1465d3d3bd0 conn=dyndial duration=188.026ms peers=0 req=false err="Genesis block mismatch - d39d4123fc97324e (!= d4e56740f876aef8)"
DEBUG[07-27|11:31:33.423] Adding p2p peer                          name=Geth/v1.8.12-stable/...                                               addr=51.6.79.226:30303     peers=1
DEBUG[07-27|11:31:33.423] Ethereum peer connected                  id=efed57386b2b058f conn=dyndial name=Geth/v1.8.12-stable/darwin-amd64/go1.10.3
DEBUG[07-27|11:31:33.569] Fetching batch of headers                id=efed57386b2b058f conn=dyndial count=1 fromnum=1920000 skip=0 reverse=false
DEBUG[07-27|11:31:34.488] Verified to be on the same side of the DAO fork id=efed57386b2b058f conn=dyndial
DEBUG[07-27|11:31:38.435] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[07-27|11:31:39.055] Peer discarded announcement              peer=efed57386b2b058f number=6038265 hash=783537…6d8618 distance=2233659
DEBUG[07-27|11:31:39.055] Peer discarded announcement              peer=efed57386b2b058f number=6038266 hash=5d7577…a626b5 distance=2233660
DEBUG[07-27|11:31:40.590] Synchronising with the network           peer=efed57386b2b058f eth=63 head=2d8e87…f3f692 td=5615468682269065524418 mode=full
DEBUG[07-27|11:31:40.590] Retrieving remote chain height           peer=efed57386b2b058f
DEBUG[07-27|11:31:40.590] Fetching batch of headers                id=efed57386b2b058f conn=dyndial count=1 fromhash=2d8e87…f3f692 skip=0 reverse=false
DEBUG[07-27|11:31:42.840] Bad discv4 packet                        addr=69.164.215.14:30303   err="bad hash"
DEBUG[07-27|11:31:43.162] Remote head header identified            peer=efed57386b2b058f number=6038264 hash=2d8e87…f3f692
DEBUG[07-27|11:31:43.162] Looking for common ancestor              peer=efed57386b2b058f local=3804606 remote=6038264
DEBUG[07-27|11:31:43.162] Fetching batch of headers                id=efed57386b2b058f conn=dyndial count=13 fromnum=3804414 skip=15 reverse=false
DEBUG[07-27|11:31:44.961] Found common ancestor                    peer=efed57386b2b058f number=3804606 hash=143bf8…1d4ceb
DEBUG[07-27|11:31:44.961] Directing header downloads               peer=efed57386b2b058f origin=3804607
DEBUG[07-27|11:31:44.961] Downloading transaction receipts         origin=3804607
DEBUG[07-27|11:31:44.961] Downloading block bodies                 origin=3804607
DEBUG[07-27|11:31:44.961] Fetching batch of headers                id=efed57386b2b058f conn=dyndial count=128 fromnum=3804798 skip=191 reverse=false
DEBUG[07-27|11:31:45.671] Filling up skeleton                      from=3804607
DEBUG[07-27|11:31:45.771] Fetching batch of headers                id=efed57386b2b058f conn=dyndial count=192 fromnum=3804607 skip=0   reverse=false
DEBUG[07-27|11:31:46.158] Fetching batch of headers                id=efed57386b2b058f conn=dyndial count=192 fromnum=3804799 skip=0   reverse=false
DEBUG[07-27|11:31:46.159] Fetching batch of block bodies           id=efed57386b2b058f conn=dyndial count=2
DEBUG[07-27|11:31:46.541] Fetching batch of headers                id=efed57386b2b058f conn=dyndial count=192 fromnum=3804991 skip=0   reverse=false
DEBUG[07-27|11:31:46.548] Fetching batch of block bodies           id=efed57386b2b058f conn=dyndial count=10
DEBUG[07-27|11:31:46.548] Inserting downloaded chain               items=2 firstnum=3804607 firsthash=9de2a5…5fbd13 lastnum=3804608 lasthash=92a212…1fa95b
DEBUG[07-27|11:31:46.552] Loaded old ethash cache from disk        epoch=126
DEBUG[07-27|11:31:46.561] Loaded old ethash cache from disk        epoch=127
DEBUG[07-27|11:31:46.587] VM returned with error                   err="out of gas"
DEBUG[07-27|11:31:46.591] VM returned with error                   err="invalid opcode 0xfe"
ERROR[07-27|11:31:46.667] 
########## BAD BLOCK #########
Chain config: {ChainID: 1 Homestead: 1150000 DAO: 1920000 DAOSupport: true EIP150: 2463000 EIP155: 2675000 EIP158: 2675000 Byzantium: 4370000 Constantinople: <nil> Engine: ethash}

Number: 3804607
Hash: 0x9de2a5df83774e36b5728cf722cc2296af97e1c1e932b21bb90e18c2e15fbd13
...
...
...

Error: invalid gas used (remote: 1329607 local: 1541792)
##############################
 
DEBUG[07-27|11:31:46.668] Downloaded item processing failed        number=3804607 hash=9de2a5…5fbd13 err="invalid gas used (remote: 1329607 local: 1541792)"
DEBUG[07-27|11:31:46.668] Transaction receipt download terminated  err="receipt download canceled (requested)"
DEBUG[07-27|11:31:46.668] Block body download terminated           err="block body download canceled (requested)"
DEBUG[07-27|11:31:46.668] Skeleton fill terminated                 err="block header download canceled (requested)"
DEBUG[07-27|11:31:46.668] Skeleton chain invalid                   peer=efed57386b2b058f err="block header download canceled (requested)"
DEBUG[07-27|11:31:46.668] Header download terminated               peer=efed57386b2b058f
DEBUG[07-27|11:31:46.668] Synchronisation terminated               elapsed=6.07799511s
WARN [07-27|11:31:46.668] Synchronisation failed, dropping peer    peer=efed57386b2b058f err="retrieved hash chain is invalid"
DEBUG[07-27|11:31:46.668] Removing Ethereum peer                   peer=efed57386b2b058f
DEBUG[07-27|11:31:46.668] Ethereum message handling failed         id=efed57386b2b058f conn=dyndial err=EOF
DEBUG[07-27|11:31:46.668] Removing p2p peer                        id=efed57386b2b058f conn=dyndial duration=13.245s   peers=0 req=false err="useless peer"
@holiman

This comment has been minimized.

Copy link
Contributor

commented Jul 27, 2018

Very interesting.. when you say two attempts, does that mean that you removed the datadir in between attempts? Or just restarted? Because if the latter, I would suspect disk corruption. If the former, well, then that's very very odd. We regularly do full syncs for testing.

@rapidddenis

This comment has been minimized.

Copy link
Author

commented Jul 27, 2018

"sudo geth --datadir /media/nuc/970_EVO_500GB/ethereum_full removedb" between, starting the third
(edit: --datadir)

@rapidddenis

This comment has been minimized.

Copy link
Author

commented Jul 29, 2018

the 3rd, 4th attempts failed on some random blocks (before block 3804607) due to db corruption
the 5th attempt failed due to:

########## BAD BLOCK #########
Chain config: {ChainID: 1 Homestead: 1150000 DAO: 1920000 DAOSupport: true EIP150: 2463000 EIP155: 2675000 EIP158: 2675000 Byzantium: 4370000 Constantinople: <nil> Engine: ethash}

Number: 3804607
Hash: 0x9de2a5df83774e36b5728cf722cc2296af97e1c1e932b21bb90e18c2e15fbd13
...
...
...

Error: invalid gas used (remote: 1329607 local: 1269910)
##############################
@henter

This comment has been minimized.

Copy link

commented Jul 30, 2018

same issue

@PhilThurston

This comment has been minimized.

Copy link

commented Aug 12, 2018

same issue here: 1.8.13-stable-225171a4

@Senshii

This comment has been minimized.

Copy link

commented Aug 20, 2018

Same issue here: Geth/v1.8.13-stable/linux-amd64/go1.10.3 at block 4181244.

Error: invalid gas used (remote: 5765361 local: 5765310)
##############################
 
WARN [08-17|19:31:08.350] Synchronisation failed, dropping peer    peer=19ee8970b1e85eda err="retrieved hash chain is invalid"
ERROR[08-17|19:31:10.052] 
########## BAD BLOCK #########
Chain config: {ChainID: 1 Homestead: 1150000 DAO: 1920000 DAOSupport: true EIP150: 2463000 EIP155: 2675000 EIP158: 2675000 Byzantium: 4370000 Constantinople: <nil> Engine: ethash}
Number: 4181245
Hash: 0x6f983c419d5d439a737bf99ad996d11710eee861e72143c21cf607239666e51b
@ohbriansung

This comment has been minimized.

Copy link

commented Sep 6, 2018

Same issue here: 1.8.14-stable

@vrigber

This comment has been minimized.

Copy link

commented Oct 12, 2018

Same issue.
And problem in 4181245 block too!

Error: invalid gas used (remote: 5765361 local: 5765310)
##############################
 
WARN [10-12|03:15:17.538] Synchronisation failed, dropping peer    peer=e5162f7ac06f80b3 err="retrieved hash chain is invalid"
ERROR[10-12|03:15:44.378] 
########## BAD BLOCK #########
Chain config: {ChainID: 1 Homestead: 1150000 DAO: 1920000 DAOSupport: true EIP150: 2463000 EIP155: 2675000 EIP158: 2675000 Byzantium: 4370000 Constantinople: <nil> Engine: ethash}

Number: 4181245
Hash: 0x6f983c419d5d439a737bf99ad996d11710eee861e72143c21cf607239666e51b
@usmananwar

This comment has been minimized.

Copy link

commented Oct 23, 2018

Having same issue in 1.8.16 for 3804607 block. Any solution for this, yet??

@jlopp

This comment has been minimized.

Copy link

commented Oct 30, 2018

Confirmed same issue on
Geth version: 1.8.17-stable-8bbe7207
OS & Version: PureOS 8.0

Was running sync with "geth --syncmode "full" --cache 24000

Stalls on the same error every time I restart geth

@roconnor-blockstream

This comment has been minimized.

Copy link

commented Oct 30, 2018

FWIW, tx 0x5ec195b89aa8f2385de7d1b5ffd9d7e9f0c96a8f26837886d9d0897402c9c7dc seems to be the problematic one.

@PhilThurston

This comment has been minimized.

Copy link

commented Oct 31, 2018

Same issue here as well

VERSION:
   1.8.17-stable-8bbe7207
Number: 4181245
Hash: 0x6f983c419d5d439a737bf99ad996d11710eee861e72143c21cf607239666e51b
@ymonye

This comment has been minimized.

Copy link

commented Oct 31, 2018

I'm able to sync past block 3804607 without issue.
geth --syncmode=full --gcmode=archive --cache=43581

Geth 1.8.17-stable-8bbe7207
Windows 10 Pro 64-Bit
i9-7980XE
128GB DDR4 SDRAM
Intel DC P4600 4TB PCIe NVMe SSD

image

@furqansiddiqui

This comment has been minimized.

Copy link

commented Nov 1, 2018

Facing same issue on ubuntu 16. How can we overcome this?

@rockstardev

This comment has been minimized.

Copy link

commented Nov 12, 2018

128GB DDR4 SDRAM
Intel DC P4600 4TB PCIe NVMe SSD

Power overwhelming.

@mikeyb

This comment has been minimized.

Copy link

commented Dec 2, 2018

Looks like you are getting block data from a peer with an invalid chain.
the tx does not exist on main chain
same with @vrigber
and @PhilThurston

@holiman

This comment has been minimized.

Copy link
Contributor

commented Dec 3, 2018

This was fixed by #18165 . The blocks reported here are all in the range where a certain exchange created >65K contract instances within a short time span. If you ran geth with large cache allowance, the ref counter would overflow and suddenly the code for that contract would be pruned by the in-memory pruner.

@holiman holiman closed this Dec 3, 2018

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Projects
None yet
You can’t perform that action at this time.