1493971 - Intermittent toolkit/components/antitracking/test/browser/browser_blockingStorage.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 FIXED

(Core :: DOM: Security, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: nbeleuzu [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=201403893&repo=mozilla-inbound

https://queue.taskcluster.net/v1/task/HdxK_czxQniAAWPU8A8WeQ/runs/0/artifacts/public/logs/live_backing.log

[task 2018-09-25T12:22:45.791Z] 12:22:45     INFO - Enabling content blocking for this page
[task 2018-09-25T12:22:45.795Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | Checking cookie blocking notifications - 
[task 2018-09-25T12:22:45.797Z] 12:22:45     INFO - Removing the tab
[task 2018-09-25T12:22:45.798Z] 12:22:45     INFO - Leaving test bound 
[task 2018-09-25T12:22:45.799Z] 12:22:45     INFO - Entering test bound 
[task 2018-09-25T12:22:45.801Z] 12:22:45     INFO - Cleaning up.
[task 2018-09-25T12:22:45.802Z] 12:22:45     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.net/browser/toolkit/components/antitracking/test/browser/page.html" line: 0}]
[task 2018-09-25T12:22:45.803Z] 12:22:45     INFO - Leaving test bound 
[task 2018-09-25T12:22:45.807Z] 12:22:45     INFO - Entering test bound 
[task 2018-09-25T12:22:45.809Z] 12:22:45     INFO - Starting non-blocking cookieBehavior (0) and blocking contentBlocking and no contentBlocking UI and no contentBlocking third-party cookies UI without allow list test sessionStorage and Storage Access API running in a normal window  with iframe sandbox set to null
[task 2018-09-25T12:22:45.810Z] 12:22:45     INFO - Creating a new tab
[task 2018-09-25T12:22:45.811Z] 12:22:45     INFO - Buffered messages logged at 12:22:37
[task 2018-09-25T12:22:45.813Z] 12:22:45     INFO - Creating a 3rd party content
[task 2018-09-25T12:22:45.814Z] 12:22:45     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.net/browser/toolkit/components/antitracking/test/browser/page.html" line: 0}]
[task 2018-09-25T12:22:45.815Z] 12:22:45     INFO - Buffered messages logged at 12:22:38
[task 2018-09-25T12:22:45.816Z] 12:22:45     INFO - Sending code to the 3rd party content
[task 2018-09-25T12:22:45.817Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | Doesn't yet have storage access - true == true - 
[task 2018-09-25T12:22:45.818Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | SessionStorage is always allowed - true == true - 
[task 2018-09-25T12:22:45.819Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | Now has storage access - true == true - 
[task 2018-09-25T12:22:45.820Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | SessionStorage is allowed after calling the storage access API too - true == true - 
[task 2018-09-25T12:22:45.821Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | Checking cookie blocking notifications - 
[task 2018-09-25T12:22:45.822Z] 12:22:45     INFO - Removing the tab
[task 2018-09-25T12:22:45.823Z] 12:22:45     INFO - Leaving test bound 
[task 2018-09-25T12:22:45.824Z] 12:22:45     INFO - Entering test bound 
[task 2018-09-25T12:22:45.825Z] 12:22:45     INFO - Cleaning up.
[task 2018-09-25T12:22:45.826Z] 12:22:45     INFO - Leaving test bound 
[task 2018-09-25T12:22:45.827Z] 12:22:45     INFO - Entering test bound 
[task 2018-09-25T12:22:45.829Z] 12:22:45     INFO - Starting blocking cookieBehavior (1) and blocking contentBlocking and  contentBlocking UI and  contentBlocking third-party cookies UI with allow list test sessionStorage and Storage Access API running in a normal window  with iframe sandbox set to null
[task 2018-09-25T12:22:45.830Z] 12:22:45     INFO - Creating a new tab
[task 2018-09-25T12:22:45.831Z] 12:22:45     INFO - Buffered messages logged at 12:22:39
[task 2018-09-25T12:22:45.832Z] 12:22:45     INFO - Disabling content blocking for this page
[task 2018-09-25T12:22:45.833Z] 12:22:45     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.net/browser/toolkit/components/antitracking/test/browser/page.html" line: 0}]
[task 2018-09-25T12:22:45.834Z] 12:22:45     INFO - Buffered messages logged at 12:22:40
[task 2018-09-25T12:22:45.835Z] 12:22:45     INFO - Creating a 3rd party content
[task 2018-09-25T12:22:45.836Z] 12:22:45     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.net/browser/toolkit/components/antitracking/test/browser/page.html" line: 0}]
[task 2018-09-25T12:22:45.837Z] 12:22:45     INFO - Sending code to the 3rd party content
[task 2018-09-25T12:22:45.838Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | Doesn't yet have storage access - true == true - 
[task 2018-09-25T12:22:45.840Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | SessionStorage is always allowed - true == true - 
[task 2018-09-25T12:22:45.841Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | Now has storage access - true == true - 
[task 2018-09-25T12:22:45.842Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | SessionStorage is allowed after calling the storage access API too - true == true - 
[task 2018-09-25T12:22:45.843Z] 12:22:45     INFO - Enabling content blocking for this page
[task 2018-09-25T12:22:45.844Z] 12:22:45     INFO - Buffered messages logged at 12:22:41
[task 2018-09-25T12:22:45.845Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | Checking cookie blocking notifications - 
[task 2018-09-25T12:22:45.846Z] 12:22:45     INFO - Removing the tab
[task 2018-09-25T12:22:45.847Z] 12:22:45     INFO - Leaving test bound 
[task 2018-09-25T12:22:45.848Z] 12:22:45     INFO - Entering test bound 
[task 2018-09-25T12:22:45.849Z] 12:22:45     INFO - Cleaning up.
[task 2018-09-25T12:22:45.850Z] 12:22:45     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.net/browser/toolkit/components/antitracking/test/browser/page.html" line: 0}]
[task 2018-09-25T12:22:45.851Z] 12:22:45     INFO - Leaving test bound 
[task 2018-09-25T12:22:45.852Z] 12:22:45     INFO - Entering test bound 
[task 2018-09-25T12:22:45.853Z] 12:22:45     INFO - Starting blocking cookieBehavior (4) and blocking contentBlocking and  contentBlocking UI and  contentBlocking third-party cookies UI with allow list test sessionStorage and Storage Access API running in a normal window  with iframe sandbox set to null
[task 2018-09-25T12:22:45.854Z] 12:22:45     INFO - Creating a new tab
[task 2018-09-25T12:22:45.855Z] 12:22:45     INFO - Buffered messages logged at 12:22:42
[task 2018-09-25T12:22:45.856Z] 12:22:45     INFO - Disabling content blocking for this page
[task 2018-09-25T12:22:45.857Z] 12:22:45     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.net/browser/toolkit/components/antitracking/test/browser/page.html" line: 0}]
[task 2018-09-25T12:22:45.857Z] 12:22:45     INFO - Buffered messages logged at 12:22:43
[task 2018-09-25T12:22:45.858Z] 12:22:45     INFO - Creating a 3rd party content
[task 2018-09-25T12:22:45.859Z] 12:22:45     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.net/browser/toolkit/components/antitracking/test/browser/page.html" line: 0}]
[task 2018-09-25T12:22:45.860Z] 12:22:45     INFO - Sending code to the 3rd party content
[task 2018-09-25T12:22:45.860Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | Doesn't yet have storage access - true == true - 
[task 2018-09-25T12:22:45.861Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | SessionStorage is always allowed - true == true - 
[task 2018-09-25T12:22:45.862Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | Now has storage access - true == true - 
[task 2018-09-25T12:22:45.863Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | SessionStorage is allowed after calling the storage access API too - true == true - 
[task 2018-09-25T12:22:45.864Z] 12:22:45     INFO - Enabling content blocking for this page
[task 2018-09-25T12:22:45.864Z] 12:22:45     INFO - Buffered messages logged at 12:22:44
[task 2018-09-25T12:22:45.865Z] 12:22:45     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingStorage.js | Checking cookie blocking notifications - 
[task 2018-09-25T12:22:45.866Z] 12:22:45     INFO - Removing the tab
[task 2018-09-25T12:22:45.867Z] 12:22:45     INFO - Leaving test bound 
[task 2018-09-25T12:22:45.867Z] 12:22:45     INFO - Entering test bound 
[task 2018-09-25T12:22:45.868Z] 12:22:45     INFO - Cleaning up.
[task 2018-09-25T12:22:45.869Z] 12:22:45     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.net/browser/toolkit/components/antitracking/test/browser/page.html" line: 0}]
[task 2018-09-25T12:22:45.870Z] 12:22:45     INFO - Leaving test bound 
[task 2018-09-25T12:22:45.871Z] 12:22:45     INFO - Buffered messages finished
[task 2018-09-25T12:22:45.872Z] 12:22:45     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/antitracking/test/browser/browser_blockingStorage.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 2018-09-25T12:22:45.873Z] 12:22:45     INFO - GECKO(3627) | MEMORY STAT | vsize 659MB | residentFast 340MB | heapAllocated 82MB

Comment 1

[Intermittent Failures Robot]

17 failures in 520 pushes (0.033 failures/push) were associated with this bug yesterday.

Repository breakdown:
* mozilla-inbound: 3
* autoland: 5
* mozilla-central: 8
* try: 1

Platform breakdown:
* linux32: 12
* linux64: 2
* linux64-ccov: 2
* windows10-64-ccov: 1

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

Comment 2

[Bogdan Tara[:bogdan_tara | bogdant]]

Tried to put the finger on this.

Seems to have appeared initially on the merge to mozilla-central:
https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&searchStr=linux,debug,mochitests,with,e10s,test-linux32%2Fdebug-mochitest-browser-chrome-e10s-6,m-e10s(bc6)&selectedJob=201389024&revision=c5a9878baf35a354cb913b4f06542e233685ea9a

https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&searchStr=linux,debug,mochitests,with,e10s,test-linux32%2Fdebug-mochitest-browser-chrome-e10s-6,m-e10s(bc6)&selectedJob=201389024&revision=d03b538b6b417ba892d0a92fd693945b741246e1

From inbound and autoland:
https://treeherder.mozilla.org/#/jobs?repo=mozilla-inbound&tochange=1a3c36cf4ca771802b49a0cb7ed0d8b8c22265f9&fromchange=ee5565ca40e26806ca820afe4ba19b4350b7ceec&selectedJob=201911325

https://treeherder.mozilla.org/#/jobs?repo=autoland&searchStr=linux,debug,mochitests,with,e10s,test-linux32%2Fdebug-mochitest-browser-chrome-e10s-6,m-e10s(bc6)&fromchange=345c57d30d2d4df3bef3e90a7c5b190540e08251&selectedJob=202059488


ckerschb could you, please, point this to the appropriate person?

Comment 3

[Intermittent Failures Robot]

24 failures in 522 pushes (0.046 failures/push) were associated with this bug yesterday.

Repository breakdown:
* mozilla-central: 7
* autoland: 8
* mozilla-inbound: 6
* try: 3

Platform breakdown:
* linux32: 20
* linux64: 1
* linux64-ccov: 1
* windows10-64-ccov: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493971&startday=2018-09-27&endday=2018-09-27&tree=all

Comment 4

[Christoph Kerschbaumer [:ckerschb, back on Aug 10th}]

(In reply to Bogdan Tara[:bogdan_tara] from comment #2)
> ckerschb could you, please, point this to the appropriate person?

Ehsan, Baku, could any of you take a look at this one?

Comment 5

[(no longer active)]

Attachment: Bug 1493971 - Split browser_blockingStorage.js into browser_blockingLocalStorage.js and browser_blockingSessionStorage.js to give it more breathing room timeout-wise

Comment 6

[Intermittent Failures Robot]

19 failures in 490 pushes (0.039 failures/push) were associated with this bug yesterday.

Repository breakdown:
* try: 3
* mozilla-central: 4
* mozilla-inbound: 6
* autoland: 6

Platform breakdown:
* windows10-64-ccov: 1
* linux32: 18

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493971&startday=2018-09-28&endday=2018-09-28&tree=all

Comment 7

[Intermittent Failures Robot]

74 failures in 2773 pushes (0.027 failures/push) were associated with this bug in the last 7 days.

This is the #24 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. ** 

Repository breakdown:
* autoland: 25
* mozilla-inbound: 20
* try: 7
* mozilla-central: 22

Platform breakdown:
* linux64-ccov: 5
* linux32: 62
* windows10-64-ccov: 4
* linux64: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493971&startday=2018-09-24&endday=2018-09-30&tree=all

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-central: 1

Platform breakdown:
* windows10-64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493971&startday=2018-10-01&endday=2018-10-07&tree=all

Comment 9

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/7e925d47de47
Split browser_blockingStorage.js into browser_blockingLocalStorage.js and browser_blockingSessionStorage.js to give it more breathing room timeout-wise r=baku

Comment 10

[Raul Gurzau (:RaulG)]

https://hg.mozilla.org/mozilla-central/rev/7e925d47de47