1563541 - Intermittent gfx/layers/apz/test/mochitest/test_bug1253683.html | expected at least one nonempty paint

Status: RESOLVED FIXED

(Core :: Panning and Zooming, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=254741259&repo=mozilla-inbound
Full log: https://queue.taskcluster.net/v1/task/Rzg1Ww_nQICkfbdA_ZENOw/runs/0/artifacts/public/logs/live_backing.log

---

12:39:08 INFO - TEST-START | gfx/layers/apz/test/mochitest/test_bug1253683.html
12:39:08 INFO - GECKO(8172) | Parent process: flushed APZ repaints, waiting for callback...
12:39:08 INFO - GECKO(8172) | Flushed APZ repaints, waiting for callback...
12:39:08 INFO - TEST-INFO | started process screenshot
12:39:08 INFO - TEST-INFO | screenshot: exit 0
12:39:08 INFO - Buffered messages logged at 12:39:08
12:39:08 INFO - TEST-PASS | gfx/layers/apz/test/mochitest/test_bug1253683.html | Initial scrollY should be 0
12:39:08 INFO - Buffered messages finished
12:39:08 INFO - TEST-UNEXPECTED-FAIL | gfx/layers/apz/test/mochitest/test_bug1253683.html | expected at least one nonempty paint
12:39:08 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:275:18
12:39:08 INFO - isLayerized@gfx/layers/apz/test/mochitest/apz_test_utils.js:156:3
12:39:08 INFO - test@gfx/layers/apz/test/mochitest/test_bug1253683.html:30:7
12:39:08 INFO - driveTest@gfx/layers/apz/test/mochitest/apz_test_utils.js:504:36
12:39:08 INFO - runContinuation/</<@gfx/layers/apz/test/mochitest/apz_test_utils.js:511:9
12:39:08 INFO - runContinuation/<@gfx/layers/apz/test/mochitest/apz_test_utils.js:497:12
12:39:08 INFO - promise callback*@gfx/layers/apz/test/mochitest/test_bug1253683.html:52:4
12:39:08 INFO - Not taking screenshot here: see the one that was previously logged
12:39:08 INFO - TEST-UNEXPECTED-FAIL | gfx/layers/apz/test/mochitest/test_bug1253683.html | APZ test continuation failed with exception: TypeError: nonEmptyBucket is null
12:39:08 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:275:18
12:39:08 INFO - runContinuation/</<@gfx/layers/apz/test/mochitest/apz_test_utils.js:513:20
12:39:08 INFO - runContinuation/<@gfx/layers/apz/test/mochitest/apz_test_utils.js:497:12
12:39:08 INFO - promise callback*@gfx/layers/apz/test/mochitest/test_bug1253683.html:52:4
12:44:36 INFO - Not taking screenshot here: see the one that was previously logged
12:44:36 INFO - TEST-UNEXPECTED-FAIL | gfx/layers/apz/test/mochitest/test_bug1253683.html | Test timed out.
12:44:36 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:275:18
12:44:36 INFO - reportError@SimpleTest/TestRunner.js:121:22
12:44:36 INFO - TestRunner._checkForHangs@SimpleTest/TestRunner.js:142:7

Comment 1

[Intermittent Failures Robot]

9 failures in 3501 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-inbound: 1
• mozilla-central: 3
• try: 1
• autoland: 4

Platform breakdown:

• windows10-64-shippable-qr: 2
• windows10-64: 3
• linux64: 2
• macosx1014-64-shippable: 1
• windows10-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1563541&startday=2019-07-01&endday=2019-07-07&tree=all

Comment 2

[Intermittent Failures Robot]

17 failures in 893 pushes (0.019 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 11
• mozilla-beta: 3
• mozilla-central: 2
• mozilla-inbound: 1

Platform breakdown:

• macosx1014-64: 7
• macosx1014-64-shippable: 2
• windows10-64-devedition: 1
• windows10-64-shippable-qr: 3
• windows10-64-shippable: 1
• macosx1014-64-devedition: 2
• windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1563541&startday=2019-07-11&endday=2019-07-11&tree=all

Comment 3

[Intermittent Failures Robot]

23 failures in 837 pushes (0.027 failures/push) were associated with this bug yesterday.

Repository breakdown:

• mozilla-inbound: 2
• autoland: 13
• mozilla-central: 6
• try: 2

Platform breakdown:

• linux64-shippable: 1
• windows10-64-shippable: 2
• macosx1014-64: 9
• macosx1014-64-shippable: 2
• windows10-aarch64: 1
• windows10-64-qr: 2
• windows10-64: 3
• macosx1014-64-devedition: 1
• windows10-64-shippable-qr: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1563541&startday=2019-07-12&endday=2019-07-12&tree=all

Comment 4

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

This seems to have started fairly recently. I'm going to do retriggers to see if I can find what caused it.

Comment 5

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

Retriggers are not producing much to go on. However I was able to reproduce this locally on macOS with some debug logging. It seems like the content paint happens early during page load, before the APZ test logging pref is flipped. Then we do the waitUntilApzStable which is mostly a no-op since everything is already stable, and then we start the test. So between the pref getting flipped and reading the APZ test data, there's no actual paints. If I add a forceLayerTreeToCompositor call it seems to fix it for me locally (hard to confirm, but I haven't hit the problem yet with that change).

Comment 6

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

https://treeherder.mozilla.org/#/jobs?repo=try&group_state=expanded&revision=2dfbe3fdf46907b1b6550d3d5e12d4868b63682c

Comment 7

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

Attachment: Bug 1563541 - Force a paint before reading the APZ test data. r?botond

Comment 8

[Intermittent Failures Robot]

79 failures in 4710 pushes (0.017 failures/push) were associated with this bug in the last 7 days.

This is the #23 most frequent failure this week.

** This failure happened more than 75 times this week! Resolving this bug is a very high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 1 week, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 42
• mozilla-central: 22
• mozilla-inbound: 8
• mozilla-beta: 4
• try: 3

Platform breakdown:

• windows10-64-shippable-qr: 15
• windows10-64: 11
• windows10-64-ccov: 1
• windows10-64-qr: 5
• macosx1014-64-shippable: 6
• macosx1014-64: 22
• linux64-shippable: 4
• windows7-32: 1
• linux64: 1
• windows10-64-shippable: 6
• android-em-7-0-x86_64: 1
• windows10-64-devedition: 2
• macosx1014-64-devedition: 3
• windows10-aarch64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1563541&startday=2019-07-08&endday=2019-07-14&tree=all

Comment 9

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/3accce0da9b4
Force a paint before reading the APZ test data. r=botond

Comment 10

[Razvan Maries]

https://hg.mozilla.org/mozilla-central/rev/3accce0da9b4

Comment 11

[Ryan VanderMeulen [:RyanVM]]

https://hg.mozilla.org/releases/mozilla-beta/rev/f0bf36453203

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2
• try: 1
• mozilla-beta: 2

Platform breakdown:

• linux64-shippable: 1
• windows10-64-shippable: 1
• macosx1014-64: 1
• windows10-64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1563541&startday=2019-07-15&endday=2019-07-21&tree=all