Open
Bug 1945351
Opened 7 days ago
Updated 6 days ago
Intermittent 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)
Testing
Firefox UI Tests
Tracking
(Not tracked)
NEW
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: abutkovits [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=492854438&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/VN205YmdTIihN0kN4mMKAg/runs/0/artifacts/public/logs/live_backing.log
[task 2025-02-02T01:02:40.765Z] 01:02:40 INFO - 1738458160765 Marionette DEBUG 8 -> [0,34,"WebDriver:GetPageSource",{}]
[task 2025-02-02T01:02:40.799Z] 01:02:40 INFO - 1738458160798 RemoteAgent TRACE WebDriverProcessData actor created for PID 1390
[task 2025-02-02T01:02:40.815Z] 01:02:40 INFO - 1738458160815 Marionette TRACE [25] MarionetteCommands actor created for window id 40802189313
[task 2025-02-02T01:02:40.833Z] 01:02:40 INFO - 1738458160833 Marionette DEBUG 8 <- [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-02-02T01:02:40.837Z] 01:02:40 INFO - 1738458160836 Marionette DEBUG 8 -> [0,35,"Marionette:SetContext",{"value":"content"}]
[task 2025-02-02T01:02:40.838Z] 01:02:40 INFO - 1738458160838 Marionette DEBUG 8 <- [1,35,null,{"value":null}]
[task 2025-02-02T01:02:40.874Z] 01:02:40 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-02-02T01:02:40.874Z] 01:02:40 INFO - stacktrace:
[task 2025-02-02T01:02:40.874Z] 01:02:40 INFO - RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8
[task 2025-02-02T01:02:40.874Z] 01:02:40 INFO - WebDriverError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:197:5
[task 2025-02-02T01:02:40.875Z] 01:02:40 INFO - ScriptTimeoutError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:722:5
[task 2025-02-02T01:02:40.875Z] 01:02:40 INFO - evaluate.sandbox/timeoutPromise</scriptTimeoutID<@chrome://remote/content/marionette/evaluate.sys.mjs:97:11
[task 2025-02-02T01:02:40.876Z] 01:02:40 INFO - notify@resource://gre/modules/Timer.sys.mjs:49:17
[task 2025-02-02T01:02:40.877Z] 01:02:40 INFO - Traceback (most recent call last):
[task 2025-02-02T01:02:40.877Z] 01:02:40 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_harness/marionette_test/testcases.py", line 198, in run
[task 2025-02-02T01:02:40.878Z] 01:02:40 INFO - testMethod()
[task 2025-02-02T01:02:40.878Z] 01:02:40 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-02-02T01:02:40.879Z] 01:02:40 INFO - self.wait_for_page_navigated(
[task 2025-02-02T01:02:40.879Z] 01:02:40 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-02-02T01:02:40.880Z] 01:02:40 INFO - Wait(self.marionette, ignored_exceptions=[JavascriptException]).until(
[task 2025-02-02T01:02:40.880Z] 01:02:40 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/wait.py", line 130, in until
[task 2025-02-02T01:02:40.880Z] 01:02:40 INFO - rv = condition(self.marionette)
[task 2025-02-02T01:02:40.880Z] 01:02:40 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-02-02T01:02:40.881Z] 01:02:40 INFO - return self.marionette.execute_async_script(
[task 2025-02-02T01:02:40.881Z] 01:02:40 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 1929, in execute_async_script
[task 2025-02-02T01:02:40.881Z] 01:02:40 INFO - rv = self._send_message("WebDriver:ExecuteAsyncScript", body, key="value")
[task 2025-02-02T01:02:40.881Z] 01:02:40 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/decorators.py", line 24, in _
[task 2025-02-02T01:02:40.881Z] 01:02:40 INFO - return func(*args, **kwargs)
[task 2025-02-02T01:02:40.881Z] 01:02:40 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 776, in _send_message
[task 2025-02-02T01:02:40.881Z] 01:02:40 INFO - self._handle_error(err)
[task 2025-02-02T01:02:40.881Z] 01:02:40 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 788, in _handle_error
[task 2025-02-02T01:02:40.881Z] 01:02:40 INFO - raise errors.lookup(error)(message, stacktrace=stacktrace)
[task 2025-02-02T01:02:40.881Z] 01:02:40 INFO - TEST-INFO took 30986ms
[task 2025-02-02T01:02:40.881Z] 01:02:40 INFO - 1738458160842 Marionette DEBUG 8 -> [0,36,"Marionette:GetContext",{}]
[task 2025-02-02T01:02:40.882Z] 01:02:40 INFO - 1738458160843 Marionette DEBUG 8 <- [1,36,null,{"value":"content"}]
[task 2025-02-02T01:02:40.882Z] 01:02:40 INFO - 1738458160846 Marionette DEBUG 8 -> [0,37,"Marionette:SetContext",{"value":"chrome"}]
[task 2025-02-02T01:02:40.882Z] 01:02:40 INFO - 1738458160847 Marionette DEBUG 8 <- [1,37,null,{"value":null}]
[task 2025-02-02T01:02:40.882Z] 01:02:40 INFO - 1738458160856 Marionette DEBUG 8 -> [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-02-02T01:02:40.888Z] 01:02:40 INFO - 1738458160887 Marionette DEBUG 8 <- [1,38,null,{"value":null}]
[task 2025-02-02T01:02:40.891Z] 01:02:40 INFO - 1738458160890 Marionette DEBUG 8 -> [0,39,"Marionette:SetContext",{"value":"content"}]
[task 2025-02-02T01:02:40.892Z] 01:02:40 INFO - 1738458160891 Marionette DEBUG 8 <- [1,39,null,{"value":null}]
[task 2025-02-02T01:02:40.895Z] 01:02:40 INFO - 1738458160895 Marionette DEBUG 8 -> [0,40,"Marionette:GetContext",{}]
[task 2025-02-02T01:02:40.896Z] 01:02:40 INFO - 1738458160896 Marionette DEBUG 8 <- [1,40,null,{"value":"content"}]
[task 2025-02-02T01:02:40.899Z] 01:02:40 INFO - 1738458160899 Marionette DEBUG 8 -> [0,41,"Marionette:SetContext",{"value":"chrome"}]
[task 2025-02-02T01:02:40.900Z] 01:02:40 INFO - 1738458160900 Marionette DEBUG 8 <- [1,41,null,{"value":null}]
[task 2025-02-02T01:02:40.902Z] 01:02:40 INFO - 1738458160901 Marionette DEBUG 8 -> [0,42,"WebDriver:GetWindowHandles",{}]
[task 2025-02-02T01:02:40.903Z] 01:02:40 INFO - 1738458160903 Marionette DEBUG 8 <- [1,42,null,["0999a6bf-7957-4d3a-82cc-95fc7cf770c0"]]
[task 2025-02-02T01:02:40.905Z] 01:02:40 INFO - 1738458160905 Marionette DEBUG 8 -> [0,43,"Marionette:SetContext",{"value":"content"}]
[task 2025-02-02T01:02:40.905Z] 01:02:40 INFO - 1738458160905 Marionette DEBUG 8 <- [1,43,null,{"value":null}]
[task 2025-02-02T01:02:40.908Z] 01:02:40 INFO - 1738458160908 Marionette DEBUG 8 -> [0,44,"Marionette:GetContext",{}]
[task 2025-02-02T01:02:40.909Z] 01:02:40 INFO - 1738458160908 Marionette DEBUG 8 <- [1,44,null,{"value":"content"}]
[task 2025-02-02T01:02:40.911Z] 01:02:40 INFO - 1738458160911 Marionette DEBUG 8 -> [0,45,"Marionette:SetContext",{"value":"content"}]
[task 2025-02-02T01:02:40.912Z] 01:02:40 INFO - 1738458160911 Marionette DEBUG 8 <- [1,45,null,{"value":null}]
[task 2025-02-02T01:02:40.913Z] 01:02:40 INFO - 1738458160913 Marionette DEBUG 8 -> [0,46,"WebDriver:GetWindowHandles",{}]
[task 2025-02-02T01:02:40.915Z] 01:02:40 INFO - 1738458160915 Marionette DEBUG 8 <- [1,46,null,["2eac694d-c496-402a-99c4-2cbeae82adb9"]]
[task 2025-02-02T01:02:40.918Z] 01:02:40 INFO - 1738458160917 Marionette DEBUG 8 -> [0,47,"Marionette:SetContext",{"value":"content"}]
[task 2025-02-02T01:02:40.918Z] 01:02:40 INFO - 1738458160918 Marionette DEBUG 8 <- [1,47,null,{"value":null}]
[task 2025-02-02T01:02:40.920Z] 01:02:40 INFO - 1738458160920 Marionette DEBUG 8 -> [0,48,"WebDriver:DeleteSession",{}]
[task 2025-02-02T01:02:40.923Z] 01:02:40 INFO - 1738458160922 Marionette TRACE [25] MarionetteCommands actor destroyed for window id 40802189313
[task 2025-02-02T01:02:40.924Z] 01:02:40 INFO - 1738458160923 Marionette TRACE [1] MarionetteCommands actor destroyed for window id 2
[task 2025-02-02T01:02:40.924Z] 01:02:40 INFO - 1738458160923 Marionette TRACE [9] MarionetteCommands actor destroyed for window id 38654705665
[task 2025-02-02T01:02:40.933Z] 01:02:40 INFO - 1738458160932 Marionette DEBUG 8 <- [1,48,null,{"value":null}]
[task 2025-02-02T01:02:40.935Z] 01:02:40 INFO - TEST-START | testing/firefox-ui/tests/functional/security/test_ssl_status_after_restart.py TestSSLStatusAfterRestart.test_ssl_status_after_restart
Comment hidden (Intermittent Failures Robot) |
You need to log in
before you can comment on or make changes to this bug.
Description
•