Closed Bug 1682056 Opened 4 years ago Closed 4 years ago

Intermittent macOS WebRender toolkit/components/printing/tests/browser_preview_navigation.js | Uncaught exception - 2 successive 'next' clicks correctly update the sheet indicator - timed out after 50 tries.

Categories

(Toolkit :: Printing, defect, P5)

Product:
Toolkit
Component:
Printing
Type:
defect

Tracking

()

Status:
RESOLVED DUPLICATE of bug 1681867
Tracking Flags:
Tracking Status
firefox-esr78 --- unaffected
firefox83 --- unaffected
firefox84 --- unaffected
firefox85 --- affected
firefox86 --- unaffected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Filed by: smolnar [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=324285135&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/FFWiU-jgSnq1hz4SX6-CnQ/runs/0/artifacts/public/logs/live_backing.log

INFO - TEST-START | toolkit/components/printing/tests/browser_preview_navigation.js
[task 2020-12-11T21:15:33.435Z] 21:15:33     INFO - GECKO(2228) | [Child 2232: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x120f64400 == 6 [pid = 2232] [id = 28]
[task 2020-12-11T21:15:33.436Z] 21:15:33     INFO - GECKO(2228) | [Child 2232: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 28 (0x120cee040) [pid = 2232] [serial = 82] [outer = 0x0]
[task 2020-12-11T21:15:33.436Z] 21:15:33     INFO - GECKO(2228) | [Child 2232: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 29 (0x120f67800) [pid = 2232] [serial = 83] [outer = 0x120cee040]
[task 2020-12-11T21:15:33.497Z] 21:15:33     INFO - GECKO(2228) | [Child 2232: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 30 (0x121a32800) [pid = 2232] [serial = 84] [outer = 0x120cee040]
[task 2020-12-11T21:15:33.764Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x16434f400 == 35 [pid = 2228] [id = 63]
[task 2020-12-11T21:15:33.764Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 115 (0x1189b7740) [pid = 2228] [serial = 145] [outer = 0x0]
[task 2020-12-11T21:15:33.774Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x165504000 == 36 [pid = 2228] [id = 64]
[task 2020-12-11T21:15:33.774Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 116 (0x128502900) [pid = 2228] [serial = 146] [outer = 0x0]
[task 2020-12-11T21:15:33.774Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x16550b000 == 37 [pid = 2228] [id = 65]
[task 2020-12-11T21:15:33.774Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 117 (0x128502e40) [pid = 2228] [serial = 147] [outer = 0x0]
[task 2020-12-11T21:15:33.774Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4287
[task 2020-12-11T21:15:33.774Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4287
[task 2020-12-11T21:15:33.774Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4287
[task 2020-12-11T21:15:33.775Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 118 (0x167cd2c00) [pid = 2228] [serial = 148] [outer = 0x1189b7740]
[task 2020-12-11T21:15:33.775Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 119 (0x167cd7000) [pid = 2228] [serial = 149] [outer = 0x128502900]
[task 2020-12-11T21:15:33.803Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 120 (0x135efa400) [pid = 2228] [serial = 150] [outer = 0x128502e40]
[task 2020-12-11T21:15:33.803Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228, Main Thread] WARNING: NS_ENSURE_TRUE(uri) failed: file /builds/worker/checkouts/gecko/caps/BasePrincipal.cpp:1327
[task 2020-12-11T21:15:33.803Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 121 (0x167ea7c00) [pid = 2228] [serial = 151] [outer = 0x128502900]
[task 2020-12-11T21:15:33.809Z] 21:15:33     INFO - GECKO(2228) | [Parent 2228, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1180
...
INFO - Buffered messages logged at 21:15:49
[task 2020-12-11T21:15:50.231Z] 21:15:50     INFO - compare10nArgs, expected sheetNum: 3, actual: 2
[task 2020-12-11T21:15:50.231Z] 21:15:50     INFO - compare10nArgs, expected sheetNum: 3, actual: 2
[task 2020-12-11T21:15:50.231Z] 21:15:50     INFO - compare10nArgs, expected sheetNum: 3, actual: 2
[task 2020-12-11T21:15:50.232Z] 21:15:50     INFO - compare10nArgs, expected sheetNum: 3, actual: 2
[task 2020-12-11T21:15:50.232Z] 21:15:50     INFO - compare10nArgs, expected sheetNum: 3, actual: 2
[task 2020-12-11T21:15:50.232Z] 21:15:50     INFO - Buffered messages finished
[task 2020-12-11T21:15:50.232Z] 21:15:50     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/printing/tests/browser_preview_navigation.js | Uncaught exception - 2 successive 'next' clicks correctly update the sheet indicator - timed out after 50 tries.
[task 2020-12-11T21:15:50.232Z] 21:15:50     INFO - Leaving test bound testPreviewNavigationCommands
[task 2020-12-11T21:15:50.232Z] 21:15:50     INFO - Entering test bound testMultiplePreviewNavigation
[task 2020-12-11T21:15:50.232Z] 21:15:50     INFO - withTestPage: http://example.com/browser/toolkit/components/printing/tests/longerArticle.html
[task 2020-12-11T21:15:50.232Z] 21:15:50     INFO - GECKO(2228) | [Child 2233: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x10c04fc00 == 1 [pid = 2233] [id = 0]
[task 2020-12-11T21:15:50.233Z] 21:15:50     INFO - GECKO(2228) | [Child 2233: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (0x109221e40) [pid = 2233] [serial = 1] [outer = 0x0]
[task 2020-12-11T21:15:50.233Z] 21:15:50     INFO - GECKO(2228) | [Child 2233: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (0x10c0c7000) [pid = 2233] [serial = 2] [outer = 0x109221e40]
[task 2020-12-11T21:15:50.255Z] 21:15:50     INFO - GECKO(2228) | [Child 2233, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2020-12-11T21:15:50.255Z] 21:15:50     INFO - GECKO(2228) | [Child 2233, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2020-12-11T21:15:50.255Z] 21:15:50     INFO - GECKO(2228) | [Child 2233: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (0x10c0cd800) [pid = 2233] [serial = 3] [outer = 0x109221e40]
[task 2020-12-11T21:15:50.311Z] 21:15:50     INFO - GECKO(2228) | [2239, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2020-12-11T21:15:50.312Z] 21:15:50     INFO - GECKO(2228) | [2239, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2020-12-11T21:15:50.312Z] 21:15:50     INFO - GECKO(2228) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/x7/6z5t3mkj79lg5vwk64y7wbfw000017/T/tmpZE4KyI.mozrunner/runtests_leaks_tab_pid2239.log
[task 2020-12-11T21:15:50.312Z] 21:15:50     INFO - GECKO(2228) | [2239, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2020-12-11T21:15:50.312Z] 21:15:50     INFO - GECKO(2228) | [2239, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2020-12-11T21:15:50.312Z] 21:15:50     INFO - GECKO(2228) | [2239, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:251
[task 2020-12-11T21:15:50.465Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x11566e000 == 9 [pid = 2228] [id = 75]
[task 2020-12-11T21:15:50.466Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 67 (0x114a62580) [pid = 2228] [serial = 173] [outer = 0x0]
[task 2020-12-11T21:15:50.466Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x10f0c0000 == 10 [pid = 2228] [id = 76]
[task 2020-12-11T21:15:50.466Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 68 (0x114a62740) [pid = 2228] [serial = 174] [outer = 0x0]
[task 2020-12-11T21:15:50.466Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x1175aa400 == 11 [pid = 2228] [id = 77]
[task 2020-12-11T21:15:50.466Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 69 (0x114a62900) [pid = 2228] [serial = 175] [outer = 0x0]
[task 2020-12-11T21:15:50.514Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4287
[task 2020-12-11T21:15:50.514Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4287
[task 2020-12-11T21:15:50.514Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4287
[task 2020-12-11T21:15:50.514Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 70 (0x118f6e400) [pid = 2228] [serial = 176] [outer = 0x114a62580]
[task 2020-12-11T21:15:50.523Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 71 (0x118f70c00) [pid = 2228] [serial = 177] [outer = 0x114a62740]
[task 2020-12-11T21:15:50.531Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 72 (0x118f6dc00) [pid = 2228] [serial = 178] [outer = 0x114a62900]
[task 2020-12-11T21:15:50.557Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228, Main Thread] WARNING: NS_ENSURE_TRUE(uri) failed: file /builds/worker/checkouts/gecko/caps/BasePrincipal.cpp:1327
[task 2020-12-11T21:15:50.664Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 73 (0x118f77800) [pid = 2228] [serial = 179] [outer = 0x114a62740]
[task 2020-12-11T21:15:50.673Z] 21:15:50     INFO - GECKO(2228) | [Parent 2228, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1180
...
INFO - compare10nArgs, expected sheetNum: 1, actual: 2
[task 2020-12-11T21:16:00.141Z] 21:16:00     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-12-11T21:16:00.142Z] 21:16:00     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/printing/tests/browser_preview_navigation.js | Uncaught exception - Indicator has the correct initial sheetCount - timed out after 50 tries.
[task 2020-12-11T21:16:00.142Z] 21:16:00     INFO - Leaving test bound testMultiplePreviewNavigation
[task 2020-12-11T21:16:00.142Z] 21:16:00     INFO - GECKO(2228) | MEMORY STAT | vsize 7930MB | residentFast 404MB | heapAllocated 117MB
[task 2020-12-11T21:16:00.145Z] 21:16:00     INFO - TEST-OK | toolkit/components/printing/tests/browser_preview_navigation.js | took 26735ms
[task 2020-12-11T21:16:00.147Z] 21:16:00     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-12-11T21:16:00.147Z] 21:16:00     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/printing/tests/browser_preview_navigation.js | Found an unexpected tab at the end of test run: http://example.com/browser/toolkit/components/printing/tests/longerArticle.html - 
[task 2020-12-11T21:16:00.212Z] 21:16:00     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-12-11T21:16:00.212Z] 21:16:00     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/printing/tests/browser_preview_navigation.js | Found an unexpected tab at the end of test run: http://example.com/browser/toolkit/components/printing/tests/longerArticle.html - 
[task 2020-12-11T21:16:00.272Z] 21:16:00     INFO - GECKO(2228) | [Child 2239: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x10e44d400 == 1 [pid = 2239] [id = 0]
[task 2020-12-11T21:16:00.273Z] 21:16:00     INFO - GECKO(2228) | [Child 2239: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (0x109c21e40) [pid = 2239] [serial = 1] [outer = 0x0]
[task 2020-12-11T21:16:00.284Z] 21:16:00     INFO - GECKO(2228) | [Child 2239: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (0x10e4c3000) [pid = 2239] [serial = 2] [outer = 0x109c21e40]
[task 2020-12-11T21:16:00.316Z] 21:16:00     INFO - checking window state
[task 2020-12-11T21:16:00.317Z] 21:16:00     INFO - TEST-START | toolkit/components/printing/tests/browser_preview_print_coop.js```
status-firefox83: --- → unaffected
status-firefox84: --- → unaffected
status-firefox85: --- → affected
status-firefox86: --- → unaffected
status-firefox-esr78: --- → unaffected
Flags: needinfo?(sfoster)
Keywords: regression
Regressed by: 1681026
Summary: Intermittent toolkit/components/printing/tests/browser_preview_navigation.js | Uncaught exception - 2 successive 'next' clicks correctly update the sheet indicator - timed out after 50 tries. → Intermittent macOS WebRender toolkit/components/printing/tests/browser_preview_navigation.js | Uncaught exception - 2 successive 'next' clicks correctly update the sheet indicator - timed out after 50 tries.
Has Regression Range: --- → yes

This looks like a dupe of bug 1681867 (or vice-versa) ?

Flags: needinfo?(sfoster) → needinfo?(aryx.bugmail)
Status: NEW → RESOLVED
Closed: 4 years ago
Flags: needinfo?(aryx.bugmail)
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.