Intermittent [tier 2] testing/firefox-ui/tests/functional/security/test_ssl_status_after_restart.py TestSSLStatusAfterRestart.test_ssl_status_after_restart | marionette_driver.errors.UnknownException: Reached error page: about:neterror?e
Categories
(Testing :: Firefox UI Tests, defect, P5)
Tracking
(firefox-esr91 disabled, firefox98 wontfix, firefox99 disabled, firefox100 disabled, firefox108 disabled, firefox109 disabled, firefox110 fixed)
People
(Reporter: intermittent-bug-filer, Assigned: keeler)
References
Details
(Keywords: intermittent-failure, Whiteboard: [stockwell disabled])
Attachments
(2 files)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=373034366&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/elVTWZdpQmWjSyhscZjaIw/runs/0/artifacts/public/logs/live_backing.log
[task 2022-04-01T01:00:57.006Z] 01:00:57 INFO - TEST-START | testing/firefox-ui/tests/functional/security/test_ssl_status_after_restart.py TestSSLStatusAfterRestart.test_ssl_status_after_restart
[task 2022-04-01T01:00:57.007Z] 01:00:57 INFO - 1648774857007 Marionette DEBUG Accepted connection 5 from 127.0.0.1:49904
[task 2022-04-01T01:00:57.024Z] 01:00:57 INFO - 1648774857024 Marionette DEBUG 5 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2022-04-01T01:00:57.026Z] 01:00:57 INFO - 1648774857026 RemoteAgent TRACE [24] Document already finished loading: about:blank
[task 2022-04-01T01:00:57.027Z] 01:00:57 INFO - 1648774857026 Marionette DEBUG 5 <- [1,1,null,{"sessionId":"8623517b-e1f7-4fa6-9481-64407bfd0841","capabilities":{"browserName":"firefox","browserVersion":"100.0 ... e.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"proxy":{}}}]
[task 2022-04-01T01:00:57.027Z] 01:00:57 INFO - 1648774857027 Marionette DEBUG 5 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2022-04-01T01:00:57.027Z] 01:00:57 INFO - 1648774857028 Marionette DEBUG 5 <- [1,2,null,{"value":null}]
[task 2022-04-01T01:00:57.028Z] 01:00:57 INFO - 1648774857028 Marionette DEBUG 5 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2022-04-01T01:00:57.029Z] 01:00:57 INFO - 1648774857029 Marionette DEBUG 5 <- [1,3,null,{"value":null}]
[task 2022-04-01T01:00:57.029Z] 01:00:57 INFO - 1648774857029 Marionette DEBUG 5 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2022-04-01T01:00:57.029Z] 01:00:57 INFO - 1648774857030 Marionette DEBUG 5 <- [1,4,null,{"value":null}]
[task 2022-04-01T01:00:57.031Z] 01:00:57 INFO - 1648774857031 Marionette DEBUG 5 -> [0,5,"Marionette:GetContext",{}]
[task 2022-04-01T01:00:57.031Z] 01:00:57 INFO - 1648774857031 Marionette DEBUG 5 <- [1,5,null,{"value":"content"}]
[task 2022-04-01T01:00:57.031Z] 01:00:57 INFO - 1648774857032 Marionette DEBUG 5 -> [0,6,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:00:57.032Z] 01:00:57 INFO - 1648774857032 Marionette DEBUG 5 <- [1,6,null,{"value":null}]
[task 2022-04-01T01:00:57.032Z] 01:00:57 INFO - 1648774857032 Marionette DEBUG 5 -> [0,7,"WebDriver:GetWindowHandle",{}]
[task 2022-04-01T01:00:57.032Z] 01:00:57 INFO - 1648774857033 Marionette DEBUG 5 <- [1,7,null,{"value":"2c473ade-0632-40ff-8049-0e9d759ec2d6"}]
[task 2022-04-01T01:00:57.033Z] 01:00:57 INFO - 1648774857033 Marionette DEBUG 5 -> [0,8,"Marionette:SetContext",{"value":"content"}]
[task 2022-04-01T01:00:57.033Z] 01:00:57 INFO - 1648774857033 Marionette DEBUG 5 <- [1,8,null,{"value":null}]
[task 2022-04-01T01:00:57.033Z] 01:00:57 INFO - 1648774857034 Marionette DEBUG 5 -> [0,9,"Marionette:GetContext",{}]
[task 2022-04-01T01:00:57.034Z] 01:00:57 INFO - 1648774857034 Marionette DEBUG 5 <- [1,9,null,{"value":"content"}]
[task 2022-04-01T01:00:57.034Z] 01:00:57 INFO - 1648774857034 Marionette DEBUG 5 -> [0,10,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:00:57.034Z] 01:00:57 INFO - 1648774857035 Marionette DEBUG 5 <- [1,10,null,{"value":null}]
[task 2022-04-01T01:00:57.035Z] 01:00:57 INFO - 1648774857035 Marionette DEBUG 5 -> [0,11,"WebDriver:GetWindowHandles",{}]
[task 2022-04-01T01:00:57.035Z] 01:00:57 INFO - 1648774857035 Marionette DEBUG 5 <- [1,11,null,["2c473ade-0632-40ff-8049-0e9d759ec2d6"]]
[task 2022-04-01T01:00:57.036Z] 01:00:57 INFO - 1648774857036 Marionette DEBUG 5 -> [0,12,"Marionette:SetContext",{"value":"content"}]
[task 2022-04-01T01:00:57.036Z] 01:00:57 INFO - 1648774857036 Marionette DEBUG 5 <- [1,12,null,{"value":null}]
[task 2022-04-01T01:00:57.036Z] 01:00:57 INFO - 1648774857037 Marionette DEBUG 5 -> [0,13,"Marionette:GetContext",{}]
[task 2022-04-01T01:00:57.037Z] 01:00:57 INFO - 1648774857037 Marionette DEBUG 5 <- [1,13,null,{"value":"content"}]
[task 2022-04-01T01:00:57.037Z] 01:00:57 INFO - 1648774857037 Marionette DEBUG 5 -> [0,14,"Marionette:SetContext",{"value":"content"}]
[task 2022-04-01T01:00:57.037Z] 01:00:57 INFO - 1648774857038 Marionette DEBUG 5 <- [1,14,null,{"value":null}]
[task 2022-04-01T01:00:57.038Z] 01:00:57 INFO - 1648774857038 Marionette DEBUG 5 -> [0,15,"WebDriver:GetWindowHandle",{}]
[task 2022-04-01T01:00:57.038Z] 01:00:57 INFO - 1648774857038 Marionette DEBUG 5 <- [1,15,null,{"value":"71bad4f4-4b3e-4988-9ea6-a7d77b8d77fd"}]
[task 2022-04-01T01:00:57.039Z] 01:00:57 INFO - 1648774857039 Marionette DEBUG 5 -> [0,16,"Marionette:SetContext",{"value":"content"}]
[task 2022-04-01T01:00:57.039Z] 01:00:57 INFO - 1648774857039 Marionette DEBUG 5 <- [1,16,null,{"value":null}]
[task 2022-04-01T01:00:57.039Z] 01:00:57 INFO - 1648774857040 Marionette DEBUG 5 -> [0,17,"Marionette:GetContext",{}]
[task 2022-04-01T01:00:57.040Z] 01:00:57 INFO - 1648774857040 Marionette DEBUG 5 <- [1,17,null,{"value":"content"}]
[task 2022-04-01T01:00:57.041Z] 01:00:57 INFO - 1648774857041 Marionette DEBUG 5 -> [0,18,"Marionette:SetContext",{"value":"content"}]
[task 2022-04-01T01:00:57.041Z] 01:00:57 INFO - 1648774857041 Marionette DEBUG 5 <- [1,18,null,{"value":null}]
[task 2022-04-01T01:00:57.041Z] 01:00:57 INFO - 1648774857042 Marionette DEBUG 5 -> [0,19,"WebDriver:GetWindowHandles",{}]
[task 2022-04-01T01:00:57.042Z] 01:00:57 INFO - 1648774857042 Marionette DEBUG 5 <- [1,19,null,["71bad4f4-4b3e-4988-9ea6-a7d77b8d77fd"]]
[task 2022-04-01T01:00:57.042Z] 01:00:57 INFO - 1648774857042 Marionette DEBUG 5 -> [0,20,"Marionette:SetContext",{"value":"content"}]
[task 2022-04-01T01:00:57.042Z] 01:00:57 INFO - 1648774857042 Marionette DEBUG 5 <- [1,20,null,{"value":null}]
[task 2022-04-01T01:00:57.043Z] 01:00:57 INFO - 1648774857043 Marionette DEBUG 5 -> [0,21,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:00:57.043Z] 01:00:57 INFO - 1648774857043 Marionette DEBUG 5 <- [1,21,null,{"value":null}]
[task 2022-04-01T01:00:57.043Z] 01:00:57 INFO - 1648774857044 Marionette DEBUG 5 -> [0,22,"Marionette:GetContext",{}]
[task 2022-04-01T01:00:57.044Z] 01:00:57 INFO - 1648774857044 Marionette DEBUG 5 <- [1,22,null,{"value":"chrome"}]
[task 2022-04-01T01:00:57.044Z] 01:00:57 INFO - 1648774857044 Marionette DEBUG 5 -> [0,23,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:00:57.044Z] 01:00:57 INFO - 1648774857044 Marionette DEBUG 5 <- [1,23,null,{"value":null}]
[task 2022-04-01T01:00:57.046Z] 01:00:57 INFO - 1648774857046 Marionette DEBUG 5 -> [0,24,"WebDriver:ExecuteScript",{"script":"Components.utils.import(\"resource://gre/modules/Preferences.jsm\");\n\n ... efault","line":831,"filename":"Z:\\task_164876914258102\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py"}]
[task 2022-04-01T01:00:57.046Z] 01:00:57 INFO - 1648774857046 Marionette TRACE [7] MarionetteCommands actor created for window id 2
[task 2022-04-01T01:00:57.049Z] 01:00:57 INFO - 1648774857049 Marionette DEBUG 5 <- [1,24,null,{"value":null}]
[task 2022-04-01T01:00:57.050Z] 01:00:57 INFO - 1648774857050 Marionette DEBUG 5 -> [0,25,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:00:57.050Z] 01:00:57 INFO - 1648774857050 Marionette DEBUG 5 <- [1,25,null,{"value":null}]
[task 2022-04-01T01:00:57.050Z] 01:00:57 INFO - 1648774857051 Marionette DEBUG 5 -> [0,26,"Marionette:GetContext",{}]
[task 2022-04-01T01:00:57.051Z] 01:00:57 INFO - 1648774857051 Marionette DEBUG 5 <- [1,26,null,{"value":"chrome"}]
[task 2022-04-01T01:00:57.051Z] 01:00:57 INFO - 1648774857051 Marionette DEBUG 5 -> [0,27,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:00:57.051Z] 01:00:57 INFO - 1648774857052 Marionette DEBUG 5 <- [1,27,null,{"value":null}]
[task 2022-04-01T01:00:57.053Z] 01:00:57 INFO - 1648774857053 Marionette DEBUG 5 -> [0,28,"WebDriver:ExecuteScript",{"script":"Components.utils.import(\"resource://gre/modules/Preferences.jsm\");\n\n ... efault","line":831,"filename":"Z:\\task_164876914258102\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py"}]
[task 2022-04-01T01:00:57.054Z] 01:00:57 INFO - 1648774857054 Marionette DEBUG 5 <- [1,28,null,{"value":null}]
[task 2022-04-01T01:00:57.055Z] 01:00:57 INFO - 1648774857055 Marionette DEBUG 5 -> [0,29,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:00:57.055Z] 01:00:57 INFO - 1648774857055 Marionette DEBUG 5 <- [1,29,null,{"value":null}]
[task 2022-04-01T01:00:57.055Z] 01:00:57 INFO - 1648774857056 Marionette DEBUG 5 -> [0,30,"Marionette:GetContext",{}]
[task 2022-04-01T01:00:57.056Z] 01:00:57 INFO - 1648774857056 Marionette DEBUG 5 <- [1,30,null,{"value":"chrome"}]
[task 2022-04-01T01:00:57.056Z] 01:00:57 INFO - 1648774857056 Marionette DEBUG 5 -> [0,31,"Marionette:SetContext",{"value":"content"}]
[task 2022-04-01T01:00:57.056Z] 01:00:57 INFO - 1648774857056 Marionette DEBUG 5 <- [1,31,null,{"value":null}]
[task 2022-04-01T01:00:57.057Z] 01:00:57 INFO - 1648774857057 Marionette DEBUG 5 -> [0,32,"WebDriver:Navigate",{"url":"https://sha512.badssl.com/"}]
[task 2022-04-01T01:00:57.059Z] 01:00:57 INFO - 1648774857059 Marionette TRACE [24] Received event beforeunload for about:blank
[task 2022-04-01T01:01:17.700Z] 01:01:17 INFO - 1648774877700 Marionette TRACE [24] Received event beforeunload for about:blank
[task 2022-04-01T01:01:17.709Z] 01:01:17 INFO - 1648774877709 Marionette TRACE [24] Received event pagehide for about:blank
[task 2022-04-01T01:01:17.800Z] 01:01:17 INFO - 1648774877804 Marionette TRACE [24] Received event DOMContentLoaded for about:neterror?e=dnsNotFound&u=https%3A//sha512.badssl.com/&c=UTF-8&d=We%20can%E2%80%99t%20connect%20to%20the%20server%20at%20sha512.badssl.com.
[task 2022-04-01T01:01:17.805Z] 01:01:17 INFO - 1648774877805 Marionette DEBUG 5 <- [1,32,{"error":"unknown error","message":"Reached error page: about:neterror?e=dnsNotFound&u=https%3A//sha512.badssl.com/&c=U ... /EventEmitter.jsm:160:20\nreceiveMessage@chrome://remote/content/marionette/actors/MarionetteEventsParent.jsm:44:25\n"},null]
[task 2022-04-01T01:01:17.809Z] 01:01:17 INFO - 1648774877809 Marionette DEBUG 5 -> [0,33,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:01:17.809Z] 01:01:17 INFO - 1648774877809 Marionette DEBUG 5 <- [1,33,null,{"value":null}]
[task 2022-04-01T01:01:17.811Z] 01:01:17 INFO - 1648774877811 Marionette DEBUG 5 -> [0,34,"Marionette:GetContext",{}]
[task 2022-04-01T01:01:17.811Z] 01:01:17 INFO - 1648774877811 Marionette DEBUG 5 <- [1,34,null,{"value":"chrome"}]
[task 2022-04-01T01:01:17.812Z] 01:01:17 INFO - 1648774877812 Marionette DEBUG 5 -> [0,35,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:01:17.812Z] 01:01:17 INFO - 1648774877812 Marionette DEBUG 5 <- [1,35,null,{"value":null}]
[task 2022-04-01T01:01:17.813Z] 01:01:17 INFO - 1648774877813 Marionette DEBUG 5 -> [0,36,"WebDriver:TakeScreenshot",{"id":null,"full":true,"hash":false,"scroll":true}]
[task 2022-04-01T01:01:17.872Z] 01:01:17 INFO - 1648774877885 Marionette DEBUG 5 <- [1,36,null,{"value":"iVBORw0KGgoAAAANSUhEUgAABAAAAAMHCAYAAACnvyW1AAAgAElEQVR4XuzdB7gtVX0w7rkKShMxUSLSLjEGjIAgSomCJQpiwW7EHiSg ... AgQCCygAAgcvfVToAAAQIECBAgQIAAAQJhBAQAYVqtUAIECBAgQIAAAQIECBCILCAAiNx9tRMgQIAAAQIECBAgQIBAGIH/D0aYrBKIrEVuAAAAAElFTkSuQmCC"}]
[task 2022-04-01T01:01:17.888Z] 01:01:17 INFO - 1648774877888 Marionette DEBUG 5 -> [0,37,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:01:17.888Z] 01:01:17 INFO - 1648774877888 Marionette DEBUG 5 <- [1,37,null,{"value":null}]
[task 2022-04-01T01:01:17.889Z] 01:01:17 INFO - 1648774877890 Marionette DEBUG 5 -> [0,38,"Marionette:GetContext",{}]
[task 2022-04-01T01:01:17.890Z] 01:01:17 INFO - 1648774877890 Marionette DEBUG 5 <- [1,38,null,{"value":"chrome"}]
[task 2022-04-01T01:01:17.890Z] 01:01:17 INFO - 1648774877891 Marionette DEBUG 5 -> [0,39,"Marionette:SetContext",{"value":"content"}]
[task 2022-04-01T01:01:17.891Z] 01:01:17 INFO - 1648774877891 Marionette DEBUG 5 <- [1,39,null,{"value":null}]
[task 2022-04-01T01:01:17.891Z] 01:01:17 INFO - 1648774877892 Marionette DEBUG 5 -> [0,40,"WebDriver:GetPageSource",{}]
[task 2022-04-01T01:01:17.894Z] 01:01:17 INFO - 1648774877894 Marionette TRACE [24] MarionetteCommands actor created for window id 4294967298
[task 2022-04-01T01:01:17.895Z] 01:01:17 INFO - 1648774877896 Marionette DEBUG 5 <- [1,40,null,{"value":"<html xmlns=\"http://www.w3.org/1999/xhtml\" dir=\"ltr\" lang=\"en-US\">\n <head>\n <meta http-equiv ... s.js\"></script>\n <script type=\"module\" src=\"chrome://browser/content/certerror/aboutNetError.js\"></script>\n</html>"}]
[task 2022-04-01T01:01:17.896Z] 01:01:17 INFO - 1648774877896 Marionette DEBUG 5 -> [0,41,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:01:17.896Z] 01:01:17 INFO - 1648774877897 Marionette DEBUG 5 <- [1,41,null,{"value":null}]
[task 2022-04-01T01:01:17.956Z] 01:01:17 INFO - TEST-UNEXPECTED-ERROR | testing/firefox-ui/tests/functional/security/test_ssl_status_after_restart.py TestSSLStatusAfterRestart.test_ssl_status_after_restart | marionette_driver.errors.UnknownException: Reached error page: about:neterror?e=dnsNotFound&u=https%3A//sha512.badssl.com/&c=UTF-8&d=We%20can%E2%80%99t%20connect%20to%20the%20server%20at%20sha512.badssl.com.
[task 2022-04-01T01:01:17.956Z] 01:01:17 INFO - stacktrace:
[task 2022-04-01T01:01:17.956Z] 01:01:17 INFO - WebDriverError@chrome://remote/content/shared/webdriver/Errors.jsm:183:5
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - UnknownError@chrome://remote/content/shared/webdriver/Errors.jsm:510:5
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - checkReadyState@chrome://remote/content/marionette/navigate.js:64:24
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - onNavigation@chrome://remote/content/marionette/navigate.js:312:39
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - emit@resource://gre/modules/EventEmitter.jsm:160:20
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - receiveMessage@chrome://remote/content/marionette/actors/MarionetteEventsParent.jsm:44:25
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - Traceback (most recent call last):
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - File "Z:\task_164876914258102\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 202, in run
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - testMethod()
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - File "Z:\task_164876914258102\build\tests\firefox-ui\tests\testing\firefox-ui\tests\functional\security\test_ssl_status_after_restart.py", line 31, in test_ssl_status_after_restart
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - self.marionette.navigate(self.test_url)
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - File "Z:\task_164876914258102\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1551, in navigate
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - self._send_message("WebDriver:Navigate", {"url": url})
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - File "Z:\task_164876914258102\build\venv\lib\site-packages\marionette_driver\decorators.py", line 27, in _
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - return func(*args, **kwargs)
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - File "Z:\task_164876914258102\build\venv\lib\site-packages\marionette_driver\marionette.py", line 668, in _send_message
[task 2022-04-01T01:01:17.964Z] 01:01:17 INFO - self._handle_error(err)
[task 2022-04-01T01:01:17.965Z] 01:01:17 INFO - File "Z:\task_164876914258102\build\venv\lib\site-packages\marionette_driver\marionette.py", line 680, in _handle_error
[task 2022-04-01T01:01:17.965Z] 01:01:17 INFO - raise errors.lookup(error)(message, stacktrace=stacktrace)
[task 2022-04-01T01:01:17.965Z] 01:01:17 INFO - TEST-INFO took 20892ms
[task 2022-04-01T01:01:17.965Z] 01:01:17 INFO - 1648774877961 Marionette DEBUG 5 -> [0,42,"Marionette:GetContext",{}]
[task 2022-04-01T01:01:17.965Z] 01:01:17 INFO - 1648774877961 Marionette DEBUG 5 <- [1,42,null,{"value":"chrome"}]
[task 2022-04-01T01:01:17.966Z] 01:01:17 INFO - 1648774877963 Marionette DEBUG 5 -> [0,43,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:01:17.966Z] 01:01:17 INFO - 1648774877963 Marionette DEBUG 5 <- [1,43,null,{"value":null}]
[task 2022-04-01T01:01:17.966Z] 01:01:17 INFO - 1648774877965 Marionette DEBUG 5 -> [0,44,"WebDriver:ExecuteScript",{"script":"Components.utils.import(\"resource://gre/modules/Preferences.jsm\");\n ... efault","line":769,"filename":"Z:\\task_164876914258102\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py"}]
[task 2022-04-01T01:01:17.969Z] 01:01:17 INFO - 1648774877969 Marionette DEBUG 5 <- [1,44,null,{"value":null}]
[task 2022-04-01T01:01:17.970Z] 01:01:17 INFO - 1648774877970 Marionette DEBUG 5 -> [0,45,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:01:17.970Z] 01:01:17 INFO - 1648774877971 Marionette DEBUG 5 <- [1,45,null,{"value":null}]
[task 2022-04-01T01:01:17.971Z] 01:01:17 INFO - 1648774877971 Marionette DEBUG 5 -> [0,46,"Marionette:GetContext",{}]
[task 2022-04-01T01:01:17.971Z] 01:01:17 INFO - 1648774877971 Marionette DEBUG 5 <- [1,46,null,{"value":"chrome"}]
[task 2022-04-01T01:01:17.971Z] 01:01:17 INFO - 1648774877972 Marionette DEBUG 5 -> [0,47,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:01:17.972Z] 01:01:17 INFO - 1648774877972 Marionette DEBUG 5 <- [1,47,null,{"value":null}]
[task 2022-04-01T01:01:17.973Z] 01:01:17 INFO - 1648774877973 Marionette DEBUG 5 -> [0,48,"WebDriver:ExecuteScript",{"script":"Components.utils.import(\"resource://gre/modules/Preferences.jsm\");\n ... efault","line":769,"filename":"Z:\\task_164876914258102\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py"}]
[task 2022-04-01T01:01:17.975Z] 01:01:17 INFO - 1648774877975 Marionette DEBUG 5 <- [1,48,null,{"value":null}]
[task 2022-04-01T01:01:17.976Z] 01:01:17 INFO - 1648774877976 Marionette DEBUG 5 -> [0,49,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:01:17.976Z] 01:01:17 INFO - 1648774877976 Marionette DEBUG 5 <- [1,49,null,{"value":null}]
[task 2022-04-01T01:01:17.979Z] 01:01:17 INFO - 1648774877980 Marionette DEBUG 5 -> [0,50,"Marionette:GetContext",{}]
[task 2022-04-01T01:01:17.979Z] 01:01:17 INFO - 1648774877980 Marionette DEBUG 5 <- [1,50,null,{"value":"chrome"}]
[task 2022-04-01T01:01:17.980Z] 01:01:17 INFO - 1648774877981 Marionette DEBUG 5 -> [0,51,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:01:17.980Z] 01:01:17 INFO - 1648774877981 Marionette DEBUG 5 <- [1,51,null,{"value":null}]
[task 2022-04-01T01:01:17.981Z] 01:01:17 INFO - 1648774877981 Marionette DEBUG 5 -> [0,52,"WebDriver:GetWindowHandles",{}]
[task 2022-04-01T01:01:17.981Z] 01:01:17 INFO - 1648774877982 Marionette DEBUG 5 <- [1,52,null,["2c473ade-0632-40ff-8049-0e9d759ec2d6"]]
[task 2022-04-01T01:01:17.981Z] 01:01:17 INFO - 1648774877982 Marionette DEBUG 5 -> [0,53,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:01:17.982Z] 01:01:17 INFO - 1648774877982 Marionette DEBUG 5 <- [1,53,null,{"value":null}]
[task 2022-04-01T01:01:17.982Z] 01:01:17 INFO - 1648774877983 Marionette DEBUG 5 -> [0,54,"Marionette:GetContext",{}]
[task 2022-04-01T01:01:17.982Z] 01:01:17 INFO - 1648774877983 Marionette DEBUG 5 <- [1,54,null,{"value":"chrome"}]
[task 2022-04-01T01:01:17.983Z] 01:01:17 INFO - 1648774877984 Marionette DEBUG 5 -> [0,55,"Marionette:SetContext",{"value":"content"}]
[task 2022-04-01T01:01:17.983Z] 01:01:17 INFO - 1648774877984 Marionette DEBUG 5 <- [1,55,null,{"value":null}]
[task 2022-04-01T01:01:17.984Z] 01:01:17 INFO - 1648774877984 Marionette DEBUG 5 -> [0,56,"WebDriver:GetWindowHandles",{}]
[task 2022-04-01T01:01:17.984Z] 01:01:17 INFO - 1648774877985 Marionette DEBUG 5 <- [1,56,null,["71bad4f4-4b3e-4988-9ea6-a7d77b8d77fd"]]
[task 2022-04-01T01:01:17.985Z] 01:01:17 INFO - 1648774877985 Marionette DEBUG 5 -> [0,57,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-04-01T01:01:17.985Z] 01:01:17 INFO - 1648774877985 Marionette DEBUG 5 <- [1,57,null,{"value":null}]
[task 2022-04-01T01:01:17.985Z] 01:01:17 INFO - 1648774877986 Marionette DEBUG 5 -> [0,58,"WebDriver:DeleteSession",{}]
[task 2022-04-01T01:01:17.987Z] 01:01:17 INFO - 1648774877987 Marionette DEBUG 5 <- [1,58,null,{"value":null}]
[task 2022-04-01T01:01:17.988Z] 01:01:17 INFO - 1648774877988 Marionette DEBUG Closed connection 5
[task 2022-04-01T01:01:17.988Z] 01:01:17 INFO -
[task 2022-04-01T01:01:17.988Z] 01:01:17 INFO - SUMMARY
[task 2022-04-01T01:01:17.988Z] 01:01:17 INFO - -------
[task 2022-04-01T01:01:17.989Z] 01:01:17 INFO - passed: 3
[task 2022-04-01T01:01:17.989Z] 01:01:17 INFO - failed: 1
[task 2022-04-01T01:01:17.989Z] 01:01:17 INFO - todo: 0
[task 2022-04-01T01:01:17.990Z] 01:01:17 INFO -
[task 2022-04-01T01:01:17.990Z] 01:01:17 INFO - FAILED TESTS
[task 2022-04-01T01:01:17.990Z] 01:01:17 INFO - -------
[task 2022-04-01T01:01:17.990Z] 01:01:17 INFO - test_ssl_status_after_restart.py test_ssl_status_after_restart.TestSSLStatusAfterRestart.test_ssl_status_after_restart
[task 2022-04-01T01:01:17.991Z] 01:01:17 INFO - SUITE-END | took 93s
[task 2022-04-01T01:01:18.147Z] 01:01:18 INFO - 1648774878153 Marionette DEBUG Accepted connection 6 from 127.0.0.1:49905
[task 2022-04-01T01:01:18.163Z] 01:01:18 INFO - 1648774878163 Marionette DEBUG 6 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2022-04-01T01:01:18.166Z] 01:01:18 INFO - 1648774878166 RemoteAgent TRACE [24] Document already finished loading: https://sha512.badssl.com/
[task 2022-04-01T01:01:18.167Z] 01:01:18 INFO - 1648774878167 Marionette DEBUG 6 <- [1,1,null,{"sessionId":"fe7a1048-5790-411f-9025-89bb03159072","capabilities":{"browserName":"firefox","browserVersion":"100.0 ... e.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"proxy":{}}}]
[task 2022-04-01T01:01:18.167Z] 01:01:18 INFO - 1648774878168 Marionette DEBUG 6 -> [0,2,"Marionette:AcceptConnections",{"value":false}]
[task 2022-04-01T01:01:18.168Z] 01:01:18 INFO - 1648774878168 Marionette INFO Stopped listening on port 2828
[task 2022-04-01T01:01:18.168Z] 01:01:18 INFO - 1648774878168 Marionette DEBUG 6 <- [1,2,null,{"value":null}]
[task 2022-04-01T01:01:18.168Z] 01:01:18 INFO - 1648774878169 Marionette DEBUG 6 -> [0,3,"Marionette:Quit",{}]
[task 2022-04-01T01:01:18.232Z] 01:01:18 INFO - 1648774878240 Marionette TRACE Received observer notification quit-application
[task 2022-04-01T01:01:18.241Z] 01:01:18 INFO - 1648774878240 Marionette TRACE Received observer notification quit-application
[task 2022-04-01T01:01:18.241Z] 01:01:18 INFO - 1648774878241 Marionette DEBUG Marionette stopped listening
[task 2022-04-01T01:01:18.242Z] 01:01:18 INFO - 1648774878243 Marionette DEBUG 6 <- [1,3,null,{"cause":"shutdown","forced":false}]
[task 2022-04-01T01:01:18.255Z] 01:01:18 INFO - 1648774878259 Marionette DEBUG Closed connection 6
[task 2022-04-01T01:01:18.842Z] 01:01:18 ERROR - Return code: 10
[task 2022-04-01T01:01:18.843Z] 01:01:18 ERROR - Got 1 unexpected statuses
Comment 1•2 years ago
|
||
After backfills and retriggers I can't find the regression bug, can anyone take a look please?
Comment 2•2 years ago
|
||
Hello Whimboo, it looks like https://sha512.badssl.com/ has an expiring cert(Not After Fri, 01 Apr 2022) which might cause this issue. Can you please take a look?
Comment hidden (Intermittent Failures Robot) |
Comment 4•2 years ago
|
||
Checking for that domain reveals that it's not accessible anymore from a lot of places around the world. So maybe the owner of that domain did not extend their contract and as result the server was shutdown? Nevertheless it's not accessible from our CI as well and as such we should land a skip patch across all active branches. I'll come up with a patch soon.
Dana, can you please have a look if it would be ok to make this test a local one by just serving a HTTPS page via a local web server? I doubt we really need something external here. If that's the case we can move this test to a basic Marionette test.
Here is the current test:
https://searchfox.org/mozilla-central/source/testing/firefox-ui/tests/functional/security/test_ssl_status_after_restart.py
Updated•2 years ago
|
Comment 5•2 years ago
|
||
Updated•2 years ago
|
Comment 6•2 years ago
|
||
For status updates about the badssl.com outage check: https://github.com/chromium/badssl.com/issues/500
Pushed by hskupin@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/3c9cc25671e8 [firefox-ui] Disable test_ssl_status_after_restart.py because badssl.com is not reachable. r=webdriver-reviewers,jdescottes
Updated•2 years ago
|
Comment 8•2 years ago
|
||
Comment 9•2 years ago
|
||
beta is already on release so a fix for 98 is no longer needed. Setting leave-open to keep this bug open until we have a proper solution.
Assignee | ||
Comment 10•2 years ago
|
||
It looks like having a local https server instead should work fine.
Comment 11•2 years ago
|
||
(In reply to Dana Keeler (she/her) (use needinfo) (:keeler for reviews) from comment #10)
It looks like having a local https server instead should work fine.
Great. I assume it doesn't matter which kind of certificate is served as long as it's HTTPS, right? I'm sure we cannot have something else than self-signed.
Assignee | ||
Comment 12•2 years ago
|
||
It's probably best if the certificate is treated as valid by Firefox. Presumably marionette has an imported root it trusts, and presumably there are server certificates issued from that root?
Comment 13•2 years ago
|
||
hm, we use wptserve as HTTP/HTTPS server. Not sure if there is an imported root that could issue certificates.
James, would that work and if yes, what would we need? I assume at least certutil which Marionette tests should already have.
Comment 14•2 years ago
|
||
https://searchfox.org/mozilla-central/source/testing/web-platform/tests/tools/wptrunner/wptrunner/browsers/firefox.py#657-706 is what wpt does for the certificates. In that case we have some certificates for web-platform.test checked in (and these days a GH job that regenerates them regularly). https://searchfox.org/mozilla-central/source/testing/web-platform/tests/tools/certs/README.md has some documentation, and the code is in https://searchfox.org/mozilla-central/source/testing/web-platform/tests/tools/wptserve/wptserve/sslutils/openssl.py
Comment 15•2 years ago
|
||
(In reply to Henrik Skupin (:whimboo) [⌚️UTC+1] from comment #6)
For status updates about the badssl.com outage check: https://github.com/chromium/badssl.com/issues/500
The outage is fixed now but I would suggest to not re-enable it. Instead I would try to make this test local by following the suggestions from James above. If it turns out to be not that easy shall we re-enable the test as is right now? Not sure how important it is for us.
Assignee | ||
Comment 16•2 years ago
|
||
I wouldn't depend on an external website in tests (other tests tend to explicitly prohibit this, so I'm surprised this was ever allowed).
Comment hidden (Intermittent Failures Robot) |
Comment 18•2 years ago
|
||
bugherder |
Updated•2 years ago
|
Comment hidden (Intermittent Failures Robot) |
Updated•2 years ago
|
Comment 20•1 year ago
|
||
(In reply to Dana Keeler (she/her) (use needinfo) (:keeler for reviews) from comment #16)
I wouldn't depend on an external website in tests (other tests tend to explicitly prohibit this, so I'm surprised this was ever allowed).
I never actually got back to this particular bug, and also won't have the time in the near future. So how important is that test for you Dana? Should we just re-enable the test? Note that external websites can be accessed but then the test job cannot be run as Tier 1, which is the case here.
Assignee | ||
Comment 21•1 year ago
|
||
test_ssl_status_after_restart.py used to use badssl.com, which isn't a site run
by Mozilla. If that site was ever unavailable, the test would fail. This patch
updates the test to use www.itisatrap.org, which other firefox-ui tests also
use apparently without any issues.
Assignee | ||
Comment 22•1 year ago
|
||
How about something like this? Other firefox-ui tests use www.itisatrap.org
and don't seem to have a problem.
Comment 23•1 year ago
|
||
That's a great idea!
Comment 24•1 year ago
|
||
Pushed by dkeeler@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/555efa0ad1f0 use www.itisatrap.org in all firefox-ui tests r=whimboo,webdriver-reviewers
Comment 25•1 year ago
|
||
bugherder |
Updated•1 year ago
|
Description
•