Closed Bug 1754998 Opened 3 years ago Closed 3 years ago

Intermittent TV gfx/layers/apz/test/mochitest/browser_test_background_tab_load_scroll.js | expect scroll position and visual scroll position to be the same: visual 20000 scroll 10000 (4,1) -

Categories

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

Product:
Core
Component:
Panning and Zooming
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE
Tracking Flags:
Tracking Status
firefox-esr91 --- unaffected
firefox97 --- unaffected
firefox98 --- wontfix
firefox99 --- fixed

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Filed by: ccozmuta [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=367556953&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/YHNGZ8leTISsY1yrsWKCPA/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/YHNGZ8leTISsY1yrsWKCPA/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2022-02-11T12:33:32.321Z] 12:33:32     INFO - TEST-START | gfx/layers/apz/test/mochitest/browser_test_background_tab_load_scroll.js
[task 2022-02-11T12:33:32.545Z] 12:33:32     INFO - GECKO(1148) | Done loading background tab
[task 2022-02-11T12:33:35.726Z] 12:33:35     INFO - GECKO(1148) | Switched background tab to foreground
[task 2022-02-11T12:33:35.732Z] 12:33:35     INFO - GECKO(1148) | WaitUntilApzStable: flushed APZ repaints in parent proc, waiting for callback...
[task 2022-02-11T12:33:35.735Z] 12:33:35     INFO - GECKO(1148) | WaitUntilApzStable: APZ flush done in parent proc
[task 2022-02-11T12:33:35.735Z] 12:33:35     INFO - GECKO(1148) | WaitUntilApzStable: got apz-flush-done in child proc
[task 2022-02-11T12:33:35.736Z] 12:33:35     INFO - GECKO(1148) | WaitUntilApzStable: done promiseFocus
<...>
[task 2022-02-11T12:34:05.878Z] 12:34:05     INFO - GECKO(1148) | PromiseApzRepaintsFlushed: APZ flush done
[task 2022-02-11T12:34:05.879Z] 12:34:05     INFO - GECKO(1148) | WaitUntilApzStable: all done
[task 2022-02-11T12:34:05.907Z] 12:34:05     INFO - GECKO(1148) | PromiseApzRepaintsFlushed: Flushed APZ repaints, waiting for callback...
[task 2022-02-11T12:34:05.911Z] 12:34:05     INFO - GECKO(1148) | PromiseApzRepaintsFlushed: APZ flush done
[task 2022-02-11T12:34:05.924Z] 12:34:05     INFO - TEST-INFO | started process screenshot
[task 2022-02-11T12:34:06.014Z] 12:34:06     INFO - TEST-INFO | screenshot: exit 0
[task 2022-02-11T12:34:06.020Z] 12:34:06     INFO - Buffered messages logged at 12:33:32
[task 2022-02-11T12:34:06.020Z] 12:34:06     INFO - Entering test bound test_main
[task 2022-02-11T12:34:06.021Z] 12:34:06     INFO - Buffered messages logged at 12:33:35
[task 2022-02-11T12:34:06.021Z] 12:34:06     INFO - TEST-PASS | gfx/layers/apz/test/mochitest/browser_test_background_tab_load_scroll.js | expect scroll position and visual scroll position to be the same: visual 10000 scroll 10000 (0,1) - 
[task 2022-02-11T12:34:06.021Z] 12:34:06     INFO - Buffered messages logged at 12:33:43
[task 2022-02-11T12:34:06.022Z] 12:34:06     INFO - TEST-PASS | gfx/layers/apz/test/mochitest/browser_test_background_tab_load_scroll.js | expect scroll position and visual scroll position to be the same: visual 10000 scroll 10000 (1,1) - 
[task 2022-02-11T12:34:06.022Z] 12:34:06     INFO - Buffered messages logged at 12:33:58
[task 2022-02-11T12:34:06.023Z] 12:34:06     INFO - TEST-PASS | gfx/layers/apz/test/mochitest/browser_test_background_tab_load_scroll.js | expect scroll position and visual scroll position to be the same: visual 10000 scroll 10000 (3,1) - 
[task 2022-02-11T12:34:06.023Z] 12:34:06     INFO - Buffered messages logged at 12:34:02
[task 2022-02-11T12:34:06.024Z] 12:34:06     INFO - TEST-PASS | gfx/layers/apz/test/mochitest/browser_test_background_tab_load_scroll.js | expect scroll position and visual scroll position to be the same: visual 20000 scroll 20000 (3,2) - 
[task 2022-02-11T12:34:06.024Z] 12:34:06     INFO - Buffered messages finished
[task 2022-02-11T12:34:06.025Z] 12:34:06     INFO - TEST-UNEXPECTED-FAIL | gfx/layers/apz/test/mochitest/browser_test_background_tab_load_scroll.js | expect scroll position and visual scroll position to be the same: visual 20000 scroll 10000 (4,1) - 
[task 2022-02-11T12:34:06.025Z] 12:34:06     INFO - Stack trace:
[task 2022-02-11T12:34:06.025Z] 12:34:06     INFO - chrome://mochikit/content/browser-test.js:test_ok:1394
[task 2022-02-11T12:34:06.025Z] 12:34:06     INFO - chrome://mochitests/content/browser/gfx/layers/apz/test/mochitest/browser_test_background_tab_load_scroll.js:checkScrollPosInContent:79
[task 2022-02-11T12:34:09.928Z] 12:34:09     INFO - GECKO(1148) | Switched background tab to foreground
[task 2022-02-11T12:34:09.936Z] 12:34:09     INFO - GECKO(1148) | WaitUntilApzStable: flushed APZ repaints in parent proc, waiting for callback...
[task 2022-02-11T12:34:09.937Z] 12:34:09     INFO - GECKO(1148) | WaitUntilApzStable: APZ flush done in parent proc
[task 2022-02-11T12:34:09.937Z] 12:34:09     INFO - GECKO(1148) | WaitUntilApzStable: got apz-flush-done in child proc
[task 2022-02-11T12:34:09.938Z] 12:34:09     INFO - GECKO(1148) | WaitUntilApzStable: done promiseFocus
[task 2022-02-11T12:34:09.938Z] 12:34:09     INFO - GECKO(1148) | WaitUntilApzStable: done promiseAllPaintsDone
[task 2022-02-11T12:34:09.939Z] 12:34:09     INFO - GECKO(1148) | PromiseApzRepaintsFlushed: Flushed APZ repaints, waiting for callback...
[task 2022-02-11T12:34:09.939Z] 12:34:09     INFO - GECKO(1148) | PromiseApzRepaintsFlushed: APZ flush done
[task 2022-02-11T12:34:09.941Z] 12:34:09     INFO - GECKO(1148) | WaitUntilApzStable: all done
[task 2022-02-11T12:34:09.947Z] 12:34:09     INFO - GECKO(1148) | PromiseApzRepaintsFlushed: Flushed APZ repaints, waiting for callback...
[task 2022-02-11T12:34:09.947Z] 12:34:09     INFO - GECKO(1148) | PromiseApzRepaintsFlushed: APZ flush done
[task 2022-02-11T12:34:09.981Z] 12:34:09     INFO - TEST-PASS | gfx/layers/apz/test/mochitest/browser_test_background_tab_load_scroll.js | expect scroll position and visual scroll position to be the same: visual 30000 scroll 30000 (4,2) - 
[task 2022-02-11T12:34:10.002Z] 12:34:10     INFO - Leaving test bound test_main
[task 2022-02-11T12:34:10.021Z] 12:34:10     INFO - GECKO(1148) | MEMORY STAT | vsize 2104107MB | vsizeMaxContiguous 69728579MB | residentFast 211MB | heapAllocated 82MB
[task 2022-02-11T12:34:10.035Z] 12:34:10     INFO - TEST-OK | gfx/layers/apz/test/mochitest/browser_test_background_tab_load_scroll.js | took 37714ms
[task 2022-02-11T12:34:10.047Z] 12:34:10     INFO - checking window state
[task 2022-02-11T12:34:10.056Z] 12:34:10     INFO - GECKO(1148) | Completed ShutdownLeaks collections in process 1948
[task 2022-02-11T12:34:10.057Z] 12:34:10     INFO - TEST-START | Shutdown

Huh, weird, despite extension TV runs on try I never saw this.

Anyways, if this keeps happening I expect bug 1753881 would fix this.

Depends on: 1753881

Set release status flags based on info from the regressing bug 1742241

status-firefox97: --- → unaffected
status-firefox98: --- → affected
status-firefox99: --- → affected
status-firefox-esr91: --- → unaffected
Has Regression Range: --- → yes
No longer depends on: 1753881

Bug 1756762 should fix this.

Depends on: 1756762

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

Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.