Closed Bug 1605321 Opened 4 years ago Closed 4 years ago

Perma fission TEST-UNEXPECTED-TIMEOUT | /html/browsers/the-window-object/apis-for-creating-and-navigating-browsing-contexts-by-name/no_window_open_when_term_nesting_level_nonzero.window.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 FIXED
Milestone:
mozilla73
Tracking Flags:
Tracking Status
firefox73 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: CosminS)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Attachments

(1 file)

Bug 1605321 - update expectations on fission for no_window_open_when_term_nesting_level_nonzero.window.html. r=jgraham,kmag
47 bytes, text/x-phabricator-request
Details | Review

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

[task 2019-12-20T04:56:26.190Z] 04:56:26 INFO - TEST-OK | /html/browsers/the-window-object/apis-for-creating-and-navigating-browsing-contexts-by-name/close_unload.html | took 273ms
[task 2019-12-20T04:56:26.192Z] 04:56:26 INFO - TEST-START | /html/browsers/the-window-object/apis-for-creating-and-navigating-browsing-contexts-by-name/no_window_open_when_term_nesting_level_nonzero.window.html
[task 2019-12-20T04:56:26.199Z] 04:56:26 INFO - Closing window 8589934600
[task 2019-12-20T04:56:26.998Z] 04:56:26 INFO - PID 14653 | JavaScript error: http://web-platform.test:8000/html/browsers/the-window-object/apis-for-creating-and-navigating-browsing-contexts-by-name/no_window_open_when_term_nesting_level_nonzero.window.js, line 9: TypeError: frame.contentWindow is null
[task 2019-12-20T04:56:26.999Z] 04:56:26 INFO - PID 14653 | JavaScript error: http://web-platform.test:8000/html/browsers/the-window-object/apis-for-creating-and-navigating-browsing-contexts-by-name/no_window_open_when_term_nesting_level_nonzero.window.js, line 13: TypeError: frame.contentWindow is null
[task 2019-12-20T04:56:27.001Z] 04:56:27 INFO - PID 14653 | JavaScript error: http://web-platform.test:8000/html/browsers/the-window-object/apis-for-creating-and-navigating-browsing-contexts-by-name/no_window_open_when_term_nesting_level_nonzero.window.js, line 21: TypeError: frame.contentWindow is null
[task 2019-12-20T04:56:46.202Z] 04:56:46 INFO - TEST-UNEXPECTED-TIMEOUT | /html/browsers/the-window-object/apis-for-creating-and-navigating-browsing-contexts-by-name/no_window_open_when_term_nesting_level_nonzero.window.html | Executor hit external timeout (this may indicate a hang)
[task 2019-12-20T04:56:46.202Z] 04:56:46 INFO - File "/usr/lib/python2.7/threading.py", line 774, in __bootstrap
[task 2019-12-20T04:56:46.202Z] 04:56:46 INFO - self.__bootstrap_inner()
[task 2019-12-20T04:56:46.202Z] 04:56:46 INFO - File "/usr/lib/python2.7/threading.py", line 801, in __bootstrap_inner
[task 2019-12-20T04:56:46.203Z] 04:56:46 INFO - self.run()
[task 2019-12-20T04:56:46.203Z] 04:56:46 INFO - File "/usr/lib/python2.7/threading.py", line 1071, in run
[task 2019-12-20T04:56:46.203Z] 04:56:46 INFO - self.finished.wait(self.interval)
[task 2019-12-20T04:56:46.204Z] 04:56:46 INFO - File "/usr/lib/python2.7/threading.py", line 614, in wait
[task 2019-12-20T04:56:46.204Z] 04:56:46 INFO - self.__cond.wait(timeout)
[task 2019-12-20T04:56:46.204Z] 04:56:46 INFO - File "/usr/lib/python2.7/threading.py", line 359, in wait
[task 2019-12-20T04:56:46.204Z] 04:56:46 INFO - _sleep(delay)
[task 2019-12-20T04:56:46.204Z] 04:56:46 INFO - TEST-INFO expected ERROR | took 20012ms
[task 2019-12-20T04:57:57.246Z] 04:57:57 INFO - Browser exited with return code -15
[task 2019-12-20T04:57:57.247Z] 04:57:57 INFO - PROCESS LEAKS None
[task 2019-12-20T04:57:57.249Z] 04:57:57 INFO - PROCESS LEAKS None
[task 2019-12-20T04:57:57.254Z] 04:57:57 WARNING - Traceback (most recent call last):
[task 2019-12-20T04:57:57.254Z] 04:57:57 WARNING - File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 642, in run_func
[task 2019-12-20T04:57:57.254Z] 04:57:57 WARNING - self.result = True, self.func(self.protocol, self.url, self.timeout)
[task 2019-12-20T04:57:57.254Z] 04:57:57 WARNING - File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 750, in do_testharness
[task 2019-12-20T04:57:57.254Z] 04:57:57 WARNING - protocol.marionette.navigate(url)
[task 2019-12-20T04:57:57.255Z] 04:57:57 WARNING - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 1467, in navigate
[task 2019-12-20T04:57:57.255Z] 04:57:57 WARNING - {"url": url})
[task 2019-12-20T04:57:57.255Z] 04:57:57 WARNING - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/decorators.py", line 26, in _
[task 2019-12-20T04:57:57.255Z] 04:57:57 WARNING - return func(*args, **kwargs)
[task 2019-12-20T04:57:57.255Z] 04:57:57 WARNING - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 590, in _send_message
[task 2019-12-20T04:57:57.255Z] 04:57:57 WARNING - msg = self.client.request(name, params)
[task 2019-12-20T04:57:57.255Z] 04:57:57 WARNING - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/transport.py", line 273, in request
[task 2019-12-20T04:57:57.256Z] 04:57:57 WARNING - return self.receive()
[task 2019-12-20T04:57:57.256Z] 04:57:57 WARNING - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/transport.py", line 166, in receive
[task 2019-12-20T04:57:57.256Z] 04:57:57 WARNING - if len(remaining) == int(length):
[task 2019-12-20T04:57:57.256Z] 04:57:57 WARNING - ValueError: invalid literal for int() with base 10: 'ull,{"valu26'

There's a spike in failures on different wpts in the last couple of weeks, especially the latter that all have
| Executor hit external timeout (this may indicate a hang) | looking at this list of bugs: https://bugzilla.mozilla.org/buglist.cgi?short_desc_type=allwordssubstr&short_desc=Executor%20hit%20external%20timeout%20%28this%20may%20indicate%20a%20hang%29&query_format=advanced&list_id=15042049
James, just a wild guess but could this indicate some issues in the wptrunner that make the tests often timeout?
Joel, any ideas what should be done here? Can we go ahead and update the expectations for the tests just like in Bug 1604654, https://phabricator.services.mozilla.com/D57602? Some of them are timing out more often than others.

This test for eg. has the following in the .ini:

[no_window_open_when_term_nesting_level_nonzero.window.html]
expected:
if (os == "linux") and webrender and not debug and not fission: ["TIMEOUT", "ERROR"]
ERROR

Flags: needinfo?(jmaher)
Flags: needinfo?(james)

:cosmins, is there a way we can retrigger and find a root cause? As this seems to be fission related, maybe there is a bug to fix in fission

Flags: needinfo?(jmaher) → needinfo?(csabou)

Yes, this exact test is on fission but most of the bugs from here are not: https://bugzilla.mozilla.org/buglist.cgi?short_desc_type=allwordssubstr&short_desc=Executor%20hit%20external%20timeout%20%28this%20may%20indicate%20a%20hang%29&query_format=advanced&list_id=15042293 and looking at the error message with |Executor hit external timeout (this may indicate a hang)| was thinking maybe there is a connection between them.
Will backfill on autoland to see where this started from.

Flags: needinfo?(csabou)
Has Regression Range: --- → yes
Keywords: regression

If it's permafailing on fission we should just put if fission: TIMEOUT into the metadata, not disable it.

The timeout handling changed a bit recently. It's hard to tell if that means we're actually timing out more or if it's just the change to more explicit messages that's being noticed.

Flags: needinfo?(james)
Assignee: nobody → csabou
Status: NEW → ASSIGNED
Pushed by csabou@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/6b72027dc498
update expectations on fission for no_window_open_when_term_nesting_level_nonzero.window.html. r=kmag

https://hg.mozilla.org/mozilla-central/rev/6b72027dc498

Status: ASSIGNED → RESOLVED
Closed: 4 years ago
status-firefox73: --- → fixed
Resolution: --- → FIXED
Target Milestone: --- → mozilla73

Test has been disabled.

Flags: needinfo?(kmaglione+bmo)
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: