Closed Bug 1958238 Opened 17 days ago Closed 17 days ago

Intermittent [tier 2] testing/firefox-ui/tests/functional/security/test_https_first.py TestHTTPSFirst.test_upgrade_with_schemeless_url | marionette_driver.errors.ScriptTimeoutException: Timed out after 30000 ms

Categories

(Testing :: Firefox UI Tests, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED DUPLICATE of bug 1945351

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2025-04-03T11:04:37.435Z] 11:04:37     INFO - TEST-START | testing/firefox-ui/tests/functional/security/test_https_first.py TestHTTPSFirst.test_upgrade_with_schemeless_url
[task 2025-04-03T11:04:37.435Z] 11:04:37     INFO -  1743678277429	Marionette	DEBUG	5 <- [1,42,null,{"value":null}]
[task 2025-04-03T11:04:37.435Z] 11:04:37     INFO -  1743678277433	Marionette	DEBUG	Closed connection 5
[task 2025-04-03T11:04:37.437Z] 11:04:37     INFO -  1743678277436	Marionette	DEBUG	Accepted connection 6 from 127.0.0.1:45058
[task 2025-04-03T11:04:37.440Z] 11:04:37     INFO -  1743678277439	Marionette	DEBUG	6 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2025-04-03T11:04:37.441Z] 11:04:37     INFO -  1743678277441	Marionette	DEBUG	Waiting for initial application window
[task 2025-04-03T11:04:37.443Z] 11:04:37     INFO -  1743678277442	RemoteAgent	TRACE	[9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=80000 waitForExplicitStart=false
[task 2025-04-03T11:04:37.443Z] 11:04:37     INFO -  1743678277443	RemoteAgent	TRACE	[9] ProgressListener Setting unload timer (80000ms)
[task 2025-04-03T11:04:37.444Z] 11:04:37     INFO -  1743678277443	RemoteAgent	TRACE	[9] Wait for initial navigation: isInitial=false, isLoadingDocument=false
[task 2025-04-03T11:04:37.444Z] 11:04:37     INFO -  1743678277443	RemoteAgent	TRACE	[9] Document already finished loading: http://example.org/
[task 2025-04-03T11:04:37.444Z] 11:04:37     INFO -  1743678277443	RemoteAgent	TRACE	[9] ProgressListener Stop: has error=false url=http://example.org/
[task 2025-04-03T11:04:37.469Z] 11:04:37     INFO -  1743678277465	Marionette	DEBUG	6 <- [1,1,null,{"sessionId":"8a5a5f02-7591-4776-88ed-d09914ef8cb9","capabilities":{"acceptInsecureCerts":false,"browserName":"firefox","browserVersion":"139.0a1","platformName":"linux","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0","moz:buildID":"20250403095150","moz:headless":false,"moz:platformVersion":"4.4.0-1014-aws","moz:processID":1325,"moz:profile":"/builds/worker/workspace/build/tmp4tsdfmef.mozrunner","moz:shutdownTimeout":180000,"pageLoadStrategy":"normal","timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"setWindowRect":true,"strictFileInteractability":true,"moz:accessibilityChecks":false,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2025-04-03T11:04:37.470Z] 11:04:37     INFO -  1743678277470	Marionette	DEBUG	6 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2025-04-03T11:04:37.474Z] 11:04:37     INFO -  1743678277473	Marionette	DEBUG	6 <- [1,2,null,{"value":null}]
[task 2025-04-03T11:04:37.476Z] 11:04:37     INFO -  1743678277475	Marionette	DEBUG	6 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2025-04-03T11:04:37.477Z] 11:04:37     INFO -  1743678277477	Marionette	DEBUG	6 <- [1,3,null,{"value":null}]
[task 2025-04-03T11:04:37.479Z] 11:04:37     INFO -  1743678277479	Marionette	DEBUG	6 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2025-04-03T11:04:37.480Z] 11:04:37     INFO -  1743678277480	Marionette	DEBUG	6 <- [1,4,null,{"value":null}]
[task 2025-04-03T11:04:37.482Z] 11:04:37     INFO -  1743678277482	Marionette	DEBUG	6 -> [0,5,"Marionette:GetContext",{}]
[task 2025-04-03T11:04:37.484Z] 11:04:37     INFO -  1743678277483	Marionette	DEBUG	6 <- [1,5,null,{"value":"content"}]
[task 2025-04-03T11:04:37.485Z] 11:04:37     INFO -  1743678277485	Marionette	DEBUG	6 -> [0,6,"Marionette:SetContext",{"value":"chrome"}]
[task 2025-04-03T11:04:37.487Z] 11:04:37     INFO -  1743678277486	Marionette	DEBUG	6 <- [1,6,null,{"value":null}]
[task 2025-04-03T11:04:37.489Z] 11:04:37     INFO -  1743678277489	Marionette	DEBUG	6 -> [0,7,"WebDriver:GetWindowHandle",{}]
[task 2025-04-03T11:04:37.490Z] 11:04:37     INFO -  1743678277490	Marionette	DEBUG	6 <- [1,7,null,{"value":"828ce112-0ea2-41f5-9ed5-4b1b507701ae"}]
[task 2025-04-03T11:04:37.497Z] 11:04:37     INFO -  1743678277494	Marionette	DEBUG	6 -> [0,8,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:04:37.497Z] 11:04:37     INFO -  1743678277495	Marionette	DEBUG	6 <- [1,8,null,{"value":null}]
[task 2025-04-03T11:04:37.505Z] 11:04:37     INFO -  1743678277505	Marionette	DEBUG	6 -> [0,9,"Marionette:GetContext",{}]
[task 2025-04-03T11:04:37.507Z] 11:04:37     INFO -  1743678277505	Marionette	DEBUG	6 <- [1,9,null,{"value":"content"}]
[task 2025-04-03T11:04:37.508Z] 11:04:37     INFO -  1743678277507	Marionette	DEBUG	6 -> [0,10,"Marionette:SetContext",{"value":"chrome"}]
[task 2025-04-03T11:04:37.508Z] 11:04:37     INFO -  1743678277508	Marionette	DEBUG	6 <- [1,10,null,{"value":null}]
[task 2025-04-03T11:04:37.510Z] 11:04:37     INFO -  1743678277508	Marionette	DEBUG	6 -> [0,11,"WebDriver:GetWindowHandles",{}]
[task 2025-04-03T11:04:37.510Z] 11:04:37     INFO -  1743678277509	Marionette	DEBUG	6 <- [1,11,null,["828ce112-0ea2-41f5-9ed5-4b1b507701ae"]]
[task 2025-04-03T11:04:37.511Z] 11:04:37     INFO -  1743678277510	Marionette	DEBUG	6 -> [0,12,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:04:37.511Z] 11:04:37     INFO -  1743678277510	Marionette	DEBUG	6 <- [1,12,null,{"value":null}]
[task 2025-04-03T11:04:37.512Z] 11:04:37     INFO -  1743678277511	Marionette	DEBUG	6 -> [0,13,"Marionette:GetContext",{}]
[task 2025-04-03T11:04:37.512Z] 11:04:37     INFO -  1743678277511	Marionette	DEBUG	6 <- [1,13,null,{"value":"content"}]
[task 2025-04-03T11:04:37.513Z] 11:04:37     INFO -  1743678277512	Marionette	DEBUG	6 -> [0,14,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:04:37.513Z] 11:04:37     INFO -  1743678277512	Marionette	DEBUG	6 <- [1,14,null,{"value":null}]
[task 2025-04-03T11:04:37.514Z] 11:04:37     INFO -  1743678277513	Marionette	DEBUG	6 -> [0,15,"WebDriver:GetWindowHandle",{}]
[task 2025-04-03T11:04:37.515Z] 11:04:37     INFO -  1743678277513	Marionette	DEBUG	6 <- [1,15,null,{"value":"0a01613d-4295-4b10-976e-e523745f7a80"}]
[task 2025-04-03T11:04:37.516Z] 11:04:37     INFO -  1743678277514	Marionette	DEBUG	6 -> [0,16,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:04:37.516Z] 11:04:37     INFO -  1743678277514	Marionette	DEBUG	6 <- [1,16,null,{"value":null}]
[task 2025-04-03T11:04:37.517Z] 11:04:37     INFO -  1743678277516	Marionette	DEBUG	6 -> [0,17,"Marionette:GetContext",{}]
[task 2025-04-03T11:04:37.517Z] 11:04:37     INFO -  1743678277516	Marionette	DEBUG	6 <- [1,17,null,{"value":"content"}]
[task 2025-04-03T11:04:37.518Z] 11:04:37     INFO -  1743678277517	Marionette	DEBUG	6 -> [0,18,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:04:37.518Z] 11:04:37     INFO -  1743678277517	Marionette	DEBUG	6 <- [1,18,null,{"value":null}]
[task 2025-04-03T11:04:37.519Z] 11:04:37     INFO -  1743678277518	Marionette	DEBUG	6 -> [0,19,"WebDriver:GetWindowHandles",{}]
[task 2025-04-03T11:04:37.519Z] 11:04:37     INFO -  1743678277518	Marionette	DEBUG	6 <- [1,19,null,["0a01613d-4295-4b10-976e-e523745f7a80"]]
[task 2025-04-03T11:04:37.520Z] 11:04:37     INFO -  1743678277519	Marionette	DEBUG	6 -> [0,20,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:04:37.521Z] 11:04:37     INFO -  1743678277519	Marionette	DEBUG	6 <- [1,20,null,{"value":null}]
[task 2025-04-03T11:04:37.522Z] 11:04:37     INFO -  1743678277520	Marionette	DEBUG	6 -> [0,21,"Marionette:GetContext",{}]
[task 2025-04-03T11:04:37.522Z] 11:04:37     INFO -  1743678277520	Marionette	DEBUG	6 <- [1,21,null,{"value":"content"}]
[task 2025-04-03T11:04:37.523Z] 11:04:37     INFO -  1743678277522	Marionette	DEBUG	6 -> [0,22,"Marionette:SetContext",{"value":"chrome"}]
[task 2025-04-03T11:04:37.523Z] 11:04:37     INFO -  1743678277522	Marionette	DEBUG	6 <- [1,22,null,{"value":null}]
[task 2025-04-03T11:04:37.524Z] 11:04:37     INFO -  1743678277523	Marionette	DEBUG	6 -> [0,23,"WebDriver:FindElement",{"value":"urlbar-input","using":"id"}]
[task 2025-04-03T11:04:37.525Z] 11:04:37     INFO -  1743678277524	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 1325
[task 2025-04-03T11:04:37.525Z] 11:04:37     INFO -  1743678277525	Marionette	TRACE	[1] MarionetteCommands actor created for window id 2
[task 2025-04-03T11:04:37.526Z] 11:04:37     INFO -  1743678277526	Marionette	DEBUG	6 <- [1,23,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6c15cbb6-c78f-472b-89bd-1da9f8c18756"}}]
[task 2025-04-03T11:04:37.527Z] 11:04:37     INFO -  1743678277527	Marionette	DEBUG	6 -> [0,24,"WebDriver:ElementClear",{"id":"6c15cbb6-c78f-472b-89bd-1da9f8c18756"}]
[task 2025-04-03T11:04:37.554Z] 11:04:37     INFO -  1743678277554	Marionette	DEBUG	6 <- [1,24,null,{"value":null}]
[task 2025-04-03T11:04:37.556Z] 11:04:37     INFO -  1743678277556	Marionette	DEBUG	6 -> [0,25,"WebDriver:ElementSendKeys",{"id":"6c15cbb6-c78f-472b-89bd-1da9f8c18756","text":"example.org"}]
[task 2025-04-03T11:04:37.651Z] 11:04:37     INFO -  1743678277650	Marionette	DEBUG	6 <- [1,25,null,{"value":null}]
[task 2025-04-03T11:04:37.789Z] 11:04:37     INFO -  1743678277784	Marionette	DEBUG	6 -> [0,26,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:04:37.789Z] 11:04:37     INFO -  1743678277785	Marionette	DEBUG	6 <- [1,26,null,{"value":null}]
[task 2025-04-03T11:04:37.831Z] 11:04:37     INFO -  1743678277830	Marionette	DEBUG	6 -> [0,27,"WebDriver:ExecuteAsyncScript",{"script":"const [url, resolve] = arguments;\n\n                if (\n                  [\"interactive\", \"complete\"].includes(document.ready ... entLoaded\", () => {\n                    resolve(window.location.href)\n                  }, { once: true });\n                }","args":["https://example.org/"],"newSandbox":true,"sandbox":"default","scriptTimeout":null,"line":63,"filename":"tests/testing/firefox-ui/tests/functional/security/test_https_first.py"}]
[task 2025-04-03T11:04:37.834Z] 11:04:37     INFO -  1743678277834	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 1863
[task 2025-04-03T11:04:37.842Z] 11:04:37     INFO -  1743678277840	Marionette	TRACE	[9] MarionetteCommands actor created for window id 38654705665
[task 2025-04-03T11:04:37.865Z] 11:04:37     INFO -  1743678277863	Marionette	TRACE	Remoteness change detected. Set new top-level browsing context to 24
[task 2025-04-03T11:04:38.503Z] 11:04:38     INFO -  [CodeCoverage] Setting handlers for process 1916.
[task 2025-04-03T11:04:38.623Z] 11:04:38     INFO -  [CodeCoverage] Setting handlers for process 1915.
[task 2025-04-03T11:04:38.829Z] 11:04:38     INFO -  [CodeCoverage] Setting handlers for process 1922.
[task 2025-04-03T11:05:07.851Z] 11:05:07     INFO -  1743678307850	Marionette	DEBUG	6 <- [1,27,{"error":"script timeout","message":"Timed out after 30000 ms","stacktrace":"RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8\nWebDriverError@chrome://remote/content/shared/webdriver/Er ... scriptTimeoutID<@chrome://remote/content/marionette/evaluate.sys.mjs:97:11\nnotify@resource://gre/modules/Timer.sys.mjs:49:17\n"},null]
[task 2025-04-03T11:05:07.853Z] 11:05:07     INFO -  1743678307852	Marionette	DEBUG	6 -> [0,28,"Marionette:GetContext",{}]
[task 2025-04-03T11:05:07.854Z] 11:05:07     INFO -  1743678307853	Marionette	DEBUG	6 <- [1,28,null,{"value":"content"}]
[task 2025-04-03T11:05:07.855Z] 11:05:07     INFO -  1743678307855	Marionette	DEBUG	6 -> [0,29,"Marionette:SetContext",{"value":"chrome"}]
[task 2025-04-03T11:05:07.856Z] 11:05:07     INFO -  1743678307855	Marionette	DEBUG	6 <- [1,29,null,{"value":null}]
[task 2025-04-03T11:05:07.857Z] 11:05:07     INFO -  1743678307857	Marionette	DEBUG	6 -> [0,30,"WebDriver:TakeScreenshot",{"id":null,"full":true,"hash":false,"scroll":true}]
[task 2025-04-03T11:05:07.909Z] 11:05:07     INFO -  1743678307908	Marionette	DEBUG	6 <- [1,30,null,{"value":"iVBORw0KGgoAAAANSUhEUgAABQAAAAQQCAYAAAC9RfbYAAAgAElEQVR4XuzdCdhkV10n/tvZExqD7CjCjAmOIAojKjqRsMg2yoABwyZKUBRENgGR4Q8IqI+AwLCIc ... TgAAAAAAQJgABAAAAIEwAAgAAAECYAAQAAACAMAEIAAAAAGECEAAAAADCBCAAAAAAhAlAAAAAAAgTgAAAAAAQJgABAAAAIOwAKab2LwHWJIAAAAAASUVORK5CYII="}]
[task 2025-04-03T11:05:07.911Z] 11:05:07     INFO -  1743678307910	Marionette	DEBUG	6 -> [0,31,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:05:07.911Z] 11:05:07     INFO -  1743678307911	Marionette	DEBUG	6 <- [1,31,null,{"value":null}]
[task 2025-04-03T11:05:07.912Z] 11:05:07     INFO -  1743678307912	Marionette	DEBUG	6 -> [0,32,"Marionette:GetContext",{}]
[task 2025-04-03T11:05:07.913Z] 11:05:07     INFO -  1743678307912	Marionette	DEBUG	6 <- [1,32,null,{"value":"content"}]
[task 2025-04-03T11:05:07.914Z] 11:05:07     INFO -  1743678307914	Marionette	DEBUG	6 -> [0,33,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:05:07.914Z] 11:05:07     INFO -  1743678307914	Marionette	DEBUG	6 <- [1,33,null,{"value":null}]
[task 2025-04-03T11:05:07.915Z] 11:05:07     INFO -  1743678307915	Marionette	DEBUG	6 -> [0,34,"WebDriver:GetPageSource",{}]
[task 2025-04-03T11:05:07.922Z] 11:05:07     INFO -  1743678307921	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 1864
[task 2025-04-03T11:05:07.925Z] 11:05:07     INFO -  1743678307925	Marionette	TRACE	[24] MarionetteCommands actor created for window id 40802189313
[task 2025-04-03T11:05:07.931Z] 11:05:07     INFO -  1743678307930	Marionette	DEBUG	6 <- [1,34,null,{"value":"<html><head>\n    <title>Example Domain</title>\n\n    <meta charset=\"utf-8\">\n    <meta http-equiv=\"Content-type\" content=\"text/ ... for permission.</p>\n    <p><a href=\"https://www.iana.org/domains/example\">More information...</a></p>\n</div>\n\n\n</body></html>"}]
[task 2025-04-03T11:05:07.932Z] 11:05:07     INFO -  1743678307931	Marionette	DEBUG	6 -> [0,35,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:05:07.932Z] 11:05:07     INFO -  1743678307932	Marionette	DEBUG	6 <- [1,35,null,{"value":null}]
[task 2025-04-03T11:05:07.954Z] 11:05:07     INFO - TEST-UNEXPECTED-ERROR | testing/firefox-ui/tests/functional/security/test_https_first.py TestHTTPSFirst.test_upgrade_with_schemeless_url | marionette_driver.errors.ScriptTimeoutException: Timed out after 30000 ms
[task 2025-04-03T11:05:07.954Z] 11:05:07     INFO - stacktrace:
[task 2025-04-03T11:05:07.954Z] 11:05:07     INFO - 	RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8
[task 2025-04-03T11:05:07.954Z] 11:05:07     INFO - 	WebDriverError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:199:5
[task 2025-04-03T11:05:07.954Z] 11:05:07     INFO - 	ScriptTimeoutError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:763:5
[task 2025-04-03T11:05:07.954Z] 11:05:07     INFO - 	evaluate.sandbox/timeoutPromise</scriptTimeoutID<@chrome://remote/content/marionette/evaluate.sys.mjs:97:11
[task 2025-04-03T11:05:07.954Z] 11:05:07     INFO - 	notify@resource://gre/modules/Timer.sys.mjs:49:17
[task 2025-04-03T11:05:07.954Z] 11:05:07     INFO - Traceback (most recent call last):
[task 2025-04-03T11:05:07.954Z] 11:05:07     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_harness/marionette_test/testcases.py", line 198, in run
[task 2025-04-03T11:05:07.954Z] 11:05:07     INFO -     testMethod()
[task 2025-04-03T11:05:07.955Z] 11:05:07     INFO -   File "/builds/worker/workspace/build/tests/firefox-ui/tests/testing/firefox-ui/tests/functional/security/test_https_first.py", line 39, in test_upgrade_with_schemeless_url
[task 2025-04-03T11:05:07.956Z] 11:05:07     INFO -     self.wait_for_page_navigated(
[task 2025-04-03T11:05:07.956Z] 11:05:07     INFO -   File "/builds/worker/workspace/build/tests/firefox-ui/tests/testing/firefox-ui/tests/functional/security/test_https_first.py", line 81, in wait_for_page_navigated
[task 2025-04-03T11:05:07.956Z] 11:05:07     INFO -     Wait(self.marionette, ignored_exceptions=[JavascriptException]).until(
[task 2025-04-03T11:05:07.956Z] 11:05:07     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/wait.py", line 130, in until
[task 2025-04-03T11:05:07.956Z] 11:05:07     INFO -     rv = condition(self.marionette)
[task 2025-04-03T11:05:07.957Z] 11:05:07     INFO -   File "/builds/worker/workspace/build/tests/firefox-ui/tests/testing/firefox-ui/tests/functional/security/test_https_first.py", line 63, in navigated
[task 2025-04-03T11:05:07.958Z] 11:05:07     INFO -     return self.marionette.execute_async_script(
[task 2025-04-03T11:05:07.958Z] 11:05:07     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 1929, in execute_async_script
[task 2025-04-03T11:05:07.958Z] 11:05:07     INFO -     rv = self._send_message("WebDriver:ExecuteAsyncScript", body, key="value")
[task 2025-04-03T11:05:07.958Z] 11:05:07     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/decorators.py", line 24, in _
[task 2025-04-03T11:05:07.958Z] 11:05:07     INFO -     return func(*args, **kwargs)
[task 2025-04-03T11:05:07.958Z] 11:05:07     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 776, in _send_message
[task 2025-04-03T11:05:07.958Z] 11:05:07     INFO -     self._handle_error(err)
[task 2025-04-03T11:05:07.958Z] 11:05:07     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 788, in _handle_error
[task 2025-04-03T11:05:07.959Z] 11:05:07     INFO -     raise errors.lookup(error)(message, stacktrace=stacktrace)
[task 2025-04-03T11:05:07.959Z] 11:05:07     INFO - TEST-INFO took 30499ms
[task 2025-04-03T11:05:07.959Z] 11:05:07     INFO -  1743678307934	Marionette	DEBUG	6 -> [0,36,"Marionette:GetContext",{}]
[task 2025-04-03T11:05:07.959Z] 11:05:07     INFO -  1743678307934	Marionette	DEBUG	6 <- [1,36,null,{"value":"content"}]
[task 2025-04-03T11:05:07.959Z] 11:05:07     INFO -  1743678307935	Marionette	DEBUG	6 -> [0,37,"Marionette:SetContext",{"value":"chrome"}]
[task 2025-04-03T11:05:07.959Z] 11:05:07     INFO -  1743678307935	Marionette	DEBUG	6 <- [1,37,null,{"value":null}]
[task 2025-04-03T11:05:07.959Z] 11:05:07     INFO -  1743678307937	Marionette	DEBUG	6 -> [0,38,"WebDriver:ExecuteScript",{"script":"Services.perms.removeAll();","args":[],"newSandbox":true,"sandbox":"default","line":33,"filename":"tests/testing/firefox-ui/tests/functional/security/test_https_first.py"}]
[task 2025-04-03T11:05:07.959Z] 11:05:07     INFO -  1743678307943	Marionette	DEBUG	6 <- [1,38,null,{"value":null}]
[task 2025-04-03T11:05:07.960Z] 11:05:07     INFO -  1743678307944	Marionette	DEBUG	6 -> [0,39,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:05:07.960Z] 11:05:07     INFO -  1743678307944	Marionette	DEBUG	6 <- [1,39,null,{"value":null}]
[task 2025-04-03T11:05:07.960Z] 11:05:07     INFO -  1743678307945	Marionette	DEBUG	6 -> [0,40,"Marionette:GetContext",{}]
[task 2025-04-03T11:05:07.960Z] 11:05:07     INFO -  1743678307946	Marionette	DEBUG	6 <- [1,40,null,{"value":"content"}]
[task 2025-04-03T11:05:07.960Z] 11:05:07     INFO -  1743678307946	Marionette	DEBUG	6 -> [0,41,"Marionette:SetContext",{"value":"chrome"}]
[task 2025-04-03T11:05:07.960Z] 11:05:07     INFO -  1743678307947	Marionette	DEBUG	6 <- [1,41,null,{"value":null}]
[task 2025-04-03T11:05:07.960Z] 11:05:07     INFO -  1743678307948	Marionette	DEBUG	6 -> [0,42,"WebDriver:GetWindowHandles",{}]
[task 2025-04-03T11:05:07.961Z] 11:05:07     INFO -  1743678307948	Marionette	DEBUG	6 <- [1,42,null,["828ce112-0ea2-41f5-9ed5-4b1b507701ae"]]
[task 2025-04-03T11:05:07.961Z] 11:05:07     INFO -  1743678307949	Marionette	DEBUG	6 -> [0,43,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:05:07.961Z] 11:05:07     INFO -  1743678307949	Marionette	DEBUG	6 <- [1,43,null,{"value":null}]
[task 2025-04-03T11:05:07.961Z] 11:05:07     INFO -  1743678307950	Marionette	DEBUG	6 -> [0,44,"Marionette:GetContext",{}]
[task 2025-04-03T11:05:07.961Z] 11:05:07     INFO -  1743678307950	Marionette	DEBUG	6 <- [1,44,null,{"value":"content"}]
[task 2025-04-03T11:05:07.962Z] 11:05:07     INFO -  1743678307951	Marionette	DEBUG	6 -> [0,45,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:05:07.962Z] 11:05:07     INFO -  1743678307951	Marionette	DEBUG	6 <- [1,45,null,{"value":null}]
[task 2025-04-03T11:05:07.962Z] 11:05:07     INFO -  1743678307952	Marionette	DEBUG	6 -> [0,46,"WebDriver:GetWindowHandles",{}]
[task 2025-04-03T11:05:07.962Z] 11:05:07     INFO -  1743678307952	Marionette	DEBUG	6 <- [1,46,null,["0a01613d-4295-4b10-976e-e523745f7a80"]]
[task 2025-04-03T11:05:07.962Z] 11:05:07     INFO -  1743678307953	Marionette	DEBUG	6 -> [0,47,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-03T11:05:07.963Z] 11:05:07     INFO -  1743678307953	Marionette	DEBUG	6 <- [1,47,null,{"value":null}]
[task 2025-04-03T11:05:07.963Z] 11:05:07     INFO -  1743678307954	Marionette	DEBUG	6 -> [0,48,"WebDriver:DeleteSession",{}]
[task 2025-04-03T11:05:07.963Z] 11:05:07     INFO -  1743678307955	Marionette	TRACE	[1] MarionetteCommands actor destroyed for window id 2
[task 2025-04-03T11:05:07.963Z] 11:05:07     INFO -  1743678307956	Marionette	TRACE	[9] MarionetteCommands actor destroyed for window id 38654705665
[task 2025-04-03T11:05:07.963Z] 11:05:07     INFO -  1743678307958	Marionette	DEBUG	6 <- [1,48,null,{"value":null}]
[task 2025-04-03T11:05:07.963Z] 11:05:07     INFO -  1743678307961	Marionette	DEBUG	Closed connection 6
[task 2025-04-03T11:05:07.963Z] 11:05:07     INFO -  1743678307961	Marionette	TRACE	[24] MarionetteCommands actor destroyed for window id 40802189313
[task 2025-04-03T11:05:07.991Z] 11:05:07     INFO - TEST-START | testing/firefox-ui/tests/functional/security/test_ssl_status_after_restart.py TestSSLStatusAfterRestart.test_ssl_status_after_restart
Status: NEW → RESOLVED
Closed: 17 days ago
Duplicate of bug: 1945351
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.