Closed Bug 1445330 Opened 6 years ago Closed 6 years ago

Intermittent dom/html/test/test_fullscreen-api-race.html | Should get fullscreenchange - got "fullscreenerror", expected "fullscreenchange"

Categories

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

defect
Not set
normal

Tracking

()

RESOLVED FIXED

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure, Whiteboard: [stockwell fixed:backout])

Filed by: apavel [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=167639860&repo=mozilla-central

https://queue.taskcluster.net/v1/task/e86RZoe0RhKjbWDTzvsaxQ/runs/0/artifacts/public/logs/live_backing.log

[task 2018-03-13T11:07:37.478Z] 11:07:37     INFO - TEST-START | dom/html/test/test_fullscreen-api-race.html
[task 2018-03-13T11:07:38.953Z] 11:07:38     INFO - TEST-INFO | started process screentopng
[task 2018-03-13T11:07:39.283Z] 11:07:39     INFO - TEST-INFO | screentopng: exit 0
[task 2018-03-13T11:07:39.285Z] 11:07:39     INFO - Buffered messages logged at 11:07:37
[task 2018-03-13T11:07:39.285Z] 11:07:39     INFO - TEST-PASS | dom/html/test/test_fullscreen-api-race.html | A valid string reason is expected 
[task 2018-03-13T11:07:39.286Z] 11:07:39     INFO - TEST-PASS | dom/html/test/test_fullscreen-api-race.html | Reason cannot be empty 
[task 2018-03-13T11:07:39.287Z] 11:07:39     INFO - Testing openNewTab, navigate
[task 2018-03-13T11:07:39.288Z] 11:07:39     INFO - About to enter fullscreen
[task 2018-03-13T11:07:39.288Z] 11:07:39     INFO - TEST-PASS | dom/html/test/test_fullscreen-api-race.html | Should get fullscreenchange 
[task 2018-03-13T11:07:39.289Z] 11:07:39     INFO - TEST-PASS | dom/html/test/test_fullscreen-api-race.html | Should have entered fullscreen 
[task 2018-03-13T11:07:39.290Z] 11:07:39     INFO - TEST-PASS | dom/html/test/test_fullscreen-api-race.html | The window should be in fullscreen 
[task 2018-03-13T11:07:39.290Z] 11:07:39     INFO - About to navigate to another page
[task 2018-03-13T11:07:39.291Z] 11:07:39     INFO - must wait for load
[task 2018-03-13T11:07:39.292Z] 11:07:39     INFO - TEST-PASS | dom/html/test/test_fullscreen-api-race.html | The window should have been closed 
[task 2018-03-13T11:07:39.292Z] 11:07:39     INFO - TEST-FAIL | dom/html/test/test_fullscreen-api-race.html | The author of the test has indicated that flaky timeouts are expected.  Reason: Need to wait for potential fullscreen transition 
[task 2018-03-13T11:07:39.293Z] 11:07:39     INFO - Buffered messages logged at 11:07:38
[task 2018-03-13T11:07:39.293Z] 11:07:39     INFO - Testing openNewTab, closeWindow
[task 2018-03-13T11:07:39.294Z] 11:07:39     INFO - About to enter fullscreen
[task 2018-03-13T11:07:39.294Z] 11:07:39     INFO - TEST-FAIL | dom/html/test/test_fullscreen-api-race.html | Failed to enter fullscreen, but try again 
[task 2018-03-13T11:07:39.295Z] 11:07:39     INFO - Buffered messages finished
[task 2018-03-13T11:07:39.296Z] 11:07:39     INFO - TEST-UNEXPECTED-FAIL | dom/html/test/test_fullscreen-api-race.html | Should get fullscreenchange - got "fullscreenerror", expected "fullscreenchange"
[task 2018-03-13T11:07:39.296Z] 11:07:39     INFO -     SimpleTest.is@SimpleTest/SimpleTest.js:312:5
[task 2018-03-13T11:07:39.297Z] 11:07:39     INFO -     listener@dom/html/test/test_fullscreen-api-race.html:125:9
[task 2018-03-13T11:07:39.298Z] 11:07:39     INFO -     EventListener.handleEvent*runTest/</<@dom/html/test/test_fullscreen-api-race.html:138:7
[task 2018-03-13T11:07:39.299Z] 11:07:39     INFO -     runTest/<@dom/html/test/test_fullscreen-api-race.html:112:12
[task 2018-03-13T11:07:39.299Z] 11:07:39     INFO -     promise callback*runTest@dom/html/test/test_fullscreen-api-race.html:109:10
[task 2018-03-13T11:07:39.300Z] 11:07:39     INFO -     next@dom/html/test/test_fullscreen-api-race.html:151:5
[task 2018-03-13T11:07:39.301Z] 11:07:39     INFO -     focusedOrLoaded/<@SimpleTest/SimpleTest.js:795:59
[task 2018-03-13T11:07:39.302Z] 11:07:39     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-03-13T11:07:39.303Z] 11:07:39     INFO - TEST-UNEXPECTED-FAIL | dom/html/test/test_fullscreen-api-race.html | Should have entered fullscreen 
[task 2018-03-13T11:07:39.304Z] 11:07:39     INFO -     listener@dom/html/test/test_fullscreen-api-race.html:126:9
[task 2018-03-13T11:07:39.305Z] 11:07:39     INFO -     EventListener.handleEvent*runTest/</<@dom/html/test/test_fullscreen-api-race.html:138:7
[task 2018-03-13T11:07:39.306Z] 11:07:39     INFO -     runTest/<@dom/html/test/test_fullscreen-api-race.html:112:12
[task 2018-03-13T11:07:39.306Z] 11:07:39     INFO -     promise callback*runTest@dom/html/test/test_fullscreen-api-race.html:109:10
[task 2018-03-13T11:07:39.307Z] 11:07:39     INFO -     next@dom/html/test/test_fullscreen-api-race.html:151:5
[task 2018-03-13T11:07:39.308Z] 11:07:39     INFO -     focusedOrLoaded/<@SimpleTest/SimpleTest.js:795:59
[task 2018-03-13T11:07:39.309Z] 11:07:39     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-03-13T11:07:39.310Z] 11:07:39     INFO - TEST-UNEXPECTED-FAIL | dom/html/test/test_fullscreen-api-race.html | The window should be in fullscreen 
[task 2018-03-13T11:07:39.310Z] 11:07:39     INFO -     listener@dom/html/test/test_fullscreen-api-race.html:127:9
[task 2018-03-13T11:07:39.311Z] 11:07:39     INFO -     EventListener.handleEvent*runTest/</<@dom/html/test/test_fullscreen-api-race.html:138:7
[task 2018-03-13T11:07:39.312Z] 11:07:39     INFO -     runTest/<@dom/html/test/test_fullscreen-api-race.html:112:12
[task 2018-03-13T11:07:39.312Z] 11:07:39     INFO -     promise callback*runTest@dom/html/test/test_fullscreen-api-race.html:109:10
[task 2018-03-13T11:07:39.312Z] 11:07:39     INFO -     next@dom/html/test/test_fullscreen-api-race.html:151:5
[task 2018-03-13T11:07:39.313Z] 11:07:39     INFO -     focusedOrLoaded/<@SimpleTest/SimpleTest.js:795:59
[task 2018-03-13T11:07:39.314Z] 11:07:39     INFO - About to close the window
[task 2018-03-13T11:07:39.315Z] 11:07:39     INFO - TEST-PASS | dom/html/test/test_fullscreen-api-race.html | The window should have been closed 
[task 2018-03-13T11:07:39.316Z] 11:07:39     INFO - TEST-FAIL | dom/html/test/test_fullscreen-api-race.html | The author of the test has indicated that flaky timeouts are expected.  Reason: Need to wait for potential fullscreen transition 
[task 2018-03-13T11:07:39.957Z] 11:07:39     INFO - Testing openNewTab, exitFullscreen
[task 2018-03-13T11:07:40.022Z] 11:07:40     INFO - About to enter fullscreen
[task 2018-03-13T11:07:40.031Z] 11:07:40     INFO - TEST-FAIL | dom/html/test/test_fullscreen-api-race.html | Failed to enter fullscreen, but try again 
[task 2018-03-13T11:07:40.036Z] 11:07:40     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-03-13T11:07:40.037Z] 11:07:40     INFO - TEST-UNEXPECTED-FAIL | dom/html/test/test_fullscreen-api-race.html | Should get fullscreenchange - got "fullscreenerror", expected "fullscreenchange"
[task 2018-03-13T11:07:40.037Z] 11:07:40     INFO -     SimpleTest.is@SimpleTest/SimpleTest.js:312:5
[task 2018-03-13T11:07:40.038Z] 11:07:40     INFO -     listener@dom/html/test/test_fullscreen-api-race.html:125:9
[task 2018-03-13T11:07:40.038Z] 11:07:40     INFO -     EventListener.handleEvent*runTest/</<@dom/html/test/test_fullscreen-api-race.html:138:7
[task 2018-03-13T11:07:40.039Z] 11:07:40     INFO -     runTest/<@dom/html/test/test_fullscreen-api-race.html:112:12
[task 2018-03-13T11:07:40.039Z] 11:07:40     INFO -     promise callback*runTest@dom/html/test/test_fullscreen-api-race.html:109:10
[task 2018-03-13T11:07:40.040Z] 11:07:40     INFO -     next@dom/html/test/test_fullscreen-api-race.html:151:5
[task 2018-03-13T11:07:40.041Z] 11:07:40     INFO -     focusedOrLoaded/<@SimpleTest/SimpleTest.js:795:59
[task 2018-03-13T11:07:40.044Z] 11:07:40     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-03-13T11:07:40.045Z] 11:07:40     INFO - TEST-UNEXPECTED-FAIL | dom/html/test/test_fullscreen-api-race.html | Should have entered fullscreen 
[task 2018-03-13T11:07:40.046Z] 11:07:40     INFO -     listener@dom/html/test/test_fullscreen-api-race.html:126:9
[task 2018-03-13T11:07:40.046Z] 11:07:40     INFO -     EventListener.handleEvent*runTest/</<@dom/html/test/test_fullscreen-api-race.html:138:7
[task 2018-03-13T11:07:40.047Z] 11:07:40     INFO -     runTest/<@dom/html/test/test_fullscreen-api-race.html:112:12
[task 2018-03-13T11:07:40.047Z] 11:07:40     INFO -     promise callback*runTest@dom/html/test/test_fullscreen-api-race.html:109:10
[task 2018-03-13T11:07:40.047Z] 11:07:40     INFO -     next@dom/html/test/test_fullscreen-api-race.html:151:5
[task 2018-03-13T11:07:40.048Z] 11:07:40     INFO -     focusedOrLoaded/<@SimpleTest/SimpleTest.js:795:59
[task 2018-03-13T11:07:40.048Z] 11:07:40     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-03-13T11:07:40.050Z] 11:07:40     INFO - TEST-UNEXPECTED-FAIL | dom/html/test/test_fullscreen-api-race.html | The window should be in fullscreen 
[task 2018-03-13T11:07:40.051Z] 11:07:40     INFO -     listener@dom/html/test/test_fullscreen-api-race.html:127:9
[task 2018-03-13T11:07:40.051Z] 11:07:40     INFO -     EventListener.handleEvent*runTest/</<@dom/html/test/test_fullscreen-api-race.html:138:7
[task 2018-03-13T11:07:40.052Z] 11:07:40     INFO -     runTest/<@dom/html/test/test_fullscreen-api-race.html:112:12
[task 2018-03-13T11:07:40.052Z] 11:07:40     INFO -     promise callback*runTest@dom/html/test/test_fullscreen-api-race.html:109:10
[task 2018-03-13T11:07:40.052Z] 11:07:40     INFO -     next@dom/html/test/test_fullscreen-api-race.html:151:5
[task 2018-03-13T11:07:40.053Z] 11:07:40     INFO -     focusedOrLoaded/<@SimpleTest/SimpleTest.js:795:59
[task 2018-03-13T11:07:40.053Z] 11:07:40     INFO - About to cancel fullscreen
[task 2018-03-13T11:12:59.349Z] 11:12:59     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-03-13T11:12:59.351Z] 11:12:59     INFO - TEST-UNEXPECTED-FAIL | dom/html/test/test_fullscreen-api-race.html | Test timed out. 
[task 2018-03-13T11:12:59.351Z] 11:12:59     INFO -     reportError@SimpleTest/TestRunner.js:121:7
[task 2018-03-13T11:12:59.352Z] 11:12:59     INFO -     TestRunner._checkForHangs@SimpleTest/TestRunner.js:142:7
[task 2018-03-13T11:12:59.353Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.353Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.354Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.354Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.355Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.356Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.357Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.358Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.358Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.359Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.360Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.361Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.361Z] 11:12:59     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2018-03-13T11:12:59.362Z] 11:12:59     INFO -     TestRunner.runTests@SimpleTest/TestRunner.js:380:5
[task 2018-03-13T11:12:59.362Z] 11:12:59     INFO -     RunSet.runtests@SimpleTest/setup.js:194:3
[task 2018-03-13T11:12:59.363Z] 11:12:59     INFO -     RunSet.runall@SimpleTest/setup.js:173:5
[task 2018-03-13T11:12:59.364Z] 11:12:59     INFO -     hookupTests@SimpleTest/setup.js:266:5
[task 2018-03-13T11:12:59.364Z] 11:12:59     INFO - parseTestManifest@http://mochi.test:8888/manifestLibrary.js:36:5
[task 2018-03-13T11:12:59.365Z] 11:12:59     INFO - getTestManifest/req.onload@http://mochi.test:8888/manifestLibrary.js:49:11
[task 2018-03-13T11:12:59.365Z] 11:12:59     INFO - EventHandlerNonNull*getTestManifest@http://mochi.test:8888/manifestLibrary.js:45:3
[task 2018-03-13T11:12:59.366Z] 11:12:59     INFO -     hookup@SimpleTest/setup.js:246:5
Since this bug was created,a day ago, there already are 48 failures.
:overholt could you please take a look?
Flags: needinfo?(overholt)
I am tempted to back out bug 1423220 instead of disabling this test.
Whiteboard: [stockwell disable-recommended] → [stockwell fixed:backout]
I've got a fix cooking in bug 1423220 so I can get warming re-enabled by default.
Flags: needinfo?(mconley)
Status: NEW → RESOLVED
Closed: 6 years ago
Flags: needinfo?(overholt)
Resolution: --- → FIXED
Component: DOM → DOM: Core & HTML
You need to log in before you can comment on or make changes to this bug.