Closed Bug 1681226 Opened 4 years ago Closed 4 years ago

Intermittent TV toolkit/components/printing/tests/browser_print_margins.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. -

Categories

(Toolkit :: Printing, defect, P5)

Product:
Toolkit
Component:
Printing
Type:
defect

Tracking

()

Status:
RESOLVED FIXED
Milestone:
85 Branch
Tracking Flags:
Tracking Status
firefox-esr78 --- unaffected
firefox83 --- unaffected
firefox84 --- unaffected
firefox85 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: mstriemer)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Attachments

(1 file)

Bug 1681226 - Reduce print dialog interaction delay in automation r?emalysz
(deleted), text/x-phabricator-request
Details

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

...
[task 2020-12-07T22:11:32.137Z] 22:11:32     INFO - Entering test bound testResetMarginPersists
[task 2020-12-07T22:11:32.137Z] 22:11:32     INFO - Buffered messages logged at 22:11:25
[task 2020-12-07T22:11:32.137Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Found a paper - 
[task 2020-12-07T22:11:32.137Z] 22:11:32     INFO - Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://example.com/browser/toolkit/components/printing/tests/simplifyArticleSample.html" line: 0}]
[task 2020-12-07T22:11:32.137Z] 22:11:32     INFO - Buffered messages logged at 22:11:28
[task 2020-12-07T22:11:32.137Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Element must be visible to click - 
[task 2020-12-07T22:11:32.137Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Got the same number of settings to check - 
[task 2020-12-07T22:11:32.138Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Checking the same setting names - 
[task 2020-12-07T22:11:32.138Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginTop matches - 
[task 2020-12-07T22:11:32.138Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginRight matches - 
[task 2020-12-07T22:11:32.138Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginBottom matches - 
[task 2020-12-07T22:11:32.138Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginLeft matches - 
[task 2020-12-07T22:11:32.139Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Element must be visible to click - 
[task 2020-12-07T22:11:32.145Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Element must be visible to click - 
[task 2020-12-07T22:11:32.146Z] 22:11:32     INFO - Buffered messages logged at 22:11:30
[task 2020-12-07T22:11:32.146Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Margin error is hidden - 
[task 2020-12-07T22:11:32.146Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginTop matches - 
[task 2020-12-07T22:11:32.146Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginRight matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginBottom matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginLeft matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Got the same number of settings to check - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Checking the same setting names - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginTop matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginRight matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginBottom matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginLeft matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Margin error is hidden - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginTop matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginRight matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginBottom matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginLeft matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Got the same number of settings to check - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Checking the same setting names - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginTop matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginRight matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginBottom matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginLeft matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - Buffered messages logged at 22:11:31
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Margin error is hidden - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginTop matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginRight matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginBottom matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginLeft matches - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - Leaving test bound testResetMarginPersists
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - Buffered messages finished
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/printing/tests/browser_print_margins.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. - 
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - GECKO(2759) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - GECKO(2759) | MEMORY STAT | vsize 7835MB | residentFast 337MB | heapAllocated 113MB
[task 2020-12-07T22:11:32.149Z] 22:11:32     INFO - TEST-OK | toolkit/components/printing/tests/browser_print_margins.js | took 130224ms```

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

status-firefox83: --- → unaffected
status-firefox84: --- → unaffected
status-firefox85: --- → affected
status-firefox-esr78: --- → unaffected
Assignee: nobody → mstriemer
Status: NEW → ASSIGNED

This test changes a lot of settings that have a 500ms delay before taking effect. Attached a patch to reduce that to 100ms when the tests are running. It took about 10 seconds off the run time locally so I'm not sure if that will be enough but hopefully it helps.

Pushed by mstriemer@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/f947a5c5794d Reduce print dialog interaction delay in automation r=emalysz

https://hg.mozilla.org/mozilla-central/rev/f947a5c5794d

Status: ASSIGNED → RESOLVED
Closed: 4 years ago
status-firefox85: affected → fixed
Resolution: --- → FIXED
Target Milestone: --- → 85 Branch
Has Regression Range: --- → yes
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: