Closed Bug 1768600 Opened 3 years ago Closed 3 years ago

Intermittent toolkit/components/antitracking/test/browser/browser_blockingSessionStorage.js | Test timed out - | Found a tab after previous test timed out: http://example.net/browser/toolkit/components/antitracking/test/browser/page.html

Categories

(Core :: Privacy: Anti-Tracking, defect, P5)

Product:
Core
Component:
Privacy: Anti-Tracking
Type:
defect

Tracking

()

Status:
RESOLVED DUPLICATE of bug 1775735

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

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

[task 2022-05-10T08:06:15.719Z] 08:06:15     INFO - TEST-PASS | toolkit/components/antitracking/test/browser/browser_blockingSessionStorage.js | SessionStorage show thrown only if cookieBehavior is REJECT - true == true - 
[task 2022-05-10T08:06:15.721Z] 08:06:15     INFO - Console message: [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use “<!DOCTYPE html>”." {file: "https://tracking.example.org/browser/toolkit/components/antitracking/test/browser/3rdPartyOpenUI.html" line: 0}]
[task 2022-05-10T08:06:15.722Z] 08:06:15     INFO - Console message: [JavaScript Warning: "Request to access cookie or storage on “https://tracking.example.org/browser/toolkit/components/antitracking/test/browser/3rdPartyUI.html” was blocked because it came from a tracker and content blocking is enabled."]
[task 2022-05-10T08:06:15.722Z] 08:06:15     INFO - Buffered messages logged at 07:49:03
[task 2022-05-10T08:06:15.723Z] 08:06:15     INFO - Console message: [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use “<!DOCTYPE html>”." {file: "https://tracking.example.org/browser/toolkit/components/antitracking/test/browser/3rdParty.html" line: 0}]
[task 2022-05-10T08:06:15.724Z] 08:06:15     INFO - Buffered messages logged at 07:49:45
[task 2022-05-10T08:06:15.724Z] 08:06:15     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 11
[task 2022-05-10T08:06:15.725Z] 08:06:15     INFO - Buffered messages logged at 07:51:15
[task 2022-05-10T08:06:15.725Z] 08:06:15     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 10
[task 2022-05-10T08:06:15.726Z] 08:06:15     INFO - Buffered messages logged at 07:52:45
[task 2022-05-10T08:06:15.726Z] 08:06:15     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 9
[task 2022-05-10T08:06:15.727Z] 08:06:15     INFO - Buffered messages logged at 07:54:15
[task 2022-05-10T08:06:15.728Z] 08:06:15     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 8
[task 2022-05-10T08:06:15.728Z] 08:06:15     INFO - Buffered messages logged at 07:55:45
[task 2022-05-10T08:06:15.729Z] 08:06:15     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 7
[task 2022-05-10T08:06:15.729Z] 08:06:15     INFO - Buffered messages logged at 07:57:15
[task 2022-05-10T08:06:15.730Z] 08:06:15     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 6
[task 2022-05-10T08:06:15.730Z] 08:06:15     INFO - Buffered messages logged at 07:58:45
[task 2022-05-10T08:06:15.731Z] 08:06:15     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 5
[task 2022-05-10T08:06:15.732Z] 08:06:15     INFO - Buffered messages logged at 08:00:15
[task 2022-05-10T08:06:15.733Z] 08:06:15     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 4
[task 2022-05-10T08:06:15.733Z] 08:06:15     INFO - Buffered messages logged at 08:01:45
[task 2022-05-10T08:06:15.733Z] 08:06:15     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 3
[task 2022-05-10T08:06:15.734Z] 08:06:15     INFO - Buffered messages logged at 08:03:15
[task 2022-05-10T08:06:15.734Z] 08:06:15     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 2
[task 2022-05-10T08:06:15.735Z] 08:06:15     INFO - Buffered messages logged at 08:04:45
[task 2022-05-10T08:06:15.736Z] 08:06:15     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 1
[task 2022-05-10T08:06:15.736Z] 08:06:15     INFO - Buffered messages finished
[task 2022-05-10T08:06:15.737Z] 08:06:15     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/antitracking/test/browser/browser_blockingSessionStorage.js | Test timed out - 
[task 2022-05-10T08:06:15.740Z] 08:06:15     INFO - GECKO(1583) | MEMORY STAT | vsize 3403MB | residentFast 615MB | heapAllocated 316MB
[task 2022-05-10T08:06:15.741Z] 08:06:15     INFO - TEST-OK | toolkit/components/antitracking/test/browser/browser_blockingSessionStorage.js | took 1080162ms
[task 2022-05-10T08:06:15.741Z] 08:06:15     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-05-10T08:06:15.741Z] 08:06:15     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/antitracking/test/browser/browser_blockingSessionStorage.js | Found a tab after previous test timed out: http://example.net/browser/toolkit/components/antitracking/test/browser/page.html - 
[task 2022-05-10T08:06:15.741Z] 08:06:15     INFO - GECKO(1583) | [Child 7978: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f9ce2b36c00 == 1 [pid = 7978] [id = 0]
[task 2022-05-10T08:06:15.741Z] 08:06:15     INFO - GECKO(1583) | [Child 7978: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f9cfda959f0) [pid = 7978] [serial = 1] [outer = 0]
[task 2022-05-10T08:06:15.741Z] 08:06:15     INFO - GECKO(1583) | [Child 7978: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f9ce2b37000) [pid = 7978] [serial = 2] [outer = 7f9cfda959f0]
[task 2022-05-10T08:06:15.746Z] 08:06:15     INFO - checking window state
[task 2022-05-10T08:06:15.747Z] 08:06:15     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-05-10T08:06:15.747Z] 08:06:15     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/antitracking/test/browser/browser_blockingSessionStorage.js | Found a browser window after previous test timed out - 
[task 2022-05-10T08:06:15.748Z] 08:06:15     INFO - GECKO(1583) | must wait for focus
task 2022-05-10T08:06:15.776Z] 08:06:15     INFO - GECKO(1583) | [Parent 1583, WRRenderBackend#1] WARNING: 'lock.ref()->Remove(aTimerId)', file /builds/worker/checkouts/gecko/toolkit/components/glean/bindings/private/TimingDistribution.cpp:27
[task 2022-05-10T08:06:15.778Z] 08:06:15     INFO - GECKO(1583) | [Parent 1583, WRRenderBackend#1] WARNING: '!optStart', file /builds/worker/checkouts/gecko/toolkit/components/glean/bindings/private/TimingDistribution.cpp:40
[task 2022-05-10T08:06:15.851Z] 08:06:15     INFO - GECKO(1583) | [Parent 1583, WRRenderBackend#1] WARNING: 'lock.ref()->Remove(aTimerId)', file /builds/worker/checkouts/gecko/toolkit/components/glean/bindings/private/TimingDistribution.cpp:27
[task 2022-05-10T08:06:15.853Z] 08:06:15     INFO - GECKO(1583) | [Parent 1583, WRRenderBackend#1] WARNING: '!optStart', file /builds/worker/checkouts/gecko/toolkit/components/glean/bindings/private/TimingDistribution.cpp:40
[task 2022-05-10T08:06:15.913Z] 08:06:15     INFO - GECKO(1583) | [Parent 1583, WRRenderBackend#34] WARNING: 'lock.ref()->Remove(aTimerId)', file /builds/worker/checkouts/gecko/toolkit/components/glean/bindings/private/TimingDistribution.cpp:27
[task 2022-05-10T08:06:15.917Z] 08:06:15     INFO - GECKO(1583) | [Parent 1583, WRRenderBackend#34] WARNING: '!optStart', file /builds/worker/checkouts/gecko/toolkit/components/glean/bindings/private/TimingDistribution.cpp:40
[task 2022-05-10T08:06:16.004Z] 08:06:16     INFO - GECKO(1583) | [Child 7920: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7fd576a37000 == 0 [pid = 7920] [id = 0] [url = https://tracking.example.org/browser/toolkit/components/antitracking/test/browser/3rdPartyUI.html]
[task 2022-05-10T08:06:16.109Z] 08:06:16     INFO - GECKO(1583) | [Parent 1583, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:365
[task 2022-05-10T08:06:16.111Z] 08:06:16     INFO - GECKO(1583) | [Parent 1583, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:365
[task 2022-05-10T08:06:16.113Z] 08:06:16     INFO - GECKO(1583) | [Parent 1583, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:365
[task 2022-05-10T08:06:16.124Z] 08:06:16     INFO - GECKO(1583) | [Parent 1583: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f9fd63c5c00 == 6 [pid = 1583] [id = 66] [url = about:blank]
[task 2022-05-10T08:06:16.126Z] 08:06:16     INFO - TEST-START | toolkit/components/antitracking/test/browser/browser_contentBlockingAllowListPrincipal.js

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

Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=381197235&repo=mozilla-central

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 3 years ago → 3 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.