1691096 - Intermittent devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Scroll Fullpage Clipboard: Image width/height matches page size minus scrollbar size - Got 2572, expected 2560

Status: RESOLVED FIXED

(DevTools :: Console, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2021-02-05T16:11:57.029Z] 16:11:57     INFO - TEST-START | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js
[task 2021-02-05T16:11:58.909Z] 16:11:58     INFO - TEST-INFO | started process screentopng
[task 2021-02-05T16:11:59.207Z] 16:11:59     INFO - TEST-INFO | screentopng: exit 0
[task 2021-02-05T16:11:59.207Z] 16:11:59     INFO - Buffered messages logged at 16:11:57
[task 2021-02-05T16:11:59.207Z] 16:11:59     INFO - Entering test bound 
[task 2021-02-05T16:11:59.208Z] 16:11:59     INFO - Adding a new tab with URL: http://example.com/browser/devtools/client/webconsole/test/browser/test_jsterm_screenshot_command.html
[task 2021-02-05T16:11:59.208Z] 16:11:59     INFO - Console message: [JavaScript Warning: "The character encoding of a framed document was not declared. The document may appear different if viewed without the document framing it." {file: "http://example.com/document-builder.sjs?html=%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%20%20%20%20%20%20%20%20%20%20%20%20%20%20html%20{%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20background:rgb(255,%20255,%200);%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20text-align:%20center;%20%20%20%20%20%20%20%20%20%20%20%20%20%20}%20%20%20%20%20%20%20%20%20%20%20%20%20%20span%20{%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20background-color:%20rgb(0,%20100,%200);%20%20%20%20%20%20%20%20%20%20%20%20%20%2" line: 0}]
[task 2021-02-05T16:11:59.208Z] 16:11:59     INFO - Tab added and finished loading
[task 2021-02-05T16:11:59.208Z] 16:11:59     INFO - Opening the toolbox
[task 2021-02-05T16:11:59.209Z] 16:11:59     INFO - Buffered messages logged at 16:11:58
[task 2021-02-05T16:11:59.209Z] 16:11:59     INFO - Toolbox opened and focused
[task 2021-02-05T16:11:59.210Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | web console opened - 
[task 2021-02-05T16:11:59.211Z] 16:11:59     INFO - Matched a message with text: "Screenshot copied to clipboard.", all messages received.
[task 2021-02-05T16:11:59.211Z] 16:11:59     INFO - content size: 1280x716
[task 2021-02-05T16:11:59.213Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | screenshot exists - 
[task 2021-02-05T16:11:59.213Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Read expected amount of data - 
[task 2021-02-05T16:11:59.214Z] 16:11:59     INFO - Waiting for the clipboard image to load in the content page
[task 2021-02-05T16:11:59.214Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Clipboard: Image width matches window size - 
[task 2021-02-05T16:11:59.215Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Clipboard: Image height matches window size - 
[task 2021-02-05T16:11:59.216Z] 16:11:59     INFO - Matched a message with text: "Screenshot copied to clipboard.", all messages received.
[task 2021-02-05T16:11:59.216Z] 16:11:59     INFO - content size: 1280x716
[task 2021-02-05T16:11:59.217Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | screenshot exists - 
[task 2021-02-05T16:11:59.217Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Read expected amount of data - 
[task 2021-02-05T16:11:59.218Z] 16:11:59     INFO - Waiting for the clipboard image to load in the content page
[task 2021-02-05T16:11:59.218Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Fullpage Clipboard: Image width matches page size - 
[task 2021-02-05T16:11:59.219Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Fullpage Clipboard: Image height matches page size - 
[task 2021-02-05T16:11:59.220Z] 16:11:59     INFO - Matched a message with text: "Screenshot copied to clipboard.", all messages received.
[task 2021-02-05T16:11:59.220Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | screenshot exists - 
[task 2021-02-05T16:11:59.221Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Read expected amount of data - 
[task 2021-02-05T16:11:59.221Z] 16:11:59     INFO - Waiting for the clipboard image to load in the content page
[task 2021-02-05T16:11:59.222Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Selector Clipboard: Image width matches element size - 100 == 100 - 
[task 2021-02-05T16:11:59.223Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Selector Clipboard: Image height matches element size - 100 == 100 - 
[task 2021-02-05T16:11:59.223Z] 16:11:59     INFO - Matched a message with text: "Screenshot copied to clipboard.", all messages received.
[task 2021-02-05T16:11:59.225Z] 16:11:59     INFO - content size: 1280x716
[task 2021-02-05T16:11:59.225Z] 16:11:59     INFO - Scrollbar size: 12x12
[task 2021-02-05T16:11:59.227Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | screenshot exists - 
[task 2021-02-05T16:11:59.227Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Read expected amount of data - 
[task 2021-02-05T16:11:59.228Z] 16:11:59     INFO - Waiting for the clipboard image to load in the content page
[task 2021-02-05T16:11:59.228Z] 16:11:59     INFO - Buffered messages finished
[task 2021-02-05T16:11:59.231Z] 16:11:59     INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Scroll Fullpage Clipboard: Image width matches page size minus scrollbar size - Got 2572, expected 2560
[task 2021-02-05T16:11:59.231Z] 16:11:59     INFO - Stack trace:
[task 2021-02-05T16:11:59.232Z] 16:11:59     INFO - chrome://mochikit/content/browser-test.js:test_is:1351
[task 2021-02-05T16:11:59.232Z] 16:11:59     INFO - chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js:testFullpageClipboardScrollbar:94
[task 2021-02-05T16:11:59.233Z] 16:11:59     INFO - chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js:null:26
[task 2021-02-05T16:11:59.233Z] 16:11:59     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1088
[task 2021-02-05T16:11:59.234Z] 16:11:59     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1128
[task 2021-02-05T16:11:59.234Z] 16:11:59     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:948
[task 2021-02-05T16:11:59.235Z] 16:11:59     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:1037
[task 2021-02-05T16:11:59.235Z] 16:11:59     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-02-05T16:11:59.237Z] 16:11:59     INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | Scroll Fullpage Clipboard: Image height matches page size minus scrollbar size - Got 1494, expected 1482
[task 2021-02-05T16:11:59.237Z] 16:11:59     INFO - Stack trace:
[task 2021-02-05T16:11:59.237Z] 16:11:59     INFO - chrome://mochikit/content/browser-test.js:test_is:1351
[task 2021-02-05T16:11:59.237Z] 16:11:59     INFO - chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js:testFullpageClipboardScrollbar:102
[task 2021-02-05T16:11:59.238Z] 16:11:59     INFO - chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js:null:26
[task 2021-02-05T16:11:59.238Z] 16:11:59     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1088
[task 2021-02-05T16:11:59.239Z] 16:11:59     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1128
[task 2021-02-05T16:11:59.239Z] 16:11:59     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:948
[task 2021-02-05T16:11:59.240Z] 16:11:59     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:1037
[task 2021-02-05T16:11:59.241Z] 16:11:59     INFO - Leaving test bound 
[task 2021-02-05T16:11:59.747Z] 16:11:59     INFO - Removing tab.
[task 2021-02-05T16:11:59.748Z] 16:11:59     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2021-02-05T16:11:59.749Z] 16:11:59     INFO - Got event: 'TabClose' on [object XULElement].
[task 2021-02-05T16:11:59.751Z] 16:11:59     INFO - GECKO(13502) | console.warn: "IGNORED REDUX ACTION:" "AUTOCOMPLETE_CLEAR"
[task 2021-02-05T16:11:59.763Z] 16:11:59     INFO - Tab removed and finished closing
[task 2021-02-05T16:11:59.788Z] 16:11:59     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | The main process DevToolsServer has no pending connection when the test ends - 
[task 2021-02-05T16:11:59.809Z] 16:11:59     INFO - GECKO(13502) | MEMORY STAT | vsize 4328MB | residentFast 1032MB | heapAllocated 552MB
[task 2021-02-05T16:11:59.809Z] 16:11:59     INFO - TEST-OK | devtools/client/webconsole/test/browser/browser_jsterm_screenshot_command_clipboard.js | took 2775ms```

Comment 1

[Intermittent Failures Robot]

22 failures in 3966 pushes (0.006 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 18
• try: 3
• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-shippable: 8
  • opt: 8
• linux1804-64: 11
  • opt: 11
• macosx1014-64-qr: 2
  • opt: 2
• macosx1014-64-shippable-qr: 1
  • opt: 1

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

Comment 2

[Bogdan Tara[:bogdan_tara | bogdant]]

This seems to start with the changes in bug 1474006.

https://treeherder.mozilla.org/jobs?repo=autoland&searchStr=Linux%2C18.04%2Cx64%2Cshippable%2Copt%2CMochitests%2Cwith%2Cfission%2Cenabled%2Ctest-linux1804-64-shippable%2Fopt-mochitest-devtools-chrome-fis-e10s%2Cdt1&tochange=f3ca9333ae5f6bc055ab3b1746b110405e06c1c1&fromchange=642b19199dd4808ae90394b36ebeafd2d2a503d9&selectedTaskRun=acyx-nRhSdWW3UMT5_FF1w.0

Nicolas, could you, please, take a look?

Comment 3

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

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

Comment 4

[Nicolas Chevobbe [:nchevobbe]]

It's more likely to have been regressed by Bug 1678483.
I'm going to look today

Comment 5

[Nicolas Chevobbe [:nchevobbe]]

Attachment: Bug 1691096 - [devtools] Fix intermittent on browser_jsterm_screenshot_command_clipboard.js. r=bomsy

We wait for a tick after triggering the overflow so the scrollbars have the time
to be rendered.

Comment 6

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/9363c9d95f6c
[devtools] Fix intermittent on browser_jsterm_screenshot_command_clipboard.js. r=bomsy

Comment 7

[Narcis Beleuzu [:NarcisB]]

https://hg.mozilla.org/mozilla-central/rev/9363c9d95f6c

Comment 8

[Intermittent Failures Robot]

24 failures in 4322 pushes (0.006 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 17
• try: 4
• mozilla-central: 3

Platform and build breakdown:

• linux1804-64: 8
  • opt: 8
• macosx1014-64-qr: 3
  • opt: 3
• linux1804-64-devedition: 1
  • opt: 1
• macosx1014-64-shippable-qr: 1
  • opt: 1
• linux1804-64-shippable: 9
  • opt: 9
• windows7-32: 2
  • opt: 2

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