1210312 - Intermittent e10s dom/events/test/test_moz_mouse_pixel_scroll_event.html | Test timed out.

Status: RESOLVED FIXED

(Core :: Panning and Zooming, defect)

Description

[Nigel Babu [:nigelb]]

23:50:38     INFO -  1949 INFO TEST-PASS | dom/events/test/test_moz_mouse_pixel_scroll_event.html | prepareScrollUnits: gScrollable128.wheelLineHeight may be illegal value, got 150
 23:50:38     INFO -  1950 INFO TEST-PASS | dom/events/test/test_moz_mouse_pixel_scroll_event.html | prepareScrollUnits: gScrollable96.wheelLineHeight may be illegal value, got 113
 23:50:38     INFO -  1951 INFO TEST-UNEXPECTED-FAIL | dom/events/test/test_moz_mouse_pixel_scroll_event.html | Test timed out.
 23:50:38     INFO -      reportError@SimpleTest/TestRunner.js:113:7
 23:50:38     INFO -      TestRunner._checkForHangs@SimpleTest/TestRunner.js:133:7
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:154:5
 23:50:38     INFO -      TestRunner.runTests@SimpleTest/TestRunner.js:369:5
 23:50:38     INFO -      RunSet.runtests@SimpleTest/setup.js:188:3
 23:50:38     INFO -      RunSet.runall@SimpleTest/setup.js:167:5
 23:50:38     INFO -      hookupTests@SimpleTest/setup.js:260:5
 23:50:38     INFO -  parseTestManifest@http://mochi.test:8888/manifestLibrary.js:36:5
 23:50:38     INFO -  getTestManifest/req.onload@http://mochi.test:8888/manifestLibrary.js:49:11
 23:50:38     INFO -  EventHandlerNonNull*getTestManifest@http://mochi.test:8888/manifestLibrary.js:45:3
 23:50:38     INFO -      hookup@SimpleTest/setup.js:240:5
 23:50:38     INFO -  EventHandlerNonNull*@http://mochi.test:8888/tests?autorun=1&closeWhenDone=1&consoleLevel=INFO&hideResultsTable=1&manifestFile=tests.json&dumpOutputDirectory=%2Ftmp:11:1
 23:50:39     INFO -  MEMORY STAT | vsize 496MB | residentFast 100MB | heapAllocated 19MB
 23:50:39     INFO -  1952 INFO TEST-OK | dom/events/test/test_moz_mouse_pixel_scroll_event.html | took 327816ms
 23:50:39     INFO -  ++DOMWINDOW == 7 (0x7f404fa3e000) [pid = 5767] [serial = 259] [outer = 0x7f40527a3400]
 23:50:39     INFO -  1953 INFO TEST-START | dom/events/test/test_offsetxy.html
 23:50:39     INFO -  ++DOMWINDOW == 8 (0x7f404fa96400) [pid = 5767] [serial = 260] [outer = 0x7f40527a3400]
 23:50:39     INFO -  MEMORY STAT | vsize 496MB | residentFast 101MB | heapAllocated 19MB
 23:50:39     INFO -  1954 INFO TEST-OK | dom/events/test/test_offsetxy.html | took 378ms
 23:50:39     INFO -  ++DOMWINDOW == 9 (0x7f404f057800) [pid = 5767] [serial = 261] [outer = 0x7f40527a3400]
 23:50:39     INFO -  1955 INFO TEST-START | dom/events/test/test_onerror_handler_args.html
 23:50:39     INFO -  ++DOMWINDOW == 10 (0x7f404fb0cc00) [pid = 5767] [serial = 262] [outer = 0x7f40527a3400]
 23:50:39     INFO -  ++DOCSHELL 0x7f404fa82600 == 3 [pid = 5767] [id = 26]
 23:50:39     INFO -  ++DOMWINDOW == 11 (0x7f404fc95400) [pid = 5767] [serial = 263] [outer = (nil)]
 23:50:39     INFO -  ++DOMWINDOW == 12 (0x7f404fc95c00) [pid = 5767] [serial = 264] [outer = 0x7f404fc95400]
 23:50:39     INFO -  MEMORY STAT | vsize 496MB | residentFast 101MB | heapAllocated 20MB
 23:50:40     INFO -  1956 INFO TEST-OK | dom/events/test/test_onerror_handler_args.html | took 288ms
 23:50:40     INFO -  ++DOMWINDOW == 13 (0x7f404fd1b400) [pid = 5767] [serial = 265] [outer = 0x7f40527a3400]
 23:50:40     INFO -  --DOCSHELL 0x7fb9149c5d00 == 6 [pid = 5709] [id = 6]
 23:50:40     INFO -  ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost
 23:50:40     INFO -  ++DOMWINDOW == 14 (0x7f404faa8000) [pid = 5767] [serial = 266] [outer = 0x7f40527a3400]
 23:50:40     INFO -  --DOCSHELL 0x7fb92bfb4f00 == 5 [pid = 5709] [id = 1]
 23:50:41     INFO -  --DOCSHELL 0x7fb9158d8300 == 4 [pid = 5709] [id = 7]
 23:50:41     INFO -  --DOCSHELL 0x7fb91aca9600 == 3 [pid = 5709] [id = 8]
 23:50:41     INFO -  --DOCSHELL 0x7fb91aca5f00 == 2 [pid = 5709] [id = 3]
 23:50:41     INFO -  --DOCSHELL 0x7fb91aca6400 == 1 [pid = 5709] [id = 4]
 23:50:41     INFO -  --DOCSHELL 0x7fb92bfb8600 == 0 [pid = 5709] [id = 2]

Comment 1

[Kartikaya Gupta (email:[e-mail])]

Probably the same underlying root cause as bug 1210057, and also a regression from APZ on Linux.

Comment 2

[Intermittent Failures Robot]

5 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 2
* try: 1
* mozilla-central: 1
* fx-team: 1

Platform breakdown:
* linux64: 3
* linux32: 2

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-10-05&endday=2015-10-11&tree=all

Comment 3

[Intermittent Failures Robot]

12 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 4
* try: 2
* mozilla-central: 2
* fx-team: 2
* b2g-inbound: 2

Platform breakdown:
* linux64: 7
* linux32: 5

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-10-12&endday=2015-10-18&tree=all

Comment 4

[Intermittent Failures Robot]

12 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* try: 8
* b2g-inbound: 3
* mozilla-inbound: 1

Platform breakdown:
* linux32: 8
* linux64: 4

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-10-19&endday=2015-10-25&tree=all

Comment 5

[Intermittent Failures Robot]

16 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 8
* try: 6
* fx-team: 2

Platform breakdown:
* linux32: 9
* linux64: 7

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-10-26&endday=2015-11-01&tree=all

Comment 6

[Intermittent Failures Robot]

13 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 5
* fx-team: 5
* b2g-inbound: 2
* try: 1

Platform breakdown:
* linux32: 7
* linux64: 6

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-11-02&endday=2015-11-08&tree=all

Comment 7

[Intermittent Failures Robot]

9 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 4
* fx-team: 4
* b2g-inbound: 1

Platform breakdown:
* linux64: 5
* linux32: 4

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-11-09&endday=2015-11-15&tree=all

Comment 8

[Intermittent Failures Robot]

9 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* fx-team: 5
* mozilla-inbound: 3
* b2g-inbound: 1

Platform breakdown:
* linux32: 5
* linux64: 4

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-11-16&endday=2015-11-22&tree=all

Comment 9

[Intermittent Failures Robot]

9 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 4
* mozilla-central: 2
* fx-team: 2
* b2g-inbound: 1

Platform breakdown:
* linux64: 6
* linux32: 3

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-11-23&endday=2015-11-29&tree=all

Comment 10

[Intermittent Failures Robot]

11 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 5
* fx-team: 4
* mozilla-central: 2

Platform breakdown:
* linux32: 8
* linux64: 3

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-11-30&endday=2015-12-06&tree=all

Comment 11

[Intermittent Failures Robot]

6 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 3
* b2g-inbound: 2
* mozilla-central: 1

Platform breakdown:
* linux32: 4
* linux64: 2

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-12-07&endday=2015-12-13&tree=all

Comment 12

[Intermittent Failures Robot]

5 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 4
* try: 1

Platform breakdown:
* linux64: 4
* linux32: 1

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-12-14&endday=2015-12-20&tree=all

Comment 13

[Intermittent Failures Robot]

10 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 4
* mozilla-central: 2
* fx-team: 2
* b2g-inbound: 2

Platform breakdown:
* linux32: 7
* linux64: 3

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2015-12-28&endday=2016-01-03&tree=all

Comment 14

[Intermittent Failures Robot]

12 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 4
* try: 3
* b2g-inbound: 3
* fx-team: 2

Platform breakdown:
* linux64: 7
* linux32: 5

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2016-01-04&endday=2016-01-10&tree=all

Comment 15

[Kartikaya Gupta (email:[e-mail])]

Blanket gfx-noted on APZ intermittent failures so they can be found more easily on https://brasstacks.mozilla.com/orangefactor/

Comment 16

[Intermittent Failures Robot]

13 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 4
* fx-team: 4
* try: 3
* mozilla-central: 1
* b2g-inbound: 1

Platform breakdown:
* linux32: 9
* linux64: 4

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2016-01-11&endday=2016-01-17&tree=all

Comment 17

[Intermittent Failures Robot]

26 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 14
* fx-team: 9
* mozilla-central: 2
* try: 1

Platform breakdown:
* linux32: 15
* linux64: 10
* b2g-emu-x86-kk: 1

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2016-01-18&endday=2016-01-24&tree=all

Comment 18

[Kartikaya Gupta (email:[e-mail])]

I'll look into this one

Comment 19

[Kartikaya Gupta (email:[e-mail])]

Got a reproduction with logging at https://treeherder.mozilla.org/#/jobs?repo=try&revision=9b5bcb36136b&selectedJob=16051117 (one of them is the "timed out" failure, and there's a bunch of other failures as well). In the log, the first wheel event seems to be processed correctly, but the second one ends up targeted at the root <html> rather than the Scrollable96 div. We see the main-thread hit-test return the root:

09:53:56     INFO -  APZCCH: For event at (61,227) found scrollable element 0xa3396460 (html@a3396460)

This means the MozMousePixelScroll event the test is waiting for never arrives and so the test times out.

Comment 20

[Kartikaya Gupta (email:[e-mail])]

I think this is the same problem that tn tracked down. The addition of the event listener doesn't propagate the updated dispatch-to-content region to the compositor, so the APZ doesn't wait for the preventDefault()s that the test is doing.

Comment 21

[Intermittent Failures Robot]

13 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 6
* fx-team: 5
* mozilla-central: 1
* mozilla-aurora: 1

Platform breakdown:
* linux64: 7
* linux32: 6

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2016-01-25&endday=2016-01-31&tree=all

Comment 22

[Intermittent Failures Robot]

10 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* fx-team: 4
* mozilla-inbound: 3
* try: 2
* mozilla-aurora: 1

Platform breakdown:
* linux32: 7
* linux64: 3

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2016-02-01&endday=2016-02-07&tree=all

Comment 23

[Kartikaya Gupta (email:[e-mail])]

Fixed by bug 1210057.

Comment 24

[Intermittent Failures Robot]

8 automation job failures were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 5
* try: 1
* mozilla-central: 1
* mozilla-aurora: 1

Platform breakdown:
* linux32: 5
* linux64: 3

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1210312&startday=2016-02-08&endday=2016-02-14&tree=all