Closed Bug 1685752 Opened 3 years ago Closed 2 years ago

Intermittent SUMMARY: ThreadSanitizer: data race /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/alloc.rs:42:9 in std::sys::unix::alloc::_$LT$impl$u20$core..alloc..global..GlobalAlloc$u20$for$u20$std..alloc..System$GT$::deall

Categories

(Core :: CSS Parsing and Computation, defect, P5)

defect

Tracking

()

RESOLVED FIXED
98 Branch
Tracking Status
firefox96 --- wontfix
firefox97 --- wontfix
firefox98 --- fixed

People

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

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure, Whiteboard: [stockwell unknown])

Attachments

(2 files)

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


[task 2021-01-08T15:58:32.669Z] 15:58:32     INFO - GECKO(3291) |   Thread T21 'StyleThread#1' (tid=3426, running) created by main thread at:
[task 2021-01-08T15:58:32.669Z] 15:58:32     INFO - GECKO(3291) |     #0 pthread_create /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors_posix.cpp:966:3 (firefox+0x5668b)
[task 2021-01-08T15:58:32.669Z] 15:58:32     INFO - GECKO(3291) |     #1 std::sys::unix::thread::Thread::new::he0fcb8382fb479a0 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/thread.rs:50:19 (libxul.so+0x7ff76e5)
[task 2021-01-08T15:58:32.670Z] 15:58:32     INFO - GECKO(3291) |     #2 std::thread::Builder::spawn_unchecked::ha601f745baa9c56b /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:498:22 (libxul.so+0x7ec4f07)
[task 2021-01-08T15:58:32.670Z] 15:58:32     INFO - GECKO(3291) |     #3 std::thread::Builder::spawn::h3ad6817dae0d71a6 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:381:18 (libxul.so+0x7ec4f07)
[task 2021-01-08T15:58:32.670Z] 15:58:32     INFO - GECKO(3291) |     #4 _$LT$rayon_core..registry..DefaultSpawn$u20$as$u20$rayon_core..registry..ThreadSpawn$GT$::spawn::h72e927ef12ab1721 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:101:9 (libxul.so+0x7ec4f07)
[task 2021-01-08T15:58:32.670Z] 15:58:32     INFO - GECKO(3291) |     #5 rayon_core::registry::Registry::new::hab306d15e6200bd3 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:260:29 (libxul.so+0x81277f7)
[task 2021-01-08T15:58:32.670Z] 15:58:32     INFO - GECKO(3291) |     #6 rayon_core::thread_pool::ThreadPool::build::h88161ce417c8eefc /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/thread_pool/mod.rs:69:24 (libxul.so+0x81277f7)
[task 2021-01-08T15:58:32.671Z] 15:58:32     INFO - GECKO(3291) |     #7 rayon_core::ThreadPoolBuilder$LT$S$GT$::build::hc3d42f131963fd06 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/lib.rs:202:9 (libxul.so+0x81277f7)
[task 2021-01-08T15:58:32.671Z] 15:58:32     INFO - GECKO(3291) |     #8 _$LT$style..global_style_data..STYLE_THREAD_POOL$u20$as$u20$core..ops..deref..Deref$GT$::deref::__static_ref_initialize::h32b79a21486e8dfa /builds/worker/checkouts/gecko/servo/components/style/global_style_data.rs:152:27 (libxul.so+0x81277f7)
[task 2021-01-08T15:58:32.673Z] 15:58:32     INFO - GECKO(3291) |     #9 core::ops::function::FnOnce::call_once::hfd8aa1e889f89652 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ops/function.rs:227:5 (libxul.so+0x81277f7)
[task 2021-01-08T15:58:32.673Z] 15:58:32     INFO - GECKO(3291) |     #10 lazy_static::lazy::Lazy$LT$T$GT$::get::_$u7b$$u7b$closure$u7d$$u7d$::hdf1331e0df157689 /builds/worker/checkouts/gecko/third_party/rust/lazy_static/src/inline_lazy.rs:31:29 (libxul.so+0x81277f7)
[task 2021-01-08T15:58:32.673Z] 15:58:32     INFO - GECKO(3291) |     #11 std::sync::once::Once::call_once::_$u7b$$u7b$closure$u7d$$u7d$::hd1ffaec532db8c01 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sync/once.rs:261:41 (libxul.so+0x81277f7)
[task 2021-01-08T15:58:32.673Z] 15:58:32     INFO - GECKO(3291) |     #12 std::sync::once::Once::call_inner::h9118e984e86aa9c3 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sync/once.rs:419:21 (libxul.so+0x7feb552)
[task 2021-01-08T15:58:32.673Z] 15:58:32     INFO - GECKO(3291) |     #13 std::sync::once::Once::call_once::h84a0686d71a1c72b /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sync/once.rs:261:9 (libxul.so+0x832a9ad)
[task 2021-01-08T15:58:32.674Z] 15:58:32     INFO - GECKO(3291) |     #14 lazy_static::lazy::Lazy$LT$T$GT$::get::h8bfa7001399b788c /builds/worker/checkouts/gecko/third_party/rust/lazy_static/src/inline_lazy.rs:30:9 (libxul.so+0x832a9ad)
[task 2021-01-08T15:58:32.674Z] 15:58:32     INFO - GECKO(3291) |     #15 _$LT$style..global_style_data..STYLE_THREAD_POOL$u20$as$u20$core..ops..deref..Deref$GT$::deref::__stability::hb0a2673a21e52338 /builds/worker/checkouts/gecko/third_party/rust/lazy_static/src/lib.rs:142:21 (libxul.so+0x832a9ad)
[task 2021-01-08T15:58:32.676Z] 15:58:32     INFO - GECKO(3291) |     #16 _$LT$style..global_style_data..STYLE_THREAD_POOL$u20$as$u20$core..ops..deref..Deref$GT$::deref::h578b0ca9aa209ca2 /builds/worker/checkouts/gecko/third_party/rust/lazy_static/src/lib.rs:144:17 (libxul.so+0x832a9ad)
[task 2021-01-08T15:58:32.676Z] 15:58:32     INFO - GECKO(3291) |     #17 geckoservo::glue::traverse_subtree::hca578a3e4bac8c3b /builds/worker/checkouts/gecko/servo/ports/geckolib/glue.rs:255:31 (libxul.so+0x79ebc3c)
[task 2021-01-08T15:58:32.676Z] 15:58:32     INFO - GECKO(3291) |     #18 Servo_TraverseSubtree /builds/worker/checkouts/gecko/servo/ports/geckolib/glue.rs:325:5 (libxul.so+0x79eb705)
[task 2021-01-08T15:58:32.676Z] 15:58:32     INFO - GECKO(3291) |     #19 mozilla::ServoStyleSet::StyleNewSubtree(mozilla::dom::Element*) /builds/worker/checkouts/gecko/layout/style/ServoStyleSet.cpp:806:7 (libxul.so+0x4d3487d)
[task 2021-01-08T15:58:32.677Z] 15:58:32     INFO - GECKO(3291) |     #20 nsCSSFrameConstructor::ConstructDocElementFrame(mozilla::dom::Element*) /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:2166:29 (libxul.so+0x4e1ba59)
[task 2021-01-08T15:58:32.677Z] 15:58:32     INFO - GECKO(3291) |     #21 nsCSSFrameConstructor::ContentRangeInserted(nsIContent*, nsIContent*, nsCSSFrameConstructor::InsertionKind) /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:6899:9 (libxul.so+0x4e2caec)
[task 2021-01-08T15:58:32.677Z] 15:58:32     INFO - GECKO(3291) |     #22 nsCSSFrameConstructor::ContentInserted(nsIContent*, nsCSSFrameConstructor::InsertionKind) /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:6817:3 (libxul.so+0x4e2c6d1)
[task 2021-01-08T15:58:32.678Z] 15:58:32     INFO - GECKO(3291) |     #23 mozilla::PresShell::Initialize() /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:1893:26 (libxul.so+0x4dcbc09)
[task 2021-01-08T15:58:32.678Z] 15:58:32     INFO - GECKO(3291) |     #24 nsContentSink::StartLayout(bool) /builds/worker/checkouts/gecko/dom/base/nsContentSink.cpp:1140:30 (libxul.so+0x25dd1c6)
[task 2021-01-08T15:58:32.679Z] 15:58:32     INFO - GECKO(3291) |     #25 HTMLContentSink::OpenBody() /builds/worker/checkouts/gecko/dom/html/nsHTMLContentSink.cpp:776:3 (libxul.so+0x3ace323)
[task 2021-01-08T15:58:32.679Z] 15:58:32     INFO - GECKO(3291) |     #26 HTMLContentSink::OpenContainer(nsIHTMLContentSink::ElementType) /builds/worker/checkouts/gecko/dom/html/nsHTMLContentSink.cpp:795:12 (libxul.so+0x3ace374)
[task 2021-01-08T15:58:32.680Z] 15:58:32     INFO - GECKO(3291) |     #27 non-virtual thunk to HTMLContentSink::OpenContainer(nsIHTMLContentSink::ElementType) /builds/worker/checkouts/gecko/dom/html/nsHTMLContentSink.cpp (libxul.so+0x3ace515)
[task 2021-01-08T15:58:32.680Z] 15:58:32     INFO - GECKO(3291) |     #28 CNavDTD::BuildModel(nsITokenizer*, nsIContentSink*) /builds/worker/checkouts/gecko/parser/htmlparser/CNavDTD.cpp:36:14 (libxul.so+0x1bb586d)
[task 2021-01-08T15:58:32.680Z] 15:58:32     INFO - GECKO(3291) |     #29 BuildModel /builds/worker/checkouts/gecko/parser/htmlparser/nsParser.cpp:1058:22 (libxul.so+0x1bbdf11)
[task 2021-01-08T15:58:32.681Z] 15:58:32     INFO - GECKO(3291) |     #30 nsParser::ResumeParse(bool, bool, bool) /builds/worker/checkouts/gecko/parser/htmlparser/nsParser.cpp:963:18 (libxul.so+0x1bbdf11)
[task 2021-01-08T15:58:32.681Z] 15:58:32     INFO - GECKO(3291) |     #31 OnStopRequest /builds/worker/checkouts/gecko/parser/htmlparser/nsParser.cpp:1352:10 (libxul.so+0x1bc0860)
[task 2021-01-08T15:58:32.681Z] 15:58:32     INFO - GECKO(3291) |     #32 non-virtual thunk to nsParser::OnStopRequest(nsIRequest*, nsresult) /builds/worker/checkouts/gecko/parser/htmlparser/nsParser.cpp (libxul.so+0x1bc0860)
[task 2021-01-08T15:58:32.681Z] 15:58:32     INFO - GECKO(3291) |     #33 nsDocumentOpenInfo::OnStopRequest(nsIRequest*, nsresult) /builds/worker/checkouts/gecko/uriloader/base/nsURILoader.cpp:215:15 (libxul.so+0x1b39ab4)
[task 2021-01-08T15:58:32.682Z] 15:58:32     INFO - GECKO(3291) |     #34 nsBaseChannel::OnStopRequest(nsIRequest*, nsresult) /builds/worker/checkouts/gecko/netwerk/base/nsBaseChannel.cpp:853:16 (libxul.so+0xcc3a18)
[task 2021-01-08T15:58:32.683Z] 15:58:32     INFO - GECKO(3291) |     #35 non-virtual thunk to nsBaseChannel::OnStopRequest(nsIRequest*, nsresult) /builds/worker/checkouts/gecko/netwerk/base/nsBaseChannel.cpp (libxul.so+0xcc3b95)
[task 2021-01-08T15:58:32.683Z] 15:58:32     INFO - GECKO(3291) |     #36 nsInputStreamPump::OnStateStop() /builds/worker/checkouts/gecko/netwerk/base/nsInputStreamPump.cpp:649:16 (libxul.so+0xcea9a3)
[task 2021-01-08T15:58:32.683Z] 15:58:32     INFO - GECKO(3291) |     #37 nsInputStreamPump::OnInputStreamReady(nsIAsyncInputStream*) /builds/worker/checkouts/gecko/netwerk/base/nsInputStreamPump.cpp:397:21 (libxul.so+0xce9af2)
[task 2021-01-08T15:58:32.685Z] 15:58:32     INFO - GECKO(3291) |     #38 non-virtual thunk to nsInputStreamPump::OnInputStreamReady(nsIAsyncInputStream*) /builds/worker/checkouts/gecko/netwerk/base/nsInputStreamPump.cpp (libxul.so+0xceac29)
[task 2021-01-08T15:58:32.685Z] 15:58:32     INFO - GECKO(3291) |     #39 RunAsyncWaitCallback /builds/worker/checkouts/gecko/xpcom/io/NonBlockingAsyncInputStream.cpp:397:13 (libxul.so+0xb1888c)
[task 2021-01-08T15:58:32.685Z] 15:58:32     INFO - GECKO(3291) |     #40 mozilla::NonBlockingAsyncInputStream::AsyncWaitRunnable::Run() /builds/worker/checkouts/gecko/xpcom/io/NonBlockingAsyncInputStream.cpp:33:14 (libxul.so+0xb1888c)
[task 2021-01-08T15:58:32.685Z] 15:58:32     INFO - GECKO(3291) |     #41 mozilla::RunnableTask::Run() /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:459:16 (libxul.so+0xb77f42)
[task 2021-01-08T15:58:32.686Z] 15:58:32     INFO - GECKO(3291) |     #42 mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:739:26 (libxul.so+0xb75e80)
[task 2021-01-08T15:58:32.687Z] 15:58:32     INFO - GECKO(3291) |     #43 mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:598:15 (libxul.so+0xb74ae6)
[task 2021-01-08T15:58:32.687Z] 15:58:32     INFO - GECKO(3291) |     #44 mozilla::TaskController::ProcessPendingMTTask(bool) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:382:36 (libxul.so+0xb74d84)
[task 2021-01-08T15:58:32.687Z] 15:58:32     INFO - GECKO(3291) |     #45 operator() /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:123:37 (libxul.so+0xb7af37)
[task 2021-01-08T15:58:32.688Z] 15:58:32     INFO - GECKO(3291) |     #46 mozilla::detail::RunnableFunction<mozilla::TaskController::InitializeInternal()::$_3>::Run() /builds/worker/workspace/obj-build/dist/include/nsThreadUtils.h:534:5 (libxul.so+0xb7af37)
[task 2021-01-08T15:58:32.689Z] 15:58:32     INFO - GECKO(3291) |     #47 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1200:14 (libxul.so+0xb8bf7a)
[task 2021-01-08T15:58:32.689Z] 15:58:32     INFO - GECKO(3291) |     #48 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:548:10 (libxul.so+0xb91cb2)
[task 2021-01-08T15:58:32.689Z] 15:58:32     INFO - GECKO(3291) |     #49 mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:87:21 (libxul.so+0x148db5d)
[task 2021-01-08T15:58:32.689Z] 15:58:32     INFO - GECKO(3291) |     #50 mozilla::ipc::MessagePumpForChildProcess::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:270:30 (libxul.so+0x148e5fb)
[task 2021-01-08T15:58:32.690Z] 15:58:32     INFO - GECKO(3291) |     #51 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:334:10 (libxul.so+0x1418fcc)
[task 2021-01-08T15:58:32.691Z] 15:58:32     INFO - GECKO(3291) |     #52 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:327:3 (libxul.so+0x1418fcc)
[task 2021-01-08T15:58:32.691Z] 15:58:32     INFO - GECKO(3291) |     #53 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:309:3 (libxul.so+0x1418fcc)
[task 2021-01-08T15:58:32.691Z] 15:58:32     INFO - GECKO(3291) |     #54 nsBaseAppShell::Run() /builds/worker/checkouts/gecko/widget/nsBaseAppShell.cpp:137:27 (libxul.so+0x4adb6e6)
[task 2021-01-08T15:58:32.691Z] 15:58:32     INFO - GECKO(3291) |     #55 XRE_RunAppShell() /builds/worker/checkouts/gecko/toolkit/xre/nsEmbedFunctions.cpp:902:20 (libxul.so+0x67404a9)
[task 2021-01-08T15:58:32.693Z] 15:58:32     INFO - GECKO(3291) |     #56 mozilla::ipc::MessagePumpForChildProcess::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:237:9 (libxul.so+0x148e5ad)
[task 2021-01-08T15:58:32.693Z] 15:58:32     INFO - GECKO(3291) |     #57 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:334:10 (libxul.so+0x1418fcc)
[task 2021-01-08T15:58:32.693Z] 15:58:32     INFO - GECKO(3291) |     #58 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:327:3 (libxul.so+0x1418fcc)
[task 2021-01-08T15:58:32.693Z] 15:58:32     INFO - GECKO(3291) |     #59 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:309:3 (libxul.so+0x1418fcc)
[task 2021-01-08T15:58:32.694Z] 15:58:32     INFO - GECKO(3291) |     #60 XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/nsEmbedFunctions.cpp:733:34 (libxul.so+0x674022a)
[task 2021-01-08T15:58:32.694Z] 15:58:32     INFO - GECKO(3291) |     #61 mozilla::BootstrapImpl::XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:67:12 (libxul.so+0x6747ec2)
[task 2021-01-08T15:58:32.694Z] 15:58:32     INFO - GECKO(3291) |     #62 content_process_main /builds/worker/checkouts/gecko/browser/app/../../ipc/contentproc/plugin-container.cpp:57:28 (firefox+0xc7901)
[task 2021-01-08T15:58:32.696Z] 15:58:32     INFO - GECKO(3291) |     #63 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:305:18 (firefox+0xc7901)
[task 2021-01-08T15:58:32.696Z] 15:58:32     INFO - GECKO(3291) | SUMMARY: ThreadSanitizer: data race /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/alloc.rs:42:9 in std::sys::unix::alloc::_$LT$impl$u20$core..alloc..global..GlobalAlloc$u20$for$u20$std..alloc..System$GT$::dealloc::hf2558a0b1315b81b
[task 2021-01-08T15:58:32.696Z] 15:58:32     INFO - GECKO(3291) | ==================



[task 2021-01-08T15:57:55.058Z] 15:57:55     INFO - TEST-START | layout/generic/test/test_scroll_position_restore.html```
Blocks: tsan
Component: Layout → CSS Parsing and Computation

Another instance slipping through the cracks of the crossbeam supressions.

Looks like the new supression worked for this

Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → WORKSFORME

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=348225499&repo=mozilla-esr91&lineNumber=2935

[task 2021-08-12T13:38:39.862Z] 13:38:39     INFO - REFTEST TEST-START | layout/base/crashtests/468555-1.xhtml
[task 2021-08-12T13:38:39.865Z] 13:38:39     INFO - REFTEST TEST-LOAD | file:///builds/worker/workspace/build/tests/reftest/tests/layout/base/crashtests/468555-1.xhtml | 120 / 121 (99%)
[task 2021-08-12T13:38:40.050Z] 13:38:40     INFO - REFTEST TEST-PASS | layout/base/crashtests/468555-1.xhtml | (LOAD ONLY)
[task 2021-08-12T13:38:40.050Z] 13:38:40     INFO - REFTEST TEST-END | layout/base/crashtests/468555-1.xhtml
[task 2021-08-12T13:38:40.113Z] 13:38:40     INFO - REFTEST INFO | Result summary:
[task 2021-08-12T13:38:40.113Z] 13:38:40     INFO - REFTEST INFO | Successful: 121 (0 pass, 121 load only)
[task 2021-08-12T13:38:40.114Z] 13:38:40     INFO - REFTEST INFO | Unexpected: 0 (0 unexpected fail, 0 unexpected pass, 0 unexpected asserts, 0 failed load, 0 exception)
[task 2021-08-12T13:38:40.115Z] 13:38:40     INFO - REFTEST INFO | Known problems: 0 (0 known fail, 0 known asserts, 0 random, 0 skipped, 0 slow)
[task 2021-08-12T13:38:40.115Z] 13:38:40     INFO - REFTEST SUITE-END | Shutdown
[task 2021-08-12T13:38:40.117Z] 13:38:40     INFO - REFTEST INFO | Slowest test took 3485ms (file:///builds/worker/workspace/build/tests/reftest/tests/layout/base/crashtests/373628-1.html)
[task 2021-08-12T13:38:40.119Z] 13:38:40     INFO - REFTEST INFO | Total canvas count = 0
[task 2021-08-12T13:38:40.848Z] 13:38:40     INFO - 1628775520846	Marionette	TRACE	Received observer notification quit-application
[task 2021-08-12T13:38:40.852Z] 13:38:40     INFO - 1628775520850	Marionette	INFO	Stopped listening on port 2828
[task 2021-08-12T13:38:40.855Z] 13:38:40     INFO - 1628775520851	Marionette	DEBUG	Marionette stopped listening
[task 2021-08-12T13:38:41.357Z] 13:38:41     INFO - JavaScript error: resource:///modules/Interactions.jsm, line 209: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIUserIdleService.removeIdleObserver]
[task 2021-08-12T13:38:42.455Z] 13:38:42     INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-08-12T13:38:42.468Z] 13:38:42     INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-08-12T13:38:42.470Z] 13:38:42     INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-08-12T13:38:51.814Z] 13:38:51     INFO - ==================
[task 2021-08-12T13:38:51.816Z] 13:38:51     INFO - WARNING: ThreadSanitizer: data race (pid=1456)
[task 2021-08-12T13:38:51.817Z] 13:38:51     INFO -   Write of size 8 at 0x7b7400260200 by thread T47:
[task 2021-08-12T13:38:51.817Z] 13:38:51     INFO -     #0 free /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors_posix.cpp:707:3 (firefox+0x565d8)
[task 2021-08-12T13:38:51.818Z] 13:38:51     INFO -     #1 std::sys::unix::alloc::_$LT$impl$u20$core..alloc..global..GlobalAlloc$u20$for$u20$std..alloc..System$GT$::dealloc::hc30512f2445cb68e /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/alloc.rs:42:9 (libxul.so+0x7eeb906)
[task 2021-08-12T13:38:51.819Z] 13:38:51     INFO -     #2 __rdl_dealloc /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/alloc.rs:365:18 (libxul.so+0x7eeb906)
[task 2021-08-12T13:38:51.820Z] 13:38:51     INFO -     #3 alloc::alloc::dealloc::h46ef56a1f2c8a9fa /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/alloc.rs:104:14 (libxul.so+0x77964b9)
[task 2021-08-12T13:38:51.821Z] 13:38:51     INFO -     #4 _$LT$alloc..alloc..Global$u20$as$u20$core..alloc..Allocator$GT$::deallocate::h0cf830c4369bc87a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/alloc.rs:239:22 (libxul.so+0x77964b9)
[task 2021-08-12T13:38:51.826Z] 13:38:51     INFO -     #5 alloc::alloc::box_free::hdd9ba752e43c073c /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/alloc.rs:334:9 (libxul.so+0x77964b9)
[task 2021-08-12T13:38:51.827Z] 13:38:51     INFO -     #6 core::ptr::drop_in_place$LT$alloc..boxed..Box$LT$crossbeam_epoch..internal..Local$GT$$GT$::h8a0c8fa0106e1339 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ptr/mod.rs:192:1 (libxul.so+0x77964b9)
[task 2021-08-12T13:38:51.828Z] 13:38:51     INFO -     #7 core::mem::drop::he6522a8ef8bff00d /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/mem/mod.rs:891:24 (libxul.so+0x77964b9)
[task 2021-08-12T13:38:51.829Z] 13:38:51     INFO -     #8 _$LT$crossbeam_epoch..atomic..Owned$LT$T$GT$$u20$as$u20$core..ops..drop..Drop$GT$::drop::h362522160a588ad5 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/atomic.rs:760:13 (libxul.so+0x77964b9)
[task 2021-08-12T13:38:51.830Z] 13:38:51     INFO -     #9 core::ptr::drop_in_place$LT$crossbeam_epoch..atomic..Owned$LT$crossbeam_epoch..internal..Local$GT$$GT$::hbebd3946879c164b /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ptr/mod.rs:192:1 (libxul.so+0x77964b9)
[task 2021-08-12T13:38:51.831Z] 13:38:51     INFO -     #10 core::mem::drop::h3578648017a6ccf1 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/mem/mod.rs:891:24 (libxul.so+0x77964b9)
[task 2021-08-12T13:38:51.832Z] 13:38:51     INFO -     #11 crossbeam_epoch::guard::Guard::defer_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::h735fe990e47826bd /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/guard.rs:195:47 (libxul.so+0x77964b9)
[task 2021-08-12T13:38:51.833Z] 13:38:51     INFO -     #12 crossbeam_epoch::deferred::Deferred::new::call::he419266ea7b94892 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/deferred.rs:46:21 (libxul.so+0x77964b9)
[task 2021-08-12T13:38:51.834Z] 13:38:51     INFO -     #13 crossbeam_epoch::deferred::Deferred::call::hc5160e87d7dfc55b /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/deferred.rs:77:18 (libxul.so+0x9c827a)
[task 2021-08-12T13:38:51.835Z] 13:38:51     INFO -     #14 _$LT$crossbeam_epoch..internal..Bag$u20$as$u20$core..ops..drop..Drop$GT$::drop::h01de7404a990ac2c /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/internal.rs:201:13 (libxul.so+0x9c827a)
[task 2021-08-12T13:38:51.838Z] 13:38:51     INFO -     #15 core::ptr::drop_in_place$LT$crossbeam_epoch..internal..Bag$GT$::hfaac2c349f83eb49 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ptr/mod.rs:192:1 (libxul.so+0x9c827a)
[task 2021-08-12T13:38:51.839Z] 13:38:51     INFO -     #16 core::ptr::drop_in_place$LT$crossbeam_epoch..internal..SealedBag$GT$::he31b2560e646da38 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ptr/mod.rs:192:1 (libxul.so+0x9c827a)
[task 2021-08-12T13:38:51.841Z] 13:38:51     INFO -     #17 core::mem::drop::h0da076a012118ddc /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/mem/mod.rs:891:24 (libxul.so+0x9c827a)
[task 2021-08-12T13:38:51.847Z] 13:38:51     INFO -     #18 crossbeam_epoch::internal::Global::collect::h0c6d61f157cd3874 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/internal.rs:295:37 (libxul.so+0x9c827a)
[task 2021-08-12T13:38:51.848Z] 13:38:51     INFO -     #19 crossbeam_epoch::internal::Local::pin::hdc9f51a22b2cd170 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/internal.rs:497:17 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.850Z] 13:38:51     INFO -     #20 crossbeam_epoch::collector::LocalHandle::pin::h4f8efcc2514bfca0 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/collector.rs:75:18 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.852Z] 13:38:51     INFO -     #21 crossbeam_epoch::default::pin::_$u7b$$u7b$closure$u7d$$u7d$::haed52855a5fa0eb0 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:23:26 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.853Z] 13:38:51     INFO -     #22 crossbeam_epoch::default::with_handle::_$u7b$$u7b$closure$u7d$$u7d$::hcf1a27b414d711fe /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:43:23 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.855Z] 13:38:51     INFO -     #23 std::thread::local::LocalKey$LT$T$GT$::try_with::h1c7afd3b40d029d6 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/local.rs:376:16 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.857Z] 13:38:51     INFO -     #24 crossbeam_epoch::default::with_handle::h9dbb80fdb6b1b0a5 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:42:5 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.858Z] 13:38:51     INFO -     #25 crossbeam_epoch::default::pin::hcb6d5d7e59a7a878 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:23:5 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.860Z] 13:38:51     INFO -     #26 crossbeam_deque::Stealer$LT$T$GT$::steal::h688c1b9918688358 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-deque/src/lib.rs:698:22 (libxul.so+0x7dc8651)
[task 2021-08-12T13:38:51.868Z] 13:38:51     INFO -     #27 rayon_core::registry::WorkerThread::steal::_$u7b$$u7b$closure$u7d$$u7d$::hd35ab8b8e452c168 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:779:27 (libxul.so+0x7dc8651)
[task 2021-08-12T13:38:51.870Z] 13:38:51     INFO -     #28 core::iter::traits::iterator::Iterator::find_map::check::_$u7b$$u7b$closure$u7d$$u7d$::hb9d60555b4a5230a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/traits/iterator.rs:2384:32 (libxul.so+0x7dc8651)
[task 2021-08-12T13:38:51.872Z] 13:38:51     INFO -     #29 core::iter::adapters::filter::filter_try_fold::_$u7b$$u7b$closure$u7d$$u7d$::hf5961e4869591efc /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/adapters/filter.rs:44:44 (libxul.so+0x7dc8651)
[task 2021-08-12T13:38:51.873Z] 13:38:51     INFO -     #30 core::iter::traits::iterator::Iterator::try_fold::h6b1bc7da529f3ad1 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/traits/iterator.rs:2006:21 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.875Z] 13:38:51     INFO -     #31 _$LT$core..iter..adapters..chain..Chain$LT$A$C$B$GT$$u20$as$u20$core..iter..traits..iterator..Iterator$GT$::try_fold::h2fb38fc3032618ae /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/adapters/chain.rs:108:19 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.877Z] 13:38:51     INFO -     #32 _$LT$core..iter..adapters..filter..Filter$LT$I$C$P$GT$$u20$as$u20$core..iter..traits..iterator..Iterator$GT$::try_fold::hd9446307b6d8c24f /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/adapters/filter.rs:93:9 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.878Z] 13:38:51     INFO -     #33 core::iter::traits::iterator::Iterator::find_map::h5aa9dd11a0e6170c /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/traits/iterator.rs:2390:9 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.879Z] 13:38:51     INFO -     #34 rayon_core::registry::WorkerThread::steal::h9814ce3d418a5459 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:774:23 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.880Z] 13:38:51     INFO -     #35 rayon_core::registry::WorkerThread::wait_until_cold::_$u7b$$u7b$closure$u7d$$u7d$::h1533ba9d0af8ed4d /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:726:29 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.881Z] 13:38:51     INFO -     #36 core::option::Option$LT$T$GT$::or_else::h0b8f383e7518b5af /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/option.rs:788:21 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.882Z] 13:38:51     INFO -     #37 rayon_core::registry::WorkerThread::wait_until_cold::heabb5d15cd383390 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:724:32 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.882Z] 13:38:51     INFO -     #38 rayon_core::registry::WorkerThread::wait_until::h906cfe1d88953cf4 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:704:13 (libxul.so+0x7dcad05)
[task 2021-08-12T13:38:51.883Z] 13:38:51     INFO -     #39 rayon_core::registry::main_loop::h5b1a6026d3538e54 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:837:5 (libxul.so+0x7dcad05)
[task 2021-08-12T13:38:51.883Z] 13:38:51     INFO -     #40 rayon_core::registry::ThreadBuilder::run::hce54465142ba1824 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:56:18 (libxul.so+0x7dcad05)
[task 2021-08-12T13:38:51.884Z] 13:38:51     INFO -     #41 _$LT$rayon_core..registry..DefaultSpawn$u20$as$u20$rayon_core..registry..ThreadSpawn$GT$::spawn::_$u7b$$u7b$closure$u7d$$u7d$::hebd482fb756b3666 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:101:20 (libxul.so+0x7dcad05)
[task 2021-08-12T13:38:51.885Z] 13:38:51     INFO -     #42 std::sys_common::backtrace::__rust_begin_short_backtrace::hf388b4879bac49c4 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys_common/backtrace.rs:125:18 (libxul.so+0x7dcad05)
[task 2021-08-12T13:38:51.885Z] 13:38:51     INFO -     #43 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::_$u7b$$u7b$closure$u7d$$u7d$::hb9e39a8787d5076a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:481:17 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.886Z] 13:38:51     INFO -     #44 _$LT$std..panic..AssertUnwindSafe$LT$F$GT$$u20$as$u20$core..ops..function..FnOnce$LT$$LP$$RP$$GT$$GT$::call_once::hefd2dc54bccc5e64 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panic.rs:344:9 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.887Z] 13:38:51     INFO -     #45 std::panicking::try::do_call::hb413228e0f3efe47 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:379:40 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.888Z] 13:38:51     INFO -     #46 std::panicking::try::h5d6bec00110e8dff /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:343:19 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.888Z] 13:38:51     INFO -     #47 std::panic::catch_unwind::hdfbd494db0fbb68b /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panic.rs:431:14 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.889Z] 13:38:51     INFO -     #48 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::hc11461aed3a3bbac /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:480:30 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.890Z] 13:38:51     INFO -     #49 core::ops::function::FnOnce::call_once$u7b$$u7b$vtable.shim$u7d$$u7d$::h93adb23bd0accc89 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ops/function.rs:227:5 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.890Z] 13:38:51     INFO -     #50 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::_$u7b$$u7b$closure$u7d$$u7d$::hb9e39a8787d5076a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:481:17 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.891Z] 13:38:51     INFO -     #51 _$LT$std..panic..AssertUnwindSafe$LT$F$GT$$u20$as$u20$core..ops..function..FnOnce$LT$$LP$$RP$$GT$$GT$::call_once::hefd2dc54bccc5e64 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panic.rs:344:9 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.892Z] 13:38:51     INFO -     #52 std::panicking::try::do_call::hb413228e0f3efe47 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:379:40 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.893Z] 13:38:51     INFO -     #53 std::panicking::try::h5d6bec00110e8dff /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:343:19 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.893Z] 13:38:51     INFO -     #54 std::panic::catch_unwind::hdfbd494db0fbb68b /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panic.rs:431:14 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.894Z] 13:38:51     INFO -     #55 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::hc11461aed3a3bbac /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:480:30 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.895Z] 13:38:51     INFO -     #56 core::ops::function::FnOnce::call_once$u7b$$u7b$vtable.shim$u7d$$u7d$::h93adb23bd0accc89 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ops/function.rs:227:5 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.896Z] 13:38:51     INFO -     #57 _$LT$alloc..boxed..Box$LT$F$C$A$GT$$u20$as$u20$core..ops..function..FnOnce$LT$Args$GT$$GT$::call_once::hddd425db0b4240a1 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/boxed.rs:1546:9 (libxul.so+0x7eed016)
[task 2021-08-12T13:38:51.896Z] 13:38:51     INFO -     #58 _$LT$alloc..boxed..Box$LT$F$C$A$GT$$u20$as$u20$core..ops..function..FnOnce$LT$Args$GT$$GT$::call_once::h7e8c9405d5d08b7a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/boxed.rs:1546:9 (libxul.so+0x7eed016)
[task 2021-08-12T13:38:51.897Z] 13:38:51     INFO -     #59 std::sys::unix::thread::Thread::new::thread_start::h3769be6c1ba69e87 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/thread.rs:71:17 (libxul.so+0x7eed016)
[task 2021-08-12T13:38:51.898Z] 13:38:51     INFO -   Previous atomic read of size 8 at 0x7b7400260200 by thread T29:
[task 2021-08-12T13:38:51.898Z] 13:38:51     INFO -     #0 __tsan_atomic64_load /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interface_atomic.cpp:539:3 (firefox+0xa325e)
[task 2021-08-12T13:38:51.899Z] 13:38:51     INFO -     #1 core::sync::atomic::atomic_load::hb586bce3631ea3cf /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/sync/atomic.rs:2353:24 (libxul.so+0x9c834c)
[task 2021-08-12T13:38:51.900Z] 13:38:51     INFO -     #2 core::sync::atomic::AtomicUsize::load::h2d27f95094b18894 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/sync/atomic.rs:1492:26 (libxul.so+0x9c834c)
[task 2021-08-12T13:38:51.901Z] 13:38:51     INFO -     #3 crossbeam_epoch::atomic::Atomic$LT$T$GT$::load::hf1109fdd8982f4fb /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/atomic.rs:209:37 (libxul.so+0x9c834c)
[task 2021-08-12T13:38:51.902Z] 13:38:51     INFO -     #4 _$LT$crossbeam_epoch..sync..list..Iter$LT$T$C$C$GT$$u20$as$u20$core..iter..traits..iterator..Iterator$GT$::next::h174a3af47c15629e /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/sync/list.rs:240:24 (libxul.so+0x9c834c)
[task 2021-08-12T13:38:51.903Z] 13:38:51     INFO -     #5 crossbeam_epoch::internal::Global::try_advance::h66493956398adbde /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/internal.rs:316:22 (libxul.so+0x9c834c)
[task 2021-08-12T13:38:51.903Z] 13:38:51     INFO -     #6 crossbeam_epoch::internal::Global::collect::h0c6d61f157cd3874 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/internal.rs:281:28 (libxul.so+0x9c7f8e)
[task 2021-08-12T13:38:51.904Z] 13:38:51     INFO -     #7 crossbeam_epoch::internal::Local::pin::hdc9f51a22b2cd170 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/internal.rs:497:17 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.904Z] 13:38:51     INFO -     #8 crossbeam_epoch::collector::LocalHandle::pin::h4f8efcc2514bfca0 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/collector.rs:75:18 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.905Z] 13:38:51     INFO -     #9 crossbeam_epoch::default::pin::_$u7b$$u7b$closure$u7d$$u7d$::haed52855a5fa0eb0 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:23:26 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.906Z] 13:38:51     INFO -     #10 crossbeam_epoch::default::with_handle::_$u7b$$u7b$closure$u7d$$u7d$::hcf1a27b414d711fe /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:43:23 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.907Z] 13:38:51     INFO -     #11 std::thread::local::LocalKey$LT$T$GT$::try_with::h1c7afd3b40d029d6 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/local.rs:376:16 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.907Z] 13:38:51     INFO -     #12 crossbeam_epoch::default::with_handle::h9dbb80fdb6b1b0a5 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:42:5 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.908Z] 13:38:51     INFO -     #13 crossbeam_epoch::default::pin::hcb6d5d7e59a7a878 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:23:5 (libxul.so+0x7dc8be0)
[task 2021-08-12T13:38:51.909Z] 13:38:51     INFO -     #14 crossbeam_deque::Stealer$LT$T$GT$::steal::h688c1b9918688358 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-deque/src/lib.rs:698:22 (libxul.so+0x7dc8651)
[task 2021-08-12T13:38:51.909Z] 13:38:51     INFO -     #15 rayon_core::registry::WorkerThread::steal::_$u7b$$u7b$closure$u7d$$u7d$::hd35ab8b8e452c168 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:779:27 (libxul.so+0x7dc8651)
[task 2021-08-12T13:38:51.910Z] 13:38:51     INFO -     #16 core::iter::traits::iterator::Iterator::find_map::check::_$u7b$$u7b$closure$u7d$$u7d$::hb9d60555b4a5230a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/traits/iterator.rs:2384:32 (libxul.so+0x7dc8651)
[task 2021-08-12T13:38:51.911Z] 13:38:51     INFO -     #17 core::iter::adapters::filter::filter_try_fold::_$u7b$$u7b$closure$u7d$$u7d$::hf5961e4869591efc /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/adapters/filter.rs:44:44 (libxul.so+0x7dc8651)
[task 2021-08-12T13:38:51.912Z] 13:38:51     INFO -     #18 core::iter::traits::iterator::Iterator::try_fold::h6b1bc7da529f3ad1 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/traits/iterator.rs:2006:21 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.912Z] 13:38:51     INFO -     #19 _$LT$core..iter..adapters..chain..Chain$LT$A$C$B$GT$$u20$as$u20$core..iter..traits..iterator..Iterator$GT$::try_fold::h2fb38fc3032618ae /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/adapters/chain.rs:108:19 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.913Z] 13:38:51     INFO -     #20 _$LT$core..iter..adapters..filter..Filter$LT$I$C$P$GT$$u20$as$u20$core..iter..traits..iterator..Iterator$GT$::try_fold::hd9446307b6d8c24f /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/adapters/filter.rs:93:9 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.914Z] 13:38:51     INFO -     #21 core::iter::traits::iterator::Iterator::find_map::h5aa9dd11a0e6170c /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/traits/iterator.rs:2390:9 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.915Z] 13:38:51     INFO -     #22 rayon_core::registry::WorkerThread::steal::h9814ce3d418a5459 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:774:23 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.915Z] 13:38:51     INFO -     #23 rayon_core::registry::WorkerThread::wait_until_cold::_$u7b$$u7b$closure$u7d$$u7d$::h1533ba9d0af8ed4d /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:726:29 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.916Z] 13:38:51     INFO -     #24 core::option::Option$LT$T$GT$::or_else::h0b8f383e7518b5af /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/option.rs:788:21 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.917Z] 13:38:51     INFO -     #25 rayon_core::registry::WorkerThread::wait_until_cold::heabb5d15cd383390 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:724:32 (libxul.so+0xa03e8d)
[task 2021-08-12T13:38:51.918Z] 13:38:51     INFO -     #26 rayon_core::registry::WorkerThread::wait_until::h906cfe1d88953cf4 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:704:13 (libxul.so+0x7dcad05)
[task 2021-08-12T13:38:51.918Z] 13:38:51     INFO -     #27 rayon_core::registry::main_loop::h5b1a6026d3538e54 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:837:5 (libxul.so+0x7dcad05)
[task 2021-08-12T13:38:51.919Z] 13:38:51     INFO -     #28 rayon_core::registry::ThreadBuilder::run::hce54465142ba1824 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:56:18 (libxul.so+0x7dcad05)
[task 2021-08-12T13:38:51.920Z] 13:38:51     INFO -     #29 _$LT$rayon_core..registry..DefaultSpawn$u20$as$u20$rayon_core..registry..ThreadSpawn$GT$::spawn::_$u7b$$u7b$closure$u7d$$u7d$::hebd482fb756b3666 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:101:20 (libxul.so+0x7dcad05)
[task 2021-08-12T13:38:51.921Z] 13:38:51     INFO -     #30 std::sys_common::backtrace::__rust_begin_short_backtrace::hf388b4879bac49c4 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys_common/backtrace.rs:125:18 (libxul.so+0x7dcad05)
[task 2021-08-12T13:38:51.921Z] 13:38:51     INFO -     #31 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::_$u7b$$u7b$closure$u7d$$u7d$::hb9e39a8787d5076a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:481:17 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.922Z] 13:38:51     INFO -     #32 _$LT$std..panic..AssertUnwindSafe$LT$F$GT$$u20$as$u20$core..ops..function..FnOnce$LT$$LP$$RP$$GT$$GT$::call_once::hefd2dc54bccc5e64 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panic.rs:344:9 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.922Z] 13:38:51     INFO -     #33 std::panicking::try::do_call::hb413228e0f3efe47 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:379:40 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.923Z] 13:38:51     INFO -     #34 std::panicking::try::h5d6bec00110e8dff /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:343:19 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.924Z] 13:38:51     INFO -     #35 std::panic::catch_unwind::hdfbd494db0fbb68b /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panic.rs:431:14 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.925Z] 13:38:51     INFO -     #36 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::hc11461aed3a3bbac /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:480:30 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.925Z] 13:38:51     INFO -     #37 core::ops::function::FnOnce::call_once$u7b$$u7b$vtable.shim$u7d$$u7d$::h93adb23bd0accc89 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ops/function.rs:227:5 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.926Z] 13:38:51     INFO -     #38 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::_$u7b$$u7b$closure$u7d$$u7d$::hb9e39a8787d5076a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:481:17 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.927Z] 13:38:51     INFO -     #39 _$LT$std..panic..AssertUnwindSafe$LT$F$GT$$u20$as$u20$core..ops..function..FnOnce$LT$$LP$$RP$$GT$$GT$::call_once::hefd2dc54bccc5e64 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panic.rs:344:9 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.928Z] 13:38:51     INFO -     #40 std::panicking::try::do_call::hb413228e0f3efe47 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:379:40 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.928Z] 13:38:51     INFO -     #41 std::panicking::try::h5d6bec00110e8dff /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:343:19 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.929Z] 13:38:51     INFO -     #42 std::panic::catch_unwind::hdfbd494db0fbb68b /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panic.rs:431:14 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.930Z] 13:38:51     INFO -     #43 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::hc11461aed3a3bbac /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:480:30 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.931Z] 13:38:51     INFO -     #44 core::ops::function::FnOnce::call_once$u7b$$u7b$vtable.shim$u7d$$u7d$::h93adb23bd0accc89 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ops/function.rs:227:5 (libxul.so+0x7dca022)
[task 2021-08-12T13:38:51.931Z] 13:38:51     INFO -     #45 _$LT$alloc..boxed..Box$LT$F$C$A$GT$$u20$as$u20$core..ops..function..FnOnce$LT$Args$GT$$GT$::call_once::hddd425db0b4240a1 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/boxed.rs:1546:9 (libxul.so+0x7eed016)
[task 2021-08-12T13:38:51.932Z] 13:38:51     INFO -     #46 _$LT$alloc..boxed..Box$LT$F$C$A$GT$$u20$as$u20$core..ops..function..FnOnce$LT$Args$GT$$GT$::call_once::h7e8c9405d5d08b7a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/boxed.rs:1546:9 (libxul.so+0x7eed016)
[task 2021-08-12T13:38:51.932Z] 13:38:51     INFO -     #47 std::sys::unix::thread::Thread::new::thread_start::h3769be6c1ba69e87 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/thread.rs:71:17 (libxul.so+0x7eed016)
[task 2021-08-12T13:38:51.933Z] 13:38:51     INFO -   Thread T47 'StyleThread#3' (tid=1535, running) created by main thread at:
[task 2021-08-12T13:38:51.933Z] 13:38:51     INFO -     #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-08-12T13:38:51.934Z] 13:38:51     INFO -     #1 std::sys::unix::thread::Thread::new::h9c3f03fae32c12e2 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/thread.rs:50:19 (libxul.so+0x7eecd7b)
[task 2021-08-12T13:38:51.935Z] 13:38:51     INFO -     #2 std::thread::Builder::spawn_unchecked::h2d7ee45c007cc32a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:505:22 (libxul.so+0x7dc9a56)
[task 2021-08-12T13:38:51.935Z] 13:38:51     INFO -     #3 std::thread::Builder::spawn::h20276e62e98c5bee /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:388:18 (libxul.so+0x7dc9a56)
[task 2021-08-12T13:38:51.936Z] 13:38:51     INFO -     #4 _$LT$rayon_core..registry..DefaultSpawn$u20$as$u20$rayon_core..registry..ThreadSpawn$GT$::spawn::h80da87d410d8cd32 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:101:9 (libxul.so+0x7dc9a56)
[task 2021-08-12T13:38:51.937Z] 13:38:51     INFO -     #5 rayon_core::registry::Registry::new::hba3f4cd079ccb318 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:260:29 (libxul.so+0x800eb50)
[task 2021-08-12T13:38:51.937Z] 13:38:51     INFO -     #6 rayon_core::thread_pool::ThreadPool::build::hbb52b51dc034aabf /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/thread_pool/mod.rs:69:24 (libxul.so+0x800eb50)
[task 2021-08-12T13:38:51.938Z] 13:38:51     INFO -     #7 rayon_core::ThreadPoolBuilder$LT$S$GT$::build::hc3c677d429b8b305 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/lib.rs:202:9 (libxul.so+0x800eb50)
[task 2021-08-12T13:38:51.938Z] 13:38:51     INFO -     #8 _$LT$style..global_style_data..STYLE_THREAD_POOL$u20$as$u20$core..ops..deref..Deref$GT$::deref::__static_ref_initialize::heefe24b8265d1e6b /builds/worker/checkouts/gecko/servo/components/style/global_style_data.rs:149:27 (libxul.so+0x800eb50)
[task 2021-08-12T13:38:51.939Z] 13:38:51     INFO -     #9 core::ops::function::FnOnce::call_once::h9ab87a47903d81f6 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ops/function.rs:227:5 (libxul.so+0x800eb50)
[task 2021-08-12T13:38:51.940Z] 13:38:51     INFO -     #10 lazy_static::lazy::Lazy$LT$T$GT$::get::_$u7b$$u7b$closure$u7d$$u7d$::hf4101768d44c8904 /builds/worker/checkouts/gecko/third_party/rust/lazy_static/src/inline_lazy.rs:31:29 (libxul.so+0x800eb50)
[task 2021-08-12T13:38:51.941Z] 13:38:51     INFO -     #11 std::sync::once::Once::call_once::_$u7b$$u7b$closure$u7d$$u7d$::ha2a18fc25e79d88b /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sync/once.rs:261:41 (libxul.so+0x800eb50)
[task 2021-08-12T13:38:51.941Z] 13:38:51     INFO -     #12 std::sync::once::Once::call_inner::h5dce4086ee6ceeed /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sync/once.rs:418:21 (libxul.so+0xa0c43b)
[task 2021-08-12T13:38:51.942Z] 13:38:51     INFO -     #13 std::sync::once::Once::call_once::hc70ce214d9771eb5 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sync/once.rs:261:9 (libxul.so+0x8244479)
[task 2021-08-12T13:38:51.942Z] 13:38:51     INFO -     #14 lazy_static::lazy::Lazy$LT$T$GT$::get::h8019d8db054c3f2a /builds/worker/checkouts/gecko/third_party/rust/lazy_static/src/inline_lazy.rs:30:9 (libxul.so+0x8244479)
[task 2021-08-12T13:38:51.943Z] 13:38:51     INFO -     #15 _$LT$style..global_style_data..STYLE_THREAD_POOL$u20$as$u20$core..ops..deref..Deref$GT$::deref::__stability::hd41c8754953540e4 /builds/worker/checkouts/gecko/third_party/rust/lazy_static/src/lib.rs:142:21 (libxul.so+0x8244479)
[task 2021-08-12T13:38:51.943Z] 13:38:51     INFO -     #16 _$LT$style..global_style_data..STYLE_THREAD_POOL$u20$as$u20$core..ops..deref..Deref$GT$::deref::h12b6afcdced318e3 /builds/worker/checkouts/gecko/third_party/rust/lazy_static/src/lib.rs:144:17 (libxul.so+0x8244479)
[task 2021-08-12T13:38:51.944Z] 13:38:51     INFO -     #17 geckoservo::glue::traverse_subtree::hba73293527990a42 /builds/worker/checkouts/gecko/servo/ports/geckolib/glue.rs:256:31 (libxul.so+0x78bcf6e)
[task 2021-08-12T13:38:51.945Z] 13:38:51     INFO -     #18 Servo_TraverseSubtree /builds/worker/checkouts/gecko/servo/ports/geckolib/glue.rs:326:5 (libxul.so+0x78bc9fb)
[task 2021-08-12T13:38:51.945Z] 13:38:51     INFO -     #19 mozilla::ServoStyleSet::StyleNewSubtree(mozilla::dom::Element*) /builds/worker/checkouts/gecko/layout/style/ServoStyleSet.cpp:807:7 (libxul.so+0x4cd3e0d)
[task 2021-08-12T13:38:51.946Z] 13:38:51     INFO -     #20 nsCSSFrameConstructor::ConstructDocElementFrame(mozilla::dom::Element*) /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:2232:29 (libxul.so+0x4db7a39)
[task 2021-08-12T13:38:51.947Z] 13:38:51     INFO -     #21 nsCSSFrameConstructor::ContentRangeInserted(nsIContent*, nsIContent*, nsCSSFrameConstructor::InsertionKind) /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:6926:9 (libxul.so+0x4dc83e6)
[task 2021-08-12T13:38:51.947Z] 13:38:51     INFO -     #22 nsCSSFrameConstructor::ContentInserted(nsIContent*, nsCSSFrameConstructor::InsertionKind) /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:6844:3 (libxul.so+0x4dc7fe1)
[task 2021-08-12T13:38:51.948Z] 13:38:51     INFO -     #23 mozilla::PresShell::Initialize() /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:1892:26 (libxul.so+0x4d676ac)
[task 2021-08-12T13:38:51.948Z] 13:38:51     INFO -     #24 mozilla::dom::PrototypeDocumentContentSink::StartLayout() /builds/worker/checkouts/gecko/dom/prototype/PrototypeDocumentContentSink.cpp:698:30 (libxul.so+0x447758f)
[task 2021-08-12T13:38:51.949Z] 13:38:51     INFO -     #25 mozilla::dom::PrototypeDocumentContentSink::DoneWalking() /builds/worker/checkouts/gecko/dom/prototype/PrototypeDocumentContentSink.cpp:667:3 (libxul.so+0x44771f9)
[task 2021-08-12T13:38:51.950Z] 13:38:51     INFO -     #26 MaybeDoneWalking /builds/worker/checkouts/gecko/dom/prototype/PrototypeDocumentContentSink.cpp:643:10 (libxul.so+0x44770f8)
[task 2021-08-12T13:38:51.950Z] 13:38:51     INFO -     #27 InitialTranslationCompleted /builds/worker/checkouts/gecko/dom/prototype/PrototypeDocumentContentSink.cpp:630:3 (libxul.so+0x44770f8)
[task 2021-08-12T13:38:51.951Z] 13:38:51     INFO -     #28 non-virtual thunk to mozilla::dom::PrototypeDocumentContentSink::InitialTranslationCompleted() /builds/worker/checkouts/gecko/dom/prototype/PrototypeDocumentContentSink.cpp (libxul.so+0x44770f8)
[task 2021-08-12T13:38:51.952Z] 13:38:51     INFO -     #29 InitialTranslationCompleted /builds/worker/checkouts/gecko/dom/l10n/DocumentL10n.cpp:302:19 (libxul.so+0x49f8844)
[task 2021-08-12T13:38:51.952Z] 13:38:51     INFO -     #30 L10nReadyHandler::ResolvedCallback(JSContext*, JS::Handle<JS::Value>) /builds/worker/checkouts/gecko/dom/l10n/DocumentL10n.cpp:79:20 (libxul.so+0x49f8844)
[task 2021-08-12T13:38:51.953Z] 13:38:51     INFO -     #31 mozilla::dom::(anonymous namespace)::PromiseNativeHandlerShim::ResolvedCallback(JSContext*, JS::Handle<JS::Value>) /builds/worker/checkouts/gecko/dom/promise/Promise.cpp:385:12 (libxul.so+0x4705b3c)
[task 2021-08-12T13:38:51.953Z] 13:38:51     INFO -     #32 mozilla::dom::NativeHandlerCallback(JSContext*, unsigned int, JS::Value*) /builds/worker/checkouts/gecko/dom/promise/Promise.cpp:338:29 (libxul.so+0x4706079)
[task 2021-08-12T13:38:51.954Z] 13:38:51     INFO -     #33 CallJSNative /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:426:13 (libxul.so+0x6873ca8)
[task 2021-08-12T13:38:51.955Z] 13:38:51     INFO -     #34 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:511:12 (libxul.so+0x6873ca8)
[task 2021-08-12T13:38:51.956Z] 13:38:51     INFO -     #35 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:571:10 (libxul.so+0x6874de3)
[task 2021-08-12T13:38:51.956Z] 13:38:51     INFO -     #36 js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:588:8 (libxul.so+0x6874de3)
[task 2021-08-12T13:38:51.957Z] 13:38:51     INFO -     #37 Call /builds/worker/checkouts/gecko/js/src/vm/Interpreter.h:106:10 (libxul.so+0x6a2d7a5)
[task 2021-08-12T13:38:51.957Z] 13:38:51     INFO -     #38 PromiseReactionJob(JSContext*, unsigned int, JS::Value*) /builds/worker/checkouts/gecko/js/src/builtin/Promise.cpp:1905:10 (libxul.so+0x6a2d7a5)
[task 2021-08-12T13:38:51.958Z] 13:38:51     INFO -     #39 CallJSNative /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:426:13 (libxul.so+0x6873ca8)
[task 2021-08-12T13:38:51.959Z] 13:38:51     INFO -     #40 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:511:12 (libxul.so+0x6873ca8)
[task 2021-08-12T13:38:51.959Z] 13:38:51     INFO -     #41 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:571:10 (libxul.so+0x6874de3)
[task 2021-08-12T13:38:51.960Z] 13:38:51     INFO -     #42 js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:588:8 (libxul.so+0x6874de3)
[task 2021-08-12T13:38:51.961Z] 13:38:51     INFO -     #43 JS::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::HandleValueArray const&, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/jsapi.cpp:2785:10 (libxul.so+0x691c001)
[task 2021-08-12T13:38:51.961Z] 13:38:51     INFO -     #44 mozilla::dom::PromiseJobCallback::Call(mozilla::dom::BindingCallContext&, JS::Handle<JS::Value>, mozilla::ErrorResult&) /builds/worker/workspace/obj-build/dom/bindings/PromiseBinding.cpp:31:8 (libxul.so+0x2af034b)
[task 2021-08-12T13:38:51.962Z] 13:38:51     INFO -     #45 Call /builds/worker/workspace/obj-build/dist/include/mozilla/dom/PromiseBinding.h:89:12 (libxul.so+0xb47460)
[task 2021-08-12T13:38:51.962Z] 13:38:51     INFO -     #46 Call /builds/worker/workspace/obj-build/dist/include/mozilla/dom/PromiseBinding.h:102:12 (libxul.so+0xb47460)
[task 2021-08-12T13:38:51.963Z] 13:38:51     INFO -     #47 mozilla::PromiseJobRunnable::Run(mozilla::AutoSlowOperation&) /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSContext.cpp:212:18 (libxul.so+0xb47460)
[task 2021-08-12T13:38:51.964Z] 13:38:51     INFO -     #48 mozilla::CycleCollectedJSContext::PerformMicroTaskCheckPoint(bool) /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSContext.cpp:647:17 (libxul.so+0xb34917)
[task 2021-08-12T13:38:51.964Z] 13:38:51     INFO -     #49 mozilla::CycleCollectedJSContext::AfterProcessTask(unsigned int) /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSContext.cpp:462:3 (libxul.so+0xb351c1)
[task 2021-08-12T13:38:51.965Z] 13:38:51     INFO -     #50 XPCJSContext::AfterProcessTask(unsigned int) /builds/worker/checkouts/gecko/js/xpconnect/src/XPCJSContext.cpp:1485:28 (libxul.so+0x1a92a3f)
[task 2021-08-12T13:38:51.965Z] 13:38:51     INFO -     #51 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1189:24 (libxul.so+0xc36afb)
[task 2021-08-12T13:38:51.966Z] 13:38:51     INFO -     #52 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:466:10 (libxul.so+0xc3ce62)
[task 2021-08-12T13:38:51.967Z] 13:38:51     INFO -     #53 mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:85:21 (libxul.so+0x151aa6d)
[task 2021-08-12T13:38:51.967Z] 13:38:51     INFO -     #54 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x149ad6c)
[task 2021-08-12T13:38:51.968Z] 13:38:51     INFO -     #55 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x149ad6c)
[task 2021-08-12T13:38:51.969Z] 13:38:51     INFO -     #56 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x149ad6c)
[task 2021-08-12T13:38:51.969Z] 13:38:51     INFO -     #57 nsBaseAppShell::Run() /builds/worker/checkouts/gecko/widget/nsBaseAppShell.cpp:137:27 (libxul.so+0x4a4c9c6)
[task 2021-08-12T13:38:51.970Z] 13:38:51     INFO -     #58 nsAppStartup::Run() /builds/worker/checkouts/gecko/toolkit/components/startup/nsAppStartup.cpp:273:30 (libxul.so+0x6625d68)
[task 2021-08-12T13:38:51.970Z] 13:38:51     INFO -     #59 XREMain::XRE_mainRun() /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5249:22 (libxul.so+0x673beaa)
[task 2021-08-12T13:38:51.971Z] 13:38:51     INFO -     #60 XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5434:8 (libxul.so+0x673cb9d)
[task 2021-08-12T13:38:51.972Z] 13:38:51     INFO -     #61 XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5493:21 (libxul.so+0x673d104)
[task 2021-08-12T13:38:51.972Z] 13:38:51     INFO -     #62 mozilla::BootstrapImpl::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:45:12 (libxul.so+0x67471b2)
[task 2021-08-12T13:38:51.973Z] 13:38:51     INFO -     #63 do_main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:225:22 (firefox+0xca6e0)
[task 2021-08-12T13:38:51.974Z] 13:38:51     INFO -     #64 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:378:16 (firefox+0xca6e0)
[task 2021-08-12T13:38:51.974Z] 13:38:51     INFO -   Thread T29 'WRWorker#1' (tid=1513, running) created by main thread at:
[task 2021-08-12T13:38:51.975Z] 13:38:51     INFO -     #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-08-12T13:38:51.976Z] 13:38:51     INFO -     #1 std::sys::unix::thread::Thread::new::h9c3f03fae32c12e2 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/thread.rs:50:19 (libxul.so+0x7eecd7b)
[task 2021-08-12T13:38:51.976Z] 13:38:51     INFO -     #2 std::thread::Builder::spawn_unchecked::h2d7ee45c007cc32a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:505:22 (libxul.so+0x7dc9a56)
[task 2021-08-12T13:38:51.977Z] 13:38:51     INFO -     #3 std::thread::Builder::spawn::h20276e62e98c5bee /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:388:18 (libxul.so+0x7dc9a56)
[task 2021-08-12T13:38:51.978Z] 13:38:51     INFO -     #4 _$LT$rayon_core..registry..DefaultSpawn$u20$as$u20$rayon_core..registry..ThreadSpawn$GT$::spawn::h80da87d410d8cd32 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:101:9 (libxul.so+0x7dc9a56)
[task 2021-08-12T13:38:51.978Z] 13:38:51     INFO -     #5 rayon_core::registry::Registry::new::hda537edff8e18c39 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:260:29 (libxul.so+0x871e4e0)
[task 2021-08-12T13:38:51.979Z] 13:38:51     INFO -     #6 rayon_core::thread_pool::ThreadPool::build::h3eb523a7b9e9e62f /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/thread_pool/mod.rs:69:24 (libxul.so+0x871e4e0)
[task 2021-08-12T13:38:51.980Z] 13:38:51     INFO -     #7 rayon_core::ThreadPoolBuilder$LT$S$GT$::build::hcf7addbe28834d28 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/lib.rs:202:9 (libxul.so+0x871e4e0)
[task 2021-08-12T13:38:51.980Z] 13:38:51     INFO -     #8 wr_thread_pool_new /builds/worker/checkouts/gecko/gfx/webrender_bindings/src/bindings.rs:1084:18 (libxul.so+0x871e4e0)
[task 2021-08-12T13:38:51.981Z] 13:38:51     INFO -     #9 WebRenderThreadPool /builds/worker/checkouts/gecko/gfx/webrender_bindings/RenderThread.cpp:1037:17 (libxul.so+0x2287117)
[task 2021-08-12T13:38:51.981Z] 13:38:51     INFO -     #10 RenderThread /builds/worker/checkouts/gecko/gfx/webrender_bindings/RenderThread.cpp:64:7 (libxul.so+0x2287117)
[task 2021-08-12T13:38:51.982Z] 13:38:51     INFO -     #11 mozilla::wr::RenderThread::Start() /builds/worker/checkouts/gecko/gfx/webrender_bindings/RenderThread.cpp:96:23 (libxul.so+0x2287117)
[task 2021-08-12T13:38:51.983Z] 13:38:51     INFO -     #12 gfxPlatform::InitLayersIPC() /builds/worker/checkouts/gecko/gfx/thebes/gfxPlatform.cpp:1331:7 (libxul.so+0x213a930)
[task 2021-08-12T13:38:51.983Z] 13:38:51     INFO -     #13 gfxPlatform::Init() /builds/worker/checkouts/gecko/gfx/thebes/gfxPlatform.cpp:971:3 (libxul.so+0x2138acd)
[task 2021-08-12T13:38:51.984Z] 13:38:51     INFO -     #14 gfxPlatform::GetPlatform() /builds/worker/checkouts/gecko/gfx/thebes/gfxPlatform.cpp:481:5 (libxul.so+0x2137b00)
[task 2021-08-12T13:38:51.984Z] 13:38:51     INFO -     #15 mozilla::widget::GfxInfoBase::GetContentBackend(nsTSubstring<char16_t>&) /builds/worker/checkouts/gecko/widget/GfxInfoBase.cpp:1851:25 (libxul.so+0x4a2c927)
[task 2021-08-12T13:38:51.985Z] 13:38:51     INFO -     #16 NS_InvokeByIndex /builds/worker/checkouts/gecko/xpcom/reflect/xptcall/md/unix/xptcinvoke_asm_x86_64_unix.S:101 (libxul.so+0xc5f735)
[task 2021-08-12T13:38:51.986Z] 13:38:51     INFO -     #17 GetAttribute /builds/worker/checkouts/gecko/js/xpconnect/src/xpcprivate.h:1461:12 (libxul.so+0x1ac8880)
[task 2021-08-12T13:38:51.987Z] 13:38:51     INFO -     #18 XPC_WN_GetterSetter(JSContext*, unsigned int, JS::Value*) /builds/worker/checkouts/gecko/js/xpconnect/src/XPCWrappedNativeJSOps.cpp:962:10 (libxul.so+0x1ac8880)
[task 2021-08-12T13:38:51.987Z] 13:38:51     INFO -     #19 CallJSNative /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:426:13 (libxul.so+0x6873ca8)
[task 2021-08-12T13:38:51.988Z] 13:38:51     INFO -     #20 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:511:12 (libxul.so+0x6873ca8)
[task 2021-08-12T13:38:51.989Z] 13:38:51     INFO -     #21 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:571:10 (libxul.so+0x6874de3)
[task 2021-08-12T13:38:51.989Z] 13:38:51     INFO -     #22 js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:588:8 (libxul.so+0x6874de3)
[task 2021-08-12T13:38:51.990Z] 13:38:51     INFO -     #23 js::CallGetter(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:713:10 (libxul.so+0x6875b35)
[task 2021-08-12T13:38:51.991Z] 13:38:51     INFO -     #24 CallGetter /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2040:12 (libxul.so+0x6b2a8a3)
[task 2021-08-12T13:38:51.991Z] 13:38:51     INFO -     #25 GetExistingProperty<js::CanGC> /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2068:12 (libxul.so+0x6b2a8a3)
[task 2021-08-12T13:38:51.992Z] 13:38:51     INFO -     #26 NativeGetPropertyInline<js::CanGC> /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2214:14 (libxul.so+0x6b2a8a3)
[task 2021-08-12T13:38:51.993Z] 13:38:51     INFO -     #27 js::NativeGetProperty(JSContext*, JS::Handle<js::NativeObject*>, JS::Handle<JS::Value>, JS::Handle<JS::PropertyKey>, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2245:10 (libxul.so+0x6b2a8a3)
[task 2021-08-12T13:38:51.994Z] 13:38:51     INFO -     #28 GetProperty /builds/worker/checkouts/gecko/js/src/vm/ObjectOperations-inl.h:116:10 (libxul.so+0x6868354)
[task 2021-08-12T13:38:51.994Z] 13:38:51     INFO -     #29 GetObjectElementOperation /builds/worker/checkouts/gecko/js/src/vm/Interpreter-inl.h:419:10 (libxul.so+0x6868354)
[task 2021-08-12T13:38:51.995Z] 13:38:51     INFO -     #30 GetElementOperationWithStackIndex /builds/worker/checkouts/gecko/js/src/vm/Interpreter-inl.h:505:10 (libxul.so+0x6868354)
[task 2021-08-12T13:38:51.995Z] 13:38:51     INFO -     #31 Interpret(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:3040:12 (libxul.so+0x6868354)
[task 2021-08-12T13:38:51.996Z] 13:38:51     INFO -     #32 js::RunScript(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:395:13 (libxul.so+0x685d201)
[task 2021-08-12T13:38:51.997Z] 13:38:51     INFO -     #33 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:543:13 (libxul.so+0x68745cb)
[task 2021-08-12T13:38:51.998Z] 13:38:51     INFO -     #34 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:571:10 (libxul.so+0x6874de3)
[task 2021-08-12T13:38:51.998Z] 13:38:51     INFO -     #35 js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:588:8 (libxul.so+0x6874de3)
[task 2021-08-12T13:38:51.999Z] 13:38:51     INFO -     #36 JS_CallFunctionValue(JSContext*, JS::Handle<JSObject*>, JS::Handle<JS::Value>, JS::HandleValueArray const&, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/jsapi.cpp:2722:10 (libxul.so+0x691b6e9)
[task 2021-08-12T13:38:52.000Z] 13:38:52     INFO -     #37 nsXPCWrappedJS::CallMethod(unsigned short, nsXPTMethodInfo const*, nsXPTCMiniVariant*) /builds/worker/checkouts/gecko/js/xpconnect/src/XPCWrappedJSClass.cpp:971:17 (libxul.so+0x1abf659)
[task 2021-08-12T13:38:52.000Z] 13:38:52     INFO -     #38 PrepareAndDispatch /builds/worker/checkouts/gecko/xpcom/reflect/xptcall/md/unix/xptcstubs_x86_64_linux.cpp:115:37 (libxul.so+0xc60711)
[task 2021-08-12T13:38:52.001Z] 13:38:52     INFO -     #39 SharedStub <null> (libxul.so+0xc5fa72)
[task 2021-08-12T13:38:52.002Z] 13:38:52     INFO -     #40 nsXREDirProvider::DoStartup() /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:982:11 (libxul.so+0x674c80e)
[task 2021-08-12T13:38:52.002Z] 13:38:52     INFO -     #41 XREMain::XRE_mainRun() /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4998:18 (libxul.so+0x673b88f)
[task 2021-08-12T13:38:52.003Z] 13:38:52     INFO -     #42 XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5434:8 (libxul.so+0x673cb9d)
[task 2021-08-12T13:38:52.004Z] 13:38:52     INFO -     #43 XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5493:21 (libxul.so+0x673d104)
[task 2021-08-12T13:38:52.004Z] 13:38:52     INFO -     #44 mozilla::BootstrapImpl::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:45:12 (libxul.so+0x67471b2)
[task 2021-08-12T13:38:52.005Z] 13:38:52     INFO -     #45 do_main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:225:22 (firefox+0xca6e0)
[task 2021-08-12T13:38:52.006Z] 13:38:52     INFO -     #46 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:378:16 (firefox+0xca6e0)
[task 2021-08-12T13:38:52.006Z] 13:38:52     INFO - SUMMARY: ThreadSanitizer: data race /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/alloc.rs:42:9 in std::sys::unix::alloc::_$LT$impl$u20$core..alloc..global..GlobalAlloc$u20$for$u20$std..alloc..System$GT$::dealloc::hc30512f2445cb68e
[task 2021-08-12T13:38:52.007Z] 13:38:52     INFO - ==================
[task 2021-08-12T13:38:52.093Z] 13:38:52    ERROR - TEST-UNEXPECTED-FAIL | layout/base/crashtests/468555-1.xhtml (finished) | application terminated with exit code -6
[task 2021-08-12T13:38:52.108Z] 13:38:52     INFO - REFTEST INFO | Process mode: e10s
[task 2021-08-12T13:38:52.109Z] 13:38:52  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2021-08-12T13:38:52.150Z] 13:38:52    ERROR - Return code: 250
[task 2021-08-12T13:38:52.151Z] 13:38:52     INFO - TinderboxPrint: reftest-crashtest<br/>242/0/0
[task 2021-08-12T13:38:52.152Z] 13:38:52    ERROR - # TBPL FAILURE #
[task 2021-08-12T13:38:52.152Z] 13:38:52  WARNING - setting return code to 2
[task 2021-08-12T13:38:52.153Z] 13:38:52    ERROR - The reftest suite: crashtest ran with return status: FAILURE
[task 2021-08-12T13:38:52.154Z] 13:38:52     INFO - Running post-action listener: _package_coverage_data
[task 2021-08-12T13:38:52.155Z] 13:38:52     INFO - Running post-action listener: _resource_record_post_action
[task 2021-08-12T13:38:52.155Z] 13:38:52     INFO - Running post-action listener: process_java_coverage_data
[task 2021-08-12T13:38:52.156Z] 13:38:52     INFO - [mozharness: 2021-08-12 13:38:52.152315Z] Finished run-tests step (success)
[task 2021-08-12T13:38:52.157Z] 13:38:52     INFO - Running post-run listener: _resource_record_post_run
[task 2021-08-12T13:38:52.217Z] 13:38:52     INFO - Validating Perfherder data against /builds/worker/workspace/mozharness/external_tools/performance-artifact-schema.json
[task 2021-08-12T13:38:52.221Z] 13:38:52     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "reftest.crashtest.14.overall", "extraOptions": ["e10s", "taskcluster-m5.large"], "subtests": [{"name": "cpu_percent", "value": 71.15866666666666}, {"name": "io_write_bytes", "value": 1881600000}, {"name": "io.read_bytes", "value": 30179328}, {"name": "io_write_time", "value": 201720}, {"name": "io_read_time", "value": 2708}]}, {"name": "reftest.crashtest.14.start-pulseaudio", "subtests": [{"name": "time", "value": 0.033814191818237305}]}, {"name": "reftest.crashtest.14.install", "subtests": [{"name": "time", "value": 33.307039976119995}, {"name": "cpu_percent", "value": 50.4296875}]}, {"name": "reftest.crashtest.14.stage-files", "subtests": [{"name": "time", "value": 0.00023865699768066406}]}, {"name": "reftest.crashtest.14.run-tests", "subtests": [{"name": "time", "value": 117.66122436523438}, {"name": "cpu_percent", "value": 77.34224137931035}]}]}
[task 2021-08-12T13:38:52.221Z] 13:38:52     INFO - Total resource usage - Wall time: 150s; CPU: 77%; Read bytes: 30179328; Write bytes: 1881600000; Read time: 2708; Write time: 201720
[task 2021-08-12T13:38:52.221Z] 13:38:52     INFO - TinderboxPrint: CPU usage<br/>77.3%
[task 2021-08-12T13:38:52.222Z] 13:38:52     INFO - TinderboxPrint: I/O read bytes / time<br/>30,179,328 / 2,708
[task 2021-08-12T13:38:52.222Z] 13:38:52     INFO - TinderboxPrint: I/O write bytes / time<br/>1,881,600,000 / 201,720
[task 2021-08-12T13:38:52.222Z] 13:38:52     INFO - TinderboxPrint: CPU idle<br/>81.2 (27.1%)
[task 2021-08-12T13:38:52.222Z] 13:38:52     INFO - TinderboxPrint: CPU iowait<br/>5.1 (1.7%)
[task 2021-08-12T13:38:52.222Z] 13:38:52     INFO - TinderboxPrint: CPU system<br/>14.9 (5.0%)
[task 2021-08-12T13:38:52.222Z] 13:38:52     INFO - TinderboxPrint: CPU user<br/>198.0 (66.2%)
[task 2021-08-12T13:38:52.223Z] 13:38:52     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2021-08-12T13:38:52.223Z] 13:38:52     INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2021-08-12T13:38:52.223Z] 13:38:52     INFO - install - Wall time: 33s; CPU: 50%; Read bytes: 352256; Write bytes: 1535123456; Read time: 80; Write time: 161724
[task 2021-08-12T13:38:52.224Z] 13:38:52     INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2021-08-12T13:38:52.225Z] 13:38:52     INFO - run-tests - Wall time: 118s; CPU: 77%; Read bytes: 29376512; Write bytes: 178675712; Read time: 2000; Write time: 12812
[task 2021-08-12T13:38:52.242Z] 13:38:52  WARNING - returning nonzero exit status 2
Status: RESOLVED → REOPENED
Resolution: WORKSFORME → ---

There are 26 total failures in the last 7 days on linux1804-64-tsan-qr opt
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=363519112&repo=autoland&lineNumber=3228

task 2022-01-09T19:50:34.812Z] 19:50:34     INFO - REFTEST TEST-START | xpcom/string/crashtests/1113005.html
[task 2022-01-09T19:50:34.814Z] 19:50:34     INFO - REFTEST TEST-SKIP | xpcom/string/crashtests/1113005.html | 
[task 2022-01-09T19:50:34.815Z] 19:50:34     INFO - REFTEST TEST-END | xpcom/string/crashtests/1113005.html
[task 2022-01-09T19:50:34.820Z] 19:50:34     INFO - REFTEST INFO | Result summary:
[task 2022-01-09T19:50:34.820Z] 19:50:34     INFO - REFTEST INFO | Successful: 121 (0 pass, 121 load only)
[task 2022-01-09T19:50:34.820Z] 19:50:34     INFO - REFTEST INFO | Unexpected: 0 (0 unexpected fail, 0 unexpected pass, 0 unexpected asserts, 0 failed load, 0 exception)
[task 2022-01-09T19:50:34.820Z] 19:50:34     INFO - REFTEST INFO | Known problems: 4 (0 known fail, 0 known asserts, 0 random, 4 skipped, 0 slow)
[task 2022-01-09T19:50:34.820Z] 19:50:34     INFO - REFTEST SUITE-END | Shutdown
[task 2022-01-09T19:50:34.822Z] 19:50:34     INFO - REFTEST INFO | Slowest test took 32727ms (file:///builds/worker/workspace/build/tests/reftest/tests/parser/htmlparser/tests/crashtests/1747514.html)
[task 2022-01-09T19:50:34.822Z] 19:50:34     INFO - REFTEST INFO | Total canvas count = 0
[task 2022-01-09T19:50:35.612Z] 19:50:35     INFO - 1641757835611	Marionette	TRACE	Received observer notification quit-application
[task 2022-01-09T19:50:35.615Z] 19:50:35     INFO - 1641757835614	Marionette	INFO	Stopped listening on port 2828
[task 2022-01-09T19:50:35.617Z] 19:50:35     INFO - 1641757835616	Marionette	DEBUG	Marionette stopped listening
[task 2022-01-09T19:50:36.342Z] 19:50:36     INFO - JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2022-01-09T19:50:36.358Z] 19:50:36     INFO - ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-09T19:50:37.065Z] 19:50:37     INFO - ###!!! [Parent][PCompositorManagerParent] Error: RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-09T19:50:37.066Z] 19:50:37     INFO - ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-09T19:50:38.066Z] 19:50:38     INFO - JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2022-01-09T19:50:55.711Z] 19:50:55     INFO - ==================
[task 2022-01-09T19:50:55.712Z] 19:50:55     INFO - WARNING: ThreadSanitizer: data race (pid=1471)
[task 2022-01-09T19:50:55.713Z] 19:50:55     INFO -   Write of size 8 at 0x7b70003a0800 by thread T49:
[task 2022-01-09T19:50:55.714Z] 19:50:55     INFO -     #0 free /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors_posix.cpp:714:3 (firefox+0x580ba)
[task 2022-01-09T19:50:55.716Z] 19:50:55     INFO -     #1 std::sys::unix::alloc::_$LT$impl$u20$core..alloc..global..GlobalAlloc$u20$for$u20$std..alloc..System$GT$::dealloc::h2bab29fb7681d672 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/alloc.rs:42:9 (libxul.so+0x896b5e6)
[task 2022-01-09T19:50:55.717Z] 19:50:55     INFO -     #2 __rdl_dealloc /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/alloc.rs:363:18 (libxul.so+0x896b5e6)
[task 2022-01-09T19:50:55.718Z] 19:50:55     INFO -     #3 alloc::alloc::dealloc::h2cfc05a5973013a8 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/alloc.rs:104:14 (libxul.so+0x81fb519)
[task 2022-01-09T19:50:55.719Z] 19:50:55     INFO -     #4 _$LT$alloc..alloc..Global$u20$as$u20$core..alloc..Allocator$GT$::deallocate::h2e792ee5fb555dd8 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/alloc.rs:239:22 (libxul.so+0x81fb519)
[task 2022-01-09T19:50:55.721Z] 19:50:55     INFO -     #5 alloc::alloc::box_free::he1d6cd99ecc89f3a /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/alloc.rs:333:9 (libxul.so+0x81fb519)
[task 2022-01-09T19:50:55.722Z] 19:50:55     INFO -     #6 core::ptr::drop_in_place$LT$alloc..boxed..Box$LT$crossbeam_epoch..internal..Local$GT$$GT$::hec9dde176b6831b4 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ptr/mod.rs:188:1 (libxul.so+0x81fb519)
[task 2022-01-09T19:50:55.723Z] 19:50:55     INFO -     #7 core::mem::drop::h03e206dbdc86fe84 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/mem/mod.rs:898:24 (libxul.so+0x81fb519)
[task 2022-01-09T19:50:55.724Z] 19:50:55     INFO -     #8 _$LT$T$u20$as$u20$crossbeam_epoch..atomic..Pointable$GT$::drop::h47ed095e1a11858c /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/atomic.rs:212:9 (libxul.so+0x81fb519)
[task 2022-01-09T19:50:55.725Z] 19:50:55     INFO -     #9 _$LT$crossbeam_epoch..atomic..Owned$LT$T$GT$$u20$as$u20$core..ops..drop..Drop$GT$::drop::h47a4ce5e787f42c8 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/atomic.rs:1087:13 (libxul.so+0x81fb519)
[task 2022-01-09T19:50:55.727Z] 19:50:55     INFO -     #10 core::ptr::drop_in_place$LT$crossbeam_epoch..atomic..Owned$LT$crossbeam_epoch..internal..Local$GT$$GT$::hc6cfa1108bfea29f /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ptr/mod.rs:188:1 (libxul.so+0x81fb519)
[task 2022-01-09T19:50:55.728Z] 19:50:55     INFO -     #11 core::mem::drop::h0ecc1fce6baabf37 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/mem/mod.rs:898:24 (libxul.so+0x81fb519)
[task 2022-01-09T19:50:55.729Z] 19:50:55     INFO -     #12 crossbeam_epoch::guard::Guard::defer_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::hae5e3241e640db2c /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/guard.rs:193:47 (libxul.so+0x81fb519)
[task 2022-01-09T19:50:55.730Z] 19:50:55     INFO -     #13 crossbeam_epoch::deferred::Deferred::new::call::h0fe1efb5e19b64ac /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/deferred.rs:44:21 (libxul.so+0x81fb519)
[task 2022-01-09T19:50:55.731Z] 19:50:55     INFO -     #14 crossbeam_epoch::deferred::Deferred::call::h195c5afde194755f /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/deferred.rs:78:18 (libxul.so+0xa453aa)
[task 2022-01-09T19:50:55.732Z] 19:50:55     INFO -     #15 _$LT$crossbeam_epoch..internal..Bag$u20$as$u20$core..ops..drop..Drop$GT$::drop::h28f1b479cb229dd3 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/internal.rs:199:13 (libxul.so+0xa453aa)
[task 2022-01-09T19:50:55.733Z] 19:50:55     INFO -     #16 core::ptr::drop_in_place$LT$crossbeam_epoch..internal..Bag$GT$::h6146f43ff489c6ba /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ptr/mod.rs:188:1 (libxul.so+0xa453aa)
[task 2022-01-09T19:50:55.736Z] 19:50:55     INFO -     #17 core::ptr::drop_in_place$LT$crossbeam_epoch..internal..SealedBag$GT$::h95e6b9f52d3ae1f1 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ptr/mod.rs:188:1 (libxul.so+0xa453aa)
[task 2022-01-09T19:50:55.748Z] 19:50:55     INFO -     #18 core::mem::drop::h854891774e405b91 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/mem/mod.rs:898:24 (libxul.so+0xa453aa)
[task 2022-01-09T19:50:55.749Z] 19:50:55     INFO -     #19 crossbeam_epoch::internal::Global::collect::hdba6452e470fe41a /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/internal.rs:293:37 (libxul.so+0xa453aa)
[task 2022-01-09T19:50:55.750Z] 19:50:55     INFO -     #20 crossbeam_epoch::internal::Local::pin::hc8ae85e4f9bd6a84 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/internal.rs:509:17 (libxul.so+0x8847bf5)
[task 2022-01-09T19:50:55.751Z] 19:50:55     INFO -     #21 crossbeam_epoch::collector::LocalHandle::pin::h6ca90785cdf62cfe /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/collector.rs:81:18 (libxul.so+0x8847bf5)
[task 2022-01-09T19:50:55.752Z] 19:50:55     INFO -     #22 crossbeam_epoch::default::pin::_$u7b$$u7b$closure$u7d$$u7d$::h7e1b379ed6cc8013 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:24:26 (libxul.so+0x8847bf5)
[task 2022-01-09T19:50:55.753Z] 19:50:55     INFO -     #23 crossbeam_epoch::default::with_handle::_$u7b$$u7b$closure$u7d$$u7d$::he9302a9c6f0858b7 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:44:23 (libxul.so+0x8847bf5)
[task 2022-01-09T19:50:55.753Z] 19:50:55     INFO -     #24 std::thread::local::LocalKey$LT$T$GT$::try_with::h24176d3ec5778736 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/local.rs:399:16 (libxul.so+0x8847bf5)
[task 2022-01-09T19:50:55.754Z] 19:50:55     INFO -     #25 crossbeam_epoch::default::with_handle::h47e9aea0010846e4 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:43:5 (libxul.so+0x8847bf5)
[task 2022-01-09T19:50:55.756Z] 19:50:55     INFO -     #26 crossbeam_epoch::default::pin::hc2062a1e623e886b /builds/worker/checkouts/gecko/third_party/rust/crossbeam-epoch/src/default.rs:24:5 (libxul.so+0x8847bf5)
[task 2022-01-09T19:50:55.757Z] 19:50:55     INFO -     #27 crossbeam_deque::deque::Stealer$LT$T$GT$::steal::h015ce23b7088dbd3 /builds/worker/checkouts/gecko/third_party/rust/crossbeam-deque/src/deque.rs:640:22 (libxul.so+0x8847509)
[task 2022-01-09T19:50:55.759Z] 19:50:55     INFO -     #28 rayon_core::registry::WorkerThread::steal::_$u7b$$u7b$closure$u7d$$u7d$::h421440d0b838d46d /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:775:27 (libxul.so+0x8847509)
[task 2022-01-09T19:50:55.763Z] 19:50:55     INFO -     #29 core::iter::traits::iterator::Iterator::find_map::check::_$u7b$$u7b$closure$u7d$$u7d$::hb990ede9220270de /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/traits/iterator.rs:2409:32 (libxul.so+0x8847509)
[task 2022-01-09T19:50:55.765Z] 19:50:55     INFO -     #30 core::iter::adapters::filter::filter_try_fold::_$u7b$$u7b$closure$u7d$$u7d$::h1c83a990354ddd41 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/adapters/filter.rs:44:44 (libxul.so+0x8847509)
[task 2022-01-09T19:50:55.766Z] 19:50:55     INFO -     #31 core::iter::traits::iterator::Iterator::try_fold::h94cb07bb7265647e /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/traits/iterator.rs:1995:21 (libxul.so+0xa86cbd)
[task 2022-01-09T19:50:55.768Z] 19:50:55     INFO -     #32 _$LT$core..iter..adapters..chain..Chain$LT$A$C$B$GT$$u20$as$u20$core..iter..traits..iterator..Iterator$GT$::try_fold::h64847770589a13e0 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/adapters/chain.rs:108:19 (libxul.so+0xa86cbd)
[task 2022-01-09T19:50:55.769Z] 19:50:55     INFO -     #33 _$LT$core..iter..adapters..filter..Filter$LT$I$C$P$GT$$u20$as$u20$core..iter..traits..iterator..Iterator$GT$::try_fold::h1d4dddada4439d53 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/adapters/filter.rs:93:9 (libxul.so+0xa86cbd)
[task 2022-01-09T19:50:55.771Z] 19:50:55     INFO -     #34 core::iter::traits::iterator::Iterator::find_map::h685bd0b6f0f4ed11 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/iter/traits/iterator.rs:2415:9 (libxul.so+0xa86cbd)
[task 2022-01-09T19:50:55.772Z] 19:50:55     INFO -     #35 rayon_core::registry::WorkerThread::steal::h43ab155495fc0368 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:770:23 (libxul.so+0xa86cbd)
[task 2022-01-09T19:50:55.774Z] 19:50:55     INFO -     #36 rayon_core::registry::WorkerThread::wait_until_cold::_$u7b$$u7b$closure$u7d$$u7d$::h4c082233ca945f17 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:722:29 (libxul.so+0xa86cbd)
[task 2022-01-09T19:50:55.779Z] 19:50:55     INFO -     #37 core::option::Option$LT$T$GT$::or_else::h9cc63b8672ea6941 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/option.rs:1149:21 (libxul.so+0xa86cbd)
[task 2022-01-09T19:50:55.782Z] 19:50:55     INFO -     #38 rayon_core::registry::WorkerThread::wait_until_cold::h8762a664c00f1cd7 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:720:32 (libxul.so+0xa86cbd)
[task 2022-01-09T19:50:55.782Z] 19:50:55     INFO -     #39 rayon_core::registry::WorkerThread::wait_until::hed6344216849de4c /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:700:13 (libxul.so+0x8849ce2)
[task 2022-01-09T19:50:55.785Z] 19:50:55     INFO -     #40 rayon_core::registry::main_loop::h6c8eb87bc1e8e548 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:833:5 (libxul.so+0x8849ce2)
[task 2022-01-09T19:50:55.785Z] 19:50:55     INFO -     #41 rayon_core::registry::ThreadBuilder::run::h3be7b22a9fe4a795 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:55:18 (libxul.so+0x8849ce2)
[task 2022-01-09T19:50:55.786Z] 19:50:55     INFO -     #42 _$LT$rayon_core..registry..DefaultSpawn$u20$as$u20$rayon_core..registry..ThreadSpawn$GT$::spawn::_$u7b$$u7b$closure$u7d$$u7d$::ha00e05feeb339628 /builds/worker/checkouts/gecko/third_party/rust/rayon-core/src/registry.rs:100:20 (libxul.so+0x8849ce2)
[task 2022-01-09T19:50:55.787Z] 19:50:55     INFO -     #43 std::sys_common::backtrace::__rust_begin_short_backtrace::ha9b8ded0a83df047 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys_common/backtrace.rs:123:18 (libxul.so+0x8849ce2)
[task 2022-01-09T19:50:55.789Z] 19:50:55     INFO -     #44 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::_$u7b$$u7b$closure$u7d$$u7d$::hf33e9702109ccacb /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:483:17 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.790Z] 19:50:55     INFO -     #45 _$LT$core..panic..unwind_safe..AssertUnwindSafe$LT$F$GT$$u20$as$u20$core..ops..function..FnOnce$LT$$LP$$RP$$GT$$GT$::call_once::h7cdfa02bc72299c4 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/panic/unwind_safe.rs:271:9 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.791Z] 19:50:55     INFO -     #46 std::panicking::try::do_call::h2b3a4856b7148a38 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:403:40 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.793Z] 19:50:55     INFO -     #47 std::panicking::try::hfcbea43ea1ad0ef8 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:367:19 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.794Z] 19:50:55     INFO -     #48 std::panic::catch_unwind::he48d8d39e765f3d2 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panic.rs:133:14 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.794Z] 19:50:55     INFO -     #49 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::h5c7c868b5acb8b9c /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:482:30 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.797Z] 19:50:55     INFO -     #50 core::ops::function::FnOnce::call_once$u7b$$u7b$vtable.shim$u7d$$u7d$::h367f7f25e479b507 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ops/function.rs:227:5 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.798Z] 19:50:55     INFO -     #51 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::_$u7b$$u7b$closure$u7d$$u7d$::hf33e9702109ccacb /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:483:17 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.799Z] 19:50:55     INFO -     #52 _$LT$core..panic..unwind_safe..AssertUnwindSafe$LT$F$GT$$u20$as$u20$core..ops..function..FnOnce$LT$$LP$$RP$$GT$$GT$::call_once::h7cdfa02bc72299c4 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/panic/unwind_safe.rs:271:9 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.801Z] 19:50:55     INFO -     #53 std::panicking::try::do_call::h2b3a4856b7148a38 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:403:40 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.801Z] 19:50:55     INFO -     #54 std::panicking::try::hfcbea43ea1ad0ef8 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panicking.rs:367:19 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.801Z] 19:50:55     INFO -     #55 std::panic::catch_unwind::he48d8d39e765f3d2 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/panic.rs:133:14 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.802Z] 19:50:55     INFO -     #56 std::thread::Builder::spawn_unchecked::_$u7b$$u7b$closure$u7d$$u7d$::h5c7c868b5acb8b9c /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/thread/mod.rs:482:30 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.805Z] 19:50:55     INFO -     #57 core::ops::function::FnOnce::call_once$u7b$$u7b$vtable.shim$u7d$$u7d$::h367f7f25e479b507 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/core/src/ops/function.rs:227:5 (libxul.so+0x8848ff2)
[task 2022-01-09T19:50:55.805Z] 19:50:55     INFO -     #58 _$LT$alloc..boxed..Box$LT$F$C$A$GT$$u20$as$u20$core..ops..function..FnOnce$LT$Args$GT$$GT$::call_once::h3e949387289b268d /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/boxed.rs:1691:9 (libxul.so+0x896c956)
[task 2022-01-09T19:50:55.806Z] 19:50:55     INFO -     #59 _$LT$alloc..boxed..Box$LT$F$C$A$GT$$u20$as$u20$core..ops..function..FnOnce$LT$Args$GT$$GT$::call_once::hc4a8c5c4cb783526 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/alloc/src/boxed.rs:1691:9 (libxul.so+0x896c956)
[task 2022-01-09T19:50:55.810Z] 19:50:55     INFO -     #60 std::sys::unix::thread::Thread::new::thread_start::hf06b1efcbfff52b6 /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/thread.rs:106:17 (libxul.so+0x896c956)

[task 2022-01-09T19:50:55.948Z] 19:50:55     INFO - SUMMARY: ThreadSanitizer: data race /builds/worker/fetches/rustc/lib/rustlib/src/rust/library/std/src/sys/unix/alloc.rs:42:9 in std::sys::unix::alloc::_$LT$impl$u20$core..alloc..global..GlobalAlloc$u20$for$u20$std..alloc..System$GT$::dealloc::h2bab29fb7681d672
[task 2022-01-09T19:50:55.949Z] 19:50:55     INFO - ==================
[task 2022-01-09T19:50:56.066Z] 19:50:56    ERROR - TEST-UNEXPECTED-FAIL | xpcom/string/crashtests/1113005.html (finished) | application terminated with exit code -6
[task 2022-01-09T19:50:56.081Z] 19:50:56     INFO - REFTEST INFO | Process mode: e10s
[task 2022-01-09T19:50:56.082Z] 19:50:56  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2022-01-09T19:50:56.123Z] 19:50:56    ERROR - Return code: 250
[task 2022-01-09T19:50:56.124Z] 19:50:56     INFO - TinderboxPrint: reftest-crashtest<br/>246/0/0
[task 2022-01-09T19:50:56.125Z] 19:50:56    ERROR - # TBPL FAILURE #
[task 2022-01-09T19:50:56.126Z] 19:50:56  WARNING - setting return code to 2
[task 2022-01-09T19:50:56.126Z] 19:50:56    ERROR - The reftest suite: crashtest ran with return status: FAILURE

Emilio, can you please take a look?
Thank you!

Flags: needinfo?(emilio)
Whiteboard: [stockwell needswork:owner]

This race is deep in crossbeam / rayon and is happening both in StyleThreads and WrWorker threads, so it might be an upstream issue...

Or maybe they are using some fence or some other thing tsan doesn't support? Aria, you have experience looking at this stuff IIRC, any chance you could take a look?

Flags: needinfo?(emilio) → needinfo?(a.beingessner)

Did we recently update crossbeam? It's possible the signature of these suppressions has changed:

https://searchfox.org/mozilla-central/rev/5ce782034b736293836a2850ab698e149ca04657/mozglue/build/TsanOptions.cpp#186-195

Flags: needinfo?(a.beingessner)

It looks like maybe we want to add "race:crossbeam_deque*::steal\n" to the suppression list?

Assignee: nobody → emilio
Pushed by ealvarez@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/b7493a1da8af
Add crossbeam_deque's steal to the tsan suppressions. r=Gankra,decoder
Status: REOPENED → RESOLVED
Closed: 3 years ago2 years ago
Resolution: --- → FIXED
Target Milestone: --- → 98 Branch

Since the status are different for nightly and release, what's the status for beta?
For more information, please visit auto_nag documentation.

The patch landed in nightly and beta is affected.
:emilio, is this bug important enough to require an uplift?
If not please set status_beta to wontfix.

For more information, please visit auto_nag documentation.

Flags: needinfo?(emilio)
Flags: needinfo?(emilio)
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: