log.txt

--> test/functional/feature_reindex_readonly.py -l DEBUG --nocleanup
2023-08-22T20:01:28.393000Z TestFramework (INFO): PRNG seed is: 8262915717492098124
2023-08-22T20:01:28.394000Z TestFramework (DEBUG): Setting up network thread
2023-08-22T20:01:28.394000Z TestFramework (INFO): Initializing test directory /tmp/bitcoin_func_test_dpo_q17r
2023-08-22T20:01:28.396000Z TestFramework.node0 (DEBUG): bitcoind started, waiting for RPC to come up
2023-08-22T20:01:28.919000Z TestFramework.node0 (DEBUG): RPC successfully started
2023-08-22T20:01:28.922000Z TestFramework (DEBUG): Generate block big enough to start second block file
2023-08-22T20:01:29.023000Z TestFramework.node0 (DEBUG): Stopping node
2023-08-22T20:01:29.244000Z TestFramework.node0 (DEBUG): Node stopped
2023-08-22T20:01:29.244000Z TestFramework (DEBUG): Make the first block file read-only
2023-08-22T20:01:29.247000Z TestFramework (WARNING): Can not make file immutable ([Errno 2] No such file or directory: 'chattr'), trying read-only instead
2023-08-22T20:01:29.248000Z TestFramework (DEBUG): Attempt to restart and reindex the node with the unwritable block file
2023-08-22T20:01:29.251000Z TestFramework.node0 (DEBUG): bitcoind started, waiting for RPC to come up
2023-08-22T20:01:29.877000Z TestFramework.node0 (DEBUG): [node 0] bitcoind exited with status 1 during initialization
2023-08-22T20:01:29.878000Z TestFramework (DEBUG): Closing down network thread
2023-08-22T20:01:29.934000Z TestFramework (INFO): Stopping nodes
2023-08-22T20:01:29.934000Z TestFramework (WARNING): Not cleaning up dir /tmp/bitcoin_func_test_dpo_q17r
2023-08-22T20:01:29.934000Z TestFramework (INFO): Tests successful
--> test/functional/combine_logs.py 
Opening latest test directory: /tmp/bitcoin_func_test_dpo_q17r
 test  2023-08-22T20:01:28.393000Z TestFramework (INFO): PRNG seed is: 8262915717492098124 
 test  2023-08-22T20:01:28.394000Z TestFramework (DEBUG): Setting up network thread 
 test  2023-08-22T20:01:28.394000Z TestFramework (INFO): Initializing test directory /tmp/bitcoin_func_test_dpo_q17r 
 test  2023-08-22T20:01:28.396000Z TestFramework.node0 (DEBUG): bitcoind started, waiting for RPC to come up 
 node0 2023-08-22T20:01:28.568202Z [init] [init/common.cpp:153] [LogPackageVersion] Bitcoin Core version v25.99.0-1e8512738737 (debug build) 
 node0 2023-08-22T20:01:28.568561Z [init] [init.cpp:690] [InitParameterInteraction] InitParameterInteraction: parameter interaction: -bind set -> setting -listen=1 
 node0 2023-08-22T20:01:28.569213Z [init] [kernel/context.cpp:24] [Context] Using the 'arm_shani(1way,2way)' SHA256 implementation 
 node0 2023-08-22T20:01:28.572760Z [init] [init/common.cpp:124] [StartLogging] Default data directory /Users/matthewzipkin/Library/Application Support/Bitcoin 
 node0 2023-08-22T20:01:28.572776Z [init] [init/common.cpp:125] [StartLogging] Using data directory /tmp/bitcoin_func_test_dpo_q17r/node0/regtest 
 node0 2023-08-22T20:01:28.572793Z [init] [init/common.cpp:130] [StartLogging] Config file: /tmp/bitcoin_func_test_dpo_q17r/node0/bitcoin.conf 
 node0 2023-08-22T20:01:28.572817Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: regtest="1" 
 node0 2023-08-22T20:01:28.572836Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] bind="127.0.0.1" 
 node0 2023-08-22T20:01:28.572850Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] connect="0" 
 node0 2023-08-22T20:01:28.572864Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] discover="0" 
 node0 2023-08-22T20:01:28.572877Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] dnsseed="0" 
 node0 2023-08-22T20:01:28.572892Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] fallbackfee="0.0002" 
 node0 2023-08-22T20:01:28.572905Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] fixedseeds="0" 
 node0 2023-08-22T20:01:28.572918Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] keypool="1" 
 node0 2023-08-22T20:01:28.572931Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] listenonion="0" 
 node0 2023-08-22T20:01:28.572949Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] natpmp="0" 
 node0 2023-08-22T20:01:28.572963Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] peertimeout="999999999" 
 node0 2023-08-22T20:01:28.572976Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] port="11617" 
 node0 2023-08-22T20:01:28.572992Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] printtoconsole="0" 
 node0 2023-08-22T20:01:28.573010Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] rpcdoccheck="1" 
 node0 2023-08-22T20:01:28.573028Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] rpcport="16617" 
 node0 2023-08-22T20:01:28.573046Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] rpcservertimeout="99000" 
 node0 2023-08-22T20:01:28.573063Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] server="1" 
 node0 2023-08-22T20:01:28.573079Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] shrinkdebugfile="0" 
 node0 2023-08-22T20:01:28.573093Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] unsafesqlitesync="1" 
 node0 2023-08-22T20:01:28.573106Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] upnp="0" 
 node0 2023-08-22T20:01:28.573120Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: datadir="/tmp/bitcoin_func_test_dpo_q17r/node0" 
 node0 2023-08-22T20:01:28.573136Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: debug="" 
 node0 2023-08-22T20:01:28.573151Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: debugexclude="libevent" 
 node0 2023-08-22T20:01:28.573166Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: debugexclude="leveldb" 
 node0 2023-08-22T20:01:28.573181Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: debugexclude="rand" 
 node0 2023-08-22T20:01:28.573194Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: disablewallet="" 
 node0 2023-08-22T20:01:28.573208Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: fastprune="" 
 node0 2023-08-22T20:01:28.573222Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: loglevel="trace" 
 node0 2023-08-22T20:01:28.573237Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: logsourcelocations="" 
 node0 2023-08-22T20:01:28.573260Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: logthreadnames="" 
 node0 2023-08-22T20:01:28.573273Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: logtimemicros="" 
 node0 2023-08-22T20:01:28.573287Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: uacomment="testnode0" 
 node0 2023-08-22T20:01:28.573297Z [init] [init.cpp:1082] [AppInitMain] Using at most 125 automatic connections (285 file descriptors available) 
 node0 2023-08-22T20:01:28.582855Z [init] [script/sigcache.cpp:104] [InitSignatureCache] Using 16 MiB out of 16 MiB requested for signature cache, able to store 524288 elements 
 node0 2023-08-22T20:01:28.591463Z [init] [validation.cpp:1743] [InitScriptExecutionCache] Using 16 MiB out of 16 MiB requested for script execution cache, able to store 524288 elements 
 node0 2023-08-22T20:01:28.591534Z [init] [init.cpp:1114] [AppInitMain] Script verification uses 7 additional threads 
 node0 2023-08-22T20:01:28.591944Z [scheduler] [util/thread.cpp:20] [TraceThread] scheduler thread start 
 node0 2023-08-22T20:01:28.592302Z [init] [wallet/init.cpp:132] [Construct] Wallet disabled! 
 node0 2023-08-22T20:01:28.602523Z [init] [httpserver.cpp:188] [InitHTTPAllowList] [http] Allowing HTTP connections from: 127.0.0.0/8 ::1/128 
 node0 2023-08-22T20:01:28.603287Z [init] [httpserver.cpp:334] [HTTPBindAddresses] Binding RPC on address ::1 port 16617 
 node0 2023-08-22T20:01:28.603854Z [init] [httpserver.cpp:334] [HTTPBindAddresses] Binding RPC on address 127.0.0.1 port 16617 
 node0 2023-08-22T20:01:28.603887Z [init] [httpserver.cpp:413] [InitHTTPServer] [http] Initialized HTTP server 
 node0 2023-08-22T20:01:28.603906Z [init] [httpserver.cpp:415] [InitHTTPServer] [http] creating work queue of depth 16 
 node0 2023-08-22T20:01:28.603944Z [init] [rpc/server.cpp:292] [StartRPC] [rpc] Starting RPC 
 node0 2023-08-22T20:01:28.604157Z [init] [httprpc.cpp:297] [StartHTTPRPC] [rpc] Starting HTTP RPC server 
 node0 2023-08-22T20:01:28.604174Z [init] [httprpc.cpp:246] [InitRPCAuthentication] Using random cookie authentication. 
 node0 2023-08-22T20:01:28.604388Z [init] [rpc/request.cpp:108] [GenerateAuthCookie] Generated RPC authentication cookie /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/.cookie 
 node0 2023-08-22T20:01:28.604435Z [init] [httpserver.cpp:698] [RegisterHTTPHandler] [http] Registering HTTP handler for / (exactmatch 1) 
 node0 2023-08-22T20:01:28.604454Z [init] [httpserver.cpp:698] [RegisterHTTPHandler] [http] Registering HTTP handler for /wallet/ (exactmatch 0) 
 node0 2023-08-22T20:01:28.604472Z [init] [httpserver.cpp:437] [StartHTTPServer] [http] Starting HTTP server 
 node0 2023-08-22T20:01:28.604487Z [init] [httpserver.cpp:439] [StartHTTPServer] [http] starting 4 worker threads 
 node0 2023-08-22T20:01:28.604515Z [http] [httpserver.cpp:301] [ThreadHTTP] [http] Entering http event loop 
 node0 2023-08-22T20:01:28.604567Z [httpworker.1] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs, httpserver.cpp:106 started 
 node0 2023-08-22T20:01:28.604591Z [httpworker.3] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs, httpserver.cpp:106 started 
 node0 2023-08-22T20:01:28.604607Z [httpworker.2] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs, httpserver.cpp:106 started 
 node0 2023-08-22T20:01:28.604618Z [init] [init.cpp:1201] [AppInitMain] Using /16 prefix for IP bucketing 
 node0 2023-08-22T20:01:28.604634Z [init] [noui.cpp:56] [noui_InitMessage] init message: Loading P2P addresses… 
 node0 2023-08-22T20:01:28.604670Z [httpworker.1] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs, httpserver.cpp:106 completed (78μs) 
 node0 2023-08-22T20:01:28.604688Z [httpworker.3] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs, httpserver.cpp:106 completed (81μs) 
 node0 2023-08-22T20:01:28.604706Z [httpworker.2] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs, httpserver.cpp:106 completed (86μs) 
 node0 2023-08-22T20:01:28.605357Z [init] [addrdb.cpp:199] [LoadAddrman] Creating peers.dat because the file was not found ("/tmp/bitcoin_func_test_dpo_q17r/node0/regtest/peers.dat") 
 node0 2023-08-22T20:01:28.611971Z [init] [noui.cpp:56] [noui_InitMessage] init message: Loading banlist… 
 node0 2023-08-22T20:01:28.612011Z [init] [banman.cpp:42] [LoadBanlist] Recreating the banlist database 
 node0 2023-08-22T20:01:28.616726Z [init] [banman.cpp:68] [DumpBanlist] [net] Flushed 0 banned node addresses/subnets to disk  1ms 
 node0 2023-08-22T20:01:28.618108Z [init] [net.cpp:1548] [SetTryNewOutboundPeer] [net] setting try another outbound peer=false 
 node0 2023-08-22T20:01:28.618162Z [init] [net.cpp:2280] [SetNetworkActive] SetNetworkActive: true 
 node0 2023-08-22T20:01:28.621423Z [init] [policy/fees.cpp:553] [CBlockPolicyEstimator] /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/fee_estimates.dat is not found. Continue anyway. 
 node0 2023-08-22T20:01:28.621980Z [init] [init.cpp:1440] [AppInitMain] Cache configuration: 
 node0 2023-08-22T20:01:28.621992Z [init] [init.cpp:1441] [AppInitMain] * Using 2.0 MiB for block index database 
 node0 2023-08-22T20:01:28.622008Z [init] [init.cpp:1449] [AppInitMain] * Using 8.0 MiB for chain state database 
 node0 2023-08-22T20:01:28.622099Z [init] [init.cpp:1468] [AppInitMain] * Using 440.0 MiB for in-memory UTXO set (plus up to 286.1 MiB of unused mempool space) 
 node0 2023-08-22T20:01:28.622563Z [init] [noui.cpp:56] [noui_InitMessage] init message: Loading block index… 
 node0 2023-08-22T20:01:28.622578Z [init] [node/chainstate.cpp:167] [LoadChainstate] Validating signatures for all blocks. 
 node0 2023-08-22T20:01:28.622589Z [init] [node/chainstate.cpp:169] [LoadChainstate] Setting nMinimumChainWork=0000000000000000000000000000000000000000000000000000000000000000 
 node0 2023-08-22T20:01:28.623018Z [init] [dbwrapper.cpp:242] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/blocks/index 
 node0 2023-08-22T20:01:28.640797Z [init] [dbwrapper.cpp:250] [CDBWrapper] Opened LevelDB successfully 
 node0 2023-08-22T20:01:28.640882Z [init] [dbwrapper.cpp:275] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/blocks/index: 0000000000000000 
 node0 2023-08-22T20:01:28.641163Z [init] [node/blockstorage.cpp:325] [LoadBlockIndexDB] LoadBlockIndexDB: last block file = 0 
 node0 2023-08-22T20:01:28.641196Z [init] [node/blockstorage.cpp:329] [LoadBlockIndexDB] LoadBlockIndexDB: last block file info: CBlockFileInfo(blocks=0, size=0, heights=0...0, time=1970-01-01...1970-01-01) 
 node0 2023-08-22T20:01:28.641209Z [init] [node/blockstorage.cpp:340] [LoadBlockIndexDB] Checking all blk files are present... 
 node0 2023-08-22T20:01:28.641225Z [init] [validation.cpp:4470] [LoadBlockIndex] Initializing databases... 
 node0 2023-08-22T20:01:28.641382Z [init] [flatfile.cpp:69] [Allocate] [validation] Pre-allocating up to position 0x4000 in blk00000.dat 
 node0 2023-08-22T20:01:28.641716Z [init] [node/chainstate.cpp:107] [CompleteChainstateInitialization] Initializing chainstate Chainstate [ibd] @ height -1 (null) 
 node0 2023-08-22T20:01:28.641774Z [init] [dbwrapper.cpp:242] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/chainstate 
 node0 2023-08-22T20:01:28.656484Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55180 
 node0 2023-08-22T20:01:28.657836Z [httpworker.0] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=getblockcount user=__cookie__ 
 node0 2023-08-22T20:01:28.657927Z [init] [dbwrapper.cpp:250] [CDBWrapper] Opened LevelDB successfully 
 node0 2023-08-22T20:01:28.658045Z [init] [dbwrapper.cpp:272] [CDBWrapper] Wrote new obfuscate key for /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/chainstate: dc00fb4b6f43968c 
 node0 2023-08-22T20:01:28.658060Z [init] [dbwrapper.cpp:275] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/chainstate: dc00fb4b6f43968c 
 node0 2023-08-22T20:01:28.659009Z [init] [validation.cpp:5567] [MaybeRebalanceCaches] [snapshot] allocating all cache to the IBD chainstate 
 node0 2023-08-22T20:01:28.659373Z [init] [dbwrapper.cpp:242] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/chainstate 
 node0 2023-08-22T20:01:28.677855Z [init] [dbwrapper.cpp:250] [CDBWrapper] Opened LevelDB successfully 
 node0 2023-08-22T20:01:28.677910Z [init] [dbwrapper.cpp:275] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/chainstate: dc00fb4b6f43968c 
 node0 2023-08-22T20:01:28.677932Z [init] [validation.cpp:4948] [ResizeCoinsCaches] [Chainstate [ibd] @ height -1 (null)] resized coinsdb cache to 8.0 MiB 
 node0 2023-08-22T20:01:28.677956Z [init] [validation.cpp:4950] [ResizeCoinsCaches] [Chainstate [ibd] @ height -1 (null)] resized coinstip cache to 440.0 MiB 
 node0 2023-08-22T20:01:28.678072Z [init] [noui.cpp:56] [noui_InitMessage] init message: Verifying blocks… 
 node0 2023-08-22T20:01:28.678110Z [init] [init.cpp:1511] [AppInitMain]  block index              55ms 
 node0 2023-08-22T20:01:28.682779Z [init] [init.cpp:1600] [AppInitMain] Setting NODE_NETWORK on non-prune mode 
 node0 2023-08-22T20:01:28.682941Z [initload] [util/thread.cpp:20] [TraceThread] initload thread start 
 node0 2023-08-22T20:01:28.683319Z [initload] [validation.cpp:2816] [ConnectTip] [bench]   - Load block from disk: 0.30ms 
 node0 2023-08-22T20:01:28.683706Z [initload] [validationinterface.cpp:255] [BlockChecked] [validation] BlockChecked: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 state=Valid 
 node0 2023-08-22T20:01:28.683922Z [initload] [validation.cpp:2832] [ConnectTip] [bench]   - Connect total: 0.60ms [0.00s (0.60ms/blk)] 
 node0 2023-08-22T20:01:28.685335Z [initload] [validation.cpp:2841] [ConnectTip] [bench]   - Flush: 1.41ms [0.00s (1.41ms/blk)] 
 node0 2023-08-22T20:01:28.685360Z [initload] [validation.cpp:2851] [ConnectTip] [bench]   - Writing chainstate: 0.03ms [0.00s (0.03ms/blk)] 
 node0 2023-08-22T20:01:28.685434Z [initload] [validation.cpp:2613] [UpdateTipLog] UpdateTip: new best=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 height=0 version=0x00000001 log2_work=1.000000 tx=1 date='2011-02-02T23:16:42Z' progress=1.000000 cache=0.3MiB(0txo) 
 node0 2023-08-22T20:01:28.685448Z [initload] [validation.cpp:2867] [ConnectTip] [bench]   - Connect postprocess: 0.09ms [0.00s (0.09ms/blk)] 
 node0 2023-08-22T20:01:28.685459Z [initload] [validation.cpp:2871] [ConnectTip] [bench] - Connect block: 2.43ms [0.00s (2.43ms/blk)] 
 node0 2023-08-22T20:01:28.685478Z [initload] [txmempool.cpp:660] [check] [mempool] Checking mempool with 0 transactions and 0 inputs 
 node0 2023-08-22T20:01:28.686383Z [initload] [validationinterface.cpp:232] [BlockConnected] [validation] Enqueuing BlockConnected: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 block height=0 
 node0 2023-08-22T20:01:28.686626Z [initload] [validationinterface.cpp:204] [UpdatedBlockTip] [validation] Enqueuing UpdatedBlockTip: new block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 fork block hash=null (in IBD=true) 
 node0 2023-08-22T20:01:28.686650Z [scheduler] [validationinterface.cpp:232] [operator()] [validation] BlockConnected: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 block height=0 
 node0 2023-08-22T20:01:28.686702Z [init] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs_main, init.cpp:1705 started 
 node0 2023-08-22T20:01:28.686722Z [init] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs_main, init.cpp:1705 completed (1μs) 
 node0 2023-08-22T20:01:28.686738Z [initload] [logging/timer.h:58] [Log] [lock] Enter: lock contention ::cs_main, validation.cpp:5548 started 
 node0 2023-08-22T20:01:28.686751Z [init] [init.cpp:1706] [AppInitMain] block tree size = 1 
 node0 2023-08-22T20:01:28.686767Z [scheduler] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs_main, net_processing.cpp:1861 started 
 node0 2023-08-22T20:01:28.686782Z [init] [init.cpp:1718] [AppInitMain] nBestHeight = 0 
 node0 2023-08-22T20:01:28.686797Z [initload] [logging/timer.h:58] [Log] [lock] Enter: lock contention ::cs_main, validation.cpp:5548 completed (22μs) 
 node0 2023-08-22T20:01:28.686817Z [scheduler] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs_main, net_processing.cpp:1861 completed (33μs) 
 node0 2023-08-22T20:01:28.686831Z [initload] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs_args, common/args.cpp:774 started 
 node0 2023-08-22T20:01:28.686854Z [initload] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs_args, common/args.cpp:774 completed (8μs) 
 node0 2023-08-22T20:01:28.686869Z [init] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs_args, common/args.cpp:782 started 
 node0 2023-08-22T20:01:28.686897Z [init] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs_args, common/args.cpp:782 completed (1μs) 
 node0 2023-08-22T20:01:28.686911Z [scheduler] [validationinterface.cpp:204] [operator()] [validation] UpdatedBlockTip: new block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 fork block hash=null (in IBD=true) 
 node0 2023-08-22T20:01:28.686927Z [initload] [kernel/mempool_persist.cpp:46] [LoadMempool] Failed to open mempool file from disk. Continuing anyway. 
 node0 2023-08-22T20:01:28.686945Z [initload] [util/thread.cpp:22] [TraceThread] initload thread exit 
 node0 2023-08-22T20:01:28.687114Z [init] [net.cpp:2216] [BindListenPort] Bound to 127.0.0.1:11617 
 node0 2023-08-22T20:01:28.687149Z [init] [net.cpp:2216] [BindListenPort] Bound to 127.0.0.1:18445 
 node0 2023-08-22T20:01:28.687171Z [init] [noui.cpp:56] [noui_InitMessage] init message: Starting network threads… 
 node0 2023-08-22T20:01:28.687280Z [net] [util/thread.cpp:20] [TraceThread] net thread start 
 node0 2023-08-22T20:01:28.687293Z [init] [net.cpp:2419] [Start] DNS seeding disabled 
 node0 2023-08-22T20:01:28.687343Z [addcon] [util/thread.cpp:20] [TraceThread] addcon thread start 
 node0 2023-08-22T20:01:28.687434Z [msghand] [util/thread.cpp:20] [TraceThread] msghand thread start 
 node0 2023-08-22T20:01:28.687478Z [init] [noui.cpp:56] [noui_InitMessage] init message: Done loading 
 node0 2023-08-22T20:01:28.915876Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55181 
 node0 2023-08-22T20:01:28.916352Z [httpworker.1] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=getblockcount user=__cookie__ 
 node0 2023-08-22T20:01:28.917573Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55181 
 node0 2023-08-22T20:01:28.917934Z [httpworker.3] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=getmempoolinfo user=__cookie__ 
 test  2023-08-22T20:01:28.919000Z TestFramework.node0 (DEBUG): RPC successfully started 
 node0 2023-08-22T20:01:28.919885Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55181 
 node0 2023-08-22T20:01:28.920141Z [httpworker.2] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=getbestblockhash user=__cookie__ 
 node0 2023-08-22T20:01:28.920871Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55181 
 node0 2023-08-22T20:01:28.921088Z [httpworker.0] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ 
 test  2023-08-22T20:01:28.922000Z TestFramework (DEBUG): Generate block big enough to start second block file 
 node0 2023-08-22T20:01:28.922006Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55181 
 node0 2023-08-22T20:01:28.922192Z [httpworker.1] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=syncwithvalidationinterfacequeue user=__cookie__ 
 node0 2023-08-22T20:01:28.924526Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55181 
 node0 2023-08-22T20:01:28.926692Z [httpworker.3] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=generateblock user=__cookie__ 
 node0 2023-08-22T20:01:28.964227Z [httpworker.3] [node/miner.cpp:163] [CreateNewBlock] CreateNewBlock(): block weight: 262960 txs: 0 fees: 0 sigops 400 
 node0 2023-08-22T20:01:28.979159Z [httpworker.3] [validation.cpp:2145] [ConnectBlock] [bench]     - Sanity checks: 4.66ms [0.00s (2.33ms/blk)] 
 node0 2023-08-22T20:01:28.979270Z [httpworker.3] [validation.cpp:2247] [ConnectBlock] [bench]     - Fork checks: 0.15ms [0.00s (0.07ms/blk)] 
 node0 2023-08-22T20:01:28.984291Z [httpworker.3] [validation.cpp:2337] [ConnectBlock] [bench]       - Connect 1 transactions: 5.00ms (5.000ms/tx, 0.000ms/txin) [0.00s (2.50ms/blk)] 
 node0 2023-08-22T20:01:28.984383Z [httpworker.3] [validation.cpp:2355] [ConnectBlock] [bench]     - Verify 0 txins: 5.11ms (0.000ms/txin) [0.01s (2.56ms/blk)] 
 node0 2023-08-22T20:01:28.985195Z [httpworker.3] [node/miner.cpp:182] [CreateNewBlock] [bench] CreateNewBlock() packages: 0.29ms (0 packages, 0 updated descendants), validity: 24.94ms (total 25.23ms) 
 node0 2023-08-22T20:01:28.996393Z [httpworker.3] [validation.cpp:2145] [ConnectBlock] [bench]     - Sanity checks: 3.67ms [0.01s (2.78ms/blk)] 
 node0 2023-08-22T20:01:28.996478Z [httpworker.3] [validation.cpp:2247] [ConnectBlock] [bench]     - Fork checks: 0.11ms [0.00s (0.09ms/blk)] 
 node0 2023-08-22T20:01:29.000657Z [httpworker.3] [validation.cpp:2337] [ConnectBlock] [bench]       - Connect 1 transactions: 4.17ms (4.170ms/tx, 0.000ms/txin) [0.01s (3.06ms/blk)] 
 node0 2023-08-22T20:01:29.000702Z [httpworker.3] [validation.cpp:2355] [ConnectBlock] [bench]     - Verify 0 txins: 4.22ms (0.000ms/txin) [0.01s (3.11ms/blk)] 
 node0 2023-08-22T20:01:29.004905Z [httpworker.3] [validation.cpp:3878] [AcceptBlockHeader] [validation:debug] Saw new header hash=1b771cb05f19315d212df6f9d0745160cdddbe5e99cfb5e7745d8dd948165d72 height=1 
 node0 2023-08-22T20:01:29.004974Z [httpworker.3] [node/blockstorage.cpp:659] [FindBlockPos] [blockstorage] Leaving block file 0: CBlockFileInfo(blocks=1, size=293, heights=0...0, time=2011-02-02...2011-02-02) 
 node0 2023-08-22T20:01:29.013943Z [httpworker.3] [flatfile.cpp:69] [Allocate] [validation] Pre-allocating up to position 0x14000 in blk00001.dat 
 node0 2023-08-22T20:01:29.014477Z [httpworker.3] [validation.cpp:2806] [ConnectTip] [bench]   - Using cached block 
 node0 2023-08-22T20:01:29.014491Z [httpworker.3] [validation.cpp:2816] [ConnectTip] [bench]   - Load block from disk: 0.02ms 
 node0 2023-08-22T20:01:29.014523Z [httpworker.3] [validation.cpp:2145] [ConnectBlock] [bench]     - Sanity checks: 0.00ms [0.01s (2.08ms/blk)] 
 node0 2023-08-22T20:01:29.014565Z [httpworker.3] [validation.cpp:2247] [ConnectBlock] [bench]     - Fork checks: 0.04ms [0.00s (0.08ms/blk)] 
 node0 2023-08-22T20:01:29.018020Z [httpworker.3] [validation.cpp:2337] [ConnectBlock] [bench]       - Connect 1 transactions: 3.45ms (3.454ms/tx, 0.000ms/txin) [0.01s (3.16ms/blk)] 
 node0 2023-08-22T20:01:29.018045Z [httpworker.3] [validation.cpp:2355] [ConnectBlock] [bench]     - Verify 0 txins: 3.48ms (0.000ms/txin) [0.01s (3.20ms/blk)] 
 node0 2023-08-22T20:01:29.018134Z [httpworker.3] [flatfile.cpp:69] [Allocate] [validation] Pre-allocating up to position 0x100000 in rev00001.dat 
 node0 2023-08-22T20:01:29.018963Z [httpworker.3] [validation.cpp:2369] [ConnectBlock] [bench]     - Write undo data: 0.92ms [0.00s (0.23ms/blk)] 
 node0 2023-08-22T20:01:29.018976Z [httpworker.3] [validation.cpp:2384] [ConnectBlock] [bench]     - Index writing: 0.01ms [0.00s (0.00ms/blk)] 
 node0 2023-08-22T20:01:29.018996Z [httpworker.3] [validationinterface.cpp:255] [BlockChecked] [validation] BlockChecked: block hash=1b771cb05f19315d212df6f9d0745160cdddbe5e99cfb5e7745d8dd948165d72 state=Valid 
 node0 2023-08-22T20:01:29.019022Z [httpworker.3] [validation.cpp:2832] [ConnectTip] [bench]   - Connect total: 4.53ms [0.01s (1.28ms/blk)] 
 node0 2023-08-22T20:01:29.020338Z [httpworker.3] [validation.cpp:2841] [ConnectTip] [bench]   - Flush: 1.32ms [0.00s (0.68ms/blk)] 
 node0 2023-08-22T20:01:29.020357Z [httpworker.3] [validation.cpp:2851] [ConnectTip] [bench]   - Writing chainstate: 0.02ms [0.00s (0.01ms/blk)] 
 node0 2023-08-22T20:01:29.020596Z [httpworker.3] [policy/fees.cpp:681] [processBlock] [estimatefee] Blockpolicy estimates updated by 0 of 0 block txs, since last block 0 of 0 tracked, mempool map size 0, max target 0 from current 
 node0 2023-08-22T20:01:29.020620Z [httpworker.3] [validation.cpp:1645] [IsInitialBlockDownload] Leaving InitialBlockDownload (latching to false) 
 node0 2023-08-22T20:01:29.020663Z [httpworker.3] [validation.cpp:2613] [UpdateTipLog] UpdateTip: new best=1b771cb05f19315d212df6f9d0745160cdddbe5e99cfb5e7745d8dd948165d72 height=1 version=0x20000000 log2_work=2.000000 tx=2 date='2023-08-22T20:01:28Z' progress=1.000000 cache=0.3MiB(0txo) 
 node0 2023-08-22T20:01:29.020675Z [httpworker.3] [validation.cpp:2867] [ConnectTip] [bench]   - Connect postprocess: 0.32ms [0.00s (0.10ms/blk)] 
 node0 2023-08-22T20:01:29.020685Z [httpworker.3] [validation.cpp:2871] [ConnectTip] [bench] - Connect block: 6.20ms [0.01s (2.16ms/blk)] 
 node0 2023-08-22T20:01:29.020704Z [httpworker.3] [txmempool.cpp:660] [check] [mempool] Checking mempool with 0 transactions and 0 inputs 
 node0 2023-08-22T20:01:29.021407Z [httpworker.3] [validationinterface.cpp:232] [BlockConnected] [validation] Enqueuing BlockConnected: block hash=1b771cb05f19315d212df6f9d0745160cdddbe5e99cfb5e7745d8dd948165d72 block height=1 
 node0 2023-08-22T20:01:29.021441Z [httpworker.3] [validationinterface.cpp:204] [UpdatedBlockTip] [validation] Enqueuing UpdatedBlockTip: new block hash=1b771cb05f19315d212df6f9d0745160cdddbe5e99cfb5e7745d8dd948165d72 fork block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 (in IBD=false) 
 node0 2023-08-22T20:01:29.021469Z [scheduler] [validationinterface.cpp:232] [operator()] [validation] BlockConnected: block hash=1b771cb05f19315d212df6f9d0745160cdddbe5e99cfb5e7745d8dd948165d72 block height=1 
 node0 2023-08-22T20:01:29.021558Z [scheduler] [validationinterface.cpp:204] [operator()] [validation] UpdatedBlockTip: new block hash=1b771cb05f19315d212df6f9d0745160cdddbe5e99cfb5e7745d8dd948165d72 fork block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 (in IBD=false) 
 node0 2023-08-22T20:01:29.022021Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55181 
 node0 2023-08-22T20:01:29.022113Z [httpworker.2] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=getbestblockhash user=__cookie__ 
 node0 2023-08-22T20:01:29.022414Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55181 
 node0 2023-08-22T20:01:29.022478Z [httpworker.0] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ 
 node0 2023-08-22T20:01:29.022800Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55181 
 node0 2023-08-22T20:01:29.022857Z [httpworker.1] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=syncwithvalidationinterfacequeue user=__cookie__ 
 test  2023-08-22T20:01:29.023000Z TestFramework.node0 (DEBUG): Stopping node 
 node0 2023-08-22T20:01:29.023120Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55181 
 node0 2023-08-22T20:01:29.023174Z [httpworker.3] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=getblockcount user=__cookie__ 
 node0 2023-08-22T20:01:29.023510Z [http] [httpserver.cpp:255] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:55181 
 node0 2023-08-22T20:01:29.023583Z [httpworker.2] [rpc/request.cpp:181] [parse] [rpc] ThreadRPCServer method=stop user=__cookie__ 
 node0 2023-08-22T20:01:29.023664Z [init] [httpserver.cpp:449] [InterruptHTTPServer] [http] Interrupting HTTP server 
 node0 2023-08-22T20:01:29.023684Z [init] [httprpc.cpp:315] [InterruptHTTPRPC] [rpc] Interrupting HTTP RPC server 
 node0 2023-08-22T20:01:29.023695Z [init] [rpc/server.cpp:302] [operator()] [rpc] Interrupting RPC 
 node0 2023-08-22T20:01:29.023752Z [addcon] [util/thread.cpp:22] [TraceThread] addcon thread exit 
 node0 2023-08-22T20:01:29.023770Z [init] [init.cpp:243] [Shutdown] Shutdown: In progress... 
 node0 2023-08-22T20:01:29.023786Z [shutoff] [httprpc.cpp:320] [StopHTTPRPC] [rpc] Stopping HTTP RPC server 
 node0 2023-08-22T20:01:29.023802Z [shutoff] [httpserver.cpp:713] [UnregisterHTTPHandler] [http] Unregistering HTTP handler for / (exactmatch 1) 
 node0 2023-08-22T20:01:29.023817Z [shutoff] [httpserver.cpp:713] [UnregisterHTTPHandler] [http] Unregistering HTTP handler for /wallet/ (exactmatch 0) 
 node0 2023-08-22T20:01:29.023840Z [shutoff] [rpc/server.cpp:314] [operator()] [rpc] Stopping RPC 
 node0 2023-08-22T20:01:29.023964Z [shutoff] [init.cpp:408] [OnRPCStopped] [rpc] RPC stopped. 
 node0 2023-08-22T20:01:29.023976Z [shutoff] [httpserver.cpp:461] [StopHTTPServer] [http] Stopping HTTP server 
 node0 2023-08-22T20:01:29.023985Z [shutoff] [httpserver.cpp:463] [StopHTTPServer] [http] Waiting for HTTP worker threads to exit 
 node0 2023-08-22T20:01:29.024029Z [http] [httpserver.cpp:304] [ThreadHTTP] [http] Exited http event loop 
 node0 2023-08-22T20:01:29.024044Z [shutoff] [httpserver.cpp:494] [StopHTTPServer] [http] Waiting for HTTP event thread to exit 
 node0 2023-08-22T20:01:29.024066Z [shutoff] [httpserver.cpp:500] [StopHTTPServer] [http] Stopped HTTP server 
 node0 2023-08-22T20:01:29.062780Z [net] [util/thread.cpp:22] [TraceThread] net thread exit 
 node0 2023-08-22T20:01:29.126662Z [msghand] [util/thread.cpp:22] [TraceThread] msghand thread exit 
 node0 2023-08-22T20:01:29.133484Z [shutoff] [net.cpp:1519] [DumpAddresses] [net] Flushed 0 addresses to peers.dat  6ms 
 node0 2023-08-22T20:01:29.133562Z [scheduler] [util/thread.cpp:22] [TraceThread] scheduler thread exit 
 node0 2023-08-22T20:01:29.139276Z [shutoff] [kernel/mempool_persist.cpp:175] [DumpMempool] Writing 0 unbroadcast transactions to disk. 
 node0 2023-08-22T20:01:29.144136Z [shutoff] [kernel/mempool_persist.cpp:188] [DumpMempool] Dumped mempool: 3.2625e-05s to copy, 0.00495892s to dump 
 node0 2023-08-22T20:01:29.144171Z [shutoff] [policy/fees.cpp:1031] [FlushUnconfirmed] [estimatefee] Recorded 0 unconfirmed txs from mempool in 6.166e-06s 
 node0 2023-08-22T20:01:29.149224Z [shutoff] [policy/fees.cpp:929] [FlushFeeEstimates] Flushed fee estimates to fee_estimates.dat. 
 node0 2023-08-22T20:01:29.149399Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started 
 node0 2023-08-22T20:01:29.157987Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (8.56ms) 
 node0 2023-08-22T20:01:29.158018Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started 
 node0 2023-08-22T20:01:29.162106Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (4.06ms) 
 node0 2023-08-22T20:01:29.162156Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) started 
 node0 2023-08-22T20:01:29.162282Z [shutoff] [txdb.cpp:167] [BatchWrite] [coindb] Writing final batch of 0.00 MiB 
 node0 2023-08-22T20:01:29.162429Z [shutoff] [txdb.cpp:169] [BatchWrite] [coindb] Committed 0 changed transaction outputs (out of 0) to coin database... 
 node0 2023-08-22T20:01:29.163715Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) completed (1.53ms) 
 node0 2023-08-22T20:01:29.163752Z [shutoff] [validationinterface.cpp:250] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=1b771cb05f19315d212df6f9d0745160cdddbe5e99cfb5e7745d8dd948165d72 
 node0 2023-08-22T20:01:29.163842Z [shutoff] [validationinterface.cpp:250] [operator()] [validation] ChainStateFlushed: block hash=1b771cb05f19315d212df6f9d0745160cdddbe5e99cfb5e7745d8dd948165d72 
 node0 2023-08-22T20:01:29.163917Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started 
 node0 2023-08-22T20:01:29.168044Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (4.10ms) 
 node0 2023-08-22T20:01:29.168091Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started 
 node0 2023-08-22T20:01:29.171922Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (3.80ms) 
 node0 2023-08-22T20:01:29.171974Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) started 
 node0 2023-08-22T20:01:29.172072Z [shutoff] [txdb.cpp:167] [BatchWrite] [coindb] Writing final batch of 0.00 MiB 
 node0 2023-08-22T20:01:29.172128Z [shutoff] [txdb.cpp:169] [BatchWrite] [coindb] Committed 0 changed transaction outputs (out of 0) to coin database... 
 node0 2023-08-22T20:01:29.173734Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) completed (1.73ms) 
 node0 2023-08-22T20:01:29.173788Z [shutoff] [validationinterface.cpp:250] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=1b771cb05f19315d212df6f9d0745160cdddbe5e99cfb5e7745d8dd948165d72 
 node0 2023-08-22T20:01:29.180566Z [shutoff] [init.cpp:359] [Shutdown] Shutdown: done 
 test  2023-08-22T20:01:29.244000Z TestFramework.node0 (DEBUG): Node stopped 
 test  2023-08-22T20:01:29.244000Z TestFramework (DEBUG): Make the first block file read-only 
 test  2023-08-22T20:01:29.247000Z TestFramework (WARNING): Can not make file immutable ([Errno 2] No such file or directory: 'chattr'), trying read-only instead 
 test  2023-08-22T20:01:29.248000Z TestFramework (DEBUG): Attempt to restart and reindex the node with the unwritable block file 
 test  2023-08-22T20:01:29.251000Z TestFramework.node0 (DEBUG): bitcoind started, waiting for RPC to come up 
 node0 2023-08-22T20:01:29.398147Z [init] [init/common.cpp:153] [LogPackageVersion] Bitcoin Core version v25.99.0-1e8512738737 (debug build) 
 node0 2023-08-22T20:01:29.398403Z [init] [init.cpp:690] [InitParameterInteraction] InitParameterInteraction: parameter interaction: -bind set -> setting -listen=1 
 node0 2023-08-22T20:01:29.398755Z [init] [kernel/context.cpp:24] [Context] Using the 'arm_shani(1way,2way)' SHA256 implementation 
 node0 2023-08-22T20:01:29.402024Z [init] [init/common.cpp:124] [StartLogging] Default data directory /Users/matthewzipkin/Library/Application Support/Bitcoin 
 node0 2023-08-22T20:01:29.402043Z [init] [init/common.cpp:125] [StartLogging] Using data directory /tmp/bitcoin_func_test_dpo_q17r/node0/regtest 
 node0 2023-08-22T20:01:29.402061Z [init] [init/common.cpp:130] [StartLogging] Config file: /tmp/bitcoin_func_test_dpo_q17r/node0/bitcoin.conf 
 node0 2023-08-22T20:01:29.402090Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: regtest="1" 
 node0 2023-08-22T20:01:29.402104Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] bind="127.0.0.1" 
 node0 2023-08-22T20:01:29.402117Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] connect="0" 
 node0 2023-08-22T20:01:29.402129Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] discover="0" 
 node0 2023-08-22T20:01:29.402140Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] dnsseed="0" 
 node0 2023-08-22T20:01:29.402153Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] fallbackfee="0.0002" 
 node0 2023-08-22T20:01:29.402164Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] fixedseeds="0" 
 node0 2023-08-22T20:01:29.402176Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] keypool="1" 
 node0 2023-08-22T20:01:29.402187Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] listenonion="0" 
 node0 2023-08-22T20:01:29.402203Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] natpmp="0" 
 node0 2023-08-22T20:01:29.402216Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] peertimeout="999999999" 
 node0 2023-08-22T20:01:29.402227Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] port="11617" 
 node0 2023-08-22T20:01:29.402241Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] printtoconsole="0" 
 node0 2023-08-22T20:01:29.402257Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] rpcdoccheck="1" 
 node0 2023-08-22T20:01:29.402273Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] rpcport="16617" 
 node0 2023-08-22T20:01:29.402290Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] rpcservertimeout="99000" 
 node0 2023-08-22T20:01:29.402305Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] server="1" 
 node0 2023-08-22T20:01:29.402319Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] shrinkdebugfile="0" 
 node0 2023-08-22T20:01:29.402333Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] unsafesqlitesync="1" 
 node0 2023-08-22T20:01:29.402344Z [init] [common/args.cpp:797] [logArgsPrefix] Config file arg: [regtest] upnp="0" 
 node0 2023-08-22T20:01:29.402357Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: datadir="/tmp/bitcoin_func_test_dpo_q17r/node0" 
 node0 2023-08-22T20:01:29.402370Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: debug="" 
 node0 2023-08-22T20:01:29.402384Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: debugexclude="libevent" 
 node0 2023-08-22T20:01:29.402398Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: debugexclude="leveldb" 
 node0 2023-08-22T20:01:29.402411Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: debugexclude="rand" 
 node0 2023-08-22T20:01:29.402422Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: disablewallet="" 
 node0 2023-08-22T20:01:29.402435Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: fastprune="" 
 node0 2023-08-22T20:01:29.402448Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: loglevel="trace" 
 node0 2023-08-22T20:01:29.402462Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: logsourcelocations="" 
 node0 2023-08-22T20:01:29.402475Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: logthreadnames="" 
 node0 2023-08-22T20:01:29.402487Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: logtimemicros="" 
 node0 2023-08-22T20:01:29.402497Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: reindex="" 
 node0 2023-08-22T20:01:29.402510Z [init] [common/args.cpp:797] [logArgsPrefix] Command-line arg: uacomment="testnode0" 
 node0 2023-08-22T20:01:29.402520Z [init] [init.cpp:1082] [AppInitMain] Using at most 125 automatic connections (285 file descriptors available) 
 node0 2023-08-22T20:01:29.410884Z [init] [script/sigcache.cpp:104] [InitSignatureCache] Using 16 MiB out of 16 MiB requested for signature cache, able to store 524288 elements 
 node0 2023-08-22T20:01:29.419943Z [init] [validation.cpp:1743] [InitScriptExecutionCache] Using 16 MiB out of 16 MiB requested for script execution cache, able to store 524288 elements 
 node0 2023-08-22T20:01:29.420011Z [init] [init.cpp:1114] [AppInitMain] Script verification uses 7 additional threads 
 node0 2023-08-22T20:01:29.420184Z [scheduler] [util/thread.cpp:20] [TraceThread] scheduler thread start 
 node0 2023-08-22T20:01:29.420240Z [init] [wallet/init.cpp:132] [Construct] Wallet disabled! 
 node0 2023-08-22T20:01:29.425210Z [init] [httpserver.cpp:188] [InitHTTPAllowList] [http] Allowing HTTP connections from: 127.0.0.0/8 ::1/128 
 node0 2023-08-22T20:01:29.425276Z [init] [httpserver.cpp:334] [HTTPBindAddresses] Binding RPC on address ::1 port 16617 
 node0 2023-08-22T20:01:29.425836Z [init] [httpserver.cpp:334] [HTTPBindAddresses] Binding RPC on address 127.0.0.1 port 16617 
 node0 2023-08-22T20:01:29.425867Z [init] [httpserver.cpp:413] [InitHTTPServer] [http] Initialized HTTP server 
 node0 2023-08-22T20:01:29.425885Z [init] [httpserver.cpp:415] [InitHTTPServer] [http] creating work queue of depth 16 
 node0 2023-08-22T20:01:29.425898Z [init] [rpc/server.cpp:292] [StartRPC] [rpc] Starting RPC 
 node0 2023-08-22T20:01:29.425934Z [init] [httprpc.cpp:297] [StartHTTPRPC] [rpc] Starting HTTP RPC server 
 node0 2023-08-22T20:01:29.425949Z [init] [httprpc.cpp:246] [InitRPCAuthentication] Using random cookie authentication. 
 node0 2023-08-22T20:01:29.426174Z [init] [rpc/request.cpp:108] [GenerateAuthCookie] Generated RPC authentication cookie /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/.cookie 
 node0 2023-08-22T20:01:29.426211Z [init] [httpserver.cpp:698] [RegisterHTTPHandler] [http] Registering HTTP handler for / (exactmatch 1) 
 node0 2023-08-22T20:01:29.426229Z [init] [httpserver.cpp:698] [RegisterHTTPHandler] [http] Registering HTTP handler for /wallet/ (exactmatch 0) 
 node0 2023-08-22T20:01:29.426247Z [init] [httpserver.cpp:437] [StartHTTPServer] [http] Starting HTTP server 
 node0 2023-08-22T20:01:29.426262Z [init] [httpserver.cpp:439] [StartHTTPServer] [http] starting 4 worker threads 
 node0 2023-08-22T20:01:29.426312Z [http] [httpserver.cpp:301] [ThreadHTTP] [http] Entering http event loop 
 node0 2023-08-22T20:01:29.426386Z [init] [init.cpp:1201] [AppInitMain] Using /16 prefix for IP bucketing 
 node0 2023-08-22T20:01:29.426401Z [init] [noui.cpp:56] [noui_InitMessage] init message: Loading P2P addresses… 
 node0 2023-08-22T20:01:29.426897Z [init] [logging/timer.h:58] [Log] [addrman] CheckAddrman: new 0, tried 0, total 0 started 
 node0 2023-08-22T20:01:29.427064Z [init] [logging/timer.h:58] [Log] [addrman] CheckAddrman: completed (0.15ms) 
 node0 2023-08-22T20:01:29.427084Z [init] [addrdb.cpp:195] [LoadAddrman] Loaded 0 addresses from peers.dat  0ms 
 node0 2023-08-22T20:01:29.427991Z [init] [noui.cpp:56] [noui_InitMessage] init message: Loading banlist… 
 node0 2023-08-22T20:01:29.428062Z [init] [banman.cpp:40] [LoadBanlist] [net] Loaded 0 banned node addresses/subnets  0ms 
 node0 2023-08-22T20:01:29.428109Z [init] [net.cpp:1548] [SetTryNewOutboundPeer] [net] setting try another outbound peer=false 
 node0 2023-08-22T20:01:29.428128Z [init] [net.cpp:2280] [SetNetworkActive] SetNetworkActive: true 
 node0 2023-08-22T20:01:29.434450Z [init] [policy/fees.cpp:457] [Read] [estimatefee] Reading estimates: 190 buckets counting confirms up to 48 blocks 
 node0 2023-08-22T20:01:29.434920Z [init] [policy/fees.cpp:457] [Read] [estimatefee] Reading estimates: 190 buckets counting confirms up to 12 blocks 
 node0 2023-08-22T20:01:29.436449Z [init] [policy/fees.cpp:457] [Read] [estimatefee] Reading estimates: 190 buckets counting confirms up to 1008 blocks 
 node0 2023-08-22T20:01:29.438842Z [init] [init.cpp:1440] [AppInitMain] Cache configuration: 
 node0 2023-08-22T20:01:29.438852Z [init] [init.cpp:1441] [AppInitMain] * Using 2.0 MiB for block index database 
 node0 2023-08-22T20:01:29.438866Z [init] [init.cpp:1449] [AppInitMain] * Using 8.0 MiB for chain state database 
 node0 2023-08-22T20:01:29.438953Z [init] [init.cpp:1468] [AppInitMain] * Using 440.0 MiB for in-memory UTXO set (plus up to 286.1 MiB of unused mempool space) 
 node0 2023-08-22T20:01:29.439040Z [init] [noui.cpp:56] [noui_InitMessage] init message: Loading block index… 
 node0 2023-08-22T20:01:29.439061Z [init] [node/chainstate.cpp:167] [LoadChainstate] Validating signatures for all blocks. 
 node0 2023-08-22T20:01:29.439071Z [init] [node/chainstate.cpp:169] [LoadChainstate] Setting nMinimumChainWork=0000000000000000000000000000000000000000000000000000000000000000 
 node0 2023-08-22T20:01:29.439107Z [init] [dbwrapper.cpp:237] [CDBWrapper] Wiping LevelDB in /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/blocks/index 
 node0 2023-08-22T20:01:29.439381Z [init] [dbwrapper.cpp:242] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/blocks/index 
 node0 2023-08-22T20:01:29.455211Z [init] [dbwrapper.cpp:250] [CDBWrapper] Opened LevelDB successfully 
 node0 2023-08-22T20:01:29.455246Z [init] [dbwrapper.cpp:275] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/blocks/index: 0000000000000000 
 node0 2023-08-22T20:01:29.455292Z [init] [validation.cpp:4470] [LoadBlockIndex] Initializing databases... 
 node0 2023-08-22T20:01:29.455312Z [init] [node/chainstate.cpp:107] [CompleteChainstateInitialization] Initializing chainstate Chainstate [ibd] @ height -1 (null) 
 node0 2023-08-22T20:01:29.455326Z [init] [dbwrapper.cpp:237] [CDBWrapper] Wiping LevelDB in /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/chainstate 
 node0 2023-08-22T20:01:29.455625Z [init] [dbwrapper.cpp:242] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/chainstate 
 node0 2023-08-22T20:01:29.470144Z [init] [dbwrapper.cpp:250] [CDBWrapper] Opened LevelDB successfully 
 node0 2023-08-22T20:01:29.470281Z [init] [dbwrapper.cpp:272] [CDBWrapper] Wrote new obfuscate key for /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/chainstate: a3c1cfa3d212229e 
 node0 2023-08-22T20:01:29.470294Z [init] [dbwrapper.cpp:275] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/chainstate: a3c1cfa3d212229e 
 node0 2023-08-22T20:01:29.471009Z [init] [validation.cpp:5567] [MaybeRebalanceCaches] [snapshot] allocating all cache to the IBD chainstate 
 node0 2023-08-22T20:01:29.471053Z [init] [dbwrapper.cpp:242] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/chainstate 
 node0 2023-08-22T20:01:29.487262Z [init] [dbwrapper.cpp:250] [CDBWrapper] Opened LevelDB successfully 
 node0 2023-08-22T20:01:29.487314Z [init] [dbwrapper.cpp:275] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/chainstate: a3c1cfa3d212229e 
 node0 2023-08-22T20:01:29.487336Z [init] [validation.cpp:4948] [ResizeCoinsCaches] [Chainstate [ibd] @ height -1 (null)] resized coinsdb cache to 8.0 MiB 
 node0 2023-08-22T20:01:29.487350Z [init] [validation.cpp:4950] [ResizeCoinsCaches] [Chainstate [ibd] @ height -1 (null)] resized coinstip cache to 440.0 MiB 
 node0 2023-08-22T20:01:29.487405Z [init] [noui.cpp:56] [noui_InitMessage] init message: Verifying blocks… 
 node0 2023-08-22T20:01:29.487435Z [init] [init.cpp:1511] [AppInitMain]  block index              48ms 
 node0 2023-08-22T20:01:29.491464Z [init] [init.cpp:1600] [AppInitMain] Setting NODE_NETWORK on non-prune mode 
 node0 2023-08-22T20:01:29.491581Z [initload] [util/thread.cpp:20] [TraceThread] initload thread start 
 node0 2023-08-22T20:01:29.491628Z [initload] [node/blockstorage.cpp:909] [ImportBlocks] Reindexing block file blk00000.dat... 
 node0 2023-08-22T20:01:29.565693Z [initload] [validation.cpp:3878] [AcceptBlockHeader] [validation:debug] Saw new header hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 height=0 
 node0 2023-08-22T20:01:29.565885Z [initload] [validation.cpp:2816] [ConnectTip] [bench]   - Load block from disk: 0.05ms 
 node0 2023-08-22T20:01:29.565937Z [initload] [validationinterface.cpp:255] [BlockChecked] [validation] BlockChecked: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 state=Valid 
 node0 2023-08-22T20:01:29.565970Z [initload] [validation.cpp:2832] [ConnectTip] [bench]   - Connect total: 0.09ms [0.00s (0.09ms/blk)] 
 node0 2023-08-22T20:01:29.567109Z [initload] [validation.cpp:2841] [ConnectTip] [bench]   - Flush: 1.14ms [0.00s (1.14ms/blk)] 
 node0 2023-08-22T20:01:29.567129Z [initload] [validation.cpp:2851] [ConnectTip] [bench]   - Writing chainstate: 0.02ms [0.00s (0.02ms/blk)] 
 node0 2023-08-22T20:01:29.567183Z [initload] [validation.cpp:2613] [UpdateTipLog] UpdateTip: new best=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 height=0 version=0x00000001 log2_work=1.000000 tx=1 date='2011-02-02T23:16:42Z' progress=1.000000 cache=0.3MiB(0txo) 
 node0 2023-08-22T20:01:29.567195Z [initload] [validation.cpp:2867] [ConnectTip] [bench]   - Connect postprocess: 0.07ms [0.00s (0.07ms/blk)] 
 node0 2023-08-22T20:01:29.567204Z [initload] [validation.cpp:2871] [ConnectTip] [bench] - Connect block: 1.37ms [0.00s (1.37ms/blk)] 
 node0 2023-08-22T20:01:29.567219Z [initload] [txmempool.cpp:660] [check] [mempool] Checking mempool with 0 transactions and 0 inputs 
 node0 2023-08-22T20:01:29.567811Z [initload] [validationinterface.cpp:232] [BlockConnected] [validation] Enqueuing BlockConnected: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 block height=0 
 node0 2023-08-22T20:01:29.567851Z [initload] [validationinterface.cpp:204] [UpdatedBlockTip] [validation] Enqueuing UpdatedBlockTip: new block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 fork block hash=null (in IBD=true) 
 node0 2023-08-22T20:01:29.567896Z [scheduler] [validationinterface.cpp:232] [operator()] [validation] BlockConnected: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 block height=0 
 node0 2023-08-22T20:01:29.567940Z [init] [init.cpp:1706] [AppInitMain] block tree size = 1 
 node0 2023-08-22T20:01:29.567958Z [init] [init.cpp:1718] [AppInitMain] nBestHeight = 0 
 node0 2023-08-22T20:01:29.567993Z [initload] [logging/timer.h:58] [Log] [lock] Enter: lock contention ::cs_main, validation.cpp:5548 started 
 node0 2023-08-22T20:01:29.568009Z [initload] [logging/timer.h:58] [Log] [lock] Enter: lock contention ::cs_main, validation.cpp:5548 completed (1μs) 
 node0 2023-08-22T20:01:29.568026Z [scheduler] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs_main, net_processing.cpp:1861 started 
 node0 2023-08-22T20:01:29.568041Z [scheduler] [logging/timer.h:58] [Log] [lock] Enter: lock contention cs_main, net_processing.cpp:1861 completed (1μs) 
 node0 2023-08-22T20:01:29.568085Z [scheduler] [validationinterface.cpp:204] [operator()] [validation] UpdatedBlockTip: new block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 fork block hash=null (in IBD=true) 
 node0 2023-08-22T20:01:29.568230Z [init] [net.cpp:2216] [BindListenPort] Bound to 127.0.0.1:11617 
 node0 2023-08-22T20:01:29.568261Z [init] [net.cpp:2216] [BindListenPort] Bound to 127.0.0.1:18445 
 node0 2023-08-22T20:01:29.568285Z [init] [noui.cpp:56] [noui_InitMessage] init message: Starting network threads… 
 node0 2023-08-22T20:01:29.568330Z [init] [net.cpp:2419] [Start] DNS seeding disabled 
 node0 2023-08-22T20:01:29.568353Z [net] [util/thread.cpp:20] [TraceThread] net thread start 
 node0 2023-08-22T20:01:29.568379Z [addcon] [util/thread.cpp:20] [TraceThread] addcon thread start 
 node0 2023-08-22T20:01:29.568404Z [init] [noui.cpp:56] [noui_InitMessage] init message: Done loading 
 node0 2023-08-22T20:01:29.568426Z [msghand] [util/thread.cpp:20] [TraceThread] msghand thread start 
 node0 2023-08-22T20:01:29.629605Z [initload] [validation.cpp:4679] [LoadExternalBlockFile] Loaded 1 blocks from external file in 137ms 
 node0 2023-08-22T20:01:29.629704Z [initload] [node/blockstorage.cpp:909] [ImportBlocks] Reindexing block file blk00001.dat... 
 node0 2023-08-22T20:01:29.699581Z [initload] [validation.cpp:3878] [AcceptBlockHeader] [validation:debug] Saw new header hash=1b771cb05f19315d212df6f9d0745160cdddbe5e99cfb5e7745d8dd948165d72 height=1 
 node0 2023-08-22T20:01:29.702852Z [initload] [flatfile.cpp:44] [Open] Unable to open file /tmp/bitcoin_func_test_dpo_q17r/node0/regtest/blocks/blk00000.dat 
 node0 2023-08-22T20:01:29.702875Z [initload] [logging.h:263] [error] ERROR: Flush: failed to open file 0 
 node0 2023-08-22T20:01:29.702900Z [initload] [node/abort.cpp:22] [AbortNode] *** Flushing block file to disk failed. This is likely the result of an I/O error. 
 node0 2023-08-22T20:01:29.702927Z [initload] [noui.cpp:43] [noui_ThreadSafeMessageBox] Error: A fatal internal error occurred, see debug.log for details 
 node0 2023-08-22T20:01:29.703065Z [init] [httpserver.cpp:449] [InterruptHTTPServer] [http] Interrupting HTTP server 
 node0 2023-08-22T20:01:29.703368Z [init] [httprpc.cpp:315] [InterruptHTTPRPC] [rpc] Interrupting HTTP RPC server 
 node0 2023-08-22T20:01:29.703382Z [init] [rpc/server.cpp:302] [operator()] [rpc] Interrupting RPC 
 node0 2023-08-22T20:01:29.703465Z [init] [init.cpp:243] [Shutdown] Shutdown: In progress... 
 node0 2023-08-22T20:01:29.703486Z [shutoff] [httprpc.cpp:320] [StopHTTPRPC] [rpc] Stopping HTTP RPC server 
 node0 2023-08-22T20:01:29.703505Z [shutoff] [httpserver.cpp:713] [UnregisterHTTPHandler] [http] Unregistering HTTP handler for / (exactmatch 1) 
 node0 2023-08-22T20:01:29.703527Z [addcon] [util/thread.cpp:22] [TraceThread] addcon thread exit 
 node0 2023-08-22T20:01:29.703553Z [shutoff] [httpserver.cpp:713] [UnregisterHTTPHandler] [http] Unregistering HTTP handler for /wallet/ (exactmatch 0) 
 node0 2023-08-22T20:01:29.703579Z [shutoff] [rpc/server.cpp:314] [operator()] [rpc] Stopping RPC 
 node0 2023-08-22T20:01:29.703743Z [shutoff] [init.cpp:408] [OnRPCStopped] [rpc] RPC stopped. 
 node0 2023-08-22T20:01:29.703755Z [shutoff] [httpserver.cpp:461] [StopHTTPServer] [http] Stopping HTTP server 
 node0 2023-08-22T20:01:29.703764Z [shutoff] [httpserver.cpp:463] [StopHTTPServer] [http] Waiting for HTTP worker threads to exit 
 node0 2023-08-22T20:01:29.703818Z [shutoff] [httpserver.cpp:494] [StopHTTPServer] [http] Waiting for HTTP event thread to exit 
 node0 2023-08-22T20:01:29.707585Z [http] [httpserver.cpp:304] [ThreadHTTP] [http] Exited http event loop 
 node0 2023-08-22T20:01:29.707645Z [shutoff] [httpserver.cpp:500] [StopHTTPServer] [http] Stopped HTTP server 
 node0 2023-08-22T20:01:29.731346Z [net] [util/thread.cpp:22] [TraceThread] net thread exit 
 node0 2023-08-22T20:01:29.768318Z [initload] [node/blockstorage.cpp:912] [ImportBlocks] Interrupt requested. Exit ImportBlocks 
 node0 2023-08-22T20:01:29.768433Z [initload] [kernel/mempool_persist.cpp:128] [LoadMempool] Imported mempool transactions from disk: 0 succeeded, 0 failed, 0 expired, 0 already there, 0 waiting for initial broadcast 
 node0 2023-08-22T20:01:29.768449Z [initload] [util/thread.cpp:22] [TraceThread] initload thread exit 
 node0 2023-08-22T20:01:29.778537Z [msghand] [util/thread.cpp:22] [TraceThread] msghand thread exit 
 node0 2023-08-22T20:01:29.783553Z [shutoff] [net.cpp:1519] [DumpAddresses] [net] Flushed 0 addresses to peers.dat  4ms 
 node0 2023-08-22T20:01:29.783652Z [scheduler] [util/thread.cpp:22] [TraceThread] scheduler thread exit 
 node0 2023-08-22T20:01:29.786370Z [shutoff] [policy/fees.cpp:1031] [FlushUnconfirmed] [estimatefee] Recorded 0 unconfirmed txs from mempool in 2.416e-06s 
 node0 2023-08-22T20:01:29.788907Z [shutoff] [policy/fees.cpp:929] [FlushFeeEstimates] Flushed fee estimates to fee_estimates.dat. 
 node0 2023-08-22T20:01:29.788985Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started 
 node0 2023-08-22T20:01:29.793579Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (4.58ms) 
 node0 2023-08-22T20:01:29.793597Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started 
 node0 2023-08-22T20:01:29.796387Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (2.78ms) 
 node0 2023-08-22T20:01:29.796408Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) started 
 node0 2023-08-22T20:01:29.796455Z [shutoff] [txdb.cpp:167] [BatchWrite] [coindb] Writing final batch of 0.00 MiB 
 node0 2023-08-22T20:01:29.796570Z [shutoff] [txdb.cpp:169] [BatchWrite] [coindb] Committed 0 changed transaction outputs (out of 0) to coin database... 
 node0 2023-08-22T20:01:29.797254Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) completed (0.83ms) 
 node0 2023-08-22T20:01:29.797277Z [shutoff] [validationinterface.cpp:250] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 
 node0 2023-08-22T20:01:29.797316Z [shutoff] [validationinterface.cpp:250] [operator()] [validation] ChainStateFlushed: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 
 node0 2023-08-22T20:01:29.797363Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started 
 node0 2023-08-22T20:01:29.805415Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (8.04ms) 
 node0 2023-08-22T20:01:29.805433Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started 
 node0 2023-08-22T20:01:29.809459Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (4.01ms) 
 node0 2023-08-22T20:01:29.809481Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) started 
 node0 2023-08-22T20:01:29.809517Z [shutoff] [txdb.cpp:167] [BatchWrite] [coindb] Writing final batch of 0.00 MiB 
 node0 2023-08-22T20:01:29.809539Z [shutoff] [txdb.cpp:169] [BatchWrite] [coindb] Committed 0 changed transaction outputs (out of 0) to coin database... 
 node0 2023-08-22T20:01:29.810260Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) completed (0.76ms) 
 node0 2023-08-22T20:01:29.810277Z [shutoff] [validationinterface.cpp:250] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 
 node0 2023-08-22T20:01:29.813798Z [shutoff] [init.cpp:359] [Shutdown] Shutdown: done 
 test  2023-08-22T20:01:29.877000Z TestFramework.node0 (DEBUG): [node 0] bitcoind exited with status 1 during initialization 
 test  2023-08-22T20:01:29.878000Z TestFramework (DEBUG): Closing down network thread 
 test  2023-08-22T20:01:29.934000Z TestFramework (INFO): Stopping nodes 
 test  2023-08-22T20:01:29.934000Z TestFramework (WARNING): Not cleaning up dir /tmp/bitcoin_func_test_dpo_q17r 
 test  2023-08-22T20:01:29.934000Z TestFramework (INFO): Tests successful 

 node0 stderr Error: A fatal internal error occurred, see debug.log for details 
-->