test_checkpoint: cursor->next() returns WT_PREPARE_CONFLICT [wiredtiger @ 518380a1]

XMLWordPrintableJSON

    • Type: Build Failure
    • Resolution: Unresolved
    • Priority: Major - P3
    • None
    • Affects Version/s: None
    • Component/s: None

      configure-combinations on ubuntu2004

      Host: i-0525e88d66e473e69
      Project: wiredtiger
      Commit: 518380a1
      Please refer to BF(G) Playbook for instructions on handling BF and BFG tickets as well as Auto-Resolution Rules

      The issue (cursor->next() returns WT_PREPARE_CONFLICT):

      [2026/03/23 11:41:56.812] test_checkpoint: do_cursor_next,480: cursor->next: WT_ROLLBACK: conflict between concurrent operations

      Task Logs:

      configure-combinations task_log

      Logs:

      [2026/03/23 11:41:56.810]  37/101 Test  #37: test_checkpoint_column_stress_sweep_timestamps ...***Failed   16.87 sec
[2026/03/23 11:41:56.810] Running test command: /data/mci/800b9b326cb92554720830480eaddb01/wiredtiger/cmake_build/test/checkpoint/test_checkpoint -t c -W 3 -r 2 -s 1 -x -n 100000 -k 100000 -D
[2026/03/23 11:41:56.811] test_checkpoint: process 45113
[2026/03/23 11:41:56.811]     1: 3 workers, 3 tables
[2026/03/23 11:41:56.811] WT open config: create,cache_cursors=false,statistics=(all),statistics_log=(json,on_close,wait=1),log=(enabled),error_prefix="test_checkpoint",cache_size=1G, eviction_dirty_trigger=5, eviction_dirty_target=1,,debug_mode=(eviction=true,table_logging=true),verbose=(recovery),,timing_stress_for_test=[aggressive_sweep],file_manager=(close_handle_minimum=1,close_idle_time=1,close_scan_interval=1)
[2026/03/23 11:41:56.811] [1774228299:968100][45113:0x7f0926811c40], test_checkpoint, wiredtiger_open: [WT_VERB_RECOVERY][INFO]: opening the WiredTiger library
[2026/03/23 11:41:56.811] [1774228299:972874][45113:0x7f0926811c40], test_checkpoint, connection: [WT_VERB_RECOVERY][INFO]: connection configuration string parsing completed
[2026/03/23 11:41:56.811] [1774228299:979858][45113:0x7f0926811c40], test_checkpoint, connection: [WT_VERB_RECOVERY][INFO]: starting WiredTiger utility threads
[2026/03/23 11:41:56.811] [1774228299:986826][45113:0x7f0926811c40], test_checkpoint, connection: [WT_VERB_RECOVERY][INFO]: starting WiredTiger recovery
[2026/03/23 11:41:56.811] [1774228299:986925][45113:0x7f0926811c40], test_checkpoint, txn-recover: [WT_VERB_RECOVERY][DEBUG_1]: Recovering file:WiredTiger.wt with id 0 @ (1,0)
[2026/03/23 11:41:56.811] [1774228299:986971][45113:0x7f0926811c40], test_checkpoint, txn-recover: [WT_VERB_RECOVERY][INFO]: scanning metadata to remove all incomplete tables
[2026/03/23 11:41:56.811] [1774228299:986995][45113:0x7f0926811c40], test_checkpoint, txn-recover: [WT_VERB_RECOVERY][INFO]: scanning metadata to find the largest file ID
[2026/03/23 11:41:56.811] [1774228299:987014][45113:0x7f0926811c40], test_checkpoint, txn-recover: [WT_VERB_RECOVERY][INFO]: largest file ID found in the metadata 0
[2026/03/23 11:41:56.811] [1774228299:987027][45113:0x7f0926811c40], test_checkpoint, txn-recover: [WT_VERB_RECOVERY][INFO]: recovery log replay has successfully finished and ran for 0 milliseconds
[2026/03/23 11:41:56.811] [1774228299:987043][45113:0x7f0926811c40], test_checkpoint, txn-recover: [WT_VERB_RECOVERY][DEBUG_1]: Set global recovery timestamp: (0, 0)
[2026/03/23 11:41:56.811] [1774228299:987053][45113:0x7f0926811c40], test_checkpoint, txn-recover: [WT_VERB_RECOVERY][DEBUG_1]: Set global oldest timestamp: (0, 0)
[2026/03/23 11:41:56.811] [1774228299:987073][45113:0x7f0926811c40], test_checkpoint, txn-recover: [WT_VERB_RECOVERY][INFO]: recovery was completed successfully and took 0ms, including 0ms for the log replay, 0ms for the rollback to stable, and 0ms for the checkpoint.
[2026/03/23 11:41:56.811] [1774228299:995649][45113:0x7f0926811c40], test_checkpoint, connection: [WT_VERB_RECOVERY][INFO]: WiredTiger utility threads started successfully
[2026/03/23 11:41:56.811] [1774228299:995665][45113:0x7f0926811c40], test_checkpoint, connection: [WT_VERB_RECOVERY][INFO]: the WiredTiger library has successfully opened
[2026/03/23 11:41:56.811] checkpointer thread starting: tid: 45113:0x7f091a7e2700
[2026/03/23 11:41:56.811] clock thread starting: tid: 45113:0x7f0919fe1700
[2026/03/23 11:41:56.811] Finished verifying with 3 tables and 0 keys at timestamp 0
[2026/03/23 11:41:56.811] worker thread starting: tid: 45113:0x7f0918fdf700 key-range: 1 - 100001
[2026/03/23 11:41:56.811] worker thread starting: tid: 45113:0x7f09187de700 key-range: 1 - 100001
[2026/03/23 11:41:56.811] worker thread starting: tid: 45113:0x7f09197e0700 key-range: 1 - 100001
[2026/03/23 11:41:56.811] Finished a checkpoint
[2026/03/23 11:41:56.811] [1774228300:028489][45113:0x7f091a7e2700], test_checkpoint, WT_SESSION.open_cursor: [WT_VERB_RECOVERY][DEBUG_1]: Recovery checkpoint_timestamp 4
[2026/03/23 11:41:56.811] [1774228300:031403][45113:0x7f091a7e2700], test_checkpoint, WT_SESSION.open_cursor: [WT_VERB_RECOVERY][DEBUG_1]: Recovery checkpoint_timestamp 4
[2026/03/23 11:41:56.811] [1774228300:032802][45113:0x7f091a7e2700], test_checkpoint, WT_SESSION.open_cursor: [WT_VERB_RECOVERY][DEBUG_1]: Recovery checkpoint_timestamp 4
[2026/03/23 11:41:56.811] Finished verifying a checkpoint with 3 tables and 0 keys at timestamp 0
[2026/03/23 11:41:56.811] Finished verifying with 3 tables and 0 keys at timestamp 1
[2026/03/23 11:41:56.811] Worker 5000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 5000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 5000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 10000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 10000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 10000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 15000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 15000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 15000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 20000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 20000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 25000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 20000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 25000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 30000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 25000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 30000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 35000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 40000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 45000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 30000 of 100000 ops
[2026/03/23 11:41:56.811] Worker 35000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 50000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 40000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 35000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 45000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 40000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 45000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 50000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 50000 of 100000 ops
[2026/03/23 11:41:56.812] Finished verifying with 3 tables and 40732 keys at timestamp 0
[2026/03/23 11:41:56.812] Finished a checkpoint
[2026/03/23 11:41:56.812] [1774228307:826942][45113:0x7f091a7e2700], test_checkpoint, WT_SESSION.open_cursor: [WT_VERB_RECOVERY][DEBUG_1]: Recovery checkpoint_timestamp 3d9
[2026/03/23 11:41:56.812] [1774228307:826979][45113:0x7f091a7e2700], test_checkpoint, WT_SESSION.open_cursor: [WT_VERB_RECOVERY][DEBUG_1]: Recovery oldest_timestamp 4
[2026/03/23 11:41:56.812] [1774228307:828422][45113:0x7f091a7e2700], test_checkpoint, WT_SESSION.open_cursor: [WT_VERB_RECOVERY][DEBUG_1]: Recovery checkpoint_timestamp 3d9
[2026/03/23 11:41:56.812] [1774228307:828471][45113:0x7f091a7e2700], test_checkpoint, WT_SESSION.open_cursor: [WT_VERB_RECOVERY][DEBUG_1]: Recovery oldest_timestamp 4
[2026/03/23 11:41:56.812] [1774228307:829975][45113:0x7f091a7e2700], test_checkpoint, WT_SESSION.open_cursor: [WT_VERB_RECOVERY][DEBUG_1]: Recovery checkpoint_timestamp 3d9
[2026/03/23 11:41:56.812] [1774228307:830040][45113:0x7f091a7e2700], test_checkpoint, WT_SESSION.open_cursor: [WT_VERB_RECOVERY][DEBUG_1]: Recovery oldest_timestamp 4
[2026/03/23 11:41:56.812] Finished verifying a checkpoint with 3 tables and 40749 keys at timestamp 0
[2026/03/23 11:41:56.812] Finished verifying with 3 tables and 35835 keys at timestamp 266
[2026/03/23 11:41:56.812] test_checkpoint: do_cursor_next,480: cursor->next: WT_ROLLBACK: conflict between concurrent operations
[2026/03/23 11:41:56.812] Worker 55000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 60000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 65000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 70000 of 100000 ops
[2026/03/23 11:41:56.812] Worker 75000 of 100000 ops
[2026/03/23 11:41:56.812] Ran workers for: 15.051226 seconds
[2026/03/23 11:41:56.812] Finished a checkpoint

      logs

      Repro Artifacts:

            Assignee:
            [DO NOT USE] Backlog - Storage Engines Team
            Reporter:
            xgen-buildbaron-user
            Votes:
            0 Vote for this issue
            Watchers:
            1 Start watching this issue

              Created:
              Updated: