Closed Bug 1681419 Opened 4 years ago Closed 4 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | /fullscreen/api/element-request-fullscreen-options.html | TestRunner hit external timeout (this may indicate a hang)

Categories

(Core :: DOM: Core & HTML, defect, P5)

defect

Tracking

()

RESOLVED DUPLICATE of bug 1644147

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2020-12-08T22:48:07.807Z] 22:48:07     INFO - TEST-START | /fullscreen/api/element-request-fullscreen-options.html
[task 2020-12-08T22:48:07.810Z] 22:48:07     INFO - Closing window 54
[task 2020-12-08T22:48:07.937Z] 22:48:07     INFO - PID 9544 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-12-08T22:48:07.947Z] 22:48:07     INFO - PID 9544 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-12-08T22:48:07.947Z] 22:48:07     INFO - PID 9544 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-12-08T22:48:17.742Z] 22:48:17     INFO - .........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................
[task 2020-12-08T22:48:17.743Z] 22:48:17     INFO - TEST-OK | /WebCryptoAPI/derive_bits_keys/pbkdf2.https.any.worker.html?6001-7000 | took 19344ms
[task 2020-12-08T22:48:17.743Z] 22:48:17     INFO - Restarting browser for new test group
[task 2020-12-08T22:48:17.743Z] 22:48:17     INFO - PID 2263 | 1607467697715	Marionette	INFO	Stopped listening on port 41279
[task 2020-12-08T22:48:17.904Z] 22:48:17     INFO - PID 2263 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-12-08T22:48:17.906Z] 22:48:17     INFO - PID 2263 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-12-08T22:48:17.906Z] 22:48:17     INFO - PID 2263 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-12-08T22:48:17.907Z] 22:48:17     INFO - PID 2263 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-12-08T22:48:17.908Z] 22:48:17     INFO - PID 2263 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-12-08T22:48:17.909Z] 22:48:17     INFO - PID 2263 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-12-08T22:48:18.045Z] 22:48:18     INFO - PID 2263 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-12-08T22:48:42.805Z] 22:48:42     INFO - Got timeout in harness
[task 2020-12-08T22:48:42.808Z] 22:48:42     INFO - TEST-UNEXPECTED-TIMEOUT | /fullscreen/api/element-request-fullscreen-options.html | TestRunner hit external timeout (this may indicate a hang)
[task 2020-12-08T22:48:42.808Z] 22:48:42     INFO - TEST-INFO took 35003ms
[task 2020-12-08T22:49:21.796Z] 22:49:21     INFO - PID 2263 | ExceptionHandler::WaitForContinueSignal waiting for continue signal...
[task 2020-12-08T22:49:21.796Z] 22:49:21     INFO - PID 2263 | ExceptionHandler::GenerateDump cloned child 9821
[task 2020-12-08T22:49:21.797Z] 22:49:21     INFO - PID 2263 | ExceptionHandler::SendContinueSignalToChild sent continue signal to child
[task 2020-12-08T22:49:28.740Z] 22:49:28     INFO - Browser exited with return code 11
[task 2020-12-08T22:49:28.740Z] 22:49:28     INFO - PROCESS LEAKS None
[task 2020-12-08T22:49:28.740Z] 22:49:28     INFO - Closing logging queue
[task 2020-12-08T22:49:28.740Z] 22:49:28     INFO - queue closed
[task 2020-12-08T22:49:28.763Z] 22:49:28     INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmp3lavv2
[task 2020-12-08T22:49:28.779Z] 22:49:28     INFO - Starting runner
[task 2020-12-08T22:49:28.836Z] 22:49:28     INFO - PID 9823 | [CodeCoverage] Setting handlers for process 9823.
[task 2020-12-08T22:49:33.959Z] 22:49:33     INFO - PID 9823 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new Error("", "(unknown module)"))
[task 2020-12-08T22:49:35.592Z] 22:49:35     INFO - PID 9823 | 1607467775588	Marionette	INFO	Listening on port 57071
[task 2020-12-08T22:49:53.869Z] 22:49:53     INFO - Browser exited with return code -15
[task 2020-12-08T22:49:53.869Z] 22:49:53     INFO - PROCESS LEAKS None
[task 2020-12-08T22:49:53.873Z] 22:49:53     INFO - Browser not responding, setting status to CRASH
[task 2020-12-08T22:49:53.874Z] 22:49:53  WARNING - Command left in command_queue during cleanup: 'test_ended', (<wptrunner.wpttest.TestharnessTest /fullscreen/api/element-request-fullscreen-options.html>, (<wptrunner.wpttest.TestharnessResult CRASH>, []))
[task 2020-12-08T22:49:53.876Z] 22:49:53     INFO - Closing logging queue
[task 2020-12-08T22:49:53.876Z] 22:49:53     INFO - IOError on command, setting status to CRASH
[task 2020-12-08T22:49:53.876Z] 22:49:53     INFO - queue closed
[task 2020-12-08T22:49:53.920Z] 22:49:53     INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmpRtahQt
[task 2020-12-08T22:49:53.961Z] 22:49:53     INFO - Starting runner
[task 2020-12-08T22:49:54.089Z] 22:49:54     INFO - PID 9922 | [CodeCoverage] Setting handlers for process 9922.
[task 2020-12-08T22:49:54.452Z] 22:49:54     INFO - PID 9823 | [CodeCoverage] Setting handlers for process 9893.
[task 2020-12-08T22:49:54.648Z] 22:49:54     INFO - PID 9823 | [CodeCoverage] Setting handlers for process 9896.
[task 2020-12-08T22:49:55.236Z] 22:49:55     INFO - PID 9823 | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'MarionetteEvents'
[task 2020-12-08T22:49:55.278Z] 22:49:55     INFO - PID 9823 | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'MarionetteEvents'
[task 2020-12-08T22:49:55.280Z] 22:49:55     INFO - PID 9823 | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'MarionetteEvents'```
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.