Closed Bug 1638546 Opened 5 years ago Closed 5 years ago

Intermittent Assertion failure: false (NS_SUCCEED[Child 8692, Main Thread] WARNING: Finishing incremental GC in progress during CC: file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3295

Categories

(Core :: XPCOM, defect, P5)

Product:
Core
Component:
XPCOM
Type:
defect

Tracking

()

Status:
RESOLVED DUPLICATE of bug 1632450

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: assertion, intermittent-failure)

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

[task 2020-05-16T10:34:03.111Z] 10:34:03 INFO - REFTEST TEST-START | dom/canvas/test/reftest/filters/strokeText-with-shadow-2.html != dom/canvas/test/reftest/filters/strokeText-without-shadow-2-ref.html
[task 2020-05-16T10:34:03.111Z] 10:34:03 INFO - REFTEST TEST-LOAD | file:///Z:/task_1589623252/build/tests/reftest/tests/dom/canvas/test/reftest/filters/strokeText-with-shadow-2.html | 29 / 30 (96%)
[task 2020-05-16T10:34:03.212Z] 10:34:03 INFO - REFTEST TEST-LOAD | file:///Z:/task_1589623252/build/tests/reftest/tests/dom/canvas/test/reftest/filters/strokeText-without-shadow-2-ref.html | 29 / 30 (96%)
[task 2020-05-16T10:34:03.355Z] 10:34:03 INFO - REFTEST TEST-PASS | dom/canvas/test/reftest/filters/strokeText-with-shadow-2.html != dom/canvas/test/reftest/filters/strokeText-without-shadow-2-ref.html | image comparison, max difference: 75, number of differing pixels: 1614
[task 2020-05-16T10:34:03.355Z] 10:34:03 INFO - REFTEST TEST-END | dom/canvas/test/reftest/filters/strokeText-with-shadow-2.html != dom/canvas/test/reftest/filters/strokeText-without-shadow-2-ref.html
[task 2020-05-16T10:34:03.404Z] 10:34:03 INFO - REFTEST INFO | Slowest test took 815ms (data:text/html,PASS)
[task 2020-05-16T10:34:03.404Z] 10:34:03 INFO - REFTEST INFO | Total canvas count = 0
[task 2020-05-16T10:34:03.894Z] 10:34:03 INFO - [Parent 8076, Main Thread] WARNING: IInputPane2::TryHide is failure: 'result', file /builds/worker/checkouts/gecko/widget/windows/OSKInputPaneManager.cpp, line 69
[task 2020-05-16T10:34:04.022Z] 10:34:04 INFO - [Parent 8076, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111 (NS_ERROR_NOT_AVAILABLE): file /builds/worker/checkouts/gecko/netwerk/cache/nsApplicationCacheService.cpp, line 161
[task 2020-05-16T10:34:04.250Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2295
[task 2020-05-16T10:34:04.250Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-16T10:34:04.251Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-16T10:34:04.251Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2295
[task 2020-05-16T10:34:04.251Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-16T10:34:04.252Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-16T10:34:04.252Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2295
[task 2020-05-16T10:34:04.252Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-16T10:34:04.253Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-16T10:34:04.253Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2295
[task 2020-05-16T10:34:04.254Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-16T10:34:04.255Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-16T10:34:04.255Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2295
[task 2020-05-16T10:34:04.256Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-16T10:34:04.256Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-16T10:34:04.291Z] 10:34:04 INFO - [Child 8236, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-05-16T10:34:04.639Z] 10:34:04 INFO - Assertion failure: false (NS_SUCCEED[Child 8692, Main Thread] WARNING: Finishing incremental GC in progress during CC: file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3295

This is another case where we're getting multiple messages mixed together at the same time. Has something changed with the way we do logging?

This is Windows 10 x64 debug Reftests test-windows10-64/debug-reftest-e10s-2 R(R2) FWIW.

Assertion failure: false (NS_SUCCEED[Child 8692, Main Thread] WARNING: Finishing incremental GC in progress during CC: file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3295
[task 2020-05-16T10:34:04.671Z] 10:34:04 INFO - ED(mTranslationTaskQueue->Dispatch( NewRunnableMethod("CanvasTranslator::StartTranslation", this, &CanvasTranslator::StartTranslation)))), at

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