Skip to content

Instantly share code, notes, and snippets.

Embed
What would you like to do?
test 2017-11-28 18:24:11.531000 TestFramework (INFO): Initializing test directory /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs
test 2017-11-28 18:24:11.651000 TestFramework.node0 (DEBUG): bitcoind started, waiting for RPC to come up
test 2017-11-28 18:24:11.655000 TestFramework.node1 (DEBUG): bitcoind started, waiting for RPC to come up
node0 2017-11-28 18:24:11.659838
node0 2017-11-28 18:24:11.660729 Bitcoin version v0.15.99.0-a89221873
node0 2017-11-28 18:24:11.660755 InitParameterInteraction: parameter interaction: -whitelistforcerelay=1 -> setting -whitelistrelay=1
node0 2017-11-28 18:24:11.660788 Validating signatures for all blocks.
node0 2017-11-28 18:24:11.660799 Setting nMinimumChainWork=0000000000000000000000000000000000000000000000000000000000000000
node0 2017-11-28 18:24:11.660850 Using the 'sse4' SHA256 implementation
node0 2017-11-28 18:24:11.660860 Using RdRand as an additional entropy source
node1 2017-11-28 18:24:11.662123
node1 2017-11-28 18:24:11.662920 Bitcoin version v0.15.99.0-a89221873
node1 2017-11-28 18:24:11.662945 InitParameterInteraction: parameter interaction: -whitelistforcerelay=1 -> setting -whitelistrelay=1
node1 2017-11-28 18:24:11.662981 Validating signatures for all blocks.
node1 2017-11-28 18:24:11.662992 Setting nMinimumChainWork=0000000000000000000000000000000000000000000000000000000000000000
node1 2017-11-28 18:24:11.663050 Using the 'sse4' SHA256 implementation
node1 2017-11-28 18:24:11.663067 Using RdRand as an additional entropy source
node0 2017-11-28 18:24:11.676045 Default data directory ########
node0 2017-11-28 18:24:11.676101 Using data directory /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node0/regtest
node0 2017-11-28 18:24:11.676170 Using config file /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node0/bitcoin.conf
node0 2017-11-28 18:24:11.676208 Using at most 125 automatic connections (283 file descriptors available)
node1 2017-11-28 18:24:11.678398 Default data directory ########
node1 2017-11-28 18:24:11.678449 Using data directory /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest
node1 2017-11-28 18:24:11.678512 Using config file /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/bitcoin.conf
node1 2017-11-28 18:24:11.678549 Using at most 125 automatic connections (283 file descriptors available)
node0 2017-11-28 18:24:11.688601 Using 16 MiB out of 32/2 requested for signature cache, able to store 524288 elements
node1 2017-11-28 18:24:11.690176 Using 16 MiB out of 32/2 requested for signature cache, able to store 524288 elements
node0 2017-11-28 18:24:11.701765 Using 16 MiB out of 32/2 requested for script execution cache, able to store 524288 elements
node0 2017-11-28 18:24:11.701847 Using 2 threads for script verification
node0 2017-11-28 18:24:11.702250 scheduler thread start
node0 2017-11-28 18:24:11.702858 Allowing HTTP connections from: 127.0.0.0/8 ::1/128
node0 2017-11-28 18:24:11.703271 Binding RPC on address ::1 port 16026
node1 2017-11-28 18:24:11.706197 Using 16 MiB out of 32/2 requested for script execution cache, able to store 524288 elements
node1 2017-11-28 18:24:11.706266 Using 2 threads for script verification
node1 2017-11-28 18:24:11.706441 scheduler thread start
node0 2017-11-28 18:24:11.706479 Binding RPC on address 127.0.0.1 port 16026
node0 2017-11-28 18:24:11.706563 Initialized HTTP server
node0 2017-11-28 18:24:11.706600 HTTP: creating work queue of depth 16
node0 2017-11-28 18:24:11.706628 Starting RPC
node0 2017-11-28 18:24:11.706669 Starting HTTP RPC server
node0 2017-11-28 18:24:11.706703 No rpcpassword set - using random cookie authentication
node1 2017-11-28 18:24:11.706873 Allowing HTTP connections from: 127.0.0.0/8 ::1/128
node1 2017-11-28 18:24:11.707182 Binding RPC on address ::1 port 16027
node0 2017-11-28 18:24:11.707205 Generated RPC authentication cookie /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node0/regtest/.cookie
node0 2017-11-28 18:24:11.707259 Registering HTTP handler for / (exactmatch 1)
node0 2017-11-28 18:24:11.707302 Registering HTTP handler for /wallet/ (exactmatch 0)
node0 2017-11-28 18:24:11.707347 Registering HTTP handler for /rest/tx/ (exactmatch 0)
node0 2017-11-28 18:24:11.707384 Registering HTTP handler for /rest/block/notxdetails/ (exactmatch 0)
node0 2017-11-28 18:24:11.707418 Registering HTTP handler for /rest/block/ (exactmatch 0)
node0 2017-11-28 18:24:11.707449 Registering HTTP handler for /rest/chaininfo (exactmatch 0)
node0 2017-11-28 18:24:11.707478 Registering HTTP handler for /rest/mempool/info (exactmatch 0)
node0 2017-11-28 18:24:11.707508 Registering HTTP handler for /rest/mempool/contents (exactmatch 0)
node0 2017-11-28 18:24:11.707538 Registering HTTP handler for /rest/headers/ (exactmatch 0)
node0 2017-11-28 18:24:11.707575 Registering HTTP handler for /rest/getutxos (exactmatch 0)
node0 2017-11-28 18:24:11.707607 Starting HTTP server
node0 2017-11-28 18:24:11.707637 HTTP: starting 4 worker threads
node0 2017-11-28 18:24:11.707712 Entering http event loop
node1 2017-11-28 18:24:11.708307 Binding RPC on address 127.0.0.1 port 16027
node1 2017-11-28 18:24:11.708390 Initialized HTTP server
node1 2017-11-28 18:24:11.708432 HTTP: creating work queue of depth 16
node1 2017-11-28 18:24:11.708472 Starting RPC
node1 2017-11-28 18:24:11.708518 Starting HTTP RPC server
node0 2017-11-28 18:24:11.708523 Using wallet directory /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node0/regtest/wallets
node1 2017-11-28 18:24:11.708554 No rpcpassword set - using random cookie authentication
node0 2017-11-28 18:24:11.708577 init message: Verifying wallet(s)...
node0 2017-11-28 18:24:11.708743 Using BerkeleyDB version Berkeley DB 4.8.30: (April 9, 2010)
node0 2017-11-28 18:24:11.708782 Using wallet wallet.dat
node0 2017-11-28 18:24:11.708995 CDBEnv::Open: LogDir=/var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node0/regtest/wallets/database ErrorFile=/var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node0/regtest/wallets/db.log
node1 2017-11-28 18:24:11.709056 Generated RPC authentication cookie /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/.cookie
node1 2017-11-28 18:24:11.709106 Registering HTTP handler for / (exactmatch 1)
node1 2017-11-28 18:24:11.709145 Registering HTTP handler for /wallet/ (exactmatch 0)
node1 2017-11-28 18:24:11.709185 Registering HTTP handler for /rest/tx/ (exactmatch 0)
node1 2017-11-28 18:24:11.709336 Registering HTTP handler for /rest/block/notxdetails/ (exactmatch 0)
node1 2017-11-28 18:24:11.709390 Registering HTTP handler for /rest/block/ (exactmatch 0)
node1 2017-11-28 18:24:11.709427 Registering HTTP handler for /rest/chaininfo (exactmatch 0)
node1 2017-11-28 18:24:11.709461 Registering HTTP handler for /rest/mempool/info (exactmatch 0)
node1 2017-11-28 18:24:11.709492 Registering HTTP handler for /rest/mempool/contents (exactmatch 0)
node1 2017-11-28 18:24:11.709525 Registering HTTP handler for /rest/headers/ (exactmatch 0)
node1 2017-11-28 18:24:11.709557 Registering HTTP handler for /rest/getutxos (exactmatch 0)
node1 2017-11-28 18:24:11.709592 Starting HTTP server
node1 2017-11-28 18:24:11.709625 HTTP: starting 4 worker threads
node1 2017-11-28 18:24:11.709705 Entering http event loop
node1 2017-11-28 18:24:11.710002 Using wallet directory /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/wallets
node1 2017-11-28 18:24:11.710061 init message: Verifying wallet(s)...
node1 2017-11-28 18:24:11.710236 Using BerkeleyDB version Berkeley DB 4.8.30: (April 9, 2010)
node1 2017-11-28 18:24:11.710280 Using wallet wallet.dat
node1 2017-11-28 18:24:11.710493 CDBEnv::Open: LogDir=/var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/wallets/database ErrorFile=/var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/wallets/db.log
node0 2017-11-28 18:24:11.740974 net: setting try another outbound peer=false
node0 2017-11-28 18:24:11.741371 Cache configuration:
node0 2017-11-28 18:24:11.741444 * Using 2.0MiB for block index database
node0 2017-11-28 18:24:11.741478 * Using 8.0MiB for chain state database
node0 2017-11-28 18:24:11.741512 * Using 440.0MiB for in-memory UTXO set (plus up to 286.1MiB of unused mempool space)
node0 2017-11-28 18:24:11.741546 init message: Loading block index...
node0 2017-11-28 18:24:11.741634 Opening LevelDB in /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node0/regtest/blocks/index
node1 2017-11-28 18:24:11.741824 net: setting try another outbound peer=false
node1 2017-11-28 18:24:11.742217 Cache configuration:
node1 2017-11-28 18:24:11.742282 * Using 2.0MiB for block index database
node1 2017-11-28 18:24:11.742319 * Using 8.0MiB for chain state database
node1 2017-11-28 18:24:11.742350 * Using 440.0MiB for in-memory UTXO set (plus up to 286.1MiB of unused mempool space)
node1 2017-11-28 18:24:11.742389 init message: Loading block index...
node1 2017-11-28 18:24:11.742492 Opening LevelDB in /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/blocks/index
node0 2017-11-28 18:24:11.831033 Opened LevelDB successfully
node0 2017-11-28 18:24:11.841398 Using obfuscation key for /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node0/regtest/blocks/index: 0000000000000000
node1 2017-11-28 18:24:11.842378 Opened LevelDB successfully
node1 2017-11-28 18:24:11.842471 Using obfuscation key for /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/blocks/index: 0000000000000000
node0 2017-11-28 18:24:11.843200 LoadBlockIndexDB: last block file = 0
node0 2017-11-28 18:24:11.843280 LoadBlockIndexDB: last block file info: CBlockFileInfo(blocks=201, size=54550, heights=0...200, time=2011-02-02...2014-01-02)
node0 2017-11-28 18:24:11.843305 Checking all blk files are present...
node0 2017-11-28 18:24:11.843399 LoadBlockIndexDB: transaction index disabled
node0 2017-11-28 18:24:11.843505 Opening LevelDB in /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node0/regtest/chainstate
node1 2017-11-28 18:24:11.843652 LoadBlockIndexDB: last block file = 0
node1 2017-11-28 18:24:11.843721 LoadBlockIndexDB: last block file info: CBlockFileInfo(blocks=201, size=54550, heights=0...200, time=2011-02-02...2014-01-02)
node1 2017-11-28 18:24:11.843746 Checking all blk files are present...
node1 2017-11-28 18:24:11.843869 LoadBlockIndexDB: transaction index disabled
node1 2017-11-28 18:24:11.843978 Opening LevelDB in /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/chainstate
node0 2017-11-28 18:24:11.930567 Received a POST request for / from 127.0.0.1:54376
node0 2017-11-28 18:24:11.940271 ThreadRPCServer method=getblockcount
node0 2017-11-28 18:24:11.956185 Opened LevelDB successfully
node0 2017-11-28 18:24:11.956305 Using obfuscation key for /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node0/regtest/chainstate: 465f3ac480e8da8b
node0 2017-11-28 18:24:11.956515 Loaded best chain: hashBestChain=0fee3f63b901ee67ece107ab5aef3a89d3c280804f7bdd0513a99d2e8b6666bd height=200 date=2014-01-02 09:10:00 progress=1.000000
node1 2017-11-28 18:24:11.956539 Opened LevelDB successfully
node0 2017-11-28 18:24:11.956581 init message: Rewinding blocks...
node1 2017-11-28 18:24:11.956621 Using obfuscation key for /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/chainstate: 35d9ecaaddbef4b9
node1 2017-11-28 18:24:11.956949 Loaded best chain: hashBestChain=0fee3f63b901ee67ece107ab5aef3a89d3c280804f7bdd0513a99d2e8b6666bd height=200 date=2014-01-02 09:10:00 progress=1.000000
node1 2017-11-28 18:24:11.956985 init message: Rewinding blocks...
node0 2017-11-28 18:24:12.013738 Writing final batch of 0.00 MiB
node0 2017-11-28 18:24:12.013933 Committed 0 changed transaction outputs (out of 0) to coin database...
node1 2017-11-28 18:24:12.028170 Writing final batch of 0.00 MiB
node0 2017-11-28 18:24:12.029341 init message: Verifying blocks...
node1 2017-11-28 18:24:12.029419 Committed 0 changed transaction outputs (out of 0) to coin database...
node0 2017-11-28 18:24:12.029466 Verifying last 6 blocks at level 3
node1 2017-11-28 18:24:12.029506 init message: Verifying blocks...
node0 2017-11-28 18:24:12.029517 [0%]...[16%]...[33%]...[50%]...[66%]...[83%]...[99%]...[DONE].
node1 2017-11-28 18:24:12.029566 Verifying last 6 blocks at level 3
node1 2017-11-28 18:24:12.029595 [0%]...[16%]...[33%]...[50%]...[66%]...[83%]...[99%]...[DONE].
node1 2017-11-28 18:24:12.030927 No coin database inconsistencies in last 7 blocks (7 transactions)
node0 2017-11-28 18:24:12.030942 No coin database inconsistencies in last 7 blocks (7 transactions)
node0 2017-11-28 18:24:12.030983 block index 289ms
node1 2017-11-28 18:24:12.030993 block index 288ms
node0 2017-11-28 18:24:12.031034 init message: Loading wallet...
node1 2017-11-28 18:24:12.031045 init message: Loading wallet...
node1 2017-11-28 18:24:12.032901 nFileVersion = 159900
node1 2017-11-28 18:24:12.032959 Keys: 52 plaintext, 0 encrypted, 52 w/ metadata, 52 total
node0 2017-11-28 18:24:12.033034 nFileVersion = 159900
node0 2017-11-28 18:24:12.033095 Keys: 52 plaintext, 0 encrypted, 52 w/ metadata, 52 total
node1 2017-11-28 18:24:12.074209 wallet 43ms
node1 2017-11-28 18:24:12.078834 keypool added 1 keys (0 internal), size=2 (1 internal)
node0 2017-11-28 18:24:12.089799 wallet 58ms
node0 2017-11-28 18:24:12.090774 keypool added 1 keys (0 internal), size=2 (1 internal)
node0 2017-11-28 18:24:12.152727 setKeyPool.size() = 2
node0 2017-11-28 18:24:12.152820 mapWallet.size() = 50
node0 2017-11-28 18:24:12.152862 mapAddressBook.size() = 0
node0 2017-11-28 18:24:12.157514 mapBlockIndex.size() = 201
node0 2017-11-28 18:24:12.157576 Imported mempool transactions from disk: 0 succeeded, 0 failed, 0 expired, 0 already there
node1 2017-11-28 18:24:12.167954 setKeyPool.size() = 2
node1 2017-11-28 18:24:12.168149 mapWallet.size() = 50
node1 2017-11-28 18:24:12.168926 mapAddressBook.size() = 0
node0 2017-11-28 18:24:12.168927 nBestHeight = 200
node1 2017-11-28 18:24:12.169070 mapBlockIndex.size() = 201
node0 2017-11-28 18:24:12.169077 Bound to [::]:11026
node1 2017-11-28 18:24:12.169129 nBestHeight = 200
node0 2017-11-28 18:24:12.169157 Bound to 0.0.0.0:11026
node0 2017-11-28 18:24:12.169208 init message: Loading P2P addresses...
node1 2017-11-28 18:24:12.169213 Imported mempool transactions from disk: 0 succeeded, 0 failed, 0 expired, 0 already there
node1 2017-11-28 18:24:12.169235 Bound to [::]:11027
node0 2017-11-28 18:24:12.169289 ERROR: DeserializeFileDB: Failed to open file /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node0/regtest/peers.dat
node1 2017-11-28 18:24:12.169333 Bound to 0.0.0.0:11027
node0 2017-11-28 18:24:12.169369 Invalid or missing peers.dat; recreating
node1 2017-11-28 18:24:12.169379 init message: Loading P2P addresses...
node1 2017-11-28 18:24:12.169462 ERROR: DeserializeFileDB: Failed to open file /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/peers.dat
node1 2017-11-28 18:24:12.169536 Invalid or missing peers.dat; recreating
node0 2017-11-28 18:24:12.180465 Flushed 0 addresses to peers.dat 11ms
node0 2017-11-28 18:24:12.180592 init message: Loading banlist...
node0 2017-11-28 18:24:12.181376 Loaded 0 banned node ips/subnets from banlist.dat 0ms
node0 2017-11-28 18:24:12.181703 init message: Starting network threads...
node1 2017-11-28 18:24:12.194287 Flushed 0 addresses to peers.dat 25ms
node1 2017-11-28 18:24:12.194397 init message: Loading banlist...
node1 2017-11-28 18:24:12.195093 Loaded 0 banned node ips/subnets from banlist.dat 1ms
node1 2017-11-28 18:24:12.195180 init message: Starting network threads...
node0 2017-11-28 18:24:12.195284 net thread start
node0 2017-11-28 18:24:12.195464 dnsseed thread start
node0 2017-11-28 18:24:12.195603 Loading addresses from DNS seeds (could take a while)
node0 2017-11-28 18:24:12.195679 0 addresses found from DNS seeds
node0 2017-11-28 18:24:12.195713 dnsseed thread exit
node1 2017-11-28 18:24:12.195771 init message: Done loading
node0 2017-11-28 18:24:12.195811 init message: Done loading
node1 2017-11-28 18:24:12.195903 net thread start
node0 2017-11-28 18:24:12.195918 addcon thread start
node0 2017-11-28 18:24:12.195980 opencon thread start
node1 2017-11-28 18:24:12.195986 dnsseed thread start
node1 2017-11-28 18:24:12.196032 Loading addresses from DNS seeds (could take a while)
node0 2017-11-28 18:24:12.196043 msghand thread start
node1 2017-11-28 18:24:12.196070 0 addresses found from DNS seeds
node1 2017-11-28 18:24:12.196111 dnsseed thread exit
node1 2017-11-28 18:24:12.196111 addcon thread start
node1 2017-11-28 18:24:12.196153 opencon thread start
node1 2017-11-28 18:24:12.196195 msghand thread start
node0 2017-11-28 18:24:12.197717 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:12.197818 ThreadRPCServer method=getblockcount
test 2017-11-28 18:24:12.198000 TestFramework.node0 (DEBUG): RPC successfully started
node1 2017-11-28 18:24:12.200899 Received a POST request for / from 127.0.0.1:54378
test 2017-11-28 18:24:12.201000 TestFramework.node1 (DEBUG): RPC successfully started
node1 2017-11-28 18:24:12.201010 ThreadRPCServer method=getblockcount
node1 2017-11-28 18:24:12.202279 Received a POST request for / from 127.0.0.1:54378
node1 2017-11-28 18:24:12.202380 ThreadRPCServer method=encryptwallet
node1 2017-11-28 18:24:12.299575 Encrypting Wallet with an nDeriveIterations of 196858
node1 2017-11-28 18:24:12.617127 keypool added 2 keys (1 internal), size=2 (1 internal)
node1 2017-11-28 18:24:12.650537 CWallet::NewKeyPool rewrote keypool
node1 2017-11-28 18:24:12.684503 CDB::Rewrite: Rewriting wallet.dat...
node1 2017-11-28 18:24:13.000716 Interrupting HTTP server
node1 2017-11-28 18:24:13.000907 Interrupting HTTP RPC server
node1 2017-11-28 18:24:13.001013 Interrupting RPC
node1 2017-11-28 18:24:13.001139 addcon thread exit
node1 2017-11-28 18:24:13.001185 opencon thread exit
node1 2017-11-28 18:24:13.001400 scheduler thread interrupt
node1 2017-11-28 18:24:13.001572 Shutdown: In progress...
node1 2017-11-28 18:24:13.001642 Stopping HTTP RPC server
node1 2017-11-28 18:24:13.001682 Unregistering HTTP handler for / (exactmatch 1)
node1 2017-11-28 18:24:13.001726 Unregistering HTTP handler for /rest/tx/ (exactmatch 0)
node1 2017-11-28 18:24:13.001767 Unregistering HTTP handler for /rest/block/notxdetails/ (exactmatch 0)
node1 2017-11-28 18:24:13.001809 Unregistering HTTP handler for /rest/block/ (exactmatch 0)
node1 2017-11-28 18:24:13.001850 Unregistering HTTP handler for /rest/chaininfo (exactmatch 0)
node1 2017-11-28 18:24:13.001892 Unregistering HTTP handler for /rest/mempool/info (exactmatch 0)
node1 2017-11-28 18:24:13.001944 Unregistering HTTP handler for /rest/mempool/contents (exactmatch 0)
node1 2017-11-28 18:24:13.002013 Unregistering HTTP handler for /rest/headers/ (exactmatch 0)
node1 2017-11-28 18:24:13.002065 Unregistering HTTP handler for /rest/getutxos (exactmatch 0)
node1 2017-11-28 18:24:13.002117 Stopping RPC
node1 2017-11-28 18:24:13.002597 RPC stopped.
node1 2017-11-28 18:24:13.002655 Stopping HTTP server
node1 2017-11-28 18:24:13.002705 Waiting for HTTP worker threads to exit
node1 2017-11-28 18:24:13.002746 Waiting for HTTP event thread to exit
node1 2017-11-28 18:24:13.003038 Exited http event loop
node1 2017-11-28 18:24:13.003287 Stopped HTTP server
node1 2017-11-28 18:24:13.003342 CDBEnv::Flush: Flush(false)
node1 2017-11-28 18:24:13.003378 CDBEnv::Flush: Flushing wallet.dat (refcount = 0)...
node1 2017-11-28 18:24:13.003414 CDBEnv::Flush: wallet.dat checkpoint
node1 2017-11-28 18:24:13.011226 msghand thread exit
node1 2017-11-28 18:24:13.037789 net thread exit
node1 2017-11-28 18:24:13.037776 CDBEnv::Flush: wallet.dat detach
node1 2017-11-28 18:24:13.050527 CDBEnv::Flush: wallet.dat closed
node1 2017-11-28 18:24:13.050699 CDBEnv::Flush: Flush(false) took 47ms
node1 2017-11-28 18:24:13.072065 Flushed 0 addresses to peers.dat 22ms
node1 2017-11-28 18:24:13.085997 Dumped mempool: 8e-06s to copy, 0.013752s to dump
node1 2017-11-28 18:24:13.086098 Recorded 0 unconfirmed txs from mempool in 3e-06s
node1 2017-11-28 18:24:13.140423 Writing final batch of 0.00 MiB
node1 2017-11-28 18:24:13.140634 Committed 0 changed transaction outputs (out of 0) to coin database...
node1 2017-11-28 18:24:13.215511 Writing final batch of 0.00 MiB
node1 2017-11-28 18:24:13.215637 Committed 0 changed transaction outputs (out of 0) to coin database...
node1 2017-11-28 18:24:13.216030 CDBEnv::Flush: Flush(true)
node1 2017-11-28 18:24:13.219985 CDBEnv::Flush: Flushing wallet.dat (refcount = 0)...
node1 2017-11-28 18:24:13.232659 CDBEnv::Flush: wallet.dat checkpoint
node1 2017-11-28 18:24:13.258350 CDBEnv::Flush: wallet.dat detach
node1 2017-11-28 18:24:13.270678 CDBEnv::Flush: wallet.dat closed
node1 2017-11-28 18:24:13.270782 CDBEnv::Flush: Flush(true) took 54ms
node1 2017-11-28 18:24:13.297503 Shutdown: done
test 2017-11-28 18:24:13.330000 TestFramework.node1 (DEBUG): Node stopped
test 2017-11-28 18:24:13.335000 TestFramework.node1 (DEBUG): bitcoind started, waiting for RPC to come up
node1 2017-11-28 18:24:13.345438
node1 2017-11-28 18:24:13.346593 Bitcoin version v0.15.99.0-a89221873
node1 2017-11-28 18:24:13.346633 InitParameterInteraction: parameter interaction: -whitelistforcerelay=1 -> setting -whitelistrelay=1
node1 2017-11-28 18:24:13.346682 Validating signatures for all blocks.
node1 2017-11-28 18:24:13.346700 Setting nMinimumChainWork=0000000000000000000000000000000000000000000000000000000000000000
node1 2017-11-28 18:24:13.346771 Using the 'sse4' SHA256 implementation
node1 2017-11-28 18:24:13.346787 Using RdRand as an additional entropy source
node1 2017-11-28 18:24:13.365038 Default data directory ########
node1 2017-11-28 18:24:13.365092 Using data directory /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest
node1 2017-11-28 18:24:13.365155 Using config file /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/bitcoin.conf
node1 2017-11-28 18:24:13.365197 Using at most 125 automatic connections (283 file descriptors available)
node1 2017-11-28 18:24:13.375932 Using 16 MiB out of 32/2 requested for signature cache, able to store 524288 elements
node1 2017-11-28 18:24:13.386683 Using 16 MiB out of 32/2 requested for script execution cache, able to store 524288 elements
node1 2017-11-28 18:24:13.386740 Using 2 threads for script verification
node1 2017-11-28 18:24:13.386865 scheduler thread start
node1 2017-11-28 18:24:13.387391 Allowing HTTP connections from: 127.0.0.0/8 ::1/128
node1 2017-11-28 18:24:13.387697 Binding RPC on address ::1 port 16027
node1 2017-11-28 18:24:13.388615 Binding RPC on address 127.0.0.1 port 16027
node1 2017-11-28 18:24:13.388709 Initialized HTTP server
node1 2017-11-28 18:24:13.388750 HTTP: creating work queue of depth 16
node1 2017-11-28 18:24:13.388782 Starting RPC
node1 2017-11-28 18:24:13.388827 Starting HTTP RPC server
node1 2017-11-28 18:24:13.388860 No rpcpassword set - using random cookie authentication
node1 2017-11-28 18:24:13.389322 Generated RPC authentication cookie /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/.cookie
node1 2017-11-28 18:24:13.389389 Registering HTTP handler for / (exactmatch 1)
node1 2017-11-28 18:24:13.389427 Registering HTTP handler for /wallet/ (exactmatch 0)
node1 2017-11-28 18:24:13.389467 Registering HTTP handler for /rest/tx/ (exactmatch 0)
node1 2017-11-28 18:24:13.389503 Registering HTTP handler for /rest/block/notxdetails/ (exactmatch 0)
node1 2017-11-28 18:24:13.389537 Registering HTTP handler for /rest/block/ (exactmatch 0)
node1 2017-11-28 18:24:13.389569 Registering HTTP handler for /rest/chaininfo (exactmatch 0)
node1 2017-11-28 18:24:13.389599 Registering HTTP handler for /rest/mempool/info (exactmatch 0)
node1 2017-11-28 18:24:13.389628 Registering HTTP handler for /rest/mempool/contents (exactmatch 0)
node1 2017-11-28 18:24:13.389660 Registering HTTP handler for /rest/headers/ (exactmatch 0)
node1 2017-11-28 18:24:13.389691 Registering HTTP handler for /rest/getutxos (exactmatch 0)
node1 2017-11-28 18:24:13.389723 Starting HTTP server
node1 2017-11-28 18:24:13.389753 HTTP: starting 4 worker threads
node1 2017-11-28 18:24:13.389838 Entering http event loop
node1 2017-11-28 18:24:13.389994 Using wallet directory /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/wallets
node1 2017-11-28 18:24:13.390050 init message: Verifying wallet(s)...
node1 2017-11-28 18:24:13.390209 Using BerkeleyDB version Berkeley DB 4.8.30: (April 9, 2010)
node1 2017-11-28 18:24:13.390246 Using wallet wallet.dat
node1 2017-11-28 18:24:13.390432 CDBEnv::Open: LogDir=/var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/wallets/database ErrorFile=/var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/wallets/db.log
node1 2017-11-28 18:24:13.409720 net: setting try another outbound peer=false
node1 2017-11-28 18:24:13.410023 Cache configuration:
node1 2017-11-28 18:24:13.410066 * Using 2.0MiB for block index database
node1 2017-11-28 18:24:13.410087 * Using 8.0MiB for chain state database
node1 2017-11-28 18:24:13.410107 * Using 440.0MiB for in-memory UTXO set (plus up to 286.1MiB of unused mempool space)
node1 2017-11-28 18:24:13.410128 init message: Loading block index...
node1 2017-11-28 18:24:13.410203 Opening LevelDB in /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/blocks/index
node1 2017-11-28 18:24:13.455482 Opened LevelDB successfully
node1 2017-11-28 18:24:13.455547 Using obfuscation key for /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/blocks/index: 0000000000000000
node1 2017-11-28 18:24:13.456401 LoadBlockIndexDB: last block file = 0
node1 2017-11-28 18:24:13.456472 LoadBlockIndexDB: last block file info: CBlockFileInfo(blocks=201, size=54550, heights=0...200, time=2011-02-02...2014-01-02)
node1 2017-11-28 18:24:13.456497 Checking all blk files are present...
node1 2017-11-28 18:24:13.456606 LoadBlockIndexDB: transaction index disabled
node1 2017-11-28 18:24:13.456681 Opening LevelDB in /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/chainstate
node1 2017-11-28 18:24:13.504673 Opened LevelDB successfully
node1 2017-11-28 18:24:13.504862 Using obfuscation key for /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/node1/regtest/chainstate: 35d9ecaaddbef4b9
node1 2017-11-28 18:24:13.505079 Loaded best chain: hashBestChain=0fee3f63b901ee67ece107ab5aef3a89d3c280804f7bdd0513a99d2e8b6666bd height=200 date=2014-01-02 09:10:00 progress=1.000000
node1 2017-11-28 18:24:13.505138 init message: Rewinding blocks...
node1 2017-11-28 18:24:13.536498 Writing final batch of 0.00 MiB
node1 2017-11-28 18:24:13.536633 Committed 0 changed transaction outputs (out of 0) to coin database...
node1 2017-11-28 18:24:13.536721 init message: Verifying blocks...
node1 2017-11-28 18:24:13.536781 Verifying last 6 blocks at level 3
node1 2017-11-28 18:24:13.536822 [0%]...[16%]...[33%]...[50%]...[66%]...[83%]...[99%]...[DONE].
node1 2017-11-28 18:24:13.540037 No coin database inconsistencies in last 7 blocks (7 transactions)
node1 2017-11-28 18:24:13.540074 block index 130ms
node1 2017-11-28 18:24:13.541815 Reading estimates: 190 buckets counting confirms up to 48 blocks
node1 2017-11-28 18:24:13.542244 Reading estimates: 190 buckets counting confirms up to 12 blocks
node1 2017-11-28 18:24:13.543490 Reading estimates: 190 buckets counting confirms up to 1008 blocks
node1 2017-11-28 18:24:13.543709 init message: Loading wallet...
node1 2017-11-28 18:24:13.544856 nFileVersion = 159900
node1 2017-11-28 18:24:13.544900 Keys: 0 plaintext, 56 encrypted, 56 w/ metadata, 56 total
node1 2017-11-28 18:24:13.595644 Received a POST request for / from 127.0.0.1:54379
node1 2017-11-28 18:24:13.596838 wallet 53ms
node1 2017-11-28 18:24:13.596870 ThreadRPCServer method=getblockcount
node1 2017-11-28 18:24:13.597025 setKeyPool.size() = 2
node1 2017-11-28 18:24:13.597057 mapWallet.size() = 50
node1 2017-11-28 18:24:13.597087 mapAddressBook.size() = 0
node1 2017-11-28 18:24:13.598007 mapBlockIndex.size() = 201
node1 2017-11-28 18:24:13.598048 nBestHeight = 200
node1 2017-11-28 18:24:13.598149 Imported mempool transactions from disk: 0 succeeded, 0 failed, 0 expired, 0 already there
node1 2017-11-28 18:24:13.598171 Bound to [::]:11027
node1 2017-11-28 18:24:13.598246 Bound to 0.0.0.0:11027
node1 2017-11-28 18:24:13.598280 init message: Loading P2P addresses...
node1 2017-11-28 18:24:13.598472 Loaded 0 addresses from peers.dat 0ms
node1 2017-11-28 18:24:13.598501 init message: Loading banlist...
node1 2017-11-28 18:24:13.598550 Loaded 0 banned node ips/subnets from banlist.dat 0ms
node1 2017-11-28 18:24:13.598574 init message: Starting network threads...
node1 2017-11-28 18:24:13.598644 dnsseed thread start
node1 2017-11-28 18:24:13.598645 net thread start
node1 2017-11-28 18:24:13.598656 addcon thread start
node1 2017-11-28 18:24:13.598679 init message: Done loading
node1 2017-11-28 18:24:13.598700 msghand thread start
node1 2017-11-28 18:24:13.598701 opencon thread start
node1 2017-11-28 18:24:13.598703 Loading addresses from DNS seeds (could take a while)
node1 2017-11-28 18:24:13.598890 0 addresses found from DNS seeds
node1 2017-11-28 18:24:13.598919 dnsseed thread exit
node1 2017-11-28 18:24:13.856519 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:13.856662 ThreadRPCServer method=getblockcount
test 2017-11-28 18:24:13.857000 TestFramework.node1 (DEBUG): RPC successfully started
node1 2017-11-28 18:24:13.857982 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:13.858069 ThreadRPCServer method=walletpassphrase
node1 2017-11-28 18:24:13.961541 queue run of timer lockwallet(wallet.dat) in 3600 seconds (using HTTP)
node0 2017-11-28 18:24:13.962811 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:13.962902 ThreadRPCServer method=addnode
node0 2017-11-28 18:24:13.962959 trying connection 127.0.0.1:11027 lastseen=0.0hrs
node0 2017-11-28 18:24:13.963563 Added connection peer=0
node0 2017-11-28 18:24:13.963628 sending version (114 bytes) peer=0
node1 2017-11-28 18:24:13.963647 Added connection peer=0
node1 2017-11-28 18:24:13.963700 connection from 127.0.0.1:54381 accepted
node0 2017-11-28 18:24:13.963742 send version message: version 70015, blocks=200, us=[::]:0, peer=0
node1 2017-11-28 18:24:13.963824 received: version (114 bytes) peer=0
node1 2017-11-28 18:24:13.963882 sending version (114 bytes) peer=0
node1 2017-11-28 18:24:13.963939 send version message: version 70015, blocks=200, us=[::]:0, peer=0
node1 2017-11-28 18:24:13.963963 sending verack (0 bytes) peer=0
node1 2017-11-28 18:24:13.964007 receive version message: /Satoshi:0.15.99(testnode0)/: version 70015, blocks=200, us=[::]:0, peer=0
node1 2017-11-28 18:24:13.964034 added time data, samples 2, offset +0 (+0 minutes)
node0 2017-11-28 18:24:13.964752 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:13.964881 ThreadRPCServer method=getpeerinfo
node0 2017-11-28 18:24:13.981937 received: version (114 bytes) peer=0
node0 2017-11-28 18:24:13.982025 sending verack (0 bytes) peer=0
node0 2017-11-28 18:24:13.982100 sending getaddr (0 bytes) peer=0
node0 2017-11-28 18:24:13.982180 receive version message: /Satoshi:0.15.99(testnode1)/: version 70015, blocks=200, us=[::]:0, peer=0
node1 2017-11-28 18:24:13.982188 received: verack (0 bytes) peer=0
node0 2017-11-28 18:24:13.982231 added time data, samples 2, offset +0 (+0 minutes)
node1 2017-11-28 18:24:13.982245 sending sendheaders (0 bytes) peer=0
node0 2017-11-28 18:24:13.982287 received: verack (0 bytes) peer=0
node1 2017-11-28 18:24:13.982303 sending sendcmpct (9 bytes) peer=0
node0 2017-11-28 18:24:13.982373 sending sendheaders (0 bytes) peer=0
node1 2017-11-28 18:24:13.982375 sending sendcmpct (9 bytes) peer=0
node0 2017-11-28 18:24:13.982460 sending sendcmpct (9 bytes) peer=0
node1 2017-11-28 18:24:13.982469 sending ping (8 bytes) peer=0
node0 2017-11-28 18:24:13.982552 sending sendcmpct (9 bytes) peer=0
node1 2017-11-28 18:24:13.982567 initial getheaders (199) to peer=0 (startheight:200)
node0 2017-11-28 18:24:13.982647 sending ping (8 bytes) peer=0
node1 2017-11-28 18:24:13.982648 sending getheaders (645 bytes) peer=0
node0 2017-11-28 18:24:13.982737 initial getheaders (199) to peer=0 (startheight:200)
node0 2017-11-28 18:24:13.982796 sending getheaders (645 bytes) peer=0
node1 2017-11-28 18:24:13.982811 sending feefilter (8 bytes) peer=0
node1 2017-11-28 18:24:13.982892 received: getaddr (0 bytes) peer=0
node0 2017-11-28 18:24:13.982931 sending feefilter (8 bytes) peer=0
node1 2017-11-28 18:24:13.982960 received: sendheaders (0 bytes) peer=0
node0 2017-11-28 18:24:13.983009 received: sendheaders (0 bytes) peer=0
node1 2017-11-28 18:24:13.983011 received: sendcmpct (9 bytes) peer=0
node0 2017-11-28 18:24:13.983066 received: sendcmpct (9 bytes) peer=0
node1 2017-11-28 18:24:13.983072 received: sendcmpct (9 bytes) peer=0
node0 2017-11-28 18:24:13.983096 received: sendcmpct (9 bytes) peer=0
node1 2017-11-28 18:24:13.983123 received: ping (8 bytes) peer=0
node0 2017-11-28 18:24:13.983124 received: ping (8 bytes) peer=0
node0 2017-11-28 18:24:13.983150 sending pong (8 bytes) peer=0
node1 2017-11-28 18:24:13.983165 sending pong (8 bytes) peer=0
node0 2017-11-28 18:24:13.983208 received: getheaders (645 bytes) peer=0
node1 2017-11-28 18:24:13.983243 received: getheaders (645 bytes) peer=0
node0 2017-11-28 18:24:13.983257 Ignoring getheaders from peer=0 because node is in initial block download
node1 2017-11-28 18:24:13.983295 Ignoring getheaders from peer=0 because node is in initial block download
node0 2017-11-28 18:24:13.983310 received: feefilter (8 bytes) peer=0
node0 2017-11-28 18:24:13.983347 received: feefilter of 0.00001000 BTC/kB from peer=0
node1 2017-11-28 18:24:13.983352 received: feefilter (8 bytes) peer=0
node0 2017-11-28 18:24:13.983374 received: pong (8 bytes) peer=0
node1 2017-11-28 18:24:13.983402 received: feefilter of 0.00001000 BTC/kB from peer=0
node1 2017-11-28 18:24:13.983442 received: pong (8 bytes) peer=0
node0 2017-11-28 18:24:14.070852 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:14.071074 ThreadRPCServer method=getpeerinfo
node1 2017-11-28 18:24:14.076280 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.076668 ThreadRPCServer method=addnode
node1 2017-11-28 18:24:14.076770 trying connection 127.0.0.1:11026 lastseen=0.0hrs
node0 2017-11-28 18:24:14.077572 Added connection peer=1
node1 2017-11-28 18:24:14.077597 Added connection peer=1
node0 2017-11-28 18:24:14.077662 connection from 127.0.0.1:54382 accepted
node1 2017-11-28 18:24:14.077664 sending version (114 bytes) peer=1
node1 2017-11-28 18:24:14.077763 send version message: version 70015, blocks=200, us=[::]:0, peer=1
node0 2017-11-28 18:24:14.077818 received: version (114 bytes) peer=1
node0 2017-11-28 18:24:14.077864 sending version (114 bytes) peer=1
node0 2017-11-28 18:24:14.077953 send version message: version 70015, blocks=200, us=[::]:0, peer=1
node0 2017-11-28 18:24:14.077989 sending verack (0 bytes) peer=1
node0 2017-11-28 18:24:14.078036 receive version message: /Satoshi:0.15.99(testnode1)/: version 70015, blocks=200, us=[::]:0, peer=1
node1 2017-11-28 18:24:14.078811 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.078894 ThreadRPCServer method=getpeerinfo
node1 2017-11-28 18:24:14.086564 received: version (114 bytes) peer=1
node1 2017-11-28 18:24:14.086694 sending verack (0 bytes) peer=1
node1 2017-11-28 18:24:14.086857 sending getaddr (0 bytes) peer=1
node1 2017-11-28 18:24:14.087065 receive version message: /Satoshi:0.15.99(testnode0)/: version 70015, blocks=200, us=[::]:0, peer=1
node0 2017-11-28 18:24:14.087090 received: verack (0 bytes) peer=1
node0 2017-11-28 18:24:14.087176 sending sendheaders (0 bytes) peer=1
node1 2017-11-28 18:24:14.087203 received: verack (0 bytes) peer=1
node0 2017-11-28 18:24:14.087278 sending sendcmpct (9 bytes) peer=1
node1 2017-11-28 18:24:14.087295 sending sendheaders (0 bytes) peer=1
node1 2017-11-28 18:24:14.087406 sending sendcmpct (9 bytes) peer=1
node0 2017-11-28 18:24:14.087429 sending sendcmpct (9 bytes) peer=1
node0 2017-11-28 18:24:14.087548 sending ping (8 bytes) peer=1
node1 2017-11-28 18:24:14.087558 sending sendcmpct (9 bytes) peer=1
node1 2017-11-28 18:24:14.087721 sending ping (8 bytes) peer=1
node0 2017-11-28 18:24:14.087739 sending feefilter (8 bytes) peer=1
node1 2017-11-28 18:24:14.087913 sending feefilter (8 bytes) peer=1
node0 2017-11-28 18:24:14.087985 received: getaddr (0 bytes) peer=1
node1 2017-11-28 18:24:14.088047 received: sendheaders (0 bytes) peer=1
node0 2017-11-28 18:24:14.088087 received: sendheaders (0 bytes) peer=1
node1 2017-11-28 18:24:14.088129 received: sendcmpct (9 bytes) peer=1
node0 2017-11-28 18:24:14.088147 received: sendcmpct (9 bytes) peer=1
node1 2017-11-28 18:24:14.088183 received: sendcmpct (9 bytes) peer=1
node0 2017-11-28 18:24:14.088199 received: sendcmpct (9 bytes) peer=1
node1 2017-11-28 18:24:14.088234 received: ping (8 bytes) peer=1
node0 2017-11-28 18:24:14.088252 received: ping (8 bytes) peer=1
node1 2017-11-28 18:24:14.088273 sending pong (8 bytes) peer=1
node0 2017-11-28 18:24:14.088293 sending pong (8 bytes) peer=1
node1 2017-11-28 18:24:14.088360 received: feefilter (8 bytes) peer=1
node0 2017-11-28 18:24:14.088424 received: feefilter (8 bytes) peer=1
node1 2017-11-28 18:24:14.088437 received: feefilter of 0.00001000 BTC/kB from peer=1
node0 2017-11-28 18:24:14.088501 received: feefilter of 0.00001000 BTC/kB from peer=1
node1 2017-11-28 18:24:14.088511 received: pong (8 bytes) peer=1
node0 2017-11-28 18:24:14.088558 received: pong (8 bytes) peer=1
node1 2017-11-28 18:24:14.180542 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.180686 ThreadRPCServer method=getpeerinfo
node0 2017-11-28 18:24:14.182129 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:14.182225 ThreadRPCServer method=getblockcount
node1 2017-11-28 18:24:14.183181 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.183273 ThreadRPCServer method=getblockcount
node0 2017-11-28 18:24:14.184249 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:14.184340 ThreadRPCServer method=waitforblockheight
node1 2017-11-28 18:24:14.185427 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.185560 ThreadRPCServer method=waitforblockheight
node0 2017-11-28 18:24:14.186565 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:14.186654 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:14.187554 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.187651 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:14.188552 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.188641 ThreadRPCServer method=getnewaddress
node1 2017-11-28 18:24:14.188761 keypool reserve 4
node1 2017-11-28 18:24:14.188849 keypool keep 4
node0 2017-11-28 18:24:14.204512 Flushing wallet.dat
node0 2017-11-28 18:24:14.247680 Flushed wallet.dat 43ms
test 2017-11-28 18:24:14.309000 TestFramework (INFO): Running tests
node0 2017-11-28 18:24:14.313824 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:14.313988 ThreadRPCServer method=getnewaddress
node0 2017-11-28 18:24:14.338334 keypool reserve 3
node0 2017-11-28 18:24:14.339751 keypool keep 3
test 2017-11-28 18:24:14.451000 TestFramework (DEBUG): Create RBF transaction
test 2017-11-28 18:24:14.453000 TestFramework (INFO): mk7wP6GE5YsqWtHUKfQmTG8xd6oMrHhc5Q
node1 2017-11-28 18:24:14.454290 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.454434 ThreadRPCServer method=listunspent
node1 2017-11-28 18:24:14.457623 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.457717 ThreadRPCServer method=getrawchangeaddress
node1 2017-11-28 18:24:14.458494 keypool added 1 keys (0 internal), size=2 (1 internal)
node1 2017-11-28 18:24:14.487668 keypool reserve 5
node1 2017-11-28 18:24:14.488828 keypool keep 5
node1 2017-11-28 18:24:14.525771 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.526998 ThreadRPCServer method=createrawtransaction
node1 2017-11-28 18:24:14.528950 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.529103 ThreadRPCServer method=signrawtransaction
node1 2017-11-28 18:24:14.530923 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.531023 ThreadRPCServer method=sendrawtransaction
node1 2017-11-28 18:24:14.531427 AddToWallet ca43e3bf038fd2b270f1f3d0b3a9c3a866df30afdbfec2078273376b5ba80ebf new
node1 2017-11-28 18:24:14.532726 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.532822 ThreadRPCServer method=gettransaction
node1 2017-11-28 18:24:14.533966 Received a POST request for / from 127.0.0.1:54380
test 2017-11-28 18:24:14.534000 TestFramework (DEBUG): {'size': 1, 'bytes': 192, 'usage': 1008, 'maxmempool': 300000000, 'mempoolminfee': Decimal('0E-8')}
node1 2017-11-28 18:24:14.534059 ThreadRPCServer method=getmempoolinfo
test 2017-11-28 18:24:14.535000 TestFramework (DEBUG): {'size': 0, 'bytes': 0, 'usage': 0, 'maxmempool': 300000000, 'mempoolminfee': Decimal('0E-8')}
test 2017-11-28 18:24:14.535000 TestFramework (DEBUG): {'amount': Decimal('-25.00000000'), 'fee': Decimal('-0.00001000'), 'confirmations': 0, 'trusted': True, 'txid': 'ca43e3bf038fd2b270f1f3d0b3a9c3a866df30afdbfec2078273376b5ba80ebf', 'walletconflicts': [], 'time': 1511893454, 'timereceived': 1511893454, 'bip125-replaceable': 'yes', 'details': [{'account': '', 'address': 'mk7wP6GE5YsqWtHUKfQmTG8xd6oMrHhc5Q', 'category': 'send', 'amount': Decimal('-25.00000000'), 'vout': 0, 'fee': Decimal('-0.00001000'), 'abandoned': False}], 'hex': '0200000001110bdbeedd5ee0e31ff1a93b45ffc8ddcb7479f3e37e3036778dbd23ef66cedc0000000049483045022100fa10e37e6ab44097e96ecdced6189121e5252869ec2ea9e00cd5d1997f42773002203fac15da3e0466210806f50293b4125c06f05512c7be6da8a423333e8ade5fcb01fdffffff0200f90295000000001976a914327e4caec554e71fee268830dd13f594c6cf96ce88ac18f50295000000001976a91417989121f200b7f98541563eb4c87471c2f1e0f888ac00000000'}
node0 2017-11-28 18:24:14.535149 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:14.535237 ThreadRPCServer method=getmempoolinfo
test 2017-11-28 18:24:14.536000 TestFramework (DEBUG): ['ca43e3bf038fd2b270f1f3d0b3a9c3a866df30afdbfec2078273376b5ba80ebf']
node1 2017-11-28 18:24:14.536416 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.536501 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:14.537512 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:14.537596 ThreadRPCServer method=getrawmempool
test 2017-11-28 18:24:14.538000 TestFramework (DEBUG): []
test 2017-11-28 18:24:14.538000 TestFramework (DEBUG): Sync mempools after creating RBF transaction
node1 2017-11-28 18:24:14.538672 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:14.538754 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:14.539676 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:14.539766 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:14.601308 sending inv (37 bytes) peer=0
node0 2017-11-28 18:24:14.601634 received: inv (37 bytes) peer=0
node0 2017-11-28 18:24:14.601899 got inv: tx ca43e3bf038fd2b270f1f3d0b3a9c3a866df30afdbfec2078273376b5ba80ebf new peer=0
node1 2017-11-28 18:24:15.543292 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:15.543481 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:15.545307 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:15.545449 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:16.120874 Flushing wallet.dat
node1 2017-11-28 18:24:16.169652 Flushed wallet.dat 49ms
node0 2017-11-28 18:24:16.262708 Flushing wallet.dat
node0 2017-11-28 18:24:16.296400 Flushed wallet.dat 34ms
node1 2017-11-28 18:24:16.547104 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:16.547252 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:16.548358 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:16.548468 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:17.549897 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:17.550062 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:17.551383 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:17.551477 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:18.558143 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:18.558602 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:18.560231 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:18.560682 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:18.567446 sending inv (37 bytes) peer=1
node0 2017-11-28 18:24:18.567902 received: inv (37 bytes) peer=1
node0 2017-11-28 18:24:18.568054 got inv: tx ca43e3bf038fd2b270f1f3d0b3a9c3a866df30afdbfec2078273376b5ba80ebf new peer=1
node1 2017-11-28 18:24:19.568187 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:19.568393 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:19.570076 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:19.570223 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:20.572641 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:20.572748 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:20.573789 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:20.573909 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:21.580666 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:21.580816 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:21.582394 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:21.582540 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:22.589370 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:22.589525 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:22.591115 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:22.591263 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:23.598349 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:23.598547 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:23.600128 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:23.600273 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:24.606241 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:24.606413 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:24.608140 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:24.608296 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:25.614998 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:25.615196 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:25.616813 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:25.616959 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:26.621636 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:26.621789 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:26.623306 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:26.623452 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:27.626262 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:27.626398 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:27.627418 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:27.627510 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:28.634125 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:28.634277 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:28.635844 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:28.635990 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:29.637995 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:29.638156 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:29.639767 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:29.639919 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:30.644587 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:30.644741 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:30.646295 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:30.646442 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:31.653422 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:31.653574 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:31.655169 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:31.655313 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:32.660501 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:32.660654 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:32.662206 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:32.662350 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:33.665385 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:33.665543 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:33.667234 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:33.667389 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:34.669826 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:34.669976 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:34.671532 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:34.671677 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:35.676205 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:35.676353 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:35.677914 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:35.678059 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:36.682612 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:36.682828 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:36.684644 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:36.684819 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:37.691695 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:37.691890 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:37.693475 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:37.693618 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:38.697191 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:38.697363 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:38.699103 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:38.699245 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:39.706104 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:39.706255 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:39.707820 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:39.707962 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:40.714841 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:40.715035 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:40.716731 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:40.716871 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:41.722937 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:41.723083 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:41.724663 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:41.724806 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:42.729297 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:42.729445 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:42.730992 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:42.731134 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:43.736418 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:43.740539 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:43.742259 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:43.742406 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:44.747717 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:44.747870 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:44.749403 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:44.749547 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:45.755518 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:45.755667 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:45.757232 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:45.757380 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:46.764220 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:46.764372 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:46.765948 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:46.766092 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:47.769632 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:47.769782 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:47.771342 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:47.771488 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:48.778331 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:48.778486 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:48.780016 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:48.780202 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:49.782872 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:49.783080 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:49.785052 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:49.785202 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:50.792102 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:50.792252 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:50.793828 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:50.793975 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:51.796671 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:51.796820 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:51.798374 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:51.798520 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:52.802849 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:52.803002 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:52.804581 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:52.804726 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:53.806663 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:53.806820 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:53.808410 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:53.808556 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:54.815393 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:54.815547 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:54.817138 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:54.817282 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:55.823752 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:55.823952 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:55.825574 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:55.825719 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:56.832588 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:56.832740 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:56.834323 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:56.834468 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:57.841612 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:57.841764 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:57.843351 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:57.843495 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:58.850325 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:58.850480 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:58.852030 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:58.852174 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:24:59.859076 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:24:59.859224 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:24:59.860770 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:24:59.860916 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:00.865913 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:00.866113 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:00.867835 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:00.867999 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:01.871678 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:01.871828 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:01.872924 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:01.873017 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:02.879622 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:02.879773 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:02.881329 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:02.881475 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:03.883808 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:03.883963 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:03.885521 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:03.885667 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:04.892478 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:04.892679 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:04.894306 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:04.894451 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:05.899818 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:05.899972 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:05.901518 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:05.901725 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:06.906830 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:06.907033 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:06.908816 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:06.908956 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:07.915863 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:07.916013 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:07.917599 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:07.917739 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:08.923114 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:08.923210 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:08.924167 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:08.924256 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:09.930331 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:09.930482 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:09.932049 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:09.932188 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:10.938799 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:10.938947 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:10.940502 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:10.940643 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:11.946926 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:11.947156 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:11.948929 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:11.949127 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:12.956700 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:12.956852 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:12.958435 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:12.958577 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:13.117798 Adding fixed seed nodes as DNS doesn't seem to be available.
node1 2017-11-28 18:25:13.965447 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:13.965606 ThreadRPCServer method=getrawmempool
node0 2017-11-28 18:25:13.967200 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:13.967346 ThreadRPCServer method=getrawmempool
node1 2017-11-28 18:25:14.492900 Adding fixed seed nodes as DNS doesn't seem to be available.
test 2017-11-28 18:25:14.969000 TestFramework (ERROR): Assertion failed
Traceback (most recent call last):
File "/#####/test/functional/test_framework/test_framework.py", line 120, in main
self.run_test()
File "test/functional/bumpfee.py", line 63, in run_test
test_simple_bumpfee_succeeds(self, rbf_node, peer_node, dest_address)
File "test/functional/bumpfee.py", line 91, in test_simple_bumpfee_succeeds
sync_mempools((rbf_node, peer_node))
File "/#####/test/functional/test_framework/util.py", line 408, in sync_mempools
raise AssertionError("Mempool sync failed")
AssertionError: Mempool sync failed
test 2017-11-28 18:25:14.974000 TestFramework (INFO): Stopping nodes
test 2017-11-28 18:25:14.974000 TestFramework.node0 (DEBUG): Stopping node
node0 2017-11-28 18:25:14.975745 Received a POST request for / from 127.0.0.1:54377
node0 2017-11-28 18:25:14.975836 ThreadRPCServer method=stop
test 2017-11-28 18:25:14.976000 TestFramework.node1 (DEBUG): Stopping node
node1 2017-11-28 18:25:14.976896 Received a POST request for / from 127.0.0.1:54380
node1 2017-11-28 18:25:14.976987 ThreadRPCServer method=stop
node1 2017-11-28 18:25:14.977686 Interrupting HTTP server
node1 2017-11-28 18:25:14.977793 Interrupting HTTP RPC server
node1 2017-11-28 18:25:14.977842 Interrupting RPC
node1 2017-11-28 18:25:14.977903 opencon thread exit
node1 2017-11-28 18:25:14.977905 addcon thread exit
node1 2017-11-28 18:25:14.977988 scheduler thread interrupt
node1 2017-11-28 18:25:14.978093 Shutdown: In progress...
node1 2017-11-28 18:25:14.978140 Stopping HTTP RPC server
node1 2017-11-28 18:25:14.978166 Unregistering HTTP handler for / (exactmatch 1)
node1 2017-11-28 18:25:14.978192 Unregistering HTTP handler for /rest/tx/ (exactmatch 0)
node1 2017-11-28 18:25:14.978214 Unregistering HTTP handler for /rest/block/notxdetails/ (exactmatch 0)
node1 2017-11-28 18:25:14.978237 Unregistering HTTP handler for /rest/block/ (exactmatch 0)
node1 2017-11-28 18:25:14.978258 Unregistering HTTP handler for /rest/chaininfo (exactmatch 0)
node1 2017-11-28 18:25:14.978280 Unregistering HTTP handler for /rest/mempool/info (exactmatch 0)
node1 2017-11-28 18:25:14.978301 Unregistering HTTP handler for /rest/mempool/contents (exactmatch 0)
node1 2017-11-28 18:25:14.978322 Unregistering HTTP handler for /rest/headers/ (exactmatch 0)
node1 2017-11-28 18:25:14.978343 Unregistering HTTP handler for /rest/getutxos (exactmatch 0)
node1 2017-11-28 18:25:14.978364 Stopping RPC
node1 2017-11-28 18:25:14.978613 RPC stopped.
node1 2017-11-28 18:25:14.978643 Stopping HTTP server
node1 2017-11-28 18:25:14.978665 Waiting for HTTP worker threads to exit
node1 2017-11-28 18:25:14.978690 Waiting for HTTP event thread to exit
node1 2017-11-28 18:25:14.978727 Exited http event loop
node1 2017-11-28 18:25:14.978871 Stopped HTTP server
node1 2017-11-28 18:25:14.978920 CDBEnv::Flush: Flush(false)
node1 2017-11-28 18:25:14.978950 CDBEnv::Flush: Flush(false) took 0ms
node1 2017-11-28 18:25:15.015085 net thread exit
node0 2017-11-28 18:25:15.015120 Interrupting HTTP server
node0 2017-11-28 18:25:15.015270 Interrupting HTTP RPC server
node0 2017-11-28 18:25:15.015348 Interrupting RPC
node0 2017-11-28 18:25:15.015412 opencon thread exit
node0 2017-11-28 18:25:15.015410 addcon thread exit
node0 2017-11-28 18:25:15.015539 scheduler thread interrupt
node0 2017-11-28 18:25:15.015713 Shutdown: In progress...
node0 2017-11-28 18:25:15.015763 Stopping HTTP RPC server
node0 2017-11-28 18:25:15.015790 Unregistering HTTP handler for / (exactmatch 1)
node0 2017-11-28 18:25:15.015815 Unregistering HTTP handler for /rest/tx/ (exactmatch 0)
node0 2017-11-28 18:25:15.015838 Unregistering HTTP handler for /rest/block/notxdetails/ (exactmatch 0)
node0 2017-11-28 18:25:15.015861 Unregistering HTTP handler for /rest/block/ (exactmatch 0)
node0 2017-11-28 18:25:15.015882 Unregistering HTTP handler for /rest/chaininfo (exactmatch 0)
node0 2017-11-28 18:25:15.015903 Unregistering HTTP handler for /rest/mempool/info (exactmatch 0)
node0 2017-11-28 18:25:15.015925 Unregistering HTTP handler for /rest/mempool/contents (exactmatch 0)
node0 2017-11-28 18:25:15.015946 Unregistering HTTP handler for /rest/headers/ (exactmatch 0)
node0 2017-11-28 18:25:15.015967 Unregistering HTTP handler for /rest/getutxos (exactmatch 0)
node0 2017-11-28 18:25:15.015987 Stopping RPC
node0 2017-11-28 18:25:15.016223 RPC stopped.
node0 2017-11-28 18:25:15.016254 Stopping HTTP server
node0 2017-11-28 18:25:15.016277 Waiting for HTTP worker threads to exit
node0 2017-11-28 18:25:15.016303 Waiting for HTTP event thread to exit
node0 2017-11-28 18:25:15.016347 Exited http event loop
node0 2017-11-28 18:25:15.016550 Stopped HTTP server
node0 2017-11-28 18:25:15.016593 CDBEnv::Flush: Flush(false)
node0 2017-11-28 18:25:15.016620 CDBEnv::Flush: Flush(false) took 0ms
node0 2017-11-28 18:25:15.068183 net thread exit
node0 2017-11-28 18:25:15.075260 msghand thread exit
node1 2017-11-28 18:25:15.075260 msghand thread exit
node0 2017-11-28 18:25:15.089449 Flushed 0 addresses to peers.dat 14ms
node1 2017-11-28 18:25:15.089483 Flushed 0 addresses to peers.dat 14ms
node0 2017-11-28 18:25:15.089503 disconnecting peer=0
node1 2017-11-28 18:25:15.089529 disconnecting peer=0
node0 2017-11-28 18:25:15.089576 disconnecting peer=1
node1 2017-11-28 18:25:15.089579 disconnecting peer=1
node0 2017-11-28 18:25:15.089665 Cleared nodestate for peer=0
node1 2017-11-28 18:25:15.089665 Cleared nodestate for peer=0
node1 2017-11-28 18:25:15.089723 Cleared nodestate for peer=1
node0 2017-11-28 18:25:15.089744 Cleared nodestate for peer=1
node1 2017-11-28 18:25:15.114365 Dumped mempool: 2e-06s to copy, 0.024572s to dump
node0 2017-11-28 18:25:15.114423 Dumped mempool: 1e-06s to copy, 0.024601s to dump
node1 2017-11-28 18:25:15.114475 Recorded 1 unconfirmed txs from mempool in 3e-06s
node0 2017-11-28 18:25:15.114503 Recorded 0 unconfirmed txs from mempool in 3e-06s
node0 2017-11-28 18:25:15.141071 Writing final batch of 0.00 MiB
node0 2017-11-28 18:25:15.141569 Committed 0 changed transaction outputs (out of 0) to coin database...
node1 2017-11-28 18:25:15.159948 Writing final batch of 0.00 MiB
node1 2017-11-28 18:25:15.160446 Committed 0 changed transaction outputs (out of 1) to coin database...
node0 2017-11-28 18:25:15.243665 Writing final batch of 0.00 MiB
node0 2017-11-28 18:25:15.257992 Committed 0 changed transaction outputs (out of 0) to coin database...
node1 2017-11-28 18:25:15.267995 Writing final batch of 0.00 MiB
node1 2017-11-28 18:25:15.268121 Committed 0 changed transaction outputs (out of 0) to coin database...
node1 2017-11-28 18:25:15.269030 CDBEnv::Flush: Flush(true)
node1 2017-11-28 18:25:15.269120 CDBEnv::Flush: Flushing wallet.dat (refcount = 0)...
node0 2017-11-28 18:25:15.269227 CDBEnv::Flush: Flush(true)
node1 2017-11-28 18:25:15.279752 CDBEnv::Flush: wallet.dat checkpoint
node0 2017-11-28 18:25:15.281313 CDBEnv::Flush: Flushing wallet.dat (refcount = 0)...
node1 2017-11-28 18:25:15.300268 CDBEnv::Flush: wallet.dat detach
node0 2017-11-28 18:25:15.300361 CDBEnv::Flush: wallet.dat checkpoint
node0 2017-11-28 18:25:15.325150 CDBEnv::Flush: wallet.dat detach
node1 2017-11-28 18:25:15.325175 CDBEnv::Flush: wallet.dat closed
node1 2017-11-28 18:25:15.325268 CDBEnv::Flush: Flush(true) took 56ms
node0 2017-11-28 18:25:15.337006 CDBEnv::Flush: wallet.dat closed
node0 2017-11-28 18:25:15.337754 CDBEnv::Flush: Flush(true) took 68ms
node1 2017-11-28 18:25:15.338960 Shutdown: done
node0 2017-11-28 18:25:15.362374 Shutdown: done
test 2017-11-28 18:25:15.392000 TestFramework.node0 (DEBUG): Node stopped
test 2017-11-28 18:25:15.393000 TestFramework.node1 (DEBUG): Node stopped
test 2017-11-28 18:25:15.393000 TestFramework (WARNING): Not cleaning up dir /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs
test 2017-11-28 18:25:15.393000 TestFramework (ERROR): Test failed. Test logging available at /var/folders/sl/5j1zvmtj0gb8qpgkklkf38dh0000gr/T/test7427wvxs/test_framework.log
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment