2022-11-14 14:43:26 Nexa version v1.0.2.0-eaad8dc (debug build) (2022-10-26 18:16:05 +0000)
2022-11-14 14:43:26 Command line: /builds/dagurval/rostrum/nexa/build/src/nexad -datadir=/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0 -rest -mocktime=0 -electrum=1 -debug=electrum -debug=rpc -electrum.rawarg=--cashaccount-activation-height=1 -electrum.rawarg=--wait-duration-secs=1 -electrum.rawarg=--scripthash-subscription-limit=5 -electrum.rawarg=--scripthash-alias-bytes-limit=112 -electrum.rawarg=--rpc-max-connections=5
2022-11-14 14:43:26 Single entry arguments:
2022-11-14 14:43:26 -bindallorfail='1'
2022-11-14 14:43:26 -datadir='/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0'
2022-11-14 14:43:26 -debug='rpc'
2022-11-14 14:43:26 -discover='0'
2022-11-14 14:43:26 -electrum='1'
2022-11-14 14:43:26 -electrum.exec='/builds/dagurval/rostrum/target/x86_64-unknown-linux-gnu/release/rostrum'
2022-11-14 14:43:26 -electrum.monitoring.port='27771'
2022-11-14 14:43:26 -electrum.port='17771'
2022-11-14 14:43:26 -electrum.rawarg='--rpc-max-connections=5'
2022-11-14 14:43:26 -electrum.ws.port='22771'
2022-11-14 14:43:26 -listenonion='0'
2022-11-14 14:43:26 -mocktime='0'
2022-11-14 14:43:26 -port='7771'
2022-11-14 14:43:26 -regtest='1'
2022-11-14 14:43:26 -relay.limitFreeRelay='15'
2022-11-14 14:43:26 -relay.minRelayTxFee='0'
2022-11-14 14:43:26 -rest=''
2022-11-14 14:43:26 -rpcallowip='127.0.0.1'
2022-11-14 14:43:26 -rpcbind='127.0.0.1'
2022-11-14 14:43:26 -rpcpassword='xxxxxxxx'
2022-11-14 14:43:26 -rpcport='12771'
2022-11-14 14:43:26 -rpcuser='xxxxxxxx'
2022-11-14 14:43:26 -server='1'
2022-11-14 14:43:26 -usecashaddr='1'
2022-11-14 14:43:26
2022-11-14 14:43:26 Multiple entry arguments:
2022-11-14 14:43:26 -debug = ['electrum', 'rpc']
2022-11-14 14:43:26 -electrum.rawarg = ['--cashaccount-activation-height=1', '--wait-duration-secs=1', '--scripthash-subscription-limit=5', '--scripthash-alias-bytes-limit=112', '--rpc-max-connections=5']
2022-11-14 14:43:26
2022-11-14 14:43:26 InitParameterInteraction: parameter interaction: -whitelistforcerelay=1 -> setting -whitelistrelay=1
2022-11-14 14:43:26 Using RdRand as an additional entropy source
2022-11-14 14:43:26 Using the 'sse4(1way+4way),avx2(8way)' SHA256 implementation
2022-11-14 14:43:26 Using BerkeleyDB version Berkeley DB 5.3.28: (September 9, 2013)
2022-11-14 14:43:26 Default data directory /root/.nexa
2022-11-14 14:43:26 Using data directory /builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest
2022-11-14 14:43:26 Using config file /builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/nexa.conf
2022-11-14 14:43:26 Using at most 125 connections
2022-11-14 14:43:26 No deployment configuration found at '/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/forks.csv' - using defaults
2022-11-14 14:43:26 Using 8 message handler threads
2022-11-14 14:43:26 Using 8 transaction admission threads
2022-11-14 14:43:26 Using 32 MiB out of 32 requested for signature cache, able to store 1048576 elements
2022-11-14 14:43:26 Launching 4 ScriptQueues each using 16 threads for script verification
2022-11-14 14:43:26 HTTP: creating work queue of depth 16
2022-11-14 14:43:26 Starting RPC
2022-11-14 14:43:26 Starting HTTP RPC server
2022-11-14 14:43:26 Config options rpcuser and rpcpassword will soon be deprecated. Locally-run instances may remove rpcuser to use cookie-based auth, or may be replaced with rpcauth. Please see share/rpcuser for rpcauth auth generation.
2022-11-14 14:43:26 HTTP: starting 4 worker threads
2022-11-14 14:43:26 Electrum: spawning /builds/dagurval/rostrum/target/x86_64-unknown-linux-gnu/release/rostrum -vvvv --daemon-rpc-addr=127.0.0.1:12771 --electrum-rpc-addr=0.0.0.0:17771 --electrum-ws-addr=0.0.0.0:22771 --daemon-dir=/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0 --db-dir=/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/rostrum --network=regtest --monitoring-addr=127.0.0.1:27771 --cookie=rpcuser💻0:rpcpass🔑0 --cashaccount-activation-height=1 --wait-duration-secs=1 --scripthash-subscription-limit=5 --scripthash-alias-bytes-limit=112 --rpc-max-connections=5
2022-11-14 14:43:26 Electrum: Starting server
2022-11-14 14:43:26 Electrum: WARNING: cookie option is deprecated and will be removed in the future!
2022-11-14 14:43:26 Electrum:
2022-11-14 14:43:26 Electrum: You most likely want to use cookie_file instead.
2022-11-14 14:43:26 Electrum: If you really don't want to use cookie_file for a good reason and knowing the consequences use the auth option
2022-11-14 14:43:26 Electrum: See authentication section in electrs usage documentation for more details.
2022-11-14 14:43:26 Electrum: https://github.com/romanz/electrs/blob/master/doc/usage.md#configuration-files-and-priorities
2022-11-14 14:43:26 Electrum: Running rostrum for Nexa
2022-11-14 14:43:26 Electrum: Config { log: StdErrLog { verbosity: Trace, quiet: false, show_level: true, timestamp: Off, modules: [], writer: "stderr", color_choice: Never, show_module_names: false }, network_type: Regtest, db_path: "/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/rostrum/regtest", daemon_dir: "/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest", daemon_rpc_addr: 127.0.0.1:12771, electrum_rpc_addr: 0.0.0.0:17771, electrum_ws_addr: 0.0.0.0:22771, monitoring_addr: 127.0.0.1:27771, index_batch_size: 100, tx_cache_size: 262144000, server_banner: "Welcome to Rostrum 6.0.0 (Electrum Rust Server)!", blocktxids_cache_size: 52428800, rpc_timeout: 10, low_memory: false, cashaccount_activation_height: 1, rpc_buffer_size: 2000, scripthash_subscription_limit: 5, scripthash_alias_bytes_limit: 112, rpc_max_connections: 5, rpc_max_connections_shared_prefix: 500 }
2022-11-14 14:43:26 Electrum: INFO - serving Prometheus metrics on 127.0.0.1:27771
2022-11-14 14:43:26 Electrum: DEBUG - Server listening on 127.0.0.1:27771
2022-11-14 14:43:26 ThreadRPCServer method=getnetworkinfo
2022-11-14 14:43:26 Electrum: DEBUG - Running accept thread
2022-11-14 14:43:26 Electrum: WARN - reconnecting to bitcoind: {"code":-28,"message":"RPC server started"}
2022-11-14 14:43:26 ThreadRPCServer method=getblockcount
2022-11-14 14:43:26 ThreadRPCServer method=getblockcount
2022-11-14 14:43:27 ThreadRPCServer method=getblockcount
2022-11-14 14:43:27 ThreadRPCServer method=getblockcount
2022-11-14 14:43:27 Using wallet wallet.dat
2022-11-14 14:43:27 init message: Verifying wallet...
2022-11-14 14:43:27 CDBEnv::Open: LogDir=/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/database ErrorFile=/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/db.log
2022-11-14 14:43:27 Cache configuration:
2022-11-14 14:43:27 * Using 0.0MiB for block database
2022-11-14 14:43:27 * Using 0.0MiB for block undo database
2022-11-14 14:43:27 * Using 2.0MiB for block index database
2022-11-14 14:43:27 * Using 0.0MiB for txindex database
2022-11-14 14:43:27 * Using 1982.2MiB for chain state database
2022-11-14 14:43:27 * Using 13811.8MiB for in-memory UTXO set
2022-11-14 14:43:27 init message: Opening Block database...
2022-11-14 14:43:27 LevelDB using max_open_files=1000 (default=1000)
2022-11-14 14:43:27 Opening LevelDB in /builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/blocks/index
2022-11-14 14:43:27 ThreadRPCServer method=getnetworkinfo
2022-11-14 14:43:27 Electrum: WARN - reconnecting to bitcoind: {"code":-28,"message":"Opening Block database..."}
2022-11-14 14:43:27 Opened LevelDB successfully
2022-11-14 14:43:27 Using obfuscation key for /builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/blocks/index: 0000000000000000
2022-11-14 14:43:27 init message: Opening UTXO database...
2022-11-14 14:43:27 LevelDB using max_open_files=1000 (default=1000)
2022-11-14 14:43:27 Opening LevelDB in /builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/chainstate
2022-11-14 14:43:27 Opened LevelDB successfully
2022-11-14 14:43:27 Wrote new obfuscate key for /builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/chainstate: f3f82a5d8b6bfb30
2022-11-14 14:43:27 Using obfuscation key for /builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/chainstate: f3f82a5d8b6bfb30
2022-11-14 14:43:27 init message: Opening Coins Cache database...
2022-11-14 14:43:27 init message: Loading block index...
2022-11-14 14:43:27 Checking all blk files are present...
2022-11-14 14:43:27 LoadBlockIndexDB: last block file = 0
2022-11-14 14:43:27 LoadBlockIndexDB: last block file info: CBlockFileInfo(blocks=0, size=0, heights=0...0, time=1970-01-01...1970-01-01)
2022-11-14 14:43:27 Initializing databases...
2022-11-14 14:43:27 UpdateTip: new best=d71ee431e307d12dfef31a6b21e071f1d5652c0eb6155c04e3222612c9d0b371 height=0 bits=545259519 log2_work=1 tx=1 date=2021-07-14 15:13:43 progress=1.000000 cache=0.0MiB(0txo)
2022-11-14 14:43:27 init message: Verifying blocks...
2022-11-14 14:43:27 block index 91ms
2022-11-14 14:43:27 init message: Loading wallet...
2022-11-14 14:43:27 nFileVersion = 1000200
2022-11-14 14:43:27 Keys: 0 plaintext, 0 encrypted, 0 w/ metadata, 0 total
2022-11-14 14:43:27 Performing wallet upgrade to 60000
2022-11-14 14:43:27 ThreadRPCServer method=getblockcount
2022-11-14 14:43:27 ThreadRPCServer method=getblockcount
2022-11-14 14:43:28 ThreadRPCServer method=getblockcount
2022-11-14 14:43:28 ThreadRPCServer method=getblockcount
2022-11-14 14:43:28 ThreadRPCServer method=getnetworkinfo
2022-11-14 14:43:28 Electrum: WARN - reconnecting to bitcoind: {"code":-28,"message":"Loading wallet..."}
2022-11-14 14:43:28 ThreadRPCServer method=getblockcount
2022-11-14 14:43:28 ThreadRPCServer method=getblockcount
2022-11-14 14:43:29 ThreadRPCServer method=getblockcount
2022-11-14 14:43:29 ThreadRPCServer method=getblockcount
2022-11-14 14:43:29 ThreadRPCServer method=getnetworkinfo
2022-11-14 14:43:29 Electrum: WARN - reconnecting to bitcoind: {"code":-28,"message":"Loading wallet..."}
2022-11-14 14:43:29 ThreadRPCServer method=getblockcount
2022-11-14 14:43:29 wallet 2279ms
2022-11-14 14:43:29 Bound to [::]:7771
2022-11-14 14:43:29 Bound to 0.0.0.0:7771
2022-11-14 14:43:29 init message: Waiting for Genesis Block...
2022-11-14 14:43:29 mapBlockIndex.size() = 1
2022-11-14 14:43:29 nBestHeight = 0
2022-11-14 14:43:29 setKeyPool.size() = 99
2022-11-14 14:43:29 mapWallet.size() = 0
2022-11-14 14:43:29 mapAddressBook.size() = 1
2022-11-14 14:43:29 init message: Loading addresses...
2022-11-14 14:43:29 ERROR: Read: Failed to open file /builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/peers.dat
2022-11-14 14:43:29 Invalid or missing peers.dat; recreating
2022-11-14 14:43:29 init message: Loading banlist...
2022-11-14 14:43:29 ERROR: Read: Failed to open file /builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/banlist.dat
2022-11-14 14:43:29 Invalid or missing banlist.dat; recreating
2022-11-14 14:43:29 Using default DNS seeds.
2022-11-14 14:43:29 Loading addresses from DNS seeds (could take a while)
2022-11-14 14:43:29 0 addresses found from DNS seeds
2022-11-14 14:43:29 Bitnodes API seeding disabled
2022-11-14 14:43:29 ThreadRPCServer method=getblockcount
2022-11-14 14:43:30 ThreadRPCServer method=getblockcount
2022-11-14 14:43:30 Nothing to do. Already on the correct chain.
2022-11-14 14:43:30 init message: Reaccepting Wallet Transactions
2022-11-14 14:43:30 init message: Loading TxPool
2022-11-14 14:43:30 Failed to open txpool file from disk. Continuing anyway.
2022-11-14 14:43:30 init message: Loading Orphanpool
2022-11-14 14:43:30 Failed to open orphanpool file from disk. Continuing anyway.
2022-11-14 14:43:30 init message: Activating best chain...
2022-11-14 14:43:30 Nothing to do. Already on the correct chain.
2022-11-14 14:43:30 Failed to open msgpool file from disk. Continuing anyway.
2022-11-14 14:43:30 init message: Done loading
2022-11-14 14:43:30 ThreadRPCServer method=getblockcount
2022-11-14 14:43:30 ThreadRPCServer method=generate
2022-11-14 14:43:30 CreateNewBlock: total size 1197 txs: 0 of 0 fees: 0 sigops 100
2022-11-14 14:43:30 UpdateTip: new best=08254c76d6fb865a75311abd67ee94b6a88616c68259acdc4d61dd427490bd5d height=1 bits=545259519 log2_work=2 tx=2 date=2022-11-14 14:43:30 progress=1.000000 cache=0.0MiB(1txo)
2022-11-14 14:43:30 Electrum: TRACE - notified via SIG10
2022-11-14 14:43:30 ThreadRPCServer method=getnetworkinfo
2022-11-14 14:43:30 Electrum: INFO - NetworkInfo { version: 1000200, subversion: "/Nexa:1.0.2(64bit)/", relayfee: 0.0 }
2022-11-14 14:43:30 ThreadRPCServer method=getblockchaininfo
2022-11-14 14:43:30 Electrum: INFO - BlockchainInfo { chain: "regtest", blocks: 1, headers: 1, verificationprogress: 1.0, bestblockhash: "08254c76d6fb865a75311abd67ee94b6a88616c68259acdc4d61dd427490bd5d", pruned: false, initialblockdownload: false }
2022-11-14 14:43:30 ThreadRPCServer method=getblockchaininfo
2022-11-14 14:43:30 Electrum: DEBUG - opening DB at "/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/rostrum/regtest"
2022-11-14 14:43:30 Electrum: TRACE - closing DB at "/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/rostrum/regtest"
2022-11-14 14:43:35 Electrum: TRACE - done closing db
2022-11-14 14:43:35 Electrum: DEBUG - opening DB at "/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/rostrum/regtest"
2022-11-14 14:43:36 ThreadRPCServer method=getblock
2022-11-14 14:43:36 getblock for height 0 (tip is at 1)
2022-11-14 14:43:36 Electrum: INFO - Latest indexed blockhash: 0000000000000000000000000000000000000000000000000000000000000000
2022-11-14 14:43:36 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:36 ThreadRPCServer method=getblockheader
2022-11-14 14:43:36 ThreadRPCServer method=getblockheader
2022-11-14 14:43:36 Electrum: TRACE - downloading 2 block headers
2022-11-14 14:43:36 ThreadRPCServer method=getblockhash
2022-11-14 14:43:36 ThreadRPCServer method=getblockhash
2022-11-14 14:43:36 ThreadRPCServer method=getblockheader
2022-11-14 14:43:36 ThreadRPCServer method=getblockheader
2022-11-14 14:43:36 Electrum: INFO - Chain: Undoing block d71ee431e307d12dfef31a6b21e071f1d5652c0eb6155c04e3222612c9d0b371 (height 0)
2022-11-14 14:43:36 ThreadRPCServer method=getblock
2022-11-14 14:43:36 Electrum: INFO - chain updated: tip=08254c76d6fb865a75311abd67ee94b6a88616c68259acdc4d61dd427490bd5d, height=1
2022-11-14 14:43:36 Electrum: TRACE - notified via SIG10
2022-11-14 14:43:36 ThreadRPCServer method=getblock
2022-11-14 14:43:36 ThreadRPCServer method=getblock
2022-11-14 14:43:36 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:36 Electrum: TRACE - block_on()
2022-11-14 14:43:36 Electrum: TRACE - block_on()
2022-11-14 14:43:36 Electrum: TRACE - block_on: completed
2022-11-14 14:43:36 Electrum: TRACE - block_on
2022-11-14 14:43:36 Electrum: TRACE - add: epoll_fd=22, fd=24, ev=Event { key: 18446744073709551615, readable: false, writable: false }
2022-11-14 14:43:36 Electrum: TRACE - block_on()
2022-11-14 14:43:36 Electrum: TRACE - add: epoll_fd=22, fd=23, ev=Event { key: 18446744073709551615, readable: true, writable: false }
2022-11-14 14:43:36 Electrum: TRACE - new: epoll_fd=22, event_fd=23, timer_fd=Some(24)
2022-11-14 14:43:36 Electrum: TRACE - block_on()
2022-11-14 14:43:36 Electrum: INFO - Starting a WebSocket server on 0.0.0.0:22771
2022-11-14 14:43:36 Electrum: TRACE - WebSocket proxy to 127.0.0.1:17771
2022-11-14 14:43:36 Electrum: TRACE - block_on: waiting on I/O
2022-11-14 14:43:36 Electrum: TRACE - add: epoll_fd=22, fd=25, ev=Event { key: 0, readable: false, writable: false }
2022-11-14 14:43:36 Electrum: TRACE - process_timers: 0 ready wakers
2022-11-14 14:43:36 Electrum: TRACE - Poller::wait(_, None)
2022-11-14 14:43:36 Electrum: INFO - WebSocket initalized
2022-11-14 14:43:36 Electrum: TRACE - wait: epoll_fd=22, timeout=None
2022-11-14 14:43:36 Electrum: TRACE - modify: epoll_fd=22, fd=24, ev=Event { key: 18446744073709551615, readable: true, writable: false }
2022-11-14 14:43:36 Electrum: TRACE - modify: epoll_fd=22, fd=25, ev=Event { key: 0, readable: true, writable: false }
2022-11-14 14:43:36 Electrum: TRACE - block_on: sleep until notification
2022-11-14 14:43:36 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:36 Electrum: TRACE - main_loop: sleeping for 50 us
2022-11-14 14:43:36 Electrum: TRACE - main_loop: notified
2022-11-14 14:43:36 Electrum: TRACE - main_loop: sleeping for 50 us
2022-11-14 14:43:36 Electrum: TRACE - main_loop: sleeping for 75 us
2022-11-14 14:43:36 ThreadRPCServer method=getblockheader
2022-11-14 14:43:36 Electrum: TRACE - main_loop: sleeping for 100 us
2022-11-14 14:43:36 Electrum: TRACE - block_on: sleep until notification
2022-11-14 14:43:36 Electrum: TRACE - block_on()
2022-11-14 14:43:36 Electrum: TRACE - block_on: sleep until notification
2022-11-14 14:43:36 Electrum: TRACE - block_on()
2022-11-14 14:43:36 Electrum: DEBUG - downloading new block headers (1 already indexed) from 08254c76d6fb865a75311abd67ee94b6a88616c68259acdc4d61dd427490bd5d
2022-11-14 14:43:36 Electrum: TRACE - downloaded 0 block headers
2022-11-14 14:43:36 Electrum: TRACE - main_loop: sleeping for 250 us
2022-11-14 14:43:36 Electrum: TRACE - block_on: sleep until notification
2022-11-14 14:43:36 Electrum: TRACE - main_loop: sleeping for 500 us
2022-11-14 14:43:36 Electrum: TRACE - main_loop: sleeping for 750 us
2022-11-14 14:43:36 Electrum: TRACE - main_loop: sleeping for 1000 us
2022-11-14 14:43:36 Electrum: TRACE - main_loop: sleeping for 2500 us
2022-11-14 14:43:36 Electrum: TRACE - main_loop: sleeping for 5000 us
2022-11-14 14:43:36 Electrum: TRACE - main_loop: sleeping for 10000 us
2022-11-14 14:43:36 ThreadRPCServer method=getrawtxpool
2022-11-14 14:43:36 Electrum: INFO - Electrum RPC server running on 0.0.0.0:17771 (protocol 1.4.3)
2022-11-14 14:43:37 Electrum: TRACE - [127.0.0.1:49052] spawned ThreadId(27)
2022-11-14 14:43:37 Electrum: INFO - [127.0.0.1:49052] connected peer ((1, 1) out of (5, 500) connection slots used)
2022-11-14 14:43:37 Electrum: TRACE - [127.0.0.1:49054] spawned ThreadId(29)
2022-11-14 14:43:37 Electrum: INFO - [127.0.0.1:49054] connected peer ((2, 2) out of (5, 500) connection slots used)
2022-11-14 14:43:37 Electrum: TRACE - RPC "{\"id\": 2, \"method\": \"server.version\", \"params\": []}\n"
2022-11-14 14:43:37 Electrum: TRACE - [127.0.0.1:49056] spawned ThreadId(31)
2022-11-14 14:43:37 Electrum: TRACE - [127.0.0.1:49058] spawned ThreadId(32)
2022-11-14 14:43:37 Electrum: TRACE - [127.0.0.1:49060] spawned ThreadId(33)
2022-11-14 14:43:37 Electrum: TRACE - [127.0.0.1:49062] dropping peer - Maximum connection limit of 5 reached.
2022-11-14 14:43:37 Electrum: INFO - [127.0.0.1:49060] connected peer ((5, 5) out of (5, 500) connection slots used)
2022-11-14 14:43:37 Electrum: INFO - [127.0.0.1:49056] connected peer ((3, 3) out of (5, 500) connection slots used)
2022-11-14 14:43:37 Electrum: TRACE - RPC "{\"id\": 2, \"method\": \"server.version\", \"params\": []}\n"
2022-11-14 14:43:37 Electrum: TRACE - RPC "{\"id\": 2, \"method\": \"server.version\", \"params\": []}\n"
2022-11-14 14:43:37 Electrum: INFO - [127.0.0.1:49058] connected peer ((4, 4) out of (5, 500) connection slots used)
2022-11-14 14:43:37 Electrum: TRACE - RPC "{\"id\": 2, \"method\": \"server.version\", \"params\": []}\n"
2022-11-14 14:43:37 Electrum: TRACE - RPC "{\"id\": 2, \"method\": \"server.version\", \"params\": []}\n"
2022-11-14 14:43:37 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:37 ThreadRPCServer method=getrawtxpool
2022-11-14 14:43:38 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:38 ThreadRPCServer method=getrawtxpool
2022-11-14 14:43:39 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:39 ThreadRPCServer method=getrawtxpool
2022-11-14 14:43:40 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:40 ThreadRPCServer method=getrawtxpool
2022-11-14 14:43:41 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:41 ThreadRPCServer method=getrawtxpool
2022-11-14 14:43:42 Electrum: TRACE - [127.0.0.1:49164] dropping peer - Maximum connection limit of 5 reached.
2022-11-14 14:43:42 Electrum: DEBUG - [127.0.0.1:49052] shutting down connection
2022-11-14 14:43:42 Electrum: INFO - [127.0.0.1:49052] disconnected peer ((4, 4) out of (5, 500) connection slots used)
2022-11-14 14:43:42 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:42 ThreadRPCServer method=getrawtxpool
2022-11-14 14:43:43 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:43 ThreadRPCServer method=getrawtxpool
2022-11-14 14:43:44 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:44 ThreadRPCServer method=getrawtxpool
2022-11-14 14:43:45 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:45 ThreadRPCServer method=getrawtxpool
2022-11-14 14:43:46 ThreadRPCServer method=getbestblockhash
2022-11-14 14:43:46 ThreadRPCServer method=getrawtxpool
2022-11-14 14:43:47 ThreadRPCServer method=stop
2022-11-14 14:43:47 Interrupting HTTP RPC server
2022-11-14 14:43:47 Interrupting RPC
2022-11-14 14:43:47 Electrum: WARN - reconnecting to bitcoind: expected 109 bytes, got 12
2022-11-14 14:43:48 Electrum: WARN - failed to connect daemon at 127.0.0.1:12771: Connection refused (os error 111)
2022-11-14 14:43:50 Shutdown: In progress...
2022-11-14 14:43:50 Stopping HTTP RPC server
2022-11-14 14:43:50 Stopping RPC
2022-11-14 14:43:50 RPC stopped.
2022-11-14 14:43:50 StopNode()
2022-11-14 14:43:50 Electrum: Stopping server
2022-11-14 14:43:50 Electrum: TRACE - notified via SIG2
2022-11-14 14:43:50 Electrum: TRACE - stop accepting new RPCs
2022-11-14 14:43:50 Electrum: INFO - closing 5 RPC connections
2022-11-14 14:43:50 Electrum: INFO - waiting for 5 RPC handling threads
2022-11-14 14:43:50 Electrum: TRACE - joining ThreadId(27)
2022-11-14 14:43:50 Electrum: DEBUG - [127.0.0.1:49054] shutting down connection
2022-11-14 14:43:50 Electrum: DEBUG - [127.0.0.1:49056] shutting down connection
2022-11-14 14:43:50 Electrum: TRACE - joining ThreadId(32)
2022-11-14 14:43:50 Electrum: DEBUG - [127.0.0.1:49060] shutting down connection
2022-11-14 14:43:50 Electrum: DEBUG - [127.0.0.1:49058] shutting down connection
2022-11-14 14:43:50 Electrum: ERROR - [127.0.0.1:49056] receiver failed: channel closed
2022-11-14 14:43:50 Electrum: ERROR - [127.0.0.1:49054] receiver failed: channel closed
2022-11-14 14:43:50 Electrum: INFO - [127.0.0.1:49054] disconnected peer ((3, 3) out of (5, 500) connection slots used)
2022-11-14 14:43:50 Electrum: ERROR - [127.0.0.1:49058] receiver failed: channel closed
2022-11-14 14:43:50 Electrum: INFO - [127.0.0.1:49058] disconnected peer ((1, 1) out of (5, 500) connection slots used)
2022-11-14 14:43:50 Electrum: TRACE - joining ThreadId(31)
2022-11-14 14:43:50 Electrum: ERROR - [127.0.0.1:49060] receiver failed: channel closed
2022-11-14 14:43:50 Electrum: INFO - [127.0.0.1:49060] disconnected peer ((0, 0) out of (5, 500) connection slots used)
2022-11-14 14:43:50 Electrum: INFO - [127.0.0.1:49056] disconnected peer ((2, 2) out of (5, 500) connection slots used)
2022-11-14 14:43:50 Electrum: TRACE - joining ThreadId(33)
2022-11-14 14:43:50 Electrum: TRACE - joining ThreadId(29)
2022-11-14 14:43:50 Electrum: INFO - RPC connections are closed
2022-11-14 14:43:50 Electrum: TRACE - RPC server is stopped
2022-11-14 14:43:50 Electrum: TRACE - closing DB at "/builds/dagurval/rostrum/nexa/build/qa/qa_tests/test_electrumdoslimitpy_ndyaysh4/node0/regtest/rostrum/regtest"
2022-11-14 14:43:50 Electrum: TRACE - done closing db
2022-11-14 14:43:51 Electrum: ERROR - server failed: Interrupted by signal 2
2022-11-14 14:43:51 Electrum: Server not running: exited with error, exit status 1, termination signal -1
2022-11-14 14:43:53 Dumped txpool: 5e-05s to copy, 0.326737s to dump
2022-11-14 14:43:53 Dumped orphanpool: 2.6e-05s to copy, 0.491405s to dump
2022-11-14 14:43:53 Dumped msgpool: 2e-05s to copy, 0.217153s to dump
2022-11-14 14:43:54 Shutdown: done
11/14/2022 02:43:54 PM ERROR: Failed
- stderr --------------------------------------------------
File "/builds/dagurval/rostrum/nexa/build/qa/rpc-tests/test_framework/test_framework.py", line 316, in main
self.run_test()
File "/builds/dagurval/rostrum/nexa/build/src/../qa/rpc-tests/electrum_doslimit.py", line 44, in run_test
asyncio.run(async_tests())
File "/usr/local/lib/python3.11/asyncio/runners.py", line 190, in run
return runner.run(main)
^^^^^^^^^^^^^^^^
File "/usr/local/lib/python3.11/asyncio/runners.py", line 118, in run
return self._loop.run_until_complete(task)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/local/lib/python3.11/asyncio/base_events.py", line 650, in run_until_complete
return future.result()
^^^^^^^^^^^^^^^
File "/builds/dagurval/rostrum/nexa/build/src/../qa/rpc-tests/electrum_doslimit.py", line 40, in async_tests
await self.test_connection_limit()
File "/builds/dagurval/rostrum/nexa/build/src/../qa/rpc-tests/electrum_doslimit.py", line 149, in test_connection_limit
await asyncio.wait_for(extra_connection2.call("server.ping"), timeout = 5)
File "/usr/local/lib/python3.11/asyncio/tasks.py", line 492, in wait_for
raise exceptions.TimeoutError() from exc
#########################