Closed
Bug 1696109
Opened 4 years ago
Closed 3 years ago
Intermittent browser/components/shell/test/browser_headless_screenshot_1.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
(Firefox :: Shell Integration, defect, P5)
Firefox
Shell Integration
Tracking
()
RESOLVED
INCOMPLETE
88 Branch
| Tracking | Status | |
|---|---|---|
| firefox-esr78 | --- | unaffected |
| firefox86 | --- | unaffected |
| firefox87 | --- | unaffected |
| firefox88 | --- | fixed |
People
(Reporter: intermittent-bug-filer, Assigned: bdahl)
References
(Regression)
Details
(Keywords: intermittent-failure, regression)
Attachments
(1 file)
Filed by: smolnar [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=331848863&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/fnCaaxgZQzepS3bTaXbeAQ/runs/0/artifacts/public/logs/live_backing.log
INFO - TEST-START | browser/components/shell/test/browser_headless_screenshot_1.js
[task 2021-03-03T05:48:01.487Z] 05:48:01 INFO - GECKO(3634) | [CodeCoverage] Setting handlers for process 3857.
[task 2021-03-03T05:48:01.487Z] 05:48:01 INFO - GECKO(3634) | *** You are running in headless mode.
[task 2021-03-03T05:48:01.905Z] 05:48:01 INFO - GECKO(3634) | >>> 1614750481895 Marionette TRACE Marionette enabled
[task 2021-03-03T05:48:01.909Z] 05:48:01 INFO - GECKO(3634) | >>> 1614750481896 Marionette TRACE Received observer notification profile-after-change
[task 2021-03-03T05:48:02.067Z] 05:48:02 INFO - GECKO(3634) | >>> 1614750482058 Marionette TRACE Received observer notification command-line-startup
[task 2021-03-03T05:48:05.250Z] 05:48:05 INFO - GECKO(3634) | [CodeCoverage] Setting handlers for process 3885.
[task 2021-03-03T05:48:05.960Z] 05:48:05 INFO - GECKO(3634) | [CodeCoverage] Setting handlers for process 3908.
[task 2021-03-03T05:48:06.110Z] 05:48:06 INFO - GECKO(3634) | >>> Screenshot saved to: /tmp/headless_test_screenshot.png
[task 2021-03-03T05:48:06.347Z] 05:48:06 INFO - GECKO(3634) | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 575: uncaught exception: Object
[task 2021-03-03T05:48:12.474Z] 05:48:12 INFO - GECKO(3634) | [CodeCoverage] Setting handlers for process 3978.
[task 2021-03-03T05:48:12.924Z] 05:48:12 INFO - GECKO(3634) | >>> 1614750492915 Marionette TRACE Marionette enabled
[task 2021-03-03T05:48:12.924Z] 05:48:12 INFO - GECKO(3634) | >>> 1614750492915 Marionette TRACE Received observer notification profile-after-change
[task 2021-03-03T05:48:13.060Z] 05:48:13 INFO - GECKO(3634) | >>> 1614750493050 Marionette TRACE Received observer notification command-line-startup
[task 2021-03-03T05:48:16.715Z] 05:48:16 INFO - GECKO(3634) | [CodeCoverage] Setting handlers for process 4025.
[task 2021-03-03T05:48:16.856Z] 05:48:16 INFO - GECKO(3634) | >>> Screenshot saved to: /tmp/headless_test_screenshot.png
[task 2021-03-03T05:48:16.973Z] 05:48:16 INFO - GECKO(3634) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-03-03T05:48:17.069Z] 05:48:17 INFO - GECKO(3634) | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 575: uncaught exception: Object
[task 2021-03-03T05:48:22.911Z] 05:48:22 INFO - GECKO(3634) | [CodeCoverage] Setting handlers for process 4077.
[task 2021-03-03T05:48:22.911Z] 05:48:22 INFO - GECKO(3634) | *** You are running in headless mode.
[task 2021-03-03T05:48:23.289Z] 05:48:23 INFO - GECKO(3634) | >>> 1614750503281 Marionette TRACE Marionette enabled
[task 2021-03-03T05:48:23.290Z] 05:48:23 INFO - GECKO(3634) | >>> 1614750503282 Marionette TRACE Received observer notification profile-after-change
[task 2021-03-03T05:48:23.426Z] 05:48:23 INFO - GECKO(3634) | >>> 1614750503417 Marionette TRACE Received observer notification command-line-startup
[task 2021-03-03T05:48:27.027Z] 05:48:27 INFO - GECKO(3634) | [CodeCoverage] Setting handlers for process 4123.
[task 2021-03-03T05:48:27.176Z] 05:48:27 INFO - GECKO(3634) | >>> Screenshot saved to: /tmp/headless_test_screenshot.png
[task 2021-03-03T05:48:27.292Z] 05:48:27 INFO - GECKO(3634) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-03-03T05:48:27.373Z] 05:48:27 INFO - GECKO(3634) | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 575: uncaught exception: Object
[task 2021-03-03T05:48:33.419Z] 05:48:33 INFO - GECKO(3634) | [CodeCoverage] Setting handlers for process 4172.
[task 2021-03-03T05:48:33.877Z] 05:48:33 INFO - GECKO(3634) | >>> 1614750513869 Marionette TRACE Marionette enabled
[task 2021-03-03T05:48:33.877Z] 05:48:33 INFO - GECKO(3634) | >>> 1614750513869 Marionette TRACE Received observer notification profile-after-change
[task 2021-03-03T05:48:34.014Z] 05:48:34 INFO - GECKO(3634) | >>> 1614750514009 Marionette TRACE Received observer notification command-line-startup
[task 2021-03-03T05:48:37.675Z] 05:48:37 INFO - GECKO(3634) | [CodeCoverage] Setting handlers for process 4219.
[task 2021-03-03T05:48:37.816Z] 05:48:37 INFO - GECKO(3634) | >>> Screenshot saved to: /tmp/headless_test_screenshot.png
[task 2021-03-03T05:48:38.045Z] 05:48:38 INFO - GECKO(3634) | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 575: uncaught exception: Object
[task 2021-03-03T05:48:44.151Z] 05:48:44 INFO - GECKO(3634) | [CodeCoverage] Setting handlers for process 4273.
[task 2021-03-03T05:48:44.151Z] 05:48:44 INFO - GECKO(3634) | *** You are running in headless mode.
INFO - GECKO(3634) | >>> 1614750524555 Marionette TRACE Marionette enabled
[task 2021-03-03T05:48:44.569Z] 05:48:44 INFO - GECKO(3634) | >>> 1614750524555 Marionette TRACE Received observer notification profile-after-change
[task 2021-03-03T05:48:44.707Z] 05:48:44 INFO - GECKO(3634) | >>> 1614750524697 Marionette TRACE Received observer notification command-line-startup
[task 2021-03-03T05:48:48.325Z] 05:48:48 INFO - GECKO(3634) | [CodeCoverage] Setting handlers for process 4320.
[task 2021-03-03T05:48:48.466Z] 05:48:48 INFO - GECKO(3634) | >>> Screenshot saved to: /tmp/headless_test_screenshot.png
[task 2021-03-03T05:48:48.668Z] 05:48:48 INFO - GECKO(3634) | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 575: uncaught exception: Object
[task 2021-03-03T05:48:54.873Z] 05:48:54 INFO - TEST-INFO | started process screentopng
[task 2021-03-03T05:48:55.029Z] 05:48:55 INFO - TEST-INFO | screentopng: exit 0
[task 2021-03-03T05:48:55.031Z] 05:48:55 INFO - Buffered messages logged at 05:48:01
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - Entering test bound
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - Buffered messages logged at 05:48:12
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | Firefox process should exit with code 0 -
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | A screenshot should be saved as /tmp/headless_test_screenshot.png -
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | Screenshot should not be an empty file -
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - Buffered messages logged at 05:48:22
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | Firefox process should exit with code 0 -
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | A screenshot should be saved as /tmp/headless_test_screenshot.png -
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | Screenshot should not be an empty file -
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - Buffered messages logged at 05:48:33
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | Firefox process should exit with code 0 -
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | A screenshot should be saved as /tmp/headless_test_screenshot.png -
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | Screenshot should not be an empty file -
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - Buffered messages logged at 05:48:44
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | Firefox process should exit with code 0 -
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | A screenshot should be saved as /tmp/headless_test_screenshot.png -
[task 2021-03-03T05:48:55.032Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | Screenshot should not be an empty file -
[task 2021-03-03T05:48:55.033Z] 05:48:55 INFO - Buffered messages logged at 05:48:54
[task 2021-03-03T05:48:55.033Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | Firefox process should exit with code 0 -
[task 2021-03-03T05:48:55.033Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | A screenshot should be saved as /tmp/headless_test_screenshot.png -
[task 2021-03-03T05:48:55.033Z] 05:48:55 INFO - TEST-PASS | browser/components/shell/test/browser_headless_screenshot_1.js | Screenshot should not be an empty file -
[task 2021-03-03T05:48:55.033Z] 05:48:55 INFO - Leaving test bound
[task 2021-03-03T05:48:55.033Z] 05:48:55 INFO - Buffered messages finished
[task 2021-03-03T05:48:55.033Z] 05:48:55 INFO - TEST-UNEXPECTED-FAIL | browser/components/shell/test/browser_headless_screenshot_1.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-03T05:48:55.033Z] 05:48:55 INFO - GECKO(3634) | MEMORY STAT | vsize 3167MB | residentFast 594MB | heapAllocated 92MB
[task 2021-03-03T05:48:55.033Z] 05:48:55 INFO - TEST-OK | browser/components/shell/test/browser_headless_screenshot_1.js | took 53552ms
[task 2021-03-03T05:48:55.033Z] 05:48:55 INFO - checking window state
[task 2021-03-03T05:48:55.033Z] 05:48:55 INFO - TEST-START | browser/components/shell/test/browser_headless_screenshot_2.js```
|
||
Comment 1•4 years ago
|
||
This is a new test from bug 1571419 and the failures are on the slow Linux code coverage platform. Brendan, can you check the failure and decide on a fix or if it shall get disabled for ccov?
status-firefox86:
--- → unaffected
status-firefox87:
--- → unaffected
status-firefox88:
--- → affected
status-firefox-esr78:
--- → unaffected
Flags: needinfo?(bdahl)
Regressed by: 1571419
|
||
Updated•4 years ago
|
Has Regression Range: --- → yes
|
Assignee | |
Comment 2•4 years ago
|
||
|
||
Updated•4 years ago
|
Assignee: nobody → bdahl
Status: NEW → ASSIGNED
| Comment hidden (Intermittent Failures Robot) |
Pushed by bdahl@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/4ce822272b78
Disable headless screenshot test for code coverage. r=kmag
|
||
Comment 5•4 years ago
|
||
| bugherder | ||
Status: ASSIGNED → RESOLVED
Closed: 4 years ago
Resolution: --- → FIXED
Target Milestone: --- → 88 Branch
|
|
Assignee | |
Updated•4 years ago
|
Flags: needinfo?(bdahl)
|
||
Comment 6•3 years ago
|
||
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=361510288&repo=autoland&lineNumber=3222
Status: RESOLVED → REOPENED
Resolution: FIXED → ---
|
||
Updated•3 years ago
|
Keywords: regression
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 8•3 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: REOPENED → RESOLVED
Closed: 4 years ago → 3 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•