test 2024-08-15T16:40:40.945000Z TestFramework (INFO): PRNG seed is: 6855069601752998378 test 2024-08-15T16:40:40.945000Z TestFramework (DEBUG): Setting up network thread test 2024-08-15T16:40:40.945000Z TestFramework (INFO): Initializing test directory /tmp/bitcoin_func_test__c38k83u test 2024-08-15T16:40:40.946000Z TestFramework (DEBUG): Copy cache directory /home/gloria/bitcoin/test/cache/node0 to node 0 test 2024-08-15T16:40:40.955000Z TestFramework.node0 (DEBUG): bitcoind started, waiting for RPC to come up node0 2024-08-15T16:40:40.957465Z [init] [init/common.cpp:149] [LogPackageVersion] Bitcoin Core version v27.99.0-faa1b9b0e6de (release build) node0 2024-08-15T16:40:40.957468Z [init] [init.cpp:742] [InitParameterInteraction] parameter interaction: -bind set -> setting -listen=1 node0 2024-08-15T16:40:40.957514Z [init] [node/chainstatemanager_args.cpp:57] [ApplyArgsManOptions] Script verification uses 11 additional threads node0 2024-08-15T16:40:40.957599Z [init] [kernel/context.cpp:20] [operator()] Using the 'sse4(1way),sse41(4way),avx2(8way)' SHA256 implementation node0 2024-08-15T16:40:41.079150Z [init] [random.cpp:114] [ReportHardwareRand] Using RdSeed as an additional entropy source node0 2024-08-15T16:40:41.079153Z [init] [random.cpp:117] [ReportHardwareRand] Using RdRand as an additional entropy source node0 2024-08-15T16:40:41.080586Z [init] [init/common.cpp:120] [StartLogging] Default data directory /home/gloria/.bitcoin node0 2024-08-15T16:40:41.080589Z [init] [init/common.cpp:121] [StartLogging] Using data directory /tmp/bitcoin_func_test__c38k83u/node0/regtest node0 2024-08-15T16:40:41.080595Z [init] [init/common.cpp:126] [StartLogging] Config file: /tmp/bitcoin_func_test__c38k83u/node0/bitcoin.conf node0 2024-08-15T16:40:41.080603Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: regtest="1" node0 2024-08-15T16:40:41.080608Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] bind="127.0.0.1" node0 2024-08-15T16:40:41.080612Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] connect="0" node0 2024-08-15T16:40:41.080616Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] deprecatedrpc="create_bdb" node0 2024-08-15T16:40:41.080619Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] discover="0" node0 2024-08-15T16:40:41.080622Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] dnsseed="0" node0 2024-08-15T16:40:41.080625Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] fallbackfee="0.0002" node0 2024-08-15T16:40:41.080628Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] fixedseeds="0" node0 2024-08-15T16:40:41.080631Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] keypool="1" node0 2024-08-15T16:40:41.080634Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] listenonion="0" node0 2024-08-15T16:40:41.080637Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] natpmp="0" node0 2024-08-15T16:40:41.080641Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] peertimeout="999999999" node0 2024-08-15T16:40:41.080644Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] port="14645" node0 2024-08-15T16:40:41.080647Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] printtoconsole="0" node0 2024-08-15T16:40:41.080651Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] rpcdoccheck="1" node0 2024-08-15T16:40:41.080655Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] rpcport="19645" node0 2024-08-15T16:40:41.080659Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] rpcservertimeout="99000" node0 2024-08-15T16:40:41.080663Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] server="1" node0 2024-08-15T16:40:41.080666Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] shrinkdebugfile="0" node0 2024-08-15T16:40:41.080670Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] unsafesqlitesync="1" node0 2024-08-15T16:40:41.080672Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] upnp="0" node0 2024-08-15T16:40:41.080676Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: blocksxor="1" node0 2024-08-15T16:40:41.080679Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: datacarriersize="100000" node0 2024-08-15T16:40:41.080684Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: datadir="/tmp/bitcoin_func_test__c38k83u/node0" node0 2024-08-15T16:40:41.080687Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: debug="" node0 2024-08-15T16:40:41.080690Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: debugexclude="libevent" node0 2024-08-15T16:40:41.080697Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: debugexclude="leveldb" node0 2024-08-15T16:40:41.080700Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: debugexclude="rand" node0 2024-08-15T16:40:41.080703Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: disablewallet="" node0 2024-08-15T16:40:41.080706Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: fastprune="1" node0 2024-08-15T16:40:41.080710Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: loglevel="trace" node0 2024-08-15T16:40:41.080713Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: logsourcelocations="" node0 2024-08-15T16:40:41.080716Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: logthreadnames="" node0 2024-08-15T16:40:41.080719Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: logtimemicros="" node0 2024-08-15T16:40:41.080722Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: uacomment="testnode0" node0 2024-08-15T16:40:41.080725Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: v2transport="0" node0 2024-08-15T16:40:41.080728Z [init] [init.cpp:1158] [AppInitMain] Using at most 125 automatic connections (1024 file descriptors available) node0 2024-08-15T16:40:41.080783Z [init] [wallet/init.cpp:129] [Construct] Wallet disabled! node0 2024-08-15T16:40:41.080827Z [scheduler] [util/thread.cpp:20] [TraceThread] scheduler thread start node0 2024-08-15T16:40:41.082009Z [init] [httpserver.cpp:238] [InitHTTPAllowList] [http] Allowing HTTP connections from: 127.0.0.0/8 ::1/128 node0 2024-08-15T16:40:41.082052Z [init] [httpserver.cpp:384] [HTTPBindAddresses] Binding RPC on address ::1 port 19645 node0 2024-08-15T16:40:41.082115Z [init] [httpserver.cpp:384] [HTTPBindAddresses] Binding RPC on address 127.0.0.1 port 19645 node0 2024-08-15T16:40:41.082138Z [init] [httpserver.cpp:463] [InitHTTPServer] [http] Initialized HTTP server node0 2024-08-15T16:40:41.082144Z [init] [httpserver.cpp:465] [InitHTTPServer] [http] creating work queue of depth 16 node0 2024-08-15T16:40:41.082147Z [init] [rpc/server.cpp:298] [StartRPC] [rpc] Starting RPC node0 2024-08-15T16:40:41.082154Z [init] [httprpc.cpp:360] [StartHTTPRPC] [rpc] Starting HTTP RPC server node0 2024-08-15T16:40:41.082157Z [init] [httprpc.cpp:297] [InitRPCAuthentication] Using random cookie authentication. node0 2024-08-15T16:40:41.082199Z [init] [rpc/request.cpp:132] [GenerateAuthCookie] Generated RPC authentication cookie /tmp/bitcoin_func_test__c38k83u/node0/regtest/.cookie node0 2024-08-15T16:40:41.082214Z [init] [rpc/request.cpp:133] [GenerateAuthCookie] Permissions used for cookie: rw------- node0 2024-08-15T16:40:41.082221Z [init] [httpserver.cpp:745] [RegisterHTTPHandler] [http] Registering HTTP handler for / (exactmatch 1) node0 2024-08-15T16:40:41.082225Z [init] [httpserver.cpp:745] [RegisterHTTPHandler] [http] Registering HTTP handler for /wallet/ (exactmatch 0) node0 2024-08-15T16:40:41.082230Z [init] [httpserver.cpp:488] [StartHTTPServer] Starting HTTP server with 4 worker threads node0 2024-08-15T16:40:41.082335Z [init] [init.cpp:1265] [AppInitMain] Using /16 prefix for IP bucketing node0 2024-08-15T16:40:41.082346Z [init] [noui.cpp:57] [noui_InitMessage] init message: Loading P2P addresses… node0 2024-08-15T16:40:41.082352Z [http] [httpserver.cpp:351] [ThreadHTTP] [http] Entering http event loop node0 2024-08-15T16:40:41.082609Z [init] [addrdb.cpp:206] [LoadAddrman] Creating peers.dat because the file was not found ("/tmp/bitcoin_func_test__c38k83u/node0/regtest/peers.dat") node0 2024-08-15T16:40:41.092743Z [init] [noui.cpp:57] [noui_InitMessage] init message: Loading banlist… node0 2024-08-15T16:40:41.092762Z [init] [banman.cpp:42] [LoadBanlist] Recreating the banlist database node0 2024-08-15T16:40:41.092814Z [init] [banman.cpp:69] [DumpBanlist] [net] Flushed 0 banned node addresses/subnets to disk 0ms node0 2024-08-15T16:40:41.092832Z [init] [net.cpp:2360] [SetTryNewOutboundPeer] [net] setting try another outbound peer=false node0 2024-08-15T16:40:41.092837Z [init] [net.cpp:3136] [SetNetworkActive] SetNetworkActive: true node0 2024-08-15T16:40:41.093107Z [init] [policy/fees.cpp:560] [CBlockPolicyEstimator] /tmp/bitcoin_func_test__c38k83u/node0/regtest/fee_estimates.dat is not found. Continue anyway. node0 2024-08-15T16:40:41.093159Z [init] [node/chainstatemanager_args.cpp:57] [ApplyArgsManOptions] Script verification uses 11 additional threads node0 2024-08-15T16:40:41.093166Z [init] [init.cpp:1517] [AppInitMain] Cache configuration: node0 2024-08-15T16:40:41.093175Z [init] [init.cpp:1518] [AppInitMain] * Using 2.0 MiB for block index database node0 2024-08-15T16:40:41.093178Z [init] [init.cpp:1526] [AppInitMain] * Using 8.0 MiB for chain state database node0 2024-08-15T16:40:41.093214Z [init] [init.cpp:1549] [AppInitMain] * Using 440.0 MiB for in-memory UTXO set (plus up to 286.1 MiB of unused mempool space) node0 2024-08-15T16:40:41.093882Z [init] [node/blockstorage.cpp:1184] [InitBlocksdirXorKey] Using obfuscation key for blocksdir *.dat files (/tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks): '0000000000000000' node0 2024-08-15T16:40:41.098099Z [init] [script/sigcache.cpp:36] [SignatureCache] Using 16 MiB out of 16 MiB requested for signature cache, able to store 524288 elements node0 2024-08-15T16:40:41.102405Z [init] [validation.cpp:2125] [ValidationCache] Using 16 MiB out of 16 MiB requested for script execution cache, able to store 524288 elements node0 2024-08-15T16:40:41.102430Z [init] [noui.cpp:57] [noui_InitMessage] init message: Loading block index… node0 2024-08-15T16:40:41.102436Z [init] [node/chainstate.cpp:168] [LoadChainstate] Validating signatures for all blocks. node0 2024-08-15T16:40:41.102442Z [init] [node/chainstate.cpp:170] [LoadChainstate] Setting nMinimumChainWork=0000000000000000000000000000000000000000000000000000000000000000 node0 2024-08-15T16:40:41.102496Z [init] [dbwrapper.cpp:241] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks/index node0 2024-08-15T16:40:41.105778Z [init] [dbwrapper.cpp:249] [CDBWrapper] Opened LevelDB successfully node0 2024-08-15T16:40:41.105792Z [init] [dbwrapper.cpp:274] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks/index: 0000000000000000 node0 2024-08-15T16:40:41.106147Z [init] [node/blockstorage.cpp:508] [LoadBlockIndexDB] LoadBlockIndexDB: last block file = 0 node0 2024-08-15T16:40:41.106162Z [init] [node/blockstorage.cpp:512] [LoadBlockIndexDB] LoadBlockIndexDB: last block file info: CBlockFileInfo(blocks=200, size=52530, heights=0...199, time=2011-02-02...2011-02-02) node0 2024-08-15T16:40:41.106168Z [init] [node/blockstorage.cpp:523] [LoadBlockIndexDB] Checking all blk files are present... node0 2024-08-15T16:40:41.106237Z [init] [node/chainstate.cpp:108] [CompleteChainstateInitialization] Initializing chainstate Chainstate [ibd] @ height -1 (null) node0 2024-08-15T16:40:41.106250Z [init] [dbwrapper.cpp:241] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test__c38k83u/node0/regtest/chainstate node0 2024-08-15T16:40:41.109360Z [init] [dbwrapper.cpp:249] [CDBWrapper] Opened LevelDB successfully node0 2024-08-15T16:40:41.109396Z [init] [dbwrapper.cpp:274] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test__c38k83u/node0/regtest/chainstate: 8a556cbbe58ab7be node0 2024-08-15T16:40:41.109479Z [init] [validation.cpp:4695] [LoadChainTip] Loaded best chain: hashBestChain=39455d83324a3dbbb15712ab63dd2f96b45a30f271617aa16c12483a561f721c height=199 date=2011-02-02T23:17:17Z progress=1.000000 node0 2024-08-15T16:40:41.109519Z [init] [dbwrapper.cpp:241] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test__c38k83u/node0/regtest/chainstate node0 2024-08-15T16:40:41.111599Z [init] [dbwrapper.cpp:249] [CDBWrapper] Opened LevelDB successfully node0 2024-08-15T16:40:41.111632Z [init] [dbwrapper.cpp:274] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test__c38k83u/node0/regtest/chainstate: 8a556cbbe58ab7be node0 2024-08-15T16:40:41.111642Z [init] [validation.cpp:5560] [ResizeCoinsCaches] [Chainstate [ibd] @ height 199 (39455d83324a3dbbb15712ab63dd2f96b45a30f271617aa16c12483a561f721c)] resized coinsdb cache to 8.0 MiB node0 2024-08-15T16:40:41.111647Z [init] [validation.cpp:5562] [ResizeCoinsCaches] [Chainstate [ibd] @ height 199 (39455d83324a3dbbb15712ab63dd2f96b45a30f271617aa16c12483a561f721c)] resized coinstip cache to 440.0 MiB node0 2024-08-15T16:40:41.111658Z [init] [noui.cpp:57] [noui_InitMessage] init message: Verifying blocks… node0 2024-08-15T16:40:41.111664Z [init] [validation.cpp:4727] [VerifyDB] Verifying last 6 blocks at level 3 node0 2024-08-15T16:40:41.111682Z [init] [validation.cpp:4736] [VerifyDB] Verification progress: 0% node0 2024-08-15T16:40:41.111767Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 16% node0 2024-08-15T16:40:41.111807Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 33% node0 2024-08-15T16:40:41.111846Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 50% node0 2024-08-15T16:40:41.111882Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 66% node0 2024-08-15T16:40:41.111920Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 83% node0 2024-08-15T16:40:41.111959Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 99% node0 2024-08-15T16:40:41.111964Z [init] [validation.cpp:4838] [VerifyDB] Verification: No coin database inconsistencies in last 6 blocks (6 transactions) node0 2024-08-15T16:40:41.111968Z [init] [init.cpp:1611] [AppInitMain] block index 9ms node0 2024-08-15T16:40:41.111994Z [init] [init.cpp:1698] [AppInitMain] Setting NODE_NETWORK on non-prune mode node0 2024-08-15T16:40:41.112044Z [init] [init.cpp:1808] [AppInitMain] block tree size = 200 node0 2024-08-15T16:40:41.112048Z [init] [init.cpp:1821] [AppInitMain] nBestHeight = 199 node0 2024-08-15T16:40:41.112088Z [init] [net.cpp:3073] [BindListenPort] Bound to 127.0.0.1:14645 node0 2024-08-15T16:40:41.112097Z [init] [noui.cpp:57] [noui_InitMessage] init message: Starting network threads… node0 2024-08-15T16:40:41.112107Z [initload] [util/thread.cpp:20] [TraceThread] initload thread start node0 2024-08-15T16:40:41.112120Z [init] [net.cpp:3297] [Start] DNS seeding disabled node0 2024-08-15T16:40:41.112138Z [initload] [node/mempool_persist.cpp:47] [LoadMempool] Failed to open mempool file. Continuing anyway. node0 2024-08-15T16:40:41.112167Z [initload] [util/thread.cpp:22] [TraceThread] initload thread exit node0 2024-08-15T16:40:41.112185Z [init] [noui.cpp:57] [noui_InitMessage] init message: Done loading node0 2024-08-15T16:40:41.112200Z [net] [util/thread.cpp:20] [TraceThread] net thread start node0 2024-08-15T16:40:41.112215Z [msghand] [util/thread.cpp:20] [TraceThread] msghand thread start node0 2024-08-15T16:40:41.112292Z [addcon] [util/thread.cpp:20] [TraceThread] addcon thread start test 2024-08-15T16:40:41.207000Z TestFramework.node0 (DEBUG): RPC successfully started node0 2024-08-15T16:40:41.207046Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.207143Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockcount user=__cookie__ node0 2024-08-15T16:40:41.207559Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.207635Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getmempoolinfo user=__cookie__ test 2024-08-15T16:40:41.208000Z TestFramework (DEBUG): Generate a block with current time test 2024-08-15T16:40:41.208000Z TestFramework.node0 (DEBUG): TestNode.generate() dispatches `generate` call to `generatetoaddress` node0 2024-08-15T16:40:41.208076Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.208149Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.208597Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.208681Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=generatetoaddress user=__cookie__ node0 2024-08-15T16:40:41.208740Z [httpworker.3] [node/miner.cpp:158] [CreateNewBlock] CreateNewBlock(): block weight: 904 txs: 0 fees: 0 sigops 400 node0 2024-08-15T16:40:41.208770Z [httpworker.3] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.208797Z [httpworker.3] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.03ms [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.208805Z [httpworker.3] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 1 transactions: 0.01ms (0.007ms/tx, 0.000ms/txin) [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.208812Z [httpworker.3] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 0 txins: 0.01ms (0.000ms/txin) [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.208822Z [httpworker.3] [node/miner.cpp:177] [CreateNewBlock] [bench] CreateNewBlock() packages: 0.00ms (0 packages, 0 updated descendants), validity: 0.09ms (total 0.09ms) node0 2024-08-15T16:40:41.208834Z [httpworker.3] [validation.cpp:4393] [AcceptBlockHeader] [validation] Saw new header hash=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 height=200 node0 2024-08-15T16:40:41.208920Z [httpworker.3] [validation.cpp:3168] [ConnectTip] [bench] - Using cached block node0 2024-08-15T16:40:41.208926Z [httpworker.3] [validation.cpp:3178] [ConnectTip] [bench] - Load block from disk: 0.01ms node0 2024-08-15T16:40:41.208943Z [httpworker.3] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.208957Z [httpworker.3] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.01ms [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.208962Z [httpworker.3] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 1 transactions: 0.01ms (0.005ms/tx, 0.000ms/txin) [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.208968Z [httpworker.3] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 0 txins: 0.01ms (0.000ms/txin) [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.208987Z [httpworker.3] [validation.cpp:2733] [ConnectBlock] [bench] - Write undo data: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.208991Z [httpworker.3] [validation.cpp:2748] [ConnectBlock] [bench] - Index writing: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.208996Z [httpworker.3] [validationinterface.cpp:251] [BlockChecked] [validation] BlockChecked: block hash=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 state=Valid node0 2024-08-15T16:40:41.209001Z [httpworker.3] [validation.cpp:3197] [ConnectTip] [bench] - Connect total: 0.08ms [0.00s (0.04ms/blk)] node0 2024-08-15T16:40:41.209016Z [httpworker.3] [validation.cpp:3206] [ConnectTip] [bench] - Flush: 0.01ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.209020Z [httpworker.3] [validation.cpp:3216] [ConnectTip] [bench] - Writing chainstate: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.209024Z [httpworker.3] [validationinterface.cpp:228] [MempoolTransactionsRemovedForBlock] [validation] Enqueuing MempoolTransactionsRemovedForBlock: block height=200 txs removed=0 node0 2024-08-15T16:40:41.209033Z [httpworker.3] [validation.cpp:2030] [IsInitialBlockDownload] Leaving InitialBlockDownload (latching to false) node0 2024-08-15T16:40:41.209048Z [httpworker.3] [validation.cpp:2979] [UpdateTipLog] UpdateTip: new best=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 height=200 version=0x30000000 log2_work=8.651052 tx=201 date='2024-08-15T16:40:41Z' progress=1.000000 cache=0.3MiB(1txo) node0 2024-08-15T16:40:41.209052Z [httpworker.3] [validation.cpp:3232] [ConnectTip] [bench] - Connect postprocess: 0.03ms [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.209055Z [httpworker.3] [validation.cpp:3236] [ConnectTip] [bench] - Connect block: 0.13ms [0.00s (0.07ms/blk)] node0 2024-08-15T16:40:41.209059Z [httpworker.3] [txmempool.cpp:664] [check] [mempool] Checking mempool with 0 transactions and 0 inputs node0 2024-08-15T16:40:41.209076Z [httpworker.3] [validationinterface.cpp:218] [BlockConnected] [validation] Enqueuing BlockConnected: block hash=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 block height=200 node0 2024-08-15T16:40:41.209082Z [httpworker.3] [validationinterface.cpp:183] [UpdatedBlockTip] [validation] Enqueuing UpdatedBlockTip: new block hash=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 fork block hash=39455d83324a3dbbb15712ab63dd2f96b45a30f271617aa16c12483a561f721c (in IBD=false) node0 2024-08-15T16:40:41.209090Z [httpworker.3] [validationinterface.cpp:188] [ActiveTipChange] [validation] ActiveTipChange: new block hash=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 block height=200 node0 2024-08-15T16:40:41.209096Z [scheduler] [validationinterface.cpp:228] [operator()] [validation] MempoolTransactionsRemovedForBlock: block height=200 txs removed=0 node0 2024-08-15T16:40:41.209164Z [scheduler] [policy/fees.cpp:708] [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 2024-08-15T16:40:41.209177Z [scheduler] [validationinterface.cpp:218] [operator()] [validation] BlockConnected: block hash=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 block height=200 node0 2024-08-15T16:40:41.209994Z [scheduler] [validationinterface.cpp:183] [operator()] [validation] UpdatedBlockTip: new block hash=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 fork block hash=39455d83324a3dbbb15712ab63dd2f96b45a30f271617aa16c12483a561f721c (in IBD=false) node0 2024-08-15T16:40:41.210160Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.210236Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblock user=__cookie__ node0 2024-08-15T16:40:41.210663Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.210740Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=submitblock user=__cookie__ node0 2024-08-15T16:40:41.211075Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.211135Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.211547Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.211608Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getbestblockhash user=__cookie__ node0 2024-08-15T16:40:41.211939Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.212000Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ test 2024-08-15T16:40:41.212000Z TestFramework (INFO): Mine some blocks, to create multiple blk*.dat/rev*.dat files node0 2024-08-15T16:40:41.212278Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.212336Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=syncwithvalidationinterfacequeue user=__cookie__ node0 2024-08-15T16:40:41.216097Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.216177Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=scantxoutset user=__cookie__ node0 2024-08-15T16:40:41.216264Z [httpworker.1] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started node0 2024-08-15T16:40:41.233473Z [httpworker.1] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (17.20ms) node0 2024-08-15T16:40:41.233487Z [httpworker.1] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started node0 2024-08-15T16:40:41.234126Z [httpworker.1] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (0.63ms) node0 2024-08-15T16:40:41.234133Z [httpworker.1] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (1 coins, 262kB) started node0 2024-08-15T16:40:41.234170Z [httpworker.1] [txdb.cpp:146] [BatchWrite] [coindb] Writing final batch of 0.00 MiB node0 2024-08-15T16:40:41.234186Z [httpworker.1] [txdb.cpp:148] [BatchWrite] [coindb] Committed 1 changed transaction outputs (out of 1) to coin database... node0 2024-08-15T16:40:41.234241Z [httpworker.1] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (1 coins, 262kB) completed (0.10ms) node0 2024-08-15T16:40:41.234252Z [httpworker.1] [validationinterface.cpp:246] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 node0 2024-08-15T16:40:41.234318Z [scheduler] [validationinterface.cpp:246] [operator()] [validation] ChainStateFlushed: block hash=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 node0 2024-08-15T16:40:41.279050Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.279154Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ node0 2024-08-15T16:40:41.279658Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.279727Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.285038Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.286461Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=sendrawtransaction user=__cookie__ node0 2024-08-15T16:40:41.287086Z [httpworker.2] [validationinterface.cpp:199] [TransactionAddedToMempool] [validation] Enqueuing TransactionAddedToMempool: txid=dc09385e49e897b6092cf38d305b946138e6ea22a859b9e75af6a422eecfe487 wtxid=112f0c4f62ea151ecbf1c7aaa888b31a27e4a53caeb920f10462b697277d4cac node0 2024-08-15T16:40:41.287101Z [httpworker.2] [txmempool.cpp:664] [check] [mempool] Checking mempool with 1 transactions and 1 inputs node0 2024-08-15T16:40:41.287153Z [scheduler] [validationinterface.cpp:199] [operator()] [validation] TransactionAddedToMempool: txid=dc09385e49e897b6092cf38d305b946138e6ea22a859b9e75af6a422eecfe487 wtxid=112f0c4f62ea151ecbf1c7aaa888b31a27e4a53caeb920f10462b697277d4cac node0 2024-08-15T16:40:41.287779Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.289131Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=decoderawtransaction user=__cookie__ node0 2024-08-15T16:40:41.295789Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.295873Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.296441Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.296510Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=generatetodescriptor user=__cookie__ node0 2024-08-15T16:40:41.296572Z [httpworker.0] [node/miner.cpp:158] [CreateNewBlock] CreateNewBlock(): block weight: 80943 txs: 1 fees: 6000300 sigops 400 node0 2024-08-15T16:40:41.296646Z [httpworker.0] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.296677Z [httpworker.0] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.03ms [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.296710Z [httpworker.0] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 2 transactions: 0.03ms (0.016ms/tx, 0.032ms/txin) [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.296716Z [httpworker.0] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 1 txins: 0.04ms (0.039ms/txin) [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.296721Z [httpworker.0] [node/miner.cpp:177] [CreateNewBlock] [bench] CreateNewBlock() packages: 0.01ms (1 packages, 0 updated descendants), validity: 0.16ms (total 0.17ms) node0 2024-08-15T16:40:41.296752Z [httpworker.0] [validation.cpp:4395] [AcceptBlockHeader] Saw new header hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 height=201 node0 2024-08-15T16:40:41.296774Z [httpworker.0] [validationinterface.cpp:256] [NewPoWValidBlock] [validation] NewPoWValidBlock: block hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 node0 2024-08-15T16:40:41.296791Z [httpworker.0] [node/blockstorage.cpp:891] [FindNextBlockPos] [blockstorage] Leaving block file 0: CBlockFileInfo(blocks=201, size=52791, heights=0...200, time=2011-02-02...2024-08-15) (onto 1) (height 201) node0 2024-08-15T16:40:41.299767Z [httpworker.0] [flatfile.cpp:69] [Allocate] [validation] Pre-allocating up to position 0x8000 in blk00001.dat node0 2024-08-15T16:40:41.299869Z [httpworker.0] [validation.cpp:3168] [ConnectTip] [bench] - Using cached block node0 2024-08-15T16:40:41.299880Z [httpworker.0] [validation.cpp:3178] [ConnectTip] [bench] - Load block from disk: 0.01ms node0 2024-08-15T16:40:41.299897Z [httpworker.0] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.299923Z [httpworker.0] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.03ms [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.299950Z [httpworker.0] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 2 transactions: 0.03ms (0.013ms/tx, 0.027ms/txin) [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.299955Z [httpworker.0] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 1 txins: 0.03ms (0.032ms/txin) [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.299975Z [httpworker.0] [flatfile.cpp:69] [Allocate] [validation] Pre-allocating up to position 0x100000 in rev00001.dat node0 2024-08-15T16:40:41.300003Z [httpworker.0] [validation.cpp:2733] [ConnectBlock] [bench] - Write undo data: 0.05ms [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.300007Z [httpworker.0] [validation.cpp:2748] [ConnectBlock] [bench] - Index writing: 0.01ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.300013Z [httpworker.0] [validationinterface.cpp:251] [BlockChecked] [validation] BlockChecked: block hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 state=Valid node0 2024-08-15T16:40:41.300019Z [httpworker.0] [validation.cpp:3197] [ConnectTip] [bench] - Connect total: 0.14ms [0.00s (0.05ms/blk)] node0 2024-08-15T16:40:41.300034Z [httpworker.0] [validation.cpp:3206] [ConnectTip] [bench] - Flush: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.300038Z [httpworker.0] [validation.cpp:3216] [ConnectTip] [bench] - Writing chainstate: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.300047Z [httpworker.0] [txmempool.cpp:1039] [RemoveUnbroadcastTx] [mempool] Removed dc09385e49e897b6092cf38d305b946138e6ea22a859b9e75af6a422eecfe487 from set of unbroadcast txns before confirmation that txn was sent out node0 2024-08-15T16:40:41.300051Z [httpworker.0] [validationinterface.cpp:228] [MempoolTransactionsRemovedForBlock] [validation] Enqueuing MempoolTransactionsRemovedForBlock: block height=201 txs removed=1 node0 2024-08-15T16:40:41.300071Z [httpworker.0] [validation.cpp:2979] [UpdateTipLog] UpdateTip: new best=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 height=201 version=0x30000000 log2_work=8.658211 tx=203 date='2024-08-15T16:40:41Z' progress=1.000000 cache=0.3MiB(3txo) node0 2024-08-15T16:40:41.300076Z [httpworker.0] [validation.cpp:3232] [ConnectTip] [bench] - Connect postprocess: 0.04ms [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.300080Z [httpworker.0] [validation.cpp:3236] [ConnectTip] [bench] - Connect block: 0.21ms [0.00s (0.08ms/blk)] node0 2024-08-15T16:40:41.300084Z [httpworker.0] [txmempool.cpp:664] [check] [mempool] Checking mempool with 0 transactions and 0 inputs node0 2024-08-15T16:40:41.300101Z [httpworker.0] [validationinterface.cpp:218] [BlockConnected] [validation] Enqueuing BlockConnected: block hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 block height=201 node0 2024-08-15T16:40:41.300109Z [httpworker.0] [validationinterface.cpp:183] [UpdatedBlockTip] [validation] Enqueuing UpdatedBlockTip: new block hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 fork block hash=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 (in IBD=false) node0 2024-08-15T16:40:41.300119Z [scheduler] [validationinterface.cpp:228] [operator()] [validation] MempoolTransactionsRemovedForBlock: block height=201 txs removed=1 node0 2024-08-15T16:40:41.300129Z [httpworker.0] [validationinterface.cpp:188] [ActiveTipChange] [validation] ActiveTipChange: new block hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 block height=201 node0 2024-08-15T16:40:41.300209Z [scheduler] [policy/fees.cpp:702] [processBlock] [estimatefee] Blockpolicy first recorded height 201 node0 2024-08-15T16:40:41.300217Z [scheduler] [policy/fees.cpp:708] [processBlock] [estimatefee] Blockpolicy estimates updated by 1 of 1 block txs, since last block 1 of 1 tracked, mempool map size 0, max target 0 from current node0 2024-08-15T16:40:41.300238Z [scheduler] [validationinterface.cpp:218] [operator()] [validation] BlockConnected: block hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 block height=201 node0 2024-08-15T16:40:41.300283Z [scheduler] [validationinterface.cpp:183] [operator()] [validation] UpdatedBlockTip: new block hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 fork block hash=5301a50c5358eaa3d1a48b9ded6cae6662decdba129a017773d6ce464e1425d1 (in IBD=false) node0 2024-08-15T16:40:41.300906Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.301004Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=scantxoutset user=__cookie__ node0 2024-08-15T16:40:41.301073Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started node0 2024-08-15T16:40:41.302343Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (1.26ms) node0 2024-08-15T16:40:41.302353Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started node0 2024-08-15T16:40:41.302899Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (0.54ms) node0 2024-08-15T16:40:41.302906Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (3 coins, 262kB) started node0 2024-08-15T16:40:41.302921Z [httpworker.2] [txdb.cpp:146] [BatchWrite] [coindb] Writing final batch of 0.00 MiB node0 2024-08-15T16:40:41.302933Z [httpworker.2] [txdb.cpp:148] [BatchWrite] [coindb] Committed 3 changed transaction outputs (out of 3) to coin database... node0 2024-08-15T16:40:41.302958Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (3 coins, 262kB) completed (0.05ms) node0 2024-08-15T16:40:41.302965Z [httpworker.2] [validationinterface.cpp:246] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 node0 2024-08-15T16:40:41.303024Z [scheduler] [validationinterface.cpp:246] [operator()] [validation] ChainStateFlushed: block hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 node0 2024-08-15T16:40:41.305088Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.305179Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ node0 2024-08-15T16:40:41.305534Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.305634Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getbestblockhash user=__cookie__ node0 2024-08-15T16:40:41.305954Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.305987Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ node0 2024-08-15T16:40:41.306222Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.306311Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=syncwithvalidationinterfacequeue user=__cookie__ node0 2024-08-15T16:40:41.306744Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.306804Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.311929Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.313317Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=sendrawtransaction user=__cookie__ node0 2024-08-15T16:40:41.313929Z [httpworker.3] [validationinterface.cpp:199] [TransactionAddedToMempool] [validation] Enqueuing TransactionAddedToMempool: txid=a5df035741db3670da793ee5a77c074739b486d64994772836e1b3ec609aae1c wtxid=6f7101bc1f5a458b670a0a6d989657856fe2b06a4b7a07e34f2ccdde4a53938e node0 2024-08-15T16:40:41.313950Z [httpworker.3] [txmempool.cpp:664] [check] [mempool] Checking mempool with 1 transactions and 1 inputs node0 2024-08-15T16:40:41.314001Z [scheduler] [validationinterface.cpp:199] [operator()] [validation] TransactionAddedToMempool: txid=a5df035741db3670da793ee5a77c074739b486d64994772836e1b3ec609aae1c wtxid=6f7101bc1f5a458b670a0a6d989657856fe2b06a4b7a07e34f2ccdde4a53938e node0 2024-08-15T16:40:41.314630Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.315991Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=decoderawtransaction user=__cookie__ node0 2024-08-15T16:40:41.362738Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.362819Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.363421Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.363489Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=generatetodescriptor user=__cookie__ node0 2024-08-15T16:40:41.363551Z [httpworker.1] [node/miner.cpp:158] [CreateNewBlock] CreateNewBlock(): block weight: 80943 txs: 1 fees: 6000300 sigops 400 node0 2024-08-15T16:40:41.363627Z [httpworker.1] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.363659Z [httpworker.1] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.03ms [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.363688Z [httpworker.1] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 2 transactions: 0.03ms (0.014ms/tx, 0.028ms/txin) [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.363693Z [httpworker.1] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 1 txins: 0.03ms (0.034ms/txin) [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.363698Z [httpworker.1] [node/miner.cpp:177] [CreateNewBlock] [bench] CreateNewBlock() packages: 0.01ms (1 packages, 0 updated descendants), validity: 0.16ms (total 0.16ms) node0 2024-08-15T16:40:41.363729Z [httpworker.1] [validation.cpp:4395] [AcceptBlockHeader] Saw new header hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb height=202 node0 2024-08-15T16:40:41.363751Z [httpworker.1] [validationinterface.cpp:256] [NewPoWValidBlock] [validation] NewPoWValidBlock: block hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb node0 2024-08-15T16:40:41.363797Z [httpworker.1] [flatfile.cpp:69] [Allocate] [validation] Pre-allocating up to position 0xc000 in blk00001.dat node0 2024-08-15T16:40:41.363886Z [httpworker.1] [validation.cpp:3168] [ConnectTip] [bench] - Using cached block node0 2024-08-15T16:40:41.363892Z [httpworker.1] [validation.cpp:3178] [ConnectTip] [bench] - Load block from disk: 0.01ms node0 2024-08-15T16:40:41.363906Z [httpworker.1] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.00ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.363924Z [httpworker.1] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.02ms [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.363949Z [httpworker.1] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 2 transactions: 0.02ms (0.012ms/tx, 0.024ms/txin) [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.363953Z [httpworker.1] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 1 txins: 0.03ms (0.029ms/txin) [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.363972Z [httpworker.1] [validation.cpp:2733] [ConnectBlock] [bench] - Write undo data: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.363976Z [httpworker.1] [validation.cpp:2748] [ConnectBlock] [bench] - Index writing: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.363981Z [httpworker.1] [validationinterface.cpp:251] [BlockChecked] [validation] BlockChecked: block hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb state=Valid node0 2024-08-15T16:40:41.363989Z [httpworker.1] [validation.cpp:3197] [ConnectTip] [bench] - Connect total: 0.10ms [0.00s (0.05ms/blk)] node0 2024-08-15T16:40:41.364005Z [httpworker.1] [validation.cpp:3206] [ConnectTip] [bench] - Flush: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.364009Z [httpworker.1] [validation.cpp:3216] [ConnectTip] [bench] - Writing chainstate: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.364017Z [httpworker.1] [txmempool.cpp:1039] [RemoveUnbroadcastTx] [mempool] Removed a5df035741db3670da793ee5a77c074739b486d64994772836e1b3ec609aae1c from set of unbroadcast txns before confirmation that txn was sent out node0 2024-08-15T16:40:41.364022Z [httpworker.1] [validationinterface.cpp:228] [MempoolTransactionsRemovedForBlock] [validation] Enqueuing MempoolTransactionsRemovedForBlock: block height=202 txs removed=1 node0 2024-08-15T16:40:41.364036Z [httpworker.1] [validation.cpp:2979] [UpdateTipLog] UpdateTip: new best=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb height=202 version=0x30000000 log2_work=8.665336 tx=205 date='2024-08-15T16:40:41Z' progress=1.000000 cache=0.3MiB(3txo) node0 2024-08-15T16:40:41.364041Z [httpworker.1] [validation.cpp:3232] [ConnectTip] [bench] - Connect postprocess: 0.03ms [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.364044Z [httpworker.1] [validation.cpp:3236] [ConnectTip] [bench] - Connect block: 0.15ms [0.00s (0.08ms/blk)] node0 2024-08-15T16:40:41.364048Z [httpworker.1] [txmempool.cpp:664] [check] [mempool] Checking mempool with 0 transactions and 0 inputs node0 2024-08-15T16:40:41.364065Z [httpworker.1] [validationinterface.cpp:218] [BlockConnected] [validation] Enqueuing BlockConnected: block hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb block height=202 node0 2024-08-15T16:40:41.364073Z [httpworker.1] [validationinterface.cpp:183] [UpdatedBlockTip] [validation] Enqueuing UpdatedBlockTip: new block hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb fork block hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 (in IBD=false) node0 2024-08-15T16:40:41.364080Z [httpworker.1] [validationinterface.cpp:188] [ActiveTipChange] [validation] ActiveTipChange: new block hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb block height=202 node0 2024-08-15T16:40:41.364088Z [scheduler] [validationinterface.cpp:228] [operator()] [validation] MempoolTransactionsRemovedForBlock: block height=202 txs removed=1 node0 2024-08-15T16:40:41.364150Z [scheduler] [policy/fees.cpp:708] [processBlock] [estimatefee] Blockpolicy estimates updated by 1 of 1 block txs, since last block 1 of 1 tracked, mempool map size 0, max target 0 from current node0 2024-08-15T16:40:41.364164Z [scheduler] [validationinterface.cpp:218] [operator()] [validation] BlockConnected: block hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb block height=202 node0 2024-08-15T16:40:41.364230Z [scheduler] [validationinterface.cpp:183] [operator()] [validation] UpdatedBlockTip: new block hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb fork block hash=422aa1c3fae5e1a8b1aefc84ffff6e57e5fbbd828c0590055757f9e909b5e979 (in IBD=false) node0 2024-08-15T16:40:41.364677Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.364748Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=scantxoutset user=__cookie__ node0 2024-08-15T16:40:41.364814Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started node0 2024-08-15T16:40:41.365898Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (1.07ms) node0 2024-08-15T16:40:41.365908Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started node0 2024-08-15T16:40:41.366509Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (0.59ms) node0 2024-08-15T16:40:41.366520Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (3 coins, 262kB) started node0 2024-08-15T16:40:41.366541Z [httpworker.3] [txdb.cpp:146] [BatchWrite] [coindb] Writing final batch of 0.00 MiB node0 2024-08-15T16:40:41.366555Z [httpworker.3] [txdb.cpp:148] [BatchWrite] [coindb] Committed 3 changed transaction outputs (out of 3) to coin database... node0 2024-08-15T16:40:41.366579Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (3 coins, 262kB) completed (0.05ms) node0 2024-08-15T16:40:41.366587Z [httpworker.3] [validationinterface.cpp:246] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb node0 2024-08-15T16:40:41.366649Z [scheduler] [validationinterface.cpp:246] [operator()] [validation] ChainStateFlushed: block hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb node0 2024-08-15T16:40:41.368741Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.368808Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ node0 2024-08-15T16:40:41.369156Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.369220Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getbestblockhash user=__cookie__ node0 2024-08-15T16:40:41.369468Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.369528Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ node0 2024-08-15T16:40:41.369779Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.369838Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=syncwithvalidationinterfacequeue user=__cookie__ node0 2024-08-15T16:40:41.370144Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.370197Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.375193Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.376548Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=sendrawtransaction user=__cookie__ node0 2024-08-15T16:40:41.377159Z [httpworker.2] [validationinterface.cpp:199] [TransactionAddedToMempool] [validation] Enqueuing TransactionAddedToMempool: txid=81ab724266dae3870c007e062f0f8530322854d4656b00761b914009f0a4a024 wtxid=ed95e05fb20f74955757ca6f6397a82d32dd545014310707d91d8d971230698d node0 2024-08-15T16:40:41.377174Z [httpworker.2] [txmempool.cpp:664] [check] [mempool] Checking mempool with 1 transactions and 1 inputs node0 2024-08-15T16:40:41.377226Z [scheduler] [validationinterface.cpp:199] [operator()] [validation] TransactionAddedToMempool: txid=81ab724266dae3870c007e062f0f8530322854d4656b00761b914009f0a4a024 wtxid=ed95e05fb20f74955757ca6f6397a82d32dd545014310707d91d8d971230698d node0 2024-08-15T16:40:41.377831Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.379195Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=decoderawtransaction user=__cookie__ node0 2024-08-15T16:40:41.426790Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.426873Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.427479Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.427546Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=generatetodescriptor user=__cookie__ node0 2024-08-15T16:40:41.427609Z [httpworker.0] [node/miner.cpp:158] [CreateNewBlock] CreateNewBlock(): block weight: 80943 txs: 1 fees: 6000300 sigops 400 node0 2024-08-15T16:40:41.427688Z [httpworker.0] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.427720Z [httpworker.0] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.03ms [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.427749Z [httpworker.0] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 2 transactions: 0.03ms (0.014ms/tx, 0.028ms/txin) [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.427754Z [httpworker.0] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 1 txins: 0.03ms (0.034ms/txin) [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.427758Z [httpworker.0] [node/miner.cpp:177] [CreateNewBlock] [bench] CreateNewBlock() packages: 0.01ms (1 packages, 0 updated descendants), validity: 0.16ms (total 0.17ms) node0 2024-08-15T16:40:41.427790Z [httpworker.0] [validation.cpp:4395] [AcceptBlockHeader] Saw new header hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d height=203 node0 2024-08-15T16:40:41.427813Z [httpworker.0] [validationinterface.cpp:256] [NewPoWValidBlock] [validation] NewPoWValidBlock: block hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d node0 2024-08-15T16:40:41.427860Z [httpworker.0] [flatfile.cpp:69] [Allocate] [validation] Pre-allocating up to position 0x10000 in blk00001.dat node0 2024-08-15T16:40:41.427948Z [httpworker.0] [validation.cpp:3168] [ConnectTip] [bench] - Using cached block node0 2024-08-15T16:40:41.427954Z [httpworker.0] [validation.cpp:3178] [ConnectTip] [bench] - Load block from disk: 0.01ms node0 2024-08-15T16:40:41.427969Z [httpworker.0] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.00ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.427987Z [httpworker.0] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.02ms [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.428011Z [httpworker.0] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 2 transactions: 0.02ms (0.012ms/tx, 0.024ms/txin) [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.428015Z [httpworker.0] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 1 txins: 0.03ms (0.028ms/txin) [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.428034Z [httpworker.0] [validation.cpp:2733] [ConnectBlock] [bench] - Write undo data: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.428038Z [httpworker.0] [validation.cpp:2748] [ConnectBlock] [bench] - Index writing: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.428043Z [httpworker.0] [validationinterface.cpp:251] [BlockChecked] [validation] BlockChecked: block hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d state=Valid node0 2024-08-15T16:40:41.428048Z [httpworker.0] [validation.cpp:3197] [ConnectTip] [bench] - Connect total: 0.09ms [0.00s (0.05ms/blk)] node0 2024-08-15T16:40:41.428063Z [httpworker.0] [validation.cpp:3206] [ConnectTip] [bench] - Flush: 0.01ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.428067Z [httpworker.0] [validation.cpp:3216] [ConnectTip] [bench] - Writing chainstate: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.428075Z [httpworker.0] [txmempool.cpp:1039] [RemoveUnbroadcastTx] [mempool] Removed 81ab724266dae3870c007e062f0f8530322854d4656b00761b914009f0a4a024 from set of unbroadcast txns before confirmation that txn was sent out node0 2024-08-15T16:40:41.428079Z [httpworker.0] [validationinterface.cpp:228] [MempoolTransactionsRemovedForBlock] [validation] Enqueuing MempoolTransactionsRemovedForBlock: block height=203 txs removed=1 node0 2024-08-15T16:40:41.428097Z [httpworker.0] [validation.cpp:2979] [UpdateTipLog] UpdateTip: new best=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d height=203 version=0x30000000 log2_work=8.672425 tx=207 date='2024-08-15T16:40:41Z' progress=1.000000 cache=0.3MiB(3txo) node0 2024-08-15T16:40:41.428103Z [httpworker.0] [validation.cpp:3232] [ConnectTip] [bench] - Connect postprocess: 0.04ms [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.428106Z [httpworker.0] [validation.cpp:3236] [ConnectTip] [bench] - Connect block: 0.15ms [0.00s (0.08ms/blk)] node0 2024-08-15T16:40:41.428114Z [httpworker.0] [txmempool.cpp:664] [check] [mempool] Checking mempool with 0 transactions and 0 inputs node0 2024-08-15T16:40:41.428130Z [httpworker.0] [validationinterface.cpp:218] [BlockConnected] [validation] Enqueuing BlockConnected: block hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d block height=203 node0 2024-08-15T16:40:41.428139Z [httpworker.0] [validationinterface.cpp:183] [UpdatedBlockTip] [validation] Enqueuing UpdatedBlockTip: new block hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d fork block hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb (in IBD=false) node0 2024-08-15T16:40:41.428150Z [scheduler] [validationinterface.cpp:228] [operator()] [validation] MempoolTransactionsRemovedForBlock: block height=203 txs removed=1 node0 2024-08-15T16:40:41.428161Z [httpworker.0] [validationinterface.cpp:188] [ActiveTipChange] [validation] ActiveTipChange: new block hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d block height=203 node0 2024-08-15T16:40:41.428238Z [scheduler] [policy/fees.cpp:708] [processBlock] [estimatefee] Blockpolicy estimates updated by 1 of 1 block txs, since last block 1 of 1 tracked, mempool map size 0, max target 1 from current node0 2024-08-15T16:40:41.428256Z [scheduler] [validationinterface.cpp:218] [operator()] [validation] BlockConnected: block hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d block height=203 node0 2024-08-15T16:40:41.428302Z [scheduler] [validationinterface.cpp:183] [operator()] [validation] UpdatedBlockTip: new block hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d fork block hash=5aba21a81574c21bb4fcc4acb17f5044048bfbaa4fcacc47f55928ee3c9348cb (in IBD=false) node0 2024-08-15T16:40:41.428787Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.428858Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=scantxoutset user=__cookie__ node0 2024-08-15T16:40:41.428928Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started node0 2024-08-15T16:40:41.429977Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (1.04ms) node0 2024-08-15T16:40:41.429987Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started node0 2024-08-15T16:40:41.430650Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (0.66ms) node0 2024-08-15T16:40:41.430661Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (3 coins, 262kB) started node0 2024-08-15T16:40:41.430678Z [httpworker.2] [txdb.cpp:146] [BatchWrite] [coindb] Writing final batch of 0.00 MiB node0 2024-08-15T16:40:41.430693Z [httpworker.2] [txdb.cpp:148] [BatchWrite] [coindb] Committed 3 changed transaction outputs (out of 3) to coin database... node0 2024-08-15T16:40:41.430714Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (3 coins, 262kB) completed (0.05ms) node0 2024-08-15T16:40:41.430722Z [httpworker.2] [validationinterface.cpp:246] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d node0 2024-08-15T16:40:41.430781Z [scheduler] [validationinterface.cpp:246] [operator()] [validation] ChainStateFlushed: block hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d node0 2024-08-15T16:40:41.432883Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.432950Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ node0 2024-08-15T16:40:41.433299Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.433375Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getbestblockhash user=__cookie__ node0 2024-08-15T16:40:41.433636Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.433672Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ node0 2024-08-15T16:40:41.433887Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.433942Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=syncwithvalidationinterfacequeue user=__cookie__ node0 2024-08-15T16:40:41.434287Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.434347Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.439352Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.440712Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=sendrawtransaction user=__cookie__ node0 2024-08-15T16:40:41.441328Z [httpworker.3] [validationinterface.cpp:199] [TransactionAddedToMempool] [validation] Enqueuing TransactionAddedToMempool: txid=63890d00b634d79d028cdfb48ab2982bc78e4255b30724819799871430a26e95 wtxid=6f7ced0c98328eeb15dad24857135d2b8f776f4007db5788bc6c4d8a30aaaf3f node0 2024-08-15T16:40:41.441344Z [httpworker.3] [txmempool.cpp:664] [check] [mempool] Checking mempool with 1 transactions and 1 inputs node0 2024-08-15T16:40:41.441395Z [scheduler] [validationinterface.cpp:199] [operator()] [validation] TransactionAddedToMempool: txid=63890d00b634d79d028cdfb48ab2982bc78e4255b30724819799871430a26e95 wtxid=6f7ced0c98328eeb15dad24857135d2b8f776f4007db5788bc6c4d8a30aaaf3f node0 2024-08-15T16:40:41.441984Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.443353Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=decoderawtransaction user=__cookie__ node0 2024-08-15T16:40:41.450292Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.450388Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.451051Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.451117Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=generatetodescriptor user=__cookie__ node0 2024-08-15T16:40:41.451181Z [httpworker.1] [node/miner.cpp:158] [CreateNewBlock] CreateNewBlock(): block weight: 80943 txs: 1 fees: 6000300 sigops 400 node0 2024-08-15T16:40:41.451251Z [httpworker.1] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.451285Z [httpworker.1] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.04ms [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.451314Z [httpworker.1] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 2 transactions: 0.03ms (0.014ms/tx, 0.028ms/txin) [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.451319Z [httpworker.1] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 1 txins: 0.03ms (0.034ms/txin) [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.451324Z [httpworker.1] [node/miner.cpp:177] [CreateNewBlock] [bench] CreateNewBlock() packages: 0.01ms (1 packages, 0 updated descendants), validity: 0.15ms (total 0.16ms) node0 2024-08-15T16:40:41.451356Z [httpworker.1] [validation.cpp:4395] [AcceptBlockHeader] Saw new header hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a height=204 node0 2024-08-15T16:40:41.451378Z [httpworker.1] [validationinterface.cpp:256] [NewPoWValidBlock] [validation] NewPoWValidBlock: block hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a node0 2024-08-15T16:40:41.451398Z [httpworker.1] [node/blockstorage.cpp:891] [FindNextBlockPos] [blockstorage] Leaving block file 1: CBlockFileInfo(blocks=3, size=60900, heights=201...203, time=2024-08-15...2024-08-15) (onto 2) (height 204) node0 2024-08-15T16:40:41.452671Z [httpworker.1] [flatfile.cpp:69] [Allocate] [validation] Pre-allocating up to position 0x8000 in blk00002.dat node0 2024-08-15T16:40:41.452758Z [httpworker.1] [validation.cpp:3168] [ConnectTip] [bench] - Using cached block node0 2024-08-15T16:40:41.452765Z [httpworker.1] [validation.cpp:3178] [ConnectTip] [bench] - Load block from disk: 0.01ms node0 2024-08-15T16:40:41.452779Z [httpworker.1] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.00ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.452800Z [httpworker.1] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.02ms [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.452825Z [httpworker.1] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 2 transactions: 0.02ms (0.012ms/tx, 0.025ms/txin) [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.452830Z [httpworker.1] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 1 txins: 0.03ms (0.030ms/txin) [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.452849Z [httpworker.1] [flatfile.cpp:69] [Allocate] [validation] Pre-allocating up to position 0x100000 in rev00002.dat node0 2024-08-15T16:40:41.452876Z [httpworker.1] [validation.cpp:2733] [ConnectBlock] [bench] - Write undo data: 0.05ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.452881Z [httpworker.1] [validation.cpp:2748] [ConnectBlock] [bench] - Index writing: 0.01ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.452886Z [httpworker.1] [validationinterface.cpp:251] [BlockChecked] [validation] BlockChecked: block hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a state=Valid node0 2024-08-15T16:40:41.452891Z [httpworker.1] [validation.cpp:3197] [ConnectTip] [bench] - Connect total: 0.13ms [0.00s (0.05ms/blk)] node0 2024-08-15T16:40:41.452907Z [httpworker.1] [validation.cpp:3206] [ConnectTip] [bench] - Flush: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.452911Z [httpworker.1] [validation.cpp:3216] [ConnectTip] [bench] - Writing chainstate: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.452918Z [httpworker.1] [txmempool.cpp:1039] [RemoveUnbroadcastTx] [mempool] Removed 63890d00b634d79d028cdfb48ab2982bc78e4255b30724819799871430a26e95 from set of unbroadcast txns before confirmation that txn was sent out node0 2024-08-15T16:40:41.452923Z [httpworker.1] [validationinterface.cpp:228] [MempoolTransactionsRemovedForBlock] [validation] Enqueuing MempoolTransactionsRemovedForBlock: block height=204 txs removed=1 node0 2024-08-15T16:40:41.452938Z [httpworker.1] [validation.cpp:2979] [UpdateTipLog] UpdateTip: new best=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a height=204 version=0x30000000 log2_work=8.679480 tx=209 date='2024-08-15T16:40:41Z' progress=1.000000 cache=0.3MiB(3txo) node0 2024-08-15T16:40:41.452943Z [httpworker.1] [validation.cpp:3232] [ConnectTip] [bench] - Connect postprocess: 0.03ms [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.452946Z [httpworker.1] [validation.cpp:3236] [ConnectTip] [bench] - Connect block: 0.18ms [0.00s (0.08ms/blk)] node0 2024-08-15T16:40:41.452950Z [httpworker.1] [txmempool.cpp:664] [check] [mempool] Checking mempool with 0 transactions and 0 inputs node0 2024-08-15T16:40:41.452968Z [httpworker.1] [validationinterface.cpp:218] [BlockConnected] [validation] Enqueuing BlockConnected: block hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a block height=204 node0 2024-08-15T16:40:41.452975Z [httpworker.1] [validationinterface.cpp:183] [UpdatedBlockTip] [validation] Enqueuing UpdatedBlockTip: new block hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a fork block hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d (in IBD=false) node0 2024-08-15T16:40:41.452983Z [httpworker.1] [validationinterface.cpp:188] [ActiveTipChange] [validation] ActiveTipChange: new block hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a block height=204 node0 2024-08-15T16:40:41.452994Z [scheduler] [validationinterface.cpp:228] [operator()] [validation] MempoolTransactionsRemovedForBlock: block height=204 txs removed=1 node0 2024-08-15T16:40:41.453060Z [scheduler] [policy/fees.cpp:708] [processBlock] [estimatefee] Blockpolicy estimates updated by 1 of 1 block txs, since last block 1 of 1 tracked, mempool map size 0, max target 1 from current node0 2024-08-15T16:40:41.453081Z [scheduler] [validationinterface.cpp:218] [operator()] [validation] BlockConnected: block hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a block height=204 node0 2024-08-15T16:40:41.453143Z [scheduler] [validationinterface.cpp:183] [operator()] [validation] UpdatedBlockTip: new block hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a fork block hash=4d3a6ef13e2e6cc2a3a538323a679f49f9bee83b63903a9cd81c3d5e134cb18d (in IBD=false) node0 2024-08-15T16:40:41.453655Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.453703Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=scantxoutset user=__cookie__ node0 2024-08-15T16:40:41.453772Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started node0 2024-08-15T16:40:41.455030Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (1.25ms) node0 2024-08-15T16:40:41.455040Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started node0 2024-08-15T16:40:41.455662Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (0.62ms) node0 2024-08-15T16:40:41.455673Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (3 coins, 262kB) started node0 2024-08-15T16:40:41.455689Z [httpworker.3] [txdb.cpp:146] [BatchWrite] [coindb] Writing final batch of 0.00 MiB node0 2024-08-15T16:40:41.455706Z [httpworker.3] [txdb.cpp:148] [BatchWrite] [coindb] Committed 3 changed transaction outputs (out of 3) to coin database... node0 2024-08-15T16:40:41.455730Z [httpworker.3] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (3 coins, 262kB) completed (0.05ms) node0 2024-08-15T16:40:41.455739Z [httpworker.3] [validationinterface.cpp:246] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a node0 2024-08-15T16:40:41.455802Z [scheduler] [validationinterface.cpp:246] [operator()] [validation] ChainStateFlushed: block hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a node0 2024-08-15T16:40:41.498738Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.498821Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ node0 2024-08-15T16:40:41.499243Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.499308Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getbestblockhash user=__cookie__ node0 2024-08-15T16:40:41.499639Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.499702Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ node0 2024-08-15T16:40:41.500043Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.500079Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=syncwithvalidationinterfacequeue user=__cookie__ node0 2024-08-15T16:40:41.500489Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.500551Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.505477Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.506835Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=sendrawtransaction user=__cookie__ node0 2024-08-15T16:40:41.507454Z [httpworker.2] [validationinterface.cpp:199] [TransactionAddedToMempool] [validation] Enqueuing TransactionAddedToMempool: txid=8366b9a5f3e98dd099c4c4ac90fb271c5413f07e9cd3ea2e6ceb4bdfdcbe1641 wtxid=bf2113141354a9ee94e48330bfa6fc72b0f07a632c44a265a60b0c70056ea280 node0 2024-08-15T16:40:41.507476Z [httpworker.2] [txmempool.cpp:664] [check] [mempool] Checking mempool with 1 transactions and 1 inputs node0 2024-08-15T16:40:41.507528Z [scheduler] [validationinterface.cpp:199] [operator()] [validation] TransactionAddedToMempool: txid=8366b9a5f3e98dd099c4c4ac90fb271c5413f07e9cd3ea2e6ceb4bdfdcbe1641 wtxid=bf2113141354a9ee94e48330bfa6fc72b0f07a632c44a265a60b0c70056ea280 node0 2024-08-15T16:40:41.508181Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.509514Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=decoderawtransaction user=__cookie__ node0 2024-08-15T16:40:41.515885Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.515936Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getblockchaininfo user=__cookie__ node0 2024-08-15T16:40:41.516472Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.516542Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=generatetodescriptor user=__cookie__ node0 2024-08-15T16:40:41.516603Z [httpworker.0] [node/miner.cpp:158] [CreateNewBlock] CreateNewBlock(): block weight: 80943 txs: 1 fees: 6000300 sigops 400 node0 2024-08-15T16:40:41.516679Z [httpworker.0] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.516713Z [httpworker.0] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.04ms [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.516741Z [httpworker.0] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 2 transactions: 0.03ms (0.014ms/tx, 0.028ms/txin) [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.516746Z [httpworker.0] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 1 txins: 0.03ms (0.034ms/txin) [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.516751Z [httpworker.0] [node/miner.cpp:177] [CreateNewBlock] [bench] CreateNewBlock() packages: 0.01ms (1 packages, 0 updated descendants), validity: 0.16ms (total 0.17ms) node0 2024-08-15T16:40:41.516782Z [httpworker.0] [validation.cpp:4395] [AcceptBlockHeader] Saw new header hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d height=205 node0 2024-08-15T16:40:41.516804Z [httpworker.0] [validationinterface.cpp:256] [NewPoWValidBlock] [validation] NewPoWValidBlock: block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d node0 2024-08-15T16:40:41.516850Z [httpworker.0] [flatfile.cpp:69] [Allocate] [validation] Pre-allocating up to position 0xc000 in blk00002.dat node0 2024-08-15T16:40:41.516938Z [httpworker.0] [validation.cpp:3168] [ConnectTip] [bench] - Using cached block node0 2024-08-15T16:40:41.516944Z [httpworker.0] [validation.cpp:3178] [ConnectTip] [bench] - Load block from disk: 0.01ms node0 2024-08-15T16:40:41.516958Z [httpworker.0] [validation.cpp:2507] [ConnectBlock] [bench] - Sanity checks: 0.00ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.516978Z [httpworker.0] [validation.cpp:2609] [ConnectBlock] [bench] - Fork checks: 0.02ms [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.517002Z [httpworker.0] [validation.cpp:2701] [ConnectBlock] [bench] - Connect 2 transactions: 0.02ms (0.012ms/tx, 0.024ms/txin) [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.517007Z [httpworker.0] [validation.cpp:2719] [ConnectBlock] [bench] - Verify 1 txins: 0.03ms (0.029ms/txin) [0.00s (0.03ms/blk)] node0 2024-08-15T16:40:41.517025Z [httpworker.0] [validation.cpp:2733] [ConnectBlock] [bench] - Write undo data: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.517028Z [httpworker.0] [validation.cpp:2748] [ConnectBlock] [bench] - Index writing: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.517034Z [httpworker.0] [validationinterface.cpp:251] [BlockChecked] [validation] BlockChecked: block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d state=Valid node0 2024-08-15T16:40:41.517042Z [httpworker.0] [validation.cpp:3197] [ConnectTip] [bench] - Connect total: 0.10ms [0.00s (0.05ms/blk)] node0 2024-08-15T16:40:41.517058Z [httpworker.0] [validation.cpp:3206] [ConnectTip] [bench] - Flush: 0.02ms [0.00s (0.01ms/blk)] node0 2024-08-15T16:40:41.517062Z [httpworker.0] [validation.cpp:3216] [ConnectTip] [bench] - Writing chainstate: 0.00ms [0.00s (0.00ms/blk)] node0 2024-08-15T16:40:41.517069Z [httpworker.0] [txmempool.cpp:1039] [RemoveUnbroadcastTx] [mempool] Removed 8366b9a5f3e98dd099c4c4ac90fb271c5413f07e9cd3ea2e6ceb4bdfdcbe1641 from set of unbroadcast txns before confirmation that txn was sent out node0 2024-08-15T16:40:41.517074Z [httpworker.0] [validationinterface.cpp:228] [MempoolTransactionsRemovedForBlock] [validation] Enqueuing MempoolTransactionsRemovedForBlock: block height=205 txs removed=1 node0 2024-08-15T16:40:41.517092Z [httpworker.0] [validation.cpp:2979] [UpdateTipLog] UpdateTip: new best=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d height=205 version=0x30000000 log2_work=8.686501 tx=211 date='2024-08-15T16:40:41Z' progress=1.000000 cache=0.3MiB(3txo) node0 2024-08-15T16:40:41.517097Z [httpworker.0] [validation.cpp:3232] [ConnectTip] [bench] - Connect postprocess: 0.03ms [0.00s (0.02ms/blk)] node0 2024-08-15T16:40:41.517101Z [httpworker.0] [validation.cpp:3236] [ConnectTip] [bench] - Connect block: 0.16ms [0.00s (0.08ms/blk)] node0 2024-08-15T16:40:41.517105Z [httpworker.0] [txmempool.cpp:664] [check] [mempool] Checking mempool with 0 transactions and 0 inputs node0 2024-08-15T16:40:41.517121Z [httpworker.0] [validationinterface.cpp:218] [BlockConnected] [validation] Enqueuing BlockConnected: block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d block height=205 node0 2024-08-15T16:40:41.517129Z [httpworker.0] [validationinterface.cpp:183] [UpdatedBlockTip] [validation] Enqueuing UpdatedBlockTip: new block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d fork block hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a (in IBD=false) node0 2024-08-15T16:40:41.517139Z [scheduler] [validationinterface.cpp:228] [operator()] [validation] MempoolTransactionsRemovedForBlock: block height=205 txs removed=1 node0 2024-08-15T16:40:41.517150Z [httpworker.0] [validationinterface.cpp:188] [ActiveTipChange] [validation] ActiveTipChange: new block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d block height=205 node0 2024-08-15T16:40:41.517229Z [scheduler] [policy/fees.cpp:708] [processBlock] [estimatefee] Blockpolicy estimates updated by 1 of 1 block txs, since last block 1 of 1 tracked, mempool map size 0, max target 2 from current node0 2024-08-15T16:40:41.517247Z [scheduler] [validationinterface.cpp:218] [operator()] [validation] BlockConnected: block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d block height=205 node0 2024-08-15T16:40:41.517293Z [scheduler] [validationinterface.cpp:183] [operator()] [validation] UpdatedBlockTip: new block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d fork block hash=40fbf6bfae703986f7433ab926639543ec9c19407dc6d5b69f45090f72a4409a (in IBD=false) node0 2024-08-15T16:40:41.517773Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.517845Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=scantxoutset user=__cookie__ node0 2024-08-15T16:40:41.517913Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started node0 2024-08-15T16:40:41.518995Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (1.07ms) node0 2024-08-15T16:40:41.519005Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started node0 2024-08-15T16:40:41.519726Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (0.72ms) node0 2024-08-15T16:40:41.519741Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (3 coins, 262kB) started node0 2024-08-15T16:40:41.519758Z [httpworker.2] [txdb.cpp:146] [BatchWrite] [coindb] Writing final batch of 0.00 MiB node0 2024-08-15T16:40:41.519774Z [httpworker.2] [txdb.cpp:148] [BatchWrite] [coindb] Committed 3 changed transaction outputs (out of 3) to coin database... node0 2024-08-15T16:40:41.519797Z [httpworker.2] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (3 coins, 262kB) completed (0.05ms) node0 2024-08-15T16:40:41.519805Z [httpworker.2] [validationinterface.cpp:246] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d node0 2024-08-15T16:40:41.519864Z [scheduler] [validationinterface.cpp:246] [operator()] [validation] ChainStateFlushed: block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d node0 2024-08-15T16:40:41.562715Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.562798Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ node0 2024-08-15T16:40:41.563221Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.563259Z [httpworker.3] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getbestblockhash user=__cookie__ node0 2024-08-15T16:40:41.563559Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.563621Z [httpworker.0] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getrawmempool user=__cookie__ node0 2024-08-15T16:40:41.563977Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 test 2024-08-15T16:40:41.564000Z TestFramework (INFO): Shut down node and un-XOR block/undo files manually test 2024-08-15T16:40:41.564000Z TestFramework.node0 (DEBUG): Stopping node node0 2024-08-15T16:40:41.564040Z [httpworker.2] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=syncwithvalidationinterfacequeue user=__cookie__ node0 2024-08-15T16:40:41.565070Z [http] [httpserver.cpp:305] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:51726 node0 2024-08-15T16:40:41.565145Z [httpworker.1] [rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=stop user=__cookie__ node0 2024-08-15T16:40:41.565187Z [init] [httpserver.cpp:498] [InterruptHTTPServer] [http] Interrupting HTTP server node0 2024-08-15T16:40:41.565204Z [init] [httprpc.cpp:378] [InterruptHTTPRPC] [rpc] Interrupting HTTP RPC server node0 2024-08-15T16:40:41.565209Z [init] [rpc/server.cpp:308] [operator()] [rpc] Interrupting RPC node0 2024-08-15T16:40:41.565250Z [init] [init.cpp:273] [Shutdown] Shutdown: In progress... node0 2024-08-15T16:40:41.565258Z [shutoff] [httprpc.cpp:383] [StopHTTPRPC] [rpc] Stopping HTTP RPC server node0 2024-08-15T16:40:41.565266Z [shutoff] [httpserver.cpp:760] [UnregisterHTTPHandler] [http] Unregistering HTTP handler for / (exactmatch 1) node0 2024-08-15T16:40:41.565274Z [addcon] [util/thread.cpp:22] [TraceThread] addcon thread exit node0 2024-08-15T16:40:41.565288Z [shutoff] [httpserver.cpp:760] [UnregisterHTTPHandler] [http] Unregistering HTTP handler for /wallet/ (exactmatch 0) node0 2024-08-15T16:40:41.565296Z [shutoff] [rpc/server.cpp:320] [operator()] [rpc] Stopping RPC node0 2024-08-15T16:40:41.565352Z [shutoff] [init.cpp:441] [OnRPCStopped] [rpc] RPC stopped. node0 2024-08-15T16:40:41.565357Z [shutoff] [httpserver.cpp:510] [StopHTTPServer] [http] Stopping HTTP server node0 2024-08-15T16:40:41.565360Z [shutoff] [httpserver.cpp:512] [StopHTTPServer] [http] Waiting for HTTP worker threads to exit node0 2024-08-15T16:40:41.565378Z [shutoff] [httpserver.cpp:540] [StopHTTPServer] [http] Waiting for HTTP event thread to exit node0 2024-08-15T16:40:41.565406Z [http] [httpserver.cpp:354] [ThreadHTTP] [http] Exited http event loop node0 2024-08-15T16:40:41.565478Z [shutoff] [httpserver.cpp:546] [StopHTTPServer] [http] Stopped HTTP server node0 2024-08-15T16:40:41.613091Z [net] [util/thread.cpp:22] [TraceThread] net thread exit node0 2024-08-15T16:40:41.617436Z [msghand] [util/thread.cpp:22] [TraceThread] msghand thread exit node0 2024-08-15T16:40:41.618460Z [shutoff] [net.cpp:2328] [DumpAddresses] [net] Flushed 0 addresses to peers.dat 0ms node0 2024-08-15T16:40:41.618522Z [scheduler] [util/thread.cpp:22] [TraceThread] scheduler thread exit node0 2024-08-15T16:40:41.618808Z [shutoff] [node/mempool_persist.cpp:189] [DumpMempool] Writing 0 mempool transactions to file... node0 2024-08-15T16:40:41.618815Z [shutoff] [node/mempool_persist.cpp:199] [DumpMempool] Writing 0 unbroadcast transactions to file. node0 2024-08-15T16:40:41.619605Z [shutoff] [node/mempool_persist.cpp:213] [DumpMempool] Dumped mempool: 0.000s to copy, 0.001s to dump, 27 bytes dumped to file node0 2024-08-15T16:40:41.619614Z [shutoff] [policy/fees.cpp:1058] [FlushUnconfirmed] [estimatefee] Recorded 0 unconfirmed txs from mempool in 0.000s node0 2024-08-15T16:40:41.620491Z [shutoff] [policy/fees.cpp:956] [FlushFeeEstimates] Flushed fee estimates to fee_estimates.dat. node0 2024-08-15T16:40:41.620506Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started node0 2024-08-15T16:40:41.621355Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (0.84ms) node0 2024-08-15T16:40:41.621361Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started node0 2024-08-15T16:40:41.622013Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (0.65ms) node0 2024-08-15T16:40:41.622024Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) started node0 2024-08-15T16:40:41.622040Z [shutoff] [txdb.cpp:146] [BatchWrite] [coindb] Writing final batch of 0.00 MiB node0 2024-08-15T16:40:41.622054Z [shutoff] [txdb.cpp:148] [BatchWrite] [coindb] Committed 0 changed transaction outputs (out of 0) to coin database... node0 2024-08-15T16:40:41.622074Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) completed (0.04ms) node0 2024-08-15T16:40:41.622084Z [shutoff] [validationinterface.cpp:246] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d node0 2024-08-15T16:40:41.622091Z [shutoff] [validationinterface.cpp:246] [operator()] [validation] ChainStateFlushed: block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d node0 2024-08-15T16:40:41.622102Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk started node0 2024-08-15T16:40:41.622869Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block and undo data to disk completed (0.76ms) node0 2024-08-15T16:40:41.622879Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk started node0 2024-08-15T16:40:41.623484Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write block index to disk completed (0.60ms) node0 2024-08-15T16:40:41.623495Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) started node0 2024-08-15T16:40:41.623507Z [shutoff] [txdb.cpp:146] [BatchWrite] [coindb] Writing final batch of 0.00 MiB node0 2024-08-15T16:40:41.623521Z [shutoff] [txdb.cpp:148] [BatchWrite] [coindb] Committed 0 changed transaction outputs (out of 0) to coin database... node0 2024-08-15T16:40:41.623538Z [shutoff] [logging/timer.h:58] [Log] [bench] FlushStateToDisk: write coins cache to disk (0 coins, 262kB) completed (0.04ms) node0 2024-08-15T16:40:41.623545Z [shutoff] [validationinterface.cpp:246] [ChainStateFlushed] [validation] Enqueuing ChainStateFlushed: block hash=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d node0 2024-08-15T16:40:41.625568Z [shutoff] [init.cpp:387] [Shutdown] Shutdown: done test 2024-08-15T16:40:41.665000Z TestFramework.node0 (DEBUG): Node stopped test 2024-08-15T16:40:41.665000Z TestFramework (DEBUG): Rewriting file /tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks/blk00000.dat... test 2024-08-15T16:40:41.672000Z TestFramework (DEBUG): Rewriting file /tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks/blk00001.dat... test 2024-08-15T16:40:41.681000Z TestFramework (DEBUG): Rewriting file /tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks/blk00002.dat... test 2024-08-15T16:40:41.687000Z TestFramework (DEBUG): Rewriting file /tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks/rev00000.dat... test 2024-08-15T16:40:41.688000Z TestFramework (DEBUG): Rewriting file /tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks/rev00001.dat... test 2024-08-15T16:40:41.688000Z TestFramework (DEBUG): Rewriting file /tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks/rev00002.dat... test 2024-08-15T16:40:41.823000Z TestFramework (INFO): Check that restarting with 'blocksxor=0' fails if XOR key is present test 2024-08-15T16:40:41.823000Z TestFramework.node0 (DEBUG): bitcoind started, waiting for RPC to come up node0 2024-08-15T16:40:41.826115Z [init] [init/common.cpp:149] [LogPackageVersion] Bitcoin Core version v27.99.0-faa1b9b0e6de (release build) node0 2024-08-15T16:40:41.826118Z [init] [init.cpp:742] [InitParameterInteraction] parameter interaction: -bind set -> setting -listen=1 node0 2024-08-15T16:40:41.826162Z [init] [node/chainstatemanager_args.cpp:57] [ApplyArgsManOptions] Script verification uses 11 additional threads node0 2024-08-15T16:40:41.826296Z [init] [kernel/context.cpp:20] [operator()] Using the 'sse4(1way),sse41(4way),avx2(8way)' SHA256 implementation node0 2024-08-15T16:40:41.927730Z [init] [random.cpp:114] [ReportHardwareRand] Using RdSeed as an additional entropy source node0 2024-08-15T16:40:41.927733Z [init] [random.cpp:117] [ReportHardwareRand] Using RdRand as an additional entropy source node0 2024-08-15T16:40:41.929150Z [init] [init/common.cpp:120] [StartLogging] Default data directory /home/gloria/.bitcoin node0 2024-08-15T16:40:41.929154Z [init] [init/common.cpp:121] [StartLogging] Using data directory /tmp/bitcoin_func_test__c38k83u/node0/regtest node0 2024-08-15T16:40:41.929160Z [init] [init/common.cpp:126] [StartLogging] Config file: /tmp/bitcoin_func_test__c38k83u/node0/bitcoin.conf node0 2024-08-15T16:40:41.929168Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: regtest="1" node0 2024-08-15T16:40:41.929173Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] bind="127.0.0.1" node0 2024-08-15T16:40:41.929177Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] connect="0" node0 2024-08-15T16:40:41.929181Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] deprecatedrpc="create_bdb" node0 2024-08-15T16:40:41.929184Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] discover="0" node0 2024-08-15T16:40:41.929187Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] dnsseed="0" node0 2024-08-15T16:40:41.929190Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] fallbackfee="0.0002" node0 2024-08-15T16:40:41.929193Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] fixedseeds="0" node0 2024-08-15T16:40:41.929196Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] keypool="1" node0 2024-08-15T16:40:41.929199Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] listenonion="0" node0 2024-08-15T16:40:41.929202Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] natpmp="0" node0 2024-08-15T16:40:41.929205Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] peertimeout="999999999" node0 2024-08-15T16:40:41.929209Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] port="14645" node0 2024-08-15T16:40:41.929212Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] printtoconsole="0" node0 2024-08-15T16:40:41.929216Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] rpcdoccheck="1" node0 2024-08-15T16:40:41.929219Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] rpcport="19645" node0 2024-08-15T16:40:41.929223Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] rpcservertimeout="99000" node0 2024-08-15T16:40:41.929226Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] server="1" node0 2024-08-15T16:40:41.929230Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] shrinkdebugfile="0" node0 2024-08-15T16:40:41.929233Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] unsafesqlitesync="1" node0 2024-08-15T16:40:41.929236Z [init] [common/args.cpp:825] [logArgsPrefix] Config file arg: [regtest] upnp="0" node0 2024-08-15T16:40:41.929239Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: blocksxor="0" node0 2024-08-15T16:40:41.929243Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: datadir="/tmp/bitcoin_func_test__c38k83u/node0" node0 2024-08-15T16:40:41.929247Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: debug="" node0 2024-08-15T16:40:41.929250Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: debugexclude="libevent" node0 2024-08-15T16:40:41.929253Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: debugexclude="leveldb" node0 2024-08-15T16:40:41.929256Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: debugexclude="rand" node0 2024-08-15T16:40:41.929259Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: disablewallet="" node0 2024-08-15T16:40:41.929263Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: loglevel="trace" node0 2024-08-15T16:40:41.929268Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: logsourcelocations="" node0 2024-08-15T16:40:41.929271Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: logthreadnames="" node0 2024-08-15T16:40:41.929273Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: logtimemicros="" node0 2024-08-15T16:40:41.929277Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: uacomment="testnode0" node0 2024-08-15T16:40:41.929280Z [init] [common/args.cpp:825] [logArgsPrefix] Command-line arg: v2transport="0" node0 2024-08-15T16:40:41.929283Z [init] [init.cpp:1158] [AppInitMain] Using at most 125 automatic connections (1024 file descriptors available) node0 2024-08-15T16:40:41.929334Z [init] [wallet/init.cpp:129] [Construct] Wallet disabled! node0 2024-08-15T16:40:41.929382Z [scheduler] [util/thread.cpp:20] [TraceThread] scheduler thread start node0 2024-08-15T16:40:41.930558Z [init] [httpserver.cpp:238] [InitHTTPAllowList] [http] Allowing HTTP connections from: 127.0.0.0/8 ::1/128 node0 2024-08-15T16:40:41.930600Z [init] [httpserver.cpp:384] [HTTPBindAddresses] Binding RPC on address ::1 port 19645 node0 2024-08-15T16:40:41.930665Z [init] [httpserver.cpp:384] [HTTPBindAddresses] Binding RPC on address 127.0.0.1 port 19645 node0 2024-08-15T16:40:41.930689Z [init] [httpserver.cpp:463] [InitHTTPServer] [http] Initialized HTTP server node0 2024-08-15T16:40:41.930694Z [init] [httpserver.cpp:465] [InitHTTPServer] [http] creating work queue of depth 16 node0 2024-08-15T16:40:41.930697Z [init] [rpc/server.cpp:298] [StartRPC] [rpc] Starting RPC node0 2024-08-15T16:40:41.930706Z [init] [httprpc.cpp:360] [StartHTTPRPC] [rpc] Starting HTTP RPC server node0 2024-08-15T16:40:41.930709Z [init] [httprpc.cpp:297] [InitRPCAuthentication] Using random cookie authentication. node0 2024-08-15T16:40:41.930758Z [init] [rpc/request.cpp:132] [GenerateAuthCookie] Generated RPC authentication cookie /tmp/bitcoin_func_test__c38k83u/node0/regtest/.cookie node0 2024-08-15T16:40:41.930763Z [init] [rpc/request.cpp:133] [GenerateAuthCookie] Permissions used for cookie: rw------- node0 2024-08-15T16:40:41.930769Z [init] [httpserver.cpp:745] [RegisterHTTPHandler] [http] Registering HTTP handler for / (exactmatch 1) node0 2024-08-15T16:40:41.930773Z [init] [httpserver.cpp:745] [RegisterHTTPHandler] [http] Registering HTTP handler for /wallet/ (exactmatch 0) node0 2024-08-15T16:40:41.930777Z [init] [httpserver.cpp:488] [StartHTTPServer] Starting HTTP server with 4 worker threads node0 2024-08-15T16:40:41.930879Z [init] [init.cpp:1265] [AppInitMain] Using /16 prefix for IP bucketing node0 2024-08-15T16:40:41.930890Z [http] [httpserver.cpp:351] [ThreadHTTP] [http] Entering http event loop node0 2024-08-15T16:40:41.930959Z [init] [noui.cpp:57] [noui_InitMessage] init message: Loading P2P addresses… node0 2024-08-15T16:40:41.931126Z [init] [logging/timer.h:58] [Log] [addrman] CheckAddrman: new 0, tried 0, total 0 started node0 2024-08-15T16:40:41.931174Z [init] [logging/timer.h:58] [Log] [addrman] CheckAddrman: completed (0.04ms) node0 2024-08-15T16:40:41.931181Z [init] [addrdb.cpp:202] [LoadAddrman] Loaded 0 addresses from peers.dat 0ms node0 2024-08-15T16:40:41.931342Z [init] [noui.cpp:57] [noui_InitMessage] init message: Loading banlist… node0 2024-08-15T16:40:41.931379Z [init] [banman.cpp:40] [LoadBanlist] [net] Loaded 0 banned node addresses/subnets 0ms node0 2024-08-15T16:40:41.931394Z [init] [net.cpp:2360] [SetTryNewOutboundPeer] [net] setting try another outbound peer=false node0 2024-08-15T16:40:41.931398Z [init] [net.cpp:3136] [SetNetworkActive] SetNetworkActive: true node0 2024-08-15T16:40:41.932172Z [init] [policy/fees.cpp:470] [Read] [estimatefee] Reading estimates: 190 buckets counting confirms up to 48 blocks node0 2024-08-15T16:40:41.932297Z [init] [policy/fees.cpp:470] [Read] [estimatefee] Reading estimates: 190 buckets counting confirms up to 12 blocks node0 2024-08-15T16:40:41.932694Z [init] [policy/fees.cpp:470] [Read] [estimatefee] Reading estimates: 190 buckets counting confirms up to 1008 blocks node0 2024-08-15T16:40:41.932796Z [init] [node/chainstatemanager_args.cpp:57] [ApplyArgsManOptions] Script verification uses 11 additional threads node0 2024-08-15T16:40:41.932809Z [init] [init.cpp:1517] [AppInitMain] Cache configuration: node0 2024-08-15T16:40:41.932815Z [init] [init.cpp:1518] [AppInitMain] * Using 2.0 MiB for block index database node0 2024-08-15T16:40:41.932819Z [init] [init.cpp:1526] [AppInitMain] * Using 8.0 MiB for chain state database node0 2024-08-15T16:40:41.932852Z [init] [init.cpp:1549] [AppInitMain] * Using 440.0 MiB for in-memory UTXO set (plus up to 286.1 MiB of unused mempool space) node0 2024-08-15T16:40:41.933205Z [init] [node/blockstorage.cpp:1184] [InitBlocksdirXorKey] Using obfuscation key for blocksdir *.dat files (/tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks): '0000000000000000' node0 2024-08-15T16:40:41.937454Z [init] [script/sigcache.cpp:36] [SignatureCache] Using 16 MiB out of 16 MiB requested for signature cache, able to store 524288 elements node0 2024-08-15T16:40:41.941676Z [init] [validation.cpp:2125] [ValidationCache] Using 16 MiB out of 16 MiB requested for script execution cache, able to store 524288 elements node0 2024-08-15T16:40:41.941702Z [init] [noui.cpp:57] [noui_InitMessage] init message: Loading block index… node0 2024-08-15T16:40:41.941707Z [init] [node/chainstate.cpp:168] [LoadChainstate] Validating signatures for all blocks. node0 2024-08-15T16:40:41.941713Z [init] [node/chainstate.cpp:170] [LoadChainstate] Setting nMinimumChainWork=0000000000000000000000000000000000000000000000000000000000000000 node0 2024-08-15T16:40:41.941763Z [init] [dbwrapper.cpp:241] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks/index node0 2024-08-15T16:40:41.944702Z [init] [dbwrapper.cpp:249] [CDBWrapper] Opened LevelDB successfully node0 2024-08-15T16:40:41.944717Z [init] [dbwrapper.cpp:274] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test__c38k83u/node0/regtest/blocks/index: 0000000000000000 node0 2024-08-15T16:40:41.945122Z [init] [node/blockstorage.cpp:508] [LoadBlockIndexDB] LoadBlockIndexDB: last block file = 2 node0 2024-08-15T16:40:41.945145Z [init] [node/blockstorage.cpp:512] [LoadBlockIndexDB] LoadBlockIndexDB: last block file info: CBlockFileInfo(blocks=2, size=40600, heights=204...205, time=2024-08-15...2024-08-15) node0 2024-08-15T16:40:41.945153Z [init] [node/blockstorage.cpp:523] [LoadBlockIndexDB] Checking all blk files are present... node0 2024-08-15T16:40:41.945222Z [init] [node/chainstate.cpp:108] [CompleteChainstateInitialization] Initializing chainstate Chainstate [ibd] @ height -1 (null) node0 2024-08-15T16:40:41.945232Z [init] [dbwrapper.cpp:241] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test__c38k83u/node0/regtest/chainstate node0 2024-08-15T16:40:41.948000Z [init] [dbwrapper.cpp:249] [CDBWrapper] Opened LevelDB successfully node0 2024-08-15T16:40:41.948035Z [init] [dbwrapper.cpp:274] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test__c38k83u/node0/regtest/chainstate: 8a556cbbe58ab7be node0 2024-08-15T16:40:41.948129Z [init] [validation.cpp:4695] [LoadChainTip] Loaded best chain: hashBestChain=77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d height=205 date=2024-08-15T16:40:41Z progress=1.000000 node0 2024-08-15T16:40:41.948171Z [init] [dbwrapper.cpp:241] [CDBWrapper] Opening LevelDB in /tmp/bitcoin_func_test__c38k83u/node0/regtest/chainstate node0 2024-08-15T16:40:41.950085Z [init] [dbwrapper.cpp:249] [CDBWrapper] Opened LevelDB successfully node0 2024-08-15T16:40:41.950112Z [init] [dbwrapper.cpp:274] [CDBWrapper] Using obfuscation key for /tmp/bitcoin_func_test__c38k83u/node0/regtest/chainstate: 8a556cbbe58ab7be node0 2024-08-15T16:40:41.950122Z [init] [validation.cpp:5560] [ResizeCoinsCaches] [Chainstate [ibd] @ height 205 (77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d)] resized coinsdb cache to 8.0 MiB node0 2024-08-15T16:40:41.950127Z [init] [validation.cpp:5562] [ResizeCoinsCaches] [Chainstate [ibd] @ height 205 (77628eb588b4daef5e9b2ea23eba230c68619a89fa9b97a2fec76f426b13084d)] resized coinstip cache to 440.0 MiB node0 2024-08-15T16:40:41.950135Z [init] [noui.cpp:57] [noui_InitMessage] init message: Verifying blocks… node0 2024-08-15T16:40:41.950141Z [init] [validation.cpp:4727] [VerifyDB] Verifying last 6 blocks at level 3 node0 2024-08-15T16:40:41.950165Z [init] [validation.cpp:4736] [VerifyDB] Verification progress: 0% node0 2024-08-15T16:40:41.950400Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 16% node0 2024-08-15T16:40:41.950577Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 33% node0 2024-08-15T16:40:41.950753Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 50% node0 2024-08-15T16:40:41.950922Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 66% node0 2024-08-15T16:40:41.951097Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 83% node0 2024-08-15T16:40:41.951139Z [init] [validation.cpp:4744] [VerifyDB] Verification progress: 99% node0 2024-08-15T16:40:41.951144Z [init] [validation.cpp:4838] [VerifyDB] Verification: No coin database inconsistencies in last 6 blocks (11 transactions) node0 2024-08-15T16:40:41.951153Z [init] [init.cpp:1611] [AppInitMain] block index 9ms node0 2024-08-15T16:40:41.951181Z [init] [init.cpp:1698] [AppInitMain] Setting NODE_NETWORK on non-prune mode node0 2024-08-15T16:40:41.951232Z [init] [init.cpp:1808] [AppInitMain] block tree size = 206 node0 2024-08-15T16:40:41.951237Z [init] [init.cpp:1821] [AppInitMain] nBestHeight = 205 node0 2024-08-15T16:40:41.951275Z [init] [net.cpp:3073] [BindListenPort] Bound to 127.0.0.1:14645 node0 2024-08-15T16:40:41.951283Z [init] [noui.cpp:57] [noui_InitMessage] init message: Starting network threads… node0 2024-08-15T16:40:41.951294Z [initload] [util/thread.cpp:20] [TraceThread] initload thread start node0 2024-08-15T16:40:41.951306Z [init] [net.cpp:3297] [Start] DNS seeding disabled node0 2024-08-15T16:40:41.951328Z [initload] [node/mempool_persist.cpp:73] [LoadMempool] Loading 0 mempool transactions from file... node0 2024-08-15T16:40:41.951358Z [initload] [node/mempool_persist.cpp:145] [LoadMempool] Imported mempool transactions from file: 0 succeeded, 0 failed, 0 expired, 0 already there, 0 waiting for initial broadcast node0 2024-08-15T16:40:41.951363Z [initload] [util/thread.cpp:22] [TraceThread] initload thread exit node0 2024-08-15T16:40:41.951370Z [addcon] [util/thread.cpp:20] [TraceThread] addcon thread start node0 2024-08-15T16:40:41.951420Z [msghand] [util/thread.cpp:20] [TraceThread] msghand thread start node0 2024-08-15T16:40:41.951435Z [init] [noui.cpp:57] [noui_InitMessage] init message: Done loading node0 2024-08-15T16:40:41.951477Z [net] [util/thread.cpp:20] [TraceThread] net thread start node0 2024-08-15T16:41:26.951563Z [scheduler] [net.cpp:2365] [StartExtraBlockRelayPeers] [net] enabling extra block-relay-only peers test 2024-08-15T16:41:41.824000Z TestFramework (ERROR): Assertion failed Traceback (most recent call last): File "/home/gloria/bitcoin/test/functional/test_framework/test_node.py", line 652, in assert_start_raises_init_error ret = self.process.wait(timeout=self.rpc_timeout) File "/usr/lib/python3.10/subprocess.py", line 1209, in wait return self._wait(timeout=timeout) File "/usr/lib/python3.10/subprocess.py", line 1951, in _wait raise TimeoutExpired(self.args, timeout) subprocess.TimeoutExpired: Command '['/home/gloria/bitcoin/src/bitcoind', '-datadir=/tmp/bitcoin_func_test__c38k83u/node0', '-logtimemicros', '-debug', '-debugexclude=libevent', '-debugexclude=leveldb', '-debugexclude=rand', '-uacomment=testnode0', '-disablewallet', '-logthreadnames', '-logsourcelocations', '-loglevel=trace', '-v2transport=0', '-blocksxor=0']' timed out after 60 seconds During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/home/gloria/bitcoin/test/functional/test_framework/test_framework.py", line 132, in main self.run_test() File "/home/gloria/bitcoin/test/functional/feature_blocksxor.py", line 52, in run_test node.assert_start_raises_init_error(['-blocksxor=0'], File "/home/gloria/bitcoin/test/functional/test_framework/test_node.py", line 682, in assert_start_raises_init_error self._raise_assertion_error(assert_msg) File "/home/gloria/bitcoin/test/functional/test_framework/test_node.py", line 192, in _raise_assertion_error raise AssertionError(self._node_msg(msg)) AssertionError: [node 0] bitcoind should have exited within 60s with expected error The blocksdir XOR-key can not be disabled when a random key was already stored! test 2024-08-15T16:41:41.824000Z TestFramework (DEBUG): Closing down network thread test 2024-08-15T16:41:41.875000Z TestFramework (INFO): Stopping nodes test 2024-08-15T16:41:41.875000Z TestFramework (WARNING): Not cleaning up dir /tmp/bitcoin_func_test__c38k83u test 2024-08-15T16:41:41.875000Z TestFramework (ERROR): Test failed. Test logging available at /tmp/bitcoin_func_test__c38k83u/test_framework.log test 2024-08-15T16:41:41.875000Z TestFramework (ERROR): test 2024-08-15T16:41:41.875000Z TestFramework (ERROR): Hint: Call /home/gloria/bitcoin/test/functional/combine_logs.py '/tmp/bitcoin_func_test__c38k83u' to consolidate all logs test 2024-08-15T16:41:41.875000Z TestFramework (ERROR): test 2024-08-15T16:41:41.875000Z TestFramework (ERROR): If this failure happened unexpectedly or intermittently, please file a bug and provide a link or upload of the combined log. test 2024-08-15T16:41:41.875000Z TestFramework (ERROR): https://github.com/bitcoin/bitcoin/issues test 2024-08-15T16:41:41.875000Z TestFramework (ERROR):