Closed Bug 1718263 Opened 5 years ago Closed 5 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | /html/canvas/offscreen/path-objects/2d.path.rect.zero.5.html | Executor hit external timeout (this may indicate a hang)

Categories

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

Product:
Core
Component:
DOM: Core & HTML
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?job_id=343869515&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/UM--wf9WT4WbFOXWOimp5g/runs/0/artifacts/public/logs/live_backing.log

[task 2021-06-25T14:12:45.958Z] 14:12:45     INFO - TEST-OK | /html/canvas/offscreen/path-objects/2d.path.rect.zero.4.worker.html | took 8578ms
[task 2021-06-25T14:12:45.958Z] 14:12:45     INFO - TEST-START | /html/canvas/offscreen/path-objects/2d.path.rect.zero.5.html
[task 2021-06-25T14:12:45.959Z] 14:12:45     INFO - Closing window c8c6e2df-03f9-43b8-9b5a-70e6258874c1
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO - TEST-UNEXPECTED-TIMEOUT | /html/canvas/offscreen/path-objects/2d.path.rect.zero.5.html | Executor hit external timeout (this may indicate a hang)
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -   File "/usr/lib/python3.6/threading.py", line 884, in _bootstrap
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -     self._bootstrap_inner()
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -   File "/usr/lib/python3.6/threading.py", line 916, in _bootstrap_inner
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -     self.run()
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -   File "/usr/lib/python3.6/threading.py", line 864, in run
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -     self._target(*self._args, **self._kwargs)
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 790, in run_func
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -     self.result = True, self.func(self.protocol, self.url, self.timeout)
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 911, in do_testharness
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -     protocol.marionette.navigate(url)
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 1516, in navigate
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -     self._send_message("WebDriver:Navigate", {"url": url})
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/decorators.py", line 27, in _
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -     return func(*args, **kwargs)
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 621, in _send_message
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -     msg = self.client.request(name, params)
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/transport.py", line 292, in request
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -     return self.receive()
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/transport.py", line 165, in receive
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO -     chunk = self._sock.recv(bytes_to_recv)
[task 2021-06-25T14:13:27.268Z] 14:13:27     INFO - TEST-INFO took 41312ms
[task 2021-06-25T14:13:27.272Z] 14:13:27     INFO - PID 5734 | 1624630407270	Marionette	INFO	Stopped listening on port 56470
[task 2021-06-25T14:13:28.697Z] 14:13:28     INFO - PID 5734 | JavaScript error: resource:///modules/Interactions.jsm, line 377: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIUserIdleService.removeIdleObserver]
[task 2021-06-25T14:13:28.697Z] 14:13:28     INFO - PID 5734 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-06-25T14:13:29.048Z] 14:13:29     INFO - PID 5734 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-06-25T14:13:29.048Z] 14:13:29     INFO - PID 5734 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-06-25T14:13:29.232Z] 14:13:29     INFO - PID 5734 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-06-25T14:13:35.477Z] 14:13:35     INFO - Browser exited with return code 0
[task 2021-06-25T14:13:35.479Z] 14:13:35     INFO - Closing logging queue
[task 2021-06-25T14:13:35.479Z] 14:13:35     INFO - queue closed
[task 2021-06-25T14:13:35.580Z] 14:13:35     INFO - INFO | runtests.py | TSan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2021-06-25T14:13:35.581Z] 14:13:35     INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmph5lqlyqe
[task 2021-06-25T14:13:35.600Z] 14:13:35     INFO - PID 5873 | 1624629039888	Marionette	INFO	Marionette enabled
[task 2021-06-25T14:13:35.601Z] 14:13:35     INFO - PID 5873 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmpiypwac94/search.json.mozlz4", (void 0)))
[task 2021-06-25T14:13:35.602Z] 14:13:35     INFO - PID 5873 | 1624629059375	Marionette	INFO	Listening on port 52102
[task 2021-06-25T14:13:35.603Z] 14:13:35     INFO - PID 5873 | 1624629429964	addons.xpi	ERROR	System addon update list error Error: Failed downloading XML, status: 0, reason: error
[task 2021-06-25T14:13:35.604Z] 14:13:35     INFO - Starting runner
[task 2021-06-25T14:13:37.975Z] 14:13:37     INFO - PID 5873 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-06-25T14:13:38.205Z] 14:13:38     INFO - TEST-START | /html/canvas/offscreen/path-objects/2d.path.rect.zero.5.worker.html
[task 2021-06-25T14:13:40.066Z] 14:13:40     INFO - .
[task 2021-06-25T14:13:40.066Z] 14:13:40     INFO - TEST-OK | /html/canvas/offscreen/path-objects/2d.path.rect.zero.5.worker.html | took 1861ms

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.