__log_fsync_file vs __log_newfile data race

XMLWordPrintableJSON

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

      generate-tsan-metric on amazon2023-armv9-tsan

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

      Task Logs:

      generate-tsan-metric task_log

      Logs:

      WARNING: ThreadSanitizer: data race (pid=385918)
      Atomic write of size 8 at 0xffffa0804028 by main thread (mutexes: write M0):
      #0 __log_newfile /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log.c:1250 (libwiredtiger.so.12.0.0+0x4c4130)
      #1 __wti_log_acquire /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log.c:1372 (libwiredtiger.so.12.0.0+0x4c564c)
      #2 __log_slot_new /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log_slot.c:275 (libwiredtiger.so.12.0.0+0x4fc068)
      #3 __log_slot_switch_internal /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log_slot.c:372 (libwiredtiger.so.12.0.0+0x4f87a0)
      #4 __wti_log_slot_switch /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log_slot.c:413 (libwiredtiger.so.12.0.0+0x4f7d38)
      #5 __log_write_internal /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log.c:2700 (libwiredtiger.so.12.0.0+0x4d1bac)
      #6 __wt_log_write /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log.c:2595 (libwiredtiger.so.12.0.0+0x4d1408)
      #7 __wti_txn_log_commit /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/txn/txn_log.c:320 (libwiredtiger.so.12.0.0+0x7815f8)
      #8 __wt_txn_commit /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/txn/txn.c:1716 (libwiredtiger.so.12.0.0+0x764700)
      #9 __curfile_insert /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/cursor/cur_file.c:405 (libwiredtiger.so.12.0.0+0x3922e4)
      #10 _wrap_Cursor_insert lang/python/CMakeFiles/wiredtiger_python.dir/wiredtigerPYTHON_wrap.c:4881 (_wiredtiger.so+0x1d6e8)
      #11 cfunction_vectorcall_O ../src/Python-3.10.4/Objects/methodobject.c:516 (libpython3.10.so.1.0+0xcff44) (BuildId: 044ec6e63ddfdd59fb20701554e6dcdefab05a90)
      Previous read of size 8 at 0xffffa0804028 by thread T43 (mutexes: write M1, write M2, write M3):
      #0 __log_fsync_file /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log.c:279 (libwiredtiger.so.12.0.0+0x4c1280)
      #1 __wti_log_release /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log.c:2018 (libwiredtiger.so.12.0.0+0x4cb1b8)
      #2 __log_write_internal /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log.c:2712 (libwiredtiger.so.12.0.0+0x4d1d58)
      #3 __wt_log_write /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log.c:2595 (libwiredtiger.so.12.0.0+0x4d1408)
      #4 __wt_checkpoint_log /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/txn/txn_log.c:537 (libwiredtiger.so.12.0.0+0x78291c)
      #5 __checkpoint_db_internal /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/checkpoint/checkpoint_txn.c:1640 (libwiredtiger.so.12.0.0+0x2ae7c8)
      #6 __checkpoint_db_wrapper /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/checkpoint/checkpoint_txn.c:1729 (libwiredtiger.so.12.0.0+0x2a63d8)
      #7 __wt_checkpoint_db /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/checkpoint/checkpoint_txn.c:1808 (libwiredtiger.so.12.0.0+0x2a5ac4)
      #8 __session_checkpoint /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/session/session_api.c:2443 (libwiredtiger.so.12.0.0+0x666418)
      #9 __ckpt_server /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/checkpoint/checkpoint_conn.c:102 (libwiredtiger.so.12.0.0+0x29f5a8)
      #10 <null> <null> (libtsan.so.2+0x4fd00) (BuildId: f3170e424285d8d8364a2a0f2222db9d15960c3f)
      Location is heap block of size 15976 at 0xffffa0804000 allocated by main thread:
      #0 calloc <null> (libtsan.so.2+0x553ec) (BuildId: f3170e424285d8d8364a2a0f2222db9d15960c3f)
      #1 __wt_calloc /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/os_common/os_alloc.c:68 (libwiredtiger.so.12.0.0+0x524ce8)
      #2 __wt_logmgr_create /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log_mgr.c:1056 (libwiredtiger.so.12.0.0+0x4f1fc4)
      #3 __wti_connection_workers /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_open.c:242 (libwiredtiger.so.12.0.0+0x331350)
      #4 wiredtiger_open /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_api.c:3501 (libwiredtiger.so.12.0.0+0x2db434)
      #5 _wrap_wiredtiger_open lang/python/CMakeFiles/wiredtiger_python.dir/wiredtigerPYTHON_wrap.c:10210 (_wiredtiger.so+0x2d630)
      #6 cfunction_call ../src/Python-3.10.4/Objects/methodobject.c:552 (libpython3.10.so.1.0+0xd05e8) (BuildId: 044ec6e63ddfdd59fb20701554e6dcdefab05a90)
      Mutex M0 (0xffffa0804128) created at:
      #0 pthread_mutex_init <null> (libtsan.so.2+0x591b8) (BuildId: f3170e424285d8d8364a2a0f2222db9d15960c3f)
      #1 __wt_spin_init /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/include/mutex_inline.h:142 (libwiredtiger.so.12.0.0+0x4f25a0)
      #2 __wt_logmgr_create /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log_mgr.c:1060 (libwiredtiger.so.12.0.0+0x4f2100)
      #3 __wti_connection_workers /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_open.c:242 (libwiredtiger.so.12.0.0+0x331350)
      #4 wiredtiger_open /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_api.c:3501 (libwiredtiger.so.12.0.0+0x2db434)
      #5 _wrap_wiredtiger_open lang/python/CMakeFiles/wiredtiger_python.dir/wiredtigerPYTHON_wrap.c:10210 (_wiredtiger.so+0x2d630)
      #6 cfunction_call ../src/Python-3.10.4/Objects/methodobject.c:552 (libpython3.10.so.1.0+0xd05e8) (BuildId: 044ec6e63ddfdd59fb20701554e6dcdefab05a90)
      Mutex M1 (0xffffa57387e8) created at:
      #0 pthread_mutex_init <null> (libtsan.so.2+0x591b8) (BuildId: f3170e424285d8d8364a2a0f2222db9d15960c3f)
      #1 __wt_spin_init /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/include/mutex_inline.h:142 (libwiredtiger.so.12.0.0+0x6787e4)
      #2 __open_session /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/session/session_api.c:2598 (libwiredtiger.so.12.0.0+0x64a650)
      #3 __wt_open_session /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/session/session_api.c:2721 (libwiredtiger.so.12.0.0+0x649eec)
      #4 __wt_open_internal_session /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/session/session_api.c:2755 (libwiredtiger.so.12.0.0+0x64b280)
      #5 __ckpt_server_start /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/checkpoint/checkpoint_conn.c:151 (libwiredtiger.so.12.0.0+0x29edb4)
      #6 __wt_checkpoint_server_create /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/checkpoint/checkpoint_conn.c:192 (libwiredtiger.so.12.0.0+0x29e574)
      #7 __wti_conn_reconfig /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_reconfig.c:482 (libwiredtiger.so.12.0.0+0x33c4e4)
      #8 __conn_reconfigure /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_api.c:1354 (libwiredtiger.so.12.0.0+0x2e07d8)
      #9 _wrap_Connection_reconfigure lang/python/CMakeFiles/wiredtiger_python.dir/wiredtigerPYTHON_wrap.c:8974 (_wiredtiger.so+0x29944)
      #10 cfunction_call ../src/Python-3.10.4/Objects/methodobject.c:552 (libpython3.10.so.1.0+0xd05e8) (BuildId: 044ec6e63ddfdd59fb20701554e6dcdefab05a90)
      Mutex M2 (0xffffa003f0e8) created at:
      #0 pthread_mutex_init <null> (libtsan.so.2+0x591b8) (BuildId: f3170e424285d8d8364a2a0f2222db9d15960c3f)
      #1 __wt_spin_init /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/include/mutex_inline.h:142 (libwiredtiger.so.12.0.0+0x3150ac)
      #2 __wti_connection_init /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_handle.c:50 (libwiredtiger.so.12.0.0+0x313e4c)
      #3 wiredtiger_open /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_api.c:3090 (libwiredtiger.so.12.0.0+0x2d764c)
      #4 _wrap_wiredtiger_open lang/python/CMakeFiles/wiredtiger_python.dir/wiredtigerPYTHON_wrap.c:10210 (_wiredtiger.so+0x2d630)
      #5 cfunction_call ../src/Python-3.10.4/Objects/methodobject.c:552 (libpython3.10.so.1.0+0xd05e8) (BuildId: 044ec6e63ddfdd59fb20701554e6dcdefab05a90)
      Mutex M3 (0xffffa0804170) created at:
      #0 pthread_mutex_init <null> (libtsan.so.2+0x591b8) (BuildId: f3170e424285d8d8364a2a0f2222db9d15960c3f)
      #1 __wt_spin_init /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/include/mutex_inline.h:142 (libwiredtiger.so.12.0.0+0x4f25a0)
      #2 __wt_logmgr_create /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log_mgr.c:1061 (libwiredtiger.so.12.0.0+0x4f2160)
      #3 __wti_connection_workers /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_open.c:242 (libwiredtiger.so.12.0.0+0x331350)
      #4 wiredtiger_open /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_api.c:3501 (libwiredtiger.so.12.0.0+0x2db434)
      #5 _wrap_wiredtiger_open lang/python/CMakeFiles/wiredtiger_python.dir/wiredtigerPYTHON_wrap.c:10210 (_wiredtiger.so+0x2d630)
      #6 cfunction_call ../src/Python-3.10.4/Objects/methodobject.c:552 (libpython3.10.so.1.0+0xd05e8) (BuildId: 044ec6e63ddfdd59fb20701554e6dcdefab05a90)
      Thread T43 'checkpoint-serv' (tid=385969, running) created by main thread at:
      #0 pthread_create <null> (libtsan.so.2+0x5a608) (BuildId: f3170e424285d8d8364a2a0f2222db9d15960c3f)
      #1 __wt_thread_create /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/os_posix/os_thread.c:60 (libwiredtiger.so.12.0.0+0x540288)
      #2 __ckpt_server_start /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/checkpoint/checkpoint_conn.c:160 (libwiredtiger.so.12.0.0+0x29eea0)
      #3 __wt_checkpoint_server_create /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/checkpoint/checkpoint_conn.c:192 (libwiredtiger.so.12.0.0+0x29e574)
      #4 __wti_conn_reconfig /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_reconfig.c:482 (libwiredtiger.so.12.0.0+0x33c4e4)
      #5 __conn_reconfigure /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/conn/conn_api.c:1354 (libwiredtiger.so.12.0.0+0x2e07d8)
      #6 _wrap_Connection_reconfigure lang/python/CMakeFiles/wiredtiger_python.dir/wiredtigerPYTHON_wrap.c:8974 (_wiredtiger.so+0x29944)
      #7 cfunction_call ../src/Python-3.10.4/Objects/methodobject.c:552 (libpython3.10.so.1.0+0xd05e8) (BuildId: 044ec6e63ddfdd59fb20701554e6dcdefab05a90)
      

      logs

      generate-tsan-metric task_log

      Logs:

      SUMMARY: ThreadSanitizer: data race /data/mci/8f8c9017370a4f9ff369af0550ca913b/wiredtiger/src/log/log.c:1250 in __log_newfile
      

      logs

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

              Created:
              Updated: