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

ERROR[07-12|19:36:03] not a valid address err="recovery failed" #108

Open
michaelkunzmann-sap opened this issue Jul 12, 2018 · 1 comment

Comments

@michaelkunzmann-sap
Copy link

Using the istanbul tool, I generated the following:

genesis.json

{
    "config": {
        "chainId": 2017,
        "homesteadBlock": 1,
        "eip150Block": 2,
        "eip150Hash": "0x0000000000000000000000000000000000000000000000000000000000000000",
        "eip155Block": 3,
        "eip158Block": 3,
        "istanbul": {
            "epoch": 30000,
            "policy": 0
        },
        "isQuorum": true
    },
    "nonce": "0x0",
    "timestamp": "0x5b47921d",
    "extraData": "0x0000000000000000000000000000000000000000000000000000000000000000f89af85494403a286b2f3e897deae61774270bf932b6101f0894f6e5d9850e5bfdd9df0d971be7f8f12d7845a8db9466feeaaafc27c57b818e95c51865ca004385eebe94f5aefe121fa4f748037787cd56087b5c5c5c78ceb8410000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000c0",
    "gasLimit": "0x47b760",
    "difficulty": "0x1",
    "mixHash": "0x63746963616c2062797a616e74696e65206661756c7420746f6c6572616e6365",
    "coinbase": "0x0000000000000000000000000000000000000000",
    "alloc": {
        "403a286b2f3e897deae61774270bf932b6101f08": {
            "balance": "0x446c3b15f9926687d2c40534fdb564000000000000"
        },
        "66feeaaafc27c57b818e95c51865ca004385eebe": {
            "balance": "0x446c3b15f9926687d2c40534fdb564000000000000"
        },
        "f5aefe121fa4f748037787cd56087b5c5c5c78ce": {
            "balance": "0x446c3b15f9926687d2c40534fdb564000000000000"
        },
        "f6e5d9850e5bfdd9df0d971be7f8f12d7845a8db": {
            "balance": "0x446c3b15f9926687d2c40534fdb564000000000000"
        }
    },
    "number": "0x0",
    "gasUsed": "0x0",
    "parentHash": "0x0000000000000000000000000000000000000000000000000000000000000000"
}

static-nodes.json:

[
	"enode://3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da@0.0.0.0:30303?discport=0",
	"enode://d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca@0.0.0.0:30303?discport=0",
	"enode://0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440@0.0.0.0:30303?discport=0",
	"enode://8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233@0.0.0.0:30303?discport=0"
]

Node keys:

0: 22e31c03cd1aff9eb1534518c13ef410e2b0992b2a4f4bf55d369b04ef09c19b
1: 55ab6d8d42616402875fab0e2e2b55fab344f4eb3ef216202ce06ee4615456b1
2: 73f9851f3f2ee28ff8d07a634c2ae9dd0e1f3baf2bfbc276b03f1f4499f4cff8
3: 26003844a57dfd0e97e08407a49a1d964c424f83b694f9aeb11766d7f0697785

I'm starting quorum-geth using:

geth --datadir /qdata/dd --port 30303 --identity tblrc --mine --minerthreads 1 --istanbul.requesttimeout 10000 --istanbul.blockperiod 1 --emitcheckpoints --rpc --rpcport 8545 --rpcaddr 0.0.0.0 --rpcapi admin,db,eth,debug,miner,net,shh,txpool,personal,web3,quorum --networkid 2017 --permissioned --nodiscover --verbosity 5 --unlock 0 --password /k8s/secrets/accountPassword

However, istanbul (in Quorum) is crashing:

TRACE[07-12|19:34:45] Started watching keystore folder         path=/qdata/dd/keystore
DEBUG[07-12|19:34:45] FS scan times                            list=498.056µs set=6.386µs diff=6.673µs
TRACE[07-12|19:34:45] Handled keystore changes                 time=116.458µs
DEBUG[07-12|19:34:45] FS scan times                            list=55.512µs  set=5.333µs diff=47.191µs
TRACE[07-12|19:34:45] Handled keystore changes                 time=2.695µs
INFO [07-12|19:34:45] Starting peer-to-peer node               instance=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2
INFO [07-12|19:34:45] Allocated cache and file handles         database=/qdata/dd/geth/chaindata cache=128 handles=1024
INFO [07-12|19:34:45] Initialised chain configuration          config="{ChainID: 2017 Homestead: 1 DAO: <nil> DAOSupport: false EIP150: 2 EIP155: 3 EIP158: 3 Byzantium: <nil> IsQuorum: true Engine: istanbul}"
INFO [07-12|19:34:45] Initialising Ethereum protocol           versions="[63 62]" network=2017
INFO [07-12|19:34:45] Loaded most recent local header          number=0 hash=39ee97…249d9b td=1
INFO [07-12|19:34:45] Loaded most recent local full block      number=0 hash=39ee97…249d9b td=1
INFO [07-12|19:34:45] Loaded most recent local fast block      number=0 hash=39ee97…249d9b td=1
DEBUG[07-12|19:34:45] Reinjecting stale transactions           count=0
INFO [07-12|19:34:45] Loaded local transaction journal         transactions=0 dropped=0
INFO [07-12|19:34:45] Regenerated local transaction journal    transactions=0 accounts=0
DEBUG[07-12|19:34:45] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
TRACE[07-12|19:34:45] Loaded voting snapshot form disk         number=0 hash=39ee97…249d9b
INFO [07-12|19:34:45] Starting P2P networking 
DEBUG[07-12|19:34:45] InProc registered *node.PrivateAdminAPI under 'admin' 
DEBUG[07-12|19:34:45] InProc registered *node.PublicAdminAPI under 'admin' 
DEBUG[07-12|19:34:45] InProc registered *debug.HandlerT under 'debug' 
DEBUG[07-12|19:34:45] InProc registered *node.PublicDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] InProc registered *node.PublicWeb3API under 'web3' 
DEBUG[07-12|19:34:45] InProc registered *ethapi.PublicEthereumAPI under 'eth' 
DEBUG[07-12|19:34:45] InProc registered *ethapi.PublicBlockChainAPI under 'eth' 
DEBUG[07-12|19:34:45] InProc registered *ethapi.PublicTransactionPoolAPI under 'eth' 
DEBUG[07-12|19:34:45] InProc registered *ethapi.PublicTxPoolAPI under 'txpool' 
DEBUG[07-12|19:34:45] InProc registered *ethapi.PublicDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] InProc registered *ethapi.PrivateDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] InProc registered *ethapi.PublicAccountAPI under 'eth' 
DEBUG[07-12|19:34:45] InProc registered *ethapi.PrivateAccountAPI under 'personal' 
DEBUG[07-12|19:34:45] InProc registered *backend.API under 'istanbul' 
DEBUG[07-12|19:34:45] InProc registered *eth.PublicEthereumAPI under 'eth' 
DEBUG[07-12|19:34:45] InProc registered *eth.PublicMinerAPI under 'eth' 
DEBUG[07-12|19:34:45] InProc registered *downloader.PublicDownloaderAPI under 'eth' 
DEBUG[07-12|19:34:45] InProc registered *eth.PrivateMinerAPI under 'miner' 
INFO [07-12|19:34:45] RLPx listener up                         self="enode://3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da@[::]:30303?discport=0"
DEBUG[07-12|19:34:45] InProc registered *filters.PublicFilterAPI under 'eth' 
DEBUG[07-12|19:34:45] InProc registered *eth.PrivateAdminAPI under 'admin' 
DEBUG[07-12|19:34:45] InProc registered *eth.PublicDebugAPI under 'debug' 
TRACE[07-12|19:34:45] New dial task                            task="staticdial 3c1d6e1cbff5a9e5 100.68.165.149:30303"
TRACE[07-12|19:34:45] New dial task                            task="staticdial d25bf65162bfde47 100.67.134.175:30303"
TRACE[07-12|19:34:45] New dial task                            task="staticdial 0ea9aeb4becdce9b 100.64.19.101:30303"
TRACE[07-12|19:34:45] New dial task                            task="staticdial 8dd0af45bdbe0a3f 100.65.148.159:30303"
DEBUG[07-12|19:34:45] InProc registered *eth.PrivateDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] InProc registered *ethapi.PublicNetAPI under 'net' 
DEBUG[07-12|19:34:45] IPC registered *node.PrivateAdminAPI under 'admin' 
DEBUG[07-12|19:34:45] IPC registered *node.PublicAdminAPI under 'admin' 
DEBUG[07-12|19:34:45] IPC registered *debug.HandlerT under 'debug' 
DEBUG[07-12|19:34:45] IPC registered *node.PublicDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] IPC registered *node.PublicWeb3API under 'web3' 
DEBUG[07-12|19:34:45] IPC registered *ethapi.PublicEthereumAPI under 'eth' 
DEBUG[07-12|19:34:45] IPC registered *ethapi.PublicBlockChainAPI under 'eth' 
DEBUG[07-12|19:34:45] Executing EVM call finished              runtime=423.363µs
DEBUG[07-12|19:34:45] Release oracle not found                 contract=0xFA7B9770Ca4cb04296Cac84F37736d4041251CDF
DEBUG[07-12|19:34:45] IPC registered *ethapi.PublicTransactionPoolAPI under 'eth' 
DEBUG[07-12|19:34:45] IPC registered *ethapi.PublicTxPoolAPI under 'txpool' 
DEBUG[07-12|19:34:45] IPC registered *ethapi.PublicDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] IPC registered *ethapi.PrivateDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] IPC registered *ethapi.PublicAccountAPI under 'eth' 
DEBUG[07-12|19:34:45] IPC registered *ethapi.PrivateAccountAPI under 'personal' 
DEBUG[07-12|19:34:45] IPC registered *backend.API under 'istanbul' 
DEBUG[07-12|19:34:45] IPC registered *eth.PublicEthereumAPI under 'eth' 
DEBUG[07-12|19:34:45] IPC registered *eth.PublicMinerAPI under 'eth' 
DEBUG[07-12|19:34:45] IPC registered *downloader.PublicDownloaderAPI under 'eth' 
DEBUG[07-12|19:34:45] IPC registered *eth.PrivateMinerAPI under 'miner' 
DEBUG[07-12|19:34:45] IPC registered *filters.PublicFilterAPI under 'eth' 
DEBUG[07-12|19:34:45] IPC registered *eth.PrivateAdminAPI under 'admin' 
DEBUG[07-12|19:34:45] IPC registered *eth.PublicDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] IPC registered *eth.PrivateDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] IPC registered *ethapi.PublicNetAPI under 'net' 
DEBUG[07-12|19:34:45] HTTP registered *node.PrivateAdminAPI under 'admin' 
DEBUG[07-12|19:34:45] HTTP registered *node.PublicAdminAPI under 'admin' 
DEBUG[07-12|19:34:45] HTTP registered *debug.HandlerT under 'debug' 
DEBUG[07-12|19:34:45] HTTP registered *node.PublicDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] HTTP registered *node.PublicWeb3API under 'web3' 
INFO [07-12|19:34:45] IPC endpoint opened: /qdata/dd/geth.ipc 
DEBUG[07-12|19:34:45] HTTP registered *ethapi.PublicEthereumAPI under 'eth' 
DEBUG[07-12|19:34:45] HTTP registered *ethapi.PublicBlockChainAPI under 'eth' 
DEBUG[07-12|19:34:45] HTTP registered *ethapi.PublicTransactionPoolAPI under 'eth' 
DEBUG[07-12|19:34:45] HTTP registered *ethapi.PublicTxPoolAPI under 'txpool' 
DEBUG[07-12|19:34:45] HTTP registered *ethapi.PublicDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] HTTP registered *ethapi.PrivateDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] HTTP registered *ethapi.PublicAccountAPI under 'eth' 
DEBUG[07-12|19:34:45] HTTP registered *ethapi.PrivateAccountAPI under 'personal' 
DEBUG[07-12|19:34:45] HTTP registered *eth.PublicEthereumAPI under 'eth' 
DEBUG[07-12|19:34:45] HTTP registered *eth.PublicMinerAPI under 'eth' 
DEBUG[07-12|19:34:45] HTTP registered *downloader.PublicDownloaderAPI under 'eth' 
DEBUG[07-12|19:34:45] HTTP registered *eth.PrivateMinerAPI under 'miner' 
DEBUG[07-12|19:34:45] HTTP registered *filters.PublicFilterAPI under 'eth' 
DEBUG[07-12|19:34:45] HTTP registered *eth.PrivateAdminAPI under 'admin' 
DEBUG[07-12|19:34:45] HTTP registered *eth.PublicDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] HTTP registered *eth.PrivateDebugAPI under 'debug' 
DEBUG[07-12|19:34:45] HTTP registered *ethapi.PublicNetAPI under 'net' 
INFO [07-12|19:34:45] HTTP endpoint opened: http://0.0.0.0:8545 
TRACE[07-12|19:34:45] Quorum permissioning                     EnableNodePermission=true DataDir=/qdata/dd Current Node ID=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da Node Name=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2 Dialed Dest="enode://8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233@100.65.148.159:30303?discport=0" Connection ID=8dd0af45bdbe0a3f Connection String=8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233
TRACE[07-12|19:34:45] Node Permissioning is Enabled. 
TRACE[07-12|19:34:45] Node Permissioning                       Connection Direction=OUTGOING
DEBUG[07-12|19:34:45] parsePermissionedNodes                   DataDir=/qdata/dd file=permissioned-nodes.json
DEBUG[07-12|19:34:45] isNodePermissioned                       permissionedList="[3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca 0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440 8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233]"
DEBUG[07-12|19:34:45] isNodePermissioned                       connection=OUTGOING nodename=8dd0af45bdbe0a3f712a67c12cdfb18e DENIED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
DEBUG[07-12|19:34:45] isNodePermissioned                       connection=OUTGOING nodename=8dd0af45bdbe0a3f712a67c12cdfb18e DENIED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
DEBUG[07-12|19:34:45] isNodePermissioned                       connection=OUTGOING nodename=8dd0af45bdbe0a3f712a67c12cdfb18e DENIED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
DEBUG[07-12|19:34:45] isNodePermissioned                       connection=OUTGOING nodename=8dd0af45bdbe0a3f712a67c12cdfb18e ALLOWED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
DEBUG[07-12|19:34:45] Adding p2p peer                          id=8dd0af45bdbe0a3f name=Geth/hloej/v1.7.2-st... addr=100.65.148.159:30303 peers=1
TRACE[07-12|19:34:45] Dial task done                           task="staticdial 8dd0af45bdbe0a3f 100.65.148.159:30303"
TRACE[07-12|19:34:45] Quorum permissioning                     EnableNodePermission=true DataDir=/qdata/dd Current Node ID=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da Node Name=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2 Dialed Dest="enode://d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca@100.67.134.175:30303?discport=0" Connection ID=d25bf65162bfde47 Connection String=d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca
TRACE[07-12|19:34:45] Node Permissioning is Enabled. 
TRACE[07-12|19:34:45] Node Permissioning                       Connection Direction=OUTGOING
DEBUG[07-12|19:34:45] parsePermissionedNodes                   DataDir=/qdata/dd file=permissioned-nodes.json
DEBUG[07-12|19:34:45] isNodePermissioned                       permissionedList="[3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca 0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440 8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233]"
DEBUG[07-12|19:34:45] isNodePermissioned                       connection=OUTGOING nodename=d25bf65162bfde4753e58e82b1a20e9c DENIED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
DEBUG[07-12|19:34:45] isNodePermissioned                       connection=OUTGOING nodename=d25bf65162bfde4753e58e82b1a20e9c ALLOWED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
DEBUG[07-12|19:34:45] Adding p2p peer                          id=d25bf65162bfde47 name=Geth/rtvhf/v1.7.2-st... addr=100.67.134.175:30303 peers=2
TRACE[07-12|19:34:45] Dial task done                           task="staticdial d25bf65162bfde47 100.67.134.175:30303"
TRACE[07-12|19:34:45] Starting protocol istanbul/64            id=8dd0af45bdbe0a3f conn=staticdial
DEBUG[07-12|19:34:45] Ethereum peer connected                  id=8dd0af45bdbe0a3f conn=staticdial name=Geth/hloej/v1.7.2-stable/linux-amd64/go1.9.2
TRACE[07-12|19:34:45] Starting protocol istanbul/64            id=d25bf65162bfde47 conn=staticdial
DEBUG[07-12|19:34:45] Ethereum peer connected                  id=d25bf65162bfde47 conn=staticdial name=Geth/rtvhf/v1.7.2-stable/linux-amd64/go1.9.2
TRACE[07-12|19:34:45] Registering sync peer                    peer=d25bf65162bfde47
TRACE[07-12|19:34:45] Registering sync peer                    peer=8dd0af45bdbe0a3f
DEBUG[07-12|19:34:45] Relaxed downloader QoS values            rtt=20s confidence=0.500 ttl=1m0s
INFO [07-12|19:34:46] Unlocked account                         address=0x403A286b2F3E897dEAE61774270bf932B6101F08
INFO [07-12|19:34:46] Transaction pool price threshold updated price=18000000000
INFO [07-12|19:34:46] Starting mining operation 
TRACE[07-12|19:34:46] Start to the initial round               address=0x403A286b2F3E897dEAE61774270bf932B6101F08 old_round=-1 old_seq=0
DEBUG[07-12|19:34:46] New round                                address=0x403A286b2F3E897dEAE61774270bf932B6101F08 old_round=-1 old_seq=0 old_proposer=0x403A286b2F3E897dEAE61774270bf932B6101F08 new_round=0 new_seq=1 new_proposer=0x403A286b2F3E897dEAE61774270bf932B6101F08 valSet="[0x403A286b2F3E897dEAE61774270bf932B6101F08 0x66fEEaaAFc27c57B818e95c51865ca004385eEBe 0xf5aEFE121fA4F748037787cD56087b5c5c5C78Ce 0xf6e5d9850E5BfDd9df0D971BE7f8f12D7845A8db]" size=4 isProposer=true
INFO [07-12|19:34:46] Commit new mining work                   number=1 txs=0 uncles=0 elapsed=128.975µs
TRACE[07-12|19:34:46] handleRequest                            address=0x403A286b2F3E897dEAE61774270bf932B6101F08 state="Accept request" seq=1 number=1 hash=04eacd…e3dfe3
DEBUG[07-12|19:34:47] Couldn't add port mapping                proto=tcp extport=30303 intport=30303 interface="UPnP or NAT-PMP" err="no UPnP or NAT-PMP router discovered"
TRACE[07-12|19:34:53] Accepted connection                      addr=100.96.0.77:46378
TRACE[07-12|19:34:53] Quorum permissioning                     EnableNodePermission=true DataDir=/qdata/dd Current Node ID=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da Node Name=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2 Dialed Dest=nil                                                                                                                                                                        Connection ID=0ea9aeb4becdce9b Connection String=0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440
TRACE[07-12|19:34:53] Node Permissioning is Enabled. 
DEBUG[07-12|19:34:53] parsePermissionedNodes                   DataDir=/qdata/dd file=permissioned-nodes.json
DEBUG[07-12|19:34:53] isNodePermissioned                       permissionedList="[3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca 0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440 8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233]"
DEBUG[07-12|19:34:53] isNodePermissioned                       connection=INCOMING nodename=0ea9aeb4becdce9b971996a43c871e47 DENIED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
DEBUG[07-12|19:34:53] isNodePermissioned                       connection=INCOMING nodename=0ea9aeb4becdce9b971996a43c871e47 DENIED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
DEBUG[07-12|19:34:53] isNodePermissioned                       connection=INCOMING nodename=0ea9aeb4becdce9b971996a43c871e47 ALLOWED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
DEBUG[07-12|19:34:53] Adding p2p peer                          id=0ea9aeb4becdce9b name=Geth/hoikz/v1.7.2-st...                      addr=100.96.0.77:46378    peers=3
TRACE[07-12|19:34:53] Starting protocol istanbul/64            id=0ea9aeb4becdce9b conn=inbound
DEBUG[07-12|19:34:53] Ethereum peer connected                  id=0ea9aeb4becdce9b conn=inbound    name=Geth/hoikz/v1.7.2-stable/linux-amd64/go1.9.2
TRACE[07-12|19:34:53] Registering sync peer                    peer=0ea9aeb4becdce9b
DEBUG[07-12|19:34:53] Relaxed downloader QoS values            rtt=20s confidence=0.333 ttl=1m0s
TRACE[07-12|19:34:56] Catch up round                           address=0x403A286b2F3E897dEAE61774270bf932B6101F08 old_round=0  old_seq=1 old_proposer=0x403A286b2F3E897dEAE61774270bf932B6101F08 new_round=1 new_seq=1 new_proposer="&{validators:[0xc4201e1ae0 0xc4201e1b00 0xc4201e1b20 0xc4201e1b40] policy:0 proposer:0xc4201e1ae0 validatorMu:{w:{state:0 sema:0} writerSem:0 readerSem:0 readerCount:0 readerWait:0} selector:0xbbf1e0}"
TRACE[07-12|19:35:00] Dial error                               task="staticdial 3c1d6e1cbff5a9e5 100.68.165.149:30303" err="dial tcp 100.68.165.149:30303: i/o timeout"
DEBUG[07-12|19:35:00] Can't resolve node                       id=3c1d6e1cbff5a9e5 err="discovery is disabled"
TRACE[07-12|19:35:00] Dial task done                           task="staticdial 3c1d6e1cbff5a9e5 100.68.165.149:30303"
TRACE[07-12|19:35:00] Dial error                               task="staticdial 0ea9aeb4becdce9b 100.64.19.101:30303"  err="dial tcp 100.64.19.101:30303: i/o timeout"
DEBUG[07-12|19:35:00] Can't resolve node                       id=0ea9aeb4becdce9b err="discovery is disabled"
TRACE[07-12|19:35:00] Dial task done                           task="staticdial 0ea9aeb4becdce9b 100.64.19.101:30303"
TRACE[07-12|19:35:00] New dial task                            task="wait for dial hist expire (15.018219124s)"
DEBUG[07-12|19:35:05] Recalculated downloader QoS values       rtt=20s confidence=0.667 ttl=1m0s
TRACE[07-12|19:35:08] Catch up round                           address=0x403A286b2F3E897dEAE61774270bf932B6101F08 old_round=1  old_seq=1 old_proposer=0x403A286b2F3E897dEAE61774270bf932B6101F08 new_round=2 new_seq=1 new_proposer="&{validators:[0xc4201e1ae0 0xc4201e1b00 0xc4201e1b20 0xc4201e1b40] policy:0 proposer:0xc4201e1ae0 validatorMu:{w:{state:0 sema:0} writerSem:0 readerSem:0 readerCount:0 readerWait:0} selector:0xbbf1e0}"
TRACE[07-12|19:35:15] Dial task done                           task="wait for dial hist expire (15.018219124s)"
TRACE[07-12|19:35:15] New dial task                            task="wait for dial hist expire (1.263042ms)"
TRACE[07-12|19:35:15] Dial task done                           task="wait for dial hist expire (1.263042ms)"
TRACE[07-12|19:35:15] New dial task                            task="wait for dial hist expire (14.979546227s)"
TRACE[07-12|19:35:21] Catch up round                           address=0x403A286b2F3E897dEAE61774270bf932B6101F08 old_round=2  old_seq=1 old_proposer=0x403A286b2F3E897dEAE61774270bf932B6101F08 new_round=5 new_seq=1 new_proposer="&{validators:[0xc4201e1ae0 0xc4201e1b00 0xc4201e1b20 0xc4201e1b40] policy:0 proposer:0xc4201e1ae0 validatorMu:{w:{state:0 sema:0} writerSem:0 readerSem:0 readerCount:0 readerWait:0} selector:0xbbf1e0}"
DEBUG[07-12|19:35:21] New round                                address=0x403A286b2F3E897dEAE61774270bf932B6101F08 old_round=5  old_seq=1 old_proposer=0x403A286b2F3E897dEAE61774270bf932B6101F08 new_round=5 new_seq=1 new_proposer=0x66fEEaaAFc27c57B818e95c51865ca004385eEBe                                                                                                                                                                 valSet="[0x403A286b2F3E897dEAE61774270bf932B6101F08 0x66fEEaaAFc27c57B818e95c51865ca004385eEBe 0xf5aEFE121fA4F748037787cD56087b5c5c5C78Ce 0xf6e5d9850E5BfDd9df0D971BE7f8f12D7845A8db]" size=4 isProposer=false
INFO [07-12|19:35:21] Committed                                address=0x403A286b2F3E897dEAE61774270bf932B6101F08 hash=654791…55e569 number=1
DEBUG[07-12|19:35:21] Queued propagated block                  peer=istanbul         number=1 hash=654791…55e569 queued=1
DEBUG[07-12|19:35:21] Importing propagated block               peer=istanbul         number=1 hash=654791…55e569
WARN [07-12|19:35:21] Discarded bad propagated block           number=1 hash=654791…55e569
TRACE[07-12|19:35:21] Propagated block                         hash=654791…55e569 recipients=1 duration=2562047h47m16.854s
DEBUG[07-12|19:35:21] Queued propagated block                  peer=d25bf65162bfde47 number=1 hash=654791…55e569 queued=1
DEBUG[07-12|19:35:21] Importing propagated block               peer=d25bf65162bfde47 number=1 hash=654791…55e569
WARN [07-12|19:35:21] Discarded bad propagated block           number=1 hash=654791…55e569
TRACE[07-12|19:35:21] Propagated block                         hash=654791…55e569 recipients=0 duration=3.189ms
DEBUG[07-12|19:35:25] Recalculated downloader QoS values       rtt=20s confidence=0.833 ttl=1m0s
TRACE[07-12|19:35:30] Dial task done                           task="wait for dial hist expire (14.979546227s)"
TRACE[07-12|19:35:30] New dial task                            task="staticdial 3c1d6e1cbff5a9e5 100.68.165.149:30303"
TRACE[07-12|19:35:30] Accepted connection                      addr=10.250.15.37:44896
TRACE[07-12|19:35:30] Quorum permissioning                     EnableNodePermission=true DataDir=/qdata/dd Current Node ID=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da Node Name=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2 Dialed Dest="enode://3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da@100.68.165.149:30303?discport=0" Connection ID=3c1d6e1cbff5a9e5 Connection String=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da
TRACE[07-12|19:35:30] Node Permissioning is Enabled. 
TRACE[07-12|19:35:30] Node Permissioning                       Connection Direction=OUTGOING
DEBUG[07-12|19:35:30] parsePermissionedNodes                   DataDir=/qdata/dd file=permissioned-nodes.json
TRACE[07-12|19:35:30] Quorum permissioning                     EnableNodePermission=true DataDir=/qdata/dd Current Node ID=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da Node Name=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2 Dialed Dest=nil                                                                                                                                                                        Connection ID=3c1d6e1cbff5a9e5 Connection String=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da
TRACE[07-12|19:35:30] Node Permissioning is Enabled. 
DEBUG[07-12|19:35:30] parsePermissionedNodes                   DataDir=/qdata/dd file=permissioned-nodes.json
DEBUG[07-12|19:35:30] isNodePermissioned                       permissionedList="[3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca 0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440 8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233]"
DEBUG[07-12|19:35:30] isNodePermissioned                       connection=OUTGOING nodename=3c1d6e1cbff5a9e57dbc00e9f5a02354 ALLOWED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
TRACE[07-12|19:35:30] Rejected peer before protocol handshake  id=3c1d6e1cbff5a9e5 addr=100.68.165.149:30303 conn=staticdial err="connected to self"
TRACE[07-12|19:35:30] Dial task done                           task="staticdial 3c1d6e1cbff5a9e5 100.68.165.149:30303"
TRACE[07-12|19:35:30] New dial task                            task="wait for dial hist expire (29.999995666s)"
DEBUG[07-12|19:35:30] isNodePermissioned                       permissionedList="[3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca 0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440 8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233]"
DEBUG[07-12|19:35:30] isNodePermissioned                       connection=INCOMING nodename=3c1d6e1cbff5a9e57dbc00e9f5a02354 ALLOWED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
TRACE[07-12|19:35:30] Rejected peer before protocol handshake  id=3c1d6e1cbff5a9e5 addr=10.250.15.37:44896   conn=inbound    err="connected to self"
TRACE[07-12|19:35:31] Store future message                     address=0x403A286b2F3E897dEAE61774270bf932B6101F08 from=0x66fEEaaAFc27c57B818e95c51865ca004385eEBe state=Committed
TRACE[07-12|19:35:43] Store future message                     address=0x403A286b2F3E897dEAE61774270bf932B6101F08 from=0x66fEEaaAFc27c57B818e95c51865ca004385eEBe state=Committed
DEBUG[07-12|19:35:45] Recalculated downloader QoS values       rtt=20s confidence=0.917 ttl=1m0s
TRACE[07-12|19:35:57] Store future message                     address=0x403A286b2F3E897dEAE61774270bf932B6101F08 from=0x66fEEaaAFc27c57B818e95c51865ca004385eEBe state=Committed
TRACE[07-12|19:36:00] Dial task done                           task="wait for dial hist expire (29.999995666s)"
TRACE[07-12|19:36:00] New dial task                            task="staticdial 3c1d6e1cbff5a9e5 100.68.165.149:30303"
TRACE[07-12|19:36:00] Accepted connection                      addr=10.250.15.37:45002
TRACE[07-12|19:36:00] Quorum permissioning                     EnableNodePermission=true DataDir=/qdata/dd Current Node ID=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da Node Name=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2 Dialed Dest=nil                                                                                                                                                                        Connection ID=3c1d6e1cbff5a9e5 Connection String=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da
TRACE[07-12|19:36:00] Node Permissioning is Enabled. 
DEBUG[07-12|19:36:00] parsePermissionedNodes                   DataDir=/qdata/dd file=permissioned-nodes.json
DEBUG[07-12|19:36:00] isNodePermissioned                       permissionedList="[3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca 0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440 8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233]"
DEBUG[07-12|19:36:00] isNodePermissioned                       connection=INCOMING nodename=3c1d6e1cbff5a9e57dbc00e9f5a02354 ALLOWED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
TRACE[07-12|19:36:00] Rejected peer before protocol handshake  id=3c1d6e1cbff5a9e5 addr=10.250.15.37:45002   conn=inbound    err="connected to self"
TRACE[07-12|19:36:00] Quorum permissioning                     EnableNodePermission=true DataDir=/qdata/dd Current Node ID=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da Node Name=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2 Dialed Dest="enode://3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da@100.68.165.149:30303?discport=0" Connection ID=3c1d6e1cbff5a9e5 Connection String=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da
TRACE[07-12|19:36:00] Node Permissioning is Enabled. 
TRACE[07-12|19:36:00] Node Permissioning                       Connection Direction=OUTGOING
DEBUG[07-12|19:36:00] parsePermissionedNodes                   DataDir=/qdata/dd file=permissioned-nodes.json
DEBUG[07-12|19:36:00] isNodePermissioned                       permissionedList="[3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca 0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440 8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233]"
DEBUG[07-12|19:36:00] isNodePermissioned                       connection=OUTGOING nodename=3c1d6e1cbff5a9e57dbc00e9f5a02354 ALLOWED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
TRACE[07-12|19:36:00] Rejected peer before protocol handshake  id=3c1d6e1cbff5a9e5 addr=100.68.165.149:30303 conn=staticdial err="connected to self"
TRACE[07-12|19:36:00] Dial task done                           task="staticdial 3c1d6e1cbff5a9e5 100.68.165.149:30303"
TRACE[07-12|19:36:00] New dial task                            task="wait for dial hist expire (29.999995466s)"
TRACE[07-12|19:36:03] Catch up round                           address=0x403A286b2F3E897dEAE61774270bf932B6101F08 old_round=5  old_seq=1 old_proposer=0x66fEEaaAFc27c57B818e95c51865ca004385eEBe new_round=6 new_seq=1 new_proposer="&{validators:[0xc4201e1ae0 0xc4201e1b00 0xc4201e1b20 0xc4201e1b40] policy:0 proposer:0xc4201e1b00 validatorMu:{w:{state:0 sema:0} writerSem:0 readerSem:0 readerCount:0 readerWait:0} selector:0xbbf1e0}"
TRACE[07-12|19:36:03] Stop processing backlog                  address=0x403A286b2F3E897dEAE61774270bf932B6101F08 from=0x66fEEaaAFc27c57B818e95c51865ca004385eEBe state="Accept request" msg="{Code: 3, Address: 0x66fEEaaAFc27c57B818e95c51865ca004385eEBe}"
DEBUG[07-12|19:36:03] New round                                address=0x403A286b2F3E897dEAE61774270bf932B6101F08 old_round=6  old_seq=1 old_proposer=0x66fEEaaAFc27c57B818e95c51865ca004385eEBe new_round=6 new_seq=1 new_proposer=0xf5aEFE121fA4F748037787cD56087b5c5c5C78Ce                                                                                                                                                                 valSet="[0x403A286b2F3E897dEAE61774270bf932B6101F08 0x66fEEaaAFc27c57B818e95c51865ca004385eEBe 0xf5aEFE121fA4F748037787cD56087b5c5c5C78Ce 0xf6e5d9850E5BfDd9df0D971BE7f8f12D7845A8db]" size=4 isProposer=false
TRACE[07-12|19:36:03] Stop processing backlog                  address=0x403A286b2F3E897dEAE61774270bf932B6101F08 from=0x66fEEaaAFc27c57B818e95c51865ca004385eEBe state=Prepared         msg="{Code: 3, Address: 0x66fEEaaAFc27c57B818e95c51865ca004385eEBe}"
TRACE[07-12|19:36:03] Stop processing backlog                  address=0x403A286b2F3E897dEAE61774270bf932B6101F08 from=0x66fEEaaAFc27c57B818e95c51865ca004385eEBe state=Committed        msg="{Code: 3, Address: 0x66fEEaaAFc27c57B818e95c51865ca004385eEBe}"
INFO [07-12|19:36:03] Committed                                address=0x403A286b2F3E897dEAE61774270bf932B6101F08 hash=654791…55e569 number=1
DEBUG[07-12|19:36:03] Queued propagated block                  peer=istanbul         number=1 hash=654791…55e569 queued=1
DEBUG[07-12|19:36:03] Importing propagated block               peer=istanbul         number=1 hash=654791…55e569
ERROR[07-12|19:36:03] not a valid address                      err="recovery failed"
DEBUG[07-12|19:36:03] Propagated block verification failed     peer=istanbul         number=1 hash=654791…55e569 err="invalid signature"
DEBUG[07-12|19:36:05] Recalculated downloader QoS values       rtt=20s confidence=0.958 ttl=1m0s
TRACE[07-12|19:36:15] Store future message                     address=0x403A286b2F3E897dEAE61774270bf932B6101F08 from=0x66fEEaaAFc27c57B818e95c51865ca004385eEBe state=Committed
DEBUG[07-12|19:36:25] Recalculated downloader QoS values       rtt=20s confidence=0.979 ttl=1m0s
TRACE[07-12|19:36:30] Dial task done                           task="wait for dial hist expire (29.999995466s)"
TRACE[07-12|19:36:30] New dial task                            task="staticdial 3c1d6e1cbff5a9e5 100.68.165.149:30303"
TRACE[07-12|19:36:30] Accepted connection                      addr=10.250.15.37:45102
TRACE[07-12|19:36:30] Quorum permissioning                     EnableNodePermission=true DataDir=/qdata/dd Current Node ID=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da Node Name=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2 Dialed Dest=nil                                                                                                                                                                        Connection ID=3c1d6e1cbff5a9e5 Connection String=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da
TRACE[07-12|19:36:30] Node Permissioning is Enabled. 
DEBUG[07-12|19:36:30] parsePermissionedNodes                   DataDir=/qdata/dd file=permissioned-nodes.json
DEBUG[07-12|19:36:30] isNodePermissioned                       permissionedList="[3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca 0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440 8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233]"
DEBUG[07-12|19:36:30] isNodePermissioned                       connection=INCOMING nodename=3c1d6e1cbff5a9e57dbc00e9f5a02354 ALLOWED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
TRACE[07-12|19:36:30] Rejected peer before protocol handshake  id=3c1d6e1cbff5a9e5 addr=10.250.15.37:45102   conn=inbound    err="connected to self"
TRACE[07-12|19:36:30] Quorum permissioning                     EnableNodePermission=true DataDir=/qdata/dd Current Node ID=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da Node Name=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2 Dialed Dest="enode://3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da@100.68.165.149:30303?discport=0" Connection ID=3c1d6e1cbff5a9e5 Connection String=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da
TRACE[07-12|19:36:30] Node Permissioning is Enabled. 
TRACE[07-12|19:36:30] Node Permissioning                       Connection Direction=OUTGOING
DEBUG[07-12|19:36:30] parsePermissionedNodes                   DataDir=/qdata/dd file=permissioned-nodes.json
DEBUG[07-12|19:36:30] isNodePermissioned                       permissionedList="[3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca 0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440 8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233]"
DEBUG[07-12|19:36:30] isNodePermissioned                       connection=OUTGOING nodename=3c1d6e1cbff5a9e57dbc00e9f5a02354 ALLOWED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
TRACE[07-12|19:36:30] Rejected peer before protocol handshake  id=3c1d6e1cbff5a9e5 addr=100.68.165.149:30303 conn=staticdial err="connected to self"
TRACE[07-12|19:36:30] Dial task done                           task="staticdial 3c1d6e1cbff5a9e5 100.68.165.149:30303"
TRACE[07-12|19:36:30] New dial task                            task="wait for dial hist expire (29.999995451s)"
TRACE[07-12|19:36:41] Store future message                     address=0x403A286b2F3E897dEAE61774270bf932B6101F08 from=0x66fEEaaAFc27c57B818e95c51865ca004385eEBe state=Committed
DEBUG[07-12|19:36:45] Recalculated downloader QoS values       rtt=20s confidence=0.990 ttl=1m0s
TRACE[07-12|19:37:00] Dial task done                           task="wait for dial hist expire (29.999995451s)"
TRACE[07-12|19:37:00] New dial task                            task="staticdial 3c1d6e1cbff5a9e5 100.68.165.149:30303"
TRACE[07-12|19:37:00] Accepted connection                      addr=10.250.15.37:45204
TRACE[07-12|19:37:00] Quorum permissioning                     EnableNodePermission=true DataDir=/qdata/dd Current Node ID=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da Node Name=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2 Dialed Dest=nil                                                                                                                                                                        Connection ID=3c1d6e1cbff5a9e5 Connection String=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da
TRACE[07-12|19:37:00] Node Permissioning is Enabled. 
DEBUG[07-12|19:37:00] parsePermissionedNodes                   DataDir=/qdata/dd file=permissioned-nodes.json
DEBUG[07-12|19:37:00] isNodePermissioned                       permissionedList="[3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca 0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440 8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233]"
DEBUG[07-12|19:37:00] isNodePermissioned                       connection=INCOMING nodename=3c1d6e1cbff5a9e57dbc00e9f5a02354 ALLOWED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
TRACE[07-12|19:37:00] Rejected peer before protocol handshake  id=3c1d6e1cbff5a9e5 addr=10.250.15.37:45204   conn=inbound    err="connected to self"
TRACE[07-12|19:37:00] Quorum permissioning                     EnableNodePermission=true DataDir=/qdata/dd Current Node ID=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da Node Name=Geth/tblrc/v1.7.2-stable/linux-amd64/go1.9.2 Dialed Dest="enode://3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da@100.68.165.149:30303?discport=0" Connection ID=3c1d6e1cbff5a9e5 Connection String=3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da
TRACE[07-12|19:37:00] Node Permissioning is Enabled. 
TRACE[07-12|19:37:00] Node Permissioning                       Connection Direction=OUTGOING
DEBUG[07-12|19:37:00] parsePermissionedNodes                   DataDir=/qdata/dd file=permissioned-nodes.json
DEBUG[07-12|19:37:00] isNodePermissioned                       permissionedList="[3c1d6e1cbff5a9e57dbc00e9f5a0235454643f7641b52d59014edeea3d25153b818523b7786fad58116bb1d1bbd8e1281fb71c81b1165964821497328302a8da d25bf65162bfde4753e58e82b1a20e9c50c66713f796a0169119649b7ab9c29a888a611e729cb58710e845d8569c66a44e627bff40f1f0ff90407fbee85b81ca 0ea9aeb4becdce9b971996a43c871e47df079f03dbbad8757302f2dd4ae96ed6059ebc5835d878aa7f805a201ac2ce1ffde42d39de5375f23aaa7b010491a440 8dd0af45bdbe0a3f712a67c12cdfb18ee4c2888619896eb1835d93f4f87a703c4bf173e27bfdd3c69cb5057b58eee992e317813215e80fef77b8906c57885233]"
DEBUG[07-12|19:37:00] isNodePermissioned                       connection=OUTGOING nodename=3c1d6e1cbff5a9e57dbc00e9f5a02354 ALLOWED-BY=3c1d6e1cbff5a9e57dbc00e9f5a02354
TRACE[07-12|19:37:00] Rejected peer before protocol handshake  id=3c1d6e1cbff5a9e5 addr=100.68.165.149:30303 conn=staticdial err="connected to self"
TRACE[07-12|19:37:00] Dial task done                           task="staticdial 3c1d6e1cbff5a9e5 100.68.165.149:30303"
TRACE[07-12|19:37:00] New dial task                            task="wait for dial hist expire (29.9999959s)"
@IronGauntlets
Copy link

IronGauntlets commented Aug 9, 2018

@michaelkunzmann-sap Hi I am having trouble with setting up a network, can you please let me what commands you used to generate the genesis.json, static-nodes.json and node keys especially how you passed the password. I noticed when calling geth you -unlock 0 is that to unlock the 0th nodekey? When you created the genesis.json, static-nodes.json and nodekeys did you pass a password file and did the tool create keystores under $(pwd)0/,$(pwd)1/...? Because every time I use the setup command the keystores are not created and some random addresses show up when running the client to which I don't have access to. BTW, I am looking at IBFT for geth, not Quorum.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

2 participants