Closed
Bug 1732818
Opened 3 years ago
Closed 3 years ago
Perma Last test finished | application crashed [@ nsDebugImpl::Abort(char const*, int)] AFTER FATAL ERROR: AsyncShutdown timeout in ShutdownLeaks: Wait for cleanup to be finished before checking for leaks Conditions
Categories
(Testing :: Mochitest, defect, P3)
Testing
Mochitest
Tracking
(Fission Milestone:Future, firefox-esr78 unaffected, firefox-esr91 unaffected, firefox92 unaffected, firefox93 unaffected, firefox94 wontfix, firefox95 wontfix, firefox96 fixed)
| Tracking | Status | |
|---|---|---|
| firefox-esr78 | --- | unaffected |
| firefox-esr91 | --- | unaffected |
| firefox92 | --- | unaffected |
| firefox93 | --- | unaffected |
| firefox94 | --- | wontfix |
| firefox95 | --- | wontfix |
| firefox96 | --- | fixed |
People
(Reporter: intermittent-bug-filer, Assigned: nika)
References
(Regression)
Details
(Keywords: intermittent-failure, regression, Whiteboard: [fission:m95] [fission:m96])
Attachments
(3 files)
Filed by: ccozmuta [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=352876587&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/FURIgZsHRaOrdAaGQZw8AA/runs/0/artifacts/public/logs/live_backing.log
[task 2021-09-27T23:25:17.728Z] 23:25:17 INFO - TEST-OK | browser/components/sessionstore/test/browser_windowStateContainer.js | took 8871ms
[task 2021-09-27T23:25:17.734Z] 23:25:17 INFO - GECKO(3745) | [Child 4189: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 11c228800 == 4 [pid = 4189] [id = 41]
[task 2021-09-27T23:25:17.734Z] 23:25:17 INFO - GECKO(3745) | [Child 4189: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 19 (11bd1e740) [pid = 4189] [serial = 95] [outer = 0]
[task 2021-09-27T23:25:17.735Z] 23:25:17 INFO - GECKO(3745) | [Child 4189: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 20 (11c22a800) [pid = 4189] [serial = 96] [outer = 11bd1e740]
[task 2021-09-27T23:25:17.739Z] 23:25:17 INFO - GECKO(3745) | [Child 4440, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-27T23:25:17.746Z] 23:25:17 INFO - GECKO(3745) | [Child 4440: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 112dd7400 == 0 [pid = 4440] [id = 0] [url = http://example.com/]
[task 2021-09-27T23:25:17.751Z] 23:25:17 INFO - checking window state
<...>
[task 2021-09-27T23:26:18.911Z] 23:26:18 INFO - GECKO(3745) | FATAL ERROR: AsyncShutdown timeout in ShutdownLeaks: Wait for cleanup to be finished before checking for leaks Conditions: [{"name":"ShutdownLeaks: Wait for tabs to finish closing","state":"(none)","filename":"chrome://mochikit/content/browser-test.js","lineNumber":900,"stack":["chrome://mochikit/content/browser-test.js:nextTest/<:900","chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041"]}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources.
[task 2021-09-27T23:26:18.911Z] 23:26:18 INFO - GECKO(3745) | [Parent 3745, Main Thread] ###!!! ABORT: file chrome://mochikit/content/browser-test.js:900
[task 2021-09-27T23:26:18.912Z] 23:26:18 INFO - GECKO(3745) | #01: NS_DebugBreak [xpcom/base/nsDebugImpl.cpp:401]
[task 2021-09-27T23:26:18.912Z] 23:26:18 INFO - GECKO(3745) | #02: nsDebugImpl::Abort(char const*, int) [xpcom/base/nsDebugImpl.cpp:135]
[task 2021-09-27T23:26:18.913Z] 23:26:18 INFO - GECKO(3745) | #03: NS_InvokeByIndex [/opt/worker/tasks/task_163278081583826/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x1dc5ae]
[task 2021-09-27T23:26:18.913Z] 23:26:18 INFO - GECKO(3745) | XPCOM_MEM_BLOAT_LOG: /var/folders/p4/_gm58y794639164h1xnkpyyw000014/T/tmpiiz2t0q5.mozrunner/runtests_leaks.log
[task 2021-09-27T23:26:18.913Z] 23:26:18 INFO - GECKO(3745) | Writing to log: /var/folders/p4/_gm58y794639164h1xnkpyyw000014/T/tmpiiz2t0q5.mozrunner/runtests_leaks.log
[task 2021-09-27T23:26:18.914Z] 23:26:18 INFO - GECKO(3745) | [Parent 3745, Main Thread] ###!!! ABORT: file chrome://mochikit/content/browser-test.js:900
[task 2021-09-27T23:26:18.914Z] 23:26:18 INFO - GECKO(3745) | Hit MOZ_CRASH() at /builds/worker/checkouts/gecko/memory/mozalloc/mozalloc_abort.cpp:33
[task 2021-09-27T23:26:18.954Z] 23:26:18 INFO - GECKO(3745) | #01: mozalloc_abort [memory/mozalloc/mozalloc_abort.cpp:33]
[task 2021-09-27T23:26:18.955Z] 23:26:18 INFO - GECKO(3745) | #02: Abort(char const*) [/opt/worker/tasks/task_163278081583826/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x75e8e]
[task 2021-09-27T23:26:18.955Z] 23:26:18 INFO - GECKO(3745) | #03: NS_DebugBreak [xpcom/base/nsDebugImpl.cpp:417]
[task 2021-09-27T23:26:18.955Z] 23:26:18 INFO - GECKO(3745) | #04: nsDebugImpl::Abort(char const*, int) [xpcom/base/nsDebugImpl.cpp:135]
[task 2021-09-27T23:26:18.956Z] 23:26:18 INFO - GECKO(3745) | #05: NS_InvokeByIndex [/opt/worker/tasks/task_163278081583826/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x1dc5ae]
<...>
[task 2021-09-27T23:26:19.119Z] 23:26:19 INFO - TEST-INFO | Main app process: exit 1
[task 2021-09-27T23:26:19.120Z] 23:26:19 ERROR - TEST-UNEXPECTED-FAIL | ShutdownLeaks | process() called before end of test suite
[task 2021-09-27T23:26:19.120Z] 23:26:19 INFO - TEST-INFO | Confirming we saw 1942 DOCSHELL created and 1876 destroyed log strings.
[task 2021-09-27T23:26:19.120Z] 23:26:19 INFO - TEST-INFO | Confirming we saw 4929 DOMWINDOW created and 4708 destroyed log strings.
[task 2021-09-27T23:26:19.121Z] 23:26:19 INFO - Buffered messages finished
[task 2021-09-27T23:26:19.121Z] 23:26:19 ERROR - TEST-UNEXPECTED-FAIL | Last test finished | application terminated with exit code 1
<...>
[task 2021-09-27T23:26:19.434Z] 23:26:19 INFO - zombiecheck | Checking for orphan process with PID: 4095
[task 2021-09-27T23:26:19.435Z] 23:26:19 INFO - mozcrash Copy/paste: /opt/worker/tasks/task_163278081583826/fetches/minidump_stackwalk/minidump_stackwalk /var/folders/p4/_gm58y794639164h1xnkpyyw000014/T/tmpiiz2t0q5.mozrunner/minidumps/E6AA4332-E2EA-4A03-84D4-8D42899DDE11.dmp /opt/worker/tasks/task_163278081583826/build/symbols
[task 2021-09-27T23:26:25.227Z] 23:26:25 INFO - mozcrash Saved minidump as /opt/worker/tasks/task_163278081583826/build/blobber_upload_dir/E6AA4332-E2EA-4A03-84D4-8D42899DDE11.dmp
[task 2021-09-27T23:26:25.227Z] 23:26:25 INFO - mozcrash Saved app info as /opt/worker/tasks/task_163278081583826/build/blobber_upload_dir/E6AA4332-E2EA-4A03-84D4-8D42899DDE11.extra
[task 2021-09-27T23:26:25.639Z] 23:26:25 INFO - PROCESS-CRASH | Last test finished | application crashed [@ nsDebugImpl::Abort(char const*, int)]
[task 2021-09-27T23:26:25.639Z] 23:26:25 INFO - Mozilla crash reason: MOZ_CRASH()
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•3 years ago
|
||
Nika , this fail is regressed by 1732818.
Can you please take a look?
Flags: needinfo?(nika)
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
||
Updated•3 years ago
|
Summary: Perma [Tier 2 ] FATAL ERROR: AsyncShutdown timeout in ShutdownLeaks: Wait for cleanup to be finished before checking for leaks Conditions: [{"name":"ShutdownLeaks: Wait for tabs to finish closing","state":"(none)","filename":"chrome://mochikit/content/br → Perma [Tier 2 ] Last test finished | application crashed [@ nsDebugImpl::Abort(char const*, int)] AFTER FATAL ERROR: AsyncShutdown timeout in ShutdownLeaks: Wait for cleanup to be finished before checking for leaks Conditions
|
|
||
Updated•3 years ago
|
Summary: Perma [Tier 2 ] Last test finished | application crashed [@ nsDebugImpl::Abort(char const*, int)] AFTER FATAL ERROR: AsyncShutdown timeout in ShutdownLeaks: Wait for cleanup to be finished before checking for leaks Conditions → Perma Last test finished | application crashed [@ nsDebugImpl::Abort(char const*, int)] AFTER FATAL ERROR: AsyncShutdown timeout in ShutdownLeaks: Wait for cleanup to be finished before checking for leaks Conditions
| Comment hidden (Intermittent Failures Robot) |
|
||
Updated•3 years ago
|
Fission Milestone: --- → ?
status-firefox92:
--- → unaffected
status-firefox93:
--- → unaffected
status-firefox94:
--- → affected
status-firefox95:
--- → affected
status-firefox-esr78:
--- → unaffected
status-firefox-esr91:
--- → unaffected
| Comment hidden (Intermittent Failures Robot) |
|
||
Updated•3 years ago
|
Keywords: regression
|
Assignee | |
Comment 8•3 years ago
|
||
I've tried adding various pieces of logging to the related code to try to figure out what's happened. From this log, I'm seeing these 8 message-managers are being closed, but not fully destroying: https://treeherder.mozilla.org/logviewer?job_id=353754576&repo=try&lineNumber=48247
GECKO(3524) | message-manager-close called [1193] {"remoteType":"","existing":false,"count":0}
GECKO(3524) | message-manager-close called [1198] {"remoteType":"","existing":false,"count":1}
GECKO(3524) | message-manager-close called [1204] {"remoteType":"","existing":false,"count":2}
GECKO(3524) | message-manager-close called [1210] {"remoteType":"","existing":false,"count":3}
GECKO(3524) | message-manager-close called [1219] {"remoteType":"","existing":false,"count":4}
GECKO(3524) | message-manager-close called [1231] {"remoteType":"","existing":false,"count":5}
GECKO(3524) | message-manager-close called [1236] {"remoteType":"","existing":false,"count":6}
GECKO(3524) | message-manager-close called [1252] {"remoteType":"","existing":false,"count":7}
It seems from a quick look that this is related to process crashes in some way, but I don't quite know which way yet.
Flags: needinfo?(nika)
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 16•3 years ago
|
||
Hi Nika, this is a tier1 perma failure with 296 total occurences in the last 7 days. Is there a next step here?
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=354480392&repo=mozilla-central&lineNumber=94128
[task 2021-10-12T10:13:58.953Z] 10:13:58 INFO - TEST-START | browser/components/sessionstore/test/browser_windowStateContainer.js
[task 2021-10-12T10:13:58.982Z] 10:13:58 INFO - GECKO(3285) | [Parent 3285: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 139d0f400 == 23 [pid = 3285] [id = 429]
[task 2021-10-12T10:13:58.983Z] 10:13:58 INFO - GECKO(3285) | [Parent 3285: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 69 (129af8740) [pid = 3285] [serial = 1058] [outer = 0]
[...]
[task 2021-10-12T10:14:26.322Z] 10:14:26 INFO - GECKO(3285) | [Child 3732: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (126413400) [pid = 3732] [serial = 42] [outer = 0] [url = about:blank]
[task 2021-10-12T10:15:09.479Z] 10:15:09 INFO - GECKO(3285) | FATAL ERROR: AsyncShutdown timeout in ShutdownLeaks: Wait for cleanup to be finished before checking for leaks Conditions: [{"name":"ShutdownLeaks: Wait for tabs to finish closing","state":"(none)","filename":"chrome://mochikit/content/browser-test.js","lineNumber":900,"stack":["chrome://mochikit/content/browser-test.js:nextTest/<:900","chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041"]}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources.
[task 2021-10-12T10:15:09.479Z] 10:15:09 INFO - GECKO(3285) | [Parent 3285, Main Thread] ###!!! ABORT: file chrome://mochikit/content/browser-test.js:900
[task 2021-10-12T10:15:09.479Z] 10:15:09 INFO - GECKO(3285) | #01: NS_DebugBreak [xpcom/base/nsDebugImpl.cpp:401]
[task 2021-10-12T10:15:09.480Z] 10:15:09 INFO - GECKO(3285) | #02: nsDebugImpl::Abort(char const*, int) [xpcom/base/nsDebugImpl.cpp:135]
[task 2021-10-12T10:15:09.480Z] 10:15:09 INFO - GECKO(3285) | #03: NS_InvokeByIndex [/opt/worker/tasks/task_163403121646802/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x1df6ae]
[task 2021-10-12T10:15:09.480Z] 10:15:09 INFO - GECKO(3285) | XPCOM_MEM_BLOAT_LOG: /var/folders/7v/dcnsqn7d4_n12ksv589pxvz0000014/T/tmpwj7izo3k.mozrunner/runtests_leaks.log
[task 2021-10-12T10:15:09.481Z] 10:15:09 INFO - GECKO(3285) | Writing to log: /var/folders/7v/dcnsqn7d4_n12ksv589pxvz0000014/T/tmpwj7izo3k.mozrunner/runtests_leaks.log
[task 2021-10-12T10:15:09.481Z] 10:15:09 INFO - GECKO(3285) | [Parent 3285, Main Thread] ###!!! ABORT: file chrome://mochikit/content/browser-test.js:900
[task 2021-10-12T10:15:09.481Z] 10:15:09 INFO - GECKO(3285) | Hit MOZ_CRASH() at /builds/worker/checkouts/gecko/memory/mozalloc/mozalloc_abort.cpp:33
[task 2021-10-12T10:15:09.522Z] 10:15:09 INFO - GECKO(3285) | #01: mozalloc_abort [memory/mozalloc/mozalloc_abort.cpp:33]
[task 2021-10-12T10:15:09.522Z] 10:15:09 INFO - GECKO(3285) | #02: Abort(char const*) [/opt/worker/tasks/task_163403121646802/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x76afe]
[task 2021-10-12T10:15:09.523Z] 10:15:09 INFO - GECKO(3285) | #03: NS_DebugBreak [xpcom/base/nsDebugImpl.cpp:417]
[task 2021-10-12T10:15:09.523Z] 10:15:09 INFO - GECKO(3285) | #04: nsDebugImpl::Abort(char const*, int) [xpcom/base/nsDebugImpl.cpp:135]
[task 2021-10-12T10:15:09.524Z] 10:15:09 INFO - GECKO(3285) | #05: NS_InvokeByIndex [/opt/worker/tasks/task_163403121646802/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x1df6ae]
[task 2021-10-12T10:15:09.635Z] 10:15:09 INFO - GECKO(3285) | [Child 3599, IPC I/O Child] WARNING: [60B319F1F6F0A6D2.E6C4DB5723DB6247]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.636Z] 10:15:09 INFO - GECKO(3285) | [Child 3599, IPC I/O Child] WARNING: [60B319F1F6F0A6D2.E6C4DB5723DB6247]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.637Z] 10:15:09 INFO - GECKO(3285) | [Child 3599, IPC I/O Child] WARNING: [60B319F1F6F0A6D2.E6C4DB5723DB6247]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.639Z] 10:15:09 INFO - GECKO(3285) | [Child 3599, IPC I/O Child] WARNING: [60B319F1F6F0A6D2.E6C4DB5723DB6247]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.639Z] 10:15:09 INFO - GECKO(3285) | [Child 3599, IPC I/O Child] WARNING: [60B319F1F6F0A6D2.E6C4DB5723DB6247]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.640Z] 10:15:09 INFO - GECKO(3285) | [Child 3971, IPC I/O Child] WARNING: [A8CAA56FE964D55C.5C69226B30538638]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.641Z] 10:15:09 INFO - GECKO(3285) | [Child 3599, IPC I/O Child] WARNING: [60B319F1F6F0A6D2.E6C4DB5723DB6247]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.642Z] 10:15:09 INFO - GECKO(3285) | [Child 3735, IPC I/O Child] WARNING: [54E3A405D0F784AB.B8DB6EA95D6A0023]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.643Z] 10:15:09 INFO - GECKO(3285) | [Child 3971, IPC I/O Child] WARNING: [A8CAA56FE964D55C.5C69226B30538638]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.643Z] 10:15:09 INFO - GECKO(3285) | [Child 3599, IPC I/O Child] WARNING: [60B319F1F6F0A6D2.E6C4DB5723DB6247]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.644Z] 10:15:09 INFO - GECKO(3285) | [Child 3735, IPC I/O Child] WARNING: [54E3A405D0F784AB.B8DB6EA95D6A0023]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.645Z] 10:15:09 INFO - GECKO(3285) | [Child 3970, IPC I/O Child] WARNING: [305B4773AAEB5E4A.D8A64A26768DC015]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.646Z] 10:15:09 INFO - GECKO(3285) | [Child 3971, IPC I/O Child] WARNING: [A8CAA56FE964D55C.5C69226B30538638]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.646Z] 10:15:09 INFO - GECKO(3285) | [Child 3971, IPC I/O Child] WARNING: [A8CAA56FE964D55C.5C69226B30538638]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.647Z] 10:15:09 INFO - GECKO(3285) | [Child 3732, IPC I/O Child] WARNING: [6CBFDFD56059C909.C4CA221C623D73E2]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.647Z] 10:15:09 INFO - GECKO(3285) | [Child 3970, IPC I/O Child] WARNING: [305B4773AAEB5E4A.D8A64A26768DC015]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.648Z] 10:15:09 INFO - GECKO(3285) | [Child 3971, IPC I/O Child] WARNING: [A8CAA56FE964D55C.5C69226B30538638]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.648Z] 10:15:09 INFO - GECKO(3285) | [Child 3599, IPC I/O Child] WARNING: [60B319F1F6F0A6D2.E6C4DB5723DB6247]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.648Z] 10:15:09 INFO - GECKO(3285) | [Child 3733, IPC I/O Child] WARNING: [D809C985FAC0B16C.AAB372CB66445904]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.649Z] 10:15:09 INFO - GECKO(3285) | [Child 3970, IPC I/O Child] WARNING: [305B4773AAEB5E4A.D8A64A26768DC015]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.649Z] 10:15:09 INFO - GECKO(3285) | [Child 3527, IPC I/O Child] WARNING: [1664D7864D4583EC.1019561A37128E1B]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.650Z] 10:15:09 INFO - GECKO(3285) | [Child 3971, IPC I/O Child] WARNING: [A8CAA56FE964D55C.5C69226B30538638]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.650Z] 10:15:09 INFO - GECKO(3285) | [Child 3732, IPC I/O Child] WARNING: [6CBFDFD56059C909.C4CA221C623D73E2]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.651Z] 10:15:09 INFO - GECKO(3285) | [Child 3970, IPC I/O Child] WARNING: [305B4773AAEB5E4A.D8A64A26768DC015]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.651Z] 10:15:09 INFO - GECKO(3285) | [Child 3599, IPC I/O Child] WARNING: [60B319F1F6F0A6D2.E6C4DB5723DB6247]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.651Z] 10:15:09 INFO - GECKO(3285) | [Child 3287, IPC I/O Child] WARNING: [3C7DB980E93A5CAB.D4D84FC6EDF9B35]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.652Z] 10:15:09 INFO - GECKO(3285) | [Child 3971, IPC I/O Child] WARNING: [A8CAA56FE964D55C.5C69226B30538638]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.652Z] 10:15:09 INFO - GECKO(3285) | [Child 3970, IPC I/O Child] WARNING: [305B4773AAEB5E4A.D8A64A26768DC015]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.653Z] 10:15:09 INFO - GECKO(3285) | [Child 3527, IPC I/O Child] WARNING: [1664D7864D4583EC.1019561A37128E1B]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.653Z] 10:15:09 INFO - GECKO(3285) | [Child 3287, IPC I/O Child] WARNING: [3C7DB980E93A5CAB.D4D84FC6EDF9B35]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.653Z] 10:15:09 INFO - GECKO(3285) | [Child 3732, IPC I/O Child] WARNING: [6CBFDFD56059C909.C4CA221C623D73E2]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.654Z] 10:15:09 INFO - GECKO(3285) | [Child 3972, IPC I/O Child] WARNING: [D24560864676F15B.A6822FE07743A7E2]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.654Z] 10:15:09 INFO - GECKO(3285) | [Child 3971, IPC I/O Child] WARNING: [A8CAA56FE964D55C.5C69226B30538638]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.654Z] 10:15:09 INFO - GECKO(3285) | [Child 3733, IPC I/O Child] WARNING: [D809C985FAC0B16C.AAB372CB66445904]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.655Z] 10:15:09 INFO - GECKO(3285) | [Child 3599, IPC I/O Child] WARNING: [60B319F1F6F0A6D2.E6C4DB5723DB6247]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.655Z] 10:15:09 INFO - GECKO(3285) | Exiting due to channel error.
[...]
[task 2021-10-12T10:15:09.685Z] 10:15:09 INFO - GECKO(3285) | Exiting due to channel error.
[task 2021-10-12T10:15:09.685Z] 10:15:09 INFO - GECKO(3285) | [Child 3527, IPC I/O Child] WARNING: [1664D7864D4583EC.1019561A37128E1B]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.686Z] 10:15:09 INFO - GECKO(3285) | [Child 3527, IPC I/O Child] WARNING: [1664D7864D4583EC.1019561A37128E1B]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.686Z] 10:15:09 INFO - GECKO(3285) | [Child 3527, IPC I/O Child] WARNING: [1664D7864D4583EC.1019561A37128E1B]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.687Z] 10:15:09 INFO - GECKO(3285) | [Child 3527, IPC I/O Child] WARNING: [1664D7864D4583EC.1019561A37128E1B]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-12T10:15:09.687Z] 10:15:09 INFO - GECKO(3285) | Exiting due to channel error.
[task 2021-10-12T10:15:09.687Z] 10:15:09 INFO - TEST-INFO | Main app process: exit 1
[task 2021-10-12T10:15:09.688Z] 10:15:09 ERROR - TEST-UNEXPECTED-FAIL | ShutdownLeaks | process() called before end of test suite
[task 2021-10-12T10:15:09.688Z] 10:15:09 INFO - TEST-INFO | Confirming we saw 1945 DOCSHELL created and 1883 destroyed log strings.
[task 2021-10-12T10:15:09.688Z] 10:15:09 INFO - TEST-INFO | Confirming we saw 4939 DOMWINDOW created and 4735 destroyed log strings.
[task 2021-10-12T10:15:09.689Z] 10:15:09 INFO - Buffered messages finished
[task 2021-10-12T10:15:09.689Z] 10:15:09 ERROR - TEST-UNEXPECTED-FAIL | Last test finished | application terminated with exit code 1
[task 2021-10-12T10:15:09.689Z] 10:15:09 INFO - runtests.py | Application ran for: 0:08:02.764118
[...]
[task 2021-10-12T10:15:09.988Z] 10:15:09 INFO - mozcrash Copy/paste: /opt/worker/tasks/task_163403121646802/fetches/minidump_stackwalk/minidump_stackwalk /var/folders/7v/dcnsqn7d4_n12ksv589pxvz0000014/T/tmpwj7izo3k.mozrunner/minidumps/2A4B1AD0-3D71-4DDE-96E6-BD556953E374.dmp /opt/worker/tasks/task_163403121646802/build/symbols
[task 2021-10-12T10:15:16.240Z] 10:15:16 INFO - mozcrash Saved minidump as /opt/worker/tasks/task_163403121646802/build/blobber_upload_dir/2A4B1AD0-3D71-4DDE-96E6-BD556953E374.dmp
[task 2021-10-12T10:15:16.240Z] 10:15:16 INFO - mozcrash Saved app info as /opt/worker/tasks/task_163403121646802/build/blobber_upload_dir/2A4B1AD0-3D71-4DDE-96E6-BD556953E374.extra
[task 2021-10-12T10:15:16.656Z] 10:15:16 INFO - PROCESS-CRASH | Last test finished | application crashed [@ nsDebugImpl::Abort(char const*, int)]
[task 2021-10-12T10:15:16.656Z] 10:15:16 INFO - Mozilla crash reason: MOZ_CRASH()
[task 2021-10-12T10:15:16.656Z] 10:15:16 INFO - Crash dump filename: /var/folders/7v/dcnsqn7d4_n12ksv589pxvz0000014/T/tmpwj7izo3k.mozrunner/minidumps/2A4B1AD0-3D71-4DDE-96E6-BD556953E374.dmp
[task 2021-10-12T10:15:16.656Z] 10:15:16 INFO - Operating system: Mac OS X
[task 2021-10-12T10:15:16.656Z] 10:15:16 INFO - 10.15.7 19H524
[task 2021-10-12T10:15:16.656Z] 10:15:16 INFO - CPU: amd64
[task 2021-10-12T10:15:16.656Z] 10:15:16 INFO - family 6 model 158 stepping 10
[task 2021-10-12T10:15:16.656Z] 10:15:16 INFO - 12 CPUs
[task 2021-10-12T10:15:16.656Z] 10:15:16 INFO -
[task 2021-10-12T10:15:16.656Z] 10:15:16 INFO - GPU: UNKNOWN
[task 2021-10-12T10:15:16.656Z] 10:15:16 INFO -
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - Crash reason: EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - Crash address: 0x0
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - Process uptime: 483 seconds
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO -
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - Thread 0 tid 775 (crashed) - GeckoMain 0 libmozglue.dylib!mozalloc_abort [mozalloc_abort.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 33 + 0x16]
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rax = 0x000000010db7fa46 rdx = 0x0000000000000000
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rcx = 0x000000010db94458 rbx = 0x00007fff949ac620
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rsi = 0x00000000000120a8 rdi = 0x00007fff949abca8
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rbp = 0x00007ffee2129890 rsp = 0x00007ffee2129880
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r8 = 0x00000000000130a8 r9 = 0x0000000000000000
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r10 = 0x00007fff949abcc8 r11 = 0x00007fff949abcc0
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r12 = 0x00007ffee21298e0 r13 = 0x0000000124871700
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r14 = 0x00007ffee2129900 r15 = 0x00007ffee2129c10
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rip = 0x000000010db04a3a
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - Found by: given as instruction pointer in context
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - 1 XUL!Abort(char const*) [nsDebugImpl.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 452 + 0x8]
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rbx = 0x00007ffee2129900 rbp = 0x00007ffee21298b0
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rsp = 0x00007ffee21298a0 r12 = 0x00007ffee21298e0
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r13 = 0x0000000124871700 r14 = 0x00007ffee2129900
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r15 = 0x00007ffee2129c10 rip = 0x0000000111d0dafe
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - 2 XUL!NS_DebugBreak [nsDebugImpl.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 401 + 0x23]
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rbx = 0x00007ffee21298d0 rbp = 0x00007ffee2129f40
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rsp = 0x00007ffee21298c0 r12 = 0x00007ffee21298e0
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r13 = 0x0000000124871700 r14 = 0x00007ffee2129900
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r15 = 0x00007ffee2129c10 rip = 0x0000000111d0d82b
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - 3 XUL!nsDebugImpl::Abort(char const*, int) [nsDebugImpl.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 134 + 0xe]
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffee2129f50
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rsp = 0x00007ffee2129f50 r12 = 0x00000001249979e0
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r13 = 0x0000000000000009 r14 = 0x00007ffee2129ff8
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r15 = 0x0000000000000001 rip = 0x0000000111d0d908
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - 4 XUL!NS_InvokeByIndex + 0x8e
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffee2129f80
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - rsp = 0x00007ffee2129f60 r12 = 0x00000001249979e0
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r13 = 0x0000000000000009 r14 = 0x00007ffee2129ff8
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - r15 = 0x0000000000000001 rip = 0x0000000111e766ae
[task 2021-10-12T10:15:16.657Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - 5 XUL!CallMethodHelper::Call() [XPCWrappedNative.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 1184 + 0x18]
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffee2129fd0
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rsp = 0x00007ffee2129f90 r12 = 0x0000000000000000
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r13 = 0x0000000000000002 r14 = 0x00007ffee2129ff8
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r15 = 0x0000000000000001 rip = 0x0000000112c25790
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - 6 XUL!XPCWrappedNative::CallMethod(XPCCallContext&, XPCWrappedNative::CallMode) [XPCWrappedNative.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 1130 + 0x8]
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rbx = 0x00007ffee212a1b0 rbp = 0x00007ffee212a140
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rsp = 0x00007ffee2129fe0 r12 = 0x000000011be82940
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r13 = 0x0000000124726000 r14 = 0x00007ffee2129fe8
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r15 = 0x00007ffee2129ff8 rip = 0x0000000112c25339
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - 7 XUL!XPC_WN_CallMethod(JSContext*, unsigned int, JS::Value*) [XPCWrappedNativeJSOps.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 921 + 0x8]
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rbx = 0x00007ffee212a1b0 rbp = 0x00007ffee212a280
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rsp = 0x00007ffee212a150 r12 = 0x00000d09131647b8
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r13 = 0x0000000124726000 r14 = 0x00000001247590b8
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r15 = 0x00007ffee212a168 rip = 0x0000000112c271f4
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - 8 XUL!CallJSNative(JSContext*, bool (*)(JSContext*, unsigned int, JS::Value*), js::CallReason, JS::CallArgs const&) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 385 + 0x12]
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rbx = 0x0000000124709400 rbp = 0x00007ffee212a310
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rsp = 0x00007ffee212a290 r12 = 0x000000011c485ff0
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r13 = 0x00007ffee212a590 r14 = 0x0000000124726000
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r15 = 0x0000000112c26e40 rip = 0x0000000117a2722c
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - 9 XUL!js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 472 + 0x14]
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rbx = 0x0000000112c26e40 rbp = 0x00007ffee212a3c0
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rsp = 0x00007ffee212a320 r12 = 0x00007ffee212a340
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r13 = 0x00007ffee212a590 r14 = 0x0000000124726000
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r15 = 0xffff800000000000 rip = 0x0000000117a269be
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - 10 XUL!InternalCall(JSContext*, js::AnyInvokeArgs const&, js::CallReason) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 532 + 0x10]
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rbx = 0x00007ffee212a590 rbp = 0x00007ffee212a420
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - rsp = 0x00007ffee212a3d0 r12 = 0x00000001247590b8
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r13 = 0x000000011c1e4a60 r14 = 0x0000000000000000
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - r15 = 0x0000000124726000 rip = 0x0000000117a27cad
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.658Z] 10:15:16 INFO - 11 XUL!Interpret(JSContext*, js::RunState&) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 3239 + 0xa]
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rbx = 0x000000011c1d5680 rbp = 0x00007ffee212a8f0
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rsp = 0x00007ffee212a430 r12 = 0xfff9800000000000
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r13 = 0x000000011c485ff0 r14 = 0x0000000000000000
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r15 = 0x0000000124726000 rip = 0x0000000117a1bafd
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - 12 XUL!js::RunScript(JSContext*, js::RunState&) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 354 + 0xb]
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rbx = 0x000000011c485ff0 rbp = 0x00007ffee212a950
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rsp = 0x00007ffee212a900 r12 = 0x0000000124726000
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r13 = 0x00007ffee212aa00 r14 = 0x00007ffee212a9a0
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r15 = 0x0000024790ccea28 rip = 0x0000000117a13307
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - 13 XUL!js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 504 + 0x8]
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rbx = 0x000014de3b982430 rbp = 0x00007ffee212aa00
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rsp = 0x00007ffee212a960 r12 = 0x00007ffee212a980
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r13 = 0x00007ffee212aa90 r14 = 0x0000000124726000
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r15 = 0x0000000000000000 rip = 0x0000000117a268bd
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - 14 XUL!InternalCall(JSContext*, js::AnyInvokeArgs const&, js::CallReason) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 532 + 0x10]
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rbx = 0x00007ffee212aa90 rbp = 0x00007ffee212aa60
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rsp = 0x00007ffee212aa10 r12 = 0x00007ffee212aac8
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r13 = 0x0000000124726000 r14 = 0x0000000000000000
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r15 = 0x0000000124726000 rip = 0x0000000117a27cad
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - 15 XUL!js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>, js::CallReason) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 549 + 0xb]
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rbx = 0x00007ffee212aa90 rbp = 0x00007ffee212aa80
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rsp = 0x00007ffee212aa70 r12 = 0x00007ffee212abf0
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r13 = 0x0000000124726000 r14 = 0x00007ffee212abb8
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r15 = 0x000000011b12ee60 rip = 0x0000000117a27ea0
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - 16 XUL!js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::MutableHandle<JS::Value>) [Interpreter.h:d51a3f4602303979556ca1962d0fb271304e86fc : 106 + 0x14]
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rbx = 0x00007ffee212abd0 rbp = 0x00007ffee212ab00
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rsp = 0x00007ffee212aa90 r12 = 0x00007ffee212abf0
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r13 = 0x0000000124726000 r14 = 0x00007ffee212abb8
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r15 = 0x000000011b12ee60 rip = 0x0000000117a83bee
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - 17 XUL!PromiseReactionJob(JSContext*, unsigned int, JS::Value*) [Promise.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 2211 + 0x27]
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rbx = 0x000014de3b982430 rbp = 0x00007ffee212ac50
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - rsp = 0x00007ffee212ab10 r12 = 0xffff800000000000
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r13 = 0x000000011c1e49f0 r14 = 0x00007ffee212abf0
[task 2021-10-12T10:15:16.659Z] 10:15:16 INFO - r15 = 0x00007ffee212abb8 rip = 0x0000000117cb3e24
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - 18 XUL!CallJSNative(JSContext*, bool (*)(JSContext*, unsigned int, JS::Value*), js::CallReason, JS::CallArgs const&) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 385 + 0x12]
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rbx = 0x0000000124709400 rbp = 0x00007ffee212ace0
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rsp = 0x00007ffee212ac60 r12 = 0x000000011c485ff0
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - r13 = 0x00007ffee212ae50 r14 = 0x0000000124726000
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - r15 = 0x0000000117cb28c0 rip = 0x0000000117a2722c
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - 19 XUL!js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 472 + 0x14]
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rbx = 0x0000000117cb28c0 rbp = 0x00007ffee212ad90
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rsp = 0x00007ffee212acf0 r12 = 0x00007ffee212ad10
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - r13 = 0x00007ffee212ae50 r14 = 0x0000000124726000
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - r15 = 0xffff800000000000 rip = 0x0000000117a269be
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - 20 XUL!InternalCall(JSContext*, js::AnyInvokeArgs const&, js::CallReason) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 532 + 0x10]
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rbx = 0x00007ffee212ae50 rbp = 0x00007ffee212adf0
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rsp = 0x00007ffee212ada0 r12 = 0x00007ffee212aeb0
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - r13 = 0x00007ffee212afc0 r14 = 0x0000000000000000
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - r15 = 0x0000000124726000 rip = 0x0000000117a27cad
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - 21 XUL!js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>, js::CallReason) [Interpreter.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 549 + 0xb]
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rbx = 0x00007ffee212ae50 rbp = 0x00007ffee212ae10
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rsp = 0x00007ffee212ae00 r12 = 0x00007ffee212afb0
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - r13 = 0x00007ffee212afc0 r14 = 0x00007ffee212afe8
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - r15 = 0x0000000124726000 rip = 0x0000000117a27ea0
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - 22 XUL!JS::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::HandleValueArray const&, JS::MutableHandle<JS::Value>) [CallAndConstruct.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 117 + 0x2b]
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffee212af90
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rsp = 0x00007ffee212ae20 r12 = 0x00007ffee212afb0
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - r13 = 0x00007ffee212afc0 r14 = 0x0000000000000000
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - r15 = 0x0000000124726000 rip = 0x0000000117b9e57b
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - 23 XUL!mozilla::dom::PromiseJobCallback::Call(mozilla::dom::BindingCallContext&, JS::Handle<JS::Value>, mozilla::ErrorResult&) [PromiseBinding.cpp: : 35 + 0xf]
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rbx = 0x000000011166a300 rbp = 0x00007ffee212b020
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - rsp = 0x00007ffee212afa0 r12 = 0x00007ffee212b1d8
[task 2021-10-12T10:15:16.660Z] 10:15:16 INFO - r13 = 0x00007ffee212afc0 r14 = 0x00007ffee212afd0
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r15 = 0x000000011b12ee60 rip = 0x0000000113bf2875
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - 24 XUL!mozilla::dom::PromiseJobCallback::Call(mozilla::ErrorResult&, char const*, mozilla::dom::CallbackObject::ExceptionHandling, JS::Realm*) [PromiseBinding.h: : 89 + 0x23]
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rbx = 0x000000011b44af25 rbp = 0x00007ffee212b230
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rsp = 0x00007ffee212b030 r12 = 0x0000000000000000
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r13 = 0x00007ffee212b250 r14 = 0x0000000000000000
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r15 = 0x000000011166a300 rip = 0x0000000111d2fe0a
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - 25 XUL!mozilla::PromiseJobRunnable::Run(mozilla::AutoSlowOperation&) [CycleCollectedJSContext.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 213 + 0x43]
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rbx = 0x0000000124819700 rbp = 0x00007ffee212b2a0
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rsp = 0x00007ffee212b240 r12 = 0x000000011166a300
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r13 = 0x00007ffee212b250 r14 = 0x00007ffee212b2cc
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r15 = 0x0000000000000000 rip = 0x0000000111d2f0ae
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - 26 XUL!mozilla::CycleCollectedJSContext::PerformMicroTaskCheckPoint(bool) [CycleCollectedJSContext.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 674 + 0x16]
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffee212b340
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rsp = 0x00007ffee212b2b0 r12 = 0x0000000000000000
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r13 = 0x00000001249a3000 r14 = 0x00000001249a9310
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r15 = 0x0000000000000001 rip = 0x0000000111d1b4a9
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - 27 XUL!mozilla::CycleCollectedJSContext::AfterProcessTask(unsigned int) [CycleCollectedJSContext.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 463 + 0x7]
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rbx = 0x00000001249a3000 rbp = 0x00007ffee212b360
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rsp = 0x00007ffee212b350 r12 = 0x00000001249a3000
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r13 = 0x000000010dd22660 r14 = 0x0000000000000001
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r15 = 0x0000000000000000 rip = 0x0000000111d1beaa
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - 28 XUL!XPCJSContext::AfterProcessTask(unsigned int) [XPCJSContext.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 1492 + 0xb]
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rbx = 0x00000001116f40d0 rbp = 0x00007ffee212b450
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rsp = 0x00007ffee212b370 r12 = 0x00000001249a3000
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r13 = 0x000000010dd22660 r14 = 0x0000000000000001
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r15 = 0x0000000000000000 rip = 0x0000000112be2e67
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - 29 XUL!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 1188 + 0xd]
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rbx = 0x00000001116f40d0 rbp = 0x00007ffee212b570
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - rsp = 0x00007ffee212b460 r12 = 0x0000000000000000
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r13 = 0x000000010dd22660 r14 = 0x0000000000000001
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - r15 = 0x0000000000000000 rip = 0x0000000111e3e51d
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.661Z] 10:15:16 INFO - 30 XUL!NS_ProcessPendingEvents(nsIThread*, unsigned int) [nsThreadUtils.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 432 + 0x10]
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rbx = 0x000000010dd5d7c0 rbp = 0x00007ffee212b5c0
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rsp = 0x00007ffee212b580 r12 = 0x000000010dd22660
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - r13 = 0x0000000000000000 r14 = 0x000000000000000a
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - r15 = 0x0000000000263e9a rip = 0x0000000111e3b2c7
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - 31 XUL!nsBaseAppShell::NativeEventCallback() [nsBaseAppShell.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 87 + 0x14]
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rbx = 0x000000010dd5d7c0 rbp = 0x00007ffee212b5f0
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rsp = 0x00007ffee212b5d0 r12 = 0x0000000000000000
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - r13 = 0x0000000000000000 r14 = 0x000000010dd22660
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - r15 = 0x000000010dd5d700 rip = 0x0000000115e9d3e2
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - 32 XUL!nsAppShell::ProcessGeckoEvents(void*) [nsAppShell.mm:d51a3f4602303979556ca1962d0fb271304e86fc : 500 + 0x8]
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rbx = 0x0000000115f27590 rbp = 0x00007ffee212b650
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rsp = 0x00007ffee212b600 r12 = 0x0000000000000001
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - r13 = 0x0000000000000000 r14 = 0x000000010dd5d7c0
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - r15 = 0x000000010dd5d7c0 rip = 0x0000000115f276c7
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - 33 CoreFoundation!__CFRUNLOOP_IS_CALLING_OUT_TO_A_SOURCE0_PERFORM_FUNCTION__ + 0x11
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rbx = 0x0000000115f27590 rbp = 0x00007ffee212b660
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rsp = 0x00007ffee212b660 r12 = 0x0000000000000001
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - r13 = 0x0000000000000000 r14 = 0x000000010dd5d7c0
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - r15 = 0x0000000600002e88 rip = 0x00007fff341f8d52
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - 34 CoreFoundation!__CFRunLoopDoSource0 + 0x67
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rbp = 0x00007ffee212b690 rsp = 0x00007ffee212b670
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rip = 0x00007fff341f8cf1
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - Found by: previous frame's frame pointer
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - 35 CoreFoundation!__CFRunLoopDoSources0 + 0xd1
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rbp = 0x00007ffee212b700 rsp = 0x00007ffee212b6a0
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rip = 0x00007fff341f8b0b
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - Found by: previous frame's frame pointer
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - 36 CoreFoundation!__CFRunLoopRun + 0x39f
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rbp = 0x00007ffee212c410 rsp = 0x00007ffee212b710
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - rip = 0x00007fff341f783a
[task 2021-10-12T10:15:16.662Z] 10:15:16 INFO - Found by: previous frame's frame pointer
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - 37 CoreFoundation!CFRunLoopRunSpecific + 0x1ce
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rbp = 0x00007ffee212c4a0 rsp = 0x00007ffee212c420
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rip = 0x00007fff341f6e3e
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - Found by: previous frame's frame pointer
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - 38 HIToolbox!RunCurrentEventLoopInMode + 0x124
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rbp = 0x00007ffee212c4f0 rsp = 0x00007ffee212c4b0
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rip = 0x00007fff32e23abd
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - Found by: previous frame's frame pointer
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - 39 HIToolbox!ReceiveNextEventCommon + 0x248
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rbx = 0x0000000000000001 rbp = 0x00007ffee212c570
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rsp = 0x00007ffee212c500 r12 = 0x0000000000000000
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - r13 = 0x0000000000000000 r14 = 0x0000000000000000
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - r15 = 0x00000000ffffd96d rip = 0x00007fff32e237d5
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - 40 HIToolbox!_BlockUntilNextEventMatchingListInModeWithFilter + 0x40
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rbx = 0xffffffffffffffff rbp = 0x00007ffee212c590
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rsp = 0x00007ffee212c580 r12 = 0x0000000000000001
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - r13 = 0x0000000000000000 r14 = 0x00007fff949a84c0
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - r15 = 0x00007fff8baabb00 rip = 0x00007fff32e23579
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - 41 AppKit!_DPSNextEvent + 0x373
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rbx = 0xffffffffffffffff rbp = 0x00007ffee212c990
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rsp = 0x00007ffee212c5a0 r12 = 0x0000000000000001
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - r13 = 0x0000000000000000 r14 = 0x00007fff949a84c0
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - r15 = 0x00007fff8baabb00 rip = 0x00007fff31469039
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - 42 AppKit!-[NSApplication(NSEvent) _nextEventMatchingEventMask:untilDate:inMode:dequeue:] + 0x548
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rbp = 0x00007ffee212cbf0 rsp = 0x00007ffee212c9a0
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - rip = 0x00007fff31467880
[task 2021-10-12T10:15:16.663Z] 10:15:16 INFO - Found by: previous frame's frame pointer
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - 43 XUL!-[GeckoNSApplication nextEventMatchingMask:untilDate:inMode:dequeue:] [nsAppShell.mm:d51a3f4602303979556ca1962d0fb271304e86fc : 173 + 0x29]
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - rbp = 0x00007ffee212cc50 rsp = 0x00007ffee212cc00
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - rip = 0x0000000115f26a2e
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - Found by: previous frame's frame pointer
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - 44 AppKit!-[NSApplication run] + 0x292
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - rbx = 0x000000010dd5df50 rbp = 0x00007ffee212cd10
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - rsp = 0x00007ffee212cc60 r12 = 0x000000012c348980
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - r13 = 0x00007fff6cf4a800 r14 = 0x0000000000000000
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - r15 = 0x0000000128738d30 rip = 0x00007fff3145958e
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - 45 XUL!nsAppShell::Run() [nsAppShell.mm:d51a3f4602303979556ca1962d0fb271304e86fc : 792 + 0x1a]
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - rbp = 0x00007ffee212cd60 rsp = 0x00007ffee212cd20
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - rip = 0x0000000115f27d78
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - Found by: previous frame's frame pointer
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - 46 XUL!nsAppStartup::Run() [nsAppStartup.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 295 + 0xf]
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - rbx = 0x00000001248789c0 rbp = 0x00007ffee212cd90
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - rsp = 0x00007ffee212cd70 r14 = 0x0000000000000003
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - r15 = 0x00007ffee212cfd0 rip = 0x00000001177b7b20
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.664Z] 10:15:16 INFO - 47 XUL!XREMain::XRE_mainRun() [nsAppRunner.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 5292 + 0x16]
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - rbx = 0x0000000080004005 rbp = 0x00007ffee212cf30
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - rsp = 0x00007ffee212cda0 r14 = 0x0000000000000003
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - r15 = 0x00007ffee212cfd0 rip = 0x00000001178ef35e
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - 48 XUL!XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) [nsAppRunner.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 5477 + 0x8]
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffee212cfc0
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - rsp = 0x00007ffee212cf40 r12 = 0x000000010dd8be80
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - r13 = 0x0000000000000000 r14 = 0x00007ffee212cf80
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - r15 = 0x00007ffee212cfd0 rip = 0x00000001178f09b4
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - 49 XUL!XRE_main(int, char**, mozilla::BootstrapConfig const&) [nsAppRunner.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 5536 + 0x10]
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - rbx = 0x0000000000000005 rbp = 0x00007ffee212d100
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - rsp = 0x00007ffee212cfd0 r12 = 0x00007ffee212cfd0
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - r13 = 0x00007ffee212d598 r14 = 0x00007ffee212d140
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - r15 = 0x00007ffee212d598 rip = 0x00000001178f1275
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - 50 firefox!main [nsBrowserApp.cpp:d51a3f4602303979556ca1962d0fb271304e86fc : 392 + 0x29d]
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - rbx = 0x000000010dad4331 rbp = 0x00007ffee212d570
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - rsp = 0x00007ffee212d110 r12 = 0x000001d735be5c6d
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - r13 = 0x00007ffee212d598 r14 = 0x00007ffee212d8b1
[task 2021-10-12T10:15:16.665Z] 10:15:16 INFO - r15 = 0x0000000000000005 rip = 0x000000010dad22d7
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - 51 libdyld.dylib!start + 0x1
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffee212d588
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - rsp = 0x00007ffee212d580 r12 = 0x0000000000000000
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - r13 = 0x0000000000000000 r14 = 0x0000000000000000
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - r15 = 0x0000000000000000 rip = 0x00007fff6e0ffcc9
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - Found by: call frame info
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - 52 libdyld.dylib!start + 0x1
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffee212d588
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - rsp = 0x00007ffee212d588 r12 = 0x0000000000000000
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - r13 = 0x0000000000000000 r14 = 0x0000000000000000
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - r15 = 0x0000000000000000 rip = 0x00007fff6e0ffcc9
[task 2021-10-12T10:15:16.666Z] 10:15:16 INFO - Found by: call frame info
Flags: needinfo?(nika)
|
|
||
Updated•3 years ago
|
Whiteboard: [stockwell disable-recommended] → [stockwell needswork:owner]
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 18•3 years ago
|
||
Tentatively assigning this bug to Nika because she said she's investigating.
Assignee: nobody → nika
Fission Milestone: ? → Future
Priority: P5 → P3
Whiteboard: [stockwell disable-recommended] → [stockwell disable-recommended] [fission:m95]
|
|
||
Updated•3 years ago
|
Whiteboard: [stockwell disable-recommended] [fission:m95] → [stockwell needswork:owner][fission:m95]
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Updated•3 years ago
|
Whiteboard: [fission:m95][stockwell disable-recommended] → [fission:m95][stockwell needswork:owner]
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 23•3 years ago
|
||
There are 258 total failures in the last 7 days on
- linux1804-64-ccov-qr opt
- linux1804-64-qr debug
- macosx1015-64-qr debug
- windows10-64-2004-qr debug
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=355392842&repo=mozilla-central&lineNumber=66548
[task 2021-10-19T22:34:47.885Z] 22:34:47 INFO - TEST-START | browser/components/sessionstore/test/browser_windowStateContainer.js
[task 2021-10-19T22:34:47.916Z] 22:34:47 INFO - GECKO(2973) | [Parent 2973: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 12f024800 == 23 [pid = 2973] [id = 429]
[task 2021-10-19T22:34:47.917Z] 22:34:47 INFO - GECKO(2973) | [Parent 2973: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 69 (11e504740) [pid = 2973] [serial = 1058] [outer = 0]
[task 2021-10-19T22:35:06.169Z] 22:35:06 INFO - GECKO(2973) | [Child 3277: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (11d354000) [pid = 3277] [serial = 281] [outer = 0] [url = about:blank]
[task 2021-10-19T22:35:06.958Z] 22:35:06 INFO - GECKO(2973) | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"ShutdownLeaks: Wait for tabs to finish closing","state":"(none)","filename":"chrome://mochikit/content/browser-test.js","lineNumber":900,"stack":["chrome://mochikit/content/browser-test.js:nextTest/<:900","chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041"]}] Barrier: ShutdownLeaks: Wait for cleanup to be finished before checking for leaks
[task 2021-10-19T22:35:06.958Z] 22:35:06 INFO - GECKO(2973) | [Child 3225: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (11f9e1000) [pid = 3225] [serial = 198] [outer = 0] [url = about:newtab]
[task 2021-10-19T22:35:06.959Z] 22:35:06 INFO - GECKO(2973) | [Child 3225: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (11f9e9800) [pid = 3225] [serial = 201] [outer = 0] [url = about:newtab]
[task 2021-10-19T22:35:06.959Z] 22:35:06 INFO - GECKO(2973) | [Child 3225: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (105fb9000) [pid = 3225] [serial = 3] [outer = 0] [url = about:newtab]
[task 2021-10-19T22:35:06.975Z] 22:35:06 INFO - GECKO(2973) | [Child 3410: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (1017bdc00) [pid = 3410] [serial = 37] [outer = 0] [url = about:blank]
[task 2021-10-19T22:35:08.641Z] 22:35:08 INFO - GECKO(2973) | [Parent 2973: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (161c79000) [pid = 2973] [serial = 1071] [outer = 0] [url = about:blank]
[task 2021-10-19T22:35:58.073Z] 22:35:58 INFO - GECKO(2973) | FATAL ERROR: AsyncShutdown timeout in ShutdownLeaks: Wait for cleanup to be finished before checking for leaks Conditions: [{"name":"ShutdownLeaks: Wait for tabs to finish closing","state":"(none)","filename":"chrome://mochikit/content/browser-test.js","lineNumber":900,"stack":["chrome://mochikit/content/browser-test.js:nextTest/<:900","chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041"]}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources.
[task 2021-10-19T22:35:58.073Z] 22:35:58 INFO - GECKO(2973) | [Parent 2973, Main Thread] ###!!! ABORT: file chrome://mochikit/content/browser-test.js:900
[task 2021-10-19T22:35:58.074Z] 22:35:58 INFO - GECKO(2973) | #01: NS_DebugBreak [xpcom/base/nsDebugImpl.cpp:401]
[task 2021-10-19T22:35:58.074Z] 22:35:58 INFO - GECKO(2973) | #02: nsDebugImpl::Abort(char const*, int) [xpcom/base/nsDebugImpl.cpp:135]
[task 2021-10-19T22:35:58.074Z] 22:35:58 INFO - GECKO(2973) | #03: NS_InvokeByIndex [/opt/worker/tasks/task_163468089077968/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x369abe]
[task 2021-10-19T22:35:58.075Z] 22:35:58 INFO - GECKO(2973) | XPCOM_MEM_BLOAT_LOG: /var/folders/bp/k3k6dt8x3fx19x1k7wbmf0fm000014/T/tmpja3xcy3r.mozrunner/runtests_leaks.log
[task 2021-10-19T22:35:58.075Z] 22:35:58 INFO - GECKO(2973) | Writing to log: /var/folders/bp/k3k6dt8x3fx19x1k7wbmf0fm000014/T/tmpja3xcy3r.mozrunner/runtests_leaks.log
[task 2021-10-19T22:35:58.075Z] 22:35:58 INFO - GECKO(2973) | [Parent 2973, Main Thread] ###!!! ABORT: file chrome://mochikit/content/browser-test.js:900
[task 2021-10-19T22:35:58.076Z] 22:35:58 INFO - GECKO(2973) | Hit MOZ_CRASH() at /builds/worker/checkouts/gecko/memory/mozalloc/mozalloc_abort.cpp:33
[task 2021-10-19T22:35:58.115Z] 22:35:58 INFO - GECKO(2973) | #01: mozalloc_abort [memory/mozalloc/mozalloc_abort.cpp:33]
[task 2021-10-19T22:35:58.116Z] 22:35:58 INFO - GECKO(2973) | #02: Abort(char const*) [/opt/worker/tasks/task_163468089077968/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x2002ee]
[task 2021-10-19T22:35:58.116Z] 22:35:58 INFO - GECKO(2973) | #03: NS_DebugBreak [xpcom/base/nsDebugImpl.cpp:417]
[task 2021-10-19T22:35:58.117Z] 22:35:58 INFO - GECKO(2973) | #04: nsDebugImpl::Abort(char const*, int) [xpcom/base/nsDebugImpl.cpp:135]
[task 2021-10-19T22:35:58.117Z] 22:35:58 INFO - GECKO(2973) | #05: NS_InvokeByIndex [/opt/worker/tasks/task_163468089077968/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x369abe]
[..........]
[task 2021-10-19T22:35:58.275Z] 22:35:58 INFO - GECKO(2973) | [Child 3277, IPC I/O Child] WARNING: [7C55DB6C46BADC10.CE1DD7F33230763F]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-19T22:35:58.275Z] 22:35:58 INFO - GECKO(2973) | [Child 3277, IPC I/O Child] WARNING: [7C55DB6C46BADC10.CE1DD7F33230763F]: Ignoring message 'EVENT_MESSAGE' to peer 1.1 due to a missing broker: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:297
[task 2021-10-19T22:35:58.276Z] 22:35:58 INFO - GECKO(2973) | Exiting due to channel error.
[task 2021-10-19T22:35:58.276Z] 22:35:58 INFO - TEST-INFO | Main app process: exit 1
[task 2021-10-19T22:35:58.276Z] 22:35:58 ERROR - TEST-UNEXPECTED-FAIL | ShutdownLeaks | process() called before end of test suite
[task 2021-10-19T22:35:58.277Z] 22:35:58 INFO - TEST-INFO | Confirming we saw 1945 DOCSHELL created and 1879 destroyed log strings.
[task 2021-10-19T22:35:58.277Z] 22:35:58 INFO - TEST-INFO | Confirming we saw 4937 DOMWINDOW created and 4727 destroyed log strings.
[task 2021-10-19T22:35:58.277Z] 22:35:58 INFO - Buffered messages finished
[task 2021-10-19T22:35:58.278Z] 22:35:58 ERROR - TEST-UNEXPECTED-FAIL | Last test finished | application terminated with exit code 1
[task 2021-10-19T22:35:58.278Z] 22:35:58 INFO - runtests.py | Application ran for: 0:07:38.002289
[task 2021-10-19T22:35:58.279Z] 22:35:58 INFO - zombiecheck | Reading PID log: /var/folders/bp/k3k6dt8x3fx19x1k7wbmf0fm000014/T/tmp5gw0jarmpidlog
[task 2021-10-19T22:35:58.279Z] 22:35:58 INFO - ==> process 2973 launched child process 2974
[..................]
[task 2021-10-19T22:36:04.964Z] 22:36:04 INFO - PROCESS-CRASH | Last test finished | application crashed [@ nsDebugImpl::Abort(char const*, int)]
[task 2021-10-19T22:36:04.964Z] 22:36:04 INFO - Mozilla crash reason: MOZ_CRASH()
[task 2021-10-19T22:36:04.964Z] 22:36:04 INFO - Crash dump filename: /var/folders/bp/k3k6dt8x3fx19x1k7wbmf0fm000014/T/tmpja3xcy3r.mozrunner/minidumps/00D83534-4655-4960-848A-C7E4CEBE859E.dmp
[task 2021-10-19T22:36:04.964Z] 22:36:04 INFO - Operating system: Mac OS X
[task 2021-10-19T22:36:04.964Z] 22:36:04 INFO - 10.15.7 19H524
[task 2021-10-19T22:36:04.964Z] 22:36:04 INFO - CPU: amd64
[task 2021-10-19T22:36:04.964Z] 22:36:04 INFO - family 6 model 158 stepping 10
[task 2021-10-19T22:36:04.964Z] 22:36:04 INFO - 12 CPUs
[task 2021-10-19T22:36:04.964Z] 22:36:04 INFO -
[task 2021-10-19T22:36:04.964Z] 22:36:04 INFO - GPU: UNKNOWN
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO -
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - Crash reason: EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - Crash address: 0x0
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - Process uptime: 458 seconds
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO -
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - Thread 0 tid 775 (crashed) - GeckoMain 0 libmozglue.dylib!mozalloc_abort [mozalloc_abort.cpp:e9071741b84ca6b0d07d89a0785b4d6ee527941c : 33 + 0x16]
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - rax = 0x00000001007e9886 rdx = 0x0000000000000000
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - rcx = 0x00000001007fe468 rbx = 0x00007fff950ad620
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - rsi = 0x00000000000120a8 rdi = 0x00007fff950acca8
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - rbp = 0x00007ffeef4bbc40 rsp = 0x00007ffeef4bbc30
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - r8 = 0x00000000000130a8 r9 = 0x0000000000000000
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - r10 = 0x00007fff950accc8 r11 = 0x00007fff950accc0
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - r12 = 0x00007ffeef4bbc90 r13 = 0x00000001035d5a60
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - r14 = 0x00007ffeef4bbcb0 r15 = 0x00007ffeef4bbfc0
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - rip = 0x000000010076e6aa
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - Found by: given as instruction pointer in context
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - 1 XUL!Abort(char const*) [nsDebugImpl.cpp:e9071741b84ca6b0d07d89a0785b4d6ee527941c : 452 + 0x8]
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - rbx = 0x00007ffeef4bbcb0 rbp = 0x00007ffeef4bbc60
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - rsp = 0x00007ffeef4bbc50 r12 = 0x00007ffeef4bbc90
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - r13 = 0x00000001035d5a60 r14 = 0x00007ffeef4bbcb0
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - r15 = 0x00007ffeef4bbfc0 rip = 0x0000000103e9c2ee
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - Found by: call frame info
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - 2 XUL!NS_DebugBreak [nsDebugImpl.cpp:e9071741b84ca6b0d07d89a0785b4d6ee527941c : 401 + 0x23]
[task 2021-10-19T22:36:04.965Z] 22:36:04 INFO - rbx = 0x00007ffeef4bbc80 rbp = 0x00007ffeef4bc2f0
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - rsp = 0x00007ffeef4bbc70 r12 = 0x00007ffeef4bbc90
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - r13 = 0x00000001035d5a60 r14 = 0x00007ffeef4bbcb0
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - r15 = 0x00007ffeef4bbfc0 rip = 0x0000000103e9c01b
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - Found by: call frame info
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - 3 XUL!nsDebugImpl::Abort(char const*, int) [nsDebugImpl.cpp:e9071741b84ca6b0d07d89a0785b4d6ee527941c : 134 + 0xe]
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffeef4bc300
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - rsp = 0x00007ffeef4bc300 r12 = 0x00000001038abb00
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - r13 = 0x0000000000000009 r14 = 0x00007ffeef4bc3a8
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - r15 = 0x0000000000000001 rip = 0x0000000103e9c0f8
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - Found by: call frame info
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - 4 XUL!NS_InvokeByIndex + 0x8e
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffeef4bc330
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - rsp = 0x00007ffeef4bc310 r12 = 0x00000001038abb00
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - r13 = 0x0000000000000009 r14 = 0x00007ffeef4bc3a8
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - r15 = 0x0000000000000001 rip = 0x0000000104005abe
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - Found by: call frame info
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - 5 XUL!CallMethodHelper::Call() [XPCWrappedNative.cpp:e9071741b84ca6b0d07d89a0785b4d6ee527941c : 1184 + 0x18]
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffeef4bc380
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - rsp = 0x00007ffeef4bc340 r12 = 0x0000000000000000
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - r13 = 0x0000000000000002 r14 = 0x00007ffeef4bc3a8
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - r15 = 0x0000000000000001 rip = 0x0000000104de2950
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - Found by: call frame info
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - 6 XUL!XPCWrappedNative::CallMethod(XPCCallContext&, XPCWrappedNative::CallMode) [XPCWrappedNative.cpp:e9071741b84ca6b0d07d89a0785b4d6ee527941c : 1130 + 0x8]
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - rbx = 0x00007ffeef4bc560 rbp = 0x00007ffeef4bc4f0
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - rsp = 0x00007ffeef4bc390 r12 = 0x000000010e0709b0
[task 2021-10-19T22:36:04.966Z] 22:36:04 INFO - r13 = 0x0000000103626200 r14 = 0x00007ffeef4bc398
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - r15 = 0x00007ffeef4bc3a8 rip = 0x0000000104de24f9
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - Found by: call frame info
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - 7 XUL!XPC_WN_CallMethod(JSContext*, unsigned int, JS::Value*) [XPCWrappedNativeJSOps.cpp:e9071741b84ca6b0d07d89a0785b4d6ee527941c : 921 + 0x8]
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - rbx = 0x00007ffeef4bc560 rbp = 0x00007ffeef4bc630
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - rsp = 0x00007ffeef4bc500 r12 = 0x0000212969095b28
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - r13 = 0x0000000103626200 r14 = 0x00000001036940b8
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - r15 = 0x00007ffeef4bc518 rip = 0x0000000104de43b4
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - Found by: call frame info
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - 8 XUL!CallJSNative(JSContext*, bool (*)(JSContext*, unsigned int, JS::Value*), js::CallReason, JS::CallArgs const&) [Interpreter.cpp:e9071741b84ca6b0d07d89a0785b4d6ee527941c : 385 + 0x12]
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - rbx = 0x000000010360b800 rbp = 0x00007ffeef4bc6c0
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - rsp = 0x00007ffeef4bc640 r12 = 0x000000010e673de0
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - r13 = 0x00007ffeef4bc940 r14 = 0x0000000103626200
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - r15 = 0x0000000104de4000 rip = 0x0000000109bf7b2c
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - Found by: call frame info
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - 9 XUL!js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [Interpreter.cpp:e9071741b84ca6b0d07d89a0785b4d6ee527941c : 472 + 0x14]
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - rbx = 0x0000000104de4000 rbp = 0x00007ffeef4bc770
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - rsp = 0x00007ffeef4bc6d0 r12 = 0x00007ffeef4bc6f0
[task 2021-10-19T22:36:04.967Z] 22:36:04 INFO - r13 = 0x00007ffeef4bc940 r14 = 0x0000000103626200
[task 2021-10-19T22:36:04.968Z] 22:36:04 INFO - r15 = 0xffff800000000000 rip = 0x0000000109bf72be
[task 2021-10-19T22:36:04.968Z] 22:36:04 INFO - Found by: call frame info
[task 2021-10-19T22:36:04.968Z] 22:36:04 INFO - 10 XUL!InternalCall(JSContext*, js::AnyInvokeArgs const&, js::CallReason) [Interpreter.cpp:e9071741b84ca6b0d07d89a0785b4d6ee527941c : 532 + 0x10]
[task 2021-10-19T22:36:04.968Z] 22:36:04 INFO - rbx = 0x00007ffeef4bc940 rbp = 0x00007ffeef4bc7d0
[task 2021-10-19T22:36:04.968Z] 22:36:04 INFO - rsp = 0x00007ffeef4bc780 r12 = 0x00000001036940b8
[task 2021-10-19T22:36:04.968Z] 22:36:04 INFO - r13 = 0x000000010e3d1950 r14 = 0x0000000000000000
[task 2021-10-19T22:36:04.968Z] 22:36:04 INFO - r15 = 0x0000000103626200 rip = 0x0000000109bf85ad
[task 2021-10-19T22:36:04.968Z] 22:36:04 INFO - Found by: call frame info
Nika, are there any updates here?
Whiteboard: [fission:m95][stockwell disable-recommended] → [fission:m95][stockwell needswork:owner]
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 25•3 years ago
|
||
Nika, are there any updates here?
Nika says she can reproduce this test failure locally, but she doesn't know the cause yet.
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
|
Assignee | |
Comment 31•3 years ago
|
||
(In reply to Chris Peterson [:cpeterson] from comment #25)
Nika says she can reproduce this test failure locally, but she doesn't know the cause yet.
I can't actually reproduce it locally, I can only reproduce it on try.
Flags: needinfo?(nika)
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Updated•3 years ago
|
Whiteboard: [fission:m95][stockwell disable-recommended] → [fission:m95][stockwell needswork:owner]
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Updated•3 years ago
|
Whiteboard: [fission:m95][stockwell disable-recommended] → [fission:m95][stockwell needswork:owner]
|
|
||
Comment 35•3 years ago
|
||
I checked the last 20 failure logs and for all of them, the issue is after browser_windowStateContainer.js. Made a disabling patch for that test until there is a fix here.
|
|
||
Comment 36•3 years ago
|
||
|
||
Comment 37•3 years ago
|
||
Pushed by abutkovits@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/10c66adfb8d3
disable browser_windowStateContainer.js on linux, mac and win debug r=intermittent-reviewers,MasterWayZ DONTBUILD
|
||
Updated•3 years ago
|
Keywords: leave-open
Whiteboard: [fission:m95][stockwell needswork:owner] → [fission:m95][stockwell disabled]
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 39•3 years ago
|
||
| bugherder | ||
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
|
Assignee | |
Comment 42•3 years ago
|
||
I was unable to determine why the BrowserParent is already destroyed,
but the change of checking CanSend() in nsFrameLoaderDestroyRunnable
seems to have fixed the issue in my test run.
My original theory was that somehow the BrowserParent is being destroyed
before it is associated with the nsFrameLoader, but the assertions to
that effect which I added didn't seem to fire. I'm guessing this may
have something instead to do with BFCache, but I'm not completely
certain.
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 45•3 years ago
|
||
Pushed by nlayzell@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/9874ae255e31
Ensure DestroyComplete is run even if the BrowserParent is already destroyed, r=smaug
|
|
||
Comment 46•3 years ago
|
||
- Nika, your patch doesn't re-enable the browser_windowStateContainer.js test (i.e. revert https://hg.mozilla.org/mozilla-central/rev/10c66adfb8d3). Do you plan to re-enable the test in a follow-up patch?
- Should your fix be uplifted to Beta 95? Or is it only needed to fix shutdown leak assertions?
status-firefox96:
--- → affected
Flags: needinfo?(cpeterson)
Whiteboard: [fission:m95][stockwell disabled] → [fission:m95] [fission:m96] [stockwell disabled]
|
|
||
Comment 47•3 years ago
|
||
| bugherder | ||
| Comment hidden (Intermittent Failures Robot) |
|
|
Assignee | |
Comment 49•3 years ago
|
||
(In reply to Chris Peterson [:cpeterson] from comment #46)
- Nika, your patch doesn't re-enable the browser_windowStateContainer.js test (i.e. revert https://hg.mozilla.org/mozilla-central/rev/10c66adfb8d3). Do you plan to re-enable the test in a follow-up patch?
Yes, we need to revert it in a separate patch. I forgot to revert it in the patch I had already landed.
- Should your fix be uplifted to Beta 95? Or is it only needed to fix shutdown leak assertions?
The only visible effect AFAICT is a low-frequency small memory leak and these shutdown assertions which are test-only, so I don't think we need to uplift it to 95.
Flags: needinfo?(cpeterson)
|
|
||
Updated•3 years ago
|
|
|
||
Comment 50•3 years ago
|
||
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Updated•3 years ago
|
Keywords: leave-open
Whiteboard: [fission:m95] [fission:m96] [stockwell disabled] → [fission:m95] [fission:m96]
|
|
||
Comment 53•3 years ago
|
||
Pushed by apavel@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/4c86d4a08b6e
re-enable browser_windowStateContainer.js on all platforms r=cpeterson
|
|
||
Comment 54•3 years ago
|
||
| bugherder | ||
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → FIXED
Target Milestone: --- → 96 Branch
You need to log in
before you can comment on or make changes to this bug.
Description
•