Intermittent test_gesture_tracker.html | Test timed out | test_live_regions.html,test_pointer_relay.html | uncaught exception - Error: Only one top-level window could used with AccessFu at resource://gre/modules/accessibility/Utils.jsm:38

RESOLVED FIXED in Firefox 31

Status

()

defect
RESOLVED FIXED
5 years ago
5 years ago

People

(Reporter: RyanVM, Assigned: yzen)

Tracking

({intermittent-failure})

Trunk
mozilla32
x86_64
Linux
Points:
---

Firefox Tracking Flags

(firefox30 unaffected, firefox31 fixed, firefox32 fixed, firefox-esr24 unaffected)

Details

Attachments

(1 attachment, 5 obsolete attachments)

https://tbpl.mozilla.org/php/getParsedLog.php?id=38533226&tree=Mozilla-Inbound

Ubuntu VM 12.04 x64 mozilla-inbound debug test mochitest-other on 2014-04-25 17:42:18 PDT for push 159a32e886d0
slave: tst-linux64-spot-151

18:32:56     INFO -  398 INFO TEST-INFO | if you need more context, please use SimpleTest.requestCompleteLog() in your test
18:32:56     INFO -  399 INFO TEST-INFO | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | must wait for load
18:32:56     INFO -  400 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: tap.
18:32:56     INFO -  401 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: tap.
18:32:56     INFO -  402 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: dwell.
18:32:56     INFO -  403 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: dwellend.
18:32:56     INFO -  404 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: tap.
18:32:56     INFO -  405 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: doubletap.
18:32:56     INFO -  406 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: tap.
18:32:56     INFO -  407 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: doubletap.
18:32:56     INFO -  408 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: tripletap.
18:32:56     INFO -  409 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: tap.
18:32:56     INFO -  410 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: doubletap.
18:32:56     INFO -  411 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: doubletaphold.
18:32:56     INFO -  412 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: doubletapholdend.
18:32:56     INFO -  413 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: tap.
18:32:56     INFO -  414 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: taphold.
18:32:56     INFO -  415 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: tapholdend.
18:32:56     INFO -  416 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: swiperight.
18:32:56     INFO -  417 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: swiperight.
18:32:56     INFO -  418 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: swipeleft.
18:32:56     INFO -  419 INFO TEST-PASS | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Received correct mozAccessFuGesture: swipedown.
18:32:56     INFO -  Xlib:  extension "RANDR" missing on display ":0".
18:32:57     INFO -  TEST-INFO | screentopng: exit 0
18:32:57     INFO -  420 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | Test timed out.
18:32:57     INFO -  421 INFO TEST-INFO | MEMORY STAT vsize after test: 1777635328
18:32:57     INFO -  422 INFO TEST-INFO | MEMORY STAT residentFast after test: 345448448
18:32:57     INFO -  423 INFO TEST-END | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_gesture_tracker.html | finished in 328562ms
18:32:57     INFO -  ++DOMWINDOW == 19 (0x4402000) [pid = 3075] [serial = 398] [outer = 0x2faa0d0]
18:32:57     INFO -  424 INFO TEST-START | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_landmarks.html
18:32:57     INFO -  ++DOMWINDOW == 20 (0x65f4430) [pid = 3075] [serial = 399] [outer = 0x2faa0d0]
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:57     INFO -  [Parent 3075] WARNING: the property xml-roles already exists
18:32:57     INFO -  : file /builds/slave/m-in-l64-d-0000000000000000000/build/xpcom/ds/nsPersistentProperties.cpp, line 520
18:32:58     INFO -  425 INFO TEST-INFO | MEMORY STAT vsize after test: 1777831936
18:32:58     INFO -  426 INFO TEST-INFO | MEMORY STAT residentFast after test: 346804224
18:32:58     INFO -  427 INFO TEST-END | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_landmarks.html | finished in 1192ms
18:32:58     INFO -  ++DOMWINDOW == 21 (0x13a1d00) [pid = 3075] [serial = 400] [outer = 0x2faa0d0]
18:32:58     INFO -  428 INFO TEST-START | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_live_regions.html
18:32:58     INFO -  ++DOMWINDOW == 22 (0x6f130d0) [pid = 3075] [serial = 401] [outer = 0x2faa0d0]
18:32:58     INFO -  429 INFO TEST-INFO | dumping last 1 message(s)
18:32:58     INFO -  430 INFO TEST-INFO | if you need more context, please use SimpleTest.requestCompleteLog() in your test
18:32:58     INFO -  431 INFO TEST-INFO | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_live_regions.html | must wait for load
18:32:58     INFO -  432 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_live_regions.html | uncaught exception - Error: Only one top-level window could used with AccessFu at resource://gre/modules/accessibility/Utils.jsm:38
18:32:58     INFO -  JavaScript error: resource://gre/modules/accessibility/Utils.jsm, line 38: Only one top-level window could used with AccessFu
18:32:58     INFO -  433 INFO TEST-INFO | MEMORY STAT vsize after test: 1777831936
18:32:58     INFO -  434 INFO TEST-INFO | MEMORY STAT residentFast after test: 347496448
18:32:58     INFO -  435 INFO TEST-END | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_live_regions.html | finished in 186ms
18:32:59     INFO -  ++DOMWINDOW == 23 (0x4412750) [pid = 3075] [serial = 402] [outer = 0x2faa0d0]
18:32:59     INFO -  436 INFO TEST-START | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_output.html
18:32:59     INFO -  ++DOMWINDOW == 24 (0x4fbcab0) [pid = 3075] [serial = 403] [outer = 0x2faa0d0]
18:33:02     INFO -  437 INFO TEST-INFO | MEMORY STAT vsize after test: 1778298880
18:33:02     INFO -  438 INFO TEST-INFO | MEMORY STAT residentFast after test: 357711872
18:33:02     INFO -  439 INFO TEST-END | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_output.html | finished in 3758ms
18:33:02     INFO -  ++DOMWINDOW == 25 (0x4fb0ef0) [pid = 3075] [serial = 404] [outer = 0x2faa0d0]
18:33:03     INFO -  440 INFO TEST-START | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_pointer_relay.html
18:33:03     INFO -  ++DOMWINDOW == 26 (0x74d0a70) [pid = 3075] [serial = 405] [outer = 0x2faa0d0]
18:33:03     INFO -  441 INFO TEST-INFO | dumping last 1 message(s)
18:33:03     INFO -  442 INFO TEST-INFO | if you need more context, please use SimpleTest.requestCompleteLog() in your test
18:33:03     INFO -  443 INFO TEST-INFO | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_pointer_relay.html | must wait for load
18:33:03     INFO -  444 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_pointer_relay.html | uncaught exception - Error: Only one top-level window could used with AccessFu at resource://gre/modules/accessibility/Utils.jsm:38
18:33:03     INFO -  JavaScript error: resource://gre/modules/accessibility/Utils.jsm, line 38: Only one top-level window could used with AccessFu
18:33:03     INFO -  445 INFO TEST-INFO | MEMORY STAT vsize after test: 1778364416
18:33:03     INFO -  446 INFO TEST-INFO | MEMORY STAT residentFast after test: 358490112
18:33:03     INFO -  447 INFO TEST-END | chrome://mochitests/content/a11y/accessible/tests/mochitest/jsat/test_pointer_relay.html | finished in 246ms
Yura, this sounds like stuff you recently worked on. Can you check if you find anything obvious in the logs?
Posted patch 1001945 patch (obsolete) — Splinter Review
Enabling DEBUG logging for the test to gather more info about the failure.
Attachment #8413780 - Flags: review?(eitan)
Attachment #8413780 - Flags: review?(eitan) → review+
Posted patch 1001945 patch 2 (obsolete) — Splinter Review
Patch that clears some issues with setting/resetting of delay intervals.
Attachment #8416441 - Flags: review?(marco.zehe)
Attachment #8416441 - Flags: review?(marco.zehe) → review+
Keywords: leave-open
Posted patch 1001945 more logging patch (obsolete) — Splinter Review
More logging for pointer events.
Attachment #8417428 - Flags: review?(marco.zehe)
Attachment #8417428 - Flags: review?(marco.zehe) → review+
Posted patch 1001945 patch v2 (obsolete) — Splinter Review
Attachment #8413780 - Attachment is obsolete: true
Attachment #8416441 - Attachment is obsolete: true
Attachment #8417428 - Attachment is obsolete: true
Attachment #8418125 - Flags: review?(eitan)
Comment on attachment 8418125 [details] [diff] [review]
1001945 patch v2

Review of attachment 8418125 [details] [diff] [review]:
-----------------------------------------------------------------

Unless that is some wild js-foo below, I think you are using undeclared variable names. So not automatically r+ing on account of that.

::: accessible/tests/mochitest/jsat/test_gesture_tracker.html
@@ +13,5 @@
>    <script type="application/javascript" src="./dom_helper.js"></script>
>    <script type="application/javascript">
> +    var originalMCGD = GestureSettings.maxConsecutiveGestureDelay,
> +      originalDT = originalDwellThreshold,
> +      originalSMD = originalSwipeMaxDuration;

Where are originalSwipeMaxDuration and originalDwellThreshold defined?

@@ -27,5 @@
>            GestureTracker);
>          gestures.forEach(AccessFuTest.addSequence);
>          AccessFuTest.addFunc(stopGestureTracker);
>          AccessFuTest.waitForExplicitFinish();
> -        Logger.logLevel = Logger.DEBUG;

I think you should just leave debug on. That was my lesson from the intermittent fails I got last time..
Attachment #8418125 - Flags: review?(eitan)
(In reply to Eitan Isaacson [:eeejay] from comment #68)
> Comment on attachment 8418125 [details] [diff] [review]
> 1001945 patch v2
> 
> Review of attachment 8418125 [details] [diff] [review]:
> -----------------------------------------------------------------
> 
> Unless that is some wild js-foo below, I think you are using undeclared
> variable names. So not automatically r+ing on account of that.
> 
> ::: accessible/tests/mochitest/jsat/test_gesture_tracker.html
> @@ +13,5 @@
> >    <script type="application/javascript" src="./dom_helper.js"></script>
> >    <script type="application/javascript">
> > +    var originalMCGD = GestureSettings.maxConsecutiveGestureDelay,
> > +      originalDT = originalDwellThreshold,
> > +      originalSMD = originalSwipeMaxDuration;
> 
> Where are originalSwipeMaxDuration and originalDwellThreshold defined?
> 

Those are defined in dom_helper.js file.

> @@ -27,5 @@
> >            GestureTracker);
> >          gestures.forEach(AccessFuTest.addSequence);
> >          AccessFuTest.addFunc(stopGestureTracker);
> >          AccessFuTest.waitForExplicitFinish();
> > -        Logger.logLevel = Logger.DEBUG;
> 
> I think you should just leave debug on. That was my lesson from the
> intermittent fails I got last time..

OK
Posted patch 1001945 patch v3 (obsolete) — Splinter Review
Attachment #8418125 - Attachment is obsolete: true
Attachment #8418319 - Flags: review?(eitan)
Attachment #8418319 - Attachment is obsolete: true
Attachment #8418319 - Flags: review?(eitan)
Attachment #8418881 - Flags: review?(eitan)
Comment on attachment 8418881 [details] [diff] [review]
1001945.4.patch

Review of attachment 8418881 [details] [diff] [review]:
-----------------------------------------------------------------

perf! (perfect)
Attachment #8418881 - Flags: review?(eitan) → review+
Look like the intermittents stopped, closing as fixed.
Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → FIXED
Keywords: leave-open
Target Milestone: --- → mozilla32
You need to log in before you can comment on or make changes to this bug.