Closed Bug 1750438 Opened 4 years ago Closed 3 years ago

Intermittent TV browser/components/downloads/test/browser/browser_libraryDrop.js | Test timed out - | application timed out after 370 seconds with no output

Categories

(Firefox :: Downloads Panel, defect, P5)

Product:
Firefox
Component:
Downloads Panel
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE
Tracking Flags:
Tracking Status
firefox-esr91 --- unaffected
firefox96 --- unaffected
firefox97 --- unaffected
firefox98 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Filed by: imoraru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=364270320&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Tz3RAG1bR0CsH9PjHwWcAQ/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Tz3RAG1bR0CsH9PjHwWcAQ/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2022-01-16T12:08:11.801Z] 12:08:11     INFO - TEST-START | browser/components/downloads/test/browser/browser_libraryDrop.js
[task 2022-01-16T12:08:12.288Z] 12:08:12     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 19f0f8800 == 6 [pid = 5589] [id = 5]
[task 2022-01-16T12:08:12.289Z] 12:08:12     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 11 (12d77c3c0) [pid = 5589] [serial = 11] [outer = 0]
[task 2022-01-16T12:08:12.290Z] 12:08:12     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 12 (1a17c8400) [pid = 5589] [serial = 12] [outer = 12d77c3c0]
[task 2022-01-16T12:08:12.325Z] 12:08:12     INFO - GECKO(5589) | [Parent 5589, Main Thread] WARNING: NS_ENSURE_TRUE(uri) failed: file /builds/worker/checkouts/gecko/caps/BasePrincipal.cpp:1346
[task 2022-01-16T12:08:12.325Z] 12:08:12     INFO - GECKO(5589) | must wait for load
[task 2022-01-16T12:08:12.421Z] 12:08:12     INFO - GECKO(5589) | [Parent 5589, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4235
[task 2022-01-16T12:08:13.718Z] 12:08:13     INFO - GECKO(5589) | [2022-01-16T12:08:13Z WARN  l10nregistry_ffi::env] L10nRegistry error: Fluent Error in toolkit/global/textActions.ftl: Attempt to override an existing message: "text-action-undo".
[task 2022-01-16T12:08:13.719Z] 12:08:13     INFO - GECKO(5589) | [2022-01-16T12:08:13Z WARN  l10nregistry_ffi::env] L10nRegistry error: Fluent Error in toolkit/global/textActions.ftl: Attempt to override an existing message: "text-action-undo-shortcut".
<...>
[task 2022-01-16T12:08:13.867Z] 12:08:13     INFO - GECKO(5589) | [2022-01-16T12:08:13Z WARN  l10nregistry_ffi::env] L10nRegistry error: Fluent Error in browser/browserSets.ftl: Attempt to override an existing message: "hide-other-apps-shortcut".
[task 2022-01-16T12:08:13.878Z] 12:08:13     INFO - GECKO(5589) | [Parent 5589, Main Thread] WARNING: NS_ENSURE_TRUE(root) failed: file /builds/worker/checkouts/gecko/layout/base/nsDocumentViewer.cpp:2619
[task 2022-01-16T12:08:14.086Z] 12:08:14     INFO - GECKO(5589) | [2022-01-16T12:08:14Z WARN  webrender::device::gl] Missing optimized shader source for gpu_cache_update
[task 2022-01-16T12:08:15.658Z] 12:08:15     INFO - GECKO(5589) | must wait for focus
[task 2022-01-16T12:08:16.142Z] 12:08:16     INFO - GECKO(5589) | [Parent 5589, Main Thread] WARNING: Suboptimal indexes for the SQL statement 0x13007d700 (http://mzl.la/1FuID0j).: file /builds/worker/checkouts/gecko/storage/mozStoragePrivateHelpers.cpp:113
[task 2022-01-16T12:08:16.961Z] 12:08:16     INFO - GECKO(5589) | [Child 5590: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 10d507800 == 0 [pid = 5590] [id = 0] [url = about:blank]
[task 2022-01-16T12:08:17.105Z] 12:08:17     INFO - GECKO(5589) | [Child 5590: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (10c1b0c80) [pid = 5590] [serial = 1] [outer = 0] [url = about:blank]
[task 2022-01-16T12:08:17.300Z] 12:08:17     INFO - GECKO(5589) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/bm/t6nfhhd93xs2xgxhbmzbnnzr000014/T/tmpsvvsc935.mozrunner/runtests_leaks_tab_pid5612.log
[task 2022-01-16T12:08:17.301Z] 12:08:17     INFO - GECKO(5589) | [5612, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:253
[task 2022-01-16T12:08:19.893Z] 12:08:19     INFO - GECKO(5589) | [Child 5606: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (109e08400) [pid = 5606] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-01-16T12:08:21.479Z] 12:08:21     INFO - GECKO(5589) | [Child 5590: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (10d510000) [pid = 5590] [serial = 3] [outer = 0] [url = about:blank]
[task 2022-01-16T12:08:21.479Z] 12:08:21     INFO - GECKO(5589) | [Child 5590: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (10d50e800) [pid = 5590] [serial = 4] [outer = 0] [url = about:blank]
[task 2022-01-16T12:08:23.644Z] 12:08:23     INFO - GECKO(5589) | [Parent 5589, mozStorage #2] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/workspace/obj-build/dist/include/mozStorageHelper.h:148
[task 2022-01-16T12:08:23.644Z] 12:08:23     INFO - GECKO(5589) | [Parent 5589, mozStorage #2] WARNING: 'NS_FAILED(transaction.Start())', file /builds/worker/checkouts/gecko/toolkit/components/places/History.cpp:842
[task 2022-01-16T12:10:30.908Z] 12:10:30     INFO - TEST-INFO | started process screencapture
[task 2022-01-16T12:10:31.038Z] 12:10:31     INFO - TEST-INFO | screencapture: exit 0
[task 2022-01-16T12:10:31.038Z] 12:10:31     INFO - Buffered messages logged at 12:08:11
[task 2022-01-16T12:10:31.039Z] 12:10:31     INFO - Entering test bound test_indicatorDrop
[task 2022-01-16T12:10:31.039Z] 12:10:31     INFO - Buffered messages logged at 12:08:14
[task 2022-01-16T12:10:31.040Z] 12:10:31     INFO - Console message: [JavaScript Error: "Attempt to override an existing message: "text-action-undo"." {file: "toolkit/global/textActions.ftl" line: 0}]
[task 2022-01-16T12:10:31.040Z] 12:10:31     INFO - Console message: [JavaScript Error: "Attempt to override an existing message: "text-action-undo-shortcut"." {file: "toolkit/global/textActions.ftl" line: 0}]
<...>
[task 2022-01-16T12:10:31.071Z] 12:10:31     INFO - Console message: [JavaScript Error: "Attempt to override an existing message: "hide-other-apps-shortcut"." {file: "browser/browserSets.ftl" line: 0}]
[task 2022-01-16T12:10:31.071Z] 12:10:31     INFO - Buffered messages logged at 12:08:16
[task 2022-01-16T12:10:31.071Z] 12:10:31     INFO - TEST-PASS | browser/components/downloads/test/browser/browser_libraryDrop.js | download list box present - 
[task 2022-01-16T12:10:31.072Z] 12:10:31     INFO - Buffered messages logged at 12:08:22
[task 2022-01-16T12:10:31.072Z] 12:10:31     INFO - TEST-PASS | browser/components/downloads/test/browser/browser_libraryDrop.js | http://localhost:54090/file1.txt is added to download - 
[task 2022-01-16T12:10:31.073Z] 12:10:31     INFO - Buffered messages finished
[task 2022-01-16T12:10:31.073Z] 12:10:31     INFO - TEST-UNEXPECTED-FAIL | browser/components/downloads/test/browser/browser_libraryDrop.js | Test timed out - 
[task 2022-01-16T12:10:31.331Z] 12:10:31     INFO - removing /var/folders/bm/t6nfhhd93xs2xgxhbmzbnnzr000014/T/dm-ui-test.file
[task 2022-01-16T12:10:38.880Z] 12:10:38     INFO - removing /var/folders/bm/t6nfhhd93xs2xgxhbmzbnnzr000014/T/Temp-4cdd5d24-603c-4fcc-b39d-f8edb0a215a4/testsavedir1735202269/file1.txt
[task 2022-01-16T12:16:49.004Z] 12:16:49     INFO - Buffered messages finished
[task 2022-01-16T12:16:49.004Z] 12:16:49    ERROR - TEST-UNEXPECTED-TIMEOUT | browser/components/downloads/test/browser/browser_libraryDrop.js | application timed out after 370 seconds with no output
[task 2022-01-16T12:16:49.004Z] 12:16:49    ERROR - Force-terminating active process(es).
[task 2022-01-16T12:16:49.005Z] 12:16:49     INFO - Determining child pids from psutil...
[task 2022-01-16T12:16:49.007Z] 12:16:49     INFO - [5590, 5591, 5606, 5611, 5612]
[task 2022-01-16T12:16:49.007Z] 12:16:49     INFO - ==> process 5589 launched child process 5590
[task 2022-01-16T12:16:49.007Z] 12:16:49     INFO - ==> process 5589 launched child process 5591
[task 2022-01-16T12:16:49.008Z] 12:16:49     INFO - ==> process 5589 launched child process 5606
[task 2022-01-16T12:16:49.008Z] 12:16:49     INFO - ==> process 5589 launched child process 5611
[task 2022-01-16T12:16:49.008Z] 12:16:49     INFO - ==> process 5589 launched child process 5612
[task 2022-01-16T12:16:49.009Z] 12:16:49     INFO - Found child pids: {5606, 5611, 5612, 5590, 5591}
[task 2022-01-16T12:16:49.009Z] 12:16:49     INFO - Killing process: 5606
[task 2022-01-16T12:16:49.009Z] 12:16:49     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-01-16T12:16:49.010Z] 12:16:49     INFO - Killing process: 5611
[task 2022-01-16T12:16:49.010Z] 12:16:49     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-01-16T12:16:49.010Z] 12:16:49     INFO - Killing process: 5612
[task 2022-01-16T12:16:49.010Z] 12:16:49     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-01-16T12:16:49.011Z] 12:16:49     INFO - Killing process: 5590
[task 2022-01-16T12:16:49.011Z] 12:16:49     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-01-16T12:16:49.011Z] 12:16:49     INFO - Killing process: 5591
[task 2022-01-16T12:16:49.011Z] 12:16:49     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-01-16T12:17:19.038Z] 12:17:19  WARNING - failed to kill pid 5590 after 30s
[task 2022-01-16T12:17:19.039Z] 12:17:19  WARNING - failed to kill pid 5606 after 30s
[task 2022-01-16T12:17:19.039Z] 12:17:19  WARNING - failed to kill pid 5612 after 30s
[task 2022-01-16T12:17:19.039Z] 12:17:19  WARNING - failed to kill pid 5611 after 30s
[task 2022-01-16T12:17:19.040Z] 12:17:19  WARNING - failed to kill pid 5591 after 30s
[task 2022-01-16T12:17:19.040Z] 12:17:19     INFO - Killing process: 5589
[task 2022-01-16T12:17:19.041Z] 12:17:19     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-01-16T12:17:19.273Z] 12:17:19     INFO - psutil found pid 5589 dead
[task 2022-01-16T12:17:19.273Z] 12:17:19     INFO - TEST-INFO | Main app process: exit 0
[task 2022-01-16T12:17:19.274Z] 12:17:19    ERROR - TEST-UNEXPECTED-FAIL | ShutdownLeaks | process() called before end of test suite
[task 2022-01-16T12:17:19.274Z] 12:17:19     INFO - TEST-INFO | Confirming we saw 15 DOCSHELL created and 2 destroyed log strings.
[task 2022-01-16T12:17:19.275Z] 12:17:19     INFO - TEST-INFO | Confirming we saw 39 DOMWINDOW created and 13 destroyed log strings.
[task 2022-01-16T12:17:19.275Z] 12:17:19     INFO - runtests.py | Application ran for: 0:09:41.921446
[task 2022-01-16T12:17:19.275Z] 12:17:19     INFO - zombiecheck | Reading PID log: /var/folders/bm/t6nfhhd93xs2xgxhbmzbnnzr000014/T/tmp3ac2t_a4pidlog
[task 2022-01-16T12:17:19.276Z] 12:17:19     INFO - ==> process 5589 launched child process 5590
[task 2022-01-16T12:17:19.276Z] 12:17:19     INFO - ==> process 5589 launched child process 5591
[task 2022-01-16T12:17:19.276Z] 12:17:19     INFO - ==> process 5589 launched child process 5606
[task 2022-01-16T12:17:19.277Z] 12:17:19     INFO - ==> process 5589 launched child process 5611
[task 2022-01-16T12:17:19.277Z] 12:17:19     INFO - ==> process 5589 launched child process 5612
[task 2022-01-16T12:17:19.278Z] 12:17:19     INFO - zombiecheck | Checking for orphan process with PID: 5606
[task 2022-01-16T12:17:19.278Z] 12:17:19     INFO - zombiecheck | Checking for orphan process with PID: 5611
[task 2022-01-16T12:17:19.278Z] 12:17:19     INFO - zombiecheck | Checking for orphan process with PID: 5612
[task 2022-01-16T12:17:19.279Z] 12:17:19     INFO - zombiecheck | Checking for orphan process with PID: 5590
[task 2022-01-16T12:17:19.279Z] 12:17:19     INFO - zombiecheck | Checking for orphan process with PID: 5591
[task 2022-01-16T12:17:19.281Z] 12:17:19     INFO - mozcrash Copy/paste: /opt/worker/tasks/task_164232917841677/fetches/minidump_stackwalk/minidump_stackwalk --symbols-url=https://symbols.mozilla.org/ --human /var/folders/bm/t6nfhhd93xs2xgxhbmzbnnzr000014/T/tmpsvvsc935.mozrunner/minidumps/D25008E7-7444-4383-9A8C-0F5CCF22EF24.dmp /opt/worker/tasks/task_164232917841677/build/symbols
[task 2022-01-16T12:17:21.619Z] 12:17:21     INFO - mozcrash Saved minidump as /opt/worker/tasks/task_164232917841677/build/blobber_upload_dir/D25008E7-7444-4383-9A8C-0F5CCF22EF24.dmp
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - PROCESS-CRASH | Main app process exited normally | application crashed [@ mach_msg_trap + 0xa]
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - Crash dump filename: /var/folders/bm/t6nfhhd93xs2xgxhbmzbnnzr000014/T/tmpsvvsc935.mozrunner/minidumps/D25008E7-7444-4383-9A8C-0F5CCF22EF24.dmp
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - Operating system: Mac OS X
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO -                   10.15.7 19H524
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - CPU: amd64
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO -      family 6 model 158 stepping 10
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO -      12 CPUs
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - 
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - Crash reason:  EXC_SOFTWARE / SIGABRT
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - Crash address: 0x7fff7111edfa
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - Mac Crash Info:
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - 
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - Process uptime: 552 seconds
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - 
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO - Thread 0 MainThread (crashed)
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO -  0  libsystem_kernel.dylib!mach_msg_trap + 0xa
[task 2022-01-16T12:17:21.742Z] 12:17:21     INFO -     rax = 0x000000000100001f   rdx = 0x0000000000000000
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     rcx = 0x00007ffee1fc1e98   rbx = 0x0000000000000002
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     rsi = 0x0000000000000002   rdi = 0x00007ffee1fc1f50
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     rbp = 0x00007ffee1fc1ef0   rsp = 0x00007ffee1fc1e98
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -      r8 = 0x0000000000003c07    r9 = 0x0000000000000000
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     r10 = 0x000000000000041c   r11 = 0x0000000000000202
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     r12 = 0x0000000000000002   r13 = 0x000000000000041c
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     r14 = 0x00007ffee1fc1f50   r15 = 0x0000000000000000
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     rip = 0x00007fff7111edfa
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     Found by: given as instruction pointer in context
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -  1  XUL!google_breakpad::ReceivePort::WaitForMessage(google_breakpad::MachReceiveMessage*, unsigned int) [MachIPC.mm:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 249 + 0x17]
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     rbp = 0x00007ffee1fc1f10   rsp = 0x00007ffee1fc1f00
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     rip = 0x000000011cbaaf5a
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     Found by: previous frame's frame pointer
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -  2  XUL!google_breakpad::CrashGenerationClient::RequestDumpForException(int, int, long long, unsigned int, unsigned int) [crash_generation_client.cc:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 68 + 0x9]
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     rbp = 0x00007ffee1fc27c0   rsp = 0x00007ffee1fc1f20
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     rip = 0x000000011cb9f2f2
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -  3  XUL!google_breakpad::ExceptionHandler::WriteMinidumpWithException(int, long long, long long, __darwin_ucontext*, unsigned int, unsigned int, bool, bool) [exception_handler.cc:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 466 + 0x24]
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     rbx = 0x0000000000000000   rbp = 0x00007ffee1fc2a00
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc27d0   r12 = 0x0000000000010002
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     r13 = 0x0000000000000005   r14 = 0x000000010e211500
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     r15 = 0x0000000000000307   rip = 0x000000011cba27fc
[task 2022-01-16T12:17:21.743Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -  4  XUL!google_breakpad::ExceptionHandler::SignalHandler(int, __siginfo*, void*) [exception_handler.cc:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 725 + 0x23]
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     rbx = 0x000000010e211500   rbp = 0x00007ffee1fc2a40
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc2a10   r12 = 0x7dc82d619b0935cd
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     r13 = 0x0000000000000016   r14 = 0x00007ffee1fc2ee0
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     r15 = 0x0000000116c6cdc0   rip = 0x000000011cba3104
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -  5  libsystem_platform.dylib!_sigtramp + 0x1c
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     rbx = 0x00007ffee1fc2ee0   rbp = 0x00007ffee1fc2a50
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc2a50   r12 = 0x7dc82d619b0935cd
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     r13 = 0x0000000000000016   r14 = 0x0000580100005900
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     r15 = 0x0000000116c6cdc0   rip = 0x00007fff711d65fd
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -  6  libsystem_kernel.dylib!__psynch_cvwait + 0x9
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     rbx = 0x00007ffee1fc2ee0   rbp = 0x00007ffee1fc3030
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc2f98   r12 = 0x7dc82d619b0935cd
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     r13 = 0x0000000000000016   r14 = 0x0000580100005900
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     r15 = 0x0000000116c6cdc0   rip = 0x00007fff71121882
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -  7  libmozglue.dylib!mozilla::detail::ConditionVariableImpl::wait_for(mozilla::detail::MutexImpl&, mozilla::BaseTimeDuration<mozilla::TimeDurationValueCalculator> const&) [ConditionVariable_posix.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 115 + 0xa]
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     rbp = 0x00007ffee1fc3080   rsp = 0x00007ffee1fc3040
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     rip = 0x000000010dfe9a0d
[task 2022-01-16T12:17:21.744Z] 12:17:21     INFO -     Found by: previous frame's frame pointer
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -  8  XUL!mozilla::OffTheBooksCondVar::Wait(mozilla::BaseTimeDuration<mozilla::TimeDurationValueCalculator>) [BlockingResourceBase.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 534 + 0x10]
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     rbx = 0x000000010e22d110   rbp = 0x00007ffee1fc30d0
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3090   r12 = 0x0000000000000000
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     r13 = 0x000000010e272080   r14 = 0x000000010e272080
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     r15 = 0x000000010e22d101   rip = 0x0000000116f860b8
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -  9  XUL!mozilla::OffTheBooksCondVar::Wait() [BlockingResourceBase.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 514 + 0x4]
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     rbx = 0x000000010e22d000   rbp = 0x00007ffee1fc30e0
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc30e0   r12 = 0x000000012082024e
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     r13 = 0x00007ffee1fc30f8   r14 = 0xaaaaaaaaaaaaaaaa
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     r15 = 0x000000010e22d110   rip = 0x0000000116f85fe3
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO - 10  XUL!mozilla::TaskController::GetRunnableForMTTask(bool) [TaskController.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 516 + 0x7]
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     rbx = 0x000000010e22d000   rbp = 0x00007ffee1fc3130
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc30f0   r12 = 0x000000012082024e
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     r13 = 0x00007ffee1fc30f8   r14 = 0xaaaaaaaaaaaaaaaa
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     r15 = 0x000000010e22d110   rip = 0x0000000116f98ad8
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO - 11  XUL!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 1129 + 0x18]
[task 2022-01-16T12:17:21.745Z] 12:17:21     INFO -     rbx = 0x0000000000000001   rbp = 0x00007ffee1fc3250
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3140   r12 = 0x0000000000000001
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     r13 = 0x000000010e29d260   r14 = 0x000000010e20d901
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     r15 = 0x000000010e29d201   rip = 0x0000000116facd8a
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO - 12  XUL!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 467 + 0xc]
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     rbx = 0x0000000000000001   rbp = 0x00007ffee1fc3280
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3260   r12 = 0x0000000000000000
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     r13 = 0x000000010e20d990   r14 = 0x000000010e20d970
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     r15 = 0x000000010e29d260   rip = 0x0000000116fb437c
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO - 13  XUL!mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) [MessagePump.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 107 + 0xc]
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     rbx = 0x00007ffee1fc3490   rbp = 0x00007ffee1fc32d0
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3290   r12 = 0x0000000000000000
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     r13 = 0x000000010e20d990   r14 = 0x000000010e20d970
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     r15 = 0x000000010e29d260   rip = 0x0000000117844bd9
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.746Z] 12:17:21     INFO - 14  XUL!MessageLoop::Run() [message_loop.cc:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 306 + 0x4]
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     rbx = 0x000000010e21d450   rbp = 0x00007ffee1fc3300
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc32e0   r12 = 0x000000010e24f000
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     r13 = 0x00007ffee1fc3758   r14 = 0x000000010e29d260
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     r15 = 0x0000000080004005   rip = 0x00000001177be754
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO - 15  XUL!nsBaseAppShell::Run() [nsBaseAppShell.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 137 + 0xc]
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     rbx = 0x000000010e21d450   rbp = 0x00007ffee1fc3320
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3310   r12 = 0x000000010e24f000
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     r13 = 0x00007ffee1fc3758   r14 = 0x000000010e29d260
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     r15 = 0x0000000080004005   rip = 0x000000011b043639
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO - 16  XUL!nsAppShell::Run() [nsAppShell.mm:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 800 + 0x7]
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     rbx = 0x000000010e21d450   rbp = 0x00007ffee1fc3370
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3330   r12 = 0x000000010e24f000
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     r13 = 0x00007ffee1fc3758   r14 = 0x0000000000000000
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     r15 = 0x0000000080004005   rip = 0x000000011b0c1052
[task 2022-01-16T12:17:21.747Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO - 17  XUL!XRE_RunAppShell() [nsEmbedFunctions.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 870 + 0xe]
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     rbx = 0x00007ffee1fc3490   rbp = 0x00007ffee1fc33c0
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3380   r12 = 0x000000010e24f000
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     r13 = 0x00007ffee1fc3758   r14 = 0x000000010e20d970
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     r15 = 0x0000000080004005   rip = 0x000000011cbdc744
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO - 18  XUL!mozilla::ipc::MessagePumpForChildProcess::Run(base::MessagePump::Delegate*) [MessagePump.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 235 + 0x4]
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     rbx = 0x00007ffee1fc3490   rbp = 0x00007ffee1fc33f0
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc33d0   r12 = 0x000000010e24f000
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     r13 = 0x00007ffee1fc3758   r14 = 0x000000010e20d970
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     r15 = 0x0000000080004005   rip = 0x0000000117845631
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO - 19  XUL!MessageLoop::Run() [message_loop.cc:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 306 + 0x4]
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     rbx = 0x00000000e1fc3301   rbp = 0x00007ffee1fc3420
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3400   r12 = 0x000000010e24f000
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     r13 = 0x00007ffee1fc3758   r14 = 0x000000000000001b
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     r15 = 0x0000000080004005   rip = 0x00000001177be754
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO - 20  XUL!XRE_InitChildProcess(int, char**, XREChildData const*) [nsEmbedFunctions.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 707 + 0x4]
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     rbx = 0x00000000e1fc3301   rbp = 0x00007ffee1fc36f0
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3430   r12 = 0x000000010e24f000
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     r13 = 0x00007ffee1fc3758   r14 = 0x000000000000001b
[task 2022-01-16T12:17:21.748Z] 12:17:21     INFO -     r15 = 0x0000000080004005   rip = 0x000000011cbdc174
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO - 21  plugin-container!main [MozillaRuntimeMain.cpp:328be918baf6a6b3cb0e90c2bf4a3383eb05f89f : 72 + 0x2c]
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     rbx = 0x000000010e2030b0   rbp = 0x00007ffee1fc3730
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3700   r12 = 0x0000000000000000
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     r13 = 0x0000000000000000   r14 = 0x00007ffee1fc3758
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     r15 = 0x000000000000001e   rip = 0x000000010dc3bf43
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO - 22  libdyld.dylib!start + 0x0
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     rbx = 0x0000000000000000   rbp = 0x00007ffee1fc3748
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3740   r12 = 0x0000000000000000
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     r13 = 0x0000000000000000   r14 = 0x0000000000000000
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     r15 = 0x0000000000000000   rip = 0x00007fff70fddcc9
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO - 23  libdyld.dylib!start + 0x0
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     rbx = 0x0000000000000000   rbp = 0x00007ffee1fc3748
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     rsp = 0x00007ffee1fc3748   r12 = 0x0000000000000000
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     r13 = 0x0000000000000000   r14 = 0x0000000000000000
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     r15 = 0x0000000000000000   rip = 0x00007fff70fddcc9
[task 2022-01-16T12:17:21.749Z] 12:17:21     INFO -     Found by: call frame info
[task 2022-01-16T12:17:21.750Z] 12:17:21     INFO -
Regressed by: 1747422
See Also: 1747422 →
Has Regression Range: --- → yes

Set release status flags based on info from the regressing bug 1747422

status-firefox96: --- → unaffected
status-firefox97: --- → unaffected
status-firefox98: --- → affected
status-firefox-esr91: --- → unaffected

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.