test_backup10: Abort in checkpoint_log during connection close, triggered by duplicate backup cursor errors

XMLWordPrintableJSON

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

      unit-test on amazon2023-armv9

      Host: i-0f2a6d0327fb3733a
      Project: wiredtiger
      Commit: a1e9823f
      Please refer to BF(G) Playbook for instructions on handling BF and BFG tickets as well as Auto-Resolution Rules

      Task Logs:

      unit-test task_log

      Logs:

      [pid:7262]: ERROR: test_backup10.test_backup10.test_backup10(removing)
----------------------------------------------------------------------
[pid:7262]: testtools.testresult.real._StringException: lost connection during test 'test_backup10.test_backup10.test_backup10(removing)'
----------------------------------------------------------------------
Ran 13559 tests in 1871.710s

      logs

      unit-test task_log

      Logs:

      #0  0x0000ffff956bf634 in __pthread_kill_implementation () from /lib64/libc.so.6
#0  0x0000ffff956bf634 in __pthread_kill_implementation () from /lib64/libc.so.6
#1  0x0000ffff956763a0 [PAC] in raise () from /lib64/libc.so.6
#2  0x0000ffff95662264 [PAC] in abort () from /lib64/libc.so.6
#3  0x0000ffff94bda8d0 [PAC] in __wt_abort (session=session@entry=0x122d7d710000) at /data/mci/29b946919ad803592fed999408f49d29/wiredtiger/src/os_common/os_abort.c:31
#4  0x0000ffff94c98450 in __wt_checkpoint_log (session=session@entry=0x122d7d710000, full=full@entry=true, flags=flags@entry=8, lsnp=lsnp@entry=0x0) at /data/mci/29b946919ad803592fed999408f49d29/wiredtiger/src/txn/txn_log.c:566
#5  0x0000ffff94b28830 in __wti_connection_close (conn=conn@entry=0x122d7b096000) at /data/mci/29b946919ad803592fed999408f49d29/wiredtiger/src/conn/conn_open.c:129
#6  0x0000ffff94b1a150 in __conn_close (wt_conn=0x122d7b096000, config=<optimized out>) at /data/mci/29b946919ad803592fed999408f49d29/wiredtiger/src/conn/conn_api.c:1273
#7  0x0000ffff94f3601c in _wrap_Connection_close (self=<optimized out>, args=<optimized out>) at /data/mci/29b946919ad803592fed999408f49d29/wiredtiger/cmake_build/lang/python/CMakeFiles/wiredtiger_python.dir/wiredtigerPYTHON_wrap.c:8469
#8  0x0000ffff958d0dfc in cfunction_call (func=0xffff95164810, args=<optimized out>, kwargs=<optimized out>) at ../src/Python-3.10.4/Objects/methodobject.c:552
#9  0x0000ffff958e1530 in _PyObject_Call (tstate=0x122d7fe0c000, callable=0xffff95164810, args=0xffff90f61fc0, kwargs=<optimized out>) at ../src/Python-3.10.4/Objects/call.c:305
#10 PyObject_Call (callable=0xffff95164810, args=0xffff90f61fc0, kwargs=<optimized out>) at ../src/Python-3.10.4/Objects/call.c:317
#11 0x0000ffff958bf1dc in do_call_core (tstate=<optimized out>, trace_info=0xffffc9ea4010, func=0xffff95164810, callargs=0xffff90f61fc0, kwdict=0x0) at ../src/Python-3.10.4/Python/ceval.c:5919
#12 _PyEval_EvalFrameDefault (tstate=0x122d7fe0c000, f=<optimized out>, throwflag=<optimized out>) at ../src/Python-3.10.4/Python/ceval.c:4277
#13 0x0000ffff958d164c in _PyEval_EvalFrame (tstate=0x122d7fe0c000, f=0xffff92ac9260, throwflag=0) at ../src/Python-3.10.4/Include/internal/pycore_ceval.h:46
#14 _PyEval_Vector (tstate=0x122d7fe0c000, con=0xffff9517b380, locals=0x0, args=<optimized out>, argcount=<optimized out>, kwnames=<optimized out>) at ../src/Python-3.10.4/Python/ceval.c:5065
#15 _PyFunction_Vectorcall (func=0xffff9517b370, stack=<optimized out>, nargsf=<optimized out>, kwnames=<optimized out>) at ../src/Python-3.10.4/Objects/call.c:342
#16 0x0000ffff958bd358 in _PyObject_VectorcallTstate (tstate=<optimized out>, callable=<optimized out>, args=<optimized out>, nargsf=<optimized out>, kwnames=0x0) at ../src/Python-3.10.4/Include/cpython/abstract.h:114
#17 PyObject_Vectorcall (callable=<optimized out>, args=<optimized out>, nargsf=<optimized out>, kwnames=0x0) at ../src/Python-3.10.4/Include/cpython/abstract.h:123
#18 call_function (tstate=<optimized out>, trace_info=0xffffc9ea41e0, pp_stack=<synthetic pointer>, oparg=<optimized out>, kwnames=0x0) at ../src/Python-3.10.4/Python/ceval.c:5867
#19 _PyEval_EvalFrameDefault (tstate=0x122d7fe0c000, f=<optimized out>, throwflag=<optimized out>) at ../src/Python-3.10.4/Python/ceval.c:4198
#20 0x0000ffff958e0818 in _PyEval_EvalFrame (tstate=0x122d7fe0c000, f=0xffff92ad5700, throwflag=0) at ../src/Python-3.10.4/Include/internal/pycore_ceval.h:46
#21 _PyEval_Vector (tstate=0x122d7fe0c000, con=0xffff9519e840, locals=0x0, args=0x122d7ecec1f8, argcount=<optimized out>, kwnames=<optimized out>) at ../src/Python-3.10.4/Python/ceval.c:5065
#22 _PyFunction_Vectorcall (func=0xffff9519e830, stack=0x122d7ecec1f8, nargsf=<optimized out>, kwnames=<optimized out>) at ../src/Python-3.10.4/Objects/call.c:342
#23 _PyObject_VectorcallTstate (tstate=0x122d7fe0c000, callable=0xffff9519e830, args=0x122d7ecec1f8, nargsf=<optimized out>, kwnames=<optimized out>) at ../src/Python-3.10.4/Include/cpython/abstract.h:114
#24 method_vectorcall (method=<optimized out>, args=0x122d7ecec200, nargsf=<optimized out>, kwnames=<optimized out>) at ../src/Python-3.10.4/Objects/classobject.c:53
#25 0x0000ffff958c1498 in _PyObject_VectorcallTstate (tstate=<optimized out>, callable=<optimized out>, args=<optimized out>, nargsf=<optimized out>, kwnames=0x0) at ../src/Python-3.10.4/Include/cpython/abstract.h:114
#26 PyObject_Vectorcall (callable=<optimized out>, args=<optimized out>, nargsf=<optimized out>, kwnames=0x0) at ../src/Python-3.10.4/Include/cpython/abstract.h:123
#27 call_function (tstate=<optimized out>, trace_info=0xffffc9ea4410, pp_stack=<synthetic pointer>, oparg=<optimized out>, kwnames=0x0) at ../src/Python-3.10.4/Python/ceval.c:5867
#28 _PyEval_EvalFrameDefault (tstate=0x122d7fe0c000, f=<optimized out>, throwflag=<optimized out>) at ../src/Python-3.10.4/Python/ceval.c:4181
#29 0x0000ffff958e0818 in _PyEval_EvalFrame (tstate=0x122d7fe0c000, f=0x122d7ecec010, throwflag=0) at ../src/Python-3.10.4/Include/internal/pycore_ceval.h:46

      logs

      unit-test task_log

      Logs:

      [1749724290:248290][7267:0xffff96e4d040], test_backup10.test_backup10.test_backup10(removing), WT_SESSION.open_cursor: [WT_VERB_DEFAULT][ERROR]: __backup_start, 785: there is already a duplicate backup cursor open: Invalid argument
[1749724290:248516][7267:0xffff96e4d040], test_backup10.test_backup10.test_backup10(removing), WT_SESSION.open_cursor: [WT_VERB_DEFAULT][ERROR]: __backup_start, 785: there is already a duplicate backup cursor open: Invalid argument
[1749724290:248584][7267:0xffff96e4d040], test_backup10.test_backup10.test_backup10(removing), WT_SESSION.open_cursor: [WT_VERB_DEFAULT][ERROR]: __backup_config, 698: duplicate backup cursor must be for block-based incremental or logging backup: Invalid argument
[1749724290:311987][7267:0xffff96e4d040], WT_CONNECTION.close: [WT_VERB_DEFAULT][ERROR]: __wt_abort, 29: aborting WiredTiger library

      logs

            Assignee:
            Etienne Petrel
            Reporter:
            xgen-buildbaron-user
            Votes:
            0 Vote for this issue
            Watchers:
            2 Start watching this issue

              Created:
              Updated:
              Resolved: