Closed Bug 1742853 Opened 4 years ago Closed 4 years ago

Intermittent [tier 2] TEST-UNEXPECTED-TIMEOUT | /service-workers/service-worker/fetch-audio-tainting.https.html | Verify CORS XHR of fetch() in a Service Worker - Test timed out

Categories

(Core :: DOM: Service Workers, defect, P5)

Product:
Core
Component:
DOM: Service Workers
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

[task 2021-11-24T17:30:06.945Z] 17:30:06     INFO - TEST-START | /service-workers/service-worker/fetch-audio-tainting.https.html
[task 2021-11-24T17:30:06.950Z] 17:30:06     INFO - Closing window e00c655a-d801-470b-acef-688f1623728a
[task 2021-11-24T17:30:27.215Z] 17:30:27     INFO - 
[task 2021-11-24T17:30:27.215Z] 17:30:27     INFO - TEST-UNEXPECTED-TIMEOUT | /service-workers/service-worker/fetch-audio-tainting.https.html | Verify CORS XHR of fetch() in a Service Worker - Test timed out
[task 2021-11-24T17:30:27.216Z] 17:30:27     INFO - TEST-UNEXPECTED-TIMEOUT | /service-workers/service-worker/fetch-audio-tainting.https.html | expected OK
[task 2021-11-24T17:30:27.216Z] 17:30:27     INFO - TEST-INFO took 20270ms
[task 2021-11-24T17:30:27.218Z] 17:30:27     INFO - PID 16618 | 1637775027217	Marionette	INFO	Stopped listening on port 47573
[task 2021-11-24T17:30:27.434Z] 17:30:27     INFO - PID 16618 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-11-24T17:30:27.436Z] 17:30:27     INFO - PID 16618 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-11-24T17:30:27.454Z] 17:30:27     INFO - PID 16618 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-11-24T17:30:27.456Z] 17:30:27     INFO - PID 16618 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-11-24T17:30:37.555Z] 17:30:37     INFO - PID 16618 | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"MediaShutdownManager: shutdown","state":{"decoderInfo":"audio/x-wav, ","sInitPhase":3},"filename":"/builds/worker/checkouts/gecko/dom/media/MediaShutdownManager.cpp","lineNumber":71,"stack":"MediaShutdownManager shutdown"}] Barrier: xpcom-will-shutdown
[task 2021-11-24T17:30:42.433Z] 17:30:42     INFO - PID 16618 | console.error: (new Error("SessionFile is closed", "resource:///modules/sessionstore/SessionFile.jsm", 446))
[task 2021-11-24T17:30:45.281Z] 17:30:45     INFO - PID 16618 | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"ContentParent: id=7f8afe58dc00","state":{"remoteTypePrefix":"prealloc"},"filename":"/builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp","lineNumber":3521,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162"]},{"name":"ContentParent: id=7f8afe5cf000","state":{"remoteTypePrefix":"prealloc"},"filename":"/builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp","lineNumber":3521,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162"]}] Barrier: profile-before-change
[task 2021-11-24T17:31:28.556Z] 17:31:28     INFO - PID 16618 | FATAL ERROR: AsyncShutdown timeout in xpcom-will-shutdown Conditions: [{"name":"MediaShutdownManager: shutdown","state":{"decoderInfo":"audio/x-wav, ","sInitPhase":3},"filename":"/builds/worker/checkouts/gecko/dom/media/MediaShutdownManager.cpp","lineNumber":71,"stack":"MediaShutdownManager shutdown"}] 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-11-24T17:31:28.557Z] 17:31:28     INFO - PID 16618 | [Child 17062, Main Thread] ###!!! ABORT: file /builds/worker/checkouts/gecko/dom/media/MediaShutdownManager.cpp:71
[task 2021-11-24T17:31:36.281Z] 17:31:36     INFO - PID 16618 | FATAL ERROR: AsyncShutdown timeout in profile-before-change Conditions: [{"name":"ContentParent: id=7f8afe58dc00","state":{"remoteTypePrefix":"prealloc"},"filename":"/builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp","lineNumber":3521,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162"]},{"name":"ContentParent: id=7f8afe5cf000","state":{"remoteTypePrefix":"prealloc"},"filename":"/builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp","lineNumber":3521,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162"]}] 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-11-24T17:31:36.283Z] 17:31:36     INFO - PID 16618 | [Parent 16618, Main Thread] ###!!! ABORT: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3521
[task 2021-11-24T17:31:36.286Z] 17:31:36     INFO - PID 16618 | ExceptionHandler::GenerateDump cloned child 17686
[task 2021-11-24T17:31:36.286Z] 17:31:36     INFO - PID 16618 | ExceptionHandler::SendContinueSignalToChild sent continue signal to child
[task 2021-11-24T17:31:36.287Z] 17:31:36     INFO - PID 16618 | ExceptionHandler::WaitForContinueSignal waiting for continue signal...
[task 2021-11-24T17:31:38.256Z] 17:31:38     INFO - Browser exited with return code 11
[task 2021-11-24T17:31:38.258Z] 17:31:38     INFO - Closing logging queue
[task 2021-11-24T17:31:38.258Z] 17:31:38     INFO - queue closed
[task 2021-11-24T17:31:38.289Z] 17:31:38     INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmp2h279mqj
[task 2021-11-24T17:31:38.298Z] 17:31:38     INFO - PID 16955 | [CodeCoverage] Setting handlers for process 16955.
[task 2021-11-24T17:31:38.300Z] 17:31:38     INFO - PID 16955 | 1637774947875	Marionette	INFO	Marionette enabled
[task 2021-11-24T17:31:38.303Z] 17:31:38     INFO - PID 16955 | [CodeCoverage] Setting handlers for process 17086.
[task 2021-11-24T17:31:38.303Z] 17:31:38     INFO - PID 16955 | [CodeCoverage] Setting handlers for process 17090.
[task 2021-11-24T17:31:38.303Z] 17:31:38     INFO - PID 16955 | [CodeCoverage] Setting handlers for process 17168.
[task 2021-11-24T17:31:38.303Z] 17:31:38     INFO - PID 16955 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmpwzhx2qfo/search.json.mozlz4", (void 0)))
[task 2021-11-24T17:31:38.303Z] 17:31:38     INFO - PID 16955 | 1637774955700	Marionette	INFO	Listening on port 45589
[task 2021-11-24T17:31:38.304Z] 17:31:38     INFO - PID 16955 | [CodeCoverage] Setting handlers for process 17236.
[task 2021-11-24T17:31:38.304Z] 17:31:38     INFO - Starting runner
[task 2021-11-24T17:31:39.132Z] 17:31:39     INFO - TEST-START | /service-workers/service-worker/fetch-canvas-tainting-double-write.https.html

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

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