1815999 - High frequency SUMMARY: AddressSanitizer: SEGV /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3361:5 in operator()

Status: RESOLVED FIXED

(Core :: DOM: File, defect, P2)

Description

[Treeherder Bug Filer]

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

---

[task 2023-02-09T22:02:09.415Z] 22:02:09     INFO -  TEST-START | TestFileSystemQuotaClient.CheckUsageBeforeAnyFilesOnDisk
[task 2023-02-09T22:02:54.430Z] 22:02:54     INFO -  AddressSanitizer:DEADLYSIGNAL
[task 2023-02-09T22:02:54.430Z] 22:02:54     INFO -  =================================================================
[task 2023-02-09T22:02:54.430Z] 22:02:54    ERROR -  ==1534==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000001 (pc 0x7f0d359f843a bp 0x7f0c9ab16490 sp 0x7f0c9ab162a0 T5)
[task 2023-02-09T22:02:54.431Z] 22:02:54     INFO -  ==1534==The signal is caused by a WRITE memory access.
[task 2023-02-09T22:02:54.431Z] 22:02:54     INFO -  ==1534==Hint: address points to the zero page.
[task 2023-02-09T22:02:55.203Z] 22:02:55     INFO -      #0 0x7f0d359f843a in operator() /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3361:5
[task 2023-02-09T22:02:55.204Z] 22:02:55     INFO -      #1 0x7f0d359f843a in mozilla::dom::quota::QuotaManager::Shutdown()::$_93::__invoke(nsITimer*, void*) /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3324:36
[task 2023-02-09T22:02:55.204Z] 22:02:55     INFO -      #2 0x7f0d2ec44350 in operator() /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:660:36
[task 2023-02-09T22:02:55.205Z] 22:02:55     INFO -      #3 0x7f0d2ec44350 in matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback> &, (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:660:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:661:7)> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:309:16
[task 2023-02-09T22:02:55.206Z] 22:02:55     INFO -      #4 0x7f0d2ec44350 in matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback> &, (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:657:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:660:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:661:7)> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:318:14
[task 2023-02-09T22:02:55.207Z] 22:02:55     INFO -      #5 0x7f0d2ec44350 in matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback> &, (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:656:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:657:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:660:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:661:7)> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:318:14
[task 2023-02-09T22:02:55.207Z] 22:02:55     INFO -      #6 0x7f0d2ec44350 in matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback> &, (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:655:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:656:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:657:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:660:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:661:7)> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:318:14
[task 2023-02-09T22:02:55.208Z] 22:02:55     INFO -      #7 0x7f0d2ec44350 in matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback> &, (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:655:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:656:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:657:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:660:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:661:7)> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:902:12
[task 2023-02-09T22:02:55.209Z] 22:02:55     INFO -      #8 0x7f0d2ec44350 in match<(lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:655:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:656:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:657:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:660:7), (lambda at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:661:7)> /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:857:12
[task 2023-02-09T22:02:55.210Z] 22:02:55     INFO -      #9 0x7f0d2ec44350 in nsTimerImpl::Fire(int) /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:654:22
[task 2023-02-09T22:02:55.210Z] 22:02:55     INFO -      #10 0x7f0d2ec439bc in nsTimerEvent::Run() /builds/worker/checkouts/gecko/xpcom/threads/TimerThread.cpp:365:11
[task 2023-02-09T22:02:55.211Z] 22:02:55     INFO -      #11 0x7f0d2ec59c34 in nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1219:16
[task 2023-02-09T22:02:55.212Z] 22:02:55     INFO -      #12 0x7f0d2ec638a4 in NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:477:10
[task 2023-02-09T22:02:55.212Z] 22:02:55     INFO -      #13 0x7f0d35991660 in SpinEventLoopUntil<(mozilla::ProcessFailureBehavior)1, (lambda at /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3497:5)> /builds/worker/workspace/obj-build/dist/include/mozilla/SpinEventLoopUntil.h:176:25
[task 2023-02-09T22:02:55.213Z] 22:02:55     INFO -      #14 0x7f0d35991660 in mozilla::dom::quota::QuotaManager::Shutdown() /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3497:5
[task 2023-02-09T22:02:55.214Z] 22:02:55     INFO -      #15 0x7f0d3598abee in mozilla::dom::quota::QuotaManager::ShutdownInstance() /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2859:16
[task 2023-02-09T22:02:55.215Z] 22:02:55     INFO -      #16 0x7f0d3598aa6d in mozilla::dom::quota::RecvShutdownQuotaManager() /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2546:3
[task 2023-02-09T22:02:55.215Z] 22:02:55     INFO -      #17 0x7f0d302129a6 in mozilla::ipc::BackgroundParentImpl::RecvShutdownQuotaManager() /builds/worker/checkouts/gecko/ipc/glue/BackgroundParentImpl.cpp:1072:8
[task 2023-02-09T22:02:55.215Z] 22:02:55     INFO -      #18 0x7f0d3033522d in mozilla::ipc::PBackgroundParent::OnMessageReceived(IPC::Message const&) /builds/worker/workspace/obj-build/ipc/ipdl/PBackgroundParent.cpp:4833:52
[task 2023-02-09T22:02:55.215Z] 22:02:55     INFO -      #19 0x7f0d3028c92f in mozilla::ipc::MessageChannel::DispatchAsyncMessage(mozilla::ipc::ActorLifecycleProxy*, IPC::Message const&) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1800:25
[task 2023-02-09T22:02:55.215Z] 22:02:55     INFO -      #20 0x7f0d3028a335 in mozilla::ipc::MessageChannel::DispatchMessage(mozilla::ipc::ActorLifecycleProxy*, mozilla::UniquePtr<IPC::Message, mozilla::DefaultDelete<IPC::Message>>) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1725:9
[task 2023-02-09T22:02:55.215Z] 22:02:55     INFO -      #21 0x7f0d3028ac91 in mozilla::ipc::MessageChannel::RunMessage(mozilla::ipc::ActorLifecycleProxy*, mozilla::ipc::MessageChannel::MessageTask&) /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1525:3
[task 2023-02-09T22:02:55.215Z] 22:02:55     INFO -      #22 0x7f0d3028b9fe in mozilla::ipc::MessageChannel::MessageTask::Run() /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1623:14
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -      #23 0x7f0d2ec59c34 in nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1219:16
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -      #24 0x7f0d2ec638a4 in NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:477:10
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -      #25 0x7f0d30293f69 in mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:330:5
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -      #26 0x7f0d30134fe7 in RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:381:10
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -      #27 0x7f0d30134fe7 in RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:374:3
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -      #28 0x7f0d30134fe7 in MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:356:3
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -      #29 0x7f0d2ec51583 in nsThread::ThreadFunc(void*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:384:10
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -      #30 0x7f0d5253c628 in _pt_root /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:201:5
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -      #31 0x7f0d522546da in start_thread /tmp/glibc/nptl/pthread_create.c:463
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -      #32 0x7f0d51017a3e in __clone /tmp/glibc/misc/../sysdeps/unix/sysv/linux/x86_64/clone.S:95
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -  AddressSanitizer can not provide additional info.
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -  SUMMARY: AddressSanitizer: SEGV /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3361:5 in operator()
[task 2023-02-09T22:02:55.216Z] 22:02:55     INFO -  Thread T5 (IPDL Background) created by T0 here:
[task 2023-02-09T22:02:55.259Z] 22:02:55     INFO -      #0 0x5589c6f9986c in pthread_create /builds/worker/fetches/llvm-project/compiler-rt/lib/asan/asan_interceptors.cpp:208:3
[task 2023-02-09T22:02:55.259Z] 22:02:55     INFO -      #1 0x7f0d5252c6f9 in _PR_CreateThread /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:458:14
[task 2023-02-09T22:02:55.259Z] 22:02:55     INFO -      #2 0x7f0d5251db6e in PR_CreateThread /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:533:12
[task 2023-02-09T22:02:55.260Z] 22:02:55     INFO -      #3 0x7f0d2ec54a3b in nsThread::Init(nsTSubstring<char> const&) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:619:18
[task 2023-02-09T22:02:55.260Z] 22:02:55     INFO -      #4 0x7f0d2ec615f0 in nsThreadManager::NewNamedThread(nsTSubstring<char> const&, nsIThreadManager::ThreadCreationOptions, nsIThread**) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadManager.cpp:548:12
[task 2023-02-09T22:02:55.261Z] 22:02:55     INFO -      #5 0x7f0d2ec6dccc in NS_NewNamedThread(nsTSubstring<char> const&, nsIThread**, already_AddRefed<nsIRunnable>, nsIThreadManager::ThreadCreationOptions) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:173:57
[task 2023-02-09T22:02:55.261Z] 22:02:55     INFO -      #6 0x7f0d3021ca46 in NS_NewNamedThread<16UL> /builds/worker/workspace/obj-build/dist/include/nsThreadUtils.h:74:10
[task 2023-02-09T22:02:55.262Z] 22:02:55     INFO -      #7 0x7f0d3021ca46 in CreateBackgroundThread /builds/worker/checkouts/gecko/ipc/glue/BackgroundImpl.cpp:889:7
[task 2023-02-09T22:02:55.262Z] 22:02:55     INFO -      #8 0x7f0d3021ca46 in (anonymous namespace)::ParentImpl::AllocStarter(mozilla::dom::ContentParent*, mozilla::ipc::Endpoint<mozilla::ipc::PBackgroundStarterParent>&&, bool) /builds/worker/checkouts/gecko/ipc/glue/BackgroundImpl.cpp:821:30
[task 2023-02-09T22:02:55.263Z] 22:02:55     INFO -      #9 0x7f0d3021d329 in Startup /builds/worker/checkouts/gecko/ipc/glue/BackgroundImpl.cpp:1166:5
[task 2023-02-09T22:02:55.263Z] 22:02:55     INFO -      #10 0x7f0d3021d329 in mozilla::ipc::BackgroundChild::Startup() /builds/worker/checkouts/gecko/ipc/glue/BackgroundImpl.cpp:694:35
[task 2023-02-09T22:02:55.263Z] 22:02:55     INFO -      #11 0x7f0d3616ea2f in mozilla::dom::ContentParent::StartUp() /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:680:3
[task 2023-02-09T22:02:55.264Z] 22:02:55     INFO -      #12 0x7f0d37e1d7cd in nsLayoutStatics::Initialize() /builds/worker/checkouts/gecko/layout/build/nsLayoutStatics.cpp:150:3
[task 2023-02-09T22:02:55.264Z] 22:02:55     INFO -      #13 0x7f0d37e1d67d in nsLayoutModuleInitialize() /builds/worker/checkouts/gecko/layout/build/nsLayoutModule.cpp:104:7
[task 2023-02-09T22:02:55.264Z] 22:02:55     INFO -      #14 0x7f0d2ebfc634 in nsComponentManagerImpl::Init() /builds/worker/checkouts/gecko/xpcom/components/nsComponentManager.cpp:371:5
[task 2023-02-09T22:02:55.265Z] 22:02:55     INFO -      #15 0x7f0d2ecbb1a1 in NS_InitXPCOM /builds/worker/checkouts/gecko/xpcom/build/XPCOMInit.cpp:421:51
[task 2023-02-09T22:02:55.265Z] 22:02:55     INFO -      #16 0x7f0d2c64d4b2 in ScopedXPCOM::ScopedXPCOM(char const*, nsIDirectoryServiceProvider*) /builds/worker/workspace/obj-build/dist/include/testing/TestHarness.h:85:19
[task 2023-02-09T22:02:55.265Z] 22:02:55     INFO -      #17 0x7f0d2c64cc03 in mozilla::RunGTestFunc(int*, char**) /builds/worker/checkouts/gecko/testing/gtest/mozilla/GTestRunner.cpp:114:15
[task 2023-02-09T22:02:55.266Z] 22:02:55     INFO -      #18 0x7f0d3bbe2bdb in XREMain::XRE_mainStartup(bool*) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4677:16
[task 2023-02-09T22:02:55.266Z] 22:02:55     INFO -      #19 0x7f0d3bbf2173 in XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5831:12
[task 2023-02-09T22:02:55.266Z] 22:02:55     INFO -      #20 0x7f0d3bbf2feb in XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5899:21
[task 2023-02-09T22:02:55.266Z] 22:02:55     INFO -      #21 0x5589c6fedf8e in do_main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:226:22
[task 2023-02-09T22:02:55.267Z] 22:02:55     INFO -      #22 0x5589c6fedf8e in main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:423:16
[task 2023-02-09T22:02:55.267Z] 22:02:55     INFO -      #23 0x7f0d50f17b96 in __libc_start_main /tmp/glibc/csu/../csu/libc-start.c:310
[task 2023-02-09T22:02:55.268Z] 22:02:55     INFO -  ==1534==ABORTING
[task 2023-02-09T22:02:55.327Z] 22:02:55     INFO -  gtest INFO | gtest | process wait complete, returncode=1
[task 2023-02-09T22:02:55.327Z] 22:02:55     INFO -  mozcrash checking /builds/worker/workspace/build/tests/gtest for minidumps...
[task 2023-02-09T22:02:55.328Z] 22:02:55  WARNING -  gtest TEST-UNEXPECTED-FAIL | gtest | test failed with return code 1
[task 2023-02-09T22:02:55.329Z] 22:02:55     INFO -  gtest INFO | rungtests.py exits with code 1
[task 2023-02-09T22:02:55.349Z] 22:02:55    ERROR - Return code: 1
[task 2023-02-09T22:02:55.349Z] 22:02:55    ERROR - No tests run or test summary not found
[task 2023-02-09T22:02:55.349Z] 22:02:55     INFO - TinderboxPrint: gtest-gtest<br/><em class="testfail">T-FAIL</em>
[task 2023-02-09T22:02:55.349Z] 22:02:55    ERROR - # TBPL FAILURE #
[task 2023-02-09T22:02:55.349Z] 22:02:55  WARNING - setting return code to 2
[task 2023-02-09T22:02:55.349Z] 22:02:55    ERROR - The gtest suite: gtest ran with return status: FAILURE
[task 2023-02-09T22:02:55.350Z] 22:02:55     INFO - Running post-action listener: _package_coverage_data
[task 2023-02-09T22:02:55.350Z] 22:02:55     INFO - Running post-action listener: _resource_record_post_action
[task 2023-02-09T22:02:55.350Z] 22:02:55     INFO - Running post-action listener: process_java_coverage_data
[task 2023-02-09T22:02:55.350Z] 22:02:55     INFO - [mozharness: 2023-02-09 22:02:55.350217Z] Finished run-tests step (success)
[task 2023-02-09T22:02:55.350Z] 22:02:55     INFO - [mozharness: 2023-02-09 22:02:55.350268Z] Running uninstall step.
[task 2023-02-09T22:02:55.350Z] 22:02:55     INFO - Running pre-action listener: _resource_record_pre_action
[task 2023-02-09T22:02:55.350Z] 22:02:55     INFO - Running main action method: uninstall
[task 2023-02-09T22:02:55.350Z] 22:02:55     INFO - Skipping uninstall for non-MSIX test
[task 2023-02-09T22:02:55.350Z] 22:02:55     INFO - Running post-action listener: _resource_record_post_action
[task 2023-02-09T22:02:55.350Z] 22:02:55     INFO - [mozharness: 2023-02-09 22:02:55.350491Z] Finished uninstall step (success)
[task 2023-02-09T22:02:55.350Z] 22:02:55     INFO - Running post-run listener: _resource_record_post_run
[task 2023-02-09T22:02:55.403Z] 22:02:55     INFO - Validating Perfherder data against /builds/worker/workspace/mozharness/external_tools/performance-artifact-schema.json
[task 2023-02-09T22:02:55.406Z] 22:02:55     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "gtest.gtest.overall", "extraOptions": ["taskcluster-projects/887720501152/machineTypes/n2-standard-4"], "subtests": [{"name": "cpu_percent", "value": 11.682468220338984}, {"name": "io_write_bytes", "value": 7690649600}, {"name": "io.read_bytes", "value": 1720320}, {"name": "io_write_time", "value": 6222932}, {"name": "io_read_time", "value": 5372}]}, {"name": "gtest.gtest.start-pulseaudio", "subtests": [{"name": "time", "value": 0.01872539520263672}, {"name": "cpu_percent", "value": 0}]}, {"name": "gtest.gtest.install", "subtests": [{"name": "time", "value": 51.54157328605652}, {"name": "cpu_percent", "value": 25.250999999999998}]}, {"name": "gtest.gtest.stage-files", "subtests": [{"name": "time", "value": 2.0302248001098633}, {"name": "cpu_percent", "value": 14.625}]}, {"name": "gtest.gtest.run-tests", "subtests": [{"name": "time", "value": 419.79475593566895}, {"name": "cpu_percent", "value": 9.963755980861249}]}, {"name": "gtest.gtest.uninstall", "subtests": [{"name": "time", "value": 0.0001468658447265625}, {"name": "cpu_percent", "value": 0}]}]}
[task 2023-02-09T22:02:55.406Z] 22:02:55     INFO - Total resource usage - Wall time: 473s; CPU: Can't collect data; Read bytes: 1720320; Write bytes: 7690649600; Read time: 5372; Write time: 6222932
[task 2023-02-09T22:02:55.406Z] 22:02:55     INFO - TinderboxPrint: I/O read bytes / time<br/>1,720,320 / 5,372
[task 2023-02-09T22:02:55.406Z] 22:02:55     INFO - TinderboxPrint: I/O write bytes / time<br/>7,690,649,600 / 6,222,932
[task 2023-02-09T22:02:55.406Z] 22:02:55     INFO - TinderboxPrint: CPU idle<br/>1,656.2 (88.3%)
[task 2023-02-09T22:02:55.406Z] 22:02:55     INFO - TinderboxPrint: CPU system<br/>63.2 (3.4%)
[task 2023-02-09T22:02:55.406Z] 22:02:55     INFO - TinderboxPrint: CPU user<br/>152.0 (8.1%)
[task 2023-02-09T22:02:55.406Z] 22:02:55     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2023-02-09T22:02:55.406Z] 22:02:55     INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-02-09T22:02:55.407Z] 22:02:55     INFO - install - Wall time: 52s; CPU: 25%; Read bytes: 0; Write bytes: 1467723776; Read time: 0; Write time: 543944
[task 2023-02-09T22:02:55.407Z] 22:02:55     INFO - stage-files - Wall time: 2s; CPU: 15%; Read bytes: 8192; Write bytes: 625205248; Read time: 1904; Write time: 485712
[task 2023-02-09T22:02:55.409Z] 22:02:55     INFO - run-tests - Wall time: 420s; CPU: 10%; Read bytes: 1712128; Write bytes: 3464798208; Read time: 3468; Write time: 4843128
[task 2023-02-09T22:02:55.410Z] 22:02:55     INFO - uninstall - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-02-09T22:02:55.465Z] 22:02:55  WARNING - returning nonzero exit status 2
[task 2023-02-09T22:02:55.482Z] cleanup
[task 2023-02-09T22:02:55.482Z] + cleanup
[task 2023-02-09T22:02:55.483Z] + local rv=2
[task 2023-02-09T22:02:55.483Z] + [[ -s /builds/worker/.xsession-errors ]]
[task 2023-02-09T22:02:55.483Z] + cp /builds/worker/.xsession-errors /builds/worker/artifacts/public/xsession-errors.log
[task 2023-02-09T22:02:55.485Z] + '[' ']'
[task 2023-02-09T22:02:55.485Z] + true
[task 2023-02-09T22:02:55.485Z] + cleanup_xvfb
[task 2023-02-09T22:02:55.485Z] ++ pidof Xvfb
[task 2023-02-09T22:02:55.488Z] + local xvfb_pid=50
[task 2023-02-09T22:02:55.489Z] + local vnc=false
[task 2023-02-09T22:02:55.489Z] + local interactive=false
[task 2023-02-09T22:02:55.489Z] + '[' -n 50 ']'
[task 2023-02-09T22:02:55.489Z] + [[ false == false ]]
[task 2023-02-09T22:02:55.489Z] + [[ false == false ]]
[task 2023-02-09T22:02:55.489Z] + kill 50
[task 2023-02-09T22:02:55.489Z] + screen -XS xvfb quit
[task 2023-02-09T22:02:55.504Z] + exit 2
[taskcluster 2023-02-09 22:02:56.175Z] === Task Finished ===
[taskcluster 2023-02-09 22:02:57.689Z] Unsuccessful task run with exit code: 2 completed in 613.226 seconds

Comment 1

[Cristian Tuns]

Hi, can you please take a look at this? I think this might be caused by Bug 1798513 . Thanks!
Backfills: https://treeherder.mozilla.org/jobs?repo=autoland&group_state=expanded&collapsedPushes=1155668&fromchange=91caeb8a80194a216e4c954cd4fbba7d0b6e6412&searchStr=linux%2C18.04%2Cx64%2Cwebrender%2Casan%2Copt%2Ctest-linux1804-64-asan-qr%2Fopt-gtest-1proc%2Cgtest-1proc&tochange=5abe5311b1231b4fb279436c9a7b4a1c46b320c3&selectedTaskRun=BvT3avc7TL2SHAjm_dcRNQ.0

Comment 2

[Intermittent Failures Robot]

52 failures in 842 pushes (0.062 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 52

Platform and build breakdown:

• linux1804-64-asan-qr: 52
  • opt: 52

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1815999&startday=2023-02-09&endday=2023-02-09&tree=all

Comment 3

[Jan Varga [:janv]]

Testing a patch:
https://treeherder.mozilla.org/jobs?repo=try&revision=1205209e266271ef307f430a2298836c11444b8c

Comment 4

[Jan Varga [:janv]]

Attachment: Bug 1815999 - Fix FileSystemDataManager::GetOrCreateFileSystemManager to always resolve/reject returned MozPromise; r=#dom-storage

When QuotaManager::GetOrCreate fails in BeginOpen we create and reject a new
MozPromise instead of using corresponding MozPromiseHolder. This becomes a
problem when there's a second GetOrCreateFileSystemManager call which doesn't
call BeginOpen (because the opening is already in progress), it calls OnOpen
instead, so the MozPromise returned by OnOpen is never resolved/rejected.
This patch fixes the described problem by moving QuotaManager::GetOrCreate to
GetOrCreateFileSystemManager and holding the result in a new member variable.

Comment 5

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/4f32061b6a73
Fix FileSystemDataManager::GetOrCreateFileSystemManager to always resolve/reject returned MozPromise; r=dom-storage-reviewers,jari

Comment 6

[Cristina Horotan [:chorotan]]

https://hg.mozilla.org/mozilla-central/rev/4f32061b6a73

Comment 7

[Intermittent Failures Robot]

58 failures in 3766 pushes (0.015 failures/push) were associated with this bug in the last 7 days.

This is the #12 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 57
• try: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 58
  • opt: 58

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1815999&startday=2023-02-06&endday=2023-02-12&tree=all