Intermittent failure in rpc_gettxspendingprevout.py, line 98, assert_equal(node0.gettxspendingprevout([..]), [..]), JSONRPCException: No spending tx for the outpoint :0 in mempool, and txospenderindex is unavailable #34735

issue maflcko opened this issue on March 4, 2026
  1. maflcko commented at 8:14 PM on March 4, 2026: member
    test  2026-03-04T09:42:14.819801Z TestFramework (INFO): Find transactions spending outputs 
     node0 2026-03-04T09:42:14.820045Z [http] [httpserver.cpp:232] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:49896 
     node0 2026-03-04T09:42:14.820093Z [http_pool_1] [rpc/request.cpp:243] [parse] [rpc] ThreadRPCServer method=gettxspendingprevout user=__cookie__ 
     node1 2026-03-04T09:42:14.820445Z [http] [httpserver.cpp:232] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:54094 
     node1 2026-03-04T09:42:14.820506Z [http_pool_0] [rpc/request.cpp:243] [parse] [rpc] ThreadRPCServer method=gettxspendingprevout user=__cookie__ 
     node2 2026-03-04T09:42:14.820866Z [http] [httpserver.cpp:232] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:54088 
     node2 2026-03-04T09:42:14.820930Z [http_pool_0] [rpc/request.cpp:243] [parse] [rpc] ThreadRPCServer method=gettxspendingprevout user=__cookie__ 
     test  2026-03-04T09:42:14.821144Z TestFramework (INFO): Find transaction spending multiple outputs 
     node0 2026-03-04T09:42:14.821360Z [http] [httpserver.cpp:232] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:49896 
     node0 2026-03-04T09:42:14.821407Z [http_pool_0] [rpc/request.cpp:243] [parse] [rpc] ThreadRPCServer method=gettxspendingprevout user=__cookie__ 
     test  2026-03-04T09:42:14.821596Z TestFramework (INFO): Find no transaction when output is unspent 
     node0 2026-03-04T09:42:14.821776Z [http] [httpserver.cpp:232] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:49896 
     node0 2026-03-04T09:42:14.821811Z [http_pool_1] [rpc/request.cpp:243] [parse] [rpc] ThreadRPCServer method=gettxspendingprevout user=__cookie__ 
     test  2026-03-04T09:42:14.822031Z TestFramework (ERROR): Unexpected exception: 
                                       Traceback (most recent call last):
                                         File "/home/runner/work/_temp/test/functional/test_framework/test_framework.py", line 142, in main
                                           self.run_test()
                                           ~~~~~~~~~~~~~^^
                                         File "/home/runner/work/_temp/build/test/functional/rpc_gettxspendingprevout.py", line 98, in run_test
                                           assert_equal(node0.gettxspendingprevout([prevout(txidH, vout=0)]), [unspent_out(txidH, vout=0)])
                                                        ~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^
                                         File "/home/runner/work/_temp/test/functional/test_framework/coverage.py", line 50, in __call__
                                           return_val = self.auth_service_proxy_instance.__call__(*args, **kwargs)
                                         File "/home/runner/work/_temp/test/functional/test_framework/authproxy.py", line 152, in __call__
                                           raise JSONRPCException(response['error'], status)
                                       test_framework.authproxy.JSONRPCException: {'code': -1, 'message': 'No spending tx for the outpoint 1cdcfcb69bd749b9440fe8ad038024c4779e8315c533ad9a1604189776771124:0 in mempool, and txospenderindex is unavailable.'} [http_status=200]
     test  2026-03-04T09:42:14.824301Z TestFramework (DEBUG): Closing down network thread 
     node0 2026-03-04T09:42:14.832250Z [msghand] [net.cpp:4076] [PushMessage] [net] sending inv (73 bytes) peer=0 
     node1 2026-03-04T09:42:14.832392Z [msghand] [net_processing.cpp:3582] [ProcessMessage] [net] received: inv (73 bytes) peer=0 
     node1 2026-03-04T09:42:14.832428Z [msghand] [net_processing.cpp:4178] [ProcessMessage] [net] got inv: wtx f1a26c5103ff7a7050ad019fe36cfabe84f0f8731d7e8aa9c44128338e7d409b  new peer=0 
     node1 2026-03-04T09:42:14.832439Z [msghand] [net_processing.cpp:4178] [ProcessMessage] [net] got inv: wtx 6732b4eae65e985118d8764b9f3045ebc8b51421dd2b25d82ddfce2b94490bec  new peer=0 
     node1 2026-03-04T09:42:14.832456Z [msghand] [node/txdownloadman_impl.cpp:275] [GetRequestsToSend] [net] Requesting wtx f1a26c5103ff7a7050ad019fe36cfabe84f0f8731d7e8aa9c44128338e7d409b peer=0 
     node1 2026-03-04T09:42:14.832462Z [msghand] [node/txdownloadman_impl.cpp:275] [GetRequestsToSend] [net] Requesting wtx 6732b4eae65e985118d8764b9f3045ebc8b51421dd2b25d82ddfce2b94490bec peer=0 
     node1 2026-03-04T09:42:14.832467Z [msghand] [net.cpp:4076] [PushMessage] [net] sending getdata (73 bytes) peer=0 
     node0 2026-03-04T09:42:14.832545Z [msghand] [net_processing.cpp:3582] [ProcessMessage] [net] received: getdata (73 bytes) peer=0 
     node0 2026-03-04T09:42:14.832557Z [msghand] [net_processing.cpp:4225] [ProcessMessage] [net] received getdata (2 invsz) peer=0 
     node0 2026-03-04T09:42:14.832565Z [msghand] [net_processing.cpp:4228] [ProcessMessage] [net] received getdata for: wtx f1a26c5103ff7a7050ad019fe36cfabe84f0f8731d7e8aa9c44128338e7d409b peer=0 
     node0 2026-03-04T09:42:14.832573Z [msghand] [net.cpp:4076] [PushMessage] [net] sending tx (133 bytes) peer=0 
     node0 2026-03-04T09:42:14.832599Z [msghand] [txmempool.cpp:789] [RemoveUnbroadcastTx] [mempool] Removed 36890766ac6c5223cb40ab63657304ca800acb46df7e7338b865fb1ae00c4c57 from set of unbroadcast txns 
     node0 2026-03-04T09:42:14.832619Z [msghand] [net.cpp:4076] [PushMessage] [net] sending tx (211 bytes) peer=0 
     node1 2026-03-04T09:42:14.832631Z [msghand] [net_processing.cpp:3582] [ProcessMessage] [net] received: tx (133 bytes) peer=0 
     node0 2026-03-04T09:42:14.832638Z [msghand] [txmempool.cpp:789] [RemoveUnbroadcastTx] [mempool] Removed 1cdcfcb69bd749b9440fe8ad038024c4779e8315c533ad9a1604189776771124 from set of unbroadcast txns 
     node1 2026-03-04T09:42:14.832946Z [msghand] [validationinterface.cpp:203] [TransactionAddedToMempool] [validation] Enqueuing TransactionAddedToMempool: txid=36890766ac6c5223cb40ab63657304ca800acb46df7e7338b865fb1ae00c4c57 wtxid=f1a26c5103ff7a7050ad019fe36cfabe84f0f8731d7e8aa9c44128338e7d409b 
     node1 2026-03-04T09:42:14.832959Z [msghand] [txmempool.cpp:441] [check] [mempool] Checking mempool with 7 transactions and 7 inputs 
     node1 2026-03-04T09:42:14.832999Z [msghand] [net_processing.cpp:3157] [ProcessValidTx] [mempool] AcceptToMemoryPool: peer=0: accepted 36890766ac6c5223cb40ab63657304ca800acb46df7e7338b865fb1ae00c4c57 (wtxid=f1a26c5103ff7a7050ad019fe36cfabe84f0f8731d7e8aa9c44128338e7d409b) (poolsz 7 txn, 5 kB) 
     node1 2026-03-04T09:42:14.833016Z [msghand] [net.cpp:4076] [PushMessage] [net] sending inv (37 bytes) peer=1 
     node1 2026-03-04T09:42:14.833064Z [msghand] [net_processing.cpp:3582] [ProcessMessage] [net] received: tx (211 bytes) peer=0 
     node2 2026-03-04T09:42:14.833117Z [msghand] [net_processing.cpp:3582] [ProcessMessage] [net] received: inv (37 bytes) peer=0 
     node2 2026-03-04T09:42:14.833152Z [msghand] [net_processing.cpp:4178] [ProcessMessage] [net] got inv: wtx f1a26c5103ff7a7050ad019fe36cfabe84f0f8731d7e8aa9c44128338e7d409b  new peer=0 
     node2 2026-03-04T09:42:14.833167Z [msghand] [node/txdownloadman_impl.cpp:275] [GetRequestsToSend] [net] Requesting wtx f1a26c5103ff7a7050ad019fe36cfabe84f0f8731d7e8aa9c44128338e7d409b peer=0 
     node2 2026-03-04T09:42:14.833173Z [msghand] [net.cpp:4076] [PushMessage] [net] sending getdata (37 bytes) peer=0 
     node1 2026-03-04T09:42:14.833521Z [msghand] [validationinterface.cpp:203] [TransactionAddedToMempool] [validation] Enqueuing TransactionAddedToMempool: txid=1cdcfcb69bd749b9440fe8ad038024c4779e8315c533ad9a1604189776771124 wtxid=6732b4eae65e985118d8764b9f3045ebc8b51421dd2b25d82ddfce2b94490bec 
     node1 2026-03-04T09:42:14.833529Z [msghand] [txmempool.cpp:441] [check] [mempool] Checking mempool with 8 transactions and 9 inputs 
     node1 2026-03-04T09:42:14.833566Z [msghand] [net_processing.cpp:3157] [ProcessValidTx] [mempool] AcceptToMemoryPool: peer=0: accepted 1cdcfcb69bd749b9440fe8ad038024c4779e8315c533ad9a1604189776771124 (wtxid=6732b4eae65e985118d8764b9f3045ebc8b51421dd2b25d82ddfce2b94490bec) (poolsz 8 txn, 6 kB) 
     node1 2026-03-04T09:42:14.833587Z [msghand] [net_processing.cpp:3582] [ProcessMessage] [net] received: getdata (37 bytes) peer=1 
     node1 2026-03-04T09:42:14.833593Z [msghand] [net_processing.cpp:4225] [ProcessMessage] [net] received getdata (1 invsz) peer=1 
     node1 2026-03-04T09:42:14.833599Z [msghand] [net_processing.cpp:4228] [ProcessMessage] [net] received getdata for: wtx f1a26c5103ff7a7050ad019fe36cfabe84f0f8731d7e8aa9c44128338e7d409b peer=1 
     node1 2026-03-04T09:42:14.833605Z [msghand] [net.cpp:4076] [PushMessage] [net] sending tx (133 bytes) peer=1 
     node1 2026-03-04T09:42:14.833640Z [msghand] [net.cpp:4076] [PushMessage] [net] sending inv (37 bytes) peer=1 
     node2 2026-03-04T09:42:14.833665Z [msghand] [net_processing.cpp:3582] [ProcessMessage] [net] received: tx (133 bytes) peer=0 
     node2 2026-03-04T09:42:14.833954Z [msghand] [validationinterface.cpp:203] [TransactionAddedToMempool] [validation] Enqueuing TransactionAddedToMempool: txid=36890766ac6c5223cb40ab63657304ca800acb46df7e7338b865fb1ae00c4c57 wtxid=f1a26c5103ff7a7050ad019fe36cfabe84f0f8731d7e8aa9c44128338e7d409b 
     node2 2026-03-04T09:42:14.833965Z [msghand] [txmempool.cpp:441] [check] [mempool] Checking mempool with 7 transactions and 7 inputs 
     node2 2026-03-04T09:42:14.834002Z [msghand] [net_processing.cpp:3157] [ProcessValidTx] [mempool] AcceptToMemoryPool: peer=0: accepted 36890766ac6c5223cb40ab63657304ca800acb46df7e7338b865fb1ae00c4c57 (wtxid=f1a26c5103ff7a7050ad019fe36cfabe84f0f8731d7e8aa9c44128338e7d409b) (poolsz 7 txn, 5 kB) 
     node2 2026-03-04T09:42:14.834013Z [msghand] [net_processing.cpp:3582] [ProcessMessage] [net] received: inv (37 bytes) peer=0 
     node2 2026-03-04T09:42:14.834024Z [msghand] [net_processing.cpp:4178] [ProcessMessage] [net] got inv: wtx 6732b4eae65e985118d8764b9f3045ebc8b51421dd2b25d82ddfce2b94490bec  new peer=0 
     node2 2026-03-04T09:42:14.834032Z [msghand] [node/txdownloadman_impl.cpp:275] [GetRequestsToSend] [net] Requesting wtx 6732b4eae65e985118d8764b9f3045ebc8b51421dd2b25d82ddfce2b94490bec peer=0 
     node2 2026-03-04T09:42:14.834036Z [msghand] [net.cpp:4076] [PushMessage] [net] sending getdata (37 bytes) peer=0 
     node1 2026-03-04T09:42:14.834111Z [msghand] [net_processing.cpp:3582] [ProcessMessage] [net] received: getdata (37 bytes) peer=1 
     node1 2026-03-04T09:42:14.834123Z [msghand] [net_processing.cpp:4225] [ProcessMessage] [net] received getdata (1 invsz) peer=1 
     node1 2026-03-04T09:42:14.834128Z [msghand] [net_processing.cpp:4228] [ProcessMessage] [net] received getdata for: wtx 6732b4eae65e985118d8764b9f3045ebc8b51421dd2b25d82ddfce2b94490bec peer=1 
     node1 2026-03-04T09:42:14.834135Z [msghand] [net.cpp:4076] [PushMessage] [net] sending tx (211 bytes) peer=1 
     node2 2026-03-04T09:42:14.834193Z [msghand] [net_processing.cpp:3582] [ProcessMessage] [net] received: tx (211 bytes) peer=0 
     node2 2026-03-04T09:42:14.834666Z [msghand] [validationinterface.cpp:203] [TransactionAddedToMempool] [validation] Enqueuing TransactionAddedToMempool: txid=1cdcfcb69bd749b9440fe8ad038024c4779e8315c533ad9a1604189776771124 wtxid=6732b4eae65e985118d8764b9f3045ebc8b51421dd2b25d82ddfce2b94490bec 
     node2 2026-03-04T09:42:14.834676Z [msghand] [txmempool.cpp:441] [check] [mempool] Checking mempool with 8 transactions and 9 inputs 
     node2 2026-03-04T09:42:14.834715Z [msghand] [net_processing.cpp:3157] [ProcessValidTx] [mempool] AcceptToMemoryPool: peer=0: accepted 1cdcfcb69bd749b9440fe8ad038024c4779e8315c533ad9a1604189776771124 (wtxid=6732b4eae65e985118d8764b9f3045ebc8b51421dd2b25d82ddfce2b94490bec) (poolsz 8 txn, 6 kB) 
     node1 2026-03-04T09:42:14.861988Z [scheduler] [validationinterface.cpp:203] [operator()] [validation] TransactionAddedToMempool: txid=36890766ac6c5223cb40ab63657304ca800acb46df7e7338b865fb1ae00c4c57 wtxid=f1a26c5103ff7a7050ad019fe36cfabe84f0f8731d7e8aa9c44128338e7d409b 
     test  2026-03-04T09:42:14.874610Z TestFramework (INFO): Not stopping nodes as test failed. The dangling processes will be cleaned up later. 
    

    Probably a missing sync ... ?

  2. maflcko added the label CI failed on Mar 4, 2026
  3. fanquake added this to the milestone 31.0 on Mar 4, 2026
  4. fjahr commented at 4:52 PM on March 5, 2026: contributor

    @maflcko do you have the link to the failed run? I would like to see if it's the same Windows runner that where we saw the unit test issues.

  5. achow101 commented at 6:48 PM on March 5, 2026: member

    Probably a missing sync ... ?

    I don't think it is. There's an earlier check that each transaction is in node0's mempool.

    Edit: I think it's a race with the txospender index syncing

  6. furszy commented at 7:30 PM on March 5, 2026: member

    Edit: I think it's a race with the txospender index syncing

    Yes.

  7. fanquake closed this on Mar 6, 2026

  8. fanquake referenced this in commit d97df29d5d on Mar 6, 2026

github-metadata-mirror

This is a metadata mirror of the GitHub repository bitcoin/bitcoin. This site is not affiliated with GitHub. Content is generated from a GitHub metadata backup.
generated: 2026-04-24 09:12 UTC

This site is hosted by @0xB10C
More mirrored repositories can be found on mirror.b10c.me