Closed Bug 1752963 Opened 4 years ago Closed 4 years ago

Intermittent SUMMARY: ThreadSanitizer: use of an invalid mutex (e.g. uninitialized or destroyed) /builds/worker/checkouts/gecko/xpcom/threads/RecursiveMutex.cpp:71:3 in mozilla::RecursiveMutex::LockInternal()

Categories

(Core :: XPCOM, defect, P5)

defect

Tracking

()

RESOLVED DUPLICATE of bug 1752959

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression)

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


[task 2022-02-01T03:53:32.196Z] 03:53:32     INFO - TEST-START | dom/media/webrtc/tests/mochitests/test_peerConnection_verifyVideoAfterRenegotiation.html
[task 2022-02-01T03:53:32.529Z] 03:53:32     INFO - GECKO(7204) | Timecard created 1643687610.508093
[task 2022-02-01T03:53:32.533Z] 03:53:32     INFO - GECKO(7204) |  Timestamp   | Delta       | Event                          | File                         | Function
[task 2022-02-01T03:53:32.533Z] 03:53:32     INFO - GECKO(7204) | ======================================================================================================================
[task 2022-02-01T03:53:32.533Z] 03:53:32     INFO - GECKO(7204) |     0.000189 |    0.000189 | Constructor Completed          | PeerConnectionImpl.cpp:333   | PeerConnectionImpl
[task 2022-02-01T03:53:32.533Z] 03:53:32     INFO - GECKO(7204) |     0.001984 |    0.001795 | Initializing PC Ctx            | PeerConnectionImpl.cpp:452   | Initialize
[task 2022-02-01T03:53:32.533Z] 03:53:32     INFO - GECKO(7204) |     1.101920 |    1.099936 | Set Remote Description         | PeerConnectionImpl.cpp:1385  | SetRemoteDescription
[task 2022-02-01T03:53:32.533Z] 03:53:32     INFO - GECKO(7204) |     1.198918 |    0.096998 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.533Z] 03:53:32     INFO - GECKO(7204) |     1.206760 |    0.007842 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.533Z] 03:53:32     INFO - GECKO(7204) |     1.207979 |    0.001219 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.533Z] 03:53:32     INFO - GECKO(7204) |     1.209262 |    0.001283 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.534Z] 03:53:32     INFO - GECKO(7204) |     1.211315 |    0.002053 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.534Z] 03:53:32     INFO - GECKO(7204) |     1.212505 |    0.001190 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.536Z] 03:53:32     INFO - GECKO(7204) |     1.213650 |    0.001145 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.536Z] 03:53:32     INFO - GECKO(7204) |     1.214874 |    0.001224 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.536Z] 03:53:32     INFO - GECKO(7204) |     1.216447 |    0.001573 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.536Z] 03:53:32     INFO - GECKO(7204) |     1.217615 |    0.001168 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.536Z] 03:53:32     INFO - GECKO(7204) |     1.218969 |    0.001354 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.536Z] 03:53:32     INFO - GECKO(7204) |     1.220103 |    0.001134 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.537Z] 03:53:32     INFO - GECKO(7204) |     1.221167 |    0.001064 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.538Z] 03:53:32     INFO - GECKO(7204) |     1.222216 |    0.001049 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.539Z] 03:53:32     INFO - GECKO(7204) |     1.223263 |    0.001047 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.539Z] 03:53:32     INFO - GECKO(7204) |     1.224370 |    0.001107 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.539Z] 03:53:32     INFO - GECKO(7204) |     1.225427 |    0.001057 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.544Z] 03:53:32     INFO - GECKO(7204) |     1.226575 |    0.001148 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.544Z] 03:53:32     INFO - GECKO(7204) |     1.228568 |    0.001993 | Create Answer                  | PeerConnectionImpl.cpp:1247  | CreateAnswer
[task 2022-02-01T03:53:32.544Z] 03:53:32     INFO - GECKO(7204) |     1.233539 |    0.004971 | Set Local Description          | PeerConnectionImpl.cpp:1285  | SetLocalDescription
[task 2022-02-01T03:53:32.544Z] 03:53:32     INFO - GECKO(7204) |     1.281084 |    0.047545 | Ice gathering state: gathering | PeerConnectionImpl.cpp:2539  | IceGatheringStateChange
[task 2022-02-01T03:53:32.545Z] 03:53:32     INFO - GECKO(7204) |     1.384473 |    0.103389 | Ice state: checking            | PeerConnectionImpl.cpp:2483  | IceConnectionStateChange
[task 2022-02-01T03:53:32.545Z] 03:53:32     INFO - GECKO(7204) |     1.397485 |    0.013012 | Ice gathering state: complete  | PeerConnectionImpl.cpp:2542  | IceGatheringStateChange
[task 2022-02-01T03:53:32.545Z] 03:53:32     INFO - GECKO(7204) |     1.404898 |    0.007413 | Ice state: connected           | PeerConnectionImpl.cpp:2486  | IceConnectionStateChange
[task 2022-02-01T03:53:32.546Z] 03:53:32     INFO - GECKO(7204) |     2.015025 |    0.610127 | Destructor Invoked             | PeerConnectionImpl.cpp:342   | ~PeerConnectionImpl
[task 2022-02-01T03:53:32.546Z] 03:53:32     INFO - GECKO(7204) | [Child 7320: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:368: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for {27636ff9-4ee6-4dcd-a502-9f7681b2527e}
[task 2022-02-01T03:53:32.547Z] 03:53:32     INFO - GECKO(7204) | Timecard created 1643687610.497790
[task 2022-02-01T03:53:32.547Z] 03:53:32     INFO - GECKO(7204) |  Timestamp   | Delta       | Event                          | File                         | Function
[task 2022-02-01T03:53:32.547Z] 03:53:32     INFO - GECKO(7204) | ======================================================================================================================
[task 2022-02-01T03:53:32.547Z] 03:53:32     INFO - GECKO(7204) |     0.000247 |    0.000247 | Constructor Completed          | PeerConnectionImpl.cpp:333   | PeerConnectionImpl
[task 2022-02-01T03:53:32.547Z] 03:53:32     INFO - GECKO(7204) |     0.002832 |    0.002585 | Initializing PC Ctx            | PeerConnectionImpl.cpp:452   | Initialize
[task 2022-02-01T03:53:32.548Z] 03:53:32     INFO - GECKO(7204) |     1.022845 |    1.020013 | Create Offer                   | PeerConnectionImpl.cpp:1216  | CreateOffer
[task 2022-02-01T03:53:32.548Z] 03:53:32     INFO - GECKO(7204) |     1.062482 |    0.039637 | Set Local Description          | PeerConnectionImpl.cpp:1285  | SetLocalDescription
[task 2022-02-01T03:53:32.548Z] 03:53:32     INFO - GECKO(7204) |     1.140060 |    0.077578 | Ice gathering state: gathering | PeerConnectionImpl.cpp:2539  | IceGatheringStateChange
[task 2022-02-01T03:53:32.549Z] 03:53:32     INFO - GECKO(7204) |     1.198402 |    0.058342 | Ice gathering state: complete  | PeerConnectionImpl.cpp:2542  | IceGatheringStateChange
[task 2022-02-01T03:53:32.549Z] 03:53:32     INFO - GECKO(7204) |     1.271719 |    0.073317 | Set Remote Description         | PeerConnectionImpl.cpp:1385  | SetRemoteDescription
[task 2022-02-01T03:53:32.549Z] 03:53:32     INFO - GECKO(7204) |     1.305573 |    0.033854 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.550Z] 03:53:32     INFO - GECKO(7204) |     1.410643 |    0.105070 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.553Z] 03:53:32     INFO - GECKO(7204) |     1.413643 |    0.003000 | Ice state: checking            | PeerConnectionImpl.cpp:2483  | IceConnectionStateChange
[task 2022-02-01T03:53:32.553Z] 03:53:32     INFO - GECKO(7204) |     1.417993 |    0.004350 | Ice state: connected           | PeerConnectionImpl.cpp:2486  | IceConnectionStateChange
[task 2022-02-01T03:53:32.553Z] 03:53:32     INFO - GECKO(7204) |     1.429954 |    0.011961 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.553Z] 03:53:32     INFO - GECKO(7204) |     1.437612 |    0.007658 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.554Z] 03:53:32     INFO - GECKO(7204) |     1.440253 |    0.002641 | Add Ice Candidate              | PeerConnectionImpl.cpp:1533  | AddIceCandidate
[task 2022-02-01T03:53:32.554Z] 03:53:32     INFO - GECKO(7204) |     2.026341 |    0.586088 | Destructor Invoked             | PeerConnectionImpl.cpp:342   | ~PeerConnectionImpl
[task 2022-02-01T03:53:32.554Z] 03:53:32     INFO - GECKO(7204) | [Child 7320: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:368: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for {a7a11a5c-621c-465d-8870-75ba20ab34ef}
[task 2022-02-01T03:53:32.620Z] 03:53:32     INFO - GECKO(7204) | ==7320==WARNING: Symbolizer buffer too small
[task 2022-02-01T03:53:32.622Z] 03:53:32     INFO - GECKO(7204) | ==7320==WARNING: Symbolizer buffer too small
[task 2022-02-01T03:53:32.695Z] 03:53:32     INFO - GECKO(7204) | TEST DEVICES: Got loopback audio: Monitor of Null Output
[task 2022-02-01T03:53:32.702Z] 03:53:32     INFO - GECKO(7204) | TEST DEVICES: Got loopback video: Dummy video device (0x0000)
[task 2022-02-01T03:53:33.111Z] 03:53:33     INFO - GECKO(7204) | [Child 7320: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:332: PeerConnectionImpl: PeerConnectionImpl constructor for
[task 2022-02-01T03:53:33.121Z] 03:53:33     INFO - GECKO(7204) | [Parent 7204: Socket Thread]: D/mtransport NrIceCtx static call to find local stun addresses
[task 2022-02-01T03:53:33.125Z] 03:53:33     INFO - GECKO(7204) | [Child 7320: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:332: PeerConnectionImpl: PeerConnectionImpl constructor for
[task 2022-02-01T03:53:33.131Z] 03:53:33     INFO - GECKO(7204) | [Parent 7204: Socket Thread]: D/mtransport NrIceCtx static call to find local stun addresses
[task 2022-02-01T03:53:34.552Z] 03:53:34     INFO - GECKO(7204) | ==================
[task 2022-02-01T03:53:34.560Z] 03:53:34     INFO - GECKO(7204) | WARNING: ThreadSanitizer: use of an invalid mutex (e.g. uninitialized or destroyed) (pid=7320)
[task 2022-02-01T03:53:34.560Z] 03:53:34     INFO - GECKO(7204) |     #0 pthread_mutex_lock /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/../sanitizer_common/sanitizer_common_interceptors.inc:4249:3 (firefox+0x76448)
[task 2022-02-01T03:53:34.560Z] 03:53:34     INFO - GECKO(7204) |     #1 mozilla::RecursiveMutex::LockInternal() /builds/worker/checkouts/gecko/xpcom/threads/RecursiveMutex.cpp:71:3 (libxul.so+0xf89225)
[task 2022-02-01T03:53:34.560Z] 03:53:34     INFO - GECKO(7204) |     #2 Lock /builds/worker/workspace/obj-build/dist/include/mozilla/RecursiveMutex.h:29:17 (libxul.so+0x4724e40)
[task 2022-02-01T03:53:34.560Z] 03:53:34     INFO - GECKO(7204) |     #3 AutoLock /builds/worker/workspace/obj-build/dist/include/mozilla/DataMutex.h:81:22 (libxul.so+0x4724e40)
[task 2022-02-01T03:53:34.560Z] 03:53:34     INFO - GECKO(7204) |     #4 Lock /builds/worker/workspace/obj-build/dist/include/mozilla/DataMutex.h:92:28 (libxul.so+0x4724e40)
[task 2022-02-01T03:53:34.560Z] 03:53:34     INFO - GECKO(7204) |     #5 operator() /builds/worker/checkouts/gecko/dom/media/webrtc/libwebrtcglue/TaskQueueWrapper.h:61:43 (libxul.so+0x4724e40)
[task 2022-02-01T03:53:34.560Z] 03:53:34     INFO - GECKO(7204) |     #6 mozilla::detail::RunnableFunction<mozilla::TaskQueueWrapper<(mozilla::DeletionPolicy)1>::CreateTaskRunner(std::unique_ptr<webrtc::QueuedTask, std::default_delete<webrtc::QueuedTask> >)::'lambda'()>::Run() /builds/worker/workspace/obj-build/dist/include/nsThreadUtils.h:531:5 (libxul.so+0x4724e40)
[task 2022-02-01T03:53:34.560Z] 03:53:34     INFO - GECKO(7204) |     #7 DoRun /builds/worker/checkouts/gecko/xpcom/threads/DelayedRunnable.cpp:71:13 (libxul.so+0xf82de5)
[task 2022-02-01T03:53:34.560Z] 03:53:34     INFO - GECKO(7204) |     #8 Notify /builds/worker/checkouts/gecko/xpcom/threads/DelayedRunnable.cpp:65:10 (libxul.so+0xf82de5)
[task 2022-02-01T03:53:34.561Z] 03:53:34     INFO - GECKO(7204) |     #9 non-virtual thunk to mozilla::DelayedRunnable::Notify(nsITimer*) /builds/worker/checkouts/gecko/xpcom/threads/DelayedRunnable.cpp (libxul.so+0xf82de5)
[task 2022-02-01T03:53:34.561Z] 03:53:34     INFO - GECKO(7204) |     #10 operator() /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:654:44 (libxul.so+0xfcaa1a)
[task 2022-02-01T03:53:34.561Z] 03:53:34     INFO - GECKO(7204) |     #11 matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback> &, (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:654:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:655:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:658:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:659:7)> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:309:16 (libxul.so+0xfcaa1a)
[task 2022-02-01T03:53:34.561Z] 03:53:34     INFO - GECKO(7204) |     #12 matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback> &, (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:653:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:654:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:655:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:658:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:659:7)> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:318:14 (libxul.so+0xfcaa1a)
[task 2022-02-01T03:53:34.561Z] 03:53:34     INFO - GECKO(7204) |     #13 matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback> &, (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:653:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:654:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:655:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:658:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:659:7)> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:902:12 (libxul.so+0xfcaa1a)
[task 2022-02-01T03:53:34.561Z] 03:53:34     INFO - GECKO(7204) |     #14 match<(lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:653:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:654:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:655:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:658:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:659:7)> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:857:12 (libxul.so+0xfcaa1a)
[task 2022-02-01T03:53:34.561Z] 03:53:34     INFO - GECKO(7204) |     #15 nsTimerImpl::Fire(int) /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:652:22 (libxul.so+0xfcaa1a)
[task 2022-02-01T03:53:34.561Z] 03:53:34     INFO - GECKO(7204) |     #16 nsTimerEvent::Run() /builds/worker/checkouts/gecko/xpcom/threads/TimerThread.cpp:265:11 (libxul.so+0xf9af0f)
[task 2022-02-01T03:53:34.561Z] 03:53:34     INFO - GECKO(7204) |     #17 mozilla::TaskQueue::Runner::Run() /builds/worker/checkouts/gecko/xpcom/threads/TaskQueue.cpp:206:20 (libxul.so+0xf9627e)
[task 2022-02-01T03:53:34.561Z] 03:53:34     INFO - GECKO(7204) |     #18 nsThreadPool::Run() /builds/worker/checkouts/gecko/xpcom/threads/nsThreadPool.cpp:305:14 (libxul.so+0xfaef1d)
[task 2022-02-01T03:53:34.562Z] 03:53:34     INFO - GECKO(7204) |     #19 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1189:16 (libxul.so+0xfa5cc3)
[task 2022-02-01T03:53:34.562Z] 03:53:34     INFO - GECKO(7204) |     #20 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:467:10 (libxul.so+0xfac6e2)
[task 2022-02-01T03:53:34.564Z] 03:53:34     INFO - GECKO(7204) |     #21 mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:300:20 (libxul.so+0x19206ee)
[task 2022-02-01T03:53:34.564Z] 03:53:34     INFO - GECKO(7204) |     #22 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x189de0c)
[task 2022-02-01T03:53:34.568Z] 03:53:34     INFO - GECKO(7204) |     #23 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x189de0c)
[task 2022-02-01T03:53:34.568Z] 03:53:34     INFO - GECKO(7204) |     #24 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x189de0c)
[task 2022-02-01T03:53:34.569Z] 03:53:34     INFO - GECKO(7204) |     #25 nsThread::ThreadFunc(void*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:391:10 (libxul.so+0xfa1da3)
[task 2022-02-01T03:53:34.569Z] 03:53:34     INFO - GECKO(7204) |     #26 _pt_root /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:201:5 (libnspr4.so+0x44fbd)
[task 2022-02-01T03:53:34.570Z] 03:53:34     INFO - GECKO(7204) |   Location is heap block of size 80 at 0x7b14000ae1a0 allocated by main thread:
[task 2022-02-01T03:53:34.570Z] 03:53:34     INFO - GECKO(7204) |     #0 alloc::alloc::alloc::h50f46114450eba87 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/alloc.rs:87:14 (firefox+0x57add)
[task 2022-02-01T03:53:34.571Z] 03:53:34     INFO - GECKO(7204) |     #1 alloc::alloc::Global::alloc_impl::hc67015e368422cc6 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/alloc.rs:169:73 (firefox+0x57add)
[task 2022-02-01T03:53:34.571Z] 03:53:34     INFO - GECKO(7204) |     #2 _$LT$alloc..alloc..Global$u20$as$u20$core..alloc..Allocator$GT$::allocate::hf1b51038e97d4901 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/alloc.rs:229:9 (firefox+0x57add)
[task 2022-02-01T03:53:34.572Z] 03:53:34     INFO - GECKO(7204) |     #3 alloc::alloc::exchange_malloc::hb200f5dd5c766421 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/alloc.rs:318:11 (firefox+0x57add)
[task 2022-02-01T03:53:34.572Z] 03:53:34     INFO - GECKO(7204) |     #4 alloc::boxed::Box$LT$T$GT$::new::h8142c30e37fe9c84 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/boxed.rs:195:9 (firefox+0x57add)
[task 2022-02-01T03:53:34.573Z] 03:53:34     INFO - GECKO(7204) |     #5 style::rule_tree::core::StrongRuleNode::ensure_child::h044c65ec68fc2cc6 /builds/worker/checkouts/gecko/servo/components/style/rule_tree/core.rs:584:48 (firefox+0x57add)
[task 2022-02-01T03:53:34.573Z] 03:53:34     INFO - GECKO(7204) |     #6 style::rule_tree::_$LT$impl$u20$style..rule_tree..core..RuleTree$GT$::insert_ordered_rules_with_important::hab5bfa9ccacec41f /builds/worker/checkouts/gecko/servo/components/style/rule_tree/mod.rs:101:27 (libxul.so+0x8a2f3ec)
[task 2022-02-01T03:53:34.574Z] 03:53:34     INFO - GECKO(7204) |     #7 style::rule_tree::_$LT$impl$u20$style..rule_tree..core..RuleTree$GT$::compute_rule_node::hcba47e73d13c3721 /builds/worker/checkouts/gecko/servo/components/style/rule_tree/mod.rs:163:9 (libxul.so+0x8a2f3ec)
[task 2022-02-01T03:53:34.575Z] 03:53:34     INFO - GECKO(7204) |     #8 style::style_resolver::StyleResolverForElement$LT$E$GT$::match_primary::h99fa9b59e3158a89 /builds/worker/checkouts/gecko/servo/components/style/style_resolver.rs:491:25 (libxul.so+0x8b6d584)
[task 2022-02-01T03:53:34.575Z] 03:53:34     INFO - GECKO(7204) |     #9 style::style_resolver::StyleResolverForElement$LT$E$GT$::resolve_primary_style::h13aabfc675e2b9bb /builds/worker/checkouts/gecko/servo/components/style/style_resolver.rs:189:31 (libxul.so+0x8bb2d0a)
[task 2022-02-01T03:53:34.576Z] 03:53:34     INFO - GECKO(7204) |     #10 style::style_resolver::StyleResolverForElement$LT$E$GT$::resolve_style::h449aa591658cd2b7 /builds/worker/checkouts/gecko/servo/components/style/style_resolver.rs:259:29 (libxul.so+0x8433feb)
[task 2022-02-01T03:53:34.576Z] 03:53:34     INFO - GECKO(7204) |     #11 style::style_resolver::StyleResolverForElement$LT$E$GT$::resolve_style_with_default_parents::_$u7b$$u7b$closure$u7d$$u7d$::h58d6a9debd60120f /builds/worker/checkouts/gecko/servo/components/style/style_resolver.rs:294:13 (libxul.so+0x841f15a)
[task 2022-02-01T03:53:34.577Z] 03:53:34     INFO - GECKO(7204) |     #12 style::style_resolver::with_default_parent_styles::hbf08f389d417cf7c /builds/worker/checkouts/gecko/servo/components/style/style_resolver.rs:115:5 (libxul.so+0x841f15a)
[task 2022-02-01T03:53:34.577Z] 03:53:34     INFO - GECKO(7204) |     #13 style::style_resolver::StyleResolverForElement$LT$E$GT$::resolve_style_with_default_parents::h901f10c3f2489349 /builds/worker/checkouts/gecko/servo/components/style/style_resolver.rs:293:9 (libxul.so+0x841f15a)
[task 2022-02-01T03:53:34.578Z] 03:53:34     INFO - GECKO(7204) |     #14 style::traversal::compute_style::h411162a6a01f70d7 /builds/worker/checkouts/gecko/servo/components/style/traversal.rs:602:25 (libxul.so+0x841f15a)
[task 2022-02-01T03:53:34.578Z] 03:53:34     INFO - GECKO(7204) |     #15 style::traversal::recalc_style_at::h14f08242cfab0ec5 /builds/worker/checkouts/gecko/servo/components/style/traversal.rs:420:37 (libxul.so+0x841ee17)
[task 2022-02-01T03:53:34.579Z] 03:53:34     INFO - GECKO(7204) |     #16 _$LT$style..gecko..traversal..RecalcStyleOnly$u20$as$u20$style..traversal..DomTraversal$LT$style..gecko..wrapper..GeckoElement$GT$$GT$::process_preorder::h1d94f82355e0086c /builds/worker/checkouts/gecko/servo/components/style/gecko/traversal.rs:37:13 (libxul.so+0x841ee17)
[task 2022-02-01T03:53:34.580Z] 03:53:34     INFO - GECKO(7204) |     #17 style::driver::traverse_dom::hf5f092ed10fc7771 /builds/worker/checkouts/gecko/servo/components/style/driver.rs:112:9 (libxul.so+0x841ee17)
[task 2022-02-01T03:53:34.580Z] 03:53:34     INFO - GECKO(7204) |     #18 geckoservo::glue::traverse_subtree::h9693ca4d6f04860c /builds/worker/checkouts/gecko/servo/ports/geckolib/glue.rs:269:5 (libxul.so+0x84027ba)
[task 2022-02-01T03:53:34.581Z] 03:53:34     INFO - GECKO(7204) |     #19 Servo_TraverseSubtree /builds/worker/checkouts/gecko/servo/ports/geckolib/glue.rs:329:5 (libxul.so+0x83ffb87)
[task 2022-02-01T03:53:34.581Z] 03:53:34     INFO - GECKO(7204) |     #20 mozilla::ServoStyleSet::StyleNewSubtree(mozilla::dom::Element*) /builds/worker/checkouts/gecko/layout/style/ServoStyleSet.cpp:831:7 (libxul.so+0x83fdb29)
[task 2022-02-01T03:53:34.582Z] 03:53:34     INFO - GECKO(7204) |     #21 nsCSSFrameConstructor::ConstructDocElementFrame(mozilla::dom::Element*) /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:2249:29 (libxul.so+0x83fd428)
[task 2022-02-01T03:53:34.582Z] 03:53:34     INFO - GECKO(7204) |     #22 nsCSSFrameConstructor::ContentRangeInserted(nsIContent*, nsIContent*, nsCSSFrameConstructor::InsertionKind) /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:6906:9 (libxul.so+0x538033d)
[task 2022-02-01T03:53:34.583Z] 03:53:34     INFO - GECKO(7204) |     #23 nsCSSFrameConstructor::ContentInserted(nsIContent*, nsCSSFrameConstructor::InsertionKind) /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:6824:3 (libxul.so+0x5466ea3)
[task 2022-02-01T03:53:34.584Z] 03:53:34     INFO - GECKO(7204) |     #24 mozilla::PresShell::Initialize() /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:1852:26 (libxul.so+0x547972f)
[task 2022-02-01T03:53:34.584Z] 03:53:34     INFO - GECKO(7204) |     #25 nsContentSink::StartLayout(bool) /builds/worker/checkouts/gecko/dom/base/nsContentSink.cpp:557:30 (libxul.so+0x54792f1)
[task 2022-02-01T03:53:34.584Z] 03:53:34     INFO - GECKO(7204) |     #26 nsHtml5TreeOpExecutor::StartLayout(bool*) /builds/worker/checkouts/gecko/parser/html/nsHtml5TreeOpExecutor.cpp:839:18 (libxul.so+0x5413709)
[task 2022-02-01T03:53:34.585Z] 03:53:34     INFO - GECKO(7204) |     #27 StyleLineNumber, opSetScriptLineNumberAndFreeze, opSvgLoad, opMaybeComplainAboutCharset, opMaybeComplainAboutDeepTree, opAddClass, opAddViewSourceHref, opAddViewSourceBase, opAddErrorType, opAddLineNumberId, opStartLayout, opEnableEncodingMenu> &> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:279:14 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.586Z] 03:53:34     INFO - GECKO(7204) |     #28 match<TreeOperationMatcher, mozilla::Variant<uninitialized, opAppend, opDetach, opAppendChildrenToNewParent, opFosterParent, opAppendToDocument, opAddAttributes, nsHtml5DocumentMode, opCreateHTMLElement, opCreateSVGElement, opCreateMathMLElement, opSetFormElement, opAppendText, opFosterParentText, opAppendComment, opAppendCommentToDocument, opAppendDoctypeToDocument, opGetDocumentFragmentForTemplate, opGetFosterParent, opMarkAsBroken, opRunScript, opRunScriptAsyncDefer, opPreventScriptExecution, opDoneAddingChildren, opDoneCreatingElement, opUpdateCharsetSource, opCharsetSwitchTo, opUpdateStyleSheet, opProcessOfflineManifest, opMarkMalformedIfScript, opStreamEnded, opSetStyleLineNumber, opSetScriptLineNumberAndFreeze, opSvgLoad, opMaybeComplainAboutCharset, opMaybeComplainAboutDeepTree, opAddClass, opAddViewSourceHref, opAddViewSourceBase, opAddErrorType, opAddLineNumberId, opStartLayout, opEnableEncodingMenu> &> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:279:14 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.587Z] 03:53:34     INFO - GECKO(7204) |     #29 match<TreeOperationMatcher, mozilla::Variant<uninitialized, opAppend, opDetach, opAppendChildrenToNewParent, opFosterParent, opAppendToDocument, opAddAttributes, nsHtml5DocumentMode, opCreateHTMLElement, opCreateSVGElement, opCreateMathMLElement, opSetFormElement, opAppendText, opFosterParentText, opAppendComment, opAppendCommentToDocument, opAppendDoctypeToDocument, opGetDocumentFragmentForTemplate, opGetFosterParent, opMarkAsBroken, opRunScript, opRunScriptAsyncDefer, opPreventScriptExecution, opDoneAddingChildren, opDoneCreatingElement, opUpdateCharsetSource, opCharsetSwitchTo, opUpdateStyleSheet, opProcessOfflineManifest, opMarkMalformedIfScript, opStreamEnded, opSetStyleLineNumber, opSetScriptLineNumberAndFreeze, opSvgLoad, opMaybeComplainAboutCharset, opMaybeComplainAboutDeepTree, opAddClass, opAddViewSourceHref, opAddViewSourceBase, opAddErrorType, opAddLineNumberId, opStartLayout, opEnableEncodingMenu> &> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:279:14 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.588Z] 03:53:34     INFO - GECKO(7204) |     #30 match<TreeOperationMatcher, mozilla::Variant<uninitialized, opAppend, opDetach, opAppendChildrenToNewParent, opFosterParent, opAppendToDocument, opAddAttributes, nsHtml5DocumentMode, opCreateHTMLElement, opCreateSVGElement, opCreateMathMLElement, opSetFormElement, opAppendText, opFosterParentText, opAppendComment, opAppendCommentToDocument, opAppendDoctypeToDocument, opGetDocumentFragmentForTemplate, opGetFosterParent, opMarkAsBroken, opRunScript, opRunScriptAsyncDefer, opPreventScriptExecution, opDoneAddingChildren, opDoneCreatingElement, opUpdateCharsetSource, opCharsetSwitchTo, opUpdateStyleSheet, opProcessOfflineManifest, opMarkMalformedIfScript, opStreamEnded, opSetStyleLineNumber, opSetScriptLineNumberAndFreeze, opSvgLoad, opMaybeComplainAboutCharset, opMaybeComplainAboutDeepTree, opAddClass, opAddViewSourceHref, opAddViewSourceBase, opAddErrorType, opAddLineNumberId, opStartLayout, opEnableEncodingMenu> &> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:279:14 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.589Z] 03:53:34     INFO - GECKO(7204) |     #31 match<TreeOperationMatcher, mozilla::Variant<uninitialized, opAppend, opDetach, opAppendChildrenToNewParent, opFosterParent, opAppendToDocument, opAddAttributes, nsHtml5DocumentMode, opCreateHTMLElement, opCreateSVGElement, opCreateMathMLElement, opSetFormElement, opAppendText, opFosterParentText, opAppendComment, opAppendCommentToDocument, opAppendDoctypeToDocument, opGetDocumentFragmentForTemplate, opGetFosterParent, opMarkAsBroken, opRunScript, opRunScriptAsyncDefer, opPreventScriptExecution, opDoneAddingChildren, opDoneCreatingElement, opUpdateCharsetSource, opCharsetSwitchTo, opUpdateStyleSheet, opProcessOfflineManifest, opMarkMalformedIfScript, opStreamEnded, opSetStyleLineNumber, opSetScriptLineNumberAndFreeze, opSvgLoad, opMaybeComplainAboutCharset, opMaybeComplainAboutDeepTree, opAddClass, opAddViewSourceHref, opAddViewSourceBase, opAddErrorType, opAddLineNumberId, opStartLayout, opEnableEncodingMenu> &> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:279:14 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.589Z] 03:53:34     INFO - GECKO(7204) |     #32 match<TreeOperationMatcher, mozilla::Variant<uninitialized, opAppend, opDetach, opAppendChildrenToNewParent, opFosterParent, opAppendToDocument, opAddAttributes, nsHtml5DocumentMode, opCreateHTMLElement, opCreateSVGElement, opCreateMathMLElement, opSetFormElement, opAppendText, opFosterParentText, opAppendComment, opAppendCommentToDocument, opAppendDoctypeToDocument, opGetDocumentFragmentForTemplate, opGetFosterParent, opMarkAsBroken, opRunScript, opRunScriptAsyncDefer, opPreventScriptExecution, opDoneAddingChildren, opDoneCreatingElement, opUpdateCharsetSource, opCharsetSwitchTo, opUpdateStyleSheet, opProcessOfflineManifest, opMarkMalformedIfScript, opStreamEnded, opSetStyleLineNumber, opSetScriptLineNumberAndFreeze, opSvgLoad, opMaybeComplainAboutCharset, opMaybeComplainAboutDeepTree, opAddClass, opAddViewSourceHref, opAddViewSourceBase, opAddErrorType, opAddLineNumberId, opStartLayout, opEnableEncodingMenu> &> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:279:14 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.590Z] 03:53:34     INFO - GECKO(7204) |     #33 match<TreeOperationMatcher, mozilla::Variant<uninitialized, opAppend, opDetach, opAppendChildrenToNewParent, opFosterParent, opAppendToDocument, opAddAttributes, nsHtml5DocumentMode, opCreateHTMLElement, opCreateSVGElement, opCreateMathMLElement, opSetFormElement, opAppendText, opFosterParentText, opAppendComment, opAppendCommentToDocument, opAppendDoctypeToDocument, opGetDocumentFragmentForTemplate, opGetFosterParent, opMarkAsBroken, opRunScript, opRunScriptAsyncDefer, opPreventScriptExecution, opDoneAddingChildren, opDoneCreatingElement, opUpdateCharsetSource, opCharsetSwitchTo, opUpdateStyleSheet, opProcessOfflineManifest, opMarkMalformedIfScript, opStreamEnded, opSetStyleLineNumber, opSetScriptLineNumberAndFreeze, opSvgLoad, opMaybeComplainAboutCharset, opMaybeComplainAboutDeepTree, opAddClass, opAddViewSourceHref, opAddViewSourceBase, opAddErrorType, opAddLineNumberId, opStartLayout, opEnableEncodingMenu> &> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:279:14 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.591Z] 03:53:34     INFO - GECKO(7204) |     #34 match<TreeOperationMatcher, mozilla::Variant<uninitialized, opAppend, opDetach, opAppendChildrenToNewParent, opFosterParent, opAppendToDocument, opAddAttributes, nsHtml5DocumentMode, opCreateHTMLElement, opCreateSVGElement, opCreateMathMLElement, opSetFormElement, opAppendText, opFosterParentText, opAppendComment, opAppendCommentToDocument, opAppendDoctypeToDocument, opGetDocumentFragmentForTemplate, opGetFosterParent, opMarkAsBroken, opRunScript, opRunScriptAsyncDefer, opPreventScriptExecution, opDoneAddingChildren, opDoneCreatingElement, opUpdateCharsetSource, opCharsetSwitchTo, opUpdateStyleSheet, opProcessOfflineManifest, opMarkMalformedIfScript, opStreamEnded, opSetStyleLineNumber, opSetScriptLineNumberAndFreeze, opSvgLoad, opMaybeComplainAboutCharset, opMaybeComplainAboutDeepTree, opAddClass, opAddViewSourceHref, opAddViewSourceBase, opAddErrorType, opAddLineNumberId, opStartLayout, opEnableEncodingMenu> &> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:279:14 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.592Z] 03:53:34     INFO - GECKO(7204) |     #35 match<TreeOperationMatcher, mozilla::Variant<uninitialized, opAppend, opDetach, opAppendChildrenToNewParent, opFosterParent, opAppendToDocument, opAddAttributes, nsHtml5DocumentMode, opCreateHTMLElement, opCreateSVGElement, opCreateMathMLElement, opSetFormElement, opAppendText, opFosterParentText, opAppendComment, opAppendCommentToDocument, opAppendDoctypeToDocument, opGetDocumentFragmentForTemplate, opGetFosterParent, opMarkAsBroken, opRunScript, opRunScriptAsyncDefer, opPreventScriptExecution, opDoneAddingChildren, opDoneCreatingElement, opUpdateCharsetSource, opCharsetSwitchTo, opUpdateStyleSheet, opProcessOfflineManifest, opMarkMalformedIfScript, opStreamEnded, opSetStyleLineNumber, opSetScriptLineNumberAndFreeze, opSvgLoad, opMaybeComplainAboutCharset, opMaybeComplainAboutDeepTree, opAddClass, opAddViewSourceHref, opAddViewSourceBase, opAddErrorType, opAddLineNumberId, opStartLayout, opEnableEncodingMenu> &> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:279:14 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.593Z] 03:53:34     INFO - GECKO(7204) |     #36 match<TreeOperationMatcher, mozilla::Variant<uninitialized, opAppend, opDetach, opAppendChildrenToNewParent, opFosterParent, opAppendToDocument, opAddAttributes, nsHtml5DocumentMode, opCreateHTMLElement, opCreateSVGElement, opCreateMathMLElement, opSetFormElement, opAppendText, opFosterParentText, opAppendComment, opAppendCommentToDocument, opAppendDoctypeToDocument, opGetDocumentFragmentForTemplate, opGetFosterParent, opMarkAsBroken, opRunScript, opRunScriptAsyncDefer, opPreventScriptExecution, opDoneAddingChildren, opDoneCreatingElement, opUpdateCharsetSource, opCharsetSwitchTo, opUpdateStyleSheet, opProcessOfflineManifest, opMarkMalformedIfScript, opStreamEnded, opSetStyleLineNumber, opSetScriptLineNumberAndFreeze, opSvgLoad, opMaybeComplainAboutCharset, opMaybeComplainAboutDeepTree, opAddClass, opAddViewSourceHref, opAddViewSourceBase, opAddErrorType, opAddLineNumberId, opStartLayout, opEnableEncodingMenu> &> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:279:14 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.594Z] 03:53:34     INFO - GECKO(7204) |     #37 match<TreeOperationMatcher> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:852:12 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.594Z] 03:53:34     INFO - GECKO(7204) |     #38 nsHtml5TreeOperation::Perform(nsHtml5TreeOpExecutor*, nsIContent**, bool*, bool*) /builds/worker/checkouts/gecko/parser/html/nsHtml5TreeOperation.cpp:1207:21 (libxul.so+0x2a74785)
[task 2022-02-01T03:53:34.594Z] 03:53:34     INFO - GECKO(7204) |     #39 <null> <null> (libxul.so+0x22092da)
[task 2022-02-01T03:53:34.595Z] 03:53:34     INFO - GECKO(7204) |     #40 <null> <null> (libxul.so+0x22084ab)
[task 2022-02-01T03:53:34.595Z] 03:53:34     INFO - GECKO(7204) |     #41 nsHtml5TreeOpExecutor::RunFlushLoop() /builds/worker/checkouts/gecko/parser/html/nsHtml5TreeOpExecutor.cpp:646:19 (libxul.so+0x2206ac8)
[task 2022-02-01T03:53:34.596Z] 03:53:34     INFO - GECKO(7204) |     #42 nsHtml5ExecutorReflusher::Run() /builds/worker/checkouts/gecko/parser/html/nsHtml5TreeOpExecutor.cpp:78:16 (libxul.so+0x220d5eb)
[task 2022-02-01T03:53:34.596Z] 03:53:34     INFO - GECKO(7204) |     #43 mozilla::SchedulerGroup::Runnable::Run() /builds/worker/checkouts/gecko/xpcom/threads/SchedulerGroup.cpp:140:20 (libxul.so+0xf8996f)
[task 2022-02-01T03:53:34.596Z] 03:53:34     INFO - GECKO(7204) |     #44 mozilla::RunnableTask::Run() /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:467:16 (libxul.so+0xfb7c77)
[task 2022-02-01T03:53:34.597Z] 03:53:34     INFO - GECKO(7204) |     #45 mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:770:26 (libxul.so+0xf9314d)
[task 2022-02-01T03:53:34.597Z] 03:53:34     INFO - GECKO(7204) |     #46 mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:606:15 (libxul.so+0xf91826)
[task 2022-02-01T03:53:34.598Z] 03:53:34     INFO - GECKO(7204) |     #47 mozilla::TaskController::ProcessPendingMTTask(bool) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:390:36 (libxul.so+0xf91b02)
[task 2022-02-01T03:53:34.598Z] 03:53:34     INFO - GECKO(7204) |     #48 operator() /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:124:37 (libxul.so+0xfbac87)
[task 2022-02-01T03:53:34.598Z] 03:53:34     INFO - GECKO(7204) |     #49 mozilla::detail::RunnableFunction<mozilla::TaskController::InitializeInternal()::$_0>::Run() /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.h:531:5 (libxul.so+0xfbac87)
[task 2022-02-01T03:53:34.599Z] 03:53:34     INFO - GECKO(7204) |     #50 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1195:16 (libxul.so+0xfa5aa3)
[task 2022-02-01T03:53:34.599Z] 03:53:34     INFO - GECKO(7204) |     #51 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:467:10 (libxul.so+0xfac6e2)
[task 2022-02-01T03:53:34.599Z] 03:53:34     INFO - GECKO(7204) |     #52 mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:85:21 (libxul.so+0x191fb4d)
[task 2022-02-01T03:53:34.600Z] 03:53:34     INFO - GECKO(7204) |     #53 mozilla::ipc::MessagePumpForChildProcess::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:268:30 (libxul.so+0x19205fb)
[task 2022-02-01T03:53:34.600Z] 03:53:34     INFO - GECKO(7204) |     #54 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x189de0c)
[task 2022-02-01T03:53:34.600Z] 03:53:34     INFO - GECKO(7204) |     #55 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x189de0c)
[task 2022-02-01T03:53:34.601Z] 03:53:34     INFO - GECKO(7204) |     #56 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x189de0c)
[task 2022-02-01T03:53:34.601Z] 03:53:34     INFO - GECKO(7204) |     #57 nsBaseAppShell::Run() /builds/worker/checkouts/gecko/widget/nsBaseAppShell.cpp:137:27 (libxul.so+0x50de156)
[task 2022-02-01T03:53:34.601Z] 03:53:34     INFO - GECKO(7204) |     #58 XRE_RunAppShell() /builds/worker/checkouts/gecko/toolkit/xre/nsEmbedFunctions.cpp:878:20 (libxul.so+0x714ca49)
[task 2022-02-01T03:53:34.602Z] 03:53:34     INFO - GECKO(7204) |     #59 mozilla::ipc::MessagePumpForChildProcess::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:235:9 (libxul.so+0x19205ad)
[task 2022-02-01T03:53:34.602Z] 03:53:34     INFO - GECKO(7204) |     #60 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x189de0c)
[task 2022-02-01T03:53:34.602Z] 03:53:34     INFO - GECKO(7204) |     #61 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x189de0c)
[task 2022-02-01T03:53:34.603Z] 03:53:34     INFO - GECKO(7204) |     #62 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x189de0c)
[task 2022-02-01T03:53:34.603Z] 03:53:34     INFO - GECKO(7204) |     #63 XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/nsEmbedFunctions.cpp:715:34 (libxul.so+0x714c78a)
[task 2022-02-01T03:53:34.604Z] 03:53:34     INFO - GECKO(7204) |     #64 mozilla::BootstrapImpl::XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:67:12 (libxul.so+0x7154582)
[task 2022-02-01T03:53:34.604Z] 03:53:34     INFO - GECKO(7204) |     #65 content_process_main /builds/worker/checkouts/gecko/browser/app/../../ipc/contentproc/plugin-container.cpp:57:28 (firefox+0xcf2a8)
[task 2022-02-01T03:53:34.604Z] 03:53:34     INFO - GECKO(7204) |     #66 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:327:18 (firefox+0xcf2a8)
[task 2022-02-01T03:53:34.605Z] 03:53:34     INFO - GECKO(7204) |   Mutex M476953936378126784 is already destroyed.
[task 2022-02-01T03:53:34.605Z] 03:53:34     INFO - GECKO(7204) | SUMMARY: ThreadSanitizer: use of an invalid mutex (e.g. uninitialized or destroyed) /builds/worker/checkouts/gecko/xpcom/threads/RecursiveMutex.cpp:71:3 in mozilla::RecursiveMutex::LockInternal()
[task 2022-02-01T03:53:34.606Z] 03:53:34     INFO - GECKO(7204) | ==================
[task 2022-02-01T03:53:34.961Z] 03:53:34    ERROR - GECKO(7204) | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2022-02-01T03:53:35.259Z] 03:53:35     INFO - GECKO(7204) | 1643687615258	Marionette	TRACE	Received observer notification quit-application
[task 2022-02-01T03:53:35.260Z] 03:53:35     INFO - GECKO(7204) | 1643687615259	Marionette	INFO	Stopped listening on port 2828
[task 2022-02-01T03:53:35.262Z] 03:53:35     INFO - GECKO(7204) | 1643687615261	Marionette	DEBUG	Marionette stopped listening
[task 2022-02-01T03:53:35.660Z] 03:53:35     INFO - GECKO(7204) | JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2022-02-01T03:53:35.664Z] 03:53:35     INFO - GECKO(7204) | ###!!! [Parent][PCompositorManagerParent] Error: RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-02-01T03:53:35.665Z] 03:53:35     INFO - GECKO(7204) | ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-02-01T03:53:35.916Z] 03:53:35     INFO - GECKO(7204) | JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2022-02-01T03:53:35.921Z] 03:53:35     INFO - GECKO(7204) | ###!!! [Parent][PCompositorManagerParent] Error: RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-02-01T03:53:37.379Z] 03:53:37     INFO - GECKO(7204) | ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-02-01T03:53:40.012Z] 03:53:40     INFO - TEST-INFO | Main app process: exit 0
[task 2022-02-01T03:53:40.013Z] 03:53:40     INFO - runtests.py | Application ran for: 0:15:48.680032
[task 2022-02-01T03:53:40.015Z] 03:53:40     INFO - zombiecheck | Reading PID log: /tmp/tmpk2de_py_pidlog
[task 2022-02-01T03:53:40.017Z] 03:53:40     INFO - ==> process 7204 launched child process 7221
[task 2022-02-01T03:53:40.018Z] 03:53:40     INFO - ==> process 7204 launched child process 7292
[task 2022-02-01T03:53:40.021Z] 03:53:40     INFO - ==> process 7204 launched child process 7317
[task 2022-02-01T03:53:40.021Z] 03:53:40     INFO - ==> process 7204 launched child process 7320
[task 2022-02-01T03:53:40.021Z] 03:53:40     INFO - ==> process 7204 launched child process 7324
[task 2022-02-01T03:53:40.021Z] 03:53:40     INFO - ==> process 7204 launched child process 7392
[task 2022-02-01T03:53:40.021Z] 03:53:40     INFO - ==> process 7204 launched child process 7434
[task 2022-02-01T03:53:40.022Z] 03:53:40     INFO - ==> process 7204 launched child process 7476
[task 2022-02-01T03:53:40.022Z] 03:53:40     INFO - ==> process 7204 launched child process 7563
[task 2022-02-01T03:53:40.022Z] 03:53:40     INFO - ==> process 7204 launched child process 9003
[task 2022-02-01T03:53:40.022Z] 03:53:40     INFO - ==> process 7204 launched child process 9448
[task 2022-02-01T03:53:40.022Z] 03:53:40     INFO - ==> process 7204 launched child process 10196
[task 2022-02-01T03:53:40.022Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 7392
[task 2022-02-01T03:53:40.022Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 9448
[task 2022-02-01T03:53:40.022Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 7434
[task 2022-02-01T03:53:40.022Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 7563
[task 2022-02-01T03:53:40.022Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 9003
[task 2022-02-01T03:53:40.022Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 7292
[task 2022-02-01T03:53:40.023Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 7476
[task 2022-02-01T03:53:40.023Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 7221
[task 2022-02-01T03:53:40.023Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 7317
[task 2022-02-01T03:53:40.023Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 10196
[task 2022-02-01T03:53:40.023Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 7320
[task 2022-02-01T03:53:40.023Z] 03:53:40     INFO - zombiecheck | Checking for orphan process with PID: 7324
[task 2022-02-01T03:53:40.023Z] 03:53:40     INFO - Stopping web server
[task 2022-02-01T03:53:40.036Z] 03:53:40     INFO - Server shut down.
[task 2022-02-01T03:53:40.065Z] 03:53:40     INFO - Web server killed.
[task 2022-02-01T03:53:40.065Z] 03:53:40     INFO - Stopping web socket server
[task 2022-02-01T03:53:40.085Z] 03:53:40     INFO - Stopping ssltunnel
[task 2022-02-01T03:53:40.107Z] 03:53:40     INFO -  websocket/process bridge listening on port 8191
[task 2022-02-01T03:53:40.187Z] 03:53:40     INFO - Stopping websocket/process bridge
[task 2022-02-01T03:53:40.188Z] 03:53:40  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2022-02-01T03:53:40.188Z] 03:53:40     INFO - runtests.py | Running tests: end.
[task 2022-02-01T03:53:40.232Z] 03:53:40     INFO - Buffered messages logged at 03:53:32
Regressed by: 1748333

This appears to be the same bug as 1752959. The stack on this one is more useful though.

Has Regression Range: --- → yes
Blocks: tsan

Byron, is it safe to close this now?

Flags: needinfo?(docfaraday)

I think so.

Status: NEW → RESOLVED
Closed: 4 years ago
Flags: needinfo?(docfaraday)
Resolution: --- → FIXED
No longer blocks: tsan
No longer regressed by: 1748333
Resolution: FIXED → DUPLICATE
See Also: 1752959
You need to log in before you can comment on or make changes to this bug.