search

web3 / web3.js

Collection of comprehensive TypeScript libraries for Interaction with the Ethereum JSON RPC API and utility functions.
https://web3js.org/
Other
19.35k stars 4.96k forks source link

Confirmation number incorrect when chain reorg happens #3608

Closed Troublor closed 3 years ago

Troublor commented 4 years ago

Expected behavior

When the block including the transaction becomes an uncle, the transaction returns to txpool. Next time the transaction is included in a new block, the confirmation number should be reset and count from 0 again.

Actual behavior

Web3.js seems to be not aware of the reorg and the confirmation number is not reset and count continuously.

Steps to reproduce the behavior

I test with this javascript: 

const fs = require("fs");

let web3 = new Web3("http://localhost:8545");

const keystore = fs.readFileSync("my/keystore/file").toString();

const decryptAccount = web3.eth.accounts.decrypt(keystore, "passphrase");

let rawTransaction = {
    "from": "0x2ecb718297080ff730269176e42c8278aa193434",
    "to": "0x2ecb718297080ff730269176e42c8278aa193434",
    "value": web3.utils.toHex(web3.utils.toWei("0.001", "ether")),
    "nonce": 3,
    "gas": 200000,
    "chainId": 123456,
};

decryptAccount.signTransaction(rawTransaction)
    .then(signedTx => {
        web3.eth.sendSignedTransaction(signedTx.rawTransaction)
            .on("transactionHash", console.log)
            // .on("error", console.log)
            // .on("receipt", console.log)
            .on("confirmation", (n, r) => {
                console.log("confirmNumber", n);
            });
    }).catch(console.log);

As for blockchain, I start two Geth nodes on localhost, one of which opens http endpoint at port 8545. The two nodes are synchronised but not connected in the beginning. After one node receives the transaction, I make it mine 3 blocks 899,900,901 (because it's hard to control how many blocks is mined using miner.start()). The transaction is included in block 899. And at the same time I make the other node (without the transaction in txpool) mine 5 blocks 899,900,901,902,903. Then the two nodes are connected and synchronised. I can see from console that the block 899 that originally included the transaction becomes uncle and the transaction returns to txpool.

Then I make the nodes mine blocks again, it mined block 904, 905, 906. Now the transaction is included in block 904. However web3.js gives these output:

0x4b283da019fb0aed959f47ebcb5eb70375eff2175196d6545acbaf566b32ae3d
confirmNumber 0
confirmNumber 1
confirmNumber 2
confirmNumber 3
confirmNumber 4
confirmNumber 5
confirmNumber 6
confirmNumber 7

Environment

Geth: 1.9.15-stable Web3.js: 1.2.9 Node.js: 10.21.0 OS: macOS

GregTheGreek commented 4 years ago

Is it possible that you could provide the geth logs as well (with --verbosity 4 please)?

Troublor commented 4 years ago

Is it possible that you could provide the geth logs as well (with --verbosity 4 please)?

Sure I will post in a minute, but I need to re-run it again so block number and transaction hash will be different.

Troublor commented 4 years ago

Geth log from the node receiving transaction from web3.js

INFO [06-30|11:31:42.209] Starting Geth on Ethereum mainnet... 
INFO [06-30|11:31:42.209] Bumping default cache on mainnet         provided=1024 updated=4096
DEBUG[06-30|11:31:42.209] Sanitizing Go's GC trigger               percent=25
INFO [06-30|11:31:42.210] Maximum peer count                       ETH=50 LES=0 total=50
DEBUG[06-30|11:31:42.210] FS scan times                            list="103.081µs" set="4.174µs" diff="2.609µs"
INFO [06-30|11:31:42.223] Starting peer-to-peer node               instance=Geth/v1.9.15-stable-0f77f34b/darwin-amd64/go1.14.2
INFO [06-30|11:31:42.223] Allocated trie memory caches             clean=614.00MiB dirty=1024.00MiB
INFO [06-30|11:31:42.223] Allocated cache and file handles         database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_doer/geth/chaindata cache=2.00GiB handles=5120
DEBUG[06-30|11:31:42.281] Chain freezer table opened               database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_doer/geth/chaindata/ancient table=diffs items=0 size=0.00B
DEBUG[06-30|11:31:42.281] Chain freezer table opened               database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_doer/geth/chaindata/ancient table=headers items=0 size=0.00B
DEBUG[06-30|11:31:42.281] Chain freezer table opened               database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_doer/geth/chaindata/ancient table=hashes  items=0 size=0.00B
DEBUG[06-30|11:31:42.281] Chain freezer table opened               database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_doer/geth/chaindata/ancient table=bodies  items=0 size=0.00B
DEBUG[06-30|11:31:42.282] Chain freezer table opened               database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_doer/geth/chaindata/ancient table=receipts items=0 size=0.00B
INFO [06-30|11:31:42.282] Opened ancient database                  database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_doer/geth/chaindata/ancient
DEBUG[06-30|11:31:42.282] Current full block not old enough        number=906 hash="0e8c68…75381a" delay=90000
INFO [06-30|11:31:42.282] Initialised chain configuration          config="{ChainID: 123456 Homestead: 0 DAO: <nil> DAOSupport: false EIP150: 0 EIP155: 0 EIP158: 0 Byzantium: 0 Constantinople: 0 Petersburg: 0 Istanbul: 0, Muir Glacier: 0, YOLO v1: <nil>, Engine: unknown}"
INFO [06-30|11:31:42.282] Disk storage enabled for ethash caches   dir=/Users/troublor/workspace/dArcher/augur/blockchain/v1_doer/geth/ethash count=3
INFO [06-30|11:31:42.282] Disk storage enabled for ethash DAGs     dir=/Users/troublor/Library/Ethash count=2
INFO [06-30|11:31:42.282] Initialising Ethereum protocol           versions="[65 64 63]" network=1 dbversion=7
INFO [06-30|11:31:42.283] Loaded most recent local header          number=906 hash="0e8c68…75381a" td=124906966 age=35m4s
INFO [06-30|11:31:42.283] Loaded most recent local full block      number=906 hash="0e8c68…75381a" td=124906966 age=35m4s
INFO [06-30|11:31:42.283] Loaded most recent local fast block      number=906 hash="0e8c68…75381a" td=124906966 age=35m4s
DEBUG[06-30|11:31:42.283] Reinjecting stale transactions           count=0
INFO [06-30|11:31:42.283] Loaded local transaction journal         transactions=0 dropped=0
INFO [06-30|11:31:42.283] Regenerated local transaction journal    transactions=0 accounts=0
WARN [06-30|11:31:42.283] Switch sync mode from fast sync to full sync 
DEBUG[06-30|11:31:42.283] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:31:42.328] TCP listener up                          addr=[::]:30303
DEBUG[06-30|11:31:42.328] InProc registered                        namespace=admin
DEBUG[06-30|11:31:42.328] InProc registered                        namespace=admin
DEBUG[06-30|11:31:42.328] InProc registered                        namespace=debug
DEBUG[06-30|11:31:42.328] InProc registered                        namespace=web3
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=eth
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=eth
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=eth
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=txpool
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=debug
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=debug
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=eth
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=personal
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=eth
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=ethash
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=eth
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=eth
INFO [06-30|11:31:42.329] New local node record                    seq=53 id=89a46879ef9aeac4 ip=127.0.0.1 udp=0 tcp=30303
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=eth
INFO [06-30|11:31:42.329] Started P2P networking                   self="enode://1a2277de9516de24b6968f7eea1f3c6521b73db156e8b7d3d8aa012d431eadd8f0b163558861e3d4afcabf7435ca2dd5aef820fa3dfee59fba48995f76d4d84a@127.0.0.1:30303?discport=0"
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=miner
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=eth
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=admin
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=debug
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=debug
DEBUG[06-30|11:31:42.329] InProc registered                        namespace=net
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=admin
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=admin
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=debug
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=web3
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=eth
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=eth
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=eth
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=txpool
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=debug
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=debug
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=eth
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=personal
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=eth
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=ethash
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=eth
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=eth
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=eth
DEBUG[06-30|11:31:42.329] IPC registered                           namespace=miner
DEBUG[06-30|11:31:42.330] IPC registered                           namespace=eth
DEBUG[06-30|11:31:42.330] IPC registered                           namespace=admin
DEBUG[06-30|11:31:42.330] IPC registered                           namespace=debug
DEBUG[06-30|11:31:42.330] IPC registered                           namespace=debug
DEBUG[06-30|11:31:42.330] IPC registered                           namespace=net
INFO [06-30|11:31:42.330] IPC endpoint opened                      url=/Users/troublor/workspace/dArcher/augur/blockchain/v1_doer/geth.ipc
INFO [06-30|11:31:42.330] HTTP endpoint opened                     url=http://127.0.0.1:8545/ cors= vhosts=localhost
DEBUG[06-30|11:31:42.364] Served rpc_modules                       reqid=1 t="94.748µs"
DEBUG[06-30|11:31:42.366] Served web3_clientVersion                reqid=2 t="13.557µs"
INFO [06-30|11:31:42.366] Etherbase automatically configured       address=0x2ecB718297080fF730269176E42C8278aA193434
DEBUG[06-30|11:31:42.366] Served eth_coinbase                      reqid=3 t="50.986µs"
DEBUG[06-30|11:31:42.366] Served eth_blockNumber                   reqid=4 t="16.832µs"
DEBUG[06-30|11:31:42.367] Served eth_blockNumber                   reqid=5 t="23.323µs"
DEBUG[06-30|11:31:42.367] Served eth_getBlockByNumber              reqid=6 t="150.625µs"
DEBUG[06-30|11:31:42.368] Served admin_datadir                     reqid=7 t="11.77µs"
DEBUG[06-30|11:31:42.368] Served rpc_modules                       reqid=8 t="34.998µs"
Welcome to the Geth JavaScript console!

instance: Geth/v1.9.15-stable-0f77f34b/darwin-amd64/go1.14.2
coinbase: 0x2ecb718297080ff730269176e42c8278aa193434
at block: 906 (Tue Jun 30 2020 10:56:38 GMT+0800 (HKT))
 datadir: /Users/troublor/workspace/dArcher/augur/blockchain/v1_doer
 modules: admin:1.0 debug:1.0 eth:1.0 ethash:1.0 miner:1.0 net:1.0 personal:1.0 rpc:1.0 txpool:1.0 web3:1.0

> DEBUG[06-30|11:31:44.433] Couldn't add port mapping                proto=tcp extport=30303 intport=30303 interface="UPnP or NAT-PMP" err="no UPnP or NAT-PMP router discovered"
DEBUG[06-30|11:32:02.287] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:32:19.168] Served eth_gasPrice                      conn=127.0.0.1:50344 reqid=1 t=1.382929ms
WARN [06-30|11:32:19.196] Served eth_sendRawTransaction            conn=127.0.0.1:50344 reqid=2 t="347.81µs"  err="nonce too low"
DEBUG[06-30|11:32:22.288] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:32:26.816] Served eth_gasPrice                      conn=127.0.0.1:50345 reqid=1 t="44.73µs"
INFO [06-30|11:32:26.847] Setting new local account                address=0x2ecB718297080fF730269176E42C8278aA193434
INFO [06-30|11:32:26.848] Submitted transaction                    fullhash=0x9e80f8f1ea1a99efdf4d9464e3b325e55d84dda79c85bebf5a34f3225f64fc58 recipient=0x2ecB718297080fF730269176E42C8278aA193434
DEBUG[06-30|11:32:26.848] Served eth_sendRawTransaction            conn=127.0.0.1:50345 reqid=2 t="466.992µs"
DEBUG[06-30|11:32:26.850] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=3 t="85.426µs"
DEBUG[06-30|11:32:27.853] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=4 t="70.513µs"
DEBUG[06-30|11:32:28.857] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=5 t="79.359µs"
DEBUG[06-30|11:32:29.858] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=6 t="64.763µs"
DEBUG[06-30|11:32:30.287] Transaction pool status report           executable=1 queued=0 stales=0
DEBUG[06-30|11:32:30.862] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=7 t="113.068µs"
DEBUG[06-30|11:32:31.862] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=8 t="115.803µs"
DEBUG[06-30|11:32:32.866] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=9 t="112.341µs"
DEBUG[06-30|11:32:33.866] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=10 t="77.715µs"
> minDEBUG[06-30|11:32:34.871] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=11 t="80.189µs"
> miner.DEBUG[06-30|11:32:35.871] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=12 t="64.178µs"
> miner.stopDEBUG[06-30|11:32:36.875] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=13 t="77.944µs"
> miner.stop()DEBUG[06-30|11:32:37.878] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=14 t="79.891µs"
DEBUG[06-30|11:32:38.883] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=15 t="113.134µs"

DEBUG[06-30|11:32:39.215] Served miner_stop                        reqid=9  t="126.123µs"
null
> minerDEBUG[06-30|11:32:39.886] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=16 t="130.008µs"
> miner.sDEBUG[06-30|11:32:40.890] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=17 t="134.046µs"
> miner.start()DEBUG[06-30|11:32:41.890] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=18 t="137µs"

INFO [06-30|11:32:42.079] Updated mining threads                   threads=16
INFO [06-30|11:32:42.079] Transaction pool price threshold updated price=1000000000
DEBUG[06-30|11:32:42.079] Served miner_start                       reqid=10 t="159.511µs"
null
> INFO [06-30|11:32:42.079] Commit new mining work                   number=907 sealhash="5f5da5…117c4c" uncles=0 txs=0 gas=0 fees=0 elapsed="184.344µs"
DEBUG[06-30|11:32:42.080] Loaded old ethash dataset from disk      epoch=0
INFO [06-30|11:32:42.080] Commit new mining work                   number=907 sealhash="c9f279…482675" uncles=0 txs=1 gas=21000 fees=0.000861 elapsed="607.698µs"
DEBUG[06-30|11:32:42.080] Loaded old ethash dataset from disk      epoch=1
INFO [06-30|11:32:42.208] Successfully sealed new block            number=907 sealhash="c9f279…482675" hash="bf71d9…5ecab5" elapsed=128.571ms
INFO [06-30|11:32:42.208] 🔨 mined potential block                  number=907 hash="bf71d9…5ecab5"
DEBUG[06-30|11:32:42.208] Reinjecting stale transactions           count=0
INFO [06-30|11:32:42.208] Commit new mining work                   number=908 sealhash="6165ab…d17694" uncles=0 txs=0 gas=0     fees=0        elapsed="148.209µs"
DEBUG[06-30|11:32:42.297] Current full block not old enough        number=907 hash="bf71d9…5ecab5" delay=90000
DEBUG[06-30|11:32:42.297] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
INFO [06-30|11:32:42.377] Successfully sealed new block            number=908 sealhash="6165ab…d17694" hash="937e09…eca6f9" elapsed=168.519ms
INFO [06-30|11:32:42.377] 🔨 mined potential block                  number=908 hash="937e09…eca6f9"
INFO [06-30|11:32:42.377] Mining too far in the future             wait=2s
DEBUG[06-30|11:32:42.377] Reinjecting stale transactions           count=0
> miner.stop()DEBUG[06-30|11:32:42.894] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=19 t="581.034µs"
DEBUG[06-30|11:32:42.897] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=20 t="134.932µs"
DEBUG[06-30|11:32:42.900] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=21 t="124.903µs"

DEBUG[06-30|11:32:43.153] Served miner_stop                        reqid=11 t="28.524µs"
null
> DEBUG[06-30|11:32:43.900] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=22 t="368.468µs"
DEBUG[06-30|11:32:43.901] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=23 t="104.528µs"
DEBUG[06-30|11:32:43.902] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=24 t="123.258µs"
DEBUG[06-30|11:32:44.900] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=25 t="309.98µs"
DEBUG[06-30|11:32:44.900] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=26 t="88.809µs"
DEBUG[06-30|11:32:44.901] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=27 t="39.579µs"
DEBUG[06-30|11:32:45.903] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=28 t="479.398µs"
DEBUG[06-30|11:32:45.904] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=29 t="128.001µs"
DEBUG[06-30|11:32:45.905] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=30 t="51.689µs"
DEBUG[06-30|11:32:46.285] Transaction pool status report           executable=0 queued=0 stales=0
DEBUG[06-30|11:32:46.907] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=31 t="480.584µs"
DEBUG[06-30|11:32:46.908] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=32 t="98.015µs"
DEBUG[06-30|11:32:46.914] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=33 t="42.954µs"
DEBUG[06-30|11:32:47.909] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=34 t="296.186µs"
DEBUG[06-30|11:32:47.910] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=35 t="97.625µs"
DEBUG[06-30|11:32:47.911] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=36 t="45.656µs"
DEBUG[06-30|11:32:48.912] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=37 t="484.717µs"
DEBUG[06-30|11:32:48.914] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=38 t="116.641µs"
DEBUG[06-30|11:32:48.915] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=39 t="51.304µs"
DEBUG[06-30|11:32:49.914] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=40 t="456.627µs"
DEBUG[06-30|11:32:49.915] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=41 t="128.562µs"
DEBUG[06-30|11:32:49.916] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=42 t="53.277µs"
DEBUG[06-30|11:32:50.918] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=43 t="271.094µs"
DEBUG[06-30|11:32:50.918] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=44 t="63.821µs"
DEBUG[06-30|11:32:50.919] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=45 t="42.639µs"
DEBUG[06-30|11:32:51.918] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=46 t="469.321µs"
DEBUG[06-30|11:32:51.919] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=47 t="96.774µs"
DEBUG[06-30|11:32:51.920] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=48 t="53.079µs"
DEBUG[06-30|11:32:52.920] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=49 t="261.963µs"
DEBUG[06-30|11:32:52.921] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=50 t="72.258µs"
DEBUG[06-30|11:32:52.922] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=51 t="41.168µs"
DEBUG[06-30|11:32:53.927] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=52 t="707.587µs"
DEBUG[06-30|11:32:53.928] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=53 t="134.016µs"
DEBUG[06-30|11:32:53.929] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=54 t="76.882µs"
DEBUG[06-30|11:32:54.928] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=55 t="691.559µs"
DEBUG[06-30|11:32:54.930] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=56 t="125.238µs"
DEBUG[06-30|11:32:54.932] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=57 t="65.521µs"
DEBUG[06-30|11:32:55.929] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=58 t="407.316µs"
DEBUG[06-30|11:32:55.930] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=59 t="88.042µs"
DEBUG[06-30|11:32:55.931] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=60 t="52.386µs"
DEBUG[06-30|11:32:56.930] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=61 t="487.573µs"
DEBUG[06-30|11:32:56.932] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=62 t="123.712µs"
DEBUG[06-30|11:32:56.933] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=63 t="75.027µs"
DEBUG[06-30|11:32:57.930] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=64 t="453.101µs"
DEBUG[06-30|11:32:57.931] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=65 t="88.473µs"
DEBUG[06-30|11:32:57.932] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=66 t="52.294µs"
DEBUG[06-30|11:32:58.935] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=67 t="702.808µs"
DEBUG[06-30|11:32:58.937] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=68 t="117.63µs"
DEBUG[06-30|11:32:58.938] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=69 t="72.088µs"
DEBUG[06-30|11:32:59.938] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=70 t="275.71µs"
DEBUG[06-30|11:32:59.939] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=71 t="68.138µs"
DEBUG[06-30|11:32:59.940] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=72 t="43.665µs"
DEBUG[06-30|11:33:00.942] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=73 t="376.371µs"
DEBUG[06-30|11:33:00.943] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=74 t="84.442µs"
DEBUG[06-30|11:33:00.944] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=75 t="45.552µs"
DEBUG[06-30|11:33:01.946] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=76 t="300.429µs"
DEBUG[06-30|11:33:01.947] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=77 t="87.664µs"
DEBUG[06-30|11:33:01.948] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=78 t="45.635µs"
DEBUG[06-30|11:33:02.298] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:33:02.947] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=79 t="299.955µs"
DEBUG[06-30|11:33:02.948] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=80 t="77.621µs"
DEBUG[06-30|11:33:02.949] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=81 t="44.12µs"
DEBUG[06-30|11:33:03.951] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=82 t="394.043µs"
DEBUG[06-30|11:33:03.952] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=83 t="91.003µs"
DEBUG[06-30|11:33:03.953] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=84 t="57.909µs"
DEBUG[06-30|11:33:04.957] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=85 t="361.23µs"
DEBUG[06-30|11:33:04.958] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=86 t="106.055µs"
DEBUG[06-30|11:33:04.959] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=87 t="44.289µs"
DEBUG[06-30|11:33:05.957] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=88 t="265.728µs"
DEBUG[06-30|11:33:05.958] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=89 t="67.741µs"
DEBUG[06-30|11:33:05.959] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=90 t="40.474µs"
DEBUG[06-30|11:33:06.962] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=91 t="702.505µs"
DEBUG[06-30|11:33:06.964] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=92 t="118.109µs"
DEBUG[06-30|11:33:06.965] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=93 t="67.028µs"
DEBUG[06-30|11:33:07.967] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=94 t="274.618µs"
DEBUG[06-30|11:33:07.968] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=95 t="83.061µs"
DEBUG[06-30|11:33:07.968] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=96 t="45.592µs"
DEBUG[06-30|11:33:08.971] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=97 t="278.926µs"
DEBUG[06-30|11:33:08.972] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=98 t="70.698µs"
DEBUG[06-30|11:33:08.973] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=99 t="38.837µs"
DEBUG[06-30|11:33:09.972] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=100 t="453.773µs"
DEBUG[06-30|11:33:09.973] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=101 t="123.513µs"
DEBUG[06-30|11:33:09.974] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=102 t="51.89µs"
DEBUG[06-30|11:33:10.971] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=103 t="455.288µs"
DEBUG[06-30|11:33:10.973] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=104 t="117.017µs"
DEBUG[06-30|11:33:10.974] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=105 t="67.922µs"
DEBUG[06-30|11:33:11.972] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=106 t="364.767µs"
DEBUG[06-30|11:33:11.973] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=107 t="97.375µs"
DEBUG[06-30|11:33:11.974] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=108 t="54.325µs"
DEBUG[06-30|11:33:12.973] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=109 t="273.496µs"
DEBUG[06-30|11:33:12.974] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=110 t="78.301µs"
DEBUG[06-30|11:33:12.975] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=111 t="40.123µs"
> aDEBUG[06-30|11:33:13.977] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=112 t="366.042µs"
DEBUG[06-30|11:33:13.978] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=113 t="87.045µs"
DEBUG[06-30|11:33:13.979] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=114 t="48.948µs"
> admin.DEBUG[06-30|11:33:14.976] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=115 t="412.534µs"
DEBUG[06-30|11:33:14.977] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=116 t="95.054µs"
DEBUG[06-30|11:33:14.978] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=117 t="50.126µs"
> admin.addPeeDEBUG[06-30|11:33:15.978] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=118 t="366.511µs"
DEBUG[06-30|11:33:15.979] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=119 t="172.544µs"
DEBUG[06-30|11:33:15.980] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=120 t="90.892µs"
> admin.addPeer(DEBUG[06-30|11:33:16.984] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=121 t="465.425µs"
DEBUG[06-30|11:33:16.986] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=122 t="141.927µs"
DEBUG[06-30|11:33:16.987] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=123 t="55.14µs"
> admin.addPeer("enode://12e3f371bd9b74e19409d28b512281aae8d122df3212102728569dc06a8a1c086b92a4a95ab59c3059cebb76c7c141d0b0d91c7d220dfca723f175f27c6ce889@127.0.0.1:30304?discport=0"DEBUG[06-30|11:33:17.984] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=124 t="678.967µs"
DEBUG[06-30|11:33:17.985] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=125 t="118.276µs"
> admin.addPeer("enode://12e3f371bd9b74e19409d28b512281aae8d122df3212102728569dc06a8a1c086b92a4a95ab59c3059cebb76c7c141d0b0d91c7d220dfca723f175f27c6ce889@127.0.0.1:30304?discport=0")
DEBUG[06-30|11:33:18.381] Served admin_addPeer                     reqid=12  t="235.312µs"
true
INFO [06-30|11:33:18.382] Looking for peers                        peercount=0 tried=0 static=1
> DEBUG[06-30|11:33:18.386] Adding p2p peer                          peercount=1 id=91cdb35a77727fcf conn=staticdial      addr=127.0.0.1:30304 name=Geth/v1.9.15-stable-...
DEBUG[06-30|11:33:18.386] Ethereum peer connected                  id=91cdb35a77727fcf conn=staticdial      name=Geth/v1.9.15-stable-0f77f34b/darwin-amd64/go1.14.2
INFO [06-30|11:33:18.386] Block synchronisation started 
DEBUG[06-30|11:33:18.386] Synchronising with the network           peer=91cdb35a77727fcf eth=65 head="3c4822…b1a8c6" td=125562966 mode=full
DEBUG[06-30|11:33:18.386] Retrieving remote chain height           peer=91cdb35a77727fcf
DEBUG[06-30|11:33:18.386] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=1 fromhash="3c4822…b1a8c6" skip=0 reverse=false
DEBUG[06-30|11:33:18.387] Remote head header identified            peer=91cdb35a77727fcf number=911 hash="3c4822…b1a8c6"
DEBUG[06-30|11:33:18.387] Looking for common ancestor              peer=91cdb35a77727fcf local=908 remote=911
DEBUG[06-30|11:33:18.387] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=2 fromnum=908 skip=1 reverse=false
DEBUG[06-30|11:33:18.387] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=1 fromnum=455 skip=0 reverse=false
DEBUG[06-30|11:33:18.388] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=1 fromnum=683 skip=0 reverse=false
DEBUG[06-30|11:33:18.388] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=1 fromnum=797 skip=0 reverse=false
DEBUG[06-30|11:33:18.389] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=1 fromnum=854 skip=0 reverse=false
DEBUG[06-30|11:33:18.389] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=1 fromnum=882 skip=0 reverse=false
DEBUG[06-30|11:33:18.389] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=1 fromnum=896 skip=0 reverse=false
DEBUG[06-30|11:33:18.390] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=1 fromnum=903 skip=0 reverse=false
DEBUG[06-30|11:33:18.390] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=1 fromnum=907 skip=0 reverse=false
DEBUG[06-30|11:33:18.390] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=1 fromnum=905 skip=0 reverse=false
DEBUG[06-30|11:33:18.391] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=1 fromnum=906 skip=0 reverse=false
DEBUG[06-30|11:33:18.391] Found common ancestor                    peer=91cdb35a77727fcf number=906 hash="0e8c68…75381a"
DEBUG[06-30|11:33:18.391] Directing header downloads               peer=91cdb35a77727fcf origin=907
DEBUG[06-30|11:33:18.391] Downloading transaction receipts         origin=907
DEBUG[06-30|11:33:18.391] Downloading block bodies                 origin=907
DEBUG[06-30|11:33:18.391] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=128 fromnum=1098 skip=191 reverse=false
DEBUG[06-30|11:33:18.391] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=192 fromnum=907  skip=0   reverse=false
DEBUG[06-30|11:33:18.392] Fetching batch of headers                id=91cdb35a77727fcf conn=staticdial      count=192 fromnum=912  skip=0   reverse=false
DEBUG[06-30|11:33:18.392] Inserting downloaded chain               items=5 firstnum=907 firsthash="b44028…6d098e" lastnum=911 lasthash="3c4822…b1a8c6"
DEBUG[06-30|11:33:18.392] No more headers available                peer=91cdb35a77727fcf
DEBUG[06-30|11:33:18.392] Header download terminated               peer=91cdb35a77727fcf
DEBUG[06-30|11:33:18.392] Data fetching completed                  type=receipts
DEBUG[06-30|11:33:18.392] Data fetching completed                  type=bodies
DEBUG[06-30|11:33:18.392] Block body download terminated           err=nil
DEBUG[06-30|11:33:18.392] Transaction receipt download terminated  err=nil
DEBUG[06-30|11:33:18.392] Loaded old ethash cache from disk        epoch=0
DEBUG[06-30|11:33:18.393] Loaded old ethash cache from disk        epoch=1
DEBUG[06-30|11:33:18.398] Inserted forked block                    number=907 hash="b44028…6d098e" diff=131072    elapsed="762.151µs" txs=0 gas=0     uncles=0 root="128004…95cd36"
DEBUG[06-30|11:33:18.399] Inserted forked block                    number=908 hash="8abf87…b0036f" diff=131136    elapsed="138.868µs" txs=0 gas=0     uncles=0 root="74f9ac…259aa4"
INFO [06-30|11:33:18.399] Chain reorg detected                     number=906 hash="0e8c68…75381a" drop=2 dropfrom="937e09…eca6f9" add=3 addfrom="540877…7c4475"
DEBUG[06-30|11:33:18.400] Inserted new block                       number=909 hash="540877…7c4475" uncles=0 txs=0 gas=0     elapsed=1.024ms     root="24cbd4…40a154"
DEBUG[06-30|11:33:18.400] Inserted new block                       number=910 hash="389d24…91081a" uncles=0 txs=0 gas=0     elapsed="156.492µs" root="94fb5d…fb6082"
DEBUG[06-30|11:33:18.400] Inserted new block                       number=911 hash="3c4822…b1a8c6" uncles=0 txs=0 gas=0     elapsed="136.399µs" root="56a112…dea0c8"
INFO [06-30|11:33:18.400] Imported new chain segment               blocks=5 txs=0 mgas=0.000 elapsed=8.544ms     mgasps=0.000 number=911 hash="3c4822…b1a8c6" dirty=11.79KiB
DEBUG[06-30|11:33:18.400] Reset ancient limit to zero 
DEBUG[06-30|11:33:18.400] Synchronisation terminated               elapsed=13.923ms
DEBUG[06-30|11:33:18.400] Reset ancient limit to zero 
DEBUG[06-30|11:33:18.401] Committing new uncle to block            hash="bf71d9…5ecab5"
DEBUG[06-30|11:33:18.401] Reinjecting stale transactions           count=1
DEBUG[06-30|11:33:18.983] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=127 t="97.975µs"
DEBUG[06-30|11:33:19.983] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=128 t="67.5µs"
DEBUG[06-30|11:33:20.986] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=129 t="106.33µs"
DEBUG[06-30|11:33:21.987] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=130 t="67.678µs"
DEBUG[06-30|11:33:22.300] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:33:22.990] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=131 t="98.173µs"
DEBUG[06-30|11:33:23.993] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=132 t="95.583µs"
DEBUG[06-30|11:33:24.993] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=133 t="67.836µs"
DEBUG[06-30|11:33:25.996] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=134 t="95.266µs"
DEBUG[06-30|11:33:26.291] Transaction pool status report           executable=1 queued=0 stales=0
DEBUG[06-30|11:33:27.000] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=135 t="67.583µs"
DEBUG[06-30|11:33:28.001] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=136 t="96.134µs"
DEBUG[06-30|11:33:29.004] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=137 t="109.381µs"
> txpoolDEBUG[06-30|11:33:30.004] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=138 t="68.68µs"
> txpool.statDEBUG[06-30|11:33:31.004] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=139 t="66.901µs"
> txpool.status
DEBUG[06-30|11:33:31.323] Served txpool_status                     reqid=13  t="88.286µs"
{
  pending: 1,
  queued: 0
}
> DEBUG[06-30|11:33:32.007] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=140 t="95.264µs"
DEBUG[06-30|11:33:33.012] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=141 t="94.134µs"
DEBUG[06-30|11:33:34.016] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=142 t="97.436µs"
DEBUG[06-30|11:33:35.018] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=143 t="49.954µs"
DEBUG[06-30|11:33:36.023] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=144 t="150.906µs"
DEBUG[06-30|11:33:37.028] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=145 t="67.668µs"
DEBUG[06-30|11:33:38.030] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=146 t="66.047µs"
DEBUG[06-30|11:33:39.029] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=147 t="44.679µs"
DEBUG[06-30|11:33:40.034] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=148 t="46.232µs"
> miner.DEBUG[06-30|11:33:41.036] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=149 t="48.384µs"
DEBUG[06-30|11:33:42.039] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=150 t="44.514µs"
> miner.minDEBUG[06-30|11:33:42.299] Current full block not old enough        number=911 hash="3c4822…b1a8c6" delay=90000
DEBUG[06-30|11:33:42.302] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
> miner.minerDEBUG[06-30|11:33:43.044] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=151 t="73.433µs"
> miner.minDEBUG[06-30|11:33:44.044] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=152 t="92.378µs"
> miner.starDEBUG[06-30|11:33:45.047] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=153 t="74.258µs"
> miner.start()DEBUG[06-30|11:33:46.050] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=154 t="66.965µs"
DEBUG[06-30|11:33:47.051] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=155 t="65.896µs"

INFO [06-30|11:33:47.670] Updated mining threads                   threads=16
INFO [06-30|11:33:47.670] Transaction pool price threshold updated price=1000000000
DEBUG[06-30|11:33:47.671] Served miner_start                       reqid=14  t="129.176µs"
null
> DEBUG[06-30|11:33:47.671] Committing new uncle to block            hash="bf71d9…5ecab5"
INFO [06-30|11:33:47.671] Commit new mining work                   number=912 sealhash="99175e…bba363" uncles=1 txs=0 gas=0     fees=0        elapsed="209.48µs"
INFO [06-30|11:33:47.671] Commit new mining work                   number=912 sealhash="b8f60f…f0b9d4" uncles=1 txs=1 gas=21000 fees=0.000861 elapsed="419.555µs"
INFO [06-30|11:33:47.874] Successfully sealed new block            number=912 sealhash="b8f60f…f0b9d4" hash="0c0eb4…22038b" elapsed=202.738ms
INFO [06-30|11:33:47.874] 🔨 mined potential block                  number=912 hash="0c0eb4…22038b"
DEBUG[06-30|11:33:47.874] Reinjecting stale transactions           count=0
INFO [06-30|11:33:47.874] Commit new mining work                   number=913 sealhash="cb227d…f01b5d" uncles=0 txs=0 gas=0     fees=0        elapsed="199.187µs"
INFO [06-30|11:33:48.003] Successfully sealed new block            number=913 sealhash="cb227d…f01b5d" hash="af009c…88daf3" elapsed=128.728ms
INFO [06-30|11:33:48.003] 🔨 mined potential block                  number=913 hash="af009c…88daf3"
DEBUG[06-30|11:33:48.003] Reinjecting stale transactions           count=0
INFO [06-30|11:33:48.003] Commit new mining work                   number=914 sealhash="4b6b67…c65caa" uncles=0 txs=0 gas=0     fees=0        elapsed="206.489µs"
DEBUG[06-30|11:33:48.052] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=156 t="815.258µs"
DEBUG[06-30|11:33:48.068] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=157 t="240.642µs"
DEBUG[06-30|11:33:48.091] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=158 t="170.963µs"
> miner.start()INFO [06-30|11:33:48.116] Successfully sealed new block            number=914 sealhash="4b6b67…c65caa" hash="019e85…4568ff" elapsed=112.735ms
INFO [06-30|11:33:48.116] Mining too far in the future             wait=2s
INFO [06-30|11:33:48.116] ⑂ block became an uncle                  number=907 hash="bf71d9…5ecab5"
DEBUG[06-30|11:33:48.116] Reinjecting stale transactions           count=0
INFO [06-30|11:33:48.116] 🔨 mined potential block                  number=914 hash="019e85…4568ff"
> admin.addPeer("enode://12e3f371bd9b74e19409d28b512281aae8d122df3212102728569dc06a8a1c086b92a4a95ab59c3059cebb76c7c141d0b0d91c7d220dfca723f175f27c6ce889@127.0.0.1:30304?discport=0")DEBUG[06-30|11:33:49.055] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=159 t="728.811µs"
DEBUG[06-30|11:33:49.056] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=160 t="155.254µs"
> miner.stop()DEBUG[06-30|11:33:50.059] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=162 t="482.726µs"
DEBUG[06-30|11:33:50.061] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=163 t="115.221µs"
> miner.stop()\INFO [06-30|11:33:50.120] Commit new mining work                   number=915 sealhash="456fef…af232b" uncles=0 txs=0 gas=0     fees=0        elapsed=2.004s
INFO [06-30|11:33:50.203] Successfully sealed new block            number=915 sealhash="456fef…af232b" hash="2b6e2f…2a19c8" elapsed=82.388ms
INFO [06-30|11:33:50.203] 😱 block lost                             number=908 hash="937e09…eca6f9"
INFO [06-30|11:33:50.203] 🔨 mined potential block                  number=915 hash="2b6e2f…2a19c8"
DEBUG[06-30|11:33:50.203] Reinjecting stale transactions           count=0
INFO [06-30|11:33:50.203] Commit new mining work                   number=916 sealhash="7a13eb…baa59e" uncles=0 txs=0 gas=0     fees=0        elapsed="136.534µs"
DEBUG[06-30|11:33:50.290] Transaction pool status report           executable=0 queued=0 stales=0
INFO [06-30|11:33:50.294] Successfully sealed new block            number=916 sealhash="7a13eb…baa59e" hash="0e88e1…45f069" elapsed=91.577ms
INFO [06-30|11:33:50.294] 🔨 mined potential block                  number=916 hash="0e88e1…45f069"
DEBUG[06-30|11:33:50.295] Reinjecting stale transactions           count=0
INFO [06-30|11:33:50.295] Mining too far in the future             wait=2s

SyntaxError: (anonymous): Line 1:13 Unexpected token ILLEGAL
> DEBUG[06-30|11:33:51.061] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=165 t="532.44µs"
DEBUG[06-30|11:33:51.062] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=166 t="137.516µs"
DEBUG[06-30|11:33:51.063] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=167 t="124.827µs"
> miner.start()DEBUG[06-30|11:33:52.063] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=168 t="482.958µs"
DEBUG[06-30|11:33:52.064] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=169 t="111.223µs"
DEBUG[06-30|11:33:52.066] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=170 t="129.138µs"
> miner.stop()\INFO [06-30|11:33:52.296] Commit new mining work                   number=917 sealhash="1ef184…21456a" uncles=0 txs=0 gas=0     fees=0        elapsed=2.001s
INFO [06-30|11:33:52.353] Successfully sealed new block            number=917 sealhash="1ef184…21456a" hash="c3d67c…929d24" elapsed=57.125ms
INFO [06-30|11:33:52.353] 🔨 mined potential block                  number=917 hash="c3d67c…929d24"
DEBUG[06-30|11:33:52.353] Reinjecting stale transactions           count=0
INFO [06-30|11:33:52.353] Commit new mining work                   number=918 sealhash="ec9797…1266a1" uncles=0 txs=0 gas=0     fees=0        elapsed="139.637µs"
INFO [06-30|11:33:52.402] Successfully sealed new block            number=918 sealhash="ec9797…1266a1" hash="cfbfee…d4017c" elapsed=49.250ms
INFO [06-30|11:33:52.402] 🔨 mined potential block                  number=918 hash="cfbfee…d4017c"
INFO [06-30|11:33:52.402] Mining too far in the future             wait=2s
DEBUG[06-30|11:33:52.402] Reinjecting stale transactions           count=0
> miner.stop()
DEBUG[06-30|11:33:52.926] Served miner_stop                        reqid=15  t="24.561µs"
null
> DEBUG[06-30|11:33:53.067] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=171 t="274.969µs"
DEBUG[06-30|11:33:53.068] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=172 t="85.433µs"
DEBUG[06-30|11:33:53.069] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=173 t="68.582µs"
INFO [06-30|11:33:53.387] Looking for peers                        peercount=1 tried=1 static=1
DEBUG[06-30|11:33:54.068] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=174 t="281.367µs"
DEBUG[06-30|11:33:54.068] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=175 t="70.851µs"
DEBUG[06-30|11:33:54.069] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=176 t="78.42µs"
DEBUG[06-30|11:33:55.072] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=177 t="278.243µs"
DEBUG[06-30|11:33:55.072] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=178 t="70.964µs"
DEBUG[06-30|11:33:55.073] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=179 t="68.79µs"
DEBUG[06-30|11:33:56.074] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=180 t="271.775µs"
DEBUG[06-30|11:33:56.075] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=181 t="68.286µs"
DEBUG[06-30|11:33:56.075] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=182 t="71.126µs"
DEBUG[06-30|11:33:57.081] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=183 t="592.914µs"
DEBUG[06-30|11:33:57.082] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=184 t="118.964µs"
DEBUG[06-30|11:33:57.083] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=185 t="90.615µs"
DEBUG[06-30|11:33:58.084] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=186 t="698.946µs"
DEBUG[06-30|11:33:58.086] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=187 t="118.236µs"
DEBUG[06-30|11:33:58.088] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=188 t="56.57µs"
DEBUG[06-30|11:33:59.090] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=189 t="694.585µs"
DEBUG[06-30|11:33:59.091] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=190 t="111.269µs"
DEBUG[06-30|11:33:59.092] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=191 t="53.041µs"
DEBUG[06-30|11:34:00.092] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=192 t="470.33µs"
DEBUG[06-30|11:34:00.093] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=193 t="119.258µs"
DEBUG[06-30|11:34:00.094] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=194 t="56.457µs"
DEBUG[06-30|11:34:01.095] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=195 t="309.797µs"
DEBUG[06-30|11:34:01.096] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=196 t="80.575µs"
DEBUG[06-30|11:34:01.097] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=197 t="46.044µs"
DEBUG[06-30|11:34:02.102] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=198 t="472.78µs"
DEBUG[06-30|11:34:02.103] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=199 t="118.876µs"
DEBUG[06-30|11:34:02.104] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=200 t="53.024µs"
DEBUG[06-30|11:34:02.304] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:34:03.103] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=201 t="298.499µs"
DEBUG[06-30|11:34:03.105] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=202 t="100.903µs"
DEBUG[06-30|11:34:03.106] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=203 t="49.382µs"
DEBUG[06-30|11:34:04.107] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=204 t="293.581µs"
DEBUG[06-30|11:34:04.108] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=205 t="74.797µs"
DEBUG[06-30|11:34:04.109] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=206 t="43.996µs"
DEBUG[06-30|11:34:05.110] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=207 t="275.94µs"
DEBUG[06-30|11:34:05.111] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=208 t="66.362µs"
DEBUG[06-30|11:34:05.112] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=209 t="41.165µs"
DEBUG[06-30|11:34:06.114] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=210 t="274.118µs"
DEBUG[06-30|11:34:06.115] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=211 t="66.539µs"
DEBUG[06-30|11:34:06.116] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=212 t="41.519µs"
DEBUG[06-30|11:34:07.120] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=213 t="276.627µs"
DEBUG[06-30|11:34:07.121] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=214 t="70.845µs"
DEBUG[06-30|11:34:07.121] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=215 t="40.569µs"
DEBUG[06-30|11:34:08.123] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=216 t="358.233µs"
DEBUG[06-30|11:34:08.124] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=217 t="93.6µs"
DEBUG[06-30|11:34:08.125] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=218 t="55.36µs"
DEBUG[06-30|11:34:09.127] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=219 t="278.516µs"
DEBUG[06-30|11:34:09.128] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=220 t="67.057µs"
DEBUG[06-30|11:34:09.128] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=221 t="50.265µs"
DEBUG[06-30|11:34:10.130] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=222 t="708.879µs"
DEBUG[06-30|11:34:10.131] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=223 t="115.214µs"
DEBUG[06-30|11:34:10.133] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=224 t="53.237µs"
DEBUG[06-30|11:34:11.132] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=225 t="709.661µs"
DEBUG[06-30|11:34:11.133] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=226 t="139.237µs"
DEBUG[06-30|11:34:11.135] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=227 t="82.37µs"
> etDEBUG[06-30|11:34:12.136] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=228 t="387.636µs"
DEBUG[06-30|11:34:12.137] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=229 t="99.559µs"
DEBUG[06-30|11:34:12.139] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=230 t="51.083µs"
> eth.bDEBUG[06-30|11:34:13.139] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=231 t="469.19µs"
DEBUG[06-30|11:34:13.141] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=232 t="140.715µs"
DEBUG[06-30|11:34:13.142] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=233 t="51.017µs"
> eth.blockcDEBUG[06-30|11:34:14.141] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=234 t="503.531µs"
DEBUG[06-30|11:34:14.142] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=235 t="110.791µs"
DEBUG[06-30|11:34:14.143] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=236 t="53.083µs"
> eth.blockNumbeDEBUG[06-30|11:34:15.145] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=237 t="478.73µs"
DEBUG[06-30|11:34:15.147] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=238 t="117.849µs"
DEBUG[06-30|11:34:15.148] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=239 t="55.554µs"
> eth.blockNumber
DEBUG[06-30|11:34:15.504] Served eth_blockNumber                   reqid=16  t="31.462µs"
918
> DEBUG[06-30|11:34:16.150] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=240 t="380.866µs"
DEBUG[06-30|11:34:16.151] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=241 t="98.143µs"
DEBUG[06-30|11:34:16.152] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=242 t="53.418µs"
> ethDEBUG[06-30|11:34:17.155] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=243 t="473.799µs"
DEBUG[06-30|11:34:17.156] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=244 t="92.668µs"
DEBUG[06-30|11:34:17.157] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=245 t="53.123µs"
> eth.DEBUG[06-30|11:34:18.158] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=246 t="308.451µs"
DEBUG[06-30|11:34:18.159] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=247 t="79.073µs"
DEBUG[06-30|11:34:18.160] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=248 t="44.643µs"
> eth.getTDEBUG[06-30|11:34:19.161] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=249 t="375.006µs"
DEBUG[06-30|11:34:19.162] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=250 t="91.859µs"
DEBUG[06-30|11:34:19.163] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=251 t="51.319µs"
> eth.getTrnDEBUG[06-30|11:34:20.167] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=252 t="519.95µs"
DEBUG[06-30|11:34:20.168] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=253 t="121.364µs"
DEBUG[06-30|11:34:20.169] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=254 t="98.377µs"
> eth.getTransactiDEBUG[06-30|11:34:21.168] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=255 t="719.692µs"
DEBUG[06-30|11:34:21.169] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=256 t="117.55µs"
DEBUG[06-30|11:34:21.171] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=257 t="55.324µs"
> eth.getTransaction(DEBUG[06-30|11:34:22.169] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=258 t="370.112µs"
DEBUG[06-30|11:34:22.170] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=259 t="92.965µs"
DEBUG[06-30|11:34:22.171] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=260 t="54.581µs"
DEBUG[06-30|11:34:22.305] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:34:23.172] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=261 t="468.671µs"
DEBUG[06-30|11:34:23.174] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=262 t="90.276µs"
DEBUG[06-30|11:34:23.174] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=263 t="53.915µs"
DEBUG[06-30|11:34:24.177] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=264 t="469.376µs"
DEBUG[06-30|11:34:24.179] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=265 t="117.836µs"
DEBUG[06-30|11:34:24.180] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=266 t="54.467µs"
DEBUG[06-30|11:34:25.177] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=267 t="717.288µs"
DEBUG[06-30|11:34:25.179] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=268 t="119.983µs"
DEBUG[06-30|11:34:25.180] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=269 t="67.064µs"
DEBUG[06-30|11:34:26.179] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=270 t="313.403µs"
DEBUG[06-30|11:34:26.180] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=271 t="78.646µs"
DEBUG[06-30|11:34:26.181] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=272 t="48.529µs"
DEBUG[06-30|11:34:27.183] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=273 t="743.572µs"
DEBUG[06-30|11:34:27.185] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=274 t="122.491µs"
DEBUG[06-30|11:34:27.187] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=275 t="57.648µs"
DEBUG[06-30|11:34:28.183] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=276 t="750.222µs"
DEBUG[06-30|11:34:28.185] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=277 t="120.165µs"
DEBUG[06-30|11:34:28.186] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=278 t="66.677µs"
> eth.getTransaction("0x9e80f8f1ea1a99efdf4d9464e3b325e55d84dda79c85bebf5a34f3225f64fc58"DEBUG[06-30|11:34:29.187] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=279 t="704.173µs"
DEBUG[06-30|11:34:29.188] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=280 t="120.612µs"
DEBUG[06-30|11:34:29.189] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=281 t="65.743µs"
> eth.getTransaction("0x9e80f8f1ea1a99efdf4d9464e3b325e55d84dda79c85bebf5a34f3225f64fc58")
DEBUG[06-30|11:34:29.628] Served eth_getTransactionByHash          reqid=17  t="513.11µs"
{
  blockHash: "0x0c0eb4c7ff309304e6ad62b6eb12442cff995b375924040f528864d30c22038b",
  blockNumber: 912,
  from: "0x2ecb718297080ff730269176e42c8278aa193434",
  gas: 200000,
  gasPrice: 41000000000,
  hash: "0x9e80f8f1ea1a99efdf4d9464e3b325e55d84dda79c85bebf5a34f3225f64fc58",
  input: "0x",
  nonce: 4,
  r: "0xe6a36d932f6cdfe293c46b72218404c5871d12917f63ca85f6204ebe698524f6",
  s: "0x771a211ed521206286336a0d58df9eec90e0b36ea80d306797c7c21af94423b7",
  to: "0x2ecb718297080ff730269176e42c8278aa193434",
  transactionIndex: 0,
  v: "0x3c4a4",
  value: 1000000000000000
}
> DEBUG[06-30|11:34:30.190] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=282 t="465.933µs"
DEBUG[06-30|11:34:30.191] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=283 t="117.675µs"
DEBUG[06-30|11:34:30.192] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=284 t="56.698µs"
DEBUG[06-30|11:34:31.194] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=285 t="705.814µs"
DEBUG[06-30|11:34:31.195] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=286 t="117.809µs"
DEBUG[06-30|11:34:31.197] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=287 t="70.093µs"
DEBUG[06-30|11:34:32.195] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=288 t="275.828µs"
DEBUG[06-30|11:34:32.196] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=289 t="76.422µs"
DEBUG[06-30|11:34:32.197] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=290 t="43.291µs"
DEBUG[06-30|11:34:33.198] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=291 t="380.658µs"
DEBUG[06-30|11:34:33.199] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=292 t="87.741µs"
DEBUG[06-30|11:34:33.200] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=293 t="58.846µs"
DEBUG[06-30|11:34:34.199] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=294 t="698.522µs"
DEBUG[06-30|11:34:34.200] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=295 t="116.54µs"
DEBUG[06-30|11:34:34.202] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=296 t="58.358µs"
DEBUG[06-30|11:34:35.201] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=297 t="332.825µs"
DEBUG[06-30|11:34:35.202] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=298 t="82.299µs"
DEBUG[06-30|11:34:35.203] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=299 t="50.164µs"
DEBUG[06-30|11:34:36.205] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=300 t="501.546µs"
DEBUG[06-30|11:34:36.207] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=301 t="130.389µs"
DEBUG[06-30|11:34:36.208] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=302 t="67.909µs"
DEBUG[06-30|11:34:37.210] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=303 t="708.434µs"
DEBUG[06-30|11:34:37.212] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=304 t="120.166µs"
DEBUG[06-30|11:34:37.213] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=305 t="68.866µs"
DEBUG[06-30|11:34:38.214] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=306 t="288.102µs"
DEBUG[06-30|11:34:38.214] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=307 t="71.775µs"
DEBUG[06-30|11:34:38.215] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=308 t="44.17µs"
DEBUG[06-30|11:34:39.218] Served eth_getTransactionReceipt         conn=127.0.0.1:50346 reqid=309 t="474.657µs"
DEBUG[06-30|11:34:39.220] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=310 t="121.661µs"
DEBUG[06-30|11:34:39.221] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=311 t="52.168µs"
> exiDEBUG[06-30|11:34:40.222] Served eth_getTransactionReceipt         conn=127.0.0.1:50345 reqid=312 t="471.299µs"
DEBUG[06-30|11:34:40.223] Served eth_getBlockByNumber              conn=127.0.0.1:50346 reqid=313 t="116.333µs"
DEBUG[06-30|11:34:40.224] Served eth_getBlockByNumber              conn=127.0.0.1:50345 reqid=314 t="53.879µs"
> exit

Geth log from the node that does not receive transaction: 

INFO [06-30|11:31:55.894] Starting Geth on Ethereum mainnet... 
INFO [06-30|11:31:55.895] Bumping default cache on mainnet         provided=1024 updated=4096
DEBUG[06-30|11:31:55.895] Sanitizing Go's GC trigger               percent=25
INFO [06-30|11:31:55.896] Maximum peer count                       ETH=50 LES=0 total=50
DEBUG[06-30|11:31:55.896] FS scan times                            list="108.415µs" set="4.892µs" diff="3.637µs"
INFO [06-30|11:31:55.909] Starting peer-to-peer node               instance=Geth/v1.9.15-stable-0f77f34b/darwin-amd64/go1.14.2
INFO [06-30|11:31:55.909] Allocated trie memory caches             clean=614.00MiB dirty=1024.00MiB
INFO [06-30|11:31:55.909] Allocated cache and file handles         database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_talker/geth/chaindata cache=2.00GiB handles=5120
DEBUG[06-30|11:31:55.970] Chain freezer table opened               database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_talker/geth/chaindata/ancient table=bodies items=0 size=0.00B
DEBUG[06-30|11:31:55.970] Chain freezer table opened               database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_talker/geth/chaindata/ancient table=receipts items=0 size=0.00B
DEBUG[06-30|11:31:55.970] Chain freezer table opened               database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_talker/geth/chaindata/ancient table=diffs    items=0 size=0.00B
DEBUG[06-30|11:31:55.970] Chain freezer table opened               database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_talker/geth/chaindata/ancient table=headers  items=0 size=0.00B
DEBUG[06-30|11:31:55.970] Chain freezer table opened               database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_talker/geth/chaindata/ancient table=hashes   items=0 size=0.00B
INFO [06-30|11:31:55.970] Opened ancient database                  database=/Users/troublor/workspace/dArcher/augur/blockchain/v1_talker/geth/chaindata/ancient
DEBUG[06-30|11:31:55.970] Current full block not old enough        number=906 hash="0e8c68…75381a" delay=90000
INFO [06-30|11:31:55.971] Initialised chain configuration          config="{ChainID: 123456 Homestead: 0 DAO: <nil> DAOSupport: false EIP150: 0 EIP155: 0 EIP158: 0 Byzantium: 0 Constantinople: 0 Petersburg: 0 Istanbul: 0, Muir Glacier: 0, YOLO v1: <nil>, Engine: unknown}"
INFO [06-30|11:31:55.971] Disk storage enabled for ethash caches   dir=/Users/troublor/workspace/dArcher/augur/blockchain/v1_talker/geth/ethash count=3
INFO [06-30|11:31:55.971] Disk storage enabled for ethash DAGs     dir=/Users/troublor/Library/Ethash count=2
INFO [06-30|11:31:55.971] Initialising Ethereum protocol           versions="[65 64 63]" network=1 dbversion=7
INFO [06-30|11:31:55.971] Loaded most recent local header          number=906 hash="0e8c68…75381a" td=124906966 age=35m17s
INFO [06-30|11:31:55.971] Loaded most recent local full block      number=906 hash="0e8c68…75381a" td=124906966 age=35m17s
INFO [06-30|11:31:55.971] Loaded most recent local fast block      number=906 hash="0e8c68…75381a" td=124906966 age=35m17s
DEBUG[06-30|11:31:55.971] Reinjecting stale transactions           count=0
INFO [06-30|11:31:55.971] Loaded local transaction journal         transactions=0 dropped=0
INFO [06-30|11:31:55.972] Regenerated local transaction journal    transactions=0 accounts=0
WARN [06-30|11:31:55.972] Switch sync mode from fast sync to full sync 
DEBUG[06-30|11:31:55.972] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:31:56.014] TCP listener up                          addr=[::]:30304
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=admin
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=admin
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=debug
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=web3
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=eth
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=eth
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=eth
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=txpool
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=debug
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=debug
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=eth
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=personal
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=eth
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=ethash
INFO [06-30|11:31:56.015] New local node record                    seq=52 id=91cdb35a77727fcf ip=127.0.0.1 udp=0 tcp=30304
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=eth
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=eth
INFO [06-30|11:31:56.015] Started P2P networking                   self="enode://12e3f371bd9b74e19409d28b512281aae8d122df3212102728569dc06a8a1c086b92a4a95ab59c3059cebb76c7c141d0b0d91c7d220dfca723f175f27c6ce889@127.0.0.1:30304?discport=0"
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=eth
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=miner
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=eth
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=admin
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=debug
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=debug
DEBUG[06-30|11:31:56.015] InProc registered                        namespace=net
DEBUG[06-30|11:31:56.015] IPC registered                           namespace=admin
DEBUG[06-30|11:31:56.015] IPC registered                           namespace=admin
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=debug
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=web3
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=eth
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=eth
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=eth
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=txpool
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=debug
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=debug
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=eth
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=personal
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=eth
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=ethash
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=eth
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=eth
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=eth
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=miner
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=eth
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=admin
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=debug
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=debug
DEBUG[06-30|11:31:56.016] IPC registered                           namespace=net
INFO [06-30|11:31:56.016] IPC endpoint opened                      url=/Users/troublor/workspace/dArcher/augur/blockchain/v1_talker/geth.ipc
DEBUG[06-30|11:31:56.050] Served rpc_modules                       reqid=1 t="46.004µs"
DEBUG[06-30|11:31:56.052] Served web3_clientVersion                reqid=2 t="18.656µs"
INFO [06-30|11:31:56.052] Etherbase automatically configured       address=0x2ecB718297080fF730269176E42C8278aA193434
DEBUG[06-30|11:31:56.052] Served eth_coinbase                      reqid=3 t="53.449µs"
DEBUG[06-30|11:31:56.052] Served eth_blockNumber                   reqid=4 t="17.148µs"
DEBUG[06-30|11:31:56.052] Served eth_blockNumber                   reqid=5 t="9.095µs"
DEBUG[06-30|11:31:56.053] Served eth_getBlockByNumber              reqid=6 t="149.613µs"
DEBUG[06-30|11:31:56.053] Served admin_datadir                     reqid=7 t="11.784µs"
DEBUG[06-30|11:31:56.053] Served rpc_modules                       reqid=8 t="13.259µs"
Welcome to the Geth JavaScript console!

instance: Geth/v1.9.15-stable-0f77f34b/darwin-amd64/go1.14.2
coinbase: 0x2ecb718297080ff730269176e42c8278aa193434
at block: 906 (Tue Jun 30 2020 10:56:38 GMT+0800 (HKT))
 datadir: /Users/troublor/workspace/dArcher/augur/blockchain/v1_talker
 modules: admin:1.0 debug:1.0 eth:1.0 ethash:1.0 miner:1.0 net:1.0 personal:1.0 rpc:1.0 txpool:1.0 web3:1.0

> DEBUG[06-30|11:31:58.116] Couldn't add port mapping                proto=tcp extport=30304 intport=30304 interface="UPnP or NAT-PMP" err="no UPnP or NAT-PMP router discovered"
DEBUG[06-30|11:32:15.973] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:32:35.973] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
> miner.startDEBUG[06-30|11:32:55.974] Current full block not old enough        number=906 hash="0e8c68…75381a" delay=90000
DEBUG[06-30|11:32:55.974] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
> miner.start()
INFO [06-30|11:32:56.740] Updated mining threads                   threads=16
INFO [06-30|11:32:56.740] Transaction pool price threshold updated price=1000000000
DEBUG[06-30|11:32:56.740] Served miner_start                       reqid=9 t="163.454µs"
null
> INFO [06-30|11:32:56.740] Commit new mining work                   number=907 sealhash="28147e…4ac7c7" uncles=0 txs=0 gas=0 fees=0 elapsed="256.51µs"
DEBUG[06-30|11:32:56.741] Loaded old ethash dataset from disk      epoch=0
DEBUG[06-30|11:32:56.741] Loaded old ethash dataset from disk      epoch=1
INFO [06-30|11:32:56.836] Successfully sealed new block            number=907 sealhash="28147e…4ac7c7" hash="b44028…6d098e" elapsed=95.354ms
INFO [06-30|11:32:56.836] 🔨 mined potential block                  number=907 hash="b44028…6d098e"
DEBUG[06-30|11:32:56.836] Reinjecting stale transactions           count=0
INFO [06-30|11:32:56.836] Commit new mining work                   number=908 sealhash="3e8304…439780" uncles=0 txs=0 gas=0 fees=0 elapsed="146.839µs"
INFO [06-30|11:32:57.094] Successfully sealed new block            number=908 sealhash="3e8304…439780" hash="8abf87…b0036f" elapsed=257.766ms
INFO [06-30|11:32:57.094] 🔨 mined potential block                  number=908 hash="8abf87…b0036f"
DEBUG[06-30|11:32:57.094] Reinjecting stale transactions           count=0
INFO [06-30|11:32:57.094] Commit new mining work                   number=909 sealhash="3bae0e…1f75c6" uncles=0 txs=0 gas=0 fees=0 elapsed="178.447µs"
INFO [06-30|11:32:57.413] Successfully sealed new block            number=909 sealhash="3bae0e…1f75c6" hash="540877…7c4475" elapsed=319.081ms
INFO [06-30|11:32:57.413] 🔨 mined potential block                  number=909 hash="540877…7c4475"
INFO [06-30|11:32:57.413] Mining too far in the future             wait=2s
DEBUG[06-30|11:32:57.413] Reinjecting stale transactions           count=0
> miner.stop(INFO [06-30|11:32:59.414] Commit new mining work                   number=910 sealhash="816334…ac5ea0" uncles=0 txs=0 gas=0 fees=0 elapsed=2.000s
> miner.stop()INFO [06-30|11:32:59.622] Successfully sealed new block            number=910 sealhash="816334…ac5ea0" hash="389d24…91081a" elapsed=207.961ms
INFO [06-30|11:32:59.622] 🔨 mined potential block                  number=910 hash="389d24…91081a"
DEBUG[06-30|11:32:59.622] Reinjecting stale transactions           count=0
INFO [06-30|11:32:59.622] Commit new mining work                   number=911 sealhash="a1c4d0…f6c557" uncles=0 txs=0 gas=0 fees=0 elapsed="153.249µs"
INFO [06-30|11:32:59.660] Successfully sealed new block            number=911 sealhash="a1c4d0…f6c557" hash="3c4822…b1a8c6" elapsed=38.130ms
INFO [06-30|11:32:59.660] 🔨 mined potential block                  number=911 hash="3c4822…b1a8c6"
INFO [06-30|11:32:59.660] Mining too far in the future             wait=2s
DEBUG[06-30|11:32:59.660] Reinjecting stale transactions           count=0

DEBUG[06-30|11:32:59.740] Served miner_stop                        reqid=10 t="28.975µs"
null
> DEBUG[06-30|11:33:15.975] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:33:18.386] Adding p2p peer                          peercount=1 id=89a46879ef9aeac4 conn=inbound addr=127.0.0.1:50350 name=Geth/v1.9.15-stable-...
INFO [06-30|11:33:18.386] Looking for peers                        peercount=1 tried=0 static=0
DEBUG[06-30|11:33:18.386] Ethereum peer connected                  id=89a46879ef9aeac4 conn=inbound name=Geth/v1.9.15-stable-0f77f34b/darwin-amd64/go1.14.2
DEBUG[06-30|11:33:23.978] Transaction pool status report           executable=1 queued=0 stales=0
DEBUG[06-30|11:33:35.976] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:33:47.874] Queued propagated block                  peer=89a46879ef9aeac4 number=912 hash="0c0eb4…22038b" queued=1
DEBUG[06-30|11:33:47.874] Importing propagated block               peer=89a46879ef9aeac4 number=912 hash="0c0eb4…22038b"
DEBUG[06-30|11:33:47.874] Loaded old ethash cache from disk        epoch=0
DEBUG[06-30|11:33:47.874] Loaded old ethash cache from disk        epoch=1
DEBUG[06-30|11:33:47.896] Inserted new block                       number=912 hash="0c0eb4…22038b" uncles=1 txs=1 gas=21000 elapsed="536.775µs" root="50e14b…065957"
INFO [06-30|11:33:47.896] Imported new chain segment               blocks=1 txs=1 mgas=0.021 elapsed=10.454ms    mgasps=2.009 number=912 hash="0c0eb4…22038b" dirty=10.10KiB
DEBUG[06-30|11:33:47.897] Reinjecting stale transactions           count=0
DEBUG[06-30|11:33:47.975] Transaction pool status report           executable=0 queued=0 stales=0
DEBUG[06-30|11:33:48.003] Queued propagated block                  peer=89a46879ef9aeac4 number=913 hash="af009c…88daf3" queued=1
DEBUG[06-30|11:33:48.003] Importing propagated block               peer=89a46879ef9aeac4 number=913 hash="af009c…88daf3"
DEBUG[06-30|11:33:48.013] Inserted new block                       number=913 hash="af009c…88daf3" uncles=0 txs=0 gas=0     elapsed="314.497µs" root="2d5057…cf5daf"
INFO [06-30|11:33:48.013] Imported new chain segment               blocks=1 txs=0 mgas=0.000 elapsed=5.088ms     mgasps=0.000 number=913 hash="af009c…88daf3" dirty=11.79KiB
DEBUG[06-30|11:33:48.013] Reinjecting stale transactions           count=0
DEBUG[06-30|11:33:48.116] Queued propagated block                  peer=89a46879ef9aeac4 number=914 hash="019e85…4568ff" queued=1
DEBUG[06-30|11:33:48.116] Importing propagated block               peer=89a46879ef9aeac4 number=914 hash="019e85…4568ff"
DEBUG[06-30|11:33:48.123] Inserted new block                       number=914 hash="019e85…4568ff" uncles=0 txs=0 gas=0     elapsed="237.481µs" root="0f971a…52bf42"
INFO [06-30|11:33:48.123] Imported new chain segment               blocks=1 txs=0 mgas=0.000 elapsed=3.018ms     mgasps=0.000 number=914 hash="019e85…4568ff" dirty=13.47KiB
INFO [06-30|11:33:48.123] Mining too far in the future             wait=2s
DEBUG[06-30|11:33:48.123] Reinjecting stale transactions           count=0
DEBUG[06-30|11:33:50.203] Queued propagated block                  peer=89a46879ef9aeac4 number=915 hash="2b6e2f…2a19c8" queued=1
DEBUG[06-30|11:33:50.203] Importing propagated block               peer=89a46879ef9aeac4 number=915 hash="2b6e2f…2a19c8"
DEBUG[06-30|11:33:50.217] Inserted new block                       number=915 hash="2b6e2f…2a19c8" uncles=0 txs=0 gas=0     elapsed="327.704µs" root="ccf9d7…c26889"
INFO [06-30|11:33:50.218] Imported new chain segment               blocks=1 txs=0 mgas=0.000 elapsed=9.057ms     mgasps=0.000 number=915 hash="2b6e2f…2a19c8" dirty=15.15KiB
DEBUG[06-30|11:33:50.218] Reinjecting stale transactions           count=0
DEBUG[06-30|11:33:50.295] Queued propagated block                  peer=89a46879ef9aeac4 number=916 hash="0e88e1…45f069" queued=1
DEBUG[06-30|11:33:50.295] Importing propagated block               peer=89a46879ef9aeac4 number=916 hash="0e88e1…45f069"
DEBUG[06-30|11:33:50.300] Inserted new block                       number=916 hash="0e88e1…45f069" uncles=0 txs=0 gas=0     elapsed="186.542µs" root="5213d1…bb5ca4"
INFO [06-30|11:33:50.300] Imported new chain segment               blocks=1 txs=0 mgas=0.000 elapsed=2.389ms     mgasps=0.000 number=916 hash="0e88e1…45f069" dirty=16.84KiB
INFO [06-30|11:33:50.300] Mining too far in the future             wait=2s
DEBUG[06-30|11:33:50.300] Reinjecting stale transactions           count=0
DEBUG[06-30|11:33:52.353] Queued propagated block                  peer=89a46879ef9aeac4 number=917 hash="c3d67c…929d24" queued=1
DEBUG[06-30|11:33:52.353] Importing propagated block               peer=89a46879ef9aeac4 number=917 hash="c3d67c…929d24"
DEBUG[06-30|11:33:52.363] Inserted new block                       number=917 hash="c3d67c…929d24" uncles=0 txs=0 gas=0     elapsed="340.43µs"  root="762aa2…6c0ee8"
INFO [06-30|11:33:52.363] Imported new chain segment               blocks=1 txs=0 mgas=0.000 elapsed=4.737ms     mgasps=0.000 number=917 hash="c3d67c…929d24" dirty=18.52KiB
DEBUG[06-30|11:33:52.363] Reinjecting stale transactions           count=0
DEBUG[06-30|11:33:52.403] Queued propagated block                  peer=89a46879ef9aeac4 number=918 hash="cfbfee…d4017c" queued=1
DEBUG[06-30|11:33:52.403] Importing propagated block               peer=89a46879ef9aeac4 number=918 hash="cfbfee…d4017c"
DEBUG[06-30|11:33:52.408] Inserted new block                       number=918 hash="cfbfee…d4017c" uncles=0 txs=0 gas=0     elapsed="220.223µs" root="d68217…663a61"
INFO [06-30|11:33:52.408] Imported new chain segment               blocks=1 txs=0 mgas=0.000 elapsed=2.329ms     mgasps=0.000 number=918 hash="cfbfee…d4017c" dirty=20.20KiB
INFO [06-30|11:33:52.408] Mining too far in the future             wait=2s
DEBUG[06-30|11:33:52.408] Reinjecting stale transactions           count=0
DEBUG[06-30|11:33:55.976] Current full block not old enough        number=918 hash="cfbfee…d4017c" delay=90000
DEBUG[06-30|11:33:55.977] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:34:15.978] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:34:35.978] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:34:40.589] Ethereum message handling failed         id=89a46879ef9aeac4 conn=inbound err=EOF
DEBUG[06-30|11:34:40.589] Removing Ethereum peer                   peer=89a46879ef9aeac4
DEBUG[06-30|11:34:40.589] Removing p2p peer                        peercount=0 id=89a46879ef9aeac4 duration=1m22.200s req=true err="client quitting"
INFO [06-30|11:34:40.589] Looking for peers                        peercount=0 tried=0 static=0
DEBUG[06-30|11:34:55.978] Current full block not old enough        number=918 hash="cfbfee…d4017c" delay=90000
DEBUG[06-30|11:34:55.979] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:35:15.980] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:35:35.982] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:35:55.980] Current full block not old enough        number=918 hash="cfbfee…d4017c" delay=90000
DEBUG[06-30|11:35:55.983] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:36:15.985] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:36:35.986] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:36:55.981] Current full block not old enough        number=918 hash="cfbfee…d4017c" delay=90000
DEBUG[06-30|11:36:55.987] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:37:15.989] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:37:35.990] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:37:55.984] Current full block not old enough        number=918 hash="cfbfee…d4017c" delay=90000
DEBUG[06-30|11:37:55.992] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s
DEBUG[06-30|11:38:15.995] Recalculated downloader QoS values       rtt=20s confidence=1.000 ttl=1m0s

Output from web3.js:

0x9e80f8f1ea1a99efdf4d9464e3b325e55d84dda79c85bebf5a34f3225f64fc58
confirmNumber 0
confirmNumber 1
confirmNumber 2
confirmNumber 3
confirmNumber 4
confirmNumber 5
confirmNumber 6
confirmNumber 7
confirmNumber 8
confirmNumber 9
confirmNumber 10
confirmNumber 11
GregTheGreek commented 4 years ago

thanks! I believe the culprit is here, will look into this.

github-actions[bot] commented 4 years ago

This issue has been automatically marked as stale because it has not had recent activity. It will be closed in 7 days if no further activity occurs. Thank you for your contributions. If you believe this was a mistake, please comment.

Troublor commented 4 years ago

@GregTheGreek Do we have a test case that can reproduce this bug now?

GregTheGreek commented 4 years ago

@Troublor thanks for bumping this - there was a previous outside contributor working on this but i think they had stopped.

Going to re-prioritise this.

cc: @frankiebee @spacesailor24

github-actions[bot] commented 3 years ago

This issue has been automatically marked as stale because it has not had recent activity. It will be closed in 7 days if no further activity occurs. Thank you for your contributions. If you believe this was a mistake, please comment.