Closed Bug 1717547 Opened 4 years ago Closed 4 years ago

Intermittent SUMMARY: ThreadSanitizer: lock-order-inversion (potential deadlock) /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:96:3 in mutexLock

Categories

(Core :: IPC, defect, P5)

Product:
Core
Component:
IPC
Type:
defect

Tracking

()

Status:
RESOLVED FIXED
Tracking Flags:
Tracking Status
firefox-esr78 --- unaffected
firefox89 --- unaffected
firefox90 --- unaffected
firefox91 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: nika)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Filed by: abutkovits [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=343430751&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/TFCnp8VpQ5qVcHCtlCyrzw/runs/0/artifacts/public/logs/live_backing.log

[task 2021-06-21T22:35:14.478Z] 22:35:14     INFO - TEST-START | dom/base/test/browser_data_documents_aboutmemory.js
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) | ==================
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) | WARNING: ThreadSanitizer: lock-order-inversion (potential deadlock) (pid=2891)
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) |   Cycle in lock order graph: M619 (0x7b1c00019b40) => M622 (0x7b0c000033f0) => M619
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) |   Mutex M622 acquired here while holding mutex M619 in thread T2:
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) |     #0 pthread_mutex_lock /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/../sanitizer_common/sanitizer_common_interceptors.inc:4233:3 (firefox+0x755a6)
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) |     #1 mutexLock /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:96:3 (firefox+0x12cb2b)
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) |     #2 mozilla::detail::MutexImpl::lock() /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:118:43 (firefox+0x12cb2b)
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) |     #3 Lock /builds/worker/workspace/obj-build/dist/include/mozilla/Mutex.h:63:23 (libxul.so+0x159ba4c)
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) |     #4 Lock /builds/worker/workspace/obj-build/dist/include/mozilla/StaticMutex.h:38:26 (libxul.so+0x159ba4c)
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) |     #5 BaseAutoLock /builds/worker/workspace/obj-build/dist/include/mozilla/Mutex.h:158:57 (libxul.so+0x159ba4c)
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) |     #6 mozilla::ipc::ChannelCountReporter::Increment(char const*) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:529:25 (libxul.so+0x159ba4c)
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) |     #7 SetIsCrossProcess /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:2870:5 (libxul.so+0x159cb66)
[task 2021-06-21T22:35:16.601Z] 22:35:16     INFO - GECKO(2825) |     #8 mozilla::ipc::PortLink::OnPortStatusChanged() /builds/worker/checkouts/gecko/ipc/glue/MessageLink.cpp:185:12 (libxul.so+0x159cb66)
[task 2021-06-21T22:35:16.637Z] 22:35:16     INFO - GECKO(2825) |     #9 mozilla::ipc::PortLink::PortObserverThunk::OnPortStatusChanged() /builds/worker/checkouts/gecko/ipc/glue/MessageLink.cpp:60:14 (libxul.so+0x15aa5ff)
[task 2021-06-21T22:35:16.637Z] 22:35:16     INFO - GECKO(2825) |     #10 applyImpl<mozilla::ipc::PortLink::PortObserverThunk, void (mozilla::ipc::PortLink::PortObserverThunk::*)()> /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.h:1150:12 (libxul.so+0x15b3276)
[task 2021-06-21T22:35:16.637Z] 22:35:16     INFO - GECKO(2825) |     #11 apply<mozilla::ipc::PortLink::PortObserverThunk, void (mozilla::ipc::PortLink::PortObserverThunk::*)()> /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.h:1156:12 (libxul.so+0x15b3276)
[task 2021-06-21T22:35:16.638Z] 22:35:16     INFO - GECKO(2825) |     #12 mozilla::detail::RunnableMethodImpl<RefPtr<mozilla::ipc::PortLink::PortObserverThunk>, void (mozilla::ipc::PortLink::PortObserverThunk::*)(), true, (mozilla::RunnableKind)0>::Run() /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.h:1203:13 (libxul.so+0x15b3276)
[task 2021-06-21T22:35:16.638Z] 22:35:16     INFO - GECKO(2825) |     #13 MessageLoop::RunTask(already_AddRefed<nsIRunnable>) /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:454:11 (libxul.so+0x1517186)
[task 2021-06-21T22:35:16.638Z] 22:35:16     INFO - GECKO(2825) |     #14 DeferOrRunPendingTask /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:463:5 (libxul.so+0x15185c7)
[task 2021-06-21T22:35:16.638Z] 22:35:16     INFO - GECKO(2825) |     #15 MessageLoop::DoWork() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:538:13 (libxul.so+0x15185c7)
[task 2021-06-21T22:35:16.638Z] 22:35:16     INFO - GECKO(2825) |     #16 base::MessagePumpLibevent::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_pump_libevent.cc:329:31 (libxul.so+0x151a090)
[task 2021-06-21T22:35:16.638Z] 22:35:16     INFO - GECKO(2825) |     #17 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.638Z] 22:35:16     INFO - GECKO(2825) |     #18 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.638Z] 22:35:16     INFO - GECKO(2825) |     #19 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.638Z] 22:35:16     INFO - GECKO(2825) |     #20 base::Thread::ThreadMain() /builds/worker/checkouts/gecko/ipc/chromium/src/base/thread.cc:187:16 (libxul.so+0x1528536)
[task 2021-06-21T22:35:16.639Z] 22:35:16     INFO - GECKO(2825) |     #21 ThreadFunc(void*) /builds/worker/checkouts/gecko/ipc/chromium/src/base/platform_thread_posix.cc:40:13 (libxul.so+0x1521c7e)
[task 2021-06-21T22:35:16.639Z] 22:35:16     INFO - GECKO(2825) |     Hint: use TSAN_OPTIONS=second_deadlock_stack=1 to get more informative warning message
[task 2021-06-21T22:35:16.639Z] 22:35:16     INFO - GECKO(2825) |   Mutex M619 acquired here while holding mutex M622 in main thread:
[task 2021-06-21T22:35:16.639Z] 22:35:16     INFO - GECKO(2825) |     #0 pthread_mutex_lock /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/../sanitizer_common/sanitizer_common_interceptors.inc:4233:3 (firefox+0x755a6)
[task 2021-06-21T22:35:16.639Z] 22:35:16     INFO - GECKO(2825) |     #1 mutexLock /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:96:3 (firefox+0x12cb2b)
[task 2021-06-21T22:35:16.640Z] 22:35:16     INFO - GECKO(2825) |     #2 mozilla::detail::MutexImpl::lock() /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:118:43 (firefox+0x12cb2b)
[task 2021-06-21T22:35:16.640Z] 22:35:16     INFO - GECKO(2825) |     #3 Lock /builds/worker/workspace/obj-build/dist/include/mozilla/Mutex.h:63:23 (libxul.so+0x1590855)
[task 2021-06-21T22:35:16.641Z] 22:35:16     INFO - GECKO(2825) |     #4 Lock /builds/worker/workspace/obj-build/dist/include/mozilla/Monitor.h:31:24 (libxul.so+0x1590855)
[task 2021-06-21T22:35:16.643Z] 22:35:16     INFO - GECKO(2825) |     #5 MonitorAutoLock /builds/worker/workspace/obj-build/dist/include/mozilla/Monitor.h:66:15 (libxul.so+0x1590855)
[task 2021-06-21T22:35:16.645Z] 22:35:16     INFO - GECKO(2825) |     #6 mozilla::ipc::MessageChannel::Send(mozilla::UniquePtr<IPC::Message, mozilla::DefaultDelete<IPC::Message> >) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:891:19 (libxul.so+0x1590855)
[task 2021-06-21T22:35:16.646Z] 22:35:16     INFO - GECKO(2825) |     #7 mozilla::ipc::IProtocol::ChannelSend(IPC::Message*) /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:523:22 (libxul.so+0x15b7f66)
[task 2021-06-21T22:35:16.646Z] 22:35:16     INFO - GECKO(2825) |     #8 mozilla::dom::PContentChild::SendAddMemoryReport(mozilla::dom::MemoryReport const&) /builds/worker/workspace/obj-build/ipc/ipdl/PContentChild.cpp:6011:21 (libxul.so+0x16bb54d)
[task 2021-06-21T22:35:16.653Z] 22:35:16     INFO - GECKO(2825) |     #9 operator() /builds/worker/checkouts/gecko/dom/ipc/ContentChild.cpp:1346:35 (libxul.so+0x47d2e18)
[task 2021-06-21T22:35:16.659Z] 22:35:16     INFO - GECKO(2825) |     #10 std::_Function_handler<void (mozilla::dom::MemoryReport const&), mozilla::dom::ContentChild::RecvRequestMemoryReport(unsigned int const&, bool const&, bool const&, mozilla::Maybe<mozilla::ipc::FileDescriptor> const&, std::function<void (unsigned int const&)> const&)::$_9>::_M_invoke(std::_Any_data const&, mozilla::dom::MemoryReport const&) /builds/worker/fetches/clang/bin/../lib/gcc/x86_64-unknown-linux-gnu/7.5.0/../../../../include/c++/7.5.0/bits/std_function.h:316:2 (libxul.so+0x47d2e18)
[task 2021-06-21T22:35:16.661Z] 22:35:16     INFO - GECKO(2825) |     #11 operator() /builds/worker/fetches/clang/bin/../lib/gcc/x86_64-unknown-linux-gnu/7.5.0/../../../../include/c++/7.5.0/bits/std_function.h:706:14 (libxul.so+0x485a13a)
[task 2021-06-21T22:35:16.662Z] 22:35:16     INFO - GECKO(2825) |     #12 mozilla::dom::HandleReportCallback::Callback(nsTSubstring<char> const&, nsTSubstring<char> const&, int, int, long, nsTSubstring<char> const&, nsISupports*) /builds/worker/checkouts/gecko/dom/ipc/MemoryReportRequest.cpp:113:5 (libxul.so+0x485a13a)
[task 2021-06-21T22:35:16.662Z] 22:35:16     INFO - GECKO(2825) |     #13 mozilla::ipc::ChannelCountReporter::CollectReports(nsIHandleReportCallback*, nsISupports*, bool) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:520:22 (libxul.so+0x15a7198)
[task 2021-06-21T22:35:16.663Z] 22:35:16     INFO - GECKO(2825) |     #14 operator() /builds/worker/checkouts/gecko/xpcom/base/nsMemoryReporterManager.cpp:1844:19 (libxul.so+0xbddc91)
[task 2021-06-21T22:35:16.664Z] 22:35:16     INFO - GECKO(2825) |     #15 mozilla::detail::RunnableFunction<nsMemoryReporterManager::DispatchReporter(nsIMemoryReporter*, bool, nsIHandleReportCallback*, nsISupports*, bool)::$_0>::Run() /builds/worker/workspace/obj-build/dist/include/nsThreadUtils.h:534:5 (libxul.so+0xbddc91)
[task 2021-06-21T22:35:16.665Z] 22:35:16     INFO - GECKO(2825) |     #16 mozilla::RunnableTask::Run() /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:502:16 (libxul.so+0xca6907)
[task 2021-06-21T22:35:16.666Z] 22:35:16     INFO - GECKO(2825) |     #17 mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:805:26 (libxul.so+0xc8396a)
[task 2021-06-21T22:35:16.667Z] 22:35:16     INFO - GECKO(2825) |     #18 mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:641:15 (libxul.so+0xc81fc6)
[task 2021-06-21T22:35:16.668Z] 22:35:16     INFO - GECKO(2825) |     #19 mozilla::TaskController::ProcessPendingMTTask(bool) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:425:36 (libxul.so+0xc82294)
[task 2021-06-21T22:35:16.673Z] 22:35:16     INFO - GECKO(2825) |     #20 operator() /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:135:37 (libxul.so+0xcaa7f7)
[task 2021-06-21T22:35:16.679Z] 22:35:16     INFO - GECKO(2825) |     #21 mozilla::detail::RunnableFunction<mozilla::TaskController::InitializeInternal()::$_0>::Run() /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.h:534:5 (libxul.so+0xcaa7f7)
[task 2021-06-21T22:35:16.679Z] 22:35:16     INFO - GECKO(2825) |     #22 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1152:16 (libxul.so+0xc944d0)
[task 2021-06-21T22:35:16.680Z] 22:35:16     INFO - GECKO(2825) |     #23 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:548:10 (libxul.so+0xc9b432)
[task 2021-06-21T22:35:16.681Z] 22:35:16     INFO - GECKO(2825) |     #24 mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:85:21 (libxul.so+0x159d52d)
[task 2021-06-21T22:35:16.681Z] 22:35:16     INFO - GECKO(2825) |     #25 mozilla::ipc::MessagePumpForChildProcess::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:268:30 (libxul.so+0x159dfcb)
[task 2021-06-21T22:35:16.682Z] 22:35:16     INFO - GECKO(2825) |     #26 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.682Z] 22:35:16     INFO - GECKO(2825) |     #27 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.683Z] 22:35:16     INFO - GECKO(2825) |     #28 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.684Z] 22:35:16     INFO - GECKO(2825) |     #29 nsBaseAppShell::Run() /builds/worker/checkouts/gecko/widget/nsBaseAppShell.cpp:137:27 (libxul.so+0x4c90626)
[task 2021-06-21T22:35:16.684Z] 22:35:16     INFO - GECKO(2825) |     #30 XRE_RunAppShell() /builds/worker/checkouts/gecko/toolkit/xre/nsEmbedFunctions.cpp:910:20 (libxul.so+0x6b04199)
[task 2021-06-21T22:35:16.688Z] 22:35:16     INFO - GECKO(2825) |     #31 mozilla::ipc::MessagePumpForChildProcess::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:235:9 (libxul.so+0x159df7d)
[task 2021-06-21T22:35:16.689Z] 22:35:16     INFO - GECKO(2825) |     #32 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.692Z] 22:35:16     INFO - GECKO(2825) |     #33 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.692Z] 22:35:16     INFO - GECKO(2825) |     #34 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.693Z] 22:35:16     INFO - GECKO(2825) |     #35 XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/nsEmbedFunctions.cpp:742:34 (libxul.so+0x6b03f19)
[task 2021-06-21T22:35:16.694Z] 22:35:16     INFO - GECKO(2825) |     #36 mozilla::BootstrapImpl::XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:67:12 (libxul.so+0x6b0bf42)
[task 2021-06-21T22:35:16.701Z] 22:35:16     INFO - GECKO(2825) |     #37 content_process_main /builds/worker/checkouts/gecko/browser/app/../../ipc/contentproc/plugin-container.cpp:57:28 (firefox+0xca371)
[task 2021-06-21T22:35:16.702Z] 22:35:16     INFO - GECKO(2825) |     #38 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:327:18 (firefox+0xca371)
[task 2021-06-21T22:35:16.702Z] 22:35:16     INFO - GECKO(2825) |   Thread T2 'IPC I/O Child' (tid=2896, running) created by main thread at:
[task 2021-06-21T22:35:16.706Z] 22:35:16     INFO - GECKO(2825) |     #0 pthread_create /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors_posix.cpp:965:3 (firefox+0x577eb)
[task 2021-06-21T22:35:16.707Z] 22:35:16     INFO - GECKO(2825) |     #1 CreateThread /builds/worker/checkouts/gecko/ipc/chromium/src/base/platform_thread_posix.cc:123:14 (libxul.so+0x151ebe7)
[task 2021-06-21T22:35:16.708Z] 22:35:16     INFO - GECKO(2825) |     #2 PlatformThread::Create(unsigned long, PlatformThread::Delegate*, unsigned long*) /builds/worker/checkouts/gecko/ipc/chromium/src/base/platform_thread_posix.cc:134:10 (libxul.so+0x151ebe7)
[task 2021-06-21T22:35:16.708Z] 22:35:16     INFO - GECKO(2825) |     #3 base::Thread::StartWithOptions(base::Thread::Options const&) /builds/worker/checkouts/gecko/ipc/chromium/src/base/thread.cc:93:8 (libxul.so+0x15280f1)
[task 2021-06-21T22:35:16.709Z] 22:35:16     INFO - GECKO(2825) |     #4 Run /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/child_thread.cc:23:12 (libxul.so+0x152909e)
[task 2021-06-21T22:35:16.709Z] 22:35:16     INFO - GECKO(2825) |     #5 ChildProcess::ChildProcess(ChildThread*) /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/child_process.cc:20:20 (libxul.so+0x152909e)
[task 2021-06-21T22:35:16.710Z] 22:35:16     INFO - GECKO(2825) |     #6 mozilla::ipc::ProcessChild::ProcessChild(int) /builds/worker/checkouts/gecko/ipc/glue/ProcessChild.cpp:28:7 (libxul.so+0x15a59e0)
[task 2021-06-21T22:35:16.711Z] 22:35:16     INFO - GECKO(2825) |     #7 ContentProcess /builds/worker/workspace/obj-build/dist/include/mozilla/dom/ContentProcess.h:29:51 (libxul.so+0x6b03e14)
[task 2021-06-21T22:35:16.712Z] 22:35:16     INFO - GECKO(2825) |     #8 MakeUnique<mozilla::dom::ContentProcess, int &> /builds/worker/workspace/obj-build/dist/include/mozilla/UniquePtr.h:609:27 (libxul.so+0x6b03e14)
[task 2021-06-21T22:35:16.713Z] 22:35:16     INFO - GECKO(2825) |     #9 XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/nsEmbedFunctions.cpp:661:21 (libxul.so+0x6b03e14)
[task 2021-06-21T22:35:16.723Z] 22:35:16     INFO - GECKO(2825) |     #10 mozilla::BootstrapImpl::XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:67:12 (libxul.so+0x6b0bf42)
[task 2021-06-21T22:35:16.724Z] 22:35:16     INFO - GECKO(2825) |     #11 content_process_main /builds/worker/checkouts/gecko/browser/app/../../ipc/contentproc/plugin-container.cpp:57:28 (firefox+0xca371)
[task 2021-06-21T22:35:16.725Z] 22:35:16     INFO - GECKO(2825) |     #12 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:327:18 (firefox+0xca371)
[task 2021-06-21T22:35:16.726Z] 22:35:16     INFO - GECKO(2825) | SUMMARY: ThreadSanitizer: lock-order-inversion (potential deadlock) /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:96:3 in mutexLock
[task 2021-06-21T22:35:16.727Z] 22:35:16     INFO - GECKO(2825) | ==================
[task 2021-06-21T22:35:16.730Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.730Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.734Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.735Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.735Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.736Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.736Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.737Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.737Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.738Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.738Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.738Z] 22:35:16     INFO - GECKO(2825) | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-06-21T22:35:16.796Z] 22:35:16     INFO - GECKO(2825) | ==================
[task 2021-06-21T22:35:16.797Z] 22:35:16     INFO - GECKO(2825) | WARNING: ThreadSanitizer: lock-order-inversion (potential deadlock) (pid=3058)
[task 2021-06-21T22:35:16.798Z] 22:35:16     INFO - GECKO(2825) |   Cycle in lock order graph: M754 (0x7b1c00019b40) => M757 (0x7b0c00003390) => M754
[task 2021-06-21T22:35:16.799Z] 22:35:16     INFO - GECKO(2825) |   Mutex M757 acquired here while holding mutex M754 in thread T2:
[task 2021-06-21T22:35:16.800Z] 22:35:16     INFO - GECKO(2825) |     #0 pthread_mutex_lock /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/../sanitizer_common/sanitizer_common_interceptors.inc:4233:3 (firefox+0x755a6)
[task 2021-06-21T22:35:16.801Z] 22:35:16     INFO - GECKO(2825) |     #1 mutexLock /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:96:3 (firefox+0x12cb2b)
[task 2021-06-21T22:35:16.810Z] 22:35:16     INFO - GECKO(2825) |     #2 mozilla::detail::MutexImpl::lock() /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:118:43 (firefox+0x12cb2b)
[task 2021-06-21T22:35:16.811Z] 22:35:16     INFO - GECKO(2825) |     #3 Lock /builds/worker/workspace/obj-build/dist/include/mozilla/Mutex.h:63:23 (libxul.so+0x159ba4c)
[task 2021-06-21T22:35:16.812Z] 22:35:16     INFO - GECKO(2825) |     #4 Lock /builds/worker/workspace/obj-build/dist/include/mozilla/StaticMutex.h:38:26 (libxul.so+0x159ba4c)
[task 2021-06-21T22:35:16.813Z] 22:35:16     INFO - GECKO(2825) |     #5 BaseAutoLock /builds/worker/workspace/obj-build/dist/include/mozilla/Mutex.h:158:57 (libxul.so+0x159ba4c)
[task 2021-06-21T22:35:16.814Z] 22:35:16     INFO - GECKO(2825) |     #6 mozilla::ipc::ChannelCountReporter::Increment(char const*) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:529:25 (libxul.so+0x159ba4c)
[task 2021-06-21T22:35:16.825Z] 22:35:16     INFO - GECKO(2825) |     #7 SetIsCrossProcess /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:2870:5 (libxul.so+0x159cb66)
[task 2021-06-21T22:35:16.827Z] 22:35:16     INFO - GECKO(2825) |     #8 mozilla::ipc::PortLink::OnPortStatusChanged() /builds/worker/checkouts/gecko/ipc/glue/MessageLink.cpp:185:12 (libxul.so+0x159cb66)
[task 2021-06-21T22:35:16.827Z] 22:35:16     INFO - GECKO(2825) |     #9 mozilla::ipc::PortLink::PortObserverThunk::OnPortStatusChanged() /builds/worker/checkouts/gecko/ipc/glue/MessageLink.cpp:60:14 (libxul.so+0x15aa5ff)
[task 2021-06-21T22:35:16.830Z] 22:35:16     INFO - GECKO(2825) |     #10 applyImpl<mozilla::ipc::PortLink::PortObserverThunk, void (mozilla::ipc::PortLink::PortObserverThunk::*)()> /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.h:1150:12 (libxul.so+0x15b3276)
[task 2021-06-21T22:35:16.831Z] 22:35:16     INFO - GECKO(2825) |     #11 apply<mozilla::ipc::PortLink::PortObserverThunk, void (mozilla::ipc::PortLink::PortObserverThunk::*)()> /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.h:1156:12 (libxul.so+0x15b3276)
[task 2021-06-21T22:35:16.833Z] 22:35:16     INFO - GECKO(2825) |     #12 mozilla::detail::RunnableMethodImpl<RefPtr<mozilla::ipc::PortLink::PortObserverThunk>, void (mozilla::ipc::PortLink::PortObserverThunk::*)(), true, (mozilla::RunnableKind)0>::Run() /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.h:1203:13 (libxul.so+0x15b3276)
[task 2021-06-21T22:35:16.837Z] 22:35:16     INFO - GECKO(2825) |     #13 MessageLoop::RunTask(already_AddRefed<nsIRunnable>) /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:454:11 (libxul.so+0x1517186)
[task 2021-06-21T22:35:16.838Z] 22:35:16     INFO - GECKO(2825) |     #14 DeferOrRunPendingTask /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:463:5 (libxul.so+0x15185c7)
[task 2021-06-21T22:35:16.838Z] 22:35:16     INFO - GECKO(2825) |     #15 MessageLoop::DoWork() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:538:13 (libxul.so+0x15185c7)
[task 2021-06-21T22:35:16.838Z] 22:35:16     INFO - GECKO(2825) |     #16 base::MessagePumpLibevent::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_pump_libevent.cc:329:31 (libxul.so+0x151a090)
[task 2021-06-21T22:35:16.838Z] 22:35:16     INFO - GECKO(2825) |     #17 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.838Z] 22:35:16     INFO - GECKO(2825) |     #18 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.838Z] 22:35:16     INFO - GECKO(2825) |     #19 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.838Z] 22:35:16     INFO - GECKO(2825) |     #20 base::Thread::ThreadMain() /builds/worker/checkouts/gecko/ipc/chromium/src/base/thread.cc:187:16 (libxul.so+0x1528536)
[task 2021-06-21T22:35:16.838Z] 22:35:16     INFO - GECKO(2825) |     #21 ThreadFunc(void*) /builds/worker/checkouts/gecko/ipc/chromium/src/base/platform_thread_posix.cc:40:13 (libxul.so+0x1521c7e)
[task 2021-06-21T22:35:16.842Z] 22:35:16     INFO - GECKO(2825) |     Hint: use TSAN_OPTIONS=second_deadlock_stack=1 to get more informative warning message
[task 2021-06-21T22:35:16.843Z] 22:35:16     INFO - GECKO(2825) |   Mutex M754 acquired here while holding mutex M757 in main thread:
[task 2021-06-21T22:35:16.843Z] 22:35:16     INFO - GECKO(2825) |     #0 pthread_mutex_lock /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/../sanitizer_common/sanitizer_common_interceptors.inc:4233:3 (firefox+0x755a6)
[task 2021-06-21T22:35:16.847Z] 22:35:16     INFO - GECKO(2825) |     #1 mutexLock /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:96:3 (firefox+0x12cb2b)
[task 2021-06-21T22:35:16.847Z] 22:35:16     INFO - GECKO(2825) |     #2 mozilla::detail::MutexImpl::lock() /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:118:43 (firefox+0x12cb2b)
[task 2021-06-21T22:35:16.848Z] 22:35:16     INFO - GECKO(2825) |     #3 Lock /builds/worker/workspace/obj-build/dist/include/mozilla/Mutex.h:63:23 (libxul.so+0x1590855)
[task 2021-06-21T22:35:16.849Z] 22:35:16     INFO - GECKO(2825) |     #4 Lock /builds/worker/workspace/obj-build/dist/include/mozilla/Monitor.h:31:24 (libxul.so+0x1590855)
[task 2021-06-21T22:35:16.852Z] 22:35:16     INFO - GECKO(2825) |     #5 MonitorAutoLock /builds/worker/workspace/obj-build/dist/include/mozilla/Monitor.h:66:15 (libxul.so+0x1590855)
[task 2021-06-21T22:35:16.853Z] 22:35:16     INFO - GECKO(2825) |     #6 mozilla::ipc::MessageChannel::Send(mozilla::UniquePtr<IPC::Message, mozilla::DefaultDelete<IPC::Message> >) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:891:19 (libxul.so+0x1590855)
[task 2021-06-21T22:35:16.854Z] 22:35:16     INFO - GECKO(2825) |     #7 mozilla::ipc::IProtocol::ChannelSend(IPC::Message*) /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:523:22 (libxul.so+0x15b7f66)
[task 2021-06-21T22:35:16.854Z] 22:35:16     INFO - GECKO(2825) |     #8 mozilla::dom::PContentChild::SendAddMemoryReport(mozilla::dom::MemoryReport const&) /builds/worker/workspace/obj-build/ipc/ipdl/PContentChild.cpp:6011:21 (libxul.so+0x16bb54d)
[task 2021-06-21T22:35:16.855Z] 22:35:16     INFO - GECKO(2825) |     #9 operator() /builds/worker/checkouts/gecko/dom/ipc/ContentChild.cpp:1346:35 (libxul.so+0x47d2e18)
[task 2021-06-21T22:35:16.861Z] 22:35:16     INFO - GECKO(2825) |     #10 std::_Function_handler<void (mozilla::dom::MemoryReport const&), mozilla::dom::ContentChild::RecvRequestMemoryReport(unsigned int const&, bool const&, bool const&, mozilla::Maybe<mozilla::ipc::FileDescriptor> const&, std::function<void (unsigned int const&)> const&)::$_9>::_M_invoke(std::_Any_data const&, mozilla::dom::MemoryReport const&) /builds/worker/fetches/clang/bin/../lib/gcc/x86_64-unknown-linux-gnu/7.5.0/../../../../include/c++/7.5.0/bits/std_function.h:316:2 (libxul.so+0x47d2e18)
[task 2021-06-21T22:35:16.862Z] 22:35:16     INFO - GECKO(2825) |     #11 operator() /builds/worker/fetches/clang/bin/../lib/gcc/x86_64-unknown-linux-gnu/7.5.0/../../../../include/c++/7.5.0/bits/std_function.h:706:14 (libxul.so+0x485a13a)
[task 2021-06-21T22:35:16.863Z] 22:35:16     INFO - GECKO(2825) |     #12 mozilla::dom::HandleReportCallback::Callback(nsTSubstring<char> const&, nsTSubstring<char> const&, int, int, long, nsTSubstring<char> const&, nsISupports*) /builds/worker/checkouts/gecko/dom/ipc/MemoryReportRequest.cpp:113:5 (libxul.so+0x485a13a)
[task 2021-06-21T22:35:16.864Z] 22:35:16     INFO - GECKO(2825) |     #13 mozilla::ipc::ChannelCountReporter::CollectReports(nsIHandleReportCallback*, nsISupports*, bool) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:520:22 (libxul.so+0x15a7198)
[task 2021-06-21T22:35:16.864Z] 22:35:16     INFO - GECKO(2825) |     #14 operator() /builds/worker/checkouts/gecko/xpcom/base/nsMemoryReporterManager.cpp:1844:19 (libxul.so+0xbddc91)
[task 2021-06-21T22:35:16.865Z] 22:35:16     INFO - GECKO(2825) |     #15 mozilla::detail::RunnableFunction<nsMemoryReporterManager::DispatchReporter(nsIMemoryReporter*, bool, nsIHandleReportCallback*, nsISupports*, bool)::$_0>::Run() /builds/worker/workspace/obj-build/dist/include/nsThreadUtils.h:534:5 (libxul.so+0xbddc91)
[task 2021-06-21T22:35:16.866Z] 22:35:16     INFO - GECKO(2825) |     #16 mozilla::RunnableTask::Run() /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:502:16 (libxul.so+0xca6907)
[task 2021-06-21T22:35:16.867Z] 22:35:16     INFO - GECKO(2825) |     #17 mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:805:26 (libxul.so+0xc8396a)
[task 2021-06-21T22:35:16.868Z] 22:35:16     INFO - GECKO(2825) |     #18 mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:641:15 (libxul.so+0xc81fc6)
[task 2021-06-21T22:35:16.869Z] 22:35:16     INFO - GECKO(2825) |     #19 mozilla::TaskController::ProcessPendingMTTask(bool) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:425:36 (libxul.so+0xc82294)
[task 2021-06-21T22:35:16.870Z] 22:35:16     INFO - GECKO(2825) |     #20 operator() /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:135:37 (libxul.so+0xcaa7f7)
[task 2021-06-21T22:35:16.870Z] 22:35:16     INFO - GECKO(2825) |     #21 mozilla::detail::RunnableFunction<mozilla::TaskController::InitializeInternal()::$_0>::Run() /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.h:534:5 (libxul.so+0xcaa7f7)
[task 2021-06-21T22:35:16.871Z] 22:35:16     INFO - GECKO(2825) |     #22 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1152:16 (libxul.so+0xc944d0)
[task 2021-06-21T22:35:16.872Z] 22:35:16     INFO - GECKO(2825) |     #23 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:548:10 (libxul.so+0xc9b432)
[task 2021-06-21T22:35:16.873Z] 22:35:16     INFO - GECKO(2825) |     #24 mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:85:21 (libxul.so+0x159d52d)
[task 2021-06-21T22:35:16.873Z] 22:35:16     INFO - GECKO(2825) |     #25 mozilla::ipc::MessagePumpForChildProcess::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:268:30 (libxul.so+0x159dfcb)
[task 2021-06-21T22:35:16.874Z] 22:35:16     INFO - GECKO(2825) |     #26 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.875Z] 22:35:16     INFO - GECKO(2825) |     #27 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.876Z] 22:35:16     INFO - GECKO(2825) |     #28 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.877Z] 22:35:16     INFO - GECKO(2825) |     #29 nsBaseAppShell::Run() /builds/worker/checkouts/gecko/widget/nsBaseAppShell.cpp:137:27 (libxul.so+0x4c90626)
[task 2021-06-21T22:35:16.877Z] 22:35:16     INFO - GECKO(2825) |     #30 XRE_RunAppShell() /builds/worker/checkouts/gecko/toolkit/xre/nsEmbedFunctions.cpp:910:20 (libxul.so+0x6b04199)
[task 2021-06-21T22:35:16.878Z] 22:35:16     INFO - GECKO(2825) |     #31 mozilla::ipc::MessagePumpForChildProcess::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:235:9 (libxul.so+0x159df7d)
[task 2021-06-21T22:35:16.879Z] 22:35:16     INFO - GECKO(2825) |     #32 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.879Z] 22:35:16     INFO - GECKO(2825) |     #33 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.880Z] 22:35:16     INFO - GECKO(2825) |     #34 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x1516e3c)
[task 2021-06-21T22:35:16.881Z] 22:35:16     INFO - GECKO(2825) |     #35 XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/nsEmbedFunctions.cpp:742:34 (libxul.so+0x6b03f19)
[task 2021-06-21T22:35:16.882Z] 22:35:16     INFO - GECKO(2825) |     #36 mozilla::BootstrapImpl::XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:67:12 (libxul.so+0x6b0bf42)
[task 2021-06-21T22:35:16.883Z] 22:35:16     INFO - GECKO(2825) |     #37 content_process_main /builds/worker/checkouts/gecko/browser/app/../../ipc/contentproc/plugin-container.cpp:57:28 (firefox+0xca371)
[task 2021-06-21T22:35:16.884Z] 22:35:16     INFO - GECKO(2825) |     #38 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:327:18 (firefox+0xca371)
[task 2021-06-21T22:35:16.884Z] 22:35:16     INFO - GECKO(2825) |   Thread T2 'IPC I/O Child' (tid=3061, running) created by main thread at:
[task 2021-06-21T22:35:16.885Z] 22:35:16     INFO - GECKO(2825) |     #0 pthread_create /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors_posix.cpp:965:3 (firefox+0x577eb)
[task 2021-06-21T22:35:16.886Z] 22:35:16     INFO - GECKO(2825) |     #1 CreateThread /builds/worker/checkouts/gecko/ipc/chromium/src/base/platform_thread_posix.cc:123:14 (libxul.so+0x151ebe7)
[task 2021-06-21T22:35:16.887Z] 22:35:16     INFO - GECKO(2825) |     #2 PlatformThread::Create(unsigned long, PlatformThread::Delegate*, unsigned long*) /builds/worker/checkouts/gecko/ipc/chromium/src/base/platform_thread_posix.cc:134:10 (libxul.so+0x151ebe7)
[task 2021-06-21T22:35:16.888Z] 22:35:16     INFO - GECKO(2825) |     #3 base::Thread::StartWithOptions(base::Thread::Options const&) /builds/worker/checkouts/gecko/ipc/chromium/src/base/thread.cc:93:8 (libxul.so+0x15280f1)
[task 2021-06-21T22:35:16.888Z] 22:35:16     INFO - GECKO(2825) |     #4 Run /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/child_thread.cc:23:12 (libxul.so+0x152909e)
[task 2021-06-21T22:35:16.889Z] 22:35:16     INFO - GECKO(2825) |     #5 ChildProcess::ChildProcess(ChildThread*) /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/child_process.cc:20:20 (libxul.so+0x152909e)
[task 2021-06-21T22:35:16.890Z] 22:35:16     INFO - GECKO(2825) |     #6 mozilla::ipc::ProcessChild::ProcessChild(int) /builds/worker/checkouts/gecko/ipc/glue/ProcessChild.cpp:28:7 (libxul.so+0x15a59e0)
[task 2021-06-21T22:35:16.890Z] 22:35:16     INFO - GECKO(2825) |     #7 ContentProcess /builds/worker/workspace/obj-build/dist/include/mozilla/dom/ContentProcess.h:29:51 (libxul.so+0x6b03e14)
[task 2021-06-21T22:35:16.891Z] 22:35:16     INFO - GECKO(2825) |     #8 MakeUnique<mozilla::dom::ContentProcess, int &> /builds/worker/workspace/obj-build/dist/include/mozilla/UniquePtr.h:609:27 (libxul.so+0x6b03e14)
[task 2021-06-21T22:35:16.892Z] 22:35:16     INFO - GECKO(2825) |     #9 XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/nsEmbedFunctions.cpp:661:21 (libxul.so+0x6b03e14)
[task 2021-06-21T22:35:16.893Z] 22:35:16     INFO - GECKO(2825) |     #10 mozilla::BootstrapImpl::XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:67:12 (libxul.so+0x6b0bf42)
[task 2021-06-21T22:35:16.894Z] 22:35:16     INFO - GECKO(2825) |     #11 content_process_main /builds/worker/checkouts/gecko/browser/app/../../ipc/contentproc/plugin-container.cpp:57:28 (firefox+0xca371)
[task 2021-06-21T22:35:16.894Z] 22:35:16     INFO - GECKO(2825) |     #12 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:327:18 (firefox+0xca371)
[task 2021-06-21T22:35:16.895Z] 22:35:16     INFO - GECKO(2825) | SUMMARY: ThreadSanitizer: lock-order-inversion (potential deadlock) /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:96:3 in mutexLock
[task 2021-06-21T22:35:16.896Z] 22:35:16     INFO - GECKO(2825) | ==================

Thanks for catching this! It looks like we're holding the sChannelCountMutex when we're calling back into the nsIHandleReportCallback when collecting memory reports here: https://searchfox.org/mozilla-central/rev/c114db74a92cf15096dfda02255e125949b0e070/ipc/glue/MessageChannel.cpp#518-521, which could potentially lead to a deadlock. We should probably instead collect these values into an array and release the mutex before doing the callbacks here.

Component: mozglue → IPC

Set release status flags based on info from the regressing bug 1706374

status-firefox89: --- → unaffected
status-firefox90: --- → unaffected
status-firefox91: --- → affected
status-firefox-esr78: --- → unaffected

This was fixed by the new part 6 patch of bug 1713148 in the second landing.

Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → FIXED
Assignee: nobody → nika
status-firefox91: affected → fixed
Has Regression Range: --- → yes
You need to log in before you can comment on or make changes to this bug.