Closed Bug 1633065 Opened 4 years ago Closed 4 years ago

Intermittent SUMMARY: ThreadSanitizer: data race /builds/worker/checkouts/gecko/toolkit/crashreporter/google-breakpad/src/common/linux/linux_libc_support.cc:61:9 in my_strncmp

Categories

(Toolkit :: Crash Reporting, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure)

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


[task 2020-04-24T23:59:53.381Z] 23:59:53     INFO - TEST-START | layout/base/tests/test_zoom_restore_bfcache.html
[task 2020-04-24T23:59:56.301Z] 23:59:56     INFO - GECKO(3387) | MEMORY STAT | vsize 130550683MB | residentFast 1127MB
[task 2020-04-24T23:59:57.103Z] 23:59:57     INFO - TEST-OK | layout/base/tests/test_zoom_restore_bfcache.html | took 3720ms
[task 2020-04-24T23:59:57.281Z] 23:59:57     INFO - TEST-START | Shutdown
[task 2020-04-24T23:59:57.282Z] 23:59:57     INFO - Passed:  3021
[task 2020-04-24T23:59:57.283Z] 23:59:57     INFO - Failed:  0
[task 2020-04-24T23:59:57.284Z] 23:59:57     INFO - Todo:    24
[task 2020-04-24T23:59:57.287Z] 23:59:57     INFO - Mode:    e10s
[task 2020-04-24T23:59:57.288Z] 23:59:57     INFO - Slowest: 8949ms - /tests/layout/base/tests/test_bug399284.html
[task 2020-04-24T23:59:57.292Z] 23:59:57     INFO - SimpleTest FINISHED
[task 2020-04-24T23:59:57.293Z] 23:59:57     INFO - TEST-INFO | Ran 1 Loops
[task 2020-04-24T23:59:57.294Z] 23:59:57     INFO - SimpleTest FINISHED
[task 2020-04-25T00:00:01.087Z] 00:00:01     INFO - GECKO(3387) | 1587772801082	Marionette	TRACE	Received observer notification xpcom-will-shutdown
[task 2020-04-25T00:00:01.087Z] 00:00:01     INFO - GECKO(3387) | 1587772801083	Marionette	INFO	Stopped listening on port 2828
[task 2020-04-25T00:00:01.087Z] 00:00:01     INFO - GECKO(3387) | 1587772801084	Marionette	DEBUG	Marionette stopped listening
[task 2020-04-25T00:00:04.301Z] 00:00:04     INFO - GECKO(3387) | ==================
[task 2020-04-25T00:00:04.301Z] 00:00:04     INFO - GECKO(3387) | WARNING: ThreadSanitizer: data race (pid=3387)
[task 2020-04-25T00:00:04.302Z] 00:00:04     INFO - GECKO(3387) |   Read of size 1 at 0x7f4ca2415000 by thread T75 (mutexes: write M2333):
[task 2020-04-25T00:00:04.302Z] 00:00:04     INFO - GECKO(3387) |     #0 my_strncmp /builds/worker/checkouts/gecko/toolkit/crashreporter/google-breakpad/src/common/linux/linux_libc_support.cc:61:9 (libxul.so+0x5f9cb97)
[task 2020-04-25T00:00:04.303Z] 00:00:04     INFO - GECKO(3387) |     #1 IsValidElf /builds/worker/checkouts/gecko/toolkit/crashreporter/google-breakpad/src/common/linux/elfutils.cc:109:10 (libxul.so+0x5f99fe7)
[task 2020-04-25T00:00:04.303Z] 00:00:04     INFO - GECKO(3387) |     #2 google_breakpad::FindElfSegments(void const*, unsigned int, google_breakpad::wasteful_vector<google_breakpad::ElfSegment>*) /builds/worker/checkouts/gecko/toolkit/crashreporter/google-breakpad/src/common/linux/elfutils.cc:158:8 (libxul.so+0x5f99fe7)
[task 2020-04-25T00:00:04.303Z] 00:00:04     INFO - GECKO(3387) |     #3 FindElfBuildIDNote /builds/worker/checkouts/gecko/toolkit/crashreporter/google-breakpad/src/common/linux/file_id.cc:101:7 (libxul.so+0x5f9aadb)
[task 2020-04-25T00:00:04.304Z] 00:00:04     INFO - GECKO(3387) |     #4 google_breakpad::FileID::ElfFileIdentifierFromMappedFile(void const*, google_breakpad::wasteful_vector<unsigned char>&) /builds/worker/checkouts/gecko/toolkit/crashreporter/google-breakpad/src/common/linux/file_id.cc:150:7 (libxul.so+0x5f9aadb)
[task 2020-04-25T00:00:04.304Z] 00:00:04     INFO - GECKO(3387) |     #5 google_breakpad::FileID::ElfFileIdentifier(google_breakpad::wasteful_vector<unsigned char>&) /builds/worker/checkouts/gecko/toolkit/crashreporter/google-breakpad/src/common/linux/file_id.cc:162:10 (libxul.so+0x5f9b15c)
[task 2020-04-25T00:00:04.306Z] 00:00:04     INFO - GECKO(3387) |     #6 getId /builds/worker/checkouts/gecko/tools/profiler/core/shared-libraries-linux.cc:98:15 (libxul.so+0x5f9df83)
[task 2020-04-25T00:00:04.307Z] 00:00:04     INFO - GECKO(3387) |     #7 SharedLibraryAtPath(char const*, unsigned long, unsigned long, unsigned long) /builds/worker/checkouts/gecko/tools/profiler/core/shared-libraries-linux.cc:119:50 (libxul.so+0x5f9df83)
[task 2020-04-25T00:00:04.307Z] 00:00:04     INFO - GECKO(3387) |     #8 SharedLibraryInfo::GetInfoForSelf() /builds/worker/checkouts/gecko/tools/profiler/core/shared-libraries-linux.cc:241:9 (libxul.so+0x5f9d3ce)
[task 2020-04-25T00:00:04.308Z] 00:00:04     INFO - GECKO(3387) |     #9 BatchProcessedStackGenerator /builds/worker/checkouts/gecko/toolkit/components/telemetry/other/ProcessedStack.cpp:79:25 (libxul.so+0x62af4b1)
[task 2020-04-25T00:00:04.308Z] 00:00:04     INFO - GECKO(3387) |     #10 mozilla::Telemetry::GetStackAndModules(std::vector<unsigned long, std::allocator<unsigned long> > const&) /builds/worker/checkouts/gecko/toolkit/components/telemetry/other/ProcessedStack.cpp:74:10 (libxul.so+0x62af4b1)
[task 2020-04-25T00:00:04.309Z] 00:00:04     INFO - GECKO(3387) |     #11 LateWriteObserver::Observe(mozilla::IOInterposeObserver::Observation&) /builds/worker/checkouts/gecko/xpcom/build/LateWriteChecks.cpp:139:7 (libxul.so+0xb0b8da)
[task 2020-04-25T00:00:04.310Z] 00:00:04     INFO - GECKO(3387) |     #12 CallObservers /builds/worker/checkouts/gecko/xpcom/build/IOInterposer.cpp:128:13 (libxul.so+0xb0788e)
[task 2020-04-25T00:00:04.311Z] 00:00:04     INFO - GECKO(3387) |     #13 mozilla::IOInterposer::Report(mozilla::IOInterposeObserver::Observation&) /builds/worker/checkouts/gecko/xpcom/build/IOInterposer.cpp:477:8 (libxul.so+0xb0788e)
[task 2020-04-25T00:00:04.312Z] 00:00:04     INFO - GECKO(3387) |     #14 mozilla::IOInterposeObserver::Observation::Report() /builds/worker/checkouts/gecko/xpcom/build/IOInterposer.cpp:384:5 (libxul.so+0xb075b1)
[task 2020-04-25T00:00:04.313Z] 00:00:04     INFO - GECKO(3387) |     #15 ~NSPRIOAutoObservation /builds/worker/checkouts/gecko/xpcom/build/NSPRInterposer.cpp:76:39 (libxul.so+0xb0440d)
[task 2020-04-25T00:00:04.314Z] 00:00:04     INFO - GECKO(3387) |     #16 (anonymous namespace)::interposedWrite(PRFileDesc*, void const*, int) /builds/worker/checkouts/gecko/xpcom/build/NSPRInterposer.cpp:105:1 (libxul.so+0xb0440d)
[task 2020-04-25T00:00:04.315Z] 00:00:04     INFO - GECKO(3387) |     #17 PR_Write /builds/worker/checkouts/gecko/nsprpub/pr/src/io/priometh.c:114:12 (libnspr4.so+0xdd1a)
[task 2020-04-25T00:00:04.315Z] 00:00:04     INFO - GECKO(3387) |     #18 Write /builds/worker/checkouts/gecko/startupcache/StartupCache.cpp:91:7 (libxul.so+0x63ba1e2)
[task 2020-04-25T00:00:04.316Z] 00:00:04     INFO - GECKO(3387) |     #19 mozilla::scache::StartupCache::WriteToDisk() /builds/worker/checkouts/gecko/startupcache/StartupCache.cpp:571:7 (libxul.so+0x63ba1e2)
[task 2020-04-25T00:00:04.316Z] 00:00:04     INFO - GECKO(3387) |     #20 operator() /builds/worker/checkouts/gecko/startupcache/StartupCache.cpp:751:29 (libxul.so+0x63bcd9e)
[task 2020-04-25T00:00:04.316Z] 00:00:04     INFO - GECKO(3387) |     #21 mozilla::detail::RunnableFunction<mozilla::scache::StartupCache::MaybeWriteOffMainThread()::$_3>::Run() /builds/worker/workspace/obj-build/dist/include/nsThreadUtils.h:557:5 (libxul.so+0x63bcd9e)
[task 2020-04-25T00:00:04.317Z] 00:00:04     INFO - GECKO(3387) |     #22 nsThreadPool::Run() /builds/worker/checkouts/gecko/xpcom/threads/nsThreadPool.cpp:300:14 (libxul.so+0xae4386)
[task 2020-04-25T00:00:04.317Z] 00:00:04     INFO - GECKO(3387) |     #23 non-virtual thunk to nsThreadPool::Run() /builds/worker/checkouts/gecko/xpcom/threads/nsThreadPool.cpp (libxul.so+0xae4ce9)
[task 2020-04-25T00:00:04.318Z] 00:00:04     INFO - GECKO(3387) |     #24 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1200:14 (libxul.so+0xadd97f)
[task 2020-04-25T00:00:04.319Z] 00:00:04     INFO - GECKO(3387) |     #25 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:481:10 (libxul.so+0xae22d2)
[task 2020-04-25T00:00:04.319Z] 00:00:04     INFO - GECKO(3387) |     #26 mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:302:20 (libxul.so+0x13719ae)
[task 2020-04-25T00:00:04.320Z] 00:00:04     INFO - GECKO(3387) |     #27 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:315:10 (libxul.so+0x13018ac)
[task 2020-04-25T00:00:04.320Z] 00:00:04     INFO - GECKO(3387) |     #28 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:308:3 (libxul.so+0x13018ac)
[task 2020-04-25T00:00:04.321Z] 00:00:04     INFO - GECKO(3387) |     #29 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:290:3 (libxul.so+0x13018ac)
[task 2020-04-25T00:00:04.321Z] 00:00:04     INFO - GECKO(3387) |     #30 nsThread::ThreadFunc(void*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:444:10 (libxul.so+0xada035)
[task 2020-04-25T00:00:04.322Z] 00:00:04     INFO - GECKO(3387) |     #31 _pt_root /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:201:5 (libnspr4.so+0x4517f)
[task 2020-04-25T00:00:04.323Z] 00:00:04     INFO - GECKO(3387) |   Previous write of size 8 at 0x7f4ca2415000 by thread T18:
[task 2020-04-25T00:00:04.323Z] 00:00:04     INFO - GECKO(3387) |     #0 NS_TableDrivenQI(void*, nsID const&, void**, QITableEntry const*) /builds/worker/checkouts/gecko/xpcom/base/nsISupportsImpl.cpp (libxul.so+0x9ff4f3)
[task 2020-04-25T00:00:04.323Z] 00:00:04     INFO - GECKO(3387) |     #1 mozilla::CancelableRunnable::QueryInterface(nsID const&, void**) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:76:1 (libxul.so+0xae660e)
[task 2020-04-25T00:00:04.324Z] 00:00:04     INFO - GECKO(3387) |     #2 nsQueryObject<nsThreadShutdownAckEvent>::operator()(nsID const&, void**) const /builds/worker/workspace/obj-build/dist/include/nsQueryObject.h:24:42 (libxul.so+0xaf055f)
[task 2020-04-25T00:00:04.325Z] 00:00:04     INFO - GECKO(3387) |     #3 nsCOMPtr_base::assign_from_helper(nsCOMPtr_helper const&, nsID const&) /builds/worker/checkouts/gecko/xpcom/base/nsCOMPtr.cpp:109:7 (libxul.so+0xa02abf)
[task 2020-04-25T00:00:04.325Z] 00:00:04     INFO - GECKO(3387) |     #4 operator= /builds/worker/workspace/obj-build/dist/include/nsCOMPtr.h:775:5 (libxul.so+0xada289)
[task 2020-04-25T00:00:04.326Z] 00:00:04     INFO - GECKO(3387) |     #5 nsThread::ThreadFunc(void*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:479:9 (libxul.so+0xada289)
[task 2020-04-25T00:00:04.327Z] 00:00:04     INFO - GECKO(3387) |     #6 _pt_root /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:201:5 (libnspr4.so+0x4517f)
[task 2020-04-25T00:00:04.327Z] 00:00:04     INFO - GECKO(3387) |   Location is global '??' at 0x7f4ca2415000 (libva.so.2.100.0+0x000000000000)
[task 2020-04-25T00:00:04.327Z] 00:00:04     INFO - GECKO(3387) |   Mutex M2333 (0x7b3400007638) created at:
[task 2020-04-25T00:00:04.328Z] 00:00:04     INFO - GECKO(3387) |     #0 pthread_mutex_init /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors.cc:1225:3 (firefox+0x5897d)
[task 2020-04-25T00:00:04.329Z] 00:00:04     INFO - GECKO(3387) |     #1 mozilla::detail::MutexImpl::MutexImpl() /builds/worker/checkouts/gecko/mozglue/misc/Mutex_posix.cpp:96:3 (firefox+0x126b92)
[task 2020-04-25T00:00:04.329Z] 00:00:04     INFO - GECKO(3387) |     #2 OffTheBooksMutex /builds/worker/workspace/obj-build/dist/include/mozilla/Mutex.h:44:12 (libxul.so+0x63b6f02)
[task 2020-04-25T00:00:04.329Z] 00:00:04     INFO - GECKO(3387) |     #3 Mutex /builds/worker/workspace/obj-build/dist/include/mozilla/Mutex.h:124:39 (libxul.so+0x63b6f02)
[task 2020-04-25T00:00:04.330Z] 00:00:04     INFO - GECKO(3387) |     #4 StartupCache /builds/worker/checkouts/gecko/startupcache/StartupCache.cpp:148:7 (libxul.so+0x63b6f02)
[task 2020-04-25T00:00:04.331Z] 00:00:04     INFO - GECKO(3387) |     #5 mozilla::scache::StartupCache::InitSingleton() /builds/worker/checkouts/gecko/startupcache/StartupCache.cpp:131:37 (libxul.so+0x63b6f02)
[task 2020-04-25T00:00:04.331Z] 00:00:04     INFO - GECKO(3387) |     #6 mozilla::scache::StartupCache::GetSingleton() /builds/worker/checkouts/gecko/startupcache/StartupCache.cpp:120:5 (libxul.so+0x63b6e10)
[task 2020-04-25T00:00:04.333Z] 00:00:04     INFO - GECKO(3387) |     #7 NS_InitXPCOM /builds/worker/checkouts/gecko/xpcom/build/XPCOMInit.cpp:462:3 (libxul.so+0xb0dc6f)
[task 2020-04-25T00:00:04.337Z] 00:00:04     INFO - GECKO(3387) |     #8 ScopedXPCOMStartup::Initialize(bool) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:1311:8 (libxul.so+0x63686bd)
[task 2020-04-25T00:00:04.338Z] 00:00:04     INFO - GECKO(3387) |     #9 XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4739:22 (libxul.so+0x6371273)
[task 2020-04-25T00:00:04.338Z] 00:00:04     INFO - GECKO(3387) |     #10 XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4797:21 (libxul.so+0x63715e4)
[task 2020-04-25T00:00:04.339Z] 00:00:04     INFO - GECKO(3387) |     #11 mozilla::BootstrapImpl::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:45:12 (libxul.so+0x637c122)
[task 2020-04-25T00:00:04.339Z] 00:00:04     INFO - GECKO(3387) |     #12 do_main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:217:22 (firefox+0xc93e3)
[task 2020-04-25T00:00:04.341Z] 00:00:04     INFO - GECKO(3387) |     #13 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:331:16 (firefox+0xc93e3)
[task 2020-04-25T00:00:04.341Z] 00:00:04     INFO - GECKO(3387) |   Thread T75 'BgIOThr~Pool #1' (tid=3664, running) created by main thread at:
[task 2020-04-25T00:00:04.342Z] 00:00:04     INFO - GECKO(3387) |     #0 pthread_create /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors.cc:967:3 (firefox+0x5749b)
[task 2020-04-25T00:00:04.343Z] 00:00:04     INFO - GECKO(3387) |     #1 _PR_CreateThread /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:458:14 (libnspr4.so+0x3c383)
[task 2020-04-25T00:00:04.343Z] 00:00:04     INFO - GECKO(3387) |     #2 PR_CreateThread /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:533:12 (libnspr4.so+0x308c2)
[task 2020-04-25T00:00:04.344Z] 00:00:04     INFO - GECKO(3387) |     #3 nsThread::Init(nsTSubstring<char> const&) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:650:8 (libxul.so+0xadb4bb)
[task 2020-04-25T00:00:04.345Z] 00:00:04     INFO - GECKO(3387) |     #4 nsThreadManager::NewNamedThread(nsTSubstring<char> const&, unsigned int, nsIThread**) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadManager.cpp:620:12 (libxul.so+0xae1a1d)
[task 2020-04-25T00:00:04.346Z] 00:00:04     INFO - GECKO(3387) |     #5 NS_NewNamedThread(nsTSubstring<char> const&, nsIThread**, nsIRunnable*, unsigned int) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:139:57 (libxul.so+0xae3cf8)
[task 2020-04-25T00:00:04.347Z] 00:00:04     INFO - GECKO(3387) |     #6 nsThreadPool::PutEvent(already_AddRefed<nsIRunnable>, unsigned int) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadPool.cpp:114:17 (libxul.so+0xae3977)
[task 2020-04-25T00:00:04.348Z] 00:00:04     INFO - GECKO(3387) |     #7 nsThreadPool::Dispatch(already_AddRefed<nsIRunnable>, unsigned int) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadPool.cpp:349:5 (libxul.so+0xae4ded)
[task 2020-04-25T00:00:04.348Z] 00:00:04     INFO - GECKO(3387) |     #8 BackgroundEventTarget::Dispatch(already_AddRefed<nsIRunnable>, unsigned int) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadManager.cpp:153:16 (libxul.so+0xadf125)
[task 2020-04-25T00:00:04.349Z] 00:00:04     INFO - GECKO(3387) |     #9 Dispatch /builds/worker/workspace/obj-build/dist/include/nsIEventTarget.h:38:14 (libxul.so+0xae838c)
[task 2020-04-25T00:00:04.350Z] 00:00:04     INFO - GECKO(3387) |     #10 DispatchToBackgroundThread /builds/worker/checkouts/gecko/xpcom/threads/nsThreadManager.cpp:553:28 (libxul.so+0xae838c)
[task 2020-04-25T00:00:04.351Z] 00:00:04     INFO - GECKO(3387) |     #11 NS_DispatchBackgroundTask(already_AddRefed<nsIRunnable>, unsigned int) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:519:33 (libxul.so+0xae838c)
[task 2020-04-25T00:00:04.351Z] 00:00:04     INFO - GECKO(3387) |     #12 mozilla::scache::StartupCache::MaybeWriteOffMainThread() /builds/worker/checkouts/gecko/startupcache/StartupCache.cpp:754:3 (libxul.so+0x63ba832)
[task 2020-04-25T00:00:04.352Z] 00:00:04     INFO - GECKO(3387) |     #13 mozilla::scache::StartupCache::MaybeInitShutdownWrite() /builds/worker/checkouts/gecko/startupcache/StartupCache.cpp:645:3 (libxul.so+0x63ba624)
[task 2020-04-25T00:00:04.353Z] 00:00:04     INFO - GECKO(3387) |     #14 mozilla::AppShutdown::Init(mozilla::AppShutdownMode) /builds/worker/checkouts/gecko/xpcom/base/AppShutdown.cpp:140:12 (libxul.so+0x9dbb58)
[task 2020-04-25T00:00:04.354Z] 00:00:04     INFO - GECKO(3387) |     #15 nsAppStartup::Quit(unsigned int) /builds/worker/checkouts/gecko/toolkit/components/startup/nsAppStartup.cpp:366:5 (libxul.so+0x6264060)
[task 2020-04-25T00:00:04.354Z] 00:00:04     INFO - GECKO(3387) |     #16 NS_InvokeByIndex /builds/worker/checkouts/gecko/xpcom/reflect/xptcall/md/unix/xptcinvoke_asm_x86_64_unix.S:106 (libxul.so+0xafafa5)
[task 2020-04-25T00:00:04.355Z] 00:00:04     INFO - GECKO(3387) |     #17 XPC_WN_CallMethod(JSContext*, unsigned int, JS::Value*) /builds/worker/checkouts/gecko/js/xpconnect/src/XPCWrappedNativeJSOps.cpp:947:10 (libxul.so+0x192ace1)
[task 2020-04-25T00:00:04.356Z] 00:00:04     INFO - GECKO(3387) |     #18 CallJSNative /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:493:13 (libxul.so+0x649b539)
[task 2020-04-25T00:00:04.357Z] 00:00:04     INFO - GECKO(3387) |     #19 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:585:12 (libxul.so+0x649b539)
[task 2020-04-25T00:00:04.358Z] 00:00:04     INFO - GECKO(3387) |     #20 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:648:10 (libxul.so+0x649c7fa)
[task 2020-04-25T00:00:04.358Z] 00:00:04     INFO - GECKO(3387) |     #21 js::CallFromStack(JSContext*, JS::CallArgs const&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:652:10 (libxul.so+0x649c7fa)
[task 2020-04-25T00:00:04.360Z] 00:00:04     INFO - GECKO(3387) |     #22 js::jit::DoCallFallback(JSContext*, js::jit::BaselineFrame*, js::jit::ICCall_Fallback*, unsigned int, JS::Value*, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/jit/BaselineIC.cpp:2927:10 (libxul.so+0x6cc985d)
[task 2020-04-25T00:00:04.360Z] 00:00:04     INFO - GECKO(3387) |     #23 <null> <null> (0x7f4ca2f10cc8)
[task 2020-04-25T00:00:04.361Z] 00:00:04     INFO - GECKO(3387) |     #24 js::RunScript(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:450:32 (libxul.so+0x6483153)
[task 2020-04-25T00:00:04.362Z] 00:00:04     INFO - GECKO(3387) |     #25 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:620:13 (libxul.so+0x649bee6)
[task 2020-04-25T00:00:04.362Z] 00:00:04     INFO - GECKO(3387) |     #26 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:648:10 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.366Z] 00:00:04     INFO - GECKO(3387) |     #27 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:665:8 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.366Z] 00:00:04     INFO - GECKO(3387) |     #28 js::ForwardingProxyHandler::call(JSContext*, JS::Handle<JSObject*>, JS::CallArgs const&) const /builds/worker/checkouts/gecko/js/src/proxy/Wrapper.cpp:162:10 (libxul.so+0x65b8b36)
[task 2020-04-25T00:00:04.367Z] 00:00:04     INFO - GECKO(3387) |     #29 js::CrossCompartmentWrapper::call(JSContext*, JS::Handle<JSObject*>, JS::CallArgs const&) const /builds/worker/checkouts/gecko/js/src/proxy/CrossCompartmentWrapper.cpp:238:19 (libxul.so+0x65a2851)
[task 2020-04-25T00:00:04.368Z] 00:00:04     INFO - GECKO(3387) |     #30 js::Proxy::call(JSContext*, JS::Handle<JSObject*>, JS::CallArgs const&) /builds/worker/checkouts/gecko/js/src/proxy/Proxy.cpp:491:19 (libxul.so+0x65ac04f)
[task 2020-04-25T00:00:04.369Z] 00:00:04     INFO - GECKO(3387) |     #31 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:559:14 (libxul.so+0x649b8c8)
[task 2020-04-25T00:00:04.370Z] 00:00:04     INFO - GECKO(3387) |     #32 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:648:10 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.371Z] 00:00:04     INFO - GECKO(3387) |     #33 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:665:8 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.372Z] 00:00:04     INFO - GECKO(3387) |     #34 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:2833:10 (libxul.so+0x6555dbe)
[task 2020-04-25T00:00:04.372Z] 00:00:04     INFO - GECKO(3387) |     #35 mozilla::dom::MessageListener::ReceiveMessage(mozilla::dom::BindingCallContext&, JS::Handle<JS::Value>, mozilla::dom::ReceiveMessageArgument const&, JS::MutableHandle<JS::Value>, mozilla::ErrorResult&) /builds/worker/workspace/obj-build/dom/bindings/MessageManagerBinding.cpp:6264:8 (libxul.so+0x295775e)
[task 2020-04-25T00:00:04.373Z] 00:00:04     INFO - GECKO(3387) |     #36 ReceiveMessage /builds/worker/workspace/obj-build/dist/include/mozilla/dom/MessageManagerBinding.h:784:12 (libxul.so+0x43784fc)
[task 2020-04-25T00:00:04.374Z] 00:00:04     INFO - GECKO(3387) |     #37 mozilla::dom::JSWindowActor::ReceiveMessageOrQuery(JSContext*, mozilla::dom::JSWindowActorMessageMeta const&, JS::Handle<JS::Value>, mozilla::ErrorResult&) /builds/worker/checkouts/gecko/dom/ipc/JSWindowActor.cpp:353:20 (libxul.so+0x43784fc)
[task 2020-04-25T00:00:04.374Z] 00:00:04     INFO - GECKO(3387) |     #38 mozilla::dom::JSWindowActor::ReceiveRawMessage(mozilla::dom::JSWindowActorMessageMeta const&, mozilla::dom::ipc::StructuredCloneData&&, mozilla::dom::ipc::StructuredCloneData&&) /builds/worker/checkouts/gecko/dom/ipc/JSWindowActor.cpp:311:7 (libxul.so+0x4377c22)
[task 2020-04-25T00:00:04.375Z] 00:00:04     INFO - GECKO(3387) |     #39 ReceiveRawMessage /builds/worker/checkouts/gecko/dom/ipc/WindowGlobalParent.cpp:346:12 (libxul.so+0x43a3b80)
[task 2020-04-25T00:00:04.376Z] 00:00:04     INFO - GECKO(3387) |     #40 mozilla::dom::WindowGlobalParent::RecvRawMessage(mozilla::dom::JSWindowActorMessageMeta const&, mozilla::dom::ClonedMessageData const&, mozilla::dom::ClonedMessageData const&) /builds/worker/checkouts/gecko/dom/ipc/WindowGlobalParent.cpp:336:3 (libxul.so+0x43a3b80)
[task 2020-04-25T00:00:04.377Z] 00:00:04     INFO - GECKO(3387) |     #41 mozilla::dom::PWindowGlobalParent::OnMessageReceived(IPC::Message const&) /builds/worker/workspace/obj-build/ipc/ipdl/PWindowGlobalParent.cpp:572:62 (libxul.so+0x17890cc)
[task 2020-04-25T00:00:04.378Z] 00:00:04     INFO - GECKO(3387) |     #42 mozilla::dom::PContentParent::OnMessageReceived(IPC::Message const&) /builds/worker/workspace/obj-build/ipc/ipdl/PContentParent.cpp:6364:32 (libxul.so+0x149949d)
[task 2020-04-25T00:00:04.378Z] 00:00:04     INFO - GECKO(3387) |     #43 mozilla::ipc::MessageChannel::DispatchAsyncMessage(mozilla::ipc::ActorLifecycleProxy*, IPC::Message const&) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:2186:25 (libxul.so+0x136d506)
[task 2020-04-25T00:00:04.379Z] 00:00:04     INFO - GECKO(3387) |     #44 mozilla::ipc::MessageChannel::DispatchMessage(IPC::Message&&) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:2110:9 (libxul.so+0x136b8ad)
[task 2020-04-25T00:00:04.379Z] 00:00:04     INFO - GECKO(3387) |     #45 mozilla::ipc::MessageChannel::RunMessage(mozilla::ipc::MessageChannel::MessageTask&) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1958:3 (libxul.so+0x136c421)
[task 2020-04-25T00:00:04.380Z] 00:00:04     INFO - GECKO(3387) |     #46 mozilla::ipc::MessageChannel::MessageTask::Run() /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1989:13 (libxul.so+0x136c959)
[task 2020-04-25T00:00:04.380Z] 00:00:04     INFO - GECKO(3387) |     #47 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1200:14 (libxul.so+0xadd97f)
[task 2020-04-25T00:00:04.381Z] 00:00:04     INFO - GECKO(3387) |     #48 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:481:10 (libxul.so+0xae22d2)
[task 2020-04-25T00:00:04.381Z] 00:00:04     INFO - GECKO(3387) |     #49 mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:87:21 (libxul.so+0x1370ea9)
[task 2020-04-25T00:00:04.382Z] 00:00:04     INFO - GECKO(3387) |     #50 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:315:10 (libxul.so+0x13018ac)
[task 2020-04-25T00:00:04.382Z] 00:00:04     INFO - GECKO(3387) |     #51 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:308:3 (libxul.so+0x13018ac)
[task 2020-04-25T00:00:04.383Z] 00:00:04     INFO - GECKO(3387) |     #52 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:290:3 (libxul.so+0x13018ac)
[task 2020-04-25T00:00:04.384Z] 00:00:04     INFO - GECKO(3387) |     #53 nsBaseAppShell::Run() /builds/worker/checkouts/gecko/widget/nsBaseAppShell.cpp:137:27 (libxul.so+0x478afa3)
[task 2020-04-25T00:00:04.386Z] 00:00:04     INFO - GECKO(3387) |     #54 nsAppStartup::Run() /builds/worker/checkouts/gecko/toolkit/components/startup/nsAppStartup.cpp:271:30 (libxul.so+0x6263da5)
[task 2020-04-25T00:00:04.387Z] 00:00:04     INFO - GECKO(3387) |     #55 XREMain::XRE_mainRun() /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4608:22 (libxul.so+0x637069a)
[task 2020-04-25T00:00:04.388Z] 00:00:04     INFO - GECKO(3387) |     #56 XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4743:8 (libxul.so+0x6371283)
[task 2020-04-25T00:00:04.390Z] 00:00:04     INFO - GECKO(3387) |     #57 XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4797:21 (libxul.so+0x63715e4)
[task 2020-04-25T00:00:04.391Z] 00:00:04     INFO - GECKO(3387) |     #58 mozilla::BootstrapImpl::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:45:12 (libxul.so+0x637c122)
[task 2020-04-25T00:00:04.391Z] 00:00:04     INFO - GECKO(3387) |     #59 do_main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:217:22 (firefox+0xc93e3)
[task 2020-04-25T00:00:04.392Z] 00:00:04     INFO - GECKO(3387) |     #60 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:331:16 (firefox+0xc93e3)
[task 2020-04-25T00:00:04.393Z] 00:00:04     INFO - GECKO(3387) |   Thread T18 'DOM Worker' (tid=3670, finished) created by main thread at:
[task 2020-04-25T00:00:04.393Z] 00:00:04     INFO - GECKO(3387) |     #0 pthread_create /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors.cc:967:3 (firefox+0x5749b)
[task 2020-04-25T00:00:04.394Z] 00:00:04     INFO - GECKO(3387) |     #1 _PR_CreateThread /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:458:14 (libnspr4.so+0x3c383)
[task 2020-04-25T00:00:04.394Z] 00:00:04     INFO - GECKO(3387) |     #2 PR_CreateThread /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:533:12 (libnspr4.so+0x308c2)
[task 2020-04-25T00:00:04.395Z] 00:00:04     INFO - GECKO(3387) |     #3 nsThread::Init(nsTSubstring<char> const&) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:650:8 (libxul.so+0xadb4bb)
[task 2020-04-25T00:00:04.396Z] 00:00:04     INFO - GECKO(3387) |     #4 mozilla::dom::WorkerThread::Create(mozilla::dom::WorkerThreadFriendKey const&) /builds/worker/checkouts/gecko/dom/workers/WorkerThread.cpp:92:7 (libxul.so+0x43f3fa1)
[task 2020-04-25T00:00:04.396Z] 00:00:04     INFO - GECKO(3387) |     #5 mozilla::dom::workerinternals::RuntimeService::ScheduleWorker(mozilla::dom::WorkerPrivate*) /builds/worker/checkouts/gecko/dom/workers/RuntimeService.cpp:1410:14 (libxul.so+0x43b0a25)
[task 2020-04-25T00:00:04.398Z] 00:00:04     INFO - GECKO(3387) |     #6 mozilla::dom::workerinternals::RuntimeService::RegisterWorker(mozilla::dom::WorkerPrivate*) /builds/worker/checkouts/gecko/dom/workers/RuntimeService.cpp:1275:19 (libxul.so+0x43aff8e)
[task 2020-04-25T00:00:04.398Z] 00:00:04     INFO - GECKO(3387) |     #7 mozilla::dom::WorkerPrivate::Constructor(JSContext*, nsTSubstring<char16_t> const&, bool, mozilla::dom::WorkerType, nsTSubstring<char16_t> const&, nsTSubstring<char> const&, mozilla::dom::WorkerLoadInfo*, mozilla::ErrorResult&, nsTString<char16_t>) /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:2421:24 (libxul.so+0x43db155)
[task 2020-04-25T00:00:04.399Z] 00:00:04     INFO - GECKO(3387) |     #8 mozilla::dom::ChromeWorker::Constructor(mozilla::dom::GlobalObject const&, nsTSubstring<char16_t> const&, mozilla::ErrorResult&) /builds/worker/checkouts/gecko/dom/workers/ChromeWorker.cpp:22:41 (libxul.so+0x43aba27)
[task 2020-04-25T00:00:04.399Z] 00:00:04     INFO - GECKO(3387) |     #9 mozilla::dom::ChromeWorker_Binding::_constructor(JSContext*, unsigned int, JS::Value*) /builds/worker/workspace/obj-build/dom/bindings/WorkerBinding.cpp:230:58 (libxul.so+0x302972c)
[task 2020-04-25T00:00:04.401Z] 00:00:04     INFO - GECKO(3387) |     #10 CallJSNative /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:493:13 (libxul.so+0x649d0b5)
[task 2020-04-25T00:00:04.401Z] 00:00:04     INFO - GECKO(3387) |     #11 CallJSNativeConstructor /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:509:8 (libxul.so+0x649d0b5)
[task 2020-04-25T00:00:04.402Z] 00:00:04     INFO - GECKO(3387) |     #12 InternalConstruct(JSContext*, js::AnyConstructArgs const&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:711:10 (libxul.so+0x649d0b5)
[task 2020-04-25T00:00:04.402Z] 00:00:04     INFO - GECKO(3387) |     #13 ConstructFromStack /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:738:10 (libxul.so+0x6490969)
[task 2020-04-25T00:00:04.403Z] 00:00:04     INFO - GECKO(3387) |     #14 Interpret(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:3313:16 (libxul.so+0x6490969)
[task 2020-04-25T00:00:04.403Z] 00:00:04     INFO - GECKO(3387) |     #15 js::RunScript(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:465:10 (libxul.so+0x64831d9)
[task 2020-04-25T00:00:04.405Z] 00:00:04     INFO - GECKO(3387) |     #16 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:620:13 (libxul.so+0x649bee6)
[task 2020-04-25T00:00:04.405Z] 00:00:04     INFO - GECKO(3387) |     #17 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:648:10 (libxul.so+0x649db23)
[task 2020-04-25T00:00:04.405Z] 00:00:04     INFO - GECKO(3387) |     #18 Call /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:665:8 (libxul.so+0x649db23)
[task 2020-04-25T00:00:04.406Z] 00:00:04     INFO - GECKO(3387) |     #19 js::CallGetter(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:789:10 (libxul.so+0x649db23)
[task 2020-04-25T00:00:04.406Z] 00:00:04     INFO - GECKO(3387) |     #20 CallGetter /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2253:12 (libxul.so+0x6787c0c)
[task 2020-04-25T00:00:04.406Z] 00:00:04     INFO - GECKO(3387) |     #21 GetExistingProperty<js::CanGC> /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2304:12 (libxul.so+0x6787c0c)
[task 2020-04-25T00:00:04.408Z] 00:00:04     INFO - GECKO(3387) |     #22 NativeGetPropertyInline<js::CanGC> /builds/worker/checkouts/gecko/js/src/vm/NativeObject.cpp:2444:14 (libxul.so+0x6787c0c)
[task 2020-04-25T00:00:04.408Z] 00:00:04     INFO - GECKO(3387) |     #23 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:2481:10 (libxul.so+0x6787c0c)
[task 2020-04-25T00:00:04.409Z] 00:00:04     INFO - GECKO(3387) |     #24 GetProperty /builds/worker/checkouts/gecko/js/src/vm/ObjectOperations-inl.h:117:10 (libxul.so+0x64a1101)
[task 2020-04-25T00:00:04.409Z] 00:00:04     INFO - GECKO(3387) |     #25 GetProperty /builds/worker/checkouts/gecko/js/src/vm/ObjectOperations-inl.h:124:10 (libxul.so+0x64a1101)
[task 2020-04-25T00:00:04.410Z] 00:00:04     INFO - GECKO(3387) |     #26 js::GetProperty(JSContext*, JS::Handle<JS::Value>, JS::Handle<js::PropertyName*>, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:4712:10 (libxul.so+0x64a1101)
[task 2020-04-25T00:00:04.411Z] 00:00:04     INFO - GECKO(3387) |     #27 GetPropertyOperation /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:224:10 (libxul.so+0x648c701)
[task 2020-04-25T00:00:04.412Z] 00:00:04     INFO - GECKO(3387) |     #28 Interpret(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:3003:12 (libxul.so+0x648c701)
[task 2020-04-25T00:00:04.413Z] 00:00:04     INFO - GECKO(3387) |     #29 js::RunScript(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:465:10 (libxul.so+0x64831d9)
[task 2020-04-25T00:00:04.413Z] 00:00:04     INFO - GECKO(3387) |     #30 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:620:13 (libxul.so+0x649bee6)
[task 2020-04-25T00:00:04.414Z] 00:00:04     INFO - GECKO(3387) |     #31 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:648:10 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.414Z] 00:00:04     INFO - GECKO(3387) |     #32 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:665:8 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.415Z] 00:00:04     INFO - GECKO(3387) |     #33 js::CallSelfHostedFunction(JSContext*, JS::Handle<js::PropertyName*>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/SelfHosting.cpp:1673:10 (libxul.so+0x67e89b5)
[task 2020-04-25T00:00:04.415Z] 00:00:04     INFO - GECKO(3387) |     #34 js::jit::InterpretResume(JSContext*, JS::Handle<JSObject*>, JS::Value*, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/jit/VMFunctions.cpp:995:10 (libxul.so+0x6d041df)
[task 2020-04-25T00:00:04.416Z] 00:00:04     INFO - GECKO(3387) |     #35 <null> <null> (0x7f4ca2f11c20)
[task 2020-04-25T00:00:04.417Z] 00:00:04     INFO - GECKO(3387) |     #36 js::RunScript(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:450:32 (libxul.so+0x6483153)
[task 2020-04-25T00:00:04.417Z] 00:00:04     INFO - GECKO(3387) |     #37 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:620:13 (libxul.so+0x649bee6)
[task 2020-04-25T00:00:04.418Z] 00:00:04     INFO - GECKO(3387) |     #38 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:648:10 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.418Z] 00:00:04     INFO - GECKO(3387) |     #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:665:8 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.419Z] 00:00:04     INFO - GECKO(3387) |     #40 js::CallSelfHostedFunction(JSContext*, JS::Handle<js::PropertyName*>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/SelfHosting.cpp:1673:10 (libxul.so+0x67e89b5)
[task 2020-04-25T00:00:04.421Z] 00:00:04     INFO - GECKO(3387) |     #41 AsyncFunctionResume(JSContext*, JS::Handle<js::AsyncFunctionGeneratorObject*>, ResumeKind, JS::Handle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/AsyncFunction.cpp:128:8 (libxul.so+0x65da030)
[task 2020-04-25T00:00:04.421Z] 00:00:04     INFO - GECKO(3387) |     #42 js::AsyncFunctionAwaitedFulfilled(JSContext*, JS::Handle<js::AsyncFunctionGeneratorObject*>, JS::Handle<JS::Value>) /builds/worker/checkouts/gecko/js/src/vm/AsyncFunction.cpp:159:10 (libxul.so+0x65d9d97)
[task 2020-04-25T00:00:04.422Z] 00:00:04     INFO - GECKO(3387) |     #43 AsyncFunctionPromiseReactionJob /builds/worker/checkouts/gecko/js/src/builtin/Promise.cpp:1667:12 (libxul.so+0x6676f7b)
[task 2020-04-25T00:00:04.422Z] 00:00:04     INFO - GECKO(3387) |     #44 PromiseReactionJob(JSContext*, unsigned int, JS::Value*) /builds/worker/checkouts/gecko/js/src/builtin/Promise.cpp:1823:12 (libxul.so+0x6676f7b)
[task 2020-04-25T00:00:04.423Z] 00:00:04     INFO - GECKO(3387) |     #45 CallJSNative /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:493:13 (libxul.so+0x649b539)
[task 2020-04-25T00:00:04.426Z] 00:00:04     INFO - GECKO(3387) |     #46 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:585:12 (libxul.so+0x649b539)
[task 2020-04-25T00:00:04.426Z] 00:00:04     INFO - GECKO(3387) |     #47 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:648:10 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.426Z] 00:00:04     INFO - GECKO(3387) |     #48 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:665:8 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.427Z] 00:00:04     INFO - GECKO(3387) |     #49 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:2833:10 (libxul.so+0x6555dbe)
[task 2020-04-25T00:00:04.427Z] 00:00:04     INFO - GECKO(3387) |     #50 mozilla::dom::PromiseJobCallback::Call(mozilla::dom::BindingCallContext&, JS::Handle<JS::Value>, mozilla::ErrorResult&) /builds/worker/workspace/obj-build/dom/bindings/PromiseBinding.cpp:28:8 (libxul.so+0x2aa204b)
[task 2020-04-25T00:00:04.427Z] 00:00:04     INFO - GECKO(3387) |     #51 Call /builds/worker/workspace/obj-build/dist/include/mozilla/dom/PromiseBinding.h:91:12 (libxul.so+0x9f7f6e)
[task 2020-04-25T00:00:04.429Z] 00:00:04     INFO - GECKO(3387) |     #52 Call /builds/worker/workspace/obj-build/dist/include/mozilla/dom/PromiseBinding.h:104:12 (libxul.so+0x9f7f6e)
[task 2020-04-25T00:00:04.429Z] 00:00:04     INFO - GECKO(3387) |     #53 mozilla::PromiseJobRunnable::Run(mozilla::AutoSlowOperation&) /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSContext.cpp:213:18 (libxul.so+0x9f7f6e)
[task 2020-04-25T00:00:04.430Z] 00:00:04     INFO - GECKO(3387) |     #54 mozilla::CycleCollectedJSContext::PerformMicroTaskCheckPoint(bool) /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSContext.cpp:644:17 (libxul.so+0x9e63a7)
[task 2020-04-25T00:00:04.431Z] 00:00:04     INFO - GECKO(3387) |     #55 mozilla::CycleCollectedJSContext::AfterProcessTask(unsigned int) /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSContext.cpp:463:3 (libxul.so+0x9e6cd7)
[task 2020-04-25T00:00:04.431Z] 00:00:04     INFO - GECKO(3387) |     #56 XPCJSContext::AfterProcessTask(unsigned int) /builds/worker/checkouts/gecko/js/xpconnect/src/XPCJSContext.cpp:1331:28 (libxul.so+0x18f91ea)
[task 2020-04-25T00:00:04.432Z] 00:00:04     INFO - GECKO(3387) |     #57 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1225:24 (libxul.so+0xaddc62)
[task 2020-04-25T00:00:04.432Z] 00:00:04     INFO - GECKO(3387) |     #58 NS_InvokeByIndex /builds/worker/checkouts/gecko/xpcom/reflect/xptcall/md/unix/xptcinvoke_asm_x86_64_unix.S:106 (libxul.so+0xafafa5)
[task 2020-04-25T00:00:04.433Z] 00:00:04     INFO - GECKO(3387) |     #59 XPC_WN_CallMethod(JSContext*, unsigned int, JS::Value*) /builds/worker/checkouts/gecko/js/xpconnect/src/XPCWrappedNativeJSOps.cpp:947:10 (libxul.so+0x192ace1)
[task 2020-04-25T00:00:04.433Z] 00:00:04     INFO - GECKO(3387) |     #60 <null> <null> (0x7f4ca2f404d0)
[task 2020-04-25T00:00:04.434Z] 00:00:04     INFO - GECKO(3387) |     #61 js::RunScript(JSContext*, js::RunState&) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:450:32 (libxul.so+0x6483153)
[task 2020-04-25T00:00:04.434Z] 00:00:04     INFO - GECKO(3387) |     #62 js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:620:13 (libxul.so+0x649bee6)
[task 2020-04-25T00:00:04.434Z] 00:00:04     INFO - GECKO(3387) |     #63 InternalCall /builds/worker/checkouts/gecko/js/src/vm/Interpreter.cpp:648:10 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.435Z] 00:00:04     INFO - GECKO(3387) |     #64 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:665:8 (libxul.so+0x649c97e)
[task 2020-04-25T00:00:04.436Z] 00:00:04     INFO - GECKO(3387) |     #65 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:2770:10 (libxul.so+0x655519d)
[task 2020-04-25T00:00:04.437Z] 00:00:04     INFO - GECKO(3387) |     #66 nsXPCWrappedJS::CallMethod(unsigned short, nsXPTMethodInfo const*, nsXPTCMiniVariant*) /builds/worker/checkouts/gecko/js/xpconnect/src/XPCWrappedJSClass.cpp:964:17 (libxul.so+0x1921faa)
[task 2020-04-25T00:00:04.437Z] 00:00:04     INFO - GECKO(3387) |     #67 PrepareAndDispatch /builds/worker/checkouts/gecko/xpcom/reflect/xptcall/md/unix/xptcstubs_x86_64_linux.cpp:125:37 (libxul.so+0xafbff4)
[task 2020-04-25T00:00:04.438Z] 00:00:04     INFO - GECKO(3387) |     #68 SharedStub <null> (libxul.so+0xafb2a2)
[task 2020-04-25T00:00:04.438Z] 00:00:04     INFO - GECKO(3387) |     #69 nsObserverService::NotifyObservers(nsISupports*, char const*, char16_t const*) /builds/worker/checkouts/gecko/xpcom/ds/nsObserverService.cpp:292:19 (libxul.so+0xa4b76c)
[task 2020-04-25T00:00:04.438Z] 00:00:04     INFO - GECKO(3387) |     #70 nsXREDirProvider::DoShutdown() /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:1043:15 (libxul.so+0x637faed)
[task 2020-04-25T00:00:04.440Z] 00:00:04     INFO - GECKO(3387) |     #71 ScopedXPCOMStartup::~ScopedXPCOMStartup() /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:1272:26 (libxul.so+0x63685de)
[task 2020-04-25T00:00:04.440Z] 00:00:04     INFO - GECKO(3387) |     #72 operator() /builds/worker/workspace/obj-build/dist/include/mozilla/UniquePtr.h:460:5 (libxul.so+0x63737ef)
[task 2020-04-25T00:00:04.440Z] 00:00:04     INFO - GECKO(3387) |     #73 mozilla::UniquePtr<ScopedXPCOMStartup, mozilla::DefaultDelete<ScopedXPCOMStartup> >::reset(ScopedXPCOMStartup*) /builds/worker/workspace/obj-build/dist/include/mozilla/UniquePtr.h:302:7 (libxul.so+0x63737ef)
[task 2020-04-25T00:00:04.441Z] 00:00:04     INFO - GECKO(3387) |     #74 operator= /builds/worker/workspace/obj-build/dist/include/mozilla/UniquePtr.h:275:5 (libxul.so+0x63712d1)
[task 2020-04-25T00:00:04.441Z] 00:00:04     INFO - GECKO(3387) |     #75 XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4760:16 (libxul.so+0x63712d1)
[task 2020-04-25T00:00:04.443Z] 00:00:04     INFO - GECKO(3387) |     #76 XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4797:21 (libxul.so+0x63715e4)
[task 2020-04-25T00:00:04.444Z] 00:00:04     INFO - GECKO(3387) |     #77 mozilla::BootstrapImpl::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:45:12 (libxul.so+0x637c122)
[task 2020-04-25T00:00:04.444Z] 00:00:04     INFO - GECKO(3387) |     #78 do_main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:217:22 (firefox+0xc93e3)
[task 2020-04-25T00:00:04.444Z] 00:00:04     INFO - GECKO(3387) |     #79 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:331:16 (firefox+0xc93e3)
[task 2020-04-25T00:00:04.445Z] 00:00:04     INFO - GECKO(3387) | SUMMARY: ThreadSanitizer: data race /builds/worker/checkouts/gecko/toolkit/crashreporter/google-breakpad/src/common/linux/linux_libc_support.cc:61:9 in my_strncmp
[task 2020-04-25T00:00:04.445Z] 00:00:04     INFO - GECKO(3387) | ==================
[task 2020-04-25T00:00:04.589Z] 00:00:04     INFO - TEST-INFO | Main app process: killed by SIGIOT
[task 2020-04-25T00:00:04.589Z] 00:00:04     INFO - Buffered messages finished
[task 2020-04-25T00:00:04.591Z] 00:00:04    ERROR - TEST-UNEXPECTED-FAIL | Last test finished | application terminated with exit code -6
[task 2020-04-25T00:00:04.591Z] 00:00:04     INFO - runtests.py | Application ran for: 0:03:36.081642
[task 2020-04-25T00:00:04.591Z] 00:00:04     INFO - zombiecheck | Reading PID log: /tmp/tmpUGxRtapidlog
[task 2020-04-25T00:00:04.592Z] 00:00:04     INFO - ==> process 3387 launched child process 3402
[task 2020-04-25T00:00:04.592Z] 00:00:04     INFO - ==> process 3387 launched child process 3474
[task 2020-04-25T00:00:04.593Z] 00:00:04     INFO - ==> process 3387 launched child process 3490
[task 2020-04-25T00:00:04.593Z] 00:00:04     INFO - ==> process 3387 launched child process 3559
[task 2020-04-25T00:00:04.594Z] 00:00:04     INFO - ==> process 3387 launched child process 3584
[task 2020-04-25T00:00:04.595Z] 00:00:04     INFO - ==> process 3387 launched child process 3641
[task 2020-04-25T00:00:04.596Z] 00:00:04     INFO - ==> process 3387 launched child process 3654
[task 2020-04-25T00:00:04.596Z] 00:00:04     INFO - zombiecheck | Checking for orphan process with PID: 3584
[task 2020-04-25T00:00:04.597Z] 00:00:04     INFO - zombiecheck | Checking for orphan process with PID: 3490
[task 2020-04-25T00:00:04.597Z] 00:00:04     INFO - zombiecheck | Checking for orphan process with PID: 3654
[task 2020-04-25T00:00:04.598Z] 00:00:04     INFO - zombiecheck | Checking for orphan process with PID: 3559
[task 2020-04-25T00:00:04.598Z] 00:00:04     INFO - zombiecheck | Checking for orphan process with PID: 3402
[task 2020-04-25T00:00:04.599Z] 00:00:04     INFO - zombiecheck | Checking for orphan process with PID: 3474
[task 2020-04-25T00:00:04.599Z] 00:00:04     INFO - zombiecheck | Checking for orphan process with PID: 3641
[task 2020-04-25T00:00:04.600Z] 00:00:04     INFO - Stopping web server
[task 2020-04-25T00:00:04.620Z] 00:00:04     INFO - Stopping web socket server
[task 2020-04-25T00:00:04.641Z] 00:00:04     INFO - Stopping ssltunnel
[task 2020-04-25T00:00:04.662Z] 00:00:04  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2020-04-25T00:00:04.663Z] 00:00:04     INFO - runtests.py | Running tests: end.
[task 2020-04-25T00:00:04.686Z] 00:00:04     INFO - Buffered messages finished
[task 2020-04-25T00:00:04.688Z] 00:00:04     INFO - Running manifest: layout/mathml/tests/mochitest.ini
[task 2020-04-25T00:00:04.724Z] 00:00:04     INFO -  Setting pipeline to PAUSED ...
[task 2020-04-25T00:00:04.724Z] 00:00:04     INFO -  Pipeline is PREROLLING ...
[task 2020-04-25T00:00:04.724Z] 00:00:04     INFO -  Pipeline is PREROLLED ...
[task 2020-04-25T00:00:04.725Z] 00:00:04     INFO -  Setting pipeline to PLAYING ...
[task 2020-04-25T00:00:04.725Z] 00:00:04     INFO -  New clock: GstSystemClock
[task 2020-04-25T00:00:04.761Z] 00:00:04     INFO -  Got EOS from element "pipeline0".
[task 2020-04-25T00:00:04.761Z] 00:00:04     INFO -  Execution ended after 0:00:00.033532219
[task 2020-04-25T00:00:04.762Z] 00:00:04     INFO -  Setting pipeline to PAUSED ...
[task 2020-04-25T00:00:04.763Z] 00:00:04     INFO -  Setting pipeline to READY ...
[task 2020-04-25T00:00:04.763Z] 00:00:04     INFO -  (gst-launch-1.0:3673): GStreamer-CRITICAL **: 00:00:04.754: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed
[task 2020-04-25T00:00:04.763Z] 00:00:04     INFO -  Setting pipeline to NULL ...
[task 2020-04-25T00:00:04.763Z] 00:00:04     INFO -  Freeing pipeline ...
[task 2020-04-25T00:00:04.792Z] 00:00:04     INFO - INFO | runtests.py | TSan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer

Oh boy, this is not a race in the crash reporting code and frankly it's hard to tell where the root cause is. We have a disk write during startup that's observed by the I/O interposer, which seems to have been set in place by telemetry which in turn uses the profiler to grab a stack trace which finally uses code from the crash reporter to get information about the currently loaded modules.

Summary: Intermittent GECKO(3387) | SUMMARY: ThreadSanitizer: data race /builds/worker/checkouts/gecko/toolkit/crashreporter/google-breakpad/src/common/linux/linux_libc_support.cc:61:9 in my_strncmp → Intermittent SUMMARY: ThreadSanitizer: data race /builds/worker/checkouts/gecko/toolkit/crashreporter/google-breakpad/src/common/linux/linux_libc_support.cc:61:9 in my_strncmp
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
Blocks: tsan
You need to log in before you can comment on or make changes to this bug.