Closed Bug 1703191 Opened 5 years ago Closed 5 years ago

Intermittent ThreadSanitizer: heap-use-after-free /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_posix.cc:970:3 in IPC::Channel::CloseClientFileDescriptor()

Tracking

()

Status:

RESOLVED FIXED

Milestone:

89 Branch

Tracking Flags:

Tracking

Status

firefox-esr78

89+

fixed

firefox87

---

wontfix

firefox88

---

wontfix

firefox89

fixed

People

(Reporter: malexandru, Assigned: jld)

References

(Blocks 1 open bug)

Details

(4 keywords, Whiteboard: [post-critsmash-triage][adv-main89+r][adv-esr78.11+r])

Attachments

(2 files)

Bug 1703191. 5 years ago Jed Davis [:jld] ⟨⏰\|UTC-7⟩ ⟦he/him⟧ 48 bytes, text/x-phabricator-request		Details
Bug 1703191. (ESR78 backport.) 5 years ago Jed Davis [:jld] ⟨⏰\|UTC-7⟩ ⟦he/him⟧ 48 bytes, text/x-phabricator-request	RyanVM : approval-mozilla-esr78+	Details

Alexandru Michis [:malexandru]

Reporter

Description

•

5 years ago

Failure log, raw log

[task 2021-04-06T08:32:22.669Z] 08:32:22     INFO - TEST-OK | /encrypted-media/clearkey-generate-request-disallowed-input.https.html | took 3096ms
[task 2021-04-06T08:32:22.669Z] 08:32:22     INFO - TEST-START | /encrypted-media/clearkey-invalid-license.https.html
[task 2021-04-06T08:32:22.677Z] 08:32:22     INFO - Closing window 47
[task 2021-04-06T08:32:23.223Z] 08:32:23     INFO - PID 4544 | ==================
[task 2021-04-06T08:32:23.223Z] 08:32:23     INFO - PID 4544 | WARNING: ThreadSanitizer: heap-use-after-free (pid=4544)
[task 2021-04-06T08:32:23.223Z] 08:32:23     INFO - PID 4544 |   Read of size 8 at 0x7b0400086b40 by thread T39:
[task 2021-04-06T08:32:23.223Z] 08:32:23     INFO - PID 4544 |     #0 IPC::Channel::CloseClientFileDescriptor() /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_posix.cc:970:3 (libxul.so+0x149d3bb)
[task 2021-04-06T08:32:23.223Z] 08:32:23     INFO - PID 4544 |     #1 mozilla::ipc::PosixProcessLauncher::DoFinishLaunch() /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:1281:13 (libxul.so+0x14ca825)
[task 2021-04-06T08:32:23.223Z] 08:32:23     INFO - PID 4544 |     #2 mozilla::ipc::BaseProcessLauncher::FinishLaunch() /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:1605:8 (libxul.so+0x14ca87a)
[task 2021-04-06T08:32:23.223Z] 08:32:23     INFO - PID 4544 |     #3 operator() /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:1023:22 (libxul.so+0x14e4c92)
[task 2021-04-06T08:32:23.223Z] 08:32:23     INFO - PID 4544 |     #4 InvokeMethod<(lambda at /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:1021:7), RefPtr<mozilla::MozPromise<mozilla::ipc::LaunchResults, mozilla::ipc::LaunchError, false> > ((lambda at /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:1021:7)::*)(int) const, const int &> /builds/worker/workspace/obj-build/dist/include/mozilla/MozPromise.h:630:12 (libxul.so+0x14e4c92)
[task 2021-04-06T08:32:23.223Z] 08:32:23     INFO - PID 4544 |     #5 InvokeCallbackMethod<true, (lambda at /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:1021:7), RefPtr<mozilla::MozPromise<mozilla::ipc::LaunchResults, mozilla::ipc::LaunchError, false> > ((lambda at /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:1021:7)::*)(int) const, const int &, RefPtr<mozilla::MozPromise<mozilla::ipc::LaunchResults, mozilla::ipc::LaunchError, false>::Private> > /builds/worker/workspace/obj-build/dist/include/mozilla/MozPromise.h:646:14 (libxul.so+0x14e4c92)
[task 2021-04-06T08:32:23.224Z] 08:32:23     INFO - PID 4544 |     #6 mozilla::MozPromise<int, mozilla::ipc::LaunchError, false>::ThenValue<mozilla::ipc::BaseProcessLauncher::PerformAsyncLaunch()::$_6, mozilla::ipc::BaseProcessLauncher::PerformAsyncLaunch()::$_7>::DoResolveOrRejectInternal(mozilla::MozPromise<int, mozilla::ipc::LaunchError, false>::ResolveOrRejectValue&) /builds/worker/workspace/obj-build/dist/include/mozilla/MozPromise.h:846:9 (libxul.so+0x14e4c92)
[task 2021-04-06T08:32:23.225Z] 08:32:23     INFO - PID 4544 |     #7 mozilla::MozPromise<int, mozilla::ipc::LaunchError, false>::ThenValueBase::DoResolveOrReject(mozilla::MozPromise<int, mozilla::ipc::LaunchError, false>::ResolveOrRejectValue&) /builds/worker/workspace/obj-build/dist/include/mozilla/MozPromise.h:608:7 (libxul.so+0x14df860)
[task 2021-04-06T08:32:23.226Z] 08:32:23     INFO - PID 4544 |     #8 mozilla::MozPromise<int, mozilla::ipc::LaunchError, false>::ThenValueBase::ResolveOrRejectRunnable::Run() /builds/worker/workspace/obj-build/dist/include/mozilla/MozPromise.h:487:21 (libxul.so+0x14df2b9)
[task 2021-04-06T08:32:23.226Z] 08:32:23     INFO - PID 4544 |     #9 mozilla::TaskQueue::Runner::Run() /builds/worker/checkouts/gecko/xpcom/threads/TaskQueue.cpp:158:20 (libxul.so+0xbdd62f)
[task 2021-04-06T08:32:23.227Z] 08:32:23     INFO - PID 4544 |     #10 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1149:16 (libxul.so+0xbebffb)
[task 2021-04-06T08:32:23.228Z] 08:32:23     INFO - PID 4544 |     #11 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:548:10 (libxul.so+0xbf2312)
[task 2021-04-06T08:32:23.228Z] 08:32:23     INFO - PID 4544 |     #12 mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:302:20 (libxul.so+0x14fca4e)
[task 2021-04-06T08:32:23.229Z] 08:32:23     INFO - PID 4544 |     #13 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:335:10 (libxul.so+0x148667c)
[task 2021-04-06T08:32:23.230Z] 08:32:23     INFO - PID 4544 |     #14 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:328:3 (libxul.so+0x148667c)
[task 2021-04-06T08:32:23.231Z] 08:32:23     INFO - PID 4544 |     #15 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:310:3 (libxul.so+0x148667c)
[task 2021-04-06T08:32:23.233Z] 08:32:23     INFO - PID 4544 |     #16 nsThread::ThreadFunc(void*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:391:10 (libxul.so+0xbe84e8)
[task 2021-04-06T08:32:23.239Z] 08:32:23     INFO - PID 4544 |     #17 _pt_root /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:201:5 (libnspr4.so+0x4524b)
[task 2021-04-06T08:32:23.240Z] 08:32:23     INFO - PID 4544 |   Previous write of size 8 at 0x7b0400086b40 by thread T4:
[task 2021-04-06T08:32:23.241Z] 08:32:23     INFO - PID 4544 |     #0 free /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors_posix.cpp:708:3 (firefox+0x55468)
[task 2021-04-06T08:32:23.242Z] 08:32:23     INFO - PID 4544 |     #1 operator delete /builds/worker/workspace/obj-build/dist/include/mozilla/cxxalloc.h:51:10 (libxul.so+0x150ae4f)
[task 2021-04-06T08:32:23.243Z] 08:32:23     INFO - PID 4544 |     #2 DeleteTask<IPC::Channel>::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/task.h:194:5 (libxul.so+0x150ae4f)
[task 2021-04-06T08:32:23.243Z] 08:32:23     INFO - PID 4544 |     #3 MessageLoop::RunTask(already_AddRefed<nsIRunnable>) /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:468:11 (libxul.so+0x14869d6)
[task 2021-04-06T08:32:23.244Z] 08:32:23     INFO - PID 4544 |     #4 DeferOrRunPendingTask /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:477:5 (libxul.so+0x1487e30)
[task 2021-04-06T08:32:23.245Z] 08:32:23     INFO - PID 4544 |     #5 MessageLoop::DoWork() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:552:13 (libxul.so+0x1487e30)
[task 2021-04-06T08:32:23.246Z] 08:32:23     INFO - PID 4544 |     #6 base::MessagePumpLibevent::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_pump_libevent.cc:329:31 (libxul.so+0x1489900)
[task 2021-04-06T08:32:23.246Z] 08:32:23     INFO - PID 4544 |     #7 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:335:10 (libxul.so+0x148667c)
[task 2021-04-06T08:32:23.247Z] 08:32:23     INFO - PID 4544 |     #8 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:328:3 (libxul.so+0x148667c)
[task 2021-04-06T08:32:23.248Z] 08:32:23     INFO - PID 4544 |     #9 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:310:3 (libxul.so+0x148667c)
[task 2021-04-06T08:32:23.249Z] 08:32:23     INFO - PID 4544 |     #10 base::Thread::ThreadMain() /builds/worker/checkouts/gecko/ipc/chromium/src/base/thread.cc:191:16 (libxul.so+0x1496cbb)
[task 2021-04-06T08:32:23.250Z] 08:32:23     INFO - PID 4544 |     #11 ThreadFunc(void*) /builds/worker/checkouts/gecko/ipc/chromium/src/base/platform_thread_posix.cc:40:13 (libxul.so+0x14917ee)
[task 2021-04-06T08:32:23.256Z] 08:32:23     INFO - PID 4544 |   Thread T39 'IPC Launch' (tid=4663, running) created by main thread at:
[task 2021-04-06T08:32:23.257Z] 08:32:23     INFO - PID 4544 |     #0 pthread_create /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors_posix.cpp:966:3 (firefox+0x5667b)
[task 2021-04-06T08:32:23.258Z] 08:32:23     INFO - PID 4544 |     #1 _PR_CreateThread /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:458:14 (libnspr4.so+0x3c3f3)
[task 2021-04-06T08:32:23.259Z] 08:32:23     INFO - PID 4544 |     #2 PR_CreateThread /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:533:12 (libnspr4.so+0x30d15)
[task 2021-04-06T08:32:23.259Z] 08:32:23     INFO - PID 4544 |     #3 nsThread::Init(nsTSubstring<char> const&) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:609:18 (libxul.so+0xbe99d8)
[task 2021-04-06T08:32:23.260Z] 08:32:23     INFO - PID 4544 |     #4 nsThreadManager::NewNamedThread(nsTSubstring<char> const&, unsigned int, nsIThread**) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadManager.cpp:555:12 (libxul.so+0xbf118a)
[task 2021-04-06T08:32:23.261Z] 08:32:23     INFO - PID 4544 |     #5 NS_NewNamedThread(nsTSubstring<char> const&, nsIThread**, already_AddRefed<nsIRunnable>, unsigned int) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:169:57 (libxul.so+0xbf8cf7)
[task 2021-04-06T08:32:23.262Z] 08:32:23     INFO - PID 4544 |     #6 NS_NewNamedThread(nsTSubstring<char> const&, nsIThread**, nsIRunnable*, unsigned int) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:160:10 (libxul.so+0xbf4016)
[task 2021-04-06T08:32:23.263Z] 08:32:23     INFO - PID 4544 |     #7 mozilla::ipc::GetIPCLauncher() /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:930:19 (libxul.so+0x14c7fd6)
[task 2021-04-06T08:32:23.264Z] 08:32:23     INFO - PID 4544 |     #8 mozilla::ipc::BaseProcessLauncher::BaseProcessLauncher(mozilla::ipc::GeckoChildProcessHost*, std::vector<std::string, std::allocator<std::string> >&&) /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:152:45 (libxul.so+0x14dcf5d)
[task 2021-04-06T08:32:23.265Z] 08:32:23     INFO - PID 4544 |     #9 PosixProcessLauncher /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:251:9 (libxul.so+0x14c6836)
[task 2021-04-06T08:32:23.272Z] 08:32:23     INFO - PID 4544 |     #10 LinuxProcessLauncher /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:312:9 (libxul.so+0x14c6836)
[task 2021-04-06T08:32:23.274Z] 08:32:23     INFO - PID 4544 |     #11 mozilla::ipc::GeckoChildProcessHost::AsyncLaunch(std::vector<std::string, std::allocator<std::string> >) /builds/worker/checkouts/gecko/ipc/glue/GeckoChildProcessHost.cpp:695:11 (libxul.so+0x14c6836)
[task 2021-04-06T08:32:23.275Z] 08:32:23     INFO - PID 4544 |     #12 mozilla::dom::ContentParent::BeginSubprocessLaunch(mozilla::hal::ProcessPriority) /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:2567:23 (libxul.so+0x4754af0)
[task 2021-04-06T08:32:23.276Z] 08:32:23     INFO - PID 4544 |     #13 mozilla::dom::ContentParent::GetNewOrUsedLaunchingBrowserProcess(nsTSubstring<char> const&, mozilla::dom::BrowsingContextGroup*, mozilla::hal::ProcessPriority, bool) /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:1086:23 (libxul.so+0x475416b)
[task 2021-04-06T08:32:23.277Z] 08:32:23     INFO - PID 4544 |     #14 GetNewOrUsedBrowserProcess /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:1131:41 (libxul.so+0x4757cf8)
[task 2021-04-06T08:32:23.278Z] 08:32:23     INFO - PID 4544 |     #15 mozilla::dom::ContentParent::CreateBrowser(mozilla::dom::TabContext const&, mozilla::dom::Element*, nsTSubstring<char> const&, mozilla::dom::BrowsingContext*, mozilla::dom::ContentParent*) /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:1521:27 (libxul.so+0x4757cf8)
[task 2021-04-06T08:32:23.279Z] 08:32:23     INFO - PID 4544 |     #16 nsFrameLoader::TryRemoteBrowserInternal() /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:2651:9 (libxul.so+0x26ca062)
[task 2021-04-06T08:32:23.280Z] 08:32:23     INFO - PID 4544 |     #17 TryRemoteBrowser /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:2713:7 (libxul.so+0x26c11c9)
[task 2021-04-06T08:32:23.280Z] 08:32:23     INFO - PID 4544 |     #18 EnsureRemoteBrowser /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:2495:28 (libxul.so+0x26c11c9)
[task 2021-04-06T08:32:23.281Z] 08:32:23     INFO - PID 4544 |     #19 nsFrameLoader::ShowRemoteFrame(mozilla::gfx::IntSizeTyped<mozilla::ScreenPixel> const&, nsSubDocumentFrame*) /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:1070:8 (libxul.so+0x26c11c9)
[task 2021-04-06T08:32:23.282Z] 08:32:23     INFO - PID 4544 |     #20 nsFrameLoader::Show(nsSubDocumentFrame*) /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:947:12 (libxul.so+0x26c26f6)
[task 2021-04-06T08:32:23.283Z] 08:32:23     INFO - PID 4544 |     #21 nsSubDocumentFrame::ShowViewer() /builds/worker/checkouts/gecko/layout/generic/nsSubDocumentFrame.cpp:196:38 (libxul.so+0x5140139)
[task 2021-04-06T08:32:23.284Z] 08:32:23     INFO - PID 4544 |     #22 AsyncFrameInit::Run() /builds/worker/checkouts/gecko/layout/generic/nsSubDocumentFrame.cpp:96:60 (libxul.so+0x5146f9e)
[task 2021-04-06T08:32:23.284Z] 08:32:23     INFO - PID 4544 |     #23 nsContentUtils::RemoveScriptBlocker() /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:5569:17 (libxul.so+0x2407015)
[task 2021-04-06T08:32:23.289Z] 08:32:23     INFO - PID 4544 |     #24 ~nsAutoScriptBlocker /builds/worker/workspace/obj-build/dist/include/nsContentUtils.h:3476:28 (libxul.so+0x4ef9b2f)
[task 2021-04-06T08:32:23.290Z] 08:32:23     INFO - PID 4544 |     #25 mozilla::PresShell::DoFlushPendingNotifications(mozilla::ChangesToFlush) /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:4203:5 (libxul.so+0x4ef9b2f)
[task 2021-04-06T08:32:23.291Z] 08:32:23     INFO - PID 4544 |     #26 FlushPendingNotifications /builds/worker/workspace/obj-build/dist/include/mozilla/PresShell.h:1408:5 (libxul.so+0x2572f59)
[task 2021-04-06T08:32:23.292Z] 08:32:23     INFO - PID 4544 |     #27 mozilla::dom::Document::FlushPendingNotifications(mozilla::ChangesToFlush) /builds/worker/checkouts/gecko/dom/base/Document.cpp:10547:16 (libxul.so+0x2572f59)
[task 2021-04-06T08:32:23.292Z] 08:32:23     INFO - PID 4544 |     #28 mozilla::dom::Document::FlushPendingNotifications(mozilla::FlushType) /builds/worker/checkouts/gecko/dom/base/Document.cpp:10468:3 (libxul.so+0x255831c)
[task 2021-04-06T08:32:23.293Z] 08:32:23     INFO - PID 4544 |     #29 nsFrameLoader::TryRemoteBrowserInternal() /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:2529:10 (libxul.so+0x26c9a13)
[task 2021-04-06T08:32:23.294Z] 08:32:23     INFO - PID 4544 |     #30 TryRemoteBrowser /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:2713:7 (libxul.so+0x26b3de8)
[task 2021-04-06T08:32:23.295Z] 08:32:23     INFO - PID 4544 |     #31 EnsureRemoteBrowser /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:2495:28 (libxul.so+0x26b3de8)
[task 2021-04-06T08:32:23.301Z] 08:32:23     INFO - PID 4544 |     #32 nsFrameLoader::GetBrowsingContext() /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:3534:15 (libxul.so+0x26b3de8)
[task 2021-04-06T08:32:23.301Z] 08:32:23     INFO - PID 4544 |     #33 nsFrameLoader::LoadContext() /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:3523:20 (libxul.so+0x26ce455)
[task 2021-04-06T08:32:23.302Z] 08:32:23     INFO - PID 4544 |     #34 mozilla::dom::FrameLoader_Binding::get_loadContext(JSContext*, JS::Handle<JSObject*>, void*, JSJitGetterCallArgs) /builds/worker/workspace/obj-build/dom/bindings/FrameLoaderBinding.cpp:312:67 (libxul.so+0x3396ffe)
[task 2021-04-06T08:32:23.303Z] 08:32:23     INFO - PID 4544 |     #35 bool mozilla::dom::binding_detail::GenericGetter<mozilla::dom::binding_detail::NormalThisPolicy, mozilla::dom::binding_detail::ThrowExceptions>(JSContext*, unsigned int, JS::Value*) /builds/worker/checkouts/gecko/dom/bindings/BindingUtils.cpp:3124:13 (libxul.so+0x3560368)
[task 2021-04-06T08:32:23.304Z] 08:32:23     INFO - PID 4544 |     #36 CallJSNative /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:435:13 (libxul.so+0x69eb8fc)
[task 2021-04-06T08:32:23.305Z] 08:32:23     INFO - PID 4544 |     #37 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:520:12 (libxul.so+0x69eb8fc)
[task 2021-04-06T08:32:23.306Z] 08:32:23     INFO - PID 4544 |     #38 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:580:10 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.307Z] 08:32:23     INFO - PID 4544 |     #39 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:597:8 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.308Z] 08:32:23     INFO - PID 4544 |     #40 js::CallGetter(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:721:10 (libxul.so+0x69edfa5)
[task 2021-04-06T08:32:23.309Z] 08:32:23     INFO - PID 4544 |     #41 CallGetter /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2128:12 (libxul.so+0x6c9ffb5)
[task 2021-04-06T08:32:23.310Z] 08:32:23     INFO - PID 4544 |     #42 GetExistingProperty<js::CanGC> /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2157:12 (libxul.so+0x6c9ffb5)
[task 2021-04-06T08:32:23.311Z] 08:32:23     INFO - PID 4544 |     #43 NativeGetPropertyInline<js::CanGC> /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2301:14 (libxul.so+0x6c9ffb5)
[task 2021-04-06T08:32:23.317Z] 08:32:23     INFO - PID 4544 |     #44 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:2331:10 (libxul.so+0x6c9ffb5)
[task 2021-04-06T08:32:23.318Z] 08:32:23     INFO - PID 4544 |     #45 GetProperty /builds/worker/checkouts/gecko/js/src/vm/ObjectOperations-inl.h:116:10 (libxul.so+0x69f0fac)
[task 2021-04-06T08:32:23.319Z] 08:32:23     INFO - PID 4544 |     #46 GetProperty /builds/worker/checkouts/gecko/js/src/vm/ObjectOperations-inl.h:123:10 (libxul.so+0x69f0fac)
[task 2021-04-06T08:32:23.319Z] 08:32:23     INFO - PID 4544 |     #47 js::GetProperty(JSContext*, JS::Handle<JS::Value>, JS::Handle<js::PropertyName*>, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:4559:10 (libxul.so+0x69f0fac)
[task 2021-04-06T08:32:23.320Z] 08:32:23     INFO - PID 4544 |     #48 GetPropertyOperation /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:219:10 (libxul.so+0x69dd397)
[task 2021-04-06T08:32:23.321Z] 08:32:23     INFO - PID 4544 |     #49 Interpret(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:2935:12 (libxul.so+0x69dd397)
[task 2021-04-06T08:32:23.322Z] 08:32:23     INFO - PID 4544 |     #50 js::RunScript(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:405:13 (libxul.so+0x69d3dbc)
[task 2021-04-06T08:32:23.323Z] 08:32:23     INFO - PID 4544 |     #51 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:552:13 (libxul.so+0x69ec1d2)
[task 2021-04-06T08:32:23.323Z] 08:32:23     INFO - PID 4544 |     #52 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:580:10 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.324Z] 08:32:23     INFO - PID 4544 |     #53 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:597:8 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.325Z] 08:32:23     INFO - PID 4544 |     #54 js::CallGetter(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:721:10 (libxul.so+0x69edfa5)
[task 2021-04-06T08:32:23.326Z] 08:32:23     INFO - PID 4544 |     #55 CallGetter /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2128:12 (libxul.so+0x6c9ffb5)
[task 2021-04-06T08:32:23.327Z] 08:32:23     INFO - PID 4544 |     #56 GetExistingProperty<js::CanGC> /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2157:12 (libxul.so+0x6c9ffb5)
[task 2021-04-06T08:32:23.328Z] 08:32:23     INFO - PID 4544 |     #57 NativeGetPropertyInline<js::CanGC> /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2301:14 (libxul.so+0x6c9ffb5)
[task 2021-04-06T08:32:23.339Z] 08:32:23     INFO - PID 4544 |     #58 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:2331:10 (libxul.so+0x6c9ffb5)
[task 2021-04-06T08:32:23.340Z] 08:32:23     INFO - PID 4544 |     #59 GetProperty /builds/worker/checkouts/gecko/js/src/vm/ObjectOperations-inl.h:116:10 (libxul.so+0x69f0fac)
[task 2021-04-06T08:32:23.342Z] 08:32:23     INFO - PID 4544 |     #60 GetProperty /builds/worker/checkouts/gecko/js/src/vm/ObjectOperations-inl.h:123:10 (libxul.so+0x69f0fac)
[task 2021-04-06T08:32:23.343Z] 08:32:23     INFO - PID 4544 |     #61 js::GetProperty(JSContext*, JS::Handle<JS::Value>, JS::Handle<js::PropertyName*>, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:4559:10 (libxul.so+0x69f0fac)
[task 2021-04-06T08:32:23.343Z] 08:32:23     INFO - PID 4544 |     #62 GetPropertyOperation /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:219:10 (libxul.so+0x69dd397)
[task 2021-04-06T08:32:23.344Z] 08:32:23     INFO - PID 4544 |     #63 Interpret(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:2935:12 (libxul.so+0x69dd397)
[task 2021-04-06T08:32:23.345Z] 08:32:23     INFO - PID 4544 |     #64 js::RunScript(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:405:13 (libxul.so+0x69d3dbc)
[task 2021-04-06T08:32:23.346Z] 08:32:23     INFO - PID 4544 |     #65 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:552:13 (libxul.so+0x69ec1d2)
[task 2021-04-06T08:32:23.347Z] 08:32:23     INFO - PID 4544 |     #66 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:580:10 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.348Z] 08:32:23     INFO - PID 4544 |     #67 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:597:8 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.349Z] 08:32:23     INFO - PID 4544 |     #68 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:2856:10 (libxul.so+0x6ea25de)
[task 2021-04-06T08:32:23.349Z] 08:32:23     INFO - PID 4544 |     #69 mozilla::dom::LifecycleConnectedCallback::Call(mozilla::dom::BindingCallContext&, JS::Handle<JS::Value>, mozilla::ErrorResult&) /builds/worker/workspace/obj-build/dom/bindings/WebComponentsBinding.cpp:237:8 (libxul.so+0x2f13ddb)
[task 2021-04-06T08:32:23.350Z] 08:32:23     INFO - PID 4544 |     #70 void mozilla::dom::LifecycleConnectedCallback::Call<RefPtr<mozilla::dom::Element> >(RefPtr<mozilla::dom::Element> const&, mozilla::ErrorResult&, char const*, mozilla::dom::CallbackObject::ExceptionHandling, JS::Realm*) /builds/worker/workspace/obj-build/dist/include/mozilla/dom/WebComponentsBinding.h:141:12 (libxul.so+0x250bb12)
[task 2021-04-06T08:32:23.351Z] 08:32:23     INFO - PID 4544 |     #71 Call<RefPtr<mozilla::dom::Element> > /builds/worker/workspace/obj-build/dist/include/mozilla/dom/WebComponentsBinding.h:163:12 (libxul.so+0x24e1f63)
[task 2021-04-06T08:32:23.354Z] 08:32:23     INFO - PID 4544 |     #72 mozilla::dom::CustomElementCallback::Call() /builds/worker/checkouts/gecko/dom/base/CustomElementRegistry.cpp:110:13 (libxul.so+0x24e1f63)
[task 2021-04-06T08:32:23.354Z] 08:32:23     INFO - PID 4544 |     #73 mozilla::dom::CustomElementCallbackReaction::Invoke(mozilla::dom::Element*, mozilla::ErrorResult&) /builds/worker/checkouts/gecko/dom/base/CustomElementRegistry.cpp:88:29 (libxul.so+0x2508e1f)
[task 2021-04-06T08:32:23.356Z] 08:32:23     INFO - PID 4544 |     #74 mozilla::dom::CustomElementReactionsStack::InvokeReactions(AutoTArray<RefPtr<mozilla::dom::Element>, 3ul>*, nsIGlobalObject*) /builds/worker/checkouts/gecko/dom/base/CustomElementRegistry.cpp:1436:19 (libxul.so+0x24e9b3c)
[task 2021-04-06T08:32:23.357Z] 08:32:23     INFO - PID 4544 |     #75 mozilla::dom::CustomElementReactionsStack::PopAndInvokeElementQueue() /builds/worker/checkouts/gecko/dom/base/CustomElementRegistry.cpp:1328:5 (libxul.so+0x24e969e)
[task 2021-04-06T08:32:23.357Z] 08:32:23     INFO - PID 4544 |     #76 LeaveCEReactions /builds/worker/workspace/obj-build/dist/include/mozilla/dom/CustomElementRegistry.h:299:7 (libxul.so+0x1cebd8c)
[task 2021-04-06T08:32:23.358Z] 08:32:23     INFO - PID 4544 |     #77 mozilla::dom::AutoCEReaction::~AutoCEReaction() /builds/worker/workspace/obj-build/dist/include/mozilla/dom/CustomElementRegistry.h:598:22 (libxul.so+0x1cebd8c)
[task 2021-04-06T08:32:23.359Z] 08:32:23     INFO - PID 4544 |     #78 ~MaybeStorage /builds/worker/workspace/obj-build/dist/include/mozilla/Maybe.h:268:25 (libxul.so+0x2a8bb52)
[task 2021-04-06T08:32:23.366Z] 08:32:23     INFO - PID 4544 |     #79 mozilla::dom::Node_Binding::appendChild(JSContext*, JS::Handle<JSObject*>, void*, JSJitMethodCallArgs const&) /builds/worker/workspace/obj-build/dom/bindings/NodeBinding.cpp:1005:1 (libxul.so+0x2a8bb52)
[task 2021-04-06T08:32:23.367Z] 08:32:23     INFO - PID 4544 |     #80 bool mozilla::dom::binding_detail::GenericMethod<mozilla::dom::binding_detail::NormalThisPolicy, mozilla::dom::binding_detail::ThrowExceptions>(JSContext*, unsigned int, JS::Value*) /builds/worker/checkouts/gecko/dom/bindings/BindingUtils.cpp:3242:13 (libxul.so+0x3564041)
[task 2021-04-06T08:32:23.367Z] 08:32:23     INFO - PID 4544 |     #81 CallJSNative /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:435:13 (libxul.so+0x69eb8fc)
[task 2021-04-06T08:32:23.368Z] 08:32:23     INFO - PID 4544 |     #82 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:520:12 (libxul.so+0x69eb8fc)
[task 2021-04-06T08:32:23.369Z] 08:32:23     INFO - PID 4544 |     #83 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:580:10 (libxul.so+0x69e132b)
[task 2021-04-06T08:32:23.370Z] 08:32:23     INFO - PID 4544 |     #84 CallFromStack /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:584:10 (libxul.so+0x69e132b)
[task 2021-04-06T08:32:23.371Z] 08:32:23     INFO - PID 4544 |     #85 Interpret(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:3244:16 (libxul.so+0x69e132b)
[task 2021-04-06T08:32:23.372Z] 08:32:23     INFO - PID 4544 |     #86 js::RunScript(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:405:13 (libxul.so+0x69d3dbc)
[task 2021-04-06T08:32:23.373Z] 08:32:23     INFO - PID 4544 |     #87 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:552:13 (libxul.so+0x69ec1d2)
[task 2021-04-06T08:32:23.374Z] 08:32:23     INFO - PID 4544 |     #88 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:580:10 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.375Z] 08:32:23     INFO - PID 4544 |     #89 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:597:8 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.381Z] 08:32:23     INFO - PID 4544 |     #90 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:2856:10 (libxul.so+0x6ea25de)
[task 2021-04-06T08:32:23.382Z] 08:32:23     INFO - PID 4544 |     #91 mozilla::dom::EventListener::HandleEvent(mozilla::dom::BindingCallContext&, JS::Handle<JS::Value>, mozilla::dom::Event&, mozilla::ErrorResult&) /builds/worker/workspace/obj-build/dom/bindings/EventListenerBinding.cpp:58:8 (libxul.so+0x325d4ef)
[task 2021-04-06T08:32:23.382Z] 08:32:23     INFO - PID 4544 |     #92 HandleEvent<mozilla::dom::EventTarget *> /builds/worker/workspace/obj-build/dist/include/mozilla/dom/EventListenerBinding.h:65:12 (libxul.so+0x39b9030)
[task 2021-04-06T08:32:23.383Z] 08:32:23     INFO - PID 4544 |     #93 mozilla::EventListenerManager::HandleEventSubType(mozilla::EventListenerManager::Listener*, mozilla::dom::Event*, mozilla::dom::EventTarget*) /builds/worker/checkouts/gecko/dom/events/EventListenerManager.cpp:1104:43 (libxul.so+0x39b9030)
[task 2021-04-06T08:32:23.384Z] 08:32:23     INFO - PID 4544 |     #94 mozilla::EventListenerManager::HandleEventInternal(nsPresContext*, mozilla::WidgetEvent*, mozilla::dom::Event**, mozilla::dom::EventTarget*, nsEventStatus*, bool) /builds/worker/checkouts/gecko/dom/events/EventListenerManager.cpp:1301:17 (libxul.so+0x39b9aee)
[task 2021-04-06T08:32:23.385Z] 08:32:23     INFO - PID 4544 |     #95 HandleEvent /builds/worker/workspace/obj-build/dist/include/mozilla/EventListenerManager.h:390:5 (libxul.so+0x39af8c9)
[task 2021-04-06T08:32:23.385Z] 08:32:23     INFO - PID 4544 |     #96 mozilla::EventTargetChainItem::HandleEvent(mozilla::EventChainPostVisitor&, mozilla::ELMCreationDetector&) /builds/worker/checkouts/gecko/dom/events/EventDispatcher.cpp:354:17 (libxul.so+0x39af8c9)
[task 2021-04-06T08:32:23.386Z] 08:32:23     INFO - PID 4544 |     #97 mozilla::EventTargetChainItem::HandleEventTargetChain(nsTArray<mozilla::EventTargetChainItem>&, mozilla::EventChainPostVisitor&, mozilla::EventDispatchingCallback*, mozilla::ELMCreationDetector&) /builds/worker/checkouts/gecko/dom/events/EventDispatcher.cpp:592:14 (libxul.so+0x39aeedc)
[task 2021-04-06T08:32:23.387Z] 08:32:23     INFO - PID 4544 |     #98 mozilla::EventDispatcher::Dispatch(nsISupports*, nsPresContext*, mozilla::WidgetEvent*, mozilla::dom::Event*, nsEventStatus*, mozilla::EventDispatchingCallback*, nsTArray<mozilla::dom::EventTarget*>*) /builds/worker/checkouts/gecko/dom/events/EventDispatcher.cpp:1099:11 (libxul.so+0x39b177f)
[task 2021-04-06T08:32:23.388Z] 08:32:23     INFO - PID 4544 |     #99 mozilla::EventDispatcher::DispatchDOMEvent(nsISupports*, mozilla::WidgetEvent*, mozilla::dom::Event*, nsPresContext*, nsEventStatus*) /builds/worker/checkouts/gecko/dom/events/EventDispatcher.cpp (libxul.so+0x39b4220)
[task 2021-04-06T08:32:23.389Z] 08:32:23     INFO - PID 4544 |     #100 nsINode::DispatchEvent(mozilla::dom::Event&, mozilla::dom::CallerType, mozilla::ErrorResult&) /builds/worker/checkouts/gecko/dom/base/nsINode.cpp:1331:17 (libxul.so+0x26db478)
[task 2021-04-06T08:32:23.395Z] 08:32:23     INFO - PID 4544 |     #101 nsContentUtils::DispatchEvent(mozilla::dom::Document*, nsISupports*, nsTSubstring<char16_t> const&, mozilla::CanBubble, mozilla::Cancelable, mozilla::Composed, mozilla::Trusted, bool*, mozilla::ChromeOnlyDispatch) /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:4188:28 (libxul.so+0x24008f5)
[task 2021-04-06T08:32:23.396Z] 08:32:23     INFO - PID 4544 |     #102 nsContentUtils::DispatchTrustedEvent(mozilla::dom::Document*, nsISupports*, nsTSubstring<char16_t> const&, mozilla::CanBubble, mozilla::Cancelable, mozilla::Composed, bool*) /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:4158:10 (libxul.so+0x24007ec)
[task 2021-04-06T08:32:23.397Z] 08:32:23     INFO - PID 4544 |     #103 mozilla::dom::Document::DispatchContentLoadedEvents() /builds/worker/checkouts/gecko/dom/base/Document.cpp:7663:3 (libxul.so+0x2564b3c)
[task 2021-04-06T08:32:23.397Z] 08:32:23     INFO - PID 4544 |     #104 mozilla::dom::Document::UnblockDOMContentLoaded() /builds/worker/checkouts/gecko/dom/base/Document.cpp:7867:5 (libxul.so+0x25659fc)
[task 2021-04-06T08:32:23.398Z] 08:32:23     INFO - PID 4544 |     #105 mozilla::dom::Document::EndLoad() /builds/worker/checkouts/gecko/dom/base/Document.cpp:7820:3 (libxul.so+0x2565720)
[task 2021-04-06T08:32:23.399Z] 08:32:23     INFO - PID 4544 |     #106 mozilla::dom::PrototypeDocumentContentSink::DoneWalking() /builds/worker/checkouts/gecko/dom/prototype/PrototypeDocumentContentSink.cpp:659:14 (libxul.so+0x45b2cd3)
[task 2021-04-06T08:32:23.399Z] 08:32:23     INFO - PID 4544 |     #107 MaybeDoneWalking /builds/worker/checkouts/gecko/dom/prototype/PrototypeDocumentContentSink.cpp:616:10 (libxul.so+0x45b2ae8)
[task 2021-04-06T08:32:23.400Z] 08:32:23     INFO - PID 4544 |     #108 InitialTranslationCompleted /builds/worker/checkouts/gecko/dom/prototype/PrototypeDocumentContentSink.cpp:603:3 (libxul.so+0x45b2ae8)
[task 2021-04-06T08:32:23.401Z] 08:32:23     INFO - PID 4544 |     #109 non-virtual thunk to mozilla::dom::PrototypeDocumentContentSink::InitialTranslationCompleted() /builds/worker/checkouts/gecko/dom/prototype/PrototypeDocumentContentSink.cpp (libxul.so+0x45b2ae8)
[task 2021-04-06T08:32:23.402Z] 08:32:23     INFO - PID 4544 |     #110 InitialTranslationCompleted /builds/worker/checkouts/gecko/dom/l10n/DocumentL10n.cpp:302:19 (libxul.so+0x4b818c4)
[task 2021-04-06T08:32:23.403Z] 08:32:23     INFO - PID 4544 |     #111 L10nReadyHandler::ResolvedCallback(JSContext*, JS::Handle<JS::Value>) /builds/worker/checkouts/gecko/dom/l10n/DocumentL10n.cpp:79:20 (libxul.so+0x4b818c4)
[task 2021-04-06T08:32:23.405Z] 08:32:23     INFO - PID 4544 |     #112 mozilla::dom::(anonymous namespace)::PromiseNativeHandlerShim::ResolvedCallback(JSContext*, JS::Handle<JS::Value>) /builds/worker/checkouts/gecko/dom/promise/Promise.cpp:385:12 (libxul.so+0x48659bc)
[task 2021-04-06T08:32:23.406Z] 08:32:23     INFO - PID 4544 |     #113 mozilla::dom::NativeHandlerCallback(JSContext*, unsigned int, JS::Value*) /builds/worker/checkouts/gecko/dom/promise/Promise.cpp:338:29 (libxul.so+0x4865edf)
[task 2021-04-06T08:32:23.407Z] 08:32:23     INFO - PID 4544 |     #114 CallJSNative /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:435:13 (libxul.so+0x69eb8fc)
[task 2021-04-06T08:32:23.410Z] 08:32:23     INFO - PID 4544 |     #115 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:520:12 (libxul.so+0x69eb8fc)
[task 2021-04-06T08:32:23.411Z] 08:32:23     INFO - PID 4544 |     #116 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:580:10 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.412Z] 08:32:23     INFO - PID 4544 |     #117 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:597:8 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.413Z] 08:32:23     INFO - PID 4544 |     #118 Call /builds/worker/checkouts/gecko/js/src/vm/Interpreter.h:106:10 (libxul.so+0x6ba8c7f)
[task 2021-04-06T08:32:23.414Z] 08:32:23     INFO - PID 4544 |     #119 PromiseReactionJob(JSContext*, unsigned int, JS::Value*) /builds/worker/checkouts/gecko/js/src/builtin/Promise.cpp:1905:10 (libxul.so+0x6ba8c7f)
[task 2021-04-06T08:32:23.415Z] 08:32:23     INFO - PID 4544 |     #120 CallJSNative /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:435:13 (libxul.so+0x69eb8fc)
[task 2021-04-06T08:32:23.416Z] 08:32:23     INFO - PID 4544 |     #121 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:520:12 (libxul.so+0x69eb8fc)
[task 2021-04-06T08:32:23.417Z] 08:32:23     INFO - PID 4544 |     #122 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:580:10 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.418Z] 08:32:23     INFO - PID 4544 |     #123 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:597:8 (libxul.so+0x69ecda6)
[task 2021-04-06T08:32:23.419Z] 08:32:23     INFO - PID 4544 |     #124 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:2856:10 (libxul.so+0x6ea25de)
[task 2021-04-06T08:32:23.420Z] 08:32:23     INFO - PID 4544 |     #125 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+0x2b4205b)
[task 2021-04-06T08:32:23.421Z] 08:32:23     INFO - PID 4544 |     #126 Call /builds/worker/workspace/obj-build/dist/include/mozilla/dom/PromiseBinding.h:89:12 (libxul.so+0xaf422e)
[task 2021-04-06T08:32:23.422Z] 08:32:23     INFO - PID 4544 |     #127 Call /builds/worker/workspace/obj-build/dist/include/mozilla/dom/PromiseBinding.h:102:12 (libxul.so+0xaf422e)
[task 2021-04-06T08:32:23.423Z] 08:32:23     INFO - PID 4544 |     #128 mozilla::PromiseJobRunnable::Run(mozilla::AutoSlowOperation&) /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSContext.cpp:212:18 (libxul.so+0xaf422e)
[task 2021-04-06T08:32:23.424Z] 08:32:23     INFO - PID 4544 |     #129 mozilla::CycleCollectedJSContext::PerformMicroTaskCheckPoint(bool) /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSContext.cpp:647:17 (libxul.so+0xadfe9e)
[task 2021-04-06T08:32:23.424Z] 08:32:23     INFO - PID 4544 |     #130 mozilla::CycleCollectedJSContext::AfterProcessTask(unsigned int) /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSContext.cpp:462:3 (libxul.so+0xae0827)
[task 2021-04-06T08:32:23.425Z] 08:32:23     INFO - PID 4544 |     #131 XPCJSContext::AfterProcessTask(unsigned int) /builds/worker/checkouts/gecko/js/xpconnect/src/XPCJSContext.cpp:1441:28 (libxul.so+0x1aa956f)
[task 2021-04-06T08:32:23.426Z] 08:32:23     INFO - PID 4544 |     #132 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1192:24 (libxul.so+0xbec358)
[task 2021-04-06T08:32:23.427Z] 08:32:23     INFO - PID 4544 |     #133 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:548:10 (libxul.so+0xbf2312)
[task 2021-04-06T08:32:23.428Z] 08:32:23     INFO - PID 4544 |     #134 mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:87:21 (libxul.so+0x14fbebd)
[task 2021-04-06T08:32:23.429Z] 08:32:23     INFO - PID 4544 |     #135 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:335:10 (libxul.so+0x148667c)
[task 2021-04-06T08:32:23.429Z] 08:32:23     INFO - PID 4544 |     #136 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:328:3 (libxul.so+0x148667c)
[task 2021-04-06T08:32:23.430Z] 08:32:23     INFO - PID 4544 |     #137 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:310:3 (libxul.so+0x148667c)
[task 2021-04-06T08:32:23.431Z] 08:32:23     INFO - PID 4544 |     #138 nsBaseAppShell::Run() /builds/worker/checkouts/gecko/widget/nsBaseAppShell.cpp:137:27 (libxul.so+0x4bde1d6)
[task 2021-04-06T08:32:23.432Z] 08:32:23     INFO - PID 4544 |     #139 nsAppStartup::Run() /builds/worker/checkouts/gecko/toolkit/components/startup/nsAppStartup.cpp:273:30 (libxul.so+0x679a118)
[task 2021-04-06T08:32:23.433Z] 08:32:23     INFO - PID 4544 |     #140 XREMain::XRE_mainRun() /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5349:22 (libxul.so+0x68b5a7f)
[task 2021-04-06T08:32:23.434Z] 08:32:23     INFO - PID 4544 |     #141 XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5540:8 (libxul.so+0x68b68d7)
[task 2021-04-06T08:32:23.434Z] 08:32:23     INFO - PID 4544 |     #142 XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5599:21 (libxul.so+0x68b6d24)
[task 2021-04-06T08:32:23.435Z] 08:32:23     INFO - PID 4544 |     #143 mozilla::BootstrapImpl::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:45:12 (libxul.so+0x68c17c2)
[task 2021-04-06T08:32:23.436Z] 08:32:23     INFO - PID 4544 |     #144 do_main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:220:22 (firefox+0xc7c60)
[task 2021-04-06T08:32:23.437Z] 08:32:23     INFO - PID 4544 |     #145 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:347:16 (firefox+0xc7c60)
[task 2021-04-06T08:32:23.438Z] 08:32:23     INFO - PID 4544 |   Thread T4 'IPC I/O Parent' (tid=4556, running) created by main thread at:
[task 2021-04-06T08:32:23.439Z] 08:32:23     INFO - PID 4544 |     #0 pthread_create /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors_posix.cpp:966:3 (firefox+0x5667b)
[task 2021-04-06T08:32:23.439Z] 08:32:23     INFO - PID 4544 |     #1 CreateThread /builds/worker/checkouts/gecko/ipc/chromium/src/base/platform_thread_posix.cc:123:14 (libxul.so+0x148e6a7)
[task 2021-04-06T08:32:23.440Z] 08:32:23     INFO - PID 4544 |     #2 PlatformThread::Create(unsigned long, PlatformThread::Delegate*, unsigned long*) /builds/worker/checkouts/gecko/ipc/chromium/src/base/platform_thread_posix.cc:134:10 (libxul.so+0x148e6a7)
[task 2021-04-06T08:32:23.441Z] 08:32:23     INFO - PID 4544 |     #3 base::Thread::StartWithOptions(base::Thread::Options const&) /builds/worker/checkouts/gecko/ipc/chromium/src/base/thread.cc:97:8 (libxul.so+0x1496851)
[task 2021-04-06T08:32:23.442Z] 08:32:23     INFO - PID 4544 |     #4 NS_InitXPCOM /builds/worker/checkouts/gecko/xpcom/build/XPCOMInit.cpp:317:9 (libxul.so+0xc2537c)
[task 2021-04-06T08:32:23.443Z] 08:32:23     INFO - PID 4544 |     #5 ScopedXPCOMStartup::Initialize(bool) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:1703:8 (libxul.so+0x68abead)
[task 2021-04-06T08:32:23.445Z] 08:32:23     INFO - PID 4544 |     #6 XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5536:22 (libxul.so+0x68b68c1)
[task 2021-04-06T08:32:23.446Z] 08:32:23     INFO - PID 4544 |     #7 XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5599:21 (libxul.so+0x68b6d24)
[task 2021-04-06T08:32:23.447Z] 08:32:23     INFO - PID 4544 |     #8 mozilla::BootstrapImpl::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:45:12 (libxul.so+0x68c17c2)
[task 2021-04-06T08:32:23.448Z] 08:32:23     INFO - PID 4544 |     #9 do_main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:220:22 (firefox+0xc7c60)
[task 2021-04-06T08:32:23.449Z] 08:32:23     INFO - PID 4544 |     #10 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:347:16 (firefox+0xc7c60)
[task 2021-04-06T08:32:23.451Z] 08:32:23     INFO - PID 4544 | SUMMARY: ThreadSanitizer: heap-use-after-free /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_posix.cc:970:3 in IPC::Channel::CloseClientFileDescriptor()
[task 2021-04-06T08:32:23.452Z] 08:32:23     INFO - PID 4544 | ==================
[task 2021-04-06T08:32:23.453Z] 08:32:23     INFO - PID 4544 | Exiting due to channel error.
[task 2021-04-06T08:32:23.455Z] 08:32:23     INFO - PID 4544 | Exiting due to channel error.
[task 2021-04-06T08:32:23.457Z] 08:32:23     INFO - PID 4544 | Crash Annotation GraphicsCriticalError: |[C0][GFX1-]: Receive IPC close with reason=AbnormalShutdown (t=7.93537) Exiting due to channel error.
[task 2021-04-06T08:32:23.459Z] 08:32:23     INFO - PID 4544 | Crash Annotation GraphicsCriticalError: |[C0][GFX1-]: Receive IPC close with reason=AbnormalShutdown (t=57.7653) [GFX1-]: Receive IPC close with reason=AbnormalShutdown
[task 2021-04-06T08:32:23.460Z] 08:32:23     INFO - PID 4544 | Exiting due to channel error.
[task 2021-04-06T08:32:23.461Z] 08:32:23     INFO - IOError on command, setting status to CRASH
[task 2021-04-06T08:32:23.463Z] 08:32:23     INFO - TEST-UNEXPECTED-CRASH | /encrypted-media/clearkey-invalid-license.https.html | expected OK
[task 2021-04-06T08:32:23.464Z] 08:32:23     INFO - TEST-INFO took 702ms
[task 2021-04-06T08:32:24.389Z] 08:32:24     INFO - Browser exited with return code -6
[task 2021-04-06T08:32:24.390Z] 08:32:24     INFO - PROCESS LEAKS None
[task 2021-04-06T08:32:24.394Z] 08:32:24     INFO - Closing logging queue
[task 2021-04-06T08:32:24.395Z] 08:32:24     INFO - queue closed
[task 2021-04-06T08:32:24.411Z] 08:32:24     INFO - INFO | runtests.py | TSan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2021-04-06T08:32:24.412Z] 08:32:24     INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmp7owym5b2
[task 2021-04-06T08:32:24.419Z] 08:32:24     INFO - PID 4851 | 1617697936691	Marionette	INFO	Marionette enabled
[task 2021-04-06T08:32:24.423Z] 08:32:24     INFO - Starting runner
[task 2021-04-06T08:32:27.057Z] 08:32:27     INFO - PID 4851 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmp82o4wo8q/search.json.mozlz4", (void 0)))
[task 2021-04-06T08:32:34.717Z] 08:32:34     INFO - PID 4851 | 1617697954716	Marionette	INFO	Listening on port 46053
[task 2021-04-06T08:32:36.219Z] 08:32:36     INFO - TEST-START | /encrypted-media/clearkey-keystatuses-multiple-sessions.https.html
[task 2021-04-06T08:32:36.389Z] 08:32:36     INFO - Setting pref dom.security.featurePolicy.experimental.enabled (true)
[task 2021-04-06T08:32:36.511Z] 08:32:36     INFO - Setting pref dom.security.featurePolicy.header.enabled (true)
[task 2021-04-06T08:32:36.621Z] 08:32:36     INFO - Setting pref dom.security.featurePolicy.webidl.enabled (true)
[task 2021-04-06T08:32:40.096Z] 08:32:40     INFO - .
[task 2021-04-06T08:32:40.096Z] 08:32:40     INFO - TEST-OK | /encrypted-media/clearkey-keystatuses-multiple-sessions.https.html | took 3874ms

Andrew McCreight [:mccr8]

Updated

•

5 years ago

Group: core-security → dom-core-security

Andrew McCreight [:mccr8]

Comment 1

•

5 years ago

Weird, I didn't realize TSan detected UAFs.

Blocks: tsan

Keywords: csectype-uaf

Andrew McCreight [:mccr8]

Comment 2

•

5 years ago

Jed, is this something you could look at? It looks like PosixProcessLauncher has a raw pointer to a channel, and is using it after the channel gets deleted for some reason. Unfortunately the stack doesn't really reveal why we are destroying the channel AFAICT due to the delete task.

Flags: needinfo?(jld)

Jed Davis [:jld] ⟨⏰|UTC-7⟩ ⟦he/him⟧

Assignee

Comment 3

•

5 years ago

Short answer: it needs to keep the child end of the socketpair alive until after the process has been forked. mChannel doesn't seem to be used for anything else, so it should work to have the launcher take ownership of the fd instead.

Assignee: nobody → jld

Flags: needinfo?(jld)

Jed Davis [:jld] ⟨⏰|UTC-7⟩ ⟦he/him⟧

Assignee

Comment 4

•

5 years ago

Cleaning up ownership… works, but is complicated, and for this we'd probably want something minimally invasive for uplift. It's simpler to do the same hack as in Transport_posix.cpp: dup the fd and close the channel's copy.

Unfortunately, it's going to be hard to hide what this patch is doing: either I delete this comment which no longer applies and make it obvious what's changing, or I leave it in place right next to the code that's touching the pointers that it's talking about.

Daniel Veditz [:dveditz]

Updated

•

5 years ago

Keywords: csectype-race, sec-moderate

Jed Davis [:jld] ⟨⏰|UTC-7⟩ ⟦he/him⟧

Assignee

Comment 5

•

5 years ago

Attached file Bug 1703191. — Details

Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)

Comment 6

•

5 years ago

r=mccr8
https://hg.mozilla.org/integration/autoland/rev/f96995cdc23511263ad0fd935c4680f8cfe51fa3
https://hg.mozilla.org/mozilla-central/rev/f96995cdc235

Group: dom-core-security → core-security-release

Status: NEW → RESOLVED

Closed: 5 years ago

status-firefox89: affected → fixed

Resolution: --- → FIXED

Target Milestone: --- → 89 Branch

Ryan VanderMeulen [:RyanVM]

Updated

•

5 years ago

status-firefox87: --- → wontfix

status-firefox88: --- → wontfix

status-firefox-esr78: --- → affected

tracking-firefox89: --- → +

tracking-firefox-esr78: --- → 89+

Brindusa Tot, DTE

Updated

•

5 years ago

Flags: qe-verify-

Whiteboard: [post-critsmash-triage]

Julien Cristau [:jcristau]

Comment 7

•

5 years ago

Is this ready for uplift to esr78?

Flags: needinfo?(jld)

Jed Davis [:jld] ⟨⏰|UTC-7⟩ ⟦he/him⟧

Assignee

Comment 8

•

5 years ago

Attached file Bug 1703191. (ESR78 backport.) — Details

Jed Davis [:jld] ⟨⏰|UTC-7⟩ ⟦he/him⟧

Assignee

Comment 9

•

5 years ago

(In reply to Julien Cristau [:jcristau] from comment #7)

Is this ready for uplift to esr78?

Yes, but there was a minor merge conflict; I've attached a modified patch.

Flags: needinfo?(jld)

Jed Davis [:jld] ⟨⏰|UTC-7⟩ ⟦he/him⟧

Assignee

Comment 10

•

5 years ago

Comment on attachment 9217929 [details]
Bug 1703191. (ESR78 backport.)

ESR Uplift Approval Request

If this is not a sec:{high,crit} bug, please state case for ESR consideration: sec-moderate and should be relatively low risk; note that this is a manual backport of D111193
User impact if declined: exposure to a security bug
Fix Landed on Version: 89
Risk to taking this patch: Low
Why is the change risky/not risky? (and alternatives if risky): The patch is relatively self-contained, and the code is used whenever we launch an IPC child process on Linux and Mac so it gets a lot of test coverage.
String or UUID changes made by this patch: none

Attachment #9217929 - Flags: approval-mozilla-esr78?

Ryan VanderMeulen [:RyanVM]

Comment 11

•

5 years ago

Comment on attachment 9217929 [details]
Bug 1703191. (ESR78 backport.)

Approved for 78.11esr.

Attachment #9217929 - Flags: approval-mozilla-esr78? → approval-mozilla-esr78+

Ryan VanderMeulen [:RyanVM]

Comment 12

•

5 years ago

uplift

https://hg.mozilla.org/releases/mozilla-esr78/rev/0c2865c2251a

status-firefox-esr78: affected → fixed

Frederik Braun [:freddy]

Updated

•

4 years ago

Whiteboard: [post-critsmash-triage] → [post-critsmash-triage][adv-main89+r]

Frederik Braun [:freddy]

Updated

•

4 years ago

Whiteboard: [post-critsmash-triage][adv-main89+r] → [post-critsmash-triage][adv-main89+r][adv-esr78.11+r]

Daniel Veditz [:dveditz]

Updated

•

4 years ago

Group: core-security-release

You need to log in before you can comment on or make changes to this bug.