Closed Bug 1681127 Opened 5 years ago Closed 3 years ago

Intermittent dom/tests/mochitest/bugs/test_resize_move_windows.html | Test timed out.

Categories

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

defect

Tracking

()

RESOLVED DUPLICATE of bug 1781569

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

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


[task 2020-12-07T17:09:46.906Z] 17:09:46     INFO - TEST-OK | dom/tests/mochitest/bugs/test_protochains.html | took 36ms
[task 2020-12-07T17:09:46.907Z] 17:09:46     INFO - TEST-START | dom/tests/mochitest/bugs/test_resize_move_windows.html
[task 2020-12-07T17:14:50.144Z] 17:14:50     INFO - TEST-INFO | started process screencapture
[task 2020-12-07T17:14:50.217Z] 17:14:50     INFO - TEST-INFO | screencapture: exit 0
[task 2020-12-07T17:14:50.218Z] 17:14:50     INFO - Buffered messages logged at 17:09:46
[task 2020-12-07T17:14:50.218Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window width shouldn't have changed 
[task 2020-12-07T17:14:50.218Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window height shouldn't have changed 
[task 2020-12-07T17:14:50.218Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window x position shouldn't have changed 
[task 2020-12-07T17:14:50.219Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window y position shouldn't have changed 
[task 2020-12-07T17:14:50.219Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window outerWidth shouldn't have changed 
[task 2020-12-07T17:14:50.219Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window outerHeight shouldn't have changed 
[task 2020-12-07T17:14:50.219Z] 17:14:50     INFO - Buffered messages logged at 17:09:47
[task 2020-12-07T17:14:50.219Z] 17:14:50     INFO - must wait for load
[task 2020-12-07T17:14:50.219Z] 17:14:50     INFO - must wait for focus
[task 2020-12-07T17:14:50.219Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | parameter width should be taken into account 
[task 2020-12-07T17:14:50.219Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | parameter height should be taken into account 
[task 2020-12-07T17:14:50.224Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | parameter screenX should be taken into account 
[task 2020-12-07T17:14:50.225Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | parameter screenY should be taken into account 
[task 2020-12-07T17:14:50.225Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window width should have changed 
[task 2020-12-07T17:14:50.225Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window height should have changed 
[task 2020-12-07T17:14:50.226Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window width should have changed 
[task 2020-12-07T17:14:50.226Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window height should have changed 
[task 2020-12-07T17:14:50.226Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window width should have changed 
[task 2020-12-07T17:14:50.226Z] 17:14:50     INFO - TEST-PASS | dom/tests/mochitest/bugs/test_resize_move_windows.html | Window height should have changed 
[task 2020-12-07T17:14:50.226Z] 17:14:50     INFO - Buffered messages finished
[task 2020-12-07T17:14:50.226Z] 17:14:50     INFO - TEST-UNEXPECTED-FAIL | dom/tests/mochitest/bugs/test_resize_move_windows.html | Test timed out. 
[task 2020-12-07T17:14:50.226Z] 17:14:50     INFO -     SimpleTest.ok@SimpleTest/SimpleTest.js:299:16
[task 2020-12-07T17:14:50.226Z] 17:14:50     INFO -     reportError@SimpleTest/TestRunner.js:128:22
[task 2020-12-07T17:14:50.226Z] 17:14:50     INFO -     TestRunner._checkForHangs@SimpleTest/TestRunner.js:150:18
[task 2020-12-07T17:14:51.158Z] 17:14:51     INFO - GECKO(1495) | MEMORY STAT | vsize 7307MB | residentFast 149MB | heapAllocated 18MB
[task 2020-12-07T17:14:51.158Z] 17:14:51     INFO - TEST-OK | dom/tests/mochitest/bugs/test_resize_move_windows.html | took 304278ms
[task 2020-12-07T17:14:54.188Z] 17:14:54     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2020-12-07T17:14:54.232Z] 17:14:54     INFO - TEST-START | dom/tests/mochitest/bugs/test_sizetocontent_clamp.html
[task 2020-12-07T17:20:21.036Z] 17:20:21     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-12-07T17:20:21.036Z] 17:20:21     INFO - Buffered messages logged at 17:14:57
[task 2020-12-07T17:20:21.036Z] 17:20:21     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2020-12-07T17:20:21.037Z] 17:20:21     INFO - must wait for load
[task 2020-12-07T17:20:21.037Z] 17:20:21     INFO - must wait for focus
[task 2020-12-07T17:20:21.037Z] 17:20:21     INFO - Buffered messages finished
[task 2020-12-07T17:20:21.037Z] 17:20:21     INFO - TEST-UNEXPECTED-FAIL | dom/tests/mochitest/bugs/test_sizetocontent_clamp.html | Test timed out. 
[task 2020-12-07T17:20:21.037Z] 17:20:21     INFO -     SimpleTest.ok@SimpleTest/SimpleTest.js:299:16
[task 2020-12-07T17:20:21.037Z] 17:20:21     INFO -     reportError@SimpleTest/TestRunner.js:128:22
[task 2020-12-07T17:20:21.037Z] 17:20:21     INFO -     TestRunner._checkForHangs@SimpleTest/TestRunner.js:150:18
[task 2020-12-07T17:20:22.027Z] 17:20:22     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-12-07T17:20:22.027Z] 17:20:22     INFO - TEST-UNEXPECTED-FAIL | dom/tests/mochitest/bugs/test_sizetocontent_clamp.html | [SimpleTest.finish()] waitForFocus() was called a different number of times from the number of callbacks run.  Maybe the test terminated prematurely -- be sure to use SimpleTest.waitForExplicitFinish(). - got 1, expected +0
[task 2020-12-07T17:20:22.027Z] 17:20:22     INFO -     SimpleTest.is@SimpleTest/SimpleTest.js:383:14
[task 2020-12-07T17:20:22.027Z] 17:20:22     INFO -     afterCleanup@SimpleTest/SimpleTest.js:1392:18
[task 2020-12-07T17:20:22.027Z] 17:20:22     INFO -     executeCleanupFunction@SimpleTest/SimpleTest.js:1468:7
[task 2020-12-07T17:20:22.027Z] 17:20:22     INFO -     SimpleTest.finish@SimpleTest/SimpleTest.js:1488:3
[task 2020-12-07T17:20:22.027Z] 17:20:22     INFO -     killTest@SimpleTest/TestRunner.js:137:22
[task 2020-12-07T17:20:22.027Z] 17:20:22     INFO - GECKO(1495) | MEMORY STAT | vsize 7313MB | residentFast 140MB | heapAllocated 17MB
[task 2020-12-07T17:20:22.037Z] 17:20:22     INFO - TEST-OK | dom/tests/mochitest/bugs/test_sizetocontent_clamp.html | took 327821ms
[task 2020-12-07T17:20:25.169Z] 17:20:25     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2020-12-07T17:20:25.170Z] 17:20:25    ERROR - /tests/dom/tests/mochitest/bugs/test_sizetocontent_clamp.html logged result after SimpleTest.finish(): [SimpleTest.finish()] waitForFocus() was called a different number of times from the number of callbacks run.  Maybe the test terminated prematurely -- be sure to use SimpleTest.waitForExplicitFinish().
[task 2020-12-07T17:20:25.170Z] 17:20:25     INFO - TEST-START | dom/tests/mochitest/bugs/test_toJSON.html
[task 2020-12-07T17:20:28.223Z] 17:20:28     INFO - GECKO(1495) | MEMORY STAT | vsize 7319MB | residentFast 142MB | heapAllocated 19MB
[task 2020-12-07T17:20:28.256Z] 17:20:28     INFO - TEST-OK | dom/tests/mochitest/bugs/test_toJSON.html | took 3077ms
[task 2020-12-07T17:20:31.290Z] 17:20:31     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2020-12-07T17:20:31.290Z] 17:20:31     INFO - TEST-START | dom/tests/mochitest/bugs/test_window_bar.html
[task 2020-12-07T17:20:38.233Z] 17:20:38     INFO - GECKO(1495) | MEMORY STAT | vsize 7330MB | residentFast 154MB | heapAllocated 26MB
[task 2020-12-07T17:20:38.384Z] 17:20:38     INFO - TEST-OK | dom/tests/mochitest/bugs/test_window_bar.html | took 7067ms
[task 2020-12-07T17:20:41.503Z] 17:20:41     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2020-12-07T17:20:41.526Z] 17:20:41     INFO - TEST-START | Shutdown
[task 2020-12-07T17:20:41.526Z] 17:20:41     INFO - Passed:  1202
[task 2020-12-07T17:20:41.526Z] 17:20:41     INFO - Failed:  4
[task 2020-12-07T17:20:41.527Z] 17:20:41     INFO - Todo:    11
[task 2020-12-07T17:20:41.527Z] 17:20:41     INFO - Mode:    e10s
[task 2020-12-07T17:20:41.527Z] 17:20:41     INFO - Slowest: 327821ms - /tests/dom/tests/mochitest/bugs/test_sizetocontent_clamp.html
[task 2020-12-07T17:20:41.527Z] 17:20:41     INFO - SimpleTest FINISHED
[task 2020-12-07T17:20:41.527Z] 17:20:41     INFO - TEST-INFO | Ran 1 Loops
[task 2020-12-07T17:20:41.528Z] 17:20:41     INFO - SimpleTest FINISHED
[task 2020-12-07T17:20:41.741Z] 17:20:41     INFO - GECKO(1495) | 1607361641718	Marionette	TRACE	Received observer notification xpcom-will-shutdown
[task 2020-12-07T17:20:41.741Z] 17:20:41     INFO - GECKO(1495) | 1607361641718	Marionette	INFO	Stopped listening on port 2828
[task 2020-12-07T17:20:41.741Z] 17:20:41     INFO - GECKO(1495) | 1607361641718	Marionette	DEBUG	Marionette stopped listening
[task 2020-12-07T17:20:41.904Z] 17:20:41     INFO - TEST-INFO | Main app process: exit 0
[task 2020-12-07T17:20:41.905Z] 17:20:41     INFO - runtests.py | Application ran for: 0:11:25.163419
[task 2020-12-07T17:20:41.905Z] 17:20:41     INFO - zombiecheck | Reading PID log: /var/folders/z_/m0q46qh13mvdf_kp2rb8r3l8000017/T/tmpcYKVBZpidlog
[task 2020-12-07T17:20:41.905Z] 17:20:41     INFO - ==> process 1495 launched child process 1496
[task 2020-12-07T17:20:41.905Z] 17:20:41     INFO - ==> process 1495 launched child process 1497
[task 2020-12-07T17:20:41.905Z] 17:20:41     INFO - ==> process 1495 launched child process 1498
[task 2020-12-07T17:20:41.906Z] 17:20:41     INFO - ==> process 1495 launched child process 1499
[task 2020-12-07T17:20:41.907Z] 17:20:41     INFO - zombiecheck | Checking for orphan process with PID: 1496
[task 2020-12-07T17:20:41.907Z] 17:20:41     INFO - zombiecheck | Checking for orphan process with PID: 1497
[task 2020-12-07T17:20:41.907Z] 17:20:41     INFO - zombiecheck | Checking for orphan process with PID: 1498
[task 2020-12-07T17:20:41.907Z] 17:20:41     INFO - zombiecheck | Checking for orphan process with PID: 1499
[task 2020-12-07T17:20:41.907Z] 17:20:41     INFO - Stopping web server
[task 2020-12-07T17:20:41.910Z] 17:20:41     INFO - Stopping web socket server
[task 2020-12-07T17:20:42.082Z] 17:20:42     INFO - Stopping ssltunnel
[task 2020-12-07T17:20:42.123Z] 17:20:42  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2020-12-07T17:20:42.123Z] 17:20:42     INFO - runtests.py | Running tests: end.
[task 2020-12-07T17:20:42.180Z] 17:20:42     INFO - Buffered messages finished
[task 2020-12-07T17:20:42.180Z] 17:20:42     INFO - Running manifest: dom/tests/mochitest/dom-level0/mochitest.ini
[task 2020-12-07T17:20:42.689Z] 17:20:42     INFO -  pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2020-12-07T17:20:42.746Z] 17:20:42     INFO - MochitestServer : launching [u'/Users/cltbld/tasks/task_1607359832/build/tests/bin/xpcshell', '-g', '/Users/cltbld/tasks/task_1607359832/build/application/Firefox.app/Contents/Resources', '-f', '/Users/cltbld/tasks/task_1607359832/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/var/folders/z_/m0q46qh13mvdf_kp2rb8r3l8000017/T/tmpGftHSo.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/Users/cltbld/tasks/task_1607359832/build/tests/mochitest/server.js']
[task 2020-12-07T17:20:42.746Z] 17:20:42     INFO - runtests.py | Server pid: 1627
[task 2020-12-07T17:20:42.746Z] 17:20:42     INFO - runtests.py | Websocket server pid: 1628
[task 2020-12-07T17:20:42.757Z] 17:20:42     INFO - runtests.py | SSL tunnel pid: 1629
[task 2020-12-07T17:20:42.962Z] 17:20:42     INFO - runtests.py | Running with scheme: http
[task 2020-12-07T17:20:42.962Z] 17:20:42     INFO - runtests.py | Running with e10s: True
[task 2020-12-07T17:20:42.962Z] 17:20:42     INFO - runtests.py | Running with fission: False
[task 2020-12-07T17:20:42.962Z] 17:20:42     INFO - runtests.py | Running with serviceworker_e10s: True
[task 2020-12-07T17:20:42.962Z] 17:20:42     INFO - runtests.py | Running with socketprocess_e10s: False
[task 2020-12-07T17:20:42.963Z] 17:20:42     INFO - runtests.py | Running tests: start.
[task 2020-12-07T17:20:42.963Z] 17:20:42     INFO - 
[task 2020-12-07T17:20:42.963Z] 17:20:42     INFO - Application command: /Users/cltbld/tasks/task_1607359832/build/application/Firefox.app/Contents/MacOS/firefox -marionette -foreground -profile /var/folders/z_/m0q46qh13mvdf_kp2rb8r3l8000017/T/tmpGftHSo.mozrunner
[task 2020-12-07T17:20:42.963Z] 17:20:42     INFO - runtests.py | Application pid: 1630
[task 2020-12-07T17:20:42.963Z] 17:20:42     INFO - TEST-INFO | started process GECKO(1630)```
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 4 years ago4 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 4 years ago3 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.