Closed Bug 942411 Opened 10 years ago Closed 8 years ago

Intermittent test_ignoreuserfocus.html | Test timed out.

Categories

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

ARM
Gonk (Firefox OS)
defect
Not set
normal
Points:
2

Tracking

()

RESOLVED FIXED
2.2 S8 (20mar)
Tracking Status
firefox28 --- wontfix
firefox29 --- wontfix
firefox30 --- wontfix
firefox31 --- wontfix
firefox32 --- wontfix
firefox33 --- fixed
firefox34 --- fixed
firefox35 --- fixed
firefox36 --- disabled
firefox37 --- fixed
firefox38 --- fixed
firefox39 --- fixed
firefox-esr24 --- unaffected
firefox-esr31 --- wontfix
b2g-v1.3 --- wontfix
b2g-v1.3T --- wontfix
b2g-v1.4 --- wontfix
b2g-v2.0 --- fixed
b2g-v2.0M --- fixed
b2g-v2.1 --- fixed
b2g-v2.2 --- fixed
b2g-master --- fixed

People

(Reporter: philor, Assigned: enndeakin)

References

Details

(Keywords: intermittent-failure)

Attachments

(3 files)

https://tbpl.mozilla.org/php/getParsedLog.php?id=30992663&tree=Mozilla-Central
b2g_emulator_vm mozilla-central opt test mochitest-2 on 2013-11-22 19:05:21 PST for push 98aa428a392c
slave: tst-linux64-ec2-136

19:43:09     INFO -  33839 INFO TEST-START | /tests/content/html/content/test/test_ignoreuserfocus.html
19:43:09     INFO -  ###################################### forms.js loaded
19:43:09     INFO -  ############################### browserElementPanning.js loaded
19:43:09     INFO -  ######################## BrowserElementChildPreload.js loaded
19:43:09     INFO -  33840 ERROR TEST-UNEXPECTED-FAIL | /tests/content/html/content/test/test_ignoreuserfocus.html | Test timed out.
19:43:09     INFO -  33841 INFO TEST-INFO | MEMORY STAT vsize after test: 96653312
19:43:09     INFO -  33842 INFO TEST-INFO | MEMORY STAT residentFast after test: 45309952
19:43:09     INFO -  33843 INFO TEST-INFO | MEMORY STAT heapAllocated after test: 16736484
19:43:09     INFO -  33844 INFO TEST-END | /tests/content/html/content/test/test_ignoreuserfocus.html | finished in 323394ms
Of the tests that haven't been disabled yet, this is probably the most frequent mochitest-3 failure we're still hitting. Andrew, if you can help find an owner, that would be cool :)
Flags: needinfo?(overholt)
Assignee: nobody → kchen
Attached patch Force reflow — — Splinter Review
Try looks greenish.
Attachment #8380118 - Flags: review?(bugs)
Flags: needinfo?(overholt)
Comment on attachment 8380118 [details] [diff] [review]
Force reflow

Use iframe.offsetLeft for forcing reflow?
Attachment #8380118 - Flags: review?(bugs) → review+
https://hg.mozilla.org/mozilla-central/rev/58484bba3199
Status: NEW → RESOLVED
Closed: 9 years ago
Resolution: --- → FIXED
Whiteboard: [qa-]
Status: RESOLVED → REOPENED
Resolution: FIXED → ---
This is quite obviously not fixed and currently one of our top oranges.
Nothing in this test ensures that the test window has the focus, let's try to see if this can be the cause:

https://hg.mozilla.org/integration/mozilla-inbound/rev/0d77baea6b58
Keywords: leave-open
Hmm, both comment 249 and comment 252 are from after my fix.  What happens is very interesting:

22:50:18     INFO -  691 INFO TEST-START | /tests/content/html/content/test/test_ignoreuserfocus.html
22:50:20     INFO -  ############################### browserElementPanning.js loaded
22:50:20     INFO -  ######################## BrowserElementChildPreload.js loaded
22:55:37     INFO -  692 INFO TEST-UNEXPECTED-FAIL | /tests/content/html/content/test/test_ignoreuserfocus.html | Test timed out.
22:55:38     INFO -  693 INFO TEST-INFO | MEMORY STAT vsize after test: 95911936
22:55:39     INFO -  694 INFO TEST-INFO | MEMORY STAT residentFast after test: 44666880
22:55:39     INFO -  695 INFO TEST-INFO | MEMORY STAT heapAllocated after test: 18193988
22:55:39     INFO -  696 INFO TEST-END | /tests/content/html/content/test/test_ignoreuserfocus.html | finished in 320385ms
22:55:40     INFO -  697 INFO TEST-INFO | dumping last 14 message(s)
22:55:40     INFO -  698 INFO TEST-INFO | if you need more context, please use SimpleTest.requestCompleteLog() in your test
22:55:40     INFO -  699 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | witness should have the focus
22:55:41     INFO -  700 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | [explicit iframe.focus()] iframe should not get the focus
22:55:41     INFO -  701 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | Shouldn't get a focus event in ignoreuserfocus iframe!
22:55:41     INFO -  702 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | Shouldn't get a focus event in ignoreuserfocus iframe!
22:55:41     INFO -  703 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | [explicit iframe.focus()] iframe should get the focus
22:55:41     INFO -  704 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | [explicit innerInput.focus()] iframe should not have the focus
22:55:41     INFO -  705 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | [synthesize mouse click] witness should have the focus
22:55:41     INFO -  706 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | [explicit innerIframe.focus()] iframe should not have the focus
22:55:41     INFO -  707 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | [synthesize mouse click inner iframe] witness should have the focus
22:55:41     INFO -  708 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | [explicit innerArea.focus()] iframe should not have the focus
22:55:41     INFO -  709 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | [synthesize mouse click] witness should have the focus
22:55:41     INFO -  710 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | witness should have the focus
22:55:41     INFO -  711 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | [synthesize tab key] iframe should not have the focus
22:55:41     INFO -  712 INFO TEST-PASS | /tests/content/html/content/test/test_ignoreuserfocus.html | witness2 should have the focus
22:55:41     INFO -  713 INFO TEST-UNEXPECTED-FAIL | /tests/content/html/content/test/test_ignoreuserfocus.html | [SimpleTest.finish()] this test already called finish!
22:55:41     INFO -  714 ERROR TEST-UNEXPECTED-FAIL | /tests/content/html/content/test/test_ignoreuserfocus.html | called finish() multiple times

It seems that the test runs until finish() is called, and then just hangs around until it times out and finish is called again on it, or something.  Adding SimpleTest.requestCompleteLog() to get in-order logging:

https://hg.mozilla.org/integration/mozilla-inbound/rev/c313ebdadc15