Intermittent dom/ipc/tests/test_process_error.xhtml | Test timed out.
Categories
(Core :: DOM: Content Processes, defect, P3)
Tracking
()
People
(Reporter: intermittent-bug-filer, Assigned: gsvelto)
References
(Depends on 1 open bug, Regression)
Details
(Keywords: intermittent-failure, regression, Whiteboard: [stockwell disabled][stockwell unknown])
Attachments
(2 files)
#[markdown(off)]
Filed by: ncsoregi [at] mozilla.com
https://treeherder.mozilla.org/logviewer.html#?job_id=240046060&repo=autoland
[task 2019-04-12T22:19:07.164Z] 22:19:07 INFO - Buffered messages logged at 22:13:39
[task 2019-04-12T22:19:07.165Z] 22:19:07 INFO - TEST-PASS | dom/ipc/tests/test_process_error.xul | Expected the right browsing context id on the oop-browser-crashed event.
[task 2019-04-12T22:19:07.165Z] 22:19:07 INFO - TEST-PASS | dom/ipc/tests/test_process_error.xul | Received correct observer topic.
[task 2019-04-12T22:19:07.166Z] 22:19:07 INFO - TEST-PASS | dom/ipc/tests/test_process_error.xul | Subject implements nsIPropertyBag2.
[task 2019-04-12T22:19:07.167Z] 22:19:07 INFO - Buffered messages finished
[task 2019-04-12T22:19:07.168Z] 22:19:07 INFO - TEST-UNEXPECTED-FAIL | dom/ipc/tests/test_process_error.xul | Test timed out.
[task 2019-04-12T22:19:07.168Z] 22:19:07 INFO - SimpleTest.ok@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:275:18
[task 2019-04-12T22:19:07.169Z] 22:19:07 INFO - reportError@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:121:22
[task 2019-04-12T22:19:07.170Z] 22:19:07 INFO - TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:142:7
[task 2019-04-12T22:19:07.171Z] 22:19:07 INFO - setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
[task 2019-04-12T22:19:07.171Z] 22:19:07 INFO - setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
[task 2019-04-12T22:19:07.172Z] 22:19:07 INFO - setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
[task 2019-04-12T22:19:07.172Z] 22:19:07 INFO - setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
[task 2019-04-12T22:19:07.172Z] 22:19:07 INFO - setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
[task 2019-04-12T22:19:07.173Z] 22:19:07 INFO - setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
[task 2019-04-12T22:19:07.173Z] 22:19:07 INFO - setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
[task 2019-04-12T22:19:07.173Z] 22:19:07 INFO - setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
[task 2019-04-12T22:19:07.173Z] 22:19:07 INFO - setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
[task 2019-04-12T22:19:07.173Z] 22:19:07 INFO - setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
[task 2019-04-12T22:19:07.173Z] 22:19:07 INFO - setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
[task 2019-04-12T22:19:07.173Z] 22:19:07 INFO - TestRunner.runTests/<@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:381:20
[task 2019-04-12T22:19:07.175Z] 22:19:07 INFO - promise callback*TestRunner.runTests@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:368:50
[task 2019-04-12T22:19:07.176Z] 22:19:07 INFO - RunSet.runtests@chrome://mochikit/content/tests/SimpleTest/setup.js:201:14
[task 2019-04-12T22:19:07.176Z] 22:19:07 INFO - RunSet.runall@chrome://mochikit/content/tests/SimpleTest/setup.js:180:12
[task 2019-04-12T22:19:07.177Z] 22:19:07 INFO - hookupTests@chrome://mochikit/content/tests/SimpleTest/setup.js:273:12
[task 2019-04-12T22:19:07.177Z] 22:19:07 INFO - parseTestManifest@chrome://mochikit/content/manifestLibrary.js:38:5
[task 2019-04-12T22:19:07.178Z] 22:19:07 INFO - getTestManifest/req.onload@chrome://mochikit/content/manifestLibrary.js:49:11
[task 2019-04-12T22:19:07.179Z] 22:19:07 INFO - EventHandlerNonNull*getTestManifest@chrome://mochikit/content/manifestLibrary.js:45:3
[task 2019-04-12T22:19:07.180Z] 22:19:07 INFO - hookup@chrome://mochikit/content/tests/SimpleTest/setup.js:253:5
[task 2019-04-12T22:19:07.180Z] 22:19:07 INFO - linkAndHookup@chrome://mochikit/content/harness.xul:54:3
[task 2019-04-12T22:19:07.180Z] 22:19:07 INFO - parseTestManifest@chrome://mochikit/content/manifestLibrary.js:38:5
[task 2019-04-12T22:19:07.181Z] 22:19:07 INFO - getTestManifest/req.onload@chrome://mochikit/content/manifestLibrary.js:49:11
[task 2019-04-12T22:19:07.181Z] 22:19:07 INFO - EventHandlerNonNull*getTestManifest@chrome://mochikit/content/manifestLibrary.js:45:3
[task 2019-04-12T22:19:07.182Z] 22:19:07 INFO - getTestList@chrome://mochikit/content/chrome-harness.js:251:3
[task 2019-04-12T22:19:07.182Z] 22:19:07 INFO - loadTests@chrome://mochikit/content/harness.xul:33:3
[task 2019-04-12T22:19:07.183Z] 22:19:07 INFO - EventListener.handleEvent*@chrome://mochikit/content/harness.xul:57:12
[task 2019-04-12T22:19:07.872Z] 22:19:07 INFO - GECKO(2485) | MEMORY STAT | vsize 2919MB | residentFast 341MB | heapAllocated 88MB
[task 2019-04-12T22:19:07.890Z] 22:19:07 INFO - TEST-UNEXPECTED-ERROR | dom/ipc/tests/test_process_error.xul | expected-crash-dump-missing - This test did not leave any crash dumps behind, but we were expecting some!
[task 2019-04-12T22:19:07.892Z] 22:19:07 INFO - TEST-UNEXPECTED-ERROR | dom/ipc/tests/test_process_error.xul | unexpected-crash-dump-found - This test left crash dumps behind, but we weren't expecting it to!
[task 2019-04-12T22:19:07.893Z] 22:19:07 INFO - Found unexpected crash dump file /tmp/tmpRa3SxC.mozrunner/minidumps/52c54ecf-93c1-45b2-c0d4-674efdf6416c.dmp.
[task 2019-04-12T22:19:07.895Z] 22:19:07 INFO - Found unexpected crash dump file /tmp/tmpRa3SxC.mozrunner/minidumps/52c54ecf-93c1-45b2-c0d4-674efdf6416c.extra.
[task 2019-04-12T22:19:07.900Z] 22:19:07 INFO - TEST-UNEXPECTED-CRASH | dom/ipc/tests/test_process_error.xul | Finished in 329739ms
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 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 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 22•5 years ago
|
||
Brad, please take a look.
Comment hidden (Intermittent Failures Robot) |
Comment 24•5 years ago
|
||
Hi Geoff, this is a tier1 failure with 56 total failures in the last 7 days and 110 total failures in the last 30.
Recent spikes are from the above mentioned bug, do we backout or disable?
Comment 25•5 years ago
|
||
I don't think 1538042 is responsible for the regression. For instance, there were significant failures in
I suggest disabling.
Comment 26•5 years ago
|
||
Updated•5 years ago
|
Comment 27•5 years ago
|
||
(In reply to Geoff Brown [:gbrown] from comment #25)
I don't think 1538042 is responsible for the regression. For instance, there were significant failures in
I agree that Bug 1538042 is very unlikely to cause a regression, since that bug landed only a unit test and mochitest. There shouldn't be any behavior change.
Updated•5 years ago
|
Comment 28•5 years ago
|
||
Comment hidden (Intermittent Failures Robot) |
Comment 30•5 years ago
|
||
bugherder |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Updated•5 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Comment 37•5 years ago
|
||
I did a quick check of this test with the patch for bug 1420363 applied and it looks good:
https://treeherder.mozilla.org/#/jobs?repo=try&revision=ee2bdcf58b952db3de5147a921b3f05c115d1ca0
Maybe we'll be able to re-enable it after that lands.
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Comment 41•5 years ago
|
||
It seems like bug 1420363 did not fix the issue, nor did the fix for bug 1280561 and the one for bug 1598258. So there's yet another race-condition lurking in this code. Ugh.
Assignee | ||
Comment 42•5 years ago
|
||
Looking at the log it seems that we're sending the ipc:content-shutdown
notification at a time when mCrashReporter
is not yet set so the dumpID
field in the property bag ends up being null. Maybe there's a simple way to fix that...
Assignee | ||
Comment 43•5 years ago
|
||
I've got a WIP patch to fix this (and other similar intermittent failures). It's going through try right now.
Assignee | ||
Comment 44•5 years ago
|
||
Yay, it's green. Time for review.
Assignee | ||
Updated•5 years ago
|
Assignee | ||
Comment 45•5 years ago
|
||
I was too optimistic, apparently the affected test was moved to a different chunk so I'll have to re-run it.
Assignee | ||
Comment 46•5 years ago
|
||
When a content or plug-in process crashes too early we haven't initialized the
CrashReporterHost for that process. This will cause the crash to be orphaned,
i.e. to miss most of its crash annotations. We added code to finalize those
crashes in bug 1282776 so that we wouldn't miss them entirely. This ensured
that crash reports would have both their .dmp and .extra files but the patch
failed to modify the code that notified various listeners about the crash
report's presence.
This changes always send the crash ID alongside the crash notifications, even
for orphaned crashes, so that listeners such as the content crash handler or
the test harnesses can always find the minidump and .extra file.
This also re-enables dom/ipc/tests/process_error.xul which failed frequently
because of this bug.
Assignee | ||
Comment 47•5 years ago
|
||
After some more fiddling with the code I managed to make the orphaned minidump go through the test assertions correctly but then the test fails because it times out.
This is caused by the harness itself. When we have an orphaned minidump not only we don't have an .extra file but we never end up informing the CrashManager
of the crash. The test harness will always wait for crashes to have been recorded in the CrashManager
before analyzing them and in this case this will never happen. Now I need a way to fix this in a way that's robust enough to work with all the test harnesses.
Assignee | ||
Comment 48•5 years ago
|
||
Alright, I've got a working patch that makes sure that orphaned minidumps are recorded by the CrashManager
and counted in our telemetry accumulators. That's cool because it means that this patch will fix a lot more than just a few intermittent failures. What's not cool is that while running the test over and over I ran into other races that cause the test harness to fail (but not the test).
See this log for example. The test is executing fine for a hundred iterations then something odd happens:
[task 2019-12-19T13:01:34.988Z] Failed to retrieve MOZ_UPLOAD_DIR env var
That's an environment variable that the test harness sets up to run the tests; the fact that it's undefined at that point is very odd. Either there's a race in the harness so we try to read it before it's set or something somewhere is unsetting it when it's still needed.
But that's not all! Looking at the same log you'll find multiple entries of this line:
[task 2019-12-19T12:54:50.919Z] GECKO(1089) | Crash cleaned up
The problem is that there's not enough of them! There should be one per iteration but there's only a handful instead. Since that's coming from the test cleanup we can only assume that we're not cleaning up correctly most of the time because of another race, ouch.
And then there's this:
[task 2019-12-19T12:56:30.676Z] GECKO(1089) | No .extra file for dumpID: 7437404b-3812-f130-c189-bb1ed029917a
Double-ouch, something is deleting the .extra file before we're done with it. This might be related to the previous problem.
Anyhow, I'll send the fix for this up for review and then file bugs for these issues too.
Updated•5 years ago
|
Comment 49•5 years ago
|
||
Comment 50•5 years ago
|
||
bugherder |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Comment 55•5 years ago
|
||
Once bug 1605100 is fixed this should go away.
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 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 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 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 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 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 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 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 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 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 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 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 hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Updated•3 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 147•3 years ago
|
||
There are 26 total failures in the last 7 days on
- macosx1015-64-shippable-qr opt
- macosx1015-64-qr opt and debug
- linux1804-64-qr debug
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=365319800&repo=autoland&lineNumber=6281
[task 2022-01-25T07:59:04.425Z] 07:59:04 INFO - TEST-START | dom/ipc/tests/test_process_error.xhtml
[task 2022-01-25T07:59:05.457Z] 07:59:05 INFO - GECKO(1479) | [Parent 1479, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/chrome/nsChromeRegistry.cpp:180
[task 2022-01-25T07:59:05.457Z] 07:59:05 INFO - GECKO(1479) | [Parent 1479, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/security/nsCSPService.cpp:191
[task 2022-01-25T07:59:05.519Z] 07:59:05 INFO - GECKO(1479) | [Parent 1479, Main Thread] WARNING: NS_ENSURE_TRUE(uri) failed: file /builds/worker/checkouts/gecko/caps/BasePrincipal.cpp:1346
[task 2022-01-25T07:59:05.534Z] 07:59:05 INFO - GECKO(1479) | [Parent 1479, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4235
[task 2022-01-25T07:59:05.617Z] 07:59:05 INFO - GECKO(1479) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/p4/p4h39g312nn2mrt_j3hjwm1h000014/T/tmp4qoi6442.mozrunner/runtests_leaks_tab_pid1490.log
[task 2022-01-25T07:59:05.617Z] 07:59:05 INFO - GECKO(1479) | [1490, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:254
[task 2022-01-25T07:59:05.620Z] 07:59:05 INFO - GECKO(1479) | [Parent 1479, GMPThread] WARNING: Failed to delete GMP storage directory: file /builds/worker/checkouts/gecko/dom/media/gmp/GMPServiceParent.cpp:1721
[task 2022-01-25T07:59:05.646Z] 07:59:05 INFO - GECKO(1479) | [2022-01-25T07:59:05Z WARN webrender::device::gl] Missing optimized shader source for gpu_cache_update
[task 2022-01-25T07:59:05.669Z] 07:59:05 INFO - GECKO(1479) | [2022-01-25T07:59:05Z WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-01-25T07:59:05.670Z] 07:59:05 INFO - GECKO(1479) | [2022-01-25T07:59:05Z WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-01-25T07:59:05.670Z] 07:59:05 INFO - GECKO(1479) | [2022-01-25T07:59:05Z WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-01-25T07:59:05.686Z] 07:59:05 INFO - GECKO(1479) | [2022-01-25T07:59:05Z WARN webrender::device::gl] Missing optimized shader source for gpu_cache_update
[task 2022-01-25T07:59:05.744Z] 07:59:05 INFO - GECKO(1479) | [2022-01-25T07:59:05Z WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-01-25T07:59:05.744Z] 07:59:05 INFO - GECKO(1479) | [2022-01-25T07:59:05Z WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-01-25T07:59:05.744Z] 07:59:05 INFO - GECKO(1479) | [2022-01-25T07:59:05Z WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-01-25T07:59:05.749Z] 07:59:05 INFO - GECKO(1479) | [Child 1490, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x804B0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS): file /builds/worker/checkouts/gecko/toolkit/components/antitracking/URLQueryStringStripper.cpp:129
[task 2022-01-25T07:59:05.753Z] 07:59:05 INFO - GECKO(1479) | Et tu, Brute?
[task 2022-01-25T07:59:05.753Z] 07:59:05 INFO - GECKO(1479) | XPCOM_MEM_BLOAT_LOG: /var/folders/p4/p4h39g312nn2mrt_j3hjwm1h000014/T/tmp4qoi6442.mozrunner/runtests_leaks.log
[task 2022-01-25T07:59:05.754Z] 07:59:05 INFO - GECKO(1479) | Writing to log: /var/folders/p4/p4h39g312nn2mrt_j3hjwm1h000014/T/tmp4qoi6442.mozrunner/runtests_leaks_tab_pid1490.log
[task 2022-01-25T07:59:30.242Z] 07:59:30 INFO - GECKO(1479) | 2022-01-25 07:59:30.241 firefox[1479:20494] Persistent UI failed to open file file:///Users/cltbld/Library/Saved%20Application%20State/org.mozilla.nightlydebug.savedState/window_1.data: No such file or directory (2)
[task 2022-01-25T08:04:05.385Z] 08:04:05 INFO - TEST-INFO | started process screencapture
[task 2022-01-25T08:04:05.507Z] 08:04:05 INFO - TEST-INFO | screencapture: exit 0
[task 2022-01-25T08:04:05.508Z] 08:04:05 INFO - TEST-UNEXPECTED-FAIL | dom/ipc/tests/test_process_error.xhtml | Test timed out. -
[task 2022-01-25T08:04:06.481Z] 08:04:06 INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-01-25T08:04:06.482Z] 08:04:06 INFO - TEST-UNEXPECTED-FAIL | dom/ipc/tests/test_process_error.xhtml | [SimpleTest.finish()] No checks actually run. (You need to call ok(), is(), or similar functions at least once. Make sure you use SimpleTest.waitForExplicitFinish() if you need it.)
[task 2022-01-25T08:04:06.482Z] 08:04:06 INFO - SimpleTest.ok@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:417:16
[task 2022-01-25T08:04:06.482Z] 08:04:06 INFO - afterCleanup@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1416:18
[task 2022-01-25T08:04:06.482Z] 08:04:06 INFO - executeCleanupFunction@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1481:7
[task 2022-01-25T08:04:06.482Z] 08:04:06 INFO - SimpleTest.finish@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1501:3
[task 2022-01-25T08:04:06.482Z] 08:04:06 INFO - killTest@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:194:22
[task 2022-01-25T08:04:06.483Z] 08:04:06 INFO - GECKO(1479) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2022-01-25T08:04:06.483Z] 08:04:06 INFO - GECKO(1479) | MEMORY STAT | vsize 7924MB | residentFast 396MB | heapAllocated 190MB
[task 2022-01-25T08:04:06.484Z] 08:04:06 INFO - TEST-UNEXPECTED-ERROR | dom/ipc/tests/test_process_error.xhtml | expected-crash-dump-missing - This test did not leave any crash dumps behind, but we were expecting some!
[task 2022-01-25T08:04:06.485Z] 08:04:06 INFO - TEST-UNEXPECTED-ERROR | dom/ipc/tests/test_process_error.xhtml | unexpected-crash-dump-found - This test left crash dumps behind, but we weren't expecting it to!
[task 2022-01-25T08:04:06.485Z] 08:04:06 INFO - Found unexpected crash dump file /var/folders/p4/p4h39g312nn2mrt_j3hjwm1h000014/T/tmp4qoi6442.mozrunner/minidumps/FF9103B3-6EF6-43A8-8AE7-EC1FD76901C2.dmp.
[task 2022-01-25T08:04:06.486Z] 08:04:06 INFO - TEST-UNEXPECTED-CRASH | dom/ipc/tests/test_process_error.xhtml | Finished in 302062ms
[task 2022-01-25T08:04:06.487Z] 08:04:06 INFO - {'runtime': 302062}
[task 2022-01-25T08:04:06.487Z] 08:04:06 INFO - TEST-INFO took 302062ms
[task 2022-01-25T08:04:06.508Z] 08:04:06 INFO - GECKO(1479) | [2022-01-25T08:04:06Z WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-01-25T08:04:06.508Z] 08:04:06 INFO - GECKO(1479) | [2022-01-25T08:04:06Z WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-01-25T08:04:06.509Z] 08:04:06 INFO - GECKO(1479) | [2022-01-25T08:04:06Z WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-01-25T08:04:07.511Z] 08:04:07 INFO - GECKO(1479) | [Parent 1479, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/chrome/nsChromeRegistry.cpp:180
[task 2022-01-25T08:04:07.512Z] 08:04:07 INFO - GECKO(1479) | [Parent 1479, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/security/nsCSPService.cpp:191
[task 2022-01-25T08:04:07.516Z] 08:04:07 ERROR - TEST-UNEXPECTED-FAIL | chrome://mochitests/content/chrome/dom/ipc/tests/test_process_error.xhtml logged result after SimpleTest.finish(): [SimpleTest.finish()] No checks actually run. (You need to call ok(), is(), or similar functions at least once. Make sure you use SimpleTest.waitForExplicitFinish() if you need it.)
[task 2022-01-25T08:04:07.526Z] 08:04:07 INFO - GECKO(1479) | [Parent 1479, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1180
Gabriele, are you still working on this? Are there any updates?
Updated•3 years ago
|
Assignee | ||
Comment 148•3 years ago
|
||
Yes, this is in my backlog and has been for such a long time. Since the volume is ticking up I'll try to prioritize it.
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 154•3 years ago
|
||
I haven't had time to look into this yet but it's on my radar.
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) |
Assignee | ||
Comment 162•3 years ago
|
||
I've been fixing two distinct races in the crash reporting code and now I'm fixing a third one. Once they've all landed I'll try to re-run this on Linux too to see if that fixed the issue here.
Updated•3 years ago
|
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Comment 164•2 years ago
|
||
Alright I'm looking into this. The fix should apply to bug 1765785 too.
Assignee | ||
Comment 165•2 years ago
|
||
See my analysis in bug 1765785 comment 8.
Updated•2 years ago
|
Updated•2 years ago
|
Description
•