1578076 - Perma fission devtools/client/webconsole/test/browser/browser_webconsole_trackingprotection_errors.js | Uncaught exception - Wait for 'blocking all third-party storage access' message - timed out after 500 tries.

Status: RESOLVED INCOMPLETE

(DevTools :: Console, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: cbrindusan [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=264453418&repo=mozilla-central
Full log: https://queue.taskcluster.net/v1/task/My1dB7lsRbOp03QJP8z54w/runs/0/artifacts/public/logs/live_backing.log

---

[task 2019-09-01T11:30:31.321Z] 11:30:31 INFO - TEST-START | devtools/client/webconsole/test/browser/browser_webconsole_trackingprotection_errors.js
[task 2019-09-01T11:30:33.449Z] 11:30:33 INFO - GECKO(4648) | Assertion failure
[task 2019-09-01T11:30:33.449Z] 11:30:33 INFO - GECKO(4648) | assert@resource:///modules/AsyncTabSwitcher.jsm:490:36
[task 2019-09-01T11:30:33.449Z] 11:30:33 INFO - GECKO(4648) | onLayersCleared@resource:///modules/AsyncTabSwitcher.jsm:827:12
[task 2019-09-01T11:30:33.449Z] 11:30:33 INFO - GECKO(4648) | handleEvent@resource:///modules/AsyncTabSwitcher.jsm:1131:16
[task 2019-09-01T11:30:33.449Z] 11:30:33 INFO - GECKO(4648) | EventListener.handleEventAsyncTabSwitcher@resource:///modules/AsyncTabSwitcher.jsm:155:17
[task 2019-09-01T11:30:33.449Z] 11:30:33 INFO - GECKO(4648) | _getSwitcher@chrome://browser/content/tabbrowser.js:4705:26
[task 2019-09-01T11:30:33.450Z] 11:30:33 INFO - GECKO(4648) | updateCurrentBrowser@chrome://browser/content/tabbrowser.js:1019:16
[task 2019-09-01T11:30:33.450Z] 11:30:33 INFO - GECKO(4648) | _setupEventListeners/<@chrome://browser/content/tabbrowser.js:5107:16
[task 2019-09-01T11:30:33.450Z] 11:30:33 INFO - GECKO(4648) | set selectedIndex@chrome://global/content/elements/tabbox.js:208:14
[task 2019-09-01T11:30:33.450Z] 11:30:33 INFO - GECKO(4648) | set selectedPanel@chrome://global/content/elements/tabbox.js:227:7
[task 2019-09-01T11:30:33.450Z] 11:30:33 INFO - GECKO(4648) | set selectedIndex@chrome://global/content/elements/tabbox.js:571:11
[task 2019-09-01T11:30:33.450Z] 11:30:33 INFO - GECKO(4648) | set selectedItem@chrome://global/content/elements/tabbox.js:591:35
[task 2019-09-01T11:30:33.450Z] 11:30:33 INFO - GECKO(4648) | set selectedTab@chrome://global/content/elements/tabbox.js:98:11
[task 2019-09-01T11:30:33.450Z] 11:30:33 INFO - GECKO(4648) | set selectedTab@chrome://browser/content/tabbrowser.js:312:7
[task 2019-09-01T11:30:33.450Z] 11:30:33 INFO - GECKO(4648) | addTab@chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:193:5
[task 2019-09-01T11:30:33.451Z] 11:30:33 INFO - GECKO(4648) | openNewWindowAndConsole@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/head.js:104:21
[task 2019-09-01T11:30:33.451Z] 11:30:33 INFO - GECKO(4648) | asynctestForeignCookieBlockedMessage@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_trackingprotection_errors.js:70:30
[task 2019-09-01T11:30:33.451Z] 11:30:33 INFO - GECKO(4648) | AsyncTester_execTest/<@chrome://mochikit/content/browser-test.js:1350:34
[task 2019-09-01T11:30:33.451Z] 11:30:33 INFO - GECKO(4648) | asyncTester_execTest@chrome://mochikit/content/browser-test.js:1385:11
[task 2019-09-01T11:30:33.451Z] 11:30:33 INFO - GECKO(4648) | nextTest/<@chrome://mochikit/content/browser-test.js:1213:14
[task 2019-09-01T11:30:33.451Z] 11:30:33 INFO - GECKO(4648) | SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:805:67
[task 2019-09-01T11:30:33.489Z] 11:30:33 INFO - GECKO(4648) | JavaScript error: resource:///actors/PageStyleChild.jsm, line 35: SecurityError: Permission denied to access property "document" on cross-origin object
[task 2019-09-01T11:30:36.543Z] 11:30:36 INFO - GECKO(4648) | console.error: (new TypeError("this._walker is undefined", "resource://devtools/client/accessibility/accessibility-startup.js", 141))
[task 2019-09-01T11:30:37.365Z] 11:30:37 INFO - GECKO(4648) | [Parent 4948, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-09-01T11:30:37.384Z] 11:30:37 INFO - GECKO(4648) | [Child 456, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-09-01T11:30:37.668Z] 11:30:37 INFO - GECKO(4648) | [Child 456, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/buil
[task 2019-09-01T11:30:37.934Z] 11:30:37 INFO - GECKO(4648) | Assertion failure
[task 2019-09-01T11:30:37.935Z] 11:30:37 INFO - GECKO(4648) | assert@resource:///modules/AsyncTabSwitcher.jsm:490:36
[task 2019-09-01T11:30:37.936Z] 11:30:37 INFO - GECKO(4648) | onLayersCleared@resource:///modules/AsyncTabSwitcher.jsm:827:12
[task 2019-09-01T11:30:37.936Z] 11:30:37 INFO - GECKO(4648) | handleEvent@resource:///modules/AsyncTabSwitcher.jsm:1131:16
[task 2019-09-01T11:30:37.937Z] 11:30:37 INFO - GECKO(4648) | EventListener.handleEventAsyncTabSwitcher@resource:///modules/AsyncTabSwitcher.jsm:155:17
[task 2019-09-01T11:30:37.937Z] 11:30:37 INFO - GECKO(4648) | _getSwitcher@chrome://browser/content/tabbrowser.js:4705:26
[task 2019-09-01T11:30:37.938Z] 11:30:37 INFO - GECKO(4648) | updateCurrentBrowser@chrome://browser/content/tabbrowser.js:1019:16
[task 2019-09-01T11:30:37.938Z] 11:30:37 INFO - GECKO(4648) | _setupEventListeners/<@chrome://browser/content/tabbrowser.js:5107:16
[task 2019-09-01T11:30:37.938Z] 11:30:37 INFO - GECKO(4648) | set selectedIndex@chrome://global/content/elements/tabbox.js:208:14
[task 2019-09-01T11:30:37.938Z] 11:30:37 INFO - GECKO(4648) | set selectedPanel@chrome://global/content/elements/tabbox.js:227:7
[task 2019-09-01T11:30:37.938Z] 11:30:37 INFO - GECKO(4648) | set selectedIndex@chrome://global/content/elements/tabbox.js:571:11
[task 2019-09-01T11:30:37.938Z] 11:30:37 INFO - GECKO(4648) | set selectedItem@chrome://global/content/elements/tabbox.js:591:35[task 2019-09-01T11:30:37.938Z] 11:30:37 INFO - GECKO(4648) | set selectedTab@chrome://global/content/elements/tabbox.js:98:11
[task 2019-09-01T11:30:37.939Z] 11:30:37 INFO - GECKO(4648) | set selectedTab@chrome://browser/content/tabbrowser.js:312:7
[task 2019-09-01T11:30:37.939Z] 11:30:37 INFO - GECKO(4648) | addTab@chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:193:5
[task 2019-09-01T11:30:37.939Z] 11:30:37 INFO - GECKO(4648) | openNewWindowAndConsole@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/head.js:104:21
[task 2019-09-01T11:30:37.939Z] 11:30:37 INFO - GECKO(4648) | asynctestLimitForeignCookieBlockedMessage@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_trackingprotection_errors.js:93:30
[task 2019-09-01T11:30:37.939Z] 11:30:37 INFO - GECKO(4648) | AsyncTester_execTest/<@chrome://mochikit/content/browser-test.js:1350:34
[task 2019-09-01T11:30:37.939Z] 11:30:37 INFO - GECKO(4648) | asyncTester_execTest@chrome://mochikit/content/browser-test.js:1385:11
[task 2019-09-01T11:30:37.939Z] 11:30:37 INFO - GECKO(4648) | nextTest/<@chrome://mochikit/content/browser-test.js:1213:14
[task 2019-09-01T11:30:37.939Z] 11:30:37 INFO - GECKO(4648) | SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:805:67
[task 2019-09-01T11:30:37.978Z] 11:30:37 INFO - GECKO(4648) | JavaScript error: resource:///actors/PageStyleChild.jsm, line 35: SecurityError: Permission denied to access property "document" on cross-origin object
[task 2019-09-01T11:31:29.254Z] 11:31:29 INFO - TEST-INFO | started process screenshot
[task 2019-09-01T11:31:29.312Z] 11:31:29 INFO - TEST-INFO | screenshot: exit 0
[task 2019-09-01T11:31:29.312Z] 11:31:29 INFO - Buffered messages logged at 11:30:31
[task 2019-09-01T11:31:29.312Z] 11:31:29 INFO - Entering test bound testContentBlockingMessage
[task 2019-09-01T11:31:29.312Z] 11:31:29 INFO - Adding a new tab with URL: http://tracking.example.org/browser/devtools/client/webconsole/test/browser/test-trackingprotection-securityerrors.html
[task 2019-09-01T11:31:29.312Z] 11:31:29 INFO - Console message: [JavaScript Warning: "The resource at “http://tracking.example.com/” was blocked because content blocking is enabled." {file: "http://tracking.example.org/browser/devtools/client/webconsole/test/browser/test-trackingprotection-securityerrors.html" line: 0}]
[task 2019-09-01T11:31:29.312Z] 11:31:29 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://tracking.example.org/browser/devtools/client/webconsole/test/browser/cookieSetter.html" line: 0}]
[task 2019-09-01T11:31:29.312Z] 11:31:29 INFO - Tab added and finished loading
[task 2019-09-01T11:31:29.313Z] 11:31:29 INFO - Opening the toolbox
[task 2019-09-01T11:31:29.313Z] 11:31:29 INFO - Buffered messages logged at 11:30:32
[task 2019-09-01T11:31:29.313Z] 11:31:29 INFO - Toolbox opened and focused
[task 2019-09-01T11:31:29.313Z] 11:31:29 INFO - Test content blocking message
[task 2019-09-01T11:31:29.313Z] 11:31:29 INFO - Clicking on the Learn More link
[task 2019-09-01T11:31:29.313Z] 11:31:29 INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_trackingprotection_errors.js | Clicking the provided link opens https://developer.mozilla.org/Firefox/Privacy/Tracking_Protection?utm_source=mozilla&utm_medium=firefox-console-errors&utm_campaign=default -
[task 2019-09-01T11:31:29.313Z] 11:31:29 INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_trackingprotection_errors.js | Clicking the provided link opens in expected tab -
[task 2019-09-01T11:31:29.313Z] 11:31:29 INFO - Leaving test bound testContentBlockingMessage
[task 2019-09-01T11:31:29.313Z] 11:31:29 INFO - Entering test bound testForeignCookieBlockedMessage
[task 2019-09-01T11:31:29.313Z] 11:31:29 INFO - Test foreign cookie blocked message
[task 2019-09-01T11:31:29.313Z] 11:31:29 INFO - Buffered messages logged at 11:30:33
[task 2019-09-01T11:31:29.314Z] 11:31:29 INFO - Adding a new tab with URL: http://example.com/browser/devtools/client/webconsole/test/browser/test-trackingprotection-securityerrors.html
[task 2019-09-01T11:31:29.314Z] 11:31:29 INFO - Console message: [JavaScript Warning: "Request to access cookie or storage on “http://tracking.example.org/browser/devtools/client/webconsole/test/browser/cookieSetter.html” was blocked because we are blocking all third-party storage access requests and content blocking is enabled." {file: "http://example.com/browser/devtools/client/webconsole/test/browser/test-trackingprotection-securityerrors.html" line: 0}]
[task 2019-09-01T11:31:29.314Z] 11:31:29 INFO - Tab added and finished loading
[task 2019-09-01T11:31:29.314Z] 11:31:29 INFO - Console message: [JavaScript Warning: "Request to access cookie or storage on “http://tracking.example.org/browser/devtools/client/webconsole/test/browser/cookieSetter.html” was blocked because we are blocking all third-party storage access requests and content blocking is enabled." {file: "http://tracking.example.org/browser/devtools/client/webconsole/test/browser/cookieSetter.html" line: 0}]
[task 2019-09-01T11:31:29.314Z] 11:31:29 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://tracking.example.org/browser/devtools/client/webconsole/test/browser/cookieSetter.html" line: 0}]
[task 2019-09-01T11:31:29.314Z] 11:31:29 INFO - Console message: [JavaScript Error: "SecurityError: Permission denied to access property "document" on cross-origin object" {file: "resource:///actors/PageStyleChild.jsm" line: 35}]
[task 2019-09-01T11:31:29.314Z] 11:31:29 INFO - Buffered messages logged at 11:30:34
[task 2019-09-01T11:31:29.314Z] 11:31:29 INFO - Clicking on the Learn More link
[task 2019-09-01T11:31:29.315Z] 11:31:29 INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_trackingprotection_errors.js | Clicking the provided link opens https://developer.mozilla.org/docs/Mozilla/Firefox/Privacy/Storage_access_policy/Errors/CookieBlockedForeign?utm_source=devtools&utm_medium=firefox-cookie-errors&utm_campaign=default -
[task 2019-09-01T11:31:29.315Z] 11:31:29 INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_trackingprotection_errors.js | Clicking the provided link opens in expected tab -
[task 2019-09-01T11:31:29.315Z] 11:31:29 INFO - Leaving test bound testForeignCookieBlockedMessage[task 2019-09-01T11:31:29.315Z] 11:31:29 INFO - Entering test bound testLimitForeignCookieBlockedMessage
[task 2019-09-01T11:31:29.315Z] 11:31:29 INFO - Test unvisited eTLD foreign cookies blocked message
[task 2019-09-01T11:31:29.315Z] 11:31:29 INFO - Buffered messages logged at 11:30:37
[task 2019-09-01T11:31:29.315Z] 11:31:29 INFO - Adding a new tab with URL: http://example.com/browser/devtools/client/webconsole/test/browser/test-trackingprotection-securityerrors.html
[task 2019-09-01T11:31:29.315Z] 11:31:29 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://tracking.example.org/browser/devtools/client/webconsole/test/browser/cookieSetter.html" line: 0}]
[task 2019-09-01T11:31:29.315Z] 11:31:29 INFO - Tab added and finished loading
[task 2019-09-01T11:31:29.316Z] 11:31:29 INFO - Buffered messages logged at 11:30:38
[task 2019-09-01T11:31:29.316Z] 11:31:29 INFO - Console message: [JavaScript Error: "SecurityError: Permission denied to access property "document" on cross-origin object" {file: "resource:///actors/PageStyleChild.jsm" line: 35}]
[task 2019-09-01T11:31:29.316Z] 11:31:29 INFO - Buffered messages logged at 11:31:16
[task 2019-09-01T11:31:29.316Z] 11:31:29 INFO - Longer timeout required, waiting longer... Remaining timeouts: 1
[task 2019-09-01T11:31:29.316Z] 11:31:29 INFO - Buffered messages finished
[task 2019-09-01T11:31:29.316Z] 11:31:29 INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_trackingprotection_errors.js | Uncaught exception - Wait for 'blocking all third-party storage access' message - timed out after 500 tries.

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 9

Platform breakdown:

• windows10-64: 7
• linux64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1578076&startday=2019-08-26&endday=2019-09-01&tree=all

Comment 2

[Natalia Csoregi [:nataliaCs]]

Result of the retriggers and backfills:
https://treeherder.mozilla.org/#/jobs?repo=autoland&searchStr=windows%2C10%2Cx64%2Copt%2Cmochitests%2Cwith%2Cfission%2Cenabled%2Ctest-windows10-64%2Fopt-mochitest-devtools-chrome-fis-e10s-2%2Cm-fis%28dt2%29&tochange=0fc21137fd5d4de89890c012d37b340539bc063a&fromchange=9057d052aceef4771b6717a4631f30cd887e3159&group_state=expanded&selectedJob=264566050

Seems to be a regression of Bug 1575364

Comment 3

[Intermittent Failures Robot]

12 failures in 4408 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 6
• try: 6

Platform breakdown:

• linux64: 7
• windows10-64: 4
• windows10-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1578076&startday=2019-09-02&endday=2019-09-08&tree=all

Comment 4

[Chris Peterson [:cpeterson]]

Tentatively moving all bugs whose summaries mention "Fission" (or other Fission-related keywords) but are not assigned to a Fission Milestone to the "?" triage milestone.

This will generate a lot of bugmail, so you can filter your bugmail for the following UUID and delete them en masse:

0ee3c76a-bc79-4eb2-8d12-05dc0b68e732

Comment 5

[Chris Peterson [:cpeterson]]

Blocks Fission mochitests milestone (M4.1)

Comment 6

[Chris Peterson [:cpeterson]]

DevTools bugs don't need to block Fission mochitests milestone (M4.1) because there is a lot of Fission DevTools work remaining. Tracking for Fission Nightly (M6).

This browser_webconsole_trackingprotection_errors.js test was disabled for Fission by bug 1535451.

https://searchfox.org/mozilla-central/rev/fca0be7e2cf2f922c9b927423ce28e8a04b3fd90/devtools/client/webconsole/test/browser/_webconsole.ini#366-367

Setting regressed-by to bug 1575364, according to comment 2.

Comment 7

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

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