Uploaded image for project: 'WiredTiger'
  1. WiredTiger
  2. WT-8987

Fix error in test_checkpoint_snapshot03: WT_ROLLBACK error for fixed column store

    XMLWordPrintable

Details

    • 0
    • Storage - Ra 2022-04-18

    Description

      unit-test-bucket09 on ubuntu2004

      Host: i-08d3d901239e93ffb
      Project: wiredtiger
      Commit: f5cfe3b1

      Task Logs:

      unit-test-bucket09 task_log

      Logs:

      Test failure
      [2022/03/22 06:05:01.267] ERROR: test_checkpoint_snapshot03.test_checkpoint_snapshot03.test_checkpoint_snapshot(column_fix) (subunit.RemotedTestCase)
      [2022/03/22 06:05:01.267] test_checkpoint_snapshot03.test_checkpoint_snapshot03.test_checkpoint_snapshot(column_fix)
      [2022/03/22 06:05:01.267] ----------------------------------------------------------------------
      [2022/03/22 06:05:01.267] testtools.testresult.real._StringException: Traceback (most recent call last):
      [2022/03/22 06:05:01.267]   File "/data/mci/9c4359ad23633cbc533fa8852496241f/wiredtiger/test/suite/test_checkpoint_snapshot03.py", line 115, in test_checkpoint_snapshot
      [2022/03/22 06:05:01.267]     self.large_updates(self.uri, valuea, ds, self.nrows)
      [2022/03/22 06:05:01.267]   File "/data/mci/9c4359ad23633cbc533fa8852496241f/wiredtiger/test/suite/test_checkpoint_snapshot03.py", line 66, in large_updates
      [2022/03/22 06:05:01.267]     cursor[ds.key(i)] = value
      [2022/03/22 06:05:01.267]   File "/data/mci/9c4359ad23633cbc533fa8852496241f/wiredtiger/cmake_build/lang/python/wiredtiger/swig_wiredtiger.py", line 320, in __setitem__
      [2022/03/22 06:05:01.267]     if self.insert() != 0:
      [2022/03/22 06:05:01.267] _wiredtiger.WiredTigerError: WT_ROLLBACK: conflict between concurrent operations
      [2022/03/22 06:05:01.267] ----------------------------------------------------------------------
      [2022/03/22 06:05:01.267] Ran 728 tests in 405.780s
      [2022/03/22 06:05:01.267] FAILED (errors=1, skipped=31)
      [2022/03/22 06:05:01.267] failure: test_checkpoint_snapshot03.test_checkpoint_snapshot03.test_checkpoint_snapshot(column_fix) [
      [2022/03/22 06:05:01.267] Traceback (most recent call last):
      [2022/03/22 06:05:01.267]   File "/data/mci/9c4359ad23633cbc533fa8852496241f/wiredtiger/test/suite/wttest.py", line 508, in tearDown
      [2022/03/22 06:05:01.268]     self.captureout.check(self)
      [2022/03/22 06:05:01.268]   File "/data/mci/9c4359ad23633cbc533fa8852496241f/wiredtiger/test/suite/wttest.py", line 116, in check
      [2022/03/22 06:05:01.268]     testcase.fail('unexpected ' + self.desc + ', contains: "' +
      [2022/03/22 06:05:01.268]   File "/opt/mongodbtoolchain/revisions/c6da1cf7f0b4b60d53566305e59857d3d540dcf7/stow/python3-v3.9MG/lib/python3.9/unittest/case.py", line 670, in fail
      [2022/03/22 06:05:01.268]     raise self.failureException(msg)
      [2022/03/22 06:05:01.268] AssertionError: unexpected standard output, contains: "[1647928709:385775][37164:0x7f832ed07740], test_checkpoint_snapshot03.test_checkpoint_snapshot03.test_checkpoint_snapshot(column_fix), file:test_checkpoint_snapshot03.wt, WT_CURSOR.insert: [WT_VERB_TRANSACTION][NOTICE]: oldest pinned transaction ID rolled back for eviction
      [2022/03/22 06:05:01.268] "
      [2022/03/22 06:05:01.268] ]
      [2022/03/22 06:05:01.268] WARNING: huge test test_rollback_to_stable25.test_rollback_to_stable25.test_rollback_to_stable25 has > 1000 scenarios.
      [2022/03/22 06:05:01.268] That is only appropriate when using the --long option.
      [2022/03/22 06:05:01.268] The number of scenarios for the test should be pruned
      [2022/03/22 06:05:01.632] Command failed: command encountered problem: error waiting on process '9d06239e-9912-4417-9f67-75c02101646f': exit status 1
      [2022/03/22 06:05:01.632] Task completed - FAILURE.
      [2022/03/22 06:05:01.663] Running post-task commands.
      [2022/03/22 06:05:01.663] Running command 'shell.exec' in "print python stacktrace" (step 1 of 5)
      [2022/03/22 06:05:01.664] if [ -d "WT_TEST" ]; then
      [2022/03/22 06:05:01.664]   /opt/mongodbtoolchain/v3/bin/python3 ../test/evergreen/print_python_stack_trace.py -e /opt/mongodbtoolchain/v3/bin/python3 -c WT_TEST -l .
      [2022/03/22 06:05:01.664] fi
      [2022/03/22 06:05:01.710] Finished 'shell.exec' in "print python stacktrace" in 46.375003ms
      [2022/03/22 06:05:01.710] Running command 'shell.exec' in "dump stderr/stdout" (step 2 of 5)
      [2022/03/22 06:05:01.711] if [ -d "WT_TEST" ]; then
      [2022/03/22 06:05:01.711]   # Dump stderr/stdout contents generated by the C libraries onto console for Python tests
      [2022/03/22 06:05:01.711]   find "WT_TEST" -name "std*.txt" ! -empty -exec sh -c "echo 'Contents from {}:'; cat '{}'" \;
      [2022/03/22 06:05:01.713] Contents from WT_TEST/test_checkpoint_snapshot03.test_checkpoint_snapshot03.test_checkpoint_snapshot_column_fix/stdout.txt:
      [2022/03/22 06:05:01.715] [1647928709:385775][37164:0x7f832ed07740], test_checkpoint_snapshot03.test_checkpoint_snapshot03.test_checkpoint_snapshot(column_fix), file:test_checkpoint_snapshot03.wt, WT_CURSOR.insert: [WT_VERB_TRANSACTION][NOTICE]: oldest pinned transaction ID rolled back for eviction
      [2022/03/22 06:05:01.715] fi
      [2022/03/22 06:05:01.715] Finished 'shell.exec' in "dump stderr/stdout" in 5.677104ms
      [2022/03/22 06:05:01.716] Running command 'archive.targz_pack' in "upload artifact" (step 3.1 of 5)
      [2022/03/22 06:05:23.518] Finished 'archive.targz_pack' in "upload artifact" in 21.80223055s
      [2022/03/22 06:05:23.518] Running command 's3.put' in "upload artifact" (step 3.2 of 5)
      [2022/03/22 06:05:23.546] Putting wiredtiger.tgz into build_external/wiredtiger/ubuntu2004/f5cfe3b143a1e7254b38a83bd574111a633c2e38/artifacts/unit-test-bucket09_wiredtiger_ubuntu2004_f5cfe3b143a1e7254b38a83bd574111a633c2e38_22_03_22_05_33_37-0.tgz (https://build_external.s3.amazonaws.com/wiredtiger/ubuntu2004/f5cfe3b143a1e7254b38a83bd574111a633c2e38/artifacts/unit-test-bucket09_wiredtiger_ubuntu2004_f5cfe3b143a1e7254b38a83bd574111a633c2e38_22_03_22_05_33_37-0.tgz)
      [2022/03/22 06:05:23.546] performing s3 put to build_external of wiredtiger/ubuntu2004/f5cfe3b143a1e7254b38a83bd574111a633c2e38/artifacts/unit-test-bucket09_wiredtiger_ubuntu2004_f5cfe3b143a1e7254b38a83bd574111a633c2e38_22_03_22_05_33_37-0.tgz [1 of 5]
      [2022/03/22 06:05:32.774] Finished 's3.put' in "upload artifact" in 9.255617299s
      [2022/03/22 06:05:32.774] Running command 'archive.targz_pack' in "save wt hang analyzer core/debugger files" (step 4.1 of 5)
      [2022/03/22 06:05:32.788] Finished 'archive.targz_pack' in "save wt hang analyzer core/debugger files" in 14.565913ms
      [2022/03/22 06:05:32.788] Running command 's3.put' in "save wt hang analyzer core/debugger files" (step 4.2 of 5)
      [2022/03/22 06:05:32.807] Putting wt-hang-analyzer.tgz into build_external/wiredtiger/ubuntu2004/f5cfe3b143a1e7254b38a83bd574111a633c2e38/wt_hang_analyzer/wt-hang-analyzer_unit-test-bucket09_wiredtiger_ubuntu2004_f5cfe3b143a1e7254b38a83bd574111a633c2e38_22_03_22_05_33_37-0.tgz (https://build_external.s3.amazonaws.com/wiredtiger/ubuntu2004/f5cfe3b143a1e7254b38a83bd574111a633c2e38/wt_hang_analyzer/wt-hang-analyzer_unit-test-bucket09_wiredtiger_ubuntu2004_f5cfe3b143a1e7254b38a83bd574111a633c2e38_22_03_22_05_33_37-0.tgz)
      [2022/03/22 06:05:32.807] performing s3 put to build_external of wiredtiger/ubuntu2004/f5cfe3b143a1e7254b38a83bd574111a633c2e38/wt_hang_analyzer/wt-hang-analyzer_unit-test-bucket09_wiredtiger_ubuntu2004_f5cfe3b143a1e7254b38a83bd574111a633c2e38_22_03_22_05_33_37-0.tgz [1 of 5]
      [2022/03/22 06:05:32.807] file '/data/mci/9c4359ad23633cbc533fa8852496241f/wt-hang-analyzer.tgz' not found but skip missing true
      [2022/03/22 06:05:32.807] Finished 's3.put' in "save wt hang analyzer core/debugger files" in 18.602679ms
      [2022/03/22 06:05:32.807] Running command 'shell.exec' in "cleanup" (step 5 of 5)
      [2022/03/22 06:05:32.948] Finished 'shell.exec' in "cleanup" in 140.702022ms
      [2022/03/22 06:05:32.948] [message='Finished running post-task commands.' total_time='31.315651744s']
      [2022/03/22 06:05:33.463] running setup group because we have a new independent task
      Link: https://evergreen.mongodb.com/task_log_raw/wiredtiger_ubuntu2004_unit_test_bucket09_f5cfe3b143a1e7254b38a83bd574111a633c2e38_22_03_22_05_33_37/0?type=T#L2178
      

      logs

      Attachments

        Issue Links

          Activity

            People

              etienne.petrel@mongodb.com Etienne Petrel
              Xgen-BuildBaron-User xgen-buildbaron-user
              Votes:
              0 Vote for this issue
              Watchers:
              5 Start watching this issue

              Dates

                Created:
                Updated:
                Resolved: