1597786 - Intermittent bugs/1553571-1.html == bugs/1553571-1-ref.html | load failed: timed out waiting for pending paint count to reach zero (waiting for MozAfterPaint) (waiting for updateCanvasPending)

Status: RESOLVED FIXED

(Core :: Layout, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: aciure [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=277016941&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Z6BCRJI2TTSpye1MR23dcA/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Z6BCRJI2TTSpye1MR23dcA/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

---

[task 2019-11-19T18:03:21.519Z] 18:03:21 INFO - REFTEST TEST-START | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/bugs/1553571-1.html == file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/bugs/1553571-1-ref.html
[task 2019-11-19T18:03:21.520Z] 18:03:21 INFO - REFTEST INFO | SET PREFERENCE pref(image.downscale-during-decode.enabled,true)
[task 2019-11-19T18:03:21.522Z] 18:03:21 INFO - REFTEST TEST-LOAD | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/bugs/1553571-1.html | 2028 / 2039 (99%)
[task 2019-11-19T18:08:21.537Z] 18:08:21 INFO - REFTEST TEST-UNEXPECTED-FAIL | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/bugs/1553571-1.html == file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/bugs/1553571-1-ref.html | load failed: timed out waiting for pending paint count to reach zero (waiting for MozAfterPaint) (waiting for updateCanvasPending)
[task 2019-11-19T18:08:21.539Z] 18:08:21 INFO - REFTEST INFO | Saved log: START file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/bugs/1553571-1.html
[task 2019-11-19T18:08:21.539Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad triggering WaitForTestEnd
[task 2019-11-19T18:08:21.540Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] WaitForTestEnd: Adding listeners
[task 2019-11-19T18:08:21.541Z] 18:08:21 INFO - REFTEST INFO | Saved log: Initializing canvas snapshot
[task 2019-11-19T18:08:21.542Z] 18:08:21 INFO - REFTEST INFO | Saved log: DoDrawWindow 0,0,800,1000
[task 2019-11-19T18:08:21.542Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress
[task 2019-11-19T18:08:21.543Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/bugs/1553571-1.html
[task 2019-11-19T18:08:21.543Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress: STATE_WAITING_TO_FIRE_INVALIDATE_EVENT
[task 2019-11-19T18:08:21.544Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress: waiting for MozAfterPaint
[task 2019-11-19T18:08:21.547Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress: waiting for updateCanvasPending
[task 2019-11-19T18:08:21.548Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] HandlePendingTasksAfterMakeProgress waiting for a MozAfterPaint
[task 2019-11-19T18:08:21.564Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/bugs/1553571-1.html
[task 2019-11-19T18:08:21.565Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] HandlePendingTasksAfterMakeProgress waiting for a MozAfterPaint
[task 2019-11-19T18:08:21.566Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/bugs/1553571-1.html
[task 2019-11-19T18:08:21.567Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] HandlePendingTasksAfterMakeProgress updating canvas
[task 2019-11-19T18:08:21.567Z] 18:08:21 INFO - REFTEST INFO | Saved log: [CONTENT] Webrender enabled, sending update whole canvas for invalidation
[task 2019-11-19T18:08:21.568Z] 18:08:21 INFO - REFTEST INFO | Saved log: Updating entire canvas for invalidation
[task 2019-11-19T18:08:21.568Z] 18:08:21 INFO - REFTEST INFO | Saved log: DoDrawWindow 0,0,800,1000

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux64-asan-qr: 1

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

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• windows10-64-shippable-qr: 1

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

Comment 3

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Comment 4

[Natalia Csoregi [:nataliaCs]]

https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=287691895&repo=autoland&lineNumber=47183

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64-shippable-qr: 1

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

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform breakdown:

• windows10-64-shippable-qr: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1597786&startday=2020-02-10&endday=2020-02-16&tree=all

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64-shippable-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1597786&startday=2020-02-17&endday=2020-02-23&tree=all

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

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

Platform breakdown:

• windows10-64-shippable-qr: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1597786&startday=2020-02-24&endday=2020-03-01&tree=all

Comment 9

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 4
• mozilla-central: 1

Platform breakdown:

• windows10-64-shippable-qr: 3
• windows10-64-qr: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1597786&startday=2020-03-02&endday=2020-03-08&tree=all

Comment 10

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• windows10-64-qr: 1

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

Comment 11

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64-asan-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1597786&startday=2020-03-16&endday=2020-03-22&tree=all

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 6
• mozilla-central: 2

Platform breakdown:

• android-hw-p2-8-0-android-aarch64-qr: 8

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1597786&startday=2020-03-23&endday=2020-03-29&tree=all

Comment 13

[Andrei Ciure[:aciure]]

There are 29 failures associated to this bug in the last 7 days. These are occurring on android-hw-p2-8-0-android-aarch64-qr debug.

recent log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=295845736&repo=autoland&lineNumber=8957

[task 2020-04-02T00:38:21.016Z] 00:33:18 INFO - REFTEST TEST-START | layout/reftests/bugs/1553571-1.html == layout/reftests/bugs/1553571-1-ref.html
[task 2020-04-02T00:38:21.016Z] 00:33:18 INFO - REFTEST INFO | SET PREFERENCE pref(image.downscale-during-decode.enabled,true)
[task 2020-04-02T00:38:21.016Z] 00:33:18 INFO - REFTEST TEST-LOAD | http://10.7.205.241:8854/tests/layout/reftests/bugs/1553571-1.html | 1376 / 1788 (76%)
[task 2020-04-02T00:38:21.016Z] 00:38:20 WARNING - REFTEST TEST-UNEXPECTED-FAIL | layout/reftests/bugs/1553571-1.html == layout/reftests/bugs/1553571-1-ref.html | load failed: timed out waiting for pending paint count to reach zero (waiting for MozAfterPaint) (waiting for updateCanvasPending)
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: START http://10.7.205.241:8854/tests/layout/reftests/bugs/1553571-1.html
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad triggering WaitForTestEnd
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] WaitForTestEnd: Adding listeners
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in http://10.7.205.241:8854/tests/layout/reftests/bugs/1553571-1.html
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in http://10.7.205.241:8854/tests/layout/reftests/bugs/1553571-1.html
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: Initializing canvas snapshot
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: DoDrawWindow 0,0,800,1000
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in http://10.7.205.241:8854/tests/layout/reftests/bugs/1553571-1.html
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] FlushRendering generated paint for window http://10.7.205.241:8854/tests/layout/reftests/bugs/1553571-1.html
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress: STATE_WAITING_TO_FIRE_INVALIDATE_EVENT
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress: waiting for MozAfterPaint
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress: waiting for updateCanvasPending
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] HandlePendingTasksAfterMakeProgress waiting for a MozAfterPaint
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in http://10.7.205.241:8854/tests/layout/reftests/bugs/1553571-1.html
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] HandlePendingTasksAfterMakeProgress updating canvas
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: [CONTENT] Webrender enabled, sending update whole canvas for invalidation
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: Updating entire canvas for invalidation
[task 2020-04-02T00:38:21.016Z] 00:38:20 INFO - REFTEST INFO | Saved log: DoDrawWindow 0,0,800,1000

Sean, can you take a look?

Comment 14

[Timothy Nikkel (:tnikkel)]

Attachment: Bug 1597786. Skip layout/reftests/bugs/1553571-1.html on android with webrender.

It does fail intermittently it turns out.

Comment 15

[Timothy Nikkel (:tnikkel)]

It spiked because I enabled it on android+webrender in bug 1625364. I'll disable it again.

Comment 16

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/727b07161722
Skip layout/reftests/bugs/1553571-1.html on android with webrender.

Comment 17

[Daniel Varga [:dvarga]]

https://hg.mozilla.org/mozilla-central/rev/727b07161722

Comment 18

[Intermittent Failures Robot]

27 failures in 5015 pushes (0.005 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 25
• mozilla-central: 2

Platform breakdown:

• android-hw-p2-8-0-android-aarch64-qr: 27

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1597786&startday=2020-03-30&endday=2020-04-05&tree=all