Open Bug 1952965 Opened 10 days ago Updated 4 days ago

Intermittent gtest TEST-UNEXPECTED-FAIL | gtest | timed out after 300 seconds without output in TwoTicketsWithSameNameBothBlockShutdown

Categories

(Core :: Audio/Video, defect, P5)

defect

Tracking

()

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: smolnar [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=498402921&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/IPuqS3yQR9e-d9A9x6DcKA/runs/0/artifacts/public/logs/live_backing.log


 TEST-PASS | ShutdownBlockingTicketDeathTest.CreateTicketAfterAppShutdownOffMain | test completed (time: 429ms)
[task 2025-03-10T17:45:40.553Z] 17:45:40     INFO -  TEST-START | ShutdownBlockingTicketDeathTest.TwoTicketsWithSameNameBothBlockShutdown
[task 2025-03-10T17:45:40.858Z] 17:45:40     INFO -  Running GTest tests...
[task 2025-03-10T17:45:40.942Z] 17:45:40     INFO -  Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2025-03-10T17:50:40.985Z] 17:50:40  WARNING -  gtest TEST-UNEXPECTED-FAIL | gtest | timed out after 300 seconds without output
[task 2025-03-10T17:50:40.985Z] 17:50:40     INFO -  gtest INFO | gtest | process wait complete, returncode=None
[task 2025-03-10T17:50:40.985Z] 17:50:40     INFO -  mozcrash checking /opt/worker/tasks/task_174162863097554/build/tests/gtest for minidumps...
[task 2025-03-10T17:50:40.987Z] 17:50:40     INFO -  mozcrash INFO | Copy/paste: /opt/worker/tasks/task_174162863097554/fetches/minidump-stackwalk/minidump-stackwalk --symbols-url=https://symbols.mozilla.org/ --cyborg=/var/folders/nt/c7qtkzrx14b8v5gf81qqzsr00000jb/T/tmpnrpe3b0m/2F150A87-F70B-43B2-B135-3508E0096ACD.trace /opt/worker/tasks/task_174162863097554/build/tests/gtest/2F150A87-F70B-43B2-B135-3508E0096ACD.dmp /opt/worker/tasks/task_174162863097554/build/symbols
[task 2025-03-10T17:50:40.996Z] 17:50:40     INFO -  mozcrash INFO | Saved minidump as /opt/worker/tasks/task_174162863097554/build/blobber_upload_dir/2F150A87-F70B-43B2-B135-3508E0096ACD.dmp
[task 2025-03-10T17:50:40.996Z] 17:50:40  WARNING -  PROCESS-CRASH | None [unknown top frame] | gtest
[task 2025-03-10T17:50:40.996Z] 17:50:40     INFO -  Crash dump filename: /opt/worker/tasks/task_174162863097554/build/tests/gtest/2F150A87-F70B-43B2-B135-3508E0096ACD.dmp
[task 2025-03-10T17:50:40.996Z] 17:50:40     INFO -  Process type: unknown
[task 2025-03-10T17:50:40.996Z] 17:50:40     INFO -  Process pid: unknown
[task 2025-03-10T17:50:40.996Z] 17:50:40     INFO -  stderr from minidump-stackwalk:
[task 2025-03-10T17:50:40.997Z] 17:50:40     INFO -  ERROR HeaderMismatch - Error reading dump: Header mismatch
[task 2025-03-10T17:50:40.997Z] 17:50:40     INFO -  minidump-stackwalk exited with return code 1
[task 2025-03-10T17:50:40.998Z] 17:50:40     INFO -  mozcrash INFO | Copy/paste: /opt/worker/tasks/task_174162863097554/fetches/minidump-stackwalk/minidump-stackwalk --symbols-url=https://symbols.mozilla.org/ --cyborg=/var/folders/nt/c7qtkzrx14b8v5gf81qqzsr00000jb/T/tmpvip9yuy3/2B893E5E-3929-4536-A379-A7373D7F6E5A.trace /opt/worker/tasks/task_174162863097554/build/tests/gtest/2B893E5E-3929-4536-A379-A7373D7F6E5A.dmp /opt/worker/tasks/task_174162863097554/build/symbols
[task 2025-03-10T17:50:50.884Z] 17:50:50     INFO -  mozcrash WARNING | .extra file does not contain proper json
[task 2025-03-10T17:50:50.885Z] 17:50:50     INFO -  mozcrash INFO    | Saved minidump as /opt/worker/tasks/task_174162863097554/build/blobber_upload_dir/2B893E5E-3929-4536-A379-A7373D7F6E5A.dmp
[task 2025-03-10T17:50:50.886Z] 17:50:50     INFO -  mozcrash INFO    | Saved app info as /opt/worker/tasks/task_174162863097554/build/blobber_upload_dir/2B893E5E-3929-4536-A379-A7373D7F6E5A.extra
[task 2025-03-10T17:50:50.887Z] 17:50:50  WARNING -  PROCESS-CRASH | None [@ mozilla::detail::MutexImpl::mutexLock] | gtest
[task 2025-03-10T17:50:50.887Z] 17:50:50     INFO -  Crash dump filename: /opt/worker/tasks/task_174162863097554/build/tests/gtest/2B893E5E-3929-4536-A379-A7373D7F6E5A.dmp
[task 2025-03-10T17:50:50.887Z] 17:50:50     INFO -  Process type: unknown
[task 2025-03-10T17:50:50.887Z] 17:50:50     INFO -  Process pid: 1006
[task 2025-03-10T17:50:50.887Z] 17:50:50     INFO -  Operating system: Mac OS X
[task 2025-03-10T17:50:50.888Z] 17:50:50     INFO -                    14.7.0 23H124
[task 2025-03-10T17:50:50.888Z] 17:50:50     INFO -  CPU: amd64
[task 2025-03-10T17:50:50.888Z] 17:50:50     INFO -       family 6 model 158 stepping 10
[task 2025-03-10T17:50:50.888Z] 17:50:50     INFO -       12 CPUs
[task 2025-03-10T17:50:50.888Z] 17:50:50     INFO -  Crash reason:  EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
[task 2025-03-10T17:50:50.888Z] 17:50:50     INFO -  Crash address: 0x0000000000000000 **
[task 2025-03-10T17:50:50.889Z] 17:50:50     INFO -      ** Null pointer detected with offset: 0x0000000000000000
[task 2025-03-10T17:50:50.889Z] 17:50:50     INFO -  Crashing instruction: `mov qword [rax], rcx`
[task 2025-03-10T17:50:50.889Z] 17:50:50     INFO -  Memory accessed by instruction:
[task 2025-03-10T17:50:50.889Z] 17:50:50     INFO -    0. Address: 0x0000000000000000
[task 2025-03-10T17:50:50.889Z] 17:50:50     INFO -       Size: 8
[task 2025-03-10T17:50:50.889Z] 17:50:50     INFO -       Access type: Write
[task 2025-03-10T17:50:50.890Z] 17:50:50     INFO -  No instruction pointer update by instruction
[task 2025-03-10T17:50:50.890Z] 17:50:50     INFO -  Mac Crash Info:
[task 2025-03-10T17:50:50.890Z] 17:50:50     INFO -    Record 0
[task 2025-03-10T17:50:50.890Z] 17:50:50     INFO -      module: /usr/lib/dyld
[task 2025-03-10T17:50:50.890Z] 17:50:50     INFO -      message2: dyld config: DYLD_LIBRARY_PATH=/opt/worker/tasks/task_174162863097554/build/application/Firefox NightlyDebug.app/Contents/Resources
[task 2025-03-10T17:50:50.890Z] 17:50:50     INFO -  Mac Boot Args:
[task 2025-03-10T17:50:50.891Z] 17:50:50     INFO -  Process uptime: 1 seconds
[task 2025-03-10T17:50:50.891Z] 17:50:50     INFO -  Thread 2 RegisterFonts (crashed) - tid: 6659
[task 2025-03-10T17:50:50.891Z] 17:50:50     INFO -   0  libmozglue.dylib!MOZ_CrashSequence(void*, long) [Assertions.h:c62fda6846e652000919dda1fa619960b6732c8e : 267]
[task 2025-03-10T17:50:50.891Z] 17:50:50     INFO -      Found by: inlining
[task 2025-03-10T17:50:50.892Z] 17:50:50     INFO -   1  libmozglue.dylib!mozilla::detail::MutexImpl::mutexLock() [Mutex_posix.cpp:c62fda6846e652000919dda1fa619960b6732c8e : 94]
[task 2025-03-10T17:50:50.892Z] 17:50:50     INFO -      Found by: inlining
[task 2025-03-10T17:50:50.892Z] 17:50:50     INFO -   2  libmozglue.dylib!mozilla::detail::MutexImpl::lock() [Mutex_posix.cpp:c62fda6846e652000919dda1fa619960b6732c8e : 116 + 0x3b]
[task 2025-03-10T17:50:50.892Z] 17:50:50     INFO -       rax = 0x0000000000000000    rdx = 0x00007ff84a5135d8
[task 2025-03-10T17:50:50.893Z] 17:50:50     INFO -       rcx = 0x0000000000000060    rbx = 0x000000010d7f68ee
[task 2025-03-10T17:50:50.893Z] 17:50:50     INFO -       rsi = 0x00000000000120a8    rdi = 0x00007ff84a5135b8
[task 2025-03-10T17:50:50.893Z] 17:50:50     INFO -       rbp = 0x0000700009c11cb0    rsp = 0x0000700009c11ca0
[task 2025-03-10T17:50:50.893Z] 17:50:50     INFO -        r8 = 0x00007ff84a5135d0     r9 = 0x00000000ffffff00
[task 2025-03-10T17:50:50.894Z] 17:50:50     INFO -       r10 = 0x0000000000000000    r11 = 0x0000000000000000
[task 2025-03-10T17:50:50.894Z] 17:50:50     INFO -       r12 = 0x0000000000000000    r13 = 0xaaaaaaaaaaaaaaaa
[task 2025-03-10T17:50:50.894Z] 17:50:50     INFO -       r14 = 0x0000000000001f7b    r15 = 0x0000000000000000
[task 2025-03-10T17:50:50.894Z] 17:50:50     INFO -       rip = 0x000000010d7cacd3
[task 2025-03-10T17:50:50.894Z] 17:50:50     INFO -      Found by: given as instruction pointer in context
[task 2025-03-10T17:50:50.895Z] 17:50:50     INFO -   3  XUL!mozilla::baseprofiler::detail::BaseProfilerMutex::Lock() [BaseProfilerDetail.h:c62fda6846e652000919dda1fa619960b6732c8e : 57 + 0x7]
[task 2025-03-10T17:50:50.895Z] 17:50:50     INFO -       rbx = 0x000000012fe7a6a8    rbp = 0x0000700009c11ce0
[task 2025-03-10T17:50:50.895Z] 17:50:50     INFO -       rsp = 0x0000700009c11cc0    r12 = 0x0000000000000000
[task 2025-03-10T17:50:50.896Z] 17:50:50     INFO -       r13 = 0xaaaaaaaaaaaaaaaa    r14 = 0x0000000000001f7b
[task 2025-03-10T17:50:50.896Z] 17:50:50     INFO -       r15 = 0x0000000000000000    rip = 0x0000000120ee0500
[task 2025-03-10T17:50:50.896Z] 17:50:50     INFO -      Found by: call frame info
[task 2025-03-10T17:50:50.897Z] 17:50:50     INFO -   4  XUL!mozilla::baseprofiler::detail::BaseProfilerAutoLock::BaseProfilerAutoLock(mozilla::baseprofiler::detail::BaseProfilerMutex&) [BaseProfilerDetail.h:c62fda6846e652000919dda1fa619960b6732c8e : 104]
[task 2025-03-10T17:50:50.897Z] 17:50:50     INFO -      Found by: inlining
[task 2025-03-10T17:50:50.897Z] 17:50:50     INFO -   5  XUL!mozilla::baseprofiler::detail::BaseProfilerAutoLock::BaseProfilerAutoLock(mozilla::baseprofiler::detail::BaseProfilerMutex&) [BaseProfilerDetail.h:c62fda6846e652000919dda1fa619960b6732c8e : 103]
[task 2025-03-10T17:50:50.897Z] 17:50:50     INFO -      Found by: inlining
[task 2025-03-10T17:50:50.898Z] 17:50:50     INFO -   6  XUL!PSAutoLock::PSAutoLock() [platform.cpp:c62fda6846e652000919dda1fa619960b6732c8e : 499]
[task 2025-03-10T17:50:50.898Z] 17:50:50     INFO -      Found by: inlining
[task 2025-03-10T17:50:50.898Z] 17:50:50     INFO -   7  XUL!PSAutoLock::PSAutoLock() [platform.cpp:c62fda6846e652000919dda1fa619960b6732c8e : 508]
[task 2025-03-10T17:50:50.898Z] 17:50:50     INFO -      Found by: inlining
[task 2025-03-10T17:50:50.899Z] 17:50:50     INFO -   8  XUL!mozilla::profiler::ThreadRegistry::Unregister(mozilla::profiler::ThreadRegistration::OnThreadRef) [platform.cpp:c62fda6846e652000919dda1fa619960b6732c8e : 7295 + 0x10]
[task 2025-03-10T17:50:50.899Z] 17:50:50     INFO -       rbx = 0x000000010da94740    rbp = 0x0000700009c11d30
[task 2025-03-10T17:50:50.899Z] 17:50:50     INFO -       rsp = 0x0000700009c11cf0    r12 = 0x0000000000000000
[task 2025-03-10T17:50:50.899Z] 17:50:50     INFO -       r13 = 0xaaaaaaaaaaaaaaaa    r14 = 0x000000010da94840
[task 2025-03-10T17:50:50.900Z] 17:50:50     INFO -       r15 = 0x000000010d310300    rip = 0x0000000128da4c85
[task 2025-03-10T17:50:50.900Z] 17:50:50     INFO -      Found by: call frame info
[task 2025-03-10T17:50:50.900Z] 17:50:50     INFO -   9  XUL!mozilla::profiler::ThreadRegistration::~ThreadRegistration() [ProfilerThreadRegistration.cpp:c62fda6846e652000919dda1fa619960b6732c8e : 79 + 0x7]
[task 2025-03-10T17:50:50.901Z] 17:50:50     INFO -       rbx = 0x000000010da94740    rbp = 0x0000700009c11e40
[task 2025-03-10T17:50:50.901Z] 17:50:50     INFO -       rsp = 0x0000700009c11d40    r12 = 0x0000000000000000
[task 2025-03-10T17:50:50.901Z] 17:50:50     INFO -       r13 = 0xaaaaaaaaaaaaaaaa    r14 = 0x000000010da94840
[task 2025-03-10T17:50:50.901Z] 17:50:50     INFO -       r15 = 0x000000010d310300    rip = 0x0000000128d5e28a
[task 2025-03-10T17:50:50.901Z] 17:50:50     INFO -      Found by: call frame info
[task 2025-03-10T17:50:50.902Z] 17:50:50     INFO -  10  XUL!mozilla::profiler::ThreadRegistration::~ThreadRegistration() [ProfilerThreadRegistration.cpp:c62fda6846e652000919dda1fa619960b6732c8e : 53]
You need to log in before you can comment on or make changes to this bug.