Skip to content
This repository has been archived by the owner on Nov 6, 2020. It is now read-only.

Private Blockchain Stops Syncing after upgrade to 2.4.x #10617

Closed
stone212 opened this issue Apr 29, 2019 · 15 comments
Closed

Private Blockchain Stops Syncing after upgrade to 2.4.x #10617

stone212 opened this issue Apr 29, 2019 · 15 comments
Labels
A3-stale 🍃 Pull request did not receive any updates in a long time. No review needed at this stage. Close it. F2-bug 🐞 The client fails to follow expected behavior. M4-core ⛓ Core client code / Rust. Z0-unconfirmed 🤔 Issue might be valid, but it’s not yet known. Z1-question 🙋‍♀️ Issue is a question. Closer should answer.

Comments

@stone212
Copy link

stone212 commented Apr 29, 2019

  • Parity Ethereum version: 2.4.5 (tested down to 2.4.)
  • Operating system: Linux
  • Installation: binary
  • Fully synchronized: no (that's the problem)
  • Network: private
  • Restarted: yes

Your issue description goes here below. Try to include actual vs. expected behavior and steps to reproduce the issue.

A private blockchain with 6 nodes that functioned well stops syncing on nodes with no miners after upgrade these nodes to 2.4.5. Tested down to 2.4.0, the same error happens.

One worker uses Parity 2.1.9 (just today got access to it and will test upgrading it - but I would like to know why this is a problem if you think this is the problem).

After downgrading all parity clients to 2.3.8 the problem stops.

Here are things I tried and questions I have that might lead to answers

  1. Removed "eip1283Transition": from the params section to avoid conflicts with Add EIP-1283 disable transition #10214. No change.

  2. Could the problem be that one worker (with the majority of hash) is using Parity 2.1.9? Specifically please tell me what would be the conflict (I am in process of testing this idea today as I just now got access to this worker - it is my best idea).

  3. Could the problem be that some nodes use Parity 2.3.8 and others use 2.4.x?

  4. I did look at the 2.4.0 Changelog (https://github.com/paritytech/parity-ethereum/blob/master/CHANGELOG.md) and I do not see any other problems but if there is a known incompatibility please tell me.

UPDATE: I tried Item 2 (upgraded strong worker to 2.4.5) and now the strong worker does not sync with the rest of the blockchain although all nodes are on 2.4.5 (updating Item 3 also).

@jam10o-new jam10o-new added Z1-question 🙋‍♀️ Issue is a question. Closer should answer. F2-bug 🐞 The client fails to follow expected behavior. Z0-unconfirmed 🤔 Issue might be valid, but it’s not yet known. M4-core ⛓ Core client code / Rust. labels May 2, 2019
@jam10o-new
Copy link
Contributor

Could you share any -l sync=trace logs if possible? Which nodes on your network are actually in sync and what version of parity are your validators running? (also, have you figured this out since making this issue?)

@stone212
Copy link
Author

stone212 commented May 7, 2019

@joshua-mir I will run these tests when I can. We had to downgrade to 2.3.9 to keep the chain running but I can definitely create a test box and run this. I will re-post when I do.

@stone212
Copy link
Author

stone212 commented May 8, 2019

@joshua-mir Okay here is some output. How much do you want?

05-08 03:22:19 UTC main INFO parity_ws  Listening for new connections on 127.0.0.1:8546.
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  == Connected 1: Parity-Ethereum/v2.3.9-stable-0b42826-20190401/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  Sending status to 1, protocol version 3
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  == Connected 3: Parity-Ethereum/v2.3.9-stable-0b42826-20190401/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  Sending status to 3, protocol version 3
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  New peer 3 (protocol: 3, network: 75, difficulty: Some(2851576303879367), latest:0xc88e…7b05, genesis:0x8ee1…30fd, snapshot:Some(1215000), private_tx_enabled:false)
2019-05-08 03:22:20 UTC IO Worker #3 DEBUG sync  Connected 3:Parity-Ethereum/v2.3.9-stable-0b42826-20190401/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 3)
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  == Connected 0: Parity-Ethereum/v2.3.9-stable-0b42826-20190401/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  Sending status to 0, protocol version 3
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  New peer 1 (protocol: 3, network: 75, difficulty: Some(2851576303879367), latest:0xc88e…7b05, genesis:0x8ee1…30fd, snapshot:Some(1215000), private_tx_enabled:false)
2019-05-08 03:22:20 UTC IO Worker #3 DEBUG sync  Connected 1:Parity-Ethereum/v2.3.9-stable-0b42826-20190401/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 1)
2019-05-08 03:22:20 UTC IO Worker #1 TRACE sync  == Connected 2: Parity-Ethereum/v2.3.9-stable-0b42826-20190401/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:20 UTC IO Worker #1 TRACE sync  Sending status to 2, protocol version 3
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  New peer 2 (protocol: 3, network: 75, difficulty: Some(2851576303879367), latest:0xc88e…7b05, genesis:0x8ee1…30fd, snapshot:Some(1215000), private_tx_enabled:false)
2019-05-08 03:22:20 UTC IO Worker #3 DEBUG sync  Connected 2:Parity-Ethereum/v2.3.9-stable-0b42826-20190401/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 2)
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  New peer 0 (protocol: 3, network: 75, difficulty: Some(2851576303879367), latest:0xc88e…7b05, genesis:0x8ee1…30fd, snapshot:Some(1215000), private_tx_enabled:false)
2019-05-08 03:22:20 UTC IO Worker #3 DEBUG sync  Connected 0:Parity-Ethereum/v2.3.9-stable-0b42826-20190401/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:20 UTC IO Worker #3 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 0)
2019-05-08 03:22:21 UTC IO Worker #3 TRACE sync  == Connected 48: Parity-Ethereum/v2.3.3-beta-3b9b1a8-20190213/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:21 UTC IO Worker #3 TRACE sync  Sending status to 48, protocol version 3
2019-05-08 03:22:21 UTC IO Worker #2 TRACE sync  New peer 48 (protocol: 3, network: 22025, difficulty: Some(79873459140251122713367531478636656658871709), latest:0x01b8…ce2c, genesis:0x1289…aade, snapshot:Some(230000), private_tx_enabled:false)
2019-05-08 03:22:21 UTC IO Worker #2 TRACE sync  Peer 48 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0x1289…aade)
2019-05-08 03:22:21 UTC IO Worker #2 DEBUG sync  48 -> Invalid packet 0
2019-05-08 03:22:21 UTC IO Worker #2 TRACE sync  Deactivating peer 48
2019-05-08 03:22:21 UTC IO Worker #1 TRACE sync  == Connected 5: Parity-Ethereum/v2.3.0-unstable-UNKNOWN-UNKNOWN/x86_64-linux-musl/rustc1.31.1
2019-05-08 03:22:21 UTC IO Worker #1 TRACE sync  Sending status to 5, protocol version 3
2019-05-08 03:22:21 UTC IO Worker #1 TRACE sync  New peer 5 (protocol: 3, network: 43568, difficulty: Some(326083908670674), latest:0xcda7…c028, genesis:0x9a2a…e7e4, snapshot:Some(600000), private_tx_enabled:false)
2019-05-08 03:22:21 UTC IO Worker #1 TRACE sync  Peer 5 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0x9a2a…e7e4)
2019-05-08 03:22:21 UTC IO Worker #1 DEBUG sync  5 -> Invalid packet 0
2019-05-08 03:22:21 UTC IO Worker #1 TRACE sync  Deactivating peer 5
2019-05-08 03:22:21 UTC IO Worker #3 TRACE sync  Syncing with peers: 4 active, 4 available, 4 total
2019-05-08 03:22:21 UTC IO Worker #3 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 2)
2019-05-08 03:22:21 UTC IO Worker #3 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 1)
2019-05-08 03:22:21 UTC IO Worker #3 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 0)
2019-05-08 03:22:21 UTC IO Worker #3 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 3)
2019-05-08 03:22:22 UTC IO Worker #3 TRACE sync  == Connected 43: Parity-Ethereum/v2.2.10-stable-7b1d3e1-20190213/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:22 UTC IO Worker #3 TRACE sync  Sending status to 43, protocol version 3
2019-05-08 03:22:22 UTC IO Worker #1 TRACE sync  New peer 43 (protocol: 3, network: 1, difficulty: Some(630759736715804303142), latest:0x2d07…2def, genesis:0xd4e5…8fa3, snapshot:Some(6830000), private_tx_enabled:false)
2019-05-08 03:22:22 UTC IO Worker #1 TRACE sync  Peer 43 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0xd4e5…8fa3)
2019-05-08 03:22:22 UTC IO Worker #1 DEBUG sync  43 -> Invalid packet 0
2019-05-08 03:22:22 UTC IO Worker #1 TRACE sync  Deactivating peer 43
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  == Connected 57: Parity-Ethereum/v2.2.9-stable-5d5b372-20190203/x86_64-linux-gnu/rustc1.31.1
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  Sending status to 57, protocol version 3
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  == Connected 60: Parity-Ethereum/v2.4.5-stable-76d4064-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  Sending status to 60, protocol version 3
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  == Connected 54: Parity-Ethereum/v2.2.9-stable-5d5b372-20190203/x86_64-linux-gnu/rustc1.31.1
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  Sending status to 54, protocol version 3
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  New peer 57 (protocol: 3, network: 16718, difficulty: Some(125144965517779696830998352625966531279056364), latest:0xb4b5…8a4c, genesis:0xc531…f4cb, snapshot:Some(365000), private_tx_enabled:false)
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  Status packet from expired session 57:Parity-Ethereum/v2.2.9-stable-5d5b372-20190203/x86_64-linux-gnu/rustc1.31.1
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  Skipping deactivated peer 57
2019-05-08 03:22:23 UTC IO Worker #3 TRACE sync  New peer 60 (protocol: 3, network: 32768, difficulty: Some(535211759682130378504514897800626904002693783), latest:0x0253…57fc, genesis:0xb289…61fd, snapshot:Some(1570000), private_tx_enabled:false)
2019-05-08 03:22:23 UTC IO Worker #3 TRACE sync  Peer 60 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0xb289…61fd)
2019-05-08 03:22:23 UTC IO Worker #3 DEBUG sync  60 -> Invalid packet 0
2019-05-08 03:22:23 UTC IO Worker #3 TRACE sync  Deactivating peer 60
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  New peer 54 (protocol: 3, network: 30737, difficulty: Some(126582318235653740900667646967758320204242284), latest:0x3dd2…446a, genesis:0xd9d6…970b, snapshot:Some(370000), private_tx_enabled:false)
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  Status packet from expired session 54:Parity-Ethereum/v2.2.9-stable-5d5b372-20190203/x86_64-linux-gnu/rustc1.31.1
2019-05-08 03:22:23 UTC IO Worker #1 TRACE sync  Skipping deactivated peer 54
2019-05-08 03:22:24 UTC IO Worker #2 TRACE sync  Syncing with peers: 4 active, 4 available, 4 total
2019-05-08 03:22:24 UTC IO Worker #2 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 0)
2019-05-08 03:22:24 UTC IO Worker #2 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 1)
2019-05-08 03:22:24 UTC IO Worker #2 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 3)
2019-05-08 03:22:24 UTC IO Worker #2 TRACE sync  Checking snapshot sync: 1215000 vs 1217282 (peer: 2)
2019-05-08 03:22:24 UTC IO Worker #0 INFO network  Public node URL: <enode>
2019-05-08 03:22:24 UTC IO Worker #2 TRACE sync  == Connected 68: Parity-Ethereum/v2.4.5-stable-76d4064-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:24 UTC IO Worker #2 TRACE sync  Sending status to 68, protocol version 3
2019-05-08 03:22:24 UTC IO Worker #1 TRACE sync  == Connected 70: Parity-Ethereum/v2.5.0-nightly-e71598d-20190227/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:24 UTC IO Worker #1 TRACE sync  Sending status to 70, protocol version 3
2019-05-08 03:22:24 UTC IO Worker #0 TRACE sync  == Connected 76: Parity/v1.9.6-unstable-651cb3979-20180410/x86_64-linux-gnu/rustc1.25.0
2019-05-08 03:22:24 UTC IO Worker #0 TRACE sync  Sending status to 76, protocol version 2
2019-05-08 03:22:24 UTC IO Worker #1 TRACE sync  New peer 70 (protocol: 3, network: 42, difficulty: Some(3661430441574858685281251118349855044000279576), latest:0x9891…3dbc, genesis:0xa3c5…2cb9, snapshot:Some(9645000), private_tx_enabled:false)
2019-05-08 03:22:24 UTC IO Worker #1 TRACE sync  Peer 70 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0xa3c5…2cb9)
2019-05-08 03:22:24 UTC IO Worker #1 DEBUG sync  70 -> Invalid packet 0
2019-05-08 03:22:24 UTC IO Worker #1 TRACE sync  Deactivating peer 70
2019-05-08 03:22:24 UTC IO Worker #1 TRACE sync  == Connected 49: Parity/v1.8.11-stable-21522ff-20180227/x86_64-linux-gnu/rustc1.24.0
2019-05-08 03:22:24 UTC IO Worker #1 TRACE sync  Sending status to 49, protocol version 2
2019-05-08 03:22:25 UTC IO Worker #2 TRACE sync  == Connected 23: Parity-Ethereum/v2.5.0-beta-b52ac20-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:25 UTC IO Worker #2 TRACE sync  Sending status to 23, protocol version 3
2019-05-08 03:22:25 UTC IO Worker #3 TRACE sync  New peer 23 (protocol: 3, network: 28883, difficulty: Some(164179436392014389851808980593679526351482323), latest:0xbee9…cc55, genesis:0x59e4…e051, snapshot:Some(480000), private_tx_enabled:false)
2019-05-08 03:22:25 UTC IO Worker #3 TRACE sync  Peer 23 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0x59e4…e051)
2019-05-08 03:22:25 UTC IO Worker #3 DEBUG sync  23 -> Invalid packet 0
2019-05-08 03:22:25 UTC IO Worker #3 TRACE sync  Deactivating peer 23
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  No snapshots found, starting full sync
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  Syncing with peers: 4 active, 4 available, 4 total
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  Considering peer 0, force=false, td=Some(2851576303879367), our td=2851576301781831, latest=0xc88e…7b05, have_latest=false, state=Idle
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  Syncing with peer 0, force=false, td=Some(2851576303879367), our td=2851576301781831, state=Idle
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  NewBlocks: Starting round (last imported count = None, last started = 1217282, block = 1217282
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  NewBlocks: Starting sync with better chain
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  0 <- GetBlockHeaders: 256 entries starting from 0x19dc…6896, set = NewBlocks
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  Considering peer 2, force=false, td=Some(2851576303879367), our td=2851576301781831, latest=0xc88e…7b05, have_latest=false, state=Blocks
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  Syncing with peer 2, force=false, td=Some(2851576303879367), our td=2851576301781831, state=Blocks
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  NewBlocks: Starting sync with better chain
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  2 <- GetBlockHeaders: 256 entries starting from 0x19dc…6896, set = NewBlocks
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  Considering peer 3, force=false, td=Some(2851576303879367), our td=2851576301781831, latest=0xc88e…7b05, have_latest=false, state=Blocks
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  Syncing with peer 3, force=false, td=Some(2851576303879367), our td=2851576301781831, state=Blocks
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  NewBlocks: Starting sync with better chain
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  3 <- GetBlockHeaders: 256 entries starting from 0x19dc…6896, set = NewBlocks
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  Considering peer 1, force=false, td=Some(2851576303879367), our td=2851576301781831, latest=0xc88e…7b05, have_latest=false, state=Blocks
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  Syncing with peer 1, force=false, td=Some(2851576303879367), our td=2851576301781831, state=Blocks
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  NewBlocks: Starting sync with better chain
2019-05-08 03:22:26 UTC IO Worker #0 TRACE sync  1 <- GetBlockHeaders: 256 entries starting from 0x19dc…6896, set = NewBlocks
2019-05-08 03:22:26 UTC IO Worker #3 TRACE sync  == Connected 59: Parity-Ethereum/v2.3.4-beta-0e95db1-20190220/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:26 UTC IO Worker #3 TRACE sync  Sending status to 59, protocol version 3
2019-05-08 03:22:26 UTC IO Worker #1 TRACE sync  == Connected 60: Parity-Ethereum/v2.2.9-stable-5d5b372-20190203/x86_64-linux-gnu/rustc1.31.1
2019-05-08 03:22:26 UTC IO Worker #1 TRACE sync  Sending status to 60, protocol version 3
2019-05-08 03:22:26 UTC IO Worker #3 TRACE sync  New peer 60 (protocol: 3, network: 16718, difficulty: Some(125145305800146617769461816000573963047267818), latest:0x1872…00dc, genesis:0xc531…f4cb, snapshot:Some(365000), private_tx_enabled:false)
2019-05-08 03:22:26 UTC IO Worker #3 TRACE sync  Status packet from expired session 60:Parity-Ethereum/v2.2.9-stable-5d5b372-20190203/x86_64-linux-gnu/rustc1.31.1
2019-05-08 03:22:26 UTC IO Worker #3 TRACE sync  Skipping deactivated peer 60
2019-05-08 03:22:28 UTC IO Worker #2 TRACE sync  == Connected 7: Parity-Ethereum/v2.2.7-stable-b00a21f-20190115/x86_64-linux-gnu/rustc1.31.1
2019-05-08 03:22:28 UTC IO Worker #2 TRACE sync  Sending status to 7, protocol version 3
2019-05-08 03:22:28 UTC IO Worker #0 TRACE sync  New peer 7 (protocol: 3, network: 3, difficulty: Some(18208724345930090), latest:0xc3fa…68e9, genesis:0x4194…4a2d, snapshot:Some(5030000), private_tx_enabled:false)
2019-05-08 03:22:28 UTC IO Worker #0 TRACE sync  Peer 7 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0x4194…4a2d)
2019-05-08 03:22:28 UTC IO Worker #0 DEBUG sync  7 -> Invalid packet 0
2019-05-08 03:22:28 UTC IO Worker #0 TRACE sync  Deactivating peer 7
2019-05-08 03:22:28 UTC IO Worker #3 TRACE sync  == Connected 50: Parity-Ethereum/v2.5.0-beta-b52ac20-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:28 UTC IO Worker #3 TRACE sync  Sending status to 50, protocol version 3
2019-05-08 03:22:28 UTC IO Worker #0 TRACE sync  New peer 50 (protocol: 3, network: 4, difficulty: Some(7948872), latest:0x3fb3…c3d0, genesis:0x6341…e177, snapshot:Some(0), private_tx_enabled:false)
2019-05-08 03:22:28 UTC IO Worker #0 TRACE sync  Status packet from expired session 50:Parity-Ethereum/v2.5.0-beta-b52ac20-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:28 UTC IO Worker #0 TRACE sync  Skipping deactivated peer 50
2019-05-08 03:22:28 UTC IO Worker #1 TRACE sync  == Connected 60: Parity-Ethereum/v2.5.0-beta-b52ac20-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:28 UTC IO Worker #1 TRACE sync  Sending status to 60, protocol version 3
2019-05-08 03:22:28 UTC IO Worker #3 TRACE sync  New peer 60 (protocol: 3, network: 100, difficulty: Some(1202929813325641115620131331109791781625764238), latest:0xd329…7e76, genesis:0x4f1d…9756, snapshot:Some(3530000), private_tx_enabled:false)
2019-05-08 03:22:28 UTC IO Worker #3 TRACE sync  Peer 60 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0x4f1d…9756)
2019-05-08 03:22:28 UTC IO Worker #3 DEBUG sync  60 -> Invalid packet 0
2019-05-08 03:22:28 UTC IO Worker #3 TRACE sync  Deactivating peer 60
2019-05-08 03:22:29 UTC IO Worker #2 INFO import  Syncing #1217282 0x19dc…6896     0.00 blk/s    0.0 tx/s    0.0 Mgas/s      0+    0 Qed  #1217282    4/25 peers   83 KiB chain 3 MiB db 0 bytes queue 15 KiB sync  RPC:  0 conn,    0 req/s,    0 µs
2019-05-08 03:22:29 UTC IO Worker #1 TRACE sync  == Connected 33: Parity-Ethereum/v2.2.9-stable-5d5b372-20190203/x86_64-linux-gnu/rustc1.31.1
2019-05-08 03:22:29 UTC IO Worker #1 TRACE sync  Sending status to 33, protocol version 3
2019-05-08 03:22:29 UTC IO Worker #3 TRACE sync  == Connected 5: Parity-Ethereum/v2.3.3-beta-3b9b1a8-20190213/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:29 UTC IO Worker #3 TRACE sync  Sending status to 5, protocol version 3
2019-05-08 03:22:29 UTC IO Worker #3 TRACE sync  New peer 33 (protocol: 3, network: 22025, difficulty: Some(79873799422618043651830994853244088427083163), latest:0x9d93…0d4c, genesis:0x1289…aade, snapshot:Some(230000), private_tx_enabled:false)
2019-05-08 03:22:29 UTC IO Worker #3 TRACE sync  Peer 33 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0x1289…aade)
2019-05-08 03:22:29 UTC IO Worker #3 DEBUG sync  33 -> Invalid packet 0
2019-05-08 03:22:29 UTC IO Worker #3 TRACE sync  Deactivating peer 33
2019-05-08 03:22:29 UTC IO Worker #0 TRACE sync  == Connected 16: Parity-Ethereum/v2.4.5-stable-76d4064-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:29 UTC IO Worker #0 TRACE sync  Sending status to 16, protocol version 3
2019-05-08 03:22:29 UTC IO Worker #1 TRACE sync  New peer 5 (protocol: 3, network: 22025, difficulty: Some(79873799422618043651830994853244088427083163), latest:0x9d93…0d4c, genesis:0x1289…aade, snapshot:Some(220000), private_tx_enabled:false)
2019-05-08 03:22:29 UTC IO Worker #1 TRACE sync  Peer 5 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0x1289…aade)
2019-05-08 03:22:29 UTC IO Worker #1 DEBUG sync  5 -> Invalid packet 0
2019-05-08 03:22:29 UTC IO Worker #1 TRACE sync  Deactivating peer 5
2019-05-08 03:22:29 UTC IO Worker #0 TRACE sync  New peer 16 (protocol: 3, network: 1, difficulty: Some(10113680645537974664376), latest:0x25da…47ab, genesis:0xd4e5…8fa3, snapshot:Some(6455000), private_tx_enabled:false)
2019-05-08 03:22:29 UTC IO Worker #0 TRACE sync  Status packet from expired session 16:Parity-Ethereum/v2.4.5-stable-76d4064-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:29 UTC IO Worker #0 TRACE sync  Skipping deactivated peer 16
2019-05-08 03:22:29 UTC IO Worker #2 TRACE sync  == Connected 39: Parity-Ethereum/v2.3.4-beta-0e95db1-20190220/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:29 UTC IO Worker #2 TRACE sync  Sending status to 39, protocol version 3
2019-05-08 03:22:30 UTC IO Worker #0 TRACE sync  == Connected 37: Parity-Ethereum/v2.4.5-stable-76d4064-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:30 UTC IO Worker #0 TRACE sync  Sending status to 37, protocol version 3
2019-05-08 03:22:30 UTC IO Worker #1 TRACE sync  New peer 37 (protocol: 3, network: 32768, difficulty: Some(535212099964497299442978361175234335770905237), latest:0x9c16…41e3, genesis:0xb289…61fd, snapshot:Some(1570000), private_tx_enabled:false)
2019-05-08 03:22:30 UTC IO Worker #1 TRACE sync  Peer 37 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0xb289…61fd)
2019-05-08 03:22:30 UTC IO Worker #1 DEBUG sync  37 -> Invalid packet 0
2019-05-08 03:22:30 UTC IO Worker #1 TRACE sync  Deactivating peer 37
2019-05-08 03:22:30 UTC IO Worker #1 TRACE sync  == Connected 55: Parity/v1.10.9-stable-23a9eef-20180707/x86_64-linux-gnu/rustc1.27.0
2019-05-08 03:22:30 UTC IO Worker #1 TRACE sync  Sending status to 55, protocol version 2
2019-05-08 03:22:30 UTC IO Worker #3 TRACE sync  == Connected 76: Parity-Ethereum/v2.5.0-beta-b52ac20-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:30 UTC IO Worker #3 TRACE sync  Sending status to 76, protocol version 3
2019-05-08 03:22:30 UTC IO Worker #3 TRACE sync  New peer 76 (protocol: 3, network: 42, difficulty: Some(3661430781857225606219714581724462475768491027), latest:0x7c5e…f719, genesis:0xa3c5…2cb9, snapshot:Some(10335000), private_tx_enabled:false)
2019-05-08 03:22:30 UTC IO Worker #3 TRACE sync  Peer 76 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0xa3c5…2cb9)
2019-05-08 03:22:30 UTC IO Worker #3 DEBUG sync  76 -> Invalid packet 0
2019-05-08 03:22:30 UTC IO Worker #3 TRACE sync  Deactivating peer 76
2019-05-08 03:22:31 UTC IO Worker #3 DEBUG sync  0 -> Dispatching packet: 7
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  0 -> NewBlock (0x3408…4d59)
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  New block with unknown parent (0xc88e680d66439b7cb9b68f6e6f66a0210beb2ae5be067bf125874db415c87b05) 0x34085faa69f171dcba6fbe09d02869c7567dd3778552a696f5e803f028614d59
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  NewBlock ignored while seeking
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  Skipping busy peer 0
2019-05-08 03:22:31 UTC IO Worker #1 DEBUG sync  0 -> Dispatching packet: 1
2019-05-08 03:22:31 UTC IO Worker #1 TRACE sync  Ignoring new hashes since we're already downloading.
2019-05-08 03:22:31 UTC IO Worker #1 TRACE sync  Skipping busy peer 0
2019-05-08 03:22:31 UTC IO Worker #0 DEBUG sync  2 -> Dispatching packet: 1
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  Ignoring new hashes since we're already downloading.
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  Skipping busy peer 2
2019-05-08 03:22:31 UTC IO Worker #0 DEBUG sync  2 -> Dispatching packet: 7
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  2 -> NewBlock (0x3408…4d59)
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  New block with unknown parent (0xc88e680d66439b7cb9b68f6e6f66a0210beb2ae5be067bf125874db415c87b05) 0x34085faa69f171dcba6fbe09d02869c7567dd3778552a696f5e803f028614d59
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  NewBlock ignored while seeking
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  Skipping busy peer 2
2019-05-08 03:22:31 UTC IO Worker #0 DEBUG sync  2 -> Dispatching packet: 7
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  2 -> NewBlock (0x3408…4d59)
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  New block with unknown parent (0xc88e680d66439b7cb9b68f6e6f66a0210beb2ae5be067bf125874db415c87b05) 0x34085faa69f171dcba6fbe09d02869c7567dd3778552a696f5e803f028614d59
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  NewBlock ignored while seeking
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  Skipping busy peer 2
2019-05-08 03:22:31 UTC IO Worker #0 DEBUG sync  3 -> Dispatching packet: 1
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  Ignoring new hashes since we're already downloading.
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  Skipping busy peer 3
2019-05-08 03:22:31 UTC IO Worker #3 DEBUG sync  3 -> Dispatching packet: 7
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  3 -> NewBlock (0x3408…4d59)
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  New block with unknown parent (0xc88e680d66439b7cb9b68f6e6f66a0210beb2ae5be067bf125874db415c87b05) 0x34085faa69f171dcba6fbe09d02869c7567dd3778552a696f5e803f028614d59
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  NewBlock ignored while seeking
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  Skipping busy peer 3
2019-05-08 03:22:31 UTC IO Worker #3 DEBUG sync  1 -> Dispatching packet: 1
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  Ignoring new hashes since we're already downloading.
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  Skipping busy peer 1
2019-05-08 03:22:31 UTC IO Worker #3 DEBUG sync  1 -> Dispatching packet: 7
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  1 -> NewBlock (0x3408…4d59)
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  New block with unknown parent (0xc88e680d66439b7cb9b68f6e6f66a0210beb2ae5be067bf125874db415c87b05) 0x34085faa69f171dcba6fbe09d02869c7567dd3778552a696f5e803f028614d59
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  NewBlock ignored while seeking
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  Skipping busy peer 1
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  == Connected 76: Parity-Ethereum/v2.3.5-stable-ebd0fd0-20190227/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  Sending status to 76, protocol version 3
2019-05-08 03:22:31 UTC IO Worker #2 TRACE sync  New peer 76 (protocol: 3, network: 1, difficulty: Some(10113680645537974664376), latest:0x25da…47ab, genesis:0xd4e5…8fa3, snapshot:Some(7320000), private_tx_enabled:false)
2019-05-08 03:22:31 UTC IO Worker #2 TRACE sync  Peer 76 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0xd4e5…8fa3)
2019-05-08 03:22:31 UTC IO Worker #2 DEBUG sync  76 -> Invalid packet 0
2019-05-08 03:22:31 UTC IO Worker #2 TRACE sync  Deactivating peer 76
2019-05-08 03:22:31 UTC IO Worker #1 TRACE sync  == Connected 32: Parity-Ethereum/v2.4.5-stable-76d4064-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:31 UTC IO Worker #1 TRACE sync  Sending status to 32, protocol version 3
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  == Connected 50: Parity-Ethereum/v2.4.5-stable-76d4064-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:31 UTC IO Worker #0 TRACE sync  Sending status to 50, protocol version 3
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  == Connected 31: Parity-Ethereum/v2.4.5-stable-76d4064-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  Sending status to 31, protocol version 3
2019-05-08 03:22:31 UTC IO Worker #2 TRACE sync  == Connected 24: Parity-Ethereum/v2.2.6-beta-e9396e158-20190109/x86_64-macos/rustc1.31.1
2019-05-08 03:22:31 UTC IO Worker #2 TRACE sync  Sending status to 24, protocol version 3
2019-05-08 03:22:31 UTC IO Worker #1 TRACE sync  == Connected 61: Parity-Ethereum/v2.4.5-stable-76d4064a4-20190408/x86_64-linux-gnu/rustc1.34.0
2019-05-08 03:22:31 UTC IO Worker #1 TRACE sync  Sending status to 61, protocol version 3
2019-05-08 03:22:31 UTC IO Worker #2 TRACE sync  New peer 31 (protocol: 3, network: 42, difficulty: Some(3661430781857225606219714581724462475768491027), latest:0x7c5e…f719, genesis:0xa3c5…2cb9, snapshot:Some(9430000), private_tx_enabled:false)
2019-05-08 03:22:31 UTC IO Worker #2 TRACE sync  Peer 31 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0xa3c5…2cb9)
2019-05-08 03:22:31 UTC IO Worker #2 DEBUG sync  31 -> Invalid packet 0
2019-05-08 03:22:31 UTC IO Worker #2 TRACE sync  Deactivating peer 31
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  New peer 24 (protocol: 3, network: 1, difficulty: Some(630759736715804303142), latest:0x2d07…2def, genesis:0xd4e5…8fa3, snapshot:Some(7990000), private_tx_enabled:false)
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  Status packet from expired session 24:Parity-Ethereum/v2.2.6-beta-e9396e158-20190109/x86_64-macos/rustc1.31.1
2019-05-08 03:22:31 UTC IO Worker #3 TRACE sync  Skipping deactivated peer 24
2019-05-08 03:22:32 UTC IO Worker #0 TRACE sync  == Connected 31: Parity-Ethereum/v2.3.9-stable-0b42826-20190401/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:32 UTC IO Worker #0 TRACE sync  Sending status to 31, protocol version 3
2019-05-08 03:22:32 UTC IO Worker #0 TRACE sync  New peer 31 (protocol: 3, network: 74, difficulty: Some(1462395436319759), latest:0xd6c7…a6a1, genesis:0x0ca6…e7f9, snapshot:Some(1645000), private_tx_enabled:false)
2019-05-08 03:22:32 UTC IO Worker #0 TRACE sync  Peer 31 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0x0ca6…e7f9)
2019-05-08 03:22:32 UTC IO Worker #0 DEBUG sync  31 -> Invalid packet 0
2019-05-08 03:22:32 UTC IO Worker #0 TRACE sync  Deactivating peer 31
2019-05-08 03:22:32 UTC IO Worker #0 TRACE sync  == Connected 25: Parity-Ethereum/v2.3.3-beta-3b9b1a8-20190213/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:32 UTC IO Worker #0 TRACE sync  Sending status to 25, protocol version 3
2019-05-08 03:22:32 UTC IO Worker #3 TRACE sync  New peer 25 (protocol: 3, network: 22025, difficulty: Some(79874139704984964590294458227851520195294617), latest:0x4101…73f7, genesis:0x1289…aade, snapshot:Some(200000), private_tx_enabled:false)
2019-05-08 03:22:32 UTC IO Worker #3 TRACE sync  Status packet from expired session 25:Parity-Ethereum/v2.3.3-beta-3b9b1a8-20190213/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:32 UTC IO Worker #3 TRACE sync  Skipping deactivated peer 25
2019-05-08 03:22:32 UTC IO Worker #2 TRACE sync  == Connected 53: Parity-Ethereum/classic/v2.4.2-beta-e1c1ecf-20190320/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:32 UTC IO Worker #2 TRACE sync  Sending status to 53, protocol version 3
2019-05-08 03:22:32 UTC IO Worker #1 TRACE sync  == Connected 62: Parity-Ethereum/v2.2.10-stable-7b1d3e1-20190213/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:32 UTC IO Worker #1 TRACE sync  Sending status to 62, protocol version 3
2019-05-08 03:22:33 UTC IO Worker #2 TRACE sync  == Connected 7: Parity-Ethereum/v2.4.5-stable-76d4064-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:33 UTC IO Worker #2 TRACE sync  Sending status to 7, protocol version 3
2019-05-08 03:22:33 UTC IO Worker #2 TRACE sync  New peer 7 (protocol: 3, network: 1, difficulty: Some(10113682564785117917249), latest:0x89b8…375a, genesis:0xd4e5…8fa3, snapshot:Some(7710000), private_tx_enabled:false)
2019-05-08 03:22:33 UTC IO Worker #2 TRACE sync  Peer 7 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0xd4e5…8fa3)
2019-05-08 03:22:33 UTC IO Worker #2 DEBUG sync  7 -> Invalid packet 0
2019-05-08 03:22:33 UTC IO Worker #2 TRACE sync  Deactivating peer 7
2019-05-08 03:22:33 UTC IO Worker #2 TRACE sync  == Connected 31: Parity-Ethereum/v2.2.10-stable-7b1d3e1-20190213/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:33 UTC IO Worker #2 TRACE sync  Sending status to 31, protocol version 3
2019-05-08 03:22:34 UTC IO Worker #1 TRACE sync  New peer 31 (protocol: 3, network: 2, difficulty: Some(558255336752489), latest:0x475d…7679, genesis:0x0cd7…e303, snapshot:Some(4215000), private_tx_enabled:false)
2019-05-08 03:22:34 UTC IO Worker #1 TRACE sync  Peer 31 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0x0cd7…e303)
2019-05-08 03:22:34 UTC IO Worker #1 DEBUG sync  31 -> Invalid packet 0
2019-05-08 03:22:34 UTC IO Worker #1 TRACE sync  Deactivating peer 31
2019-05-08 03:22:34 UTC IO Worker #0 INFO import  Syncing #1217282 0x19dc…6896     0.00 blk/s    0.0 tx/s    0.0 Mgas/s      0+    0 Qed  #1217282    4/25 peers   83 KiB chain 3 MiB db 0 bytes queue 15 KiB sync  RPC:  0 conn,    0 req/s,    0 µs
2019-05-08 03:22:34 UTC IO Worker #3 TRACE sync  == Connected 23: Parity-Ethereum/v2.4.5-unstable-76d4064-20190408/x86_64-linux-gnu/rustc1.31.1
2019-05-08 03:22:34 UTC IO Worker #3 TRACE sync  Sending status to 23, protocol version 3
2019-05-08 03:22:34 UTC IO Worker #3 DEBUG sync  Error sending status request: Error(Expired, State { next_error: None, backtrace: InternalBacktrace { backtrace: None } })
2019-05-08 03:22:34 UTC IO Worker #1 TRACE sync  == Connected 59: Parity-Ethereum/v2.3.5-stable-ebd0fd0-20190227/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:34 UTC IO Worker #1 TRACE sync  Sending status to 59, protocol version 3
2019-05-08 03:22:34 UTC IO Worker #1 DEBUG sync  Error sending status request: Error(Expired, State { next_error: None, backtrace: InternalBacktrace { backtrace: None } })
2019-05-08 03:22:34 UTC IO Worker #3 TRACE sync  == Connected 5: Parity/v1.11.4-beta-cc44ae9cb-20180619/x86_64-linux-gnu/rustc1.26.1
2019-05-08 03:22:34 UTC IO Worker #3 TRACE sync  Sending status to 5, protocol version 3
2019-05-08 03:22:34 UTC IO Worker #2 TRACE sync  == Connected 41: Parity/v1.10.0-beta-0a9d41e-20180320/x86_64-linux-gnu/rustc1.24.1
2019-05-08 03:22:34 UTC IO Worker #2 TRACE sync  Sending status to 41, protocol version 2
2019-05-08 03:22:34 UTC IO Worker #0 TRACE sync  == Connected 7: Parity-Ethereum/v2.5.0-beta-b52ac20-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:34 UTC IO Worker #0 TRACE sync  Sending status to 7, protocol version 3
2019-05-08 03:22:35 UTC IO Worker #1 TRACE sync  New peer 41 (protocol: 2, network: 9449, difficulty: Some(4754669893641168366265500181379408891274331966), latest:0x235a…e065, genesis:0x4c3e…929b, snapshot:Some(0), private_tx_enabled:false)
2019-05-08 03:22:35 UTC IO Worker #1 TRACE sync  Peer 41 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0x4c3e…929b)
2019-05-08 03:22:35 UTC IO Worker #1 DEBUG sync  41 -> Invalid packet 0
2019-05-08 03:22:35 UTC IO Worker #1 TRACE sync  Deactivating peer 41
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  == Connected 25: Parity-Ethereum/v2.3.2-beta-678138f-20190203/x86_64-linux-gnu/rustc1.31.1
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  Sending status to 25, protocol version 3
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  New peer 25 (protocol: 3, network: 8996, difficulty: Some(2139338907278327914747989914942370020232109081), latest:0x4255…62fd, genesis:0x6bdd…a9df, snapshot:Some(6285000), private_tx_enabled:false)
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  Status packet from expired session 25:Parity-Ethereum/v2.3.2-beta-678138f-20190203/x86_64-linux-gnu/rustc1.31.1
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  Skipping deactivated peer 25
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  == Connected 62: Parity-Ethereum/v2.3.4-beta-0e95db1-20190220/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  Sending status to 62, protocol version 3
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  == Connected 33: Parity-Ethereum/v2.3.4-beta-0e95db1-20190220/x86_64-linux-gnu/rustc1.32.0
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  Sending status to 33, protocol version 3
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  New peer 33 (protocol: 3, network: 1, difficulty: Some(10113684480283765147890), latest:0x41b6…41e1, genesis:0xd4e5…8fa3, snapshot:Some(4880000), private_tx_enabled:false)
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  Peer 33 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0xd4e5…8fa3)
2019-05-08 03:22:35 UTC IO Worker #0 DEBUG sync  33 -> Invalid packet 0
2019-05-08 03:22:35 UTC IO Worker #0 TRACE sync  Deactivating peer 33
2019-05-08 03:22:35 UTC IO Worker #1 TRACE sync  == Connected 50: Parity-Ethereum/v2.5.0-beta-b52ac20-20190408/x86_64-linux-gnu/rustc1.33.0
2019-05-08 03:22:35 UTC IO Worker #1 TRACE sync  Sending status to 50, protocol version 3
2019-05-08 03:22:35 UTC IO Worker #2 TRACE sync  New peer 50 (protocol: 3, network: 18883, difficulty: Some(607488755263238470959526054542956767420501216), latest:0x55ad…3191, genesis:0x20f6…7b4c, snapshot:Some(1785000), private_tx_enabled:false)
2019-05-08 03:22:35 UTC IO Worker #2 TRACE sync  Peer 50 genesis hash mismatch (ours: 0x8ee1…30fd, theirs: 0x20f6…7b4c)
2019-05-08 03:22:35 UTC IO Worker #2 DEBUG sync  50 -> Invalid packet 0
2019-05-08 03:22:35 UTC IO Worker #2 TRACE sync  Deactivating peer 50
^C2019-05-08 03:22:35 UTC main INFO parity_ethereum::run  Finishing work, please wait...

This is a Parity 2.4.5 node on a chain with 6 peers of 2.3.9. Interesting fact. I accidentally upgraded the miner on this chain and it continued to mine new blocks but all other nodes were stuck on the same block 1217282 (same block the output above shows this miner is stuck on).

I downgraded that miner. It is on block 1217303 but upgraded node that you see output on is still on 1217282. More output from that node without sync-trace:

2019-05-08 03:29:39 UTC Syncing #1217282 0x19dc…6896     0.00 blk/s    0.0 tx/s    0.0 Mgas/s      0+    0 Qed  #1217282    4/25 peers   83 KiB chain 3 MiB db 0 bytes queue 15 KiB sync  RPC:  0 conn,    0 req/s,    0 µs
2019-05-08 03:29:44 UTC Syncing #1217282 0x19dc…6896     0.00 blk/s    0.0 tx/s    0.0 Mgas/s      0+    0 Qed  #1217282    4/25 peers   83 KiB chain 3 MiB db 0 bytes queue 15 KiB sync  RPC:  0 conn,    0 req/s,    0 µs
2019-05-08 03:29:49 UTC Syncing #1217282 0x19dc…6896     0.00 blk/s    0.0 tx/s    0.0 Mgas/s      0+    0 Qed  #1217282    4/25 peers   83 KiB chain 3 MiB db 0 bytes queue 15 KiB sync  RPC:  0 conn,    0 req/s,    0 µs
2019-05-08 03:29:54 UTC Syncing #1217282 0x19dc…6896     0.00 blk/s    0.0 tx/s    0.0 Mgas/s      0+    0 Qed  #1217282    4/25 peers   83 KiB chain 3 MiB db 0 bytes queue 15 KiB sync  RPC:  0 conn,    0 req/s,    0 µs
2019-05-08 03:29:59 UTC Syncing #1217282 0x19dc…6896     0.00 blk/s    0.0 tx/s    0.0 Mgas/s      0+    0 Qed  #1217282    4/25 peers   83 KiB chain 3 MiB db 0 bytes queue 15 KiB sync  RPC:  0 conn,    0 req/s,    0 µs

@stone212
Copy link
Author

@joshua-mir Did the information I posted help? Can I post anything else?

@jam10o-new
Copy link
Contributor

Yeah, that's definitely helpful, thanks! The only peer that looks like it's one of yours has a genesis block mismatch - we'll need to look at whether we've changed anything about anything in our chainspecs between these versions, to my knowledge we haven't. Can you try resyncing some of these nodes if possible, and perhaps running the validators with a set of reserved peers (each other, and one or two other nodes) and --reserved-only? If you changed your chainspec mid chain (removing eip1283transition, for example) that could be the cause of the problem.

@stone212
Copy link
Author

stone212 commented May 24, 2019

@joshua-mir

he only peer that looks like it's one of yours has a genesis block mismatch

Can you tell me what part of the log shows you that? I am still learning to make sense of the text.

we'll need to look at whether we've changed anything about anything in our chainspecs between these versions, to my knowledge we haven't

What about this: #10214

It was on Parity 2.4.0. My private chain spec contains this line:

"eip1283Transition": "352300",

Could this be a conflict?

Can you try resyncing some of these nodes if possible, and perhaps running the validators with a set of reserved peers (each other, and one or two other nodes) and --reserved-only?

What do you mean by "validataors"? I can run some nodes by deleting all chain data and using only a few --reserved-peers. Should I upgrade these nodes to 2.4.6 first? Or better to run on 2.3.9? I will troubleshoot however you think best.

@jam10o-new
Copy link
Contributor

Can you tell me what part of the log shows you that?

Looking through the logs again I was completely wrong about this - it's clear that peers: 0, 1, 2, 3 are the ones that you are actually looking for - from these short few seconds, I can't tell what might be wrong:

At 03:22:20 you peer with peers 0,1,2, and 3
At 03:22:26 you ask for their block headers and start downloading blocks from peers 0,1,2, and 3
At 03:22:31 they send you a new block message, but you ignore it because you are still syncing older blocks.

All that said, my previous guess as to your problem was probably incorrect.

You claim:

Removed "eip1283Transition": from the params section to avoid conflicts with #10214. No change.

That may possibly be the source of your issue,

#10214 is a new transition that would allow you to disable 1283 on your chain, it would be eip1283DisableTransition. Unless you used it to disable 1283 from your chain, new nodes syncing your chain will probably have issues once they reach the block that the transition was previously expected. If you just removed eip1283transition from your chainspec, that might be the cause of your problem.

What do you mean by "validators"?

I was under the impression you were running a private network using the Aura engine?

Miners. Whichever nodes have engine_signer configured and are in your validatorSet - the nodes creating the blocks that are going through your network - the pattern I am describing here is creating "sentry nodes" that insulate these nodes that are creating blocks from the rest of the network so block production is more reliable and less time is spent ignoring requests from other nodes. It's possible that this will end up solving your problem.

Should I upgrade these nodes to 2.4.6 first?

It would be useful to be on the latest stable branch, in case we find an issue. It would be more useful if you had sync logs from a moment the problem was actually occurring, but I understand running verbose logs for so long might be an issue - you might want to run -l sync=debug if you want logs from a longer time period, and share your logs from around when your node stops syncing.

@stone212
Copy link
Author

@joshua-mir

I was under the impression you were running a private network using the Aura engine?

No. I don't know what Aura engine is?

Removed "eip1283Transition": from the params section to avoid conflicts with #10214. No change.
That may possibly be the source of your issue,

Yes. I confused a release note about eip1283DisableTransition to mean I had to disable eip1283Transition for compatibility. The upgrade works now that I re-entered eip1283Transition.

@stone212
Copy link
Author

stone212 commented Aug 29, 2019

@joshua-mir

I am re-opening this because I was wrong and it is not resolved.

If you changed your chainspec mid chain (removing eip1283transition, for example) that could be the cause of the problem.

EDIT I did not do this, I don't think.

New nodes stop at a block that is higher than the block for eip1283Transition but lower than the current block height of the other nodes.

I have turned off mining (months ago) to prevent a fork.

What information can I provide to de-bug?

@stone212 stone212 reopened this Aug 29, 2019
@stone212
Copy link
Author

@joshua-mir it seems that I did not cause the problem, but that moving workers to Parity 2.4.9 caused a fork in the chain with no errors or changes to the chain spec. What information can I provide to de-bug?

@jam10o-new
Copy link
Contributor

@stone212 do you happen to know about the on-chain activity during the period between the time you disabled eip1283transition in your chainspec and the time you added it back in? The problems caused by a bad hardfork won't happen at the fork number that enabled/disabled an eip, but at the first transaction that behaves differently than expected that is part of the chain.

I'm also assuming that you are using the ethash engine and actually mining with PoW on your private network here, as per this previous conversation, in which case hardforking your entire network (just make sure all of your nodes are on the same version and have the same chainspec and re-enable mining) may actually be the solution here, especially if transactions end up being replayed.

@stone212
Copy link
Author

stone212 commented Sep 29, 2019

@joshua-mir

Thank you for the reply.

do you happen to know about the on-chain activity during the period between the time you disabled eip1283transition in your chainspec and the time you added it back in?

First I want to be clear that this did not happen. The problem was with my reporting because we have two private blockchains and one of them had this in the spec, the other did not and so much time passed between my messages to this thread that I was confused when I replied to you. So actually I do not think at this time that I removed and then re-added anything to the chain spec (but I am not certain of that even because I was pulled away on other things).

But I know the chain spec now has eip1283transition and I think it has had this always since I put it in but not eip1283DisableTransition which it never had. (Then there is another blockchain but that is something I will look at later.)

All nodes are using the same chain spec.

Yes, PoW with ethash.

Transactions? The network has two transaction on it ever and I do not remember when it happened. I can give you some information though. We had no workers for a long time (the reason I did not come back to this thread sooner) and then we got one. I put Parity 2.3.9 on it and it started mining blocks from the top block. Good!

Then I downgraded one node at a time to 2.3.9, and if the node got stuck then I deleted chains and cache and started again. Every time (except for one #11098) this worked and now I have a private blockchain of 2.3.9 nodes that are all syncing very well again.

One of the two transactions ever on this chain (a deployed token) seems to be working correctly. The other I do not know about but have asked a developer to verify and if he is as fast as usual he will reply in 2021.

Then I downloaded Parity 2.4.9 onto one of these nodes and started it. It showed connected peers and then shows that it was syncing block X where block X is the next block in the chain after the upgrade, and it just stays there, stuck. It will not go past this. So basically the original error that casued me to open this Issue is here again.

If I downgrade this same node back to 2.3.9 it syncs again.

Parity 2.4 is the one that implements eip1283DisableTransition and this chain spec does have eip1283Transition specified (at a much lower block than the one it is stuck at). It does not have eip1283DisableTransition but I wonder if there is a default activation? The conversation at #10214 is very unclear to me. I do read "unless otherwise specified, eip-1283 will be present" and he means if eip-1283 was activated I think.

I actually don't understand what EIP1283 de-activation is really for? Maybe that will help me? Anyway it is only a guess that this is causing my Parity 2.4.9 node to stop syncing. Maybe it is something else about 2.4.x?

@stone212
Copy link
Author

stone212 commented Oct 5, 2019

@joshua-mir New issue #11133 answers all other issues I opened about this chain. They were not related to this directly I do not think. Now this issue is the primary one.

I can de-bug any way you want. These are the list of EIP in the chain spec.

		"eip161abcTransition": 0,
		"eip161dTransition": 0,
		"eip211Transition": 0,
		"eip214Transition": 0,
		"eip658Transition": "352300",
		"eip1283Transition": "352300",
		"eip145Transition": "1115000",
		"eip1052Transition": "1115000",
		"eip1014Transition": "1115000",

I do think this is a bug in Parity, or maybe a lack of documentation so there is something I do not see. It is always possible that it is something I read incorrectly too.

@stone212
Copy link
Author

stone212 commented Oct 10, 2019

@joshua-mir I tried this on a new blockchain and the error is the same. So it is not a problem of changing chain spec. I guess it must be that there is some incompatibility with Parity 2.4.x and the chain spec, maybe the list of EIP above. What information can I provide to de-bug?

@stone212
Copy link
Author

@joshua-mir This is still a major Issue that is still open. Private blockchain can not upgrade to Parity 2.4.x. Please request whatever de-bug information you think is helpful so we can resolve it.

@adria0 adria0 added the A3-stale 🍃 Pull request did not receive any updates in a long time. No review needed at this stage. Close it. label Jul 27, 2020
@adria0 adria0 closed this as completed Jul 27, 2020
Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Labels
A3-stale 🍃 Pull request did not receive any updates in a long time. No review needed at this stage. Close it. F2-bug 🐞 The client fails to follow expected behavior. M4-core ⛓ Core client code / Rust. Z0-unconfirmed 🤔 Issue might be valid, but it’s not yet known. Z1-question 🙋‍♀️ Issue is a question. Closer should answer.
Projects
None yet
Development

No branches or pull requests

3 participants