1698240 - Intermittent 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. -

Status: RESOLVED DUPLICATE of bug 1786351

(Toolkit :: Printing, defect, P5)

Description

[Treeherder Bug Filer]

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

---

...
[task 2021-03-13T01:10:51.412Z] 01:10:51     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | The update task is armed - 
[task 2021-03-13T01:10:51.412Z] 01:10:51     INFO - Buffered messages logged at 01:10:50
[task 2021-03-13T01:10:51.413Z] 01:10:51     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Converted custom margin value is expected value - 
[task 2021-03-13T01:10:51.413Z] 01:10:51     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginTop matches - 
[task 2021-03-13T01:10:51.413Z] 01:10:51     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Got the same number of settings to check - 
[task 2021-03-13T01:10:51.413Z] 01:10:51     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Checking the same setting names - 
[task 2021-03-13T01:10:51.413Z] 01:10:51     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginTop matches - 
[task 2021-03-13T01:10:51.414Z] 01:10:51     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Margin error is hidden - 
[task 2021-03-13T01:10:51.414Z] 01:10:51     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Element must be visible to click - 
[task 2021-03-13T01:10:51.414Z] 01:10:51     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | Margin error is showing - 
[task 2021-03-13T01:10:51.414Z] 01:10:51     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | The update task isn't armed - 
[task 2021-03-13T01:10:51.414Z] 01:10:51     INFO - TEST-PASS | toolkit/components/printing/tests/browser_print_margins.js | marginTop matches - 
[task 2021-03-13T01:10:51.415Z] 01:10:51     INFO - Buffered messages logged at 01:10:51
[task 2021-03-13T01:10:51.415Z] 01:10:51     INFO - Leaving test bound testCustomMarginUnits
[task 2021-03-13T01:10:51.415Z] 01:10:51     INFO - Buffered messages finished
[task 2021-03-13T01:10:51.415Z] 01:10:51     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 2021-03-13T01:10:51.415Z] 01:10:51     INFO - GECKO(2516) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2021-03-13T01:10:51.416Z] 01:10:51     INFO - GECKO(2516) | [Child 2568: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 105df7400 == 2 [pid = 2568] [id = 0] [url = http://example.com/browser/toolkit/components/printing/tests/simplifyArticleSample.html]
[task 2021-03-13T01:10:51.416Z] 01:10:51     INFO - GECKO(2516) | [Child 2568: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 105dfbc00 == 1 [pid = 2568] [id = 1] [url = about:blank]
[task 2021-03-13T01:10:51.416Z] 01:10:51     INFO - GECKO(2516) | [Child 2568: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 105fc2000 == 0 [pid = 2568] [id = 2] [url = about:blank]
[task 2021-03-13T01:10:51.416Z] 01:10:51     INFO - GECKO(2516) | MEMORY STAT | vsize 7841MB | residentFast 371MB | heapAllocated 116MB
[task 2021-03-13T01:10:51.416Z] 01:10:51     INFO - TEST-OK | toolkit/components/printing/tests/browser_print_margins.js | took 122842ms
[task 2021-03-13T01:10:51.417Z] 01:10:51     INFO - GECKO(2516) | [Child 2518: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 10ae19000 == 1 [pid = 2518] [id = 1]
[task 2021-03-13T01:10:51.424Z] 01:10:51     INFO - GECKO(2516) | [Child 2518: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (103c21200) [pid = 2518] [serial = 5] [outer = 0]
[task 2021-03-13T01:10:51.424Z] 01:10:51     INFO - GECKO(2516) | [Child 2518: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (10aef4c00) [pid = 2518] [serial = 6] [outer = 103c21200]
[task 2021-03-13T01:10:51.425Z] 01:10:51     INFO - GECKO(2516) | [Child 2568: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 7 (105fc3000) [pid = 2568] [serial = 7] [outer = 0] [url = about:blank]
[task 2021-03-13T01:10:51.425Z] 01:10:51     INFO - GECKO(2516) | [Child 2568: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 6 (105fb4400) [pid = 2568] [serial = 5] [outer = 0] [url = about:blank]
[task 2021-03-13T01:10:51.425Z] 01:10:51     INFO - GECKO(2516) | [Child 2568: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (103121e40) [pid = 2568] [serial = 1] [outer = 0] [url = http://example.com/browser/toolkit/components/printing/tests/simplifyArticleSample.html]
[task 2021-03-13T01:10:51.425Z] 01:10:51     INFO - GECKO(2516) | [Child 2568: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (105f9fe40) [pid = 2568] [serial = 6] [outer = 0] [url = about:blank]
[task 2021-03-13T01:10:51.425Z] 01:10:51     INFO - GECKO(2516) | [Child 2568: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (105f9fac0) [pid = 2568] [serial = 4] [outer = 0] [url = http://example.com/browser/toolkit/components/printing/tests/simplifyArticleSample.html]
[task 2021-03-13T01:10:51.425Z] 01:10:51     INFO - GECKO(2516) | [Child 2568: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (105dfac00) [pid = 2568] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-03-13T01:10:51.425Z] 01:10:51     INFO - GECKO(2516) | [Child 2568: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (105fb7400) [pid = 2568] [serial = 3] [outer = 0] [url = http://example.com/browser/toolkit/components/printing/tests/simplifyArticleSample.html]
[task 2021-03-13T01:10:51.426Z] 01:10:51     INFO - GECKO(2516) | [Child 2568: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (1069e9c00) [pid = 2568] [serial = 8] [outer = 0] [url = http://example.com/browser/toolkit/components/printing/tests/simplifyArticleSample.html]
[task 2021-03-13T01:10:51.426Z] 01:10:51     INFO - GECKO(2516) | [Child 2568, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3365
[task 2021-03-13T01:10:51.426Z] 01:10:51     INFO - GECKO(2516) | [Child 2568, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4442
[task 2021-03-13T01:10:51.426Z] 01:10:51     INFO - checking window state```

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 4

Platform and build breakdown:

• macosx1014-64-qr: 4
  • opt: 2
  • debug: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1698240&startday=2021-03-08&endday=2021-03-14&tree=all

Comment 2

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

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

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

[Marian-Vasile Laza]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=351910760&repo=autoland&lineNumber=2623

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 4

Platform and build breakdown:

• macosx1015-64-qr: 4
  • debug: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1698240&startday=2021-09-13&endday=2021-09-19&tree=all

Comment 6

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

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

Comment 7

[Atila Butkovits]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=359719274&repo=autoland&lineNumber=2666

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 4

Platform and build breakdown:

• macosx1015-64-qr: 4
  • opt: 2
  • debug: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1698240&startday=2021-11-29&endday=2021-12-05&tree=all

Comment 9

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

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

Comment 10

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=364329335&repo=autoland

Comment 11

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 7

Platform and build breakdown:

• macosx1015-64-qr: 7
  • debug: 3
  • opt: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1698240&startday=2022-01-17&endday=2022-01-23&tree=all

Comment 12

[Iulian Moraru]

This started to fail on tier 1: https://treeherder.mozilla.org/logviewer?job_id=367347581&repo=mozilla-central&lineNumber=11978

Comment 13

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1698240&startday=2022-02-07&endday=2022-02-13&tree=all

Comment 14

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

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

Comment 15

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=378011434&repo=autoland

Comment 16

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• macosx1015-64-qr: 2
  • opt: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1698240&startday=2022-05-09&endday=2022-05-15&tree=all

Comment 17

[Intermittent Failures Robot]

10 failures in 2624 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 10

Platform and build breakdown:

• linux1804-64-qr: 8
  • opt: 8
• windows7-32-qr: 1
  • opt: 1
• macosx1015-64-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1698240&startday=2022-05-23&endday=2022-05-29&tree=all

Comment 18

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

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

Comment 19

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=387405754&repo=autoland

Comment 20

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• macosx1015-64-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1698240&startday=2022-08-15&endday=2022-08-21&tree=all