1466966 - Intermittent accessible/tests/mochitest/jsat/test_text_editable_navigation.html | Test timed out.

Status: RESOLVED INCOMPLETE

(Core :: Disability Access APIs, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: csabou [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=181897801&repo=try

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

[task 2018-06-05T16:59:05.092Z] 16:59:05     INFO - TEST-START | accessible/tests/mochitest/jsat/test_text_editable_navigation.html
[task 2018-06-05T16:59:05.434Z] 16:59:05     INFO - GECKO(1017) | WARNING: content window passed to PrivateBrowsingUtils.isWindowPrivate. Use isContentWindowPrivate instead (but only for frame scripts).
[task 2018-06-05T16:59:05.435Z] 16:59:05     INFO - GECKO(1017) | pbu_isWindowPrivate@resource://gre/modules/PrivateBrowsingUtils.jsm:26:14
[task 2018-06-05T16:59:05.435Z] 16:59:05     INFO - GECKO(1017) | windowPrivacyMatches@chrome://browser/content/browser-sidebar.js:240:12
[task 2018-06-05T16:59:05.437Z] 16:59:05     INFO - GECKO(1017) | startDelayedLoad@chrome://browser/content/browser-sidebar.js:253:10
[task 2018-06-05T16:59:05.438Z] 16:59:05     INFO - GECKO(1017) | _delayedStartup/<@chrome://browser/content/browser.js:1576:7
[task 2018-06-05T16:59:05.484Z] 16:59:05     INFO - GECKO(1017) | JavaScript error: resource:///modules/PageStyleHandler.jsm, line 55: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIDocShell.tabChild]
[task 2018-06-05T17:04:13.915Z] 17:04:13     INFO - TEST-INFO | started process screentopng
[task 2018-06-05T17:04:14.198Z] 17:04:14     INFO - TEST-INFO | screentopng: exit 0
[task 2018-06-05T17:04:14.201Z] 17:04:14     INFO - Buffered messages logged at 16:59:05
[task 2018-06-05T17:04:14.202Z] 17:04:14     INFO - must wait for load
[task 2018-06-05T17:04:14.203Z] 17:04:14     INFO - Buffered messages finished
[task 2018-06-05T17:04:14.204Z] 17:04:14     INFO - TEST-UNEXPECTED-FAIL | accessible/tests/mochitest/jsat/test_text_editable_navigation.html | Test timed out. 
[task 2018-06-05T17:04:14.205Z] 17:04:14     INFO - reportError@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:121:7
[task 2018-06-05T17:04:14.205Z] 17:04:14     INFO - TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:142:7
[task 2018-06-05T17:04:14.913Z] 17:04:14     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-06-05T17:04:14.915Z] 17:04:14     INFO - TEST-UNEXPECTED-FAIL | accessible/tests/mochitest/jsat/test_text_editable_navigation.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 2018-06-05T17:04:14.916Z] 17:04:14     INFO - SimpleTest.is@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:312:5
[task 2018-06-05T17:04:14.917Z] 17:04:14     INFO - afterCleanup@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1179:13
[task 2018-06-05T17:04:14.918Z] 17:04:14     INFO - executeCleanupFunction@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1221:13
[task 2018-06-05T17:04:14.920Z] 17:04:14     INFO - SimpleTest.finish@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1240:5
[task 2018-06-05T17:04:14.921Z] 17:04:14     INFO - killTest@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:130:7
[task 2018-06-05T17:04:14.921Z] 17:04:14     INFO - delayedKillTest@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:157:47
[task 2018-06-05T17:04:14.923Z] 17:04:14     INFO - GECKO(1017) | MEMORY STAT | vsize 2522MB | residentFast 326MB | heapAllocated 122MB
[task 2018-06-05T17:04:14.924Z] 17:04:14     INFO - TEST-OK | accessible/tests/mochitest/jsat/test_text_editable_navigation.html | took 309824ms

Comment 1

[Intermittent Failures Robot]

1 failures in 669 pushes (0.001 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* try: 1

Platform breakdown:
* linux64-nightly: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1466966&startday=2018-06-04&endday=2018-06-10&tree=trunk

Comment 2

[Intermittent Failures Robot]

1 failures in 408 pushes (0.002 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* linux32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1466966&startday=2018-06-11&endday=2018-06-17&tree=trunk

Comment 3

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 4

[Arthur Iakab [arthur_iakab]]

Failed here https://treeherder.mozilla.org/#/jobs?repo=mozilla-inbound&revision=ae9049c5ac637ae688f0085c4d464742b9238126&filter-resultStatus=testfailed&filter-resultStatus=busted&filter-resultStatus=exception&filter-classifiedState=unclassified

Link to a recent log :https://treeherder.mozilla.org/logviewer.html#?job_id=187468330&repo=mozilla-inbound&lineNumber=8136

Part of that log: 21:51:19     INFO -  275 INFO TEST-START | accessible/tests/mochitest/jsat/test_text_editable_navigation.html
21:51:20     INFO -  GECKO(424) | WARNING: content window passed to PrivateBrowsingUtils.isWindowPrivate. Use isContentWindowPrivate instead (but only for frame scripts).
21:51:20     INFO -  GECKO(424) | pbu_isWindowPrivate@resource://gre/modules/PrivateBrowsingUtils.jsm:31:14
21:51:20     INFO -  GECKO(424) | windowPrivacyMatches@chrome://browser/content/browser-sidebar.js:240:12
21:51:20     INFO -  GECKO(424) | startDelayedLoad@chrome://browser/content/browser-sidebar.js:253:10
21:51:20     INFO -  GECKO(424) | _delayedStartup/<@chrome://browser/content/browser.js:1567:7
21:51:20     INFO -  GECKO(424) | promise callback*_delayedStartup@chrome://browser/content/browser.js:1558:5
21:51:20     INFO -  GECKO(424) | EventListener.handleEvent*onLoad@chrome://browser/content/browser.js:1390:5
21:51:20     INFO -  GECKO(424) | onload@chrome://browser/content/browser.xul:1:1
21:56:19     INFO -  TEST-INFO | started process screenshot
21:56:19     INFO -  TEST-INFO | screenshot: exit 0
21:56:19     INFO -  Buffered messages logged at 21:51:20
21:56:19     INFO -  276 INFO must wait for load
21:56:19     INFO -  Buffered messages finished
21:56:19    ERROR -  277 INFO TEST-UNEXPECTED-FAIL | accessible/tests/mochitest/jsat/test_text_editable_navigation.html | Test timed out.
21:56:19     INFO -  reportError@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:121:7
21:56:19     INFO -  TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:142:7
21:56:19     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:19     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:19     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:19     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:19     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:19     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:19     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:19     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:19     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:19     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:19     INFO -  TestRunner.runTests/<@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:381:9
21:56:19     INFO -  promise callback*TestRunner.runTests@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:368:5
21:56:19     INFO -  RunSet.runtests@chrome://mochikit/content/tests/SimpleTest/setup.js:194:3
21:56:19     INFO -  RunSet.runall@chrome://mochikit/content/tests/SimpleTest/setup.js:173:5
21:56:19     INFO -  hookupTests@chrome://mochikit/content/tests/SimpleTest/setup.js:266:5
21:56:19     INFO -  parseTestManifest@chrome://mochikit/content/manifestLibrary.js:38:5
21:56:19     INFO -  getTestManifest/req.onload@chrome://mochikit/content/manifestLibrary.js:49:11
21:56:19     INFO -  EventHandlerNonNull*getTestManifest@chrome://mochikit/content/manifestLibrary.js:45:3
21:56:19     INFO -  hookup@chrome://mochikit/content/tests/SimpleTest/setup.js:246:5
21:56:19     INFO -  linkAndHookup@chrome://mochikit/content/harness.xul:54:3
21:56:19     INFO -  parseTestManifest@chrome://mochikit/content/manifestLibrary.js:38:5
21:56:19     INFO -  getTestManifest/req.onload@chrome://mochikit/content/manifestLibrary.js:49:11
21:56:19     INFO -  EventHandlerNonNull*getTestManifest@chrome://mochikit/content/manifestLibrary.js:45:3
21:56:19     INFO -  getTestList@chrome://mochikit/content/chrome-harness.js:256:3
21:56:19     INFO -  loadTests@chrome://mochikit/content/harness.xul:33:3
21:56:19     INFO -  EventListener.handleEvent*@chrome://mochikit/content/harness.xul:57:5
21:56:20     INFO -  Not taking screenshot here: see the one that was previously logged
21:56:20    ERROR -  278 INFO TEST-UNEXPECTED-FAIL | accessible/tests/mochitest/jsat/test_text_editable_navigation.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
21:56:20     INFO -  SimpleTest.is@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:312:5
21:56:20     INFO -  afterCleanup@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1179:13
21:56:20     INFO -  executeCleanupFunction@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1221:13
21:56:20     INFO -  SimpleTest.finish@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1240:5
21:56:20     INFO -  killTest@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:130:7
21:56:20     INFO -  delayedKillTest@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:157:47
21:56:20     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:157:7
21:56:20     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:20     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:20     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:20     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:20     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:20     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:20     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:20     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:20     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:20     INFO -  setTimeout handler*TestRunner._checkForHangs@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:163:5
21:56:20     INFO -  TestRunner.runTests/<@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:381:9
21:56:20     INFO -  promise callback*TestRunner.runTests@chrome://mochikit/content/tests/SimpleTest/TestRunner.js:368:5
21:56:20     INFO -  RunSet.runtests@chrome://mochikit/content/tests/SimpleTest/setup.js:194:3
21:56:20     INFO -  RunSet.runall@chrome://mochikit/content/tests/SimpleTest/setup.js:173:5
21:56:20     INFO -  hookupTests@chrome://mochikit/content/tests/SimpleTest/setup.js:266:5
21:56:20     INFO -  parseTestManifest@chrome://mochikit/content/manifestLibrary.js:38:5
21:56:20     INFO -  getTestManifest/req.onload@chrome://mochikit/content/manifestLibrary.js:49:11
21:56:20     INFO -  EventHandlerNonNull*getTestManifest@chrome://mochikit/content/manifestLibrary.js:45:3
21:56:20     INFO -  hookup@chrome://mochikit/content/tests/SimpleTest/setup.js:246:5
21:56:20     INFO -  linkAndHookup@chrome://mochikit/content/harness.xul:54:3
21:56:20     INFO -  parseTestManifest@chrome://mochikit/content/manifestLibrary.js:38:5
21:56:20     INFO -  getTestManifest/req.onload@chrome://mochikit/content/manifestLibrary.js:49:11
21:56:20     INFO -  EventHandlerNonNull*getTestManifest@chrome://mochikit/content/manifestLibrary.js:45:3
21:56:20     INFO -  getTestList@chrome://mochikit/content/chrome-harness.js:256:3
21:56:20     INFO -  loadTests@chrome://mochikit/content/harness.xul:33:3
21:56:20     INFO -  EventListener.handleEvent*@chrome://mochikit/content/harness.xul:57:5
21:56:20     INFO -  GECKO(424) | MEMORY STAT | vsize 755MB | vsizeMaxContiguous 682MB | residentFast 237MB | heapAllocated 85MB
21:56:20     INFO -  279 INFO TEST-OK | accessible/tests/mochitest/jsat/test_text_editable_navigation.html | took 301234ms

Comment 5

[Intermittent Failures Robot]

1 failures in 623 pushes (0.002 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* windows7-32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1466966&startday=2018-07-09&endday=2018-07-15&tree=trunk

Comment 6

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 7

[Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)]

https://treeherder.mozilla.org/logviewer.html#?job_id=197314783&repo=autoland

Comment 8

[Intermittent Failures Robot]

1 failures in 2667 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1

Platform breakdown:
* windows7-32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1466966&startday=2018-09-03&endday=2018-09-09&tree=all

Comment 9

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup