Open Bug 1795566 Opened 2 years ago Updated 6 months ago

Intermittent toolkit/components/httpsonlyerror/tests/browser/browser_exception.js | single tracking bug

Categories

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

Product:
Core
Component:
DOM: Security
Type:
defect

Tracking

()

Status:
REOPENED

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure, intermittent-testcase, Whiteboard: [domsecurity-backlog])

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

[task 2022-10-15T22:26:43.220Z] 22:26:43     INFO - TEST-PASS | toolkit/components/httpsonlyerror/tests/browser/browser_exception.js | openInsecureButton should exist. - true == true - 
[task 2022-10-15T22:26:43.220Z] 22:26:43     INFO - Console message: [JavaScript Error: "HTTPS-Only Mode: Not upgrading insecure request “http://supports-insecure.expired.example.com/browser/toolkit/components/httpsonlyerror/tests/browser/file_upgrade_insecure_server.sjs?content” because it is exempt."]
[task 2022-10-15T22:26:43.220Z] 22:26:43     INFO - TEST-PASS | toolkit/components/httpsonlyerror/tests/browser/browser_exception.js | Page should load normally after exception button was clicked. - true == true - 
[task 2022-10-15T22:26:43.220Z] 22:26:43     INFO - Buffered messages finished
[task 2022-10-15T22:26:43.222Z] 22:26:43     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/httpsonlyerror/tests/browser/browser_exception.js | Test timed out - 
[task 2022-10-15T22:26:43.222Z] 22:26:43     INFO - GECKO(5685) | MEMORY STAT | vsize 7960MB | residentFast 353MB | heapAllocated 121MB
[task 2022-10-15T22:26:43.222Z] 22:26:43     INFO - TEST-OK | toolkit/components/httpsonlyerror/tests/browser/browser_exception.js | took 90087ms
[task 2022-10-15T22:26:43.222Z] 22:26:43     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-10-15T22:26:43.224Z] 22:26:43     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/httpsonlyerror/tests/browser/browser_exception.js | Found a tab after previous test timed out: http://supports-insecure.expired.example.com/browser/toolkit/components/httpsonlyerror/tests/browser/file_upgrade_insecure_server.sjs?content - 
[task 2022-10-15T22:26:43.224Z] 22:26:43     INFO - GECKO(5685) | [Child 5738, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:500
[task 2022-10-15T22:26:43.224Z] 22:26:43     INFO - GECKO(5685) | [Child 5715: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 111d44400 == 1 [pid = 5715] [id = 3]
[task 2022-10-15T22:26:43.227Z] 22:26:43     INFO - GECKO(5685) | [Child 5715: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (110c9bd40) [pid = 5715] [serial = 8] [outer = 0]
[task 2022-10-15T22:26:43.227Z] 22:26:43     INFO - GECKO(5685) | [Child 5715: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (111d44800) [pid = 5715] [serial = 9] [outer = 110c9bd40]
[task 2022-10-15T22:26:43.227Z] 22:26:43     INFO - GECKO(5685) | [Child 5687, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:500
[task 2022-10-15T22:26:43.227Z] 22:26:43     INFO - checking window state
[task 2022-10-15T22:26:43.227Z] 22:26:43     INFO - GECKO(5685) | [Parent 5685: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 11 (132eb8800) [pid = 5685] [serial = 16] [outer = 108521870]
[task 2022-10-15T22:26:43.227Z] 22:26:43     INFO - GECKO(5685) | [2022-10-15T22:26:43Z WARN  webrender::device::gl] Missing optimized shader source for gpu_cache_update
[task 2022-10-15T22:26:43.228Z] 22:26:43     INFO - GECKO(5685) | [Child 5687: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 10ad4fc00 == 0 [pid = 5687] [id = 2] [url = about:blank]
[task 2022-10-15T22:26:43.267Z] 22:26:43     INFO - GECKO(5685) | [Child 5714: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 11a045c00 == 0 [pid = 5714] [id = 0] [url = about:newtab]
[task 2022-10-15T22:26:43.311Z] 22:26:43     INFO - GECKO(5685) | [Child 5714: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (107b9bd40) [pid = 5714] [serial = 1] [outer = 0] [url = about:newtab]
[task 2022-10-15T22:26:43.311Z] 22:26:43     INFO - GECKO(5685) | [Child 5714: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (11a047c00) [pid = 5714] [serial = 3] [outer = 0] [url = about:newtab]
[task 2022-10-15T22:26:43.668Z] 22:26:43     INFO - GECKO(5685) | [Child 5741, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:824
[task 2022-10-15T22:26:43.671Z] 22:26:43     INFO - GECKO(5685) | [Child 5738: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 10894e800 == 0 [pid = 5738] [id = 0] [url = http://supports-insecure.expired.example.com/browser/toolkit/components/httpsonlyerror/tests/browser/file_upgrade_insecure_server.sjs?content]
[task 2022-10-15T22:26:43.680Z] 22:26:43     INFO - GECKO(5685) | [Child 5741, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3387
[task 2022-10-15T22:26:43.681Z] 22:26:43     INFO - GECKO(5685) | [Child 5741, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-10-15T22:26:43.685Z] 22:26:43     INFO - GECKO(5685) | [Child 5741, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4630
[task 2022-10-15T22:26:43.685Z] 22:26:43     INFO - GECKO(5685) | [Child 5687: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (10ad51400) [pid = 5687] [serial = 8] [outer = 0] [url = about:blank]
[task 2022-10-15T22:26:43.686Z] 22:26:43     INFO - GECKO(5685) | [Child 5687: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (10219bd40) [pid = 5687] [serial = 7] [outer = 0] [url = about:blank]
[task 2022-10-15T22:26:43.699Z] 22:26:43     INFO - GECKO(5685) | [Child 5738: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (10479bf10) [pid = 5738] [serial = 1] [outer = 0] [url = http://supports-insecure.expired.example.com/browser/toolkit/components/httpsonlyerror/tests/browser/file_upgrade_insecure_server.sjs?content]
[task 2022-10-15T22:26:43.700Z] 22:26:43     INFO - GECKO(5685) | [Child 5738, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:824
[task 2022-10-15T22:26:43.702Z] 22:26:43     INFO - GECKO(5685) | [Parent 5685, Compositor] WARNING: IPC Connection Error: [Parent][PImageBridgeParent] RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1883
[task 2022-10-15T22:26:43.702Z] 22:26:43     INFO - GECKO(5685) | [Child 5739, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:824
[task 2022-10-15T22:26:43.707Z] 22:26:43     INFO - GECKO(5685) | [Child 5740, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:824
[task 2022-10-15T22:26:43.709Z] 22:26:43     INFO - GECKO(5685) | [Child 5738: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (108950c00) [pid = 5738] [serial = 3] [outer = 0] [url = http://supports-insecure.expired.example.com/browser/toolkit/components/httpsonlyerror/tests/browser/file_upgrade_insecure_server.sjs?content]
[task 2022-10-15T22:26:43.712Z] 22:26:43     INFO - GECKO(5685) | [Child 5739, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3387
[task 2022-10-15T22:26:43.713Z] 22:26:43     INFO - GECKO(5685) | [Child 5739, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-10-15T22:26:43.714Z] 22:26:43     INFO - GECKO(5685) | [Child 5738, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3387
[task 2022-10-15T22:26:43.715Z] 22:26:43     INFO - GECKO(5685) | [Child 5738, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-10-15T22:26:43.716Z] 22:26:43     INFO - GECKO(5685) | [Child 5740, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3387
[task 2022-10-15T22:26:43.716Z] 22:26:43     INFO - GECKO(5685) | [Child 5740, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-10-15T22:26:43.718Z] 22:26:43     INFO - GECKO(5685) | [Child 5739, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4630
[task 2022-10-15T22:26:43.721Z] 22:26:43     INFO - GECKO(5685) | [Child 5738, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4630
[task 2022-10-15T22:26:43.722Z] 22:26:43     INFO - GECKO(5685) | [Child 5740, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4630
[task 2022-10-15T22:26:44.675Z] 22:26:44     INFO - GECKO(5685) | [Parent 5685: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (134c1c000) [pid = 5685] [serial = 9] [outer = 0] [url = about:blank]
[task 2022-10-15T22:26:44.852Z] 22:26:44     INFO - GECKO(5685) | Completed ShutdownLeaks collections in process 5687
[task 2022-10-15T22:26:44.856Z] 22:26:44     INFO - GECKO(5685) | Completed ShutdownLeaks collections in process 5715
[task 2022-10-15T22:26:44.916Z] 22:26:44     INFO - GECKO(5685) | Completed ShutdownLeaks collections in process 5714
[task 2022-10-15T22:26:45.064Z] 22:26:45     INFO - GECKO(5685) | [Parent 5685: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 11 (1104d7c00) [pid = 5685] [serial = 17] [outer = 108521870]
[task 2022-10-15T22:26:45.085Z] 22:26:45     INFO - GECKO(5685) | Completed ShutdownLeaks collections in process 5686
[task 2022-10-15T22:26:47.130Z] 22:26:47     INFO - GECKO(5685) | [Parent 5685: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (132eb8800) [pid = 5685] [serial = 16] [outer = 0] [url = about:blank]
[task 2022-10-15T22:26:47.510Z] 22:26:47     INFO - GECKO(5685) | Completed ShutdownLeaks collections in process 5685
[task 2022-10-15T22:26:47.510Z] 22:26:47     INFO - TEST-START | Shutdown

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

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

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=426168067&repo=autoland

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 2 years ago → 1 year ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=452351944&repo=autoland

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 1 year ago → 10 months ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=465915560&repo=autoland

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Blocks: https-only-mode
Component: Security → DOM: Security
Product: Firefox → Core
See Also: → 1775881
Whiteboard: [domsec

A very rare timeout on this test, but why? Is it our problem or the test harness not able to load the files for testing?

Whiteboard: [domsec → [domsecurity-backlog]
You need to log in before you can comment on or make changes to this bug.