qa: Intermittent failure in `p2p_invalid_tx.py` #34621

issue hebasto opened this issue on February 19, 2026
  1. hebasto commented at 1:52 PM on February 19, 2026: member

    https://github.com/bitcoin/bitcoin/actions/runs/22181787708/job/64145682186:

    316/455 - p2p_invalid_tx.py --v2transport failed, Duration: 3 s
    
    stdout:
    2026-02-19T12:56:47.242316Z TestFramework (INFO): PRNG seed is: 6348560005473754043
    
    2026-02-19T12:56:47.276714Z TestFramework (INFO): Initializing test directory D:\a\bitcoin\bitcoin\test_runner_₿_🏃_20260219_124134\p2p_invalid_tx_138
    
    2026-02-19T12:56:47.695785Z TestFramework (INFO): Create a new block with an anyone-can-spend coinbase.
    
    2026-02-19T12:56:47.799348Z TestFramework (INFO): Mature the block.
    
    2026-02-19T12:56:47.976687Z TestFramework (INFO): Testing invalid transaction: OutputMissing
    
    2026-02-19T12:56:48.033913Z TestFramework (INFO): Testing invalid transaction: InputMissing
    
    2026-02-19T12:56:48.086804Z TestFramework (INFO): Testing invalid transaction: SizeTooSmall
    
    2026-02-19T12:56:48.144583Z TestFramework (INFO): Testing invalid transaction: ExtraWitness
    
    2026-02-19T12:56:48.197926Z TestFramework (INFO): Testing invalid transaction: BadInputOutpointIndex
    
    2026-02-19T12:56:48.251347Z TestFramework (INFO): Testing invalid transaction: DuplicateInput
    
    2026-02-19T12:56:48.304591Z TestFramework (INFO): Testing invalid transaction: PrevoutNullInput
    
    2026-02-19T12:56:48.357833Z TestFramework (INFO): Testing invalid transaction: NonexistentInput
    
    2026-02-19T12:56:48.410814Z TestFramework (INFO): Testing invalid transaction: SpendTooMuch
    
    2026-02-19T12:56:48.463890Z TestFramework (INFO): Testing invalid transaction: CreateNegative
    
    2026-02-19T12:56:48.516884Z TestFramework (INFO): Testing invalid transaction: CreateTooLarge
    
    2026-02-19T12:56:48.570317Z TestFramework (INFO): Testing invalid transaction: CreateSumTooLarge
    
    2026-02-19T12:56:48.623911Z TestFramework (INFO): Testing invalid transaction: InvalidOPIFConstruction
    
    2026-02-19T12:56:48.677788Z TestFramework (INFO): Testing invalid transaction: TooManySigopsPerBlock
    
    2026-02-19T12:56:48.787518Z TestFramework (INFO): Testing invalid transaction: TooManySigopsPerTransaction
    
    2026-02-19T12:56:48.851114Z TestFramework (INFO): Testing invalid transaction: NonStandardAndInvalid
    
    2026-02-19T12:56:48.904906Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_CAT
    
    2026-02-19T12:56:48.958373Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_SUBSTR
    
    2026-02-19T12:56:49.011903Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_LEFT
    
    2026-02-19T12:56:49.064977Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_RIGHT
    
    2026-02-19T12:56:49.118325Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_INVERT
    
    2026-02-19T12:56:49.171756Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_AND
    
    2026-02-19T12:56:49.224993Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_OR
    
    2026-02-19T12:56:49.277882Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_XOR
    
    2026-02-19T12:56:49.331221Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_2MUL
    
    2026-02-19T12:56:49.384629Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_2DIV
    
    2026-02-19T12:56:49.437805Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_MUL
    
    2026-02-19T12:56:49.491221Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_DIV
    
    2026-02-19T12:56:49.544034Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_MOD
    
    2026-02-19T12:56:49.596877Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_LSHIFT
    
    2026-02-19T12:56:49.649868Z TestFramework (INFO): Testing invalid transaction: DisabledOpcode_OP_RSHIFT
    
    2026-02-19T12:56:49.960918Z TestFramework (INFO): Test orphan transaction handling ... 
    
    2026-02-19T12:56:49.961101Z TestFramework (INFO): Send the orphans ... 
    
    2026-02-19T12:56:50.070383Z TestFramework (INFO): Send the withhold tx ... 
    
    2026-02-19T12:56:50.124751Z TestFramework (INFO): Test orphanage can store more than 100 transactions
    
    2026-02-19T12:56:50.268148Z TestFramework (INFO): Test orphan with rejected parents
    
    2026-02-19T12:56:50.322356Z TestFramework (INFO): Test that a peer disconnection causes erase its transactions from the orphan pool
    
    2026-02-19T12:56:50.479576Z TestFramework (INFO): Test that a transaction in the orphan pool is included in a new tip block causes erase this transaction from the orphan pool
    
    2026-02-19T12:56:50.479848Z TestFramework (INFO): Send the orphan ... 
    
    2026-02-19T12:56:50.486753Z TestFramework (INFO): Send the block that includes the previous orphan ... 
    
    2026-02-19T12:56:50.498315Z TestFramework (ERROR): Unexpected exception:
    
    Traceback (most recent call last):
    
      File "D:\a\bitcoin\bitcoin\test\functional\test_framework\test_framework.py", line 142, in main
    
        self.run_test()
    
        ~~~~~~~~~~~~~^^
    
      File "D:\a\bitcoin\bitcoin/test/functional/p2p_invalid_tx.py", line 180, in run_test
    
        with node.assert_debug_log(["Erased 1 orphan transaction(s) included or conflicted by block"]):
    
             ~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
    
      File "C:\hostedtoolcache\windows\Python\3.14.3\x64\Lib\contextlib.py", line 148, in __exit__
    
        next(self.gen)
    
        ~~~~^^^^^^^^^^
    
      File "D:\a\bitcoin\bitcoin\test\functional\test_framework\test_node.py", line 584, in assert_debug_log
    
        self._raise_assertion_error(f'Expected message(s) {remaining_expected!s} '
    
        ~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
    
                                    f'not found in log:\n\n{join_log(log)}\n\n')
    
                                    ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
    
      File "D:\a\bitcoin\bitcoin\test\functional\test_framework\test_node.py", line 229, in _raise_assertion_error
    
        raise AssertionError(self._node_msg(msg))
    
    AssertionError: [node 0] Expected message(s) ['Erased 1 orphan transaction(s) included or conflicted by block'] not found in log:
    
    
    
     - 2026-02-19T12:56:50.488541Z [msghand] [net_processing.cpp:3555] [ProcessMessage] [net] received: headers (82 bytes) peer=3
    
     - 2026-02-19T12:56:50.488619Z [msghand] [net_processing.cpp:3526] [LogBlockHeader] Saw new header hash=4b6a4a2986406d7f3eb90dd04a1282d8dcc60340e231b329c4f1ebddaf89253d height=102 peer=3
    
     - 2026-02-19T12:56:50.488674Z [msghand] [net_processing.cpp:2854] [HeadersDirectFetchBlocks] [net] Requesting block 4b6a4a2986406d7f3eb90dd04a1282d8dcc60340e231b329c4f1ebddaf89253d from  peer=3
    
     - 2026-02-19T12:56:50.488691Z [msghand] [net.cpp:4074] [PushMessage] [net] sending getdata (37 bytes) peer=3
    
     - 2026-02-19T12:56:50.489460Z [msghand] [net.cpp:4074] [PushMessage] [net] sending sendheaders (0 bytes) peer=3
    
     - 2026-02-19T12:56:50.492975Z [msghand] [net_processing.cpp:3555] [ProcessMessage] [net] received: block (497 bytes) peer=3
    
     - 2026-02-19T12:56:50.492999Z [msghand] [net_processing.cpp:4841] [ProcessMessage] [net] received block 4b6a4a2986406d7f3eb90dd04a1282d8dcc60340e231b329c4f1ebddaf89253d peer=3
    
     - 2026-02-19T12:56:50.493050Z [msghand] [validationinterface.cpp:261] [NewPoWValidBlock] [validation] NewPoWValidBlock: block hash=4b6a4a2986406d7f3eb90dd04a1282d8dcc60340e231b329c4f1ebddaf89253d
    
     - 2026-02-19T12:56:50.493284Z [msghand] [validation.cpp:3062] [ConnectTip] [bench]   - Using cached block
    
     - 2026-02-19T12:56:50.493305Z [msghand] [validation.cpp:3069] [ConnectTip] [bench]   - Load block from disk: 0.02ms
    
     - 2026-02-19T12:56:50.493405Z [msghand] [validation.cpp:2386] [ConnectBlock] [bench]     - Sanity checks: 0.00ms [0.00s (0.00ms/blk)]
    
     - 2026-02-19T12:56:50.493432Z [msghand] [validation.cpp:2488] [ConnectBlock] [bench]     - Fork checks: 0.03ms [0.00s (0.02ms/blk)]
    
     - 2026-02-19T12:56:50.493468Z [msghand] [validation.cpp:2603] [ConnectBlock] [bench]       - Connect 4 transactions: 0.03ms (0.008ms/tx, 0.011ms/txin) [0.00s (0.01ms/blk)]
    
     - 2026-02-19T12:56:50.493493Z [msghand] [validation.cpp:2626] [ConnectBlock] [bench]     - Verify 3 txins: 0.06ms (0.020ms/txin) [0.01s (0.03ms/blk)]
    
     - 2026-02-19T12:56:50.493639Z [msghand] [validation.cpp:2642] [ConnectBlock] [bench]     - Write undo data: 0.14ms [0.01s (0.05ms/blk)]
    
     - 2026-02-19T12:56:50.493657Z [msghand] [validation.cpp:2657] [ConnectBlock] [bench]     - Index writing: 0.02ms [0.00s (0.01ms/blk)]
    
     - 2026-02-19T12:56:50.493671Z [msghand] [validationinterface.cpp:255] [BlockChecked] [validation] BlockChecked: block hash=4b6a4a2986406d7f3eb90dd04a1282d8dcc60340e231b329c4f1ebddaf89253d state=Valid
    
     - 2026-02-19T12:56:50.493688Z [msghand] [validation.cpp:3087] [ConnectTip] [bench]   - Connect total: 0.38ms [0.02s (0.11ms/blk)]
    
     - 2026-02-19T12:56:50.493704Z [msghand] [validation.cpp:3095] [ConnectTip] [bench]   - Flush: 0.02ms [0.00s (0.01ms/blk)]
    
     - 2026-02-19T12:56:50.493720Z [msghand] [validation.cpp:3105] [ConnectTip] [bench]   - Writing chainstate: 0.02ms [0.00s (0.01ms/blk)]
    
     - 2026-02-19T12:56:50.493740Z [msghand] [validationinterface.cpp:229] [MempoolTransactionsRemovedForBlock] [validation] Enqueuing MempoolTransactionsRemovedForBlock: block height=102 txs removed=1
    
     - 2026-02-19T12:56:50.493790Z [msghand] [validation.cpp:2873] [UpdateTipLog] UpdateTip: new best=4b6a4a2986406d7f3eb90dd04a1282d8dcc60340e231b329c4f1ebddaf89253d height=102 version=0x00000004 log2_work=7.686501 tx=106 date='2026-02-19T13:06:50Z' progress=1.000000 cache=0.3MiB(105txo)
    
     - 2026-02-19T12:56:50.493810Z [msghand] [validation.cpp:3122] [ConnectTip] [bench]   - Connect postprocess: 0.09ms [0.01s (0.05ms/blk)]
    
     - 2026-02-19T12:56:50.493825Z [msghand] [validation.cpp:3126] [ConnectTip] [bench] - Connect block: 0.52ms [0.04s (0.17ms/blk)]
    
     - 2026-02-19T12:56:50.493836Z [msghand] [txmempool.cpp:435] [check] [mempool] Checking mempool with 2 transactions and 2 inputs
    
     - 2026-02-19T12:56:50.493867Z [msghand] [validationinterface.cpp:219] [BlockConnected] [validation] Enqueuing BlockConnected: block hash=4b6a4a2986406d7f3eb90dd04a1282d8dcc60340e231b329c4f1ebddaf89253d block height=102
    
     - 2026-02-19T12:56:50.493888Z [msghand] [validationinterface.cpp:182] [UpdatedBlockTip] [validation] Enqueuing UpdatedBlockTip: new block hash=4b6a4a2986406d7f3eb90dd04a1282d8dcc60340e231b329c4f1ebddaf89253d fork block hash=1a5c3bc8b1c4b797b167f2cf9fbfd872094daedbd96c5f8d2b5094618970c2b5 (in IBD=false)
    
     - 2026-02-19T12:56:50.493904Z [msghand] [validationinterface.cpp:190] [ActiveTipChange] [validation] ActiveTipChange: new block hash=4b6a4a2986406d7f3eb90dd04a1282d8dcc60340e231b329c4f1ebddaf89253d block height=102
    
     - 2026-02-19T12:56:50.494957Z [msghand] [net_processing.cpp:3555] [ProcessMessage] [net] received: ping (8 bytes) peer=3
    
     - 2026-02-19T12:56:50.494981Z [msghand] [net.cpp:4074] [PushMessage] [net] sending pong (8 bytes) peer=3
    
     - 2026-02-19T12:56:50.496498Z [msghand] [net_processing.cpp:3555] [ProcessMessage] [net] received: ping (8 bytes) peer=3
    
     - 2026-02-19T12:56:50.496522Z [msghand] [net.cpp:4074] [PushMessage] [net] sending pong (8 bytes) peer=3
    
     - 2026-02-19T12:56:50.497570Z [http] [httpserver.cpp:232] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:59760
    
     - 2026-02-19T12:56:50.497615Z [http_pool_0] [rpc/request.cpp:243] [parse] [rpc] ThreadRPCServer method=getbestblockhash user=__cookie__
    
    
    
    
    
    2026-02-19T12:56:50.558119Z TestFramework (INFO): Not stopping nodes as test failed. The dangling processes will be cleaned up later.
    
    2026-02-19T12:56:50.558309Z TestFramework (WARNING): Not cleaning up dir D:\a\bitcoin\bitcoin\test_runner_₿_🏃_20260219_124134\p2p_invalid_tx_138
    
    2026-02-19T12:56:50.558437Z TestFramework (ERROR): Test failed. Test logging available at D:\a\bitcoin\bitcoin\test_runner_₿_🏃_20260219_124134\p2p_invalid_tx_138/test_framework.log
    
    2026-02-19T12:56:50.558563Z TestFramework (ERROR): 
    
    2026-02-19T12:56:50.558923Z TestFramework (ERROR): Hint: Call D:\a\bitcoin\bitcoin\test\functional\combine_logs.py 'D:\a\bitcoin\bitcoin\test_runner_₿_🏃_20260219_124134\p2p_invalid_tx_138' to consolidate all logs
    
    2026-02-19T12:56:50.559050Z TestFramework (ERROR): 
    
    2026-02-19T12:56:50.559148Z TestFramework (ERROR): If this failure happened unexpectedly or intermittently, please file a bug and provide a link or upload of the combined log.
    
    2026-02-19T12:56:50.559269Z TestFramework (ERROR): https://github.com/bitcoin/bitcoin/issues
    
    2026-02-19T12:56:50.559367Z TestFramework (ERROR): 
    
    
    
    stderr:
    [node 0] Cleaning up leftover process
    
    
    
    
  2. hebasto added the label Tests on Feb 19, 2026
  3. maflcko added the label CI failed on Feb 19, 2026
  4. maflcko added this to the milestone 31.0 on Feb 19, 2026
  5. achow101 closed this on Feb 21, 2026

  6. achow101 referenced this in commit fa194fca8e on Feb 21, 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-28 00:12 UTC

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