Closed Bug 1592329 Opened 5 years ago Closed 5 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | /service-workers/service-worker/postmessage.https.html | postMessage to a ServiceWorker (and back via MessagePort) - 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: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=273480125&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/bfBEH7rRS46m4O0z_dSPnA/runs/0/artifacts/public/logs/live_backing.log

[task 2019-10-29T15:02:40.963Z] 15:02:40 INFO - TEST-START | /service-workers/service-worker/postmessage-to-client.https.html
[task 2019-10-29T15:02:40.967Z] 15:02:40 INFO - Closing window 249
[task 2019-10-29T15:02:41.469Z] 15:02:41 INFO - .
[task 2019-10-29T15:02:41.469Z] 15:02:41 INFO - TEST-OK | /service-workers/service-worker/postmessage-to-client.https.html | took 503ms
[task 2019-10-29T15:02:41.471Z] 15:02:41 INFO - TEST-START | /service-workers/service-worker/postmessage.https.html
[task 2019-10-29T15:02:41.473Z] 15:02:41 INFO - Closing window 251
[task 2019-10-29T15:02:51.859Z] 15:02:51 INFO -
[task 2019-10-29T15:02:51.861Z] 15:02:51 INFO - TEST-UNEXPECTED-TIMEOUT | /service-workers/service-worker/postmessage.https.html | postMessage to a ServiceWorker (and back via MessagePort) - Test timed out
[task 2019-10-29T15:02:51.862Z] 15:02:51 INFO -
[task 2019-10-29T15:02:51.862Z] 15:02:51 INFO - TEST-UNEXPECTED-NOTRUN | /service-workers/service-worker/postmessage.https.html | postMessage a transferable ArrayBuffer between ServiceWorker and Client - expected PASS
[task 2019-10-29T15:02:51.863Z] 15:02:51 INFO -
[task 2019-10-29T15:02:51.863Z] 15:02:51 INFO - TEST-UNEXPECTED-NOTRUN | /service-workers/service-worker/postmessage.https.html | postMessage a transferable ArrayBuffer between ServiceWorker and Client over MessagePort - expected PASS
[task 2019-10-29T15:02:51.863Z] 15:02:51 INFO -
[task 2019-10-29T15:02:51.863Z] 15:02:51 INFO - TEST-UNEXPECTED-NOTRUN | /service-workers/service-worker/postmessage.https.html | postMessage with dictionary a transferable ArrayBuffer between ServiceWorker and Client - expected PASS
[task 2019-10-29T15:02:51.863Z] 15:02:51 INFO -
[task 2019-10-29T15:02:51.863Z] 15:02:51 INFO - TEST-UNEXPECTED-NOTRUN | /service-workers/service-worker/postmessage.https.html | postMessage to a redundant worker - expected FAIL
[task 2019-10-29T15:02:51.863Z] 15:02:51 INFO - TEST-INFO | expected FAIL
[task 2019-10-29T15:02:51.863Z] 15:02:51 INFO - TEST-UNEXPECTED-TIMEOUT | /service-workers/service-worker/postmessage.https.html | expected OK
[task 2019-10-29T15:02:51.863Z] 15:02:51 INFO - TEST-INFO took 10396ms
[task 2019-10-29T15:02:51.881Z] 15:02:51 INFO - PID 14525 | 1572361371873 Marionette INFO Stopped listening on port 41172
[task 2019-10-29T15:03:02.025Z] 15:03:02 INFO - PID 14525 | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"ServiceWorkerShutdownBlocker: shutting down Service Workers","state":{"pendingPromises":6,"acceptingPromises":false},"filename":"/builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp","lineNumber":82,"stack":"Service Workers shutdown"}] Barrier: profile-change-teardown
[task 2019-10-29T15:03:06.995Z] 15:03:06 INFO - PID 14525 | console.error: (new Error("SessionFile is closed", "resource:///modules/sessionstore/SessionFile.jsm", 433))
[task 2019-10-29T15:03:53.028Z] 15:03:53 INFO - PID 14525 | FATAL ERROR: AsyncShutdown timeout in profile-change-teardown Conditions: [{"name":"ServiceWorkerShutdownBlocker: shutting down Service Workers","state":{"pendingPromises":6,"acceptingPromises":false},"filename":"/builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp","lineNumber":82,"stack":"Service Workers 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 2019-10-29T15:03:53.029Z] 15:03:53 INFO - PID 14525 | [Parent 14525, Main Thread] ###!!! ABORT: file /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp, line 82
[task 2019-10-29T15:03:53.029Z] 15:03:53 INFO - PID 14525 | [Parent 14525, Main Thread] ###!!! ABORT: file /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp, line 82
[task 2019-10-29T15:03:53.029Z] 15:03:53 INFO - PID 14525 | ExceptionHandler::GenerateDump cloned child 19235
[task 2019-10-29T15:03:53.030Z] 15:03:53 INFO - PID 14525 | ExceptionHandler::SendContinueSignalToChild sent continue signal to child
[task 2019-10-29T15:03:53.030Z] 15:03:53 INFO - PID 14525 | ExceptionHandler::WaitForContinueSignal waiting for continue signal...
[task 2019-10-29T15:03:53.267Z] 15:03:53 INFO - PID 14525 | [GFX1-]: Receive IPC close with reason=AbnormalShutdown
[task 2019-10-29T15:03:53.267Z] 15:03:53 INFO - PID 14525 | [Child 19202, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 728
[task 2019-10-29T15:03:53.268Z] 15:03:53 INFO - PID 14525 | Exiting due to channel error.
[task 2019-10-29T15:03:53.268Z] 15:03:53 INFO - PID 14525 | Exiting due to channel error.
[task 2019-10-29T15:03:53.269Z] 15:03:53 INFO - PID 14525 | [GFX1-]: Receive IPC close with reason=AbnormalShutdown
[task 2019-10-29T15:03:53.269Z] 15:03:53 INFO - PID 14525 | Exiting due to channel error.
[task 2019-10-29T15:03:53.269Z] 15:03:53 INFO - PID 14525 | [Child 18247, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 728
[task 2019-10-29T15:03:53.270Z] 15:03:53 INFO - PID 14525 | Exiting due to channel error.
[task 2019-10-29T15:03:53.339Z] 15:03:53 INFO - Browser exited with return code 11
[task 2019-10-29T15:03:53.341Z] 15:03:53 INFO - PROCESS LEAKS None
[task 2019-10-29T15:03:53.342Z] 15:03:53 INFO - Closing logging queue
[task 2019-10-29T15:03:53.342Z] 15:03:53 INFO - queue closed
[task 2019-10-29T15:03:53.364Z] 15:03:53 INFO - Setting up ssl

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

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