Closed Bug 1831117 Opened 2 years ago Closed 2 years ago

Intermittent mozilla/tests/webdriver/bidi/browsing_context/navigate/error.py | test_insecure_certificate - ConnectionRefusedError: [Errno 111] Connection refused

Categories

(Remote Protocol :: WebDriver BiDi, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED DUPLICATE of bug 1571426

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2023-05-03T14:14:13.469Z] 14:14:13     INFO - PID 21773 | 1683123253468	Marionette	DEBUG	0 -> [0,17,"WebDriver:SwitchToFrame",{"id":null}]
[task 2023-05-03T14:14:13.509Z] 14:14:13     INFO - PID 21773 | 1683123253508	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 22502
[task 2023-05-03T14:14:13.523Z] 14:14:13     INFO - PID 21773 | 1683123253522	Marionette	TRACE	[3] MarionetteCommands actor created for window id 4294967297
[task 2023-05-03T14:14:13.551Z] 14:14:13     INFO - PID 21773 | 1683123253550	Marionette	DEBUG	0 <- [1,17,null,{"value":null}]
[task 2023-05-03T14:14:13.553Z] 14:14:13     INFO - PID 21773 | 1683123253551	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2023-05-03T14:14:13.554Z] 14:14:13     INFO - PID 21773 | 1683123253553	webdriver::server	DEBUG	-> DELETE /session/ab29fed6-b7f9-4b47-8c25-2fc4e8d29958
[task 2023-05-03T14:14:13.557Z] 14:14:13     INFO - PID 21773 | 1683123253555	Marionette	DEBUG	0 -> [0,18,"Marionette:Quit",{"flags":["eForceQuit"]}]
[task 2023-05-03T14:14:13.558Z] 14:14:13     INFO - PID 21773 | 1683123253557	Marionette	INFO	Stopped listening on port 40662
[task 2023-05-03T14:14:13.561Z] 14:14:13     INFO - PID 21773 | 1683123253560	Marionette	TRACE	[3] MarionetteCommands actor destroyed for window id 4294967297
[task 2023-05-03T14:14:13.567Z] 14:14:13     INFO - PID 21773 | 1683123253566	WebDriver BiDi	DEBUG	Unregistered session handler: /session/ab29fed6-b7f9-4b47-8c25-2fc4e8d29958
[task 2023-05-03T14:14:13.574Z] 14:14:13     INFO - PID 21773 | 1683123253574	RemoteAgent	TRACE	MessageHandler ROOT for session ab29fed6-b7f9-4b47-8c25-2fc4e8d29958 is being destroyed
[task 2023-05-03T14:14:13.576Z] 14:14:13     INFO - PID 21773 | 1683123253575	RemoteAgent	TRACE	Unregistered MessageHandler ROOT for session ab29fed6-b7f9-4b47-8c25-2fc4e8d29958
[task 2023-05-03T14:14:13.715Z] 14:14:13     INFO - PID 21773 | [Child 22528, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-05-03T14:14:13.717Z] 14:14:13     INFO - PID 21773 | [Child 22528, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-05-03T14:14:13.743Z] 14:14:13     INFO - PID 21773 | [Child 22528, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-05-03T14:14:13.747Z] 14:14:13     INFO - PID 21773 | [Child 22528, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-05-03T14:14:13.750Z] 14:14:13     INFO - PID 21773 | [Child 22528, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-05-03T14:14:13.750Z] 14:14:13     INFO - PID 21773 | [Child 22528, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-05-03T14:14:13.752Z] 14:14:13     INFO - PID 21773 | [Child 22528, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-05-03T14:14:13.850Z] 14:14:13     INFO - PID 21773 | 1683123253849	Marionette	TRACE	Received observer notification quit-application
[task 2023-05-03T14:14:13.856Z] 14:14:13     INFO - PID 21773 | 1683123253855	Marionette	TRACE	Received observer notification quit-application
[task 2023-05-03T14:14:13.858Z] 14:14:13     INFO - PID 21773 | 1683123253857	Marionette	DEBUG	Marionette stopped listening
[task 2023-05-03T14:14:13.859Z] 14:14:13     INFO - PID 21773 | 1683123253857	RemoteAgent	TRACE	Received observer notification quit-application
[task 2023-05-03T14:14:13.862Z] 14:14:13     INFO - PID 21773 | 1683123253861	Marionette	DEBUG	0 <- [1,18,null,{"cause":"shutdown","forced":false,"in_app":true}]
[task 2023-05-03T14:14:13.989Z] 14:14:13     INFO - PID 21773 | 1683123253987	RemoteAgent	DEBUG	Resetting recommended pref browser.contentblocking.features.standard
[task 2023-05-03T14:14:13.989Z] 14:14:13     INFO - PID 21773 | 1683123253988	RemoteAgent	DEBUG	Resetting recommended pref network.cookie.cookieBehavior
[task 2023-05-03T14:14:13.991Z] 14:14:13     INFO - PID 21773 | 1683123253990	webdriver::server	DEBUG	Teardown session
[task 2023-05-03T14:14:14.001Z] 14:14:14     INFO - PID 21773 | 1683123254000	Marionette	DEBUG	Closed connection 0
[task 2023-05-03T14:14:17.395Z] 14:14:17     INFO - PID 21773 | 1683123257394	geckodriver::browser	DEBUG	Browser process stopped: exit status: 0
[task 2023-05-03T14:14:17.396Z] 14:14:17     INFO - PID 21773 | 1683123257394	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2023-05-03T14:14:17.401Z] 14:14:17     INFO - STDOUT: =================================== FAILURES ===================================
[task 2023-05-03T14:14:17.401Z] 14:14:17     INFO - STDOUT: __________________________ test_insecure_certificate ___________________________
[task 2023-05-03T14:14:17.402Z] 14:14:17     INFO - STDOUT: configuration = {'capabilities': {'moz:firefoxOptions': {'args': ['--profile', '/tmp/tmpvxhloda4.mozrunner'], 'binary': '/builds/worker/workspace/build/application/firefox/firefox'}}, 'host': '127.0.0.1', 'port': 56758, 'timeout_multiplier': 3, ...}
[task 2023-05-03T14:14:17.402Z] 14:14:17     INFO - STDOUT: url = <function url.<locals>.url at 0x7f99aa707e60>
[task 2023-05-03T14:14:17.402Z] 14:14:17     INFO - STDOUT: custom_profile = <mozprofile.profile.Profile object at 0x7f99aa6cdf50>
[task 2023-05-03T14:14:17.402Z] 14:14:17     INFO - STDOUT: geckodriver = <function geckodriver.<locals>._geckodriver at 0x7f99aa9eb830>
[task 2023-05-03T14:14:17.412Z] 14:14:17     INFO - 
[task 2023-05-03T14:14:17.412Z] 14:14:17     INFO - TEST-UNEXPECTED-FAIL | /_mozilla/webdriver/bidi/browsing_context/navigate/error.py | test_insecure_certificate - ConnectionRefusedError: [Errno 111] Connection refused
[task 2023-05-03T14:14:17.412Z] 14:14:17     INFO - configuration = {'capabilities': {'moz:firefoxOptions': {'args': ['--profile', '/tmp/tmpvxhloda4.mozrunner'], 'binary': '/builds/worker/workspace/build/application/firefox/firefox'}}, 'host': '127.0.0.1', 'port': 56758, 'timeout_multiplier': 3, ...}
[task 2023-05-03T14:14:17.414Z] 14:14:17     INFO - url = <function url.<locals>.url at 0x7f99aa707e60>
[task 2023-05-03T14:14:17.414Z] 14:14:17     INFO - custom_profile = <mozprofile.profile.Profile object at 0x7f99aa6cdf50>
[task 2023-05-03T14:14:17.414Z] 14:14:17     INFO - geckodriver = <function geckodriver.<locals>._geckodriver at 0x7f99aa9eb830>
[task 2023-05-03T14:14:17.414Z] 14:14:17     INFO - 
[task 2023-05-03T14:14:17.415Z] 14:14:17     INFO -     async def test_insecure_certificate(configuration, url, custom_profile, geckodriver):
[task 2023-05-03T14:14:17.415Z] 14:14:17     INFO -         try:
[task 2023-05-03T14:14:17.415Z] 14:14:17     INFO -             # Create a new profile and remove the certificate storage so that
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -             # loading a HTTPS page will cause an insecure certificate error
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -             os.remove(os.path.join(custom_profile.profile, "cert9.db"))
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -         except Exception:
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -             pass
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -     
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -         config = deepcopy(configuration)
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -         config["capabilities"]["moz:firefoxOptions"]["args"] = [
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -             "--profile",
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -             custom_profile.profile,
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -         ]
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -         # Capability matching not implemented yet for WebDriver BiDi (bug 1713784)
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -         config["capabilities"]["acceptInsecureCerts"] = False
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -         config["capabilities"]["webSocketUrl"] = True
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -     
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -         driver = geckodriver(config=config)
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO - >       driver.new_session()
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO - 
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO - config     = {'capabilities': {'acceptInsecureCerts': False,
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -                   'moz:firefoxOptions': {'args': ['--profile',
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -                                                   '/tmp/tmpq_cun50f'],
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -                                          'binary': '/builds/worker/workspace/build/application/firefox/firefox'},
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -                   'webSocketUrl': True},
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -  'host': '127.0.0.1',
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -  'port': 56758,
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -  'timeout_multiplier': 3,
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -  'webdriver': {'args': ['-vv'], 'binary': '/builds/worker/fetches/geckodriver'}}
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO - configuration = {'capabilities': {'moz:firefoxOptions': {'args': ['--profile',
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -                                                   '/tmp/tmpvxhloda4.mozrunner'],
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -                                          'binary': '/builds/worker/workspace/build/application/firefox/firefox'}},
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -  'host': '127.0.0.1',
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -  'port': 56758,
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -  'timeout_multiplier': 3,
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO -  'webdriver': {'args': ['-vv'], 'binary': '/builds/worker/fetches/geckodriver'}}
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO - custom_profile = <mozprofile.profile.Profile object at 0x7f99aa6cdf50>
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO - driver     = <support.fixtures.Geckodriver object at 0x7f99aa6cdd50>
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO - geckodriver = <function geckodriver.<locals>._geckodriver at 0x7f99aa9eb830>
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO - url        = <function url.<locals>.url at 0x7f99aa707e60>
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO - 
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO - tests/web-platform/mozilla/tests/webdriver/bidi/browsing_context/navigate/error.py:28: 
[task 2023-05-03T14:14:17.416Z] 14:14:17     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2023-05-03T14:14:17.417Z] 14:14:17     INFO - tests/web-platform/mozilla/tests/webdriver/support/fixtures.py:253: in new_session
[task 2023-05-03T14:14:17.417Z] 14:14:17     INFO -     self.session.start()
[task 2023-05-03T14:14:17.417Z] 14:14:17     INFO -         self       = <support.fixtures.Geckodriver object at 0x7f99aa6cdd50>
[task 2023-05-03T14:14:17.417Z] 14:14:17     INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:558: in start
[task 2023-05-03T14:14:17.417Z] 14:14:17     INFO -     value = self.send_command("POST", "session", body=body)
[task 2023-05-03T14:14:17.417Z] 14:14:17     INFO -         body       = {'capabilities': {'alwaysMatch': {'acceptInsecureCerts': False,
[task 2023-05-03T14:14:17.417Z] 14:14:17     INFO -                                   'moz:firefoxOptions': {'args': ['--profile',
[task 2023-05-03T14:14:17.417Z] 14:14:17     INFO -                                                                   '/tmp/tmpq_cun50f'],
[task 2023-05-03T14:14:17.417Z] 14:14:17     INFO -                                                          'binary': '/builds/worker/workspace/build/application/firefox/firefox'},
[task 2023-05-03T14:14:17.418Z] 14:14:17     INFO -                                   'webSocketUrl': True}}}
[task 2023-05-03T14:14:17.419Z] 14:14:17     INFO -         self       = <Session (disconnected)>
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:613: in send_command
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -     session=self, timeout=timeout)
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -         body       = {'capabilities': {'alwaysMatch': {'acceptInsecureCerts': False,
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -                                   'moz:firefoxOptions': {'args': ['--profile',
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -                                                                   '/tmp/tmpq_cun50f'],
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -                                                          'binary': '/builds/worker/workspace/build/application/firefox/firefox'},
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -                                   'webSocketUrl': True}}}
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -         method     = 'POST'
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -         self       = <Session (disconnected)>
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -         timeout    = None
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -         url        = 'session'
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO - tests/web-platform/tests/tools/webdriver/webdriver/transport.py:234: in send
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -     response = self._request(method, uri, payload, headers, timeout=None)
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -         body       = {'capabilities': {'alwaysMatch': {'acceptInsecureCerts': False,
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -                                   'moz:firefoxOptions': {'args': ['--profile',
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -                                                                   '/tmp/tmpq_cun50f'],
[task 2023-05-03T14:14:17.420Z] 14:14:17     INFO -                                                          'binary': '/builds/worker/workspace/build/application/firefox/firefox'},
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -                                   'webSocketUrl': True}}}
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -         codec_kwargs = {'session': <Session (disconnected)>}
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -         decoder    = <class 'webdriver.protocol.Decoder'>
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -         encoder    = <class 'webdriver.protocol.Encoder'>
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -         headers    = None
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -         method     = 'POST'
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -         payload    = ('{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": '
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -  '["--profile", "/tmp/tmpq_cun50f"], "binary": '
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -  '"/builds/worker/workspace/build/application/firefox/firefox"}, '
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -  '"acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -         self       = <webdriver.transport.HTTPWireProtocol object at 0x7f99aa6cdd90>
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -         timeout    = None
[task 2023-05-03T14:14:17.421Z] 14:14:17     INFO -         uri        = 'session'
[task 2023-05-03T14:14:17.422Z] 14:14:17     INFO - tests/web-platform/tests/tools/webdriver/webdriver/transport.py:251: in _request
[task 2023-05-03T14:14:17.422Z] 14:14:17     INFO -     self.connection.request(method, url, payload, headers)
[task 2023-05-03T14:14:17.422Z] 14:14:17     INFO -         headers    = {'Connection': 'keep-alive'}
[task 2023-05-03T14:14:17.422Z] 14:14:17     INFO -         method     = 'POST'
[task 2023-05-03T14:14:17.422Z] 14:14:17     INFO -         payload    = (b'{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile'
[task 2023-05-03T14:14:17.422Z] 14:14:17     INFO -  b'", "/tmp/tmpq_cun50f"], "binary": "/builds/worker/workspace/build/applicatio'
[task 2023-05-03T14:14:17.422Z] 14:14:17     INFO -  b'n/firefox/firefox"}, "acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.422Z] 14:14:17     INFO -         self       = <webdriver.transport.HTTPWireProtocol object at 0x7f99aa6cdd90>
[task 2023-05-03T14:14:17.422Z] 14:14:17     INFO -         timeout    = None
[task 2023-05-03T14:14:17.422Z] 14:14:17     INFO -         uri        = 'session'
[task 2023-05-03T14:14:17.422Z] 14:14:17     INFO -         url        = '/session'
[task 2023-05-03T14:14:17.423Z] 14:14:17     INFO - /usr/lib/python3.7/http/client.py:1256: in request
[task 2023-05-03T14:14:17.423Z] 14:14:17     INFO -     self._send_request(method, url, body, headers, encode_chunked)
[task 2023-05-03T14:14:17.423Z] 14:14:17     INFO -         body       = (b'{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile'
[task 2023-05-03T14:14:17.423Z] 14:14:17     INFO -  b'", "/tmp/tmpq_cun50f"], "binary": "/builds/worker/workspace/build/applicatio'
[task 2023-05-03T14:14:17.423Z] 14:14:17     INFO -  b'n/firefox/firefox"}, "acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.423Z] 14:14:17     INFO -         encode_chunked = False
[task 2023-05-03T14:14:17.423Z] 14:14:17     INFO -         headers    = {'Connection': 'keep-alive'}
[task 2023-05-03T14:14:17.424Z] 14:14:17     INFO -         method     = 'POST'
[task 2023-05-03T14:14:17.424Z] 14:14:17     INFO -         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.424Z] 14:14:17     INFO -         url        = '/session'
[task 2023-05-03T14:14:17.424Z] 14:14:17     INFO - /usr/lib/python3.7/http/client.py:1302: in _send_request
[task 2023-05-03T14:14:17.424Z] 14:14:17     INFO -     self.endheaders(body, encode_chunked=encode_chunked)
[task 2023-05-03T14:14:17.425Z] 14:14:17     INFO -         body       = (b'{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile'
[task 2023-05-03T14:14:17.425Z] 14:14:17     INFO -  b'", "/tmp/tmpq_cun50f"], "binary": "/builds/worker/workspace/build/applicatio'
[task 2023-05-03T14:14:17.425Z] 14:14:17     INFO -  b'n/firefox/firefox"}, "acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.426Z] 14:14:17     INFO -         content_length = 226
[task 2023-05-03T14:14:17.426Z] 14:14:17     INFO -         encode_chunked = False
[task 2023-05-03T14:14:17.426Z] 14:14:17     INFO -         hdr        = 'Connection'
[task 2023-05-03T14:14:17.426Z] 14:14:17     INFO -         header_names = frozenset({'connection'})
[task 2023-05-03T14:14:17.426Z] 14:14:17     INFO -         headers    = {'Connection': 'keep-alive'}
[task 2023-05-03T14:14:17.427Z] 14:14:17     INFO -         method     = 'POST'
[task 2023-05-03T14:14:17.427Z] 14:14:17     INFO -         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.427Z] 14:14:17     INFO -         skips      = {}
[task 2023-05-03T14:14:17.427Z] 14:14:17     INFO -         url        = '/session'
[task 2023-05-03T14:14:17.428Z] 14:14:17     INFO -         value      = 'keep-alive'
[task 2023-05-03T14:14:17.428Z] 14:14:17     INFO - /usr/lib/python3.7/http/client.py:1251: in endheaders
[task 2023-05-03T14:14:17.428Z] 14:14:17     INFO -     self._send_output(message_body, encode_chunked=encode_chunked)
[task 2023-05-03T14:14:17.429Z] 14:14:17     INFO -         encode_chunked = False
[task 2023-05-03T14:14:17.429Z] 14:14:17     INFO -         message_body = (b'{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile'
[task 2023-05-03T14:14:17.429Z] 14:14:17     INFO -  b'", "/tmp/tmpq_cun50f"], "binary": "/builds/worker/workspace/build/applicatio'
[task 2023-05-03T14:14:17.429Z] 14:14:17     INFO -  b'n/firefox/firefox"}, "acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.429Z] 14:14:17     INFO -         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.429Z] 14:14:17     INFO - /usr/lib/python3.7/http/client.py:1030: in _send_output
[task 2023-05-03T14:14:17.430Z] 14:14:17     INFO -     self.send(msg)
[task 2023-05-03T14:14:17.430Z] 14:14:17     INFO -         encode_chunked = False
[task 2023-05-03T14:14:17.430Z] 14:14:17     INFO -         message_body = (b'{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile'
[task 2023-05-03T14:14:17.430Z] 14:14:17     INFO -  b'", "/tmp/tmpq_cun50f"], "binary": "/builds/worker/workspace/build/applicatio'
[task 2023-05-03T14:14:17.430Z] 14:14:17     INFO -  b'n/firefox/firefox"}, "acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.430Z] 14:14:17     INFO -         msg        = (b'POST /session HTTP/1.1\r\nHost: 127.0.0.1:56308\r\nAccept-Encoding: identity'
[task 2023-05-03T14:14:17.431Z] 14:14:17     INFO -  b'\r\nContent-Length: 226\r\nConnection: keep-alive\r\n\r\n')
[task 2023-05-03T14:14:17.431Z] 14:14:17     INFO -         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.431Z] 14:14:17     INFO - /usr/lib/python3.7/http/client.py:970: in send
[task 2023-05-03T14:14:17.431Z] 14:14:17     INFO -     self.connect()
[task 2023-05-03T14:14:17.432Z] 14:14:17     INFO -         data       = (b'POST /session HTTP/1.1\r\nHost: 127.0.0.1:56308\r\nAccept-Encoding: identity'
[task 2023-05-03T14:14:17.432Z] 14:14:17     INFO -  b'\r\nContent-Length: 226\r\nConnection: keep-alive\r\n\r\n')
[task 2023-05-03T14:14:17.433Z] 14:14:17     INFO -         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.433Z] 14:14:17     INFO - /usr/lib/python3.7/http/client.py:942: in connect
[task 2023-05-03T14:14:17.433Z] 14:14:17     INFO -     (self.host,self.port), self.timeout, self.source_address)
[task 2023-05-03T14:14:17.434Z] 14:14:17     INFO -         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.434Z] 14:14:17     INFO - /usr/lib/python3.7/socket.py:727: in create_connection
[task 2023-05-03T14:14:17.434Z] 14:14:17     INFO -     raise err
[task 2023-05-03T14:14:17.435Z] 14:14:17     INFO -         address    = ('127.0.0.1', 56308)
[task 2023-05-03T14:14:17.435Z] 14:14:17     INFO -         af         = <AddressFamily.AF_INET: 2>
[task 2023-05-03T14:14:17.436Z] 14:14:17     INFO -         canonname  = ''
[task 2023-05-03T14:14:17.437Z] 14:14:17     INFO -         err        = ConnectionRefusedError(111, 'Connection refused')
[task 2023-05-03T14:14:17.437Z] 14:14:17     INFO -         host       = '127.0.0.1'
[task 2023-05-03T14:14:17.437Z] 14:14:17     INFO -         port       = 56308
[task 2023-05-03T14:14:17.437Z] 14:14:17     INFO -         proto      = 6
[task 2023-05-03T14:14:17.438Z] 14:14:17     INFO -         res        = (<AddressFamily.AF_INET: 2>,
[task 2023-05-03T14:14:17.438Z] 14:14:17     INFO -  <SocketKind.SOCK_STREAM: 1>,
[task 2023-05-03T14:14:17.438Z] 14:14:17     INFO -  6,
[task 2023-05-03T14:14:17.438Z] 14:14:17     INFO -  '',
[task 2023-05-03T14:14:17.438Z] 14:14:17     INFO -  ('127.0.0.1', 56308))
[task 2023-05-03T14:14:17.439Z] 14:14:17     INFO -         sa         = ('127.0.0.1', 56308)
[task 2023-05-03T14:14:17.439Z] 14:14:17     INFO -         sock       = <socket.socket [closed] fd=-1, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6>
[task 2023-05-03T14:14:17.440Z] 14:14:17     INFO -         socktype   = <SocketKind.SOCK_STREAM: 1>
[task 2023-05-03T14:14:17.440Z] 14:14:17     INFO -         source_address = None
[task 2023-05-03T14:14:17.441Z] 14:14:17     INFO -         timeout    = <object object at 0x7f99bf018d60>
[task 2023-05-03T14:14:17.441Z] 14:14:17     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2023-05-03T14:14:17.441Z] 14:14:17     INFO - 
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - address = ('127.0.0.1', 56308), timeout = <object object at 0x7f99bf018d60>
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - source_address = None
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - 
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -     def create_connection(address, timeout=_GLOBAL_DEFAULT_TIMEOUT,
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -                           source_address=None):
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         """Connect to *address* and return the socket object.
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -     
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         Convenience function.  Connect to *address* (a 2-tuple ``(host,
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         port)``) and return the socket object.  Passing the optional
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         *timeout* parameter will set the timeout on the socket instance
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         before attempting to connect.  If no *timeout* is supplied, the
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         global default timeout setting returned by :func:`getdefaulttimeout`
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         is used.  If *source_address* is set it must be a tuple of (host, port)
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         for the socket to bind as a source address before making the connection.
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         A host of '' or port 0 tells the OS to use the default.
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         """
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -     
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         host, port = address
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         err = None
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -         for res in getaddrinfo(host, port, 0, SOCK_STREAM):
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -             af, socktype, proto, canonname, sa = res
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -             sock = None
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -             try:
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -                 sock = socket(af, socktype, proto)
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -                 if timeout is not _GLOBAL_DEFAULT_TIMEOUT:
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -                     sock.settimeout(timeout)
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -                 if source_address:
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -                     sock.bind(source_address)
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - >               sock.connect(sa)
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - E               ConnectionRefusedError: [Errno 111] Connection refused
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - 
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - address    = ('127.0.0.1', 56308)
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - af         = <AddressFamily.AF_INET: 2>
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - canonname  = ''
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - err        = ConnectionRefusedError(111, 'Connection refused')
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - host       = '127.0.0.1'
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - port       = 56308
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - proto      = 6
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - res        = (<AddressFamily.AF_INET: 2>,
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -  <SocketKind.SOCK_STREAM: 1>,
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -  6,
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -  '',
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO -  ('127.0.0.1', 56308))
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - sa         = ('127.0.0.1', 56308)
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - sock       = <socket.socket [closed] fd=-1, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6>
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - socktype   = <SocketKind.SOCK_STREAM: 1>
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - source_address = None
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - timeout    = <object object at 0x7f99bf018d60>
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - 
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - /usr/lib/python3.7/socket.py:716: ConnectionRefusedError
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - .
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - TEST-OK | /_mozilla/webdriver/bidi/browsing_context/navigate/error.py | took 14433ms
[task 2023-05-03T14:14:17.442Z] 14:14:17     INFO - Restarting browser for new test group
[task 2023-05-03T14:14:17.443Z] 14:14:17     INFO - PID 21773 | 1683123257405	webdriver::server	DEBUG	-> GET /status
[task 2023-05-03T14:14:17.443Z] 14:14:17     INFO - PID 21773 | 1683123257405	webdriver::server	DEBUG	<- 200 OK {"value":{"message":"","ready":true}}
[task 2023-05-03T14:14:17.499Z] 14:14:17     INFO - STDOUT:     async def test_insecure_certificate(configuration, url, custom_profile, geckodriver):
[task 2023-05-03T14:14:17.500Z] 14:14:17     INFO - STDOUT:         try:
[task 2023-05-03T14:14:17.500Z] 14:14:17     INFO - STDOUT:             # Create a new profile and remove the certificate storage so that
[task 2023-05-03T14:14:17.500Z] 14:14:17     INFO - STDOUT:             # loading a HTTPS page will cause an insecure certificate error
[task 2023-05-03T14:14:17.501Z] 14:14:17     INFO - STDOUT:             os.remove(os.path.join(custom_profile.profile, "cert9.db"))
[task 2023-05-03T14:14:17.501Z] 14:14:17     INFO - STDOUT:         except Exception:
[task 2023-05-03T14:14:17.501Z] 14:14:17     INFO - STDOUT:             pass
[task 2023-05-03T14:14:17.502Z] 14:14:17     INFO - STDOUT:     
[task 2023-05-03T14:14:17.502Z] 14:14:17     INFO - STDOUT:         config = deepcopy(configuration)
[task 2023-05-03T14:14:17.502Z] 14:14:17     INFO - STDOUT:         config["capabilities"]["moz:firefoxOptions"]["args"] = [
[task 2023-05-03T14:14:17.502Z] 14:14:17     INFO - STDOUT:             "--profile",
[task 2023-05-03T14:14:17.502Z] 14:14:17     INFO - STDOUT:             custom_profile.profile,
[task 2023-05-03T14:14:17.503Z] 14:14:17     INFO - STDOUT:         ]
[task 2023-05-03T14:14:17.503Z] 14:14:17     INFO - STDOUT:         # Capability matching not implemented yet for WebDriver BiDi (bug 1713784)
[task 2023-05-03T14:14:17.503Z] 14:14:17     INFO - STDOUT:         config["capabilities"]["acceptInsecureCerts"] = False
[task 2023-05-03T14:14:17.504Z] 14:14:17     INFO - STDOUT:         config["capabilities"]["webSocketUrl"] = True
[task 2023-05-03T14:14:17.504Z] 14:14:17     INFO - STDOUT:     
[task 2023-05-03T14:14:17.505Z] 14:14:17     INFO - STDOUT:         driver = geckodriver(config=config)
[task 2023-05-03T14:14:17.505Z] 14:14:17     INFO - STDOUT: >       driver.new_session()
[task 2023-05-03T14:14:17.506Z] 14:14:17     INFO - STDOUT: config     = {'capabilities': {'acceptInsecureCerts': False,
[task 2023-05-03T14:14:17.506Z] 14:14:17     INFO -                   'moz:firefoxOptions': {'args': ['--profile',
[task 2023-05-03T14:14:17.506Z] 14:14:17     INFO -                                                   '/tmp/tmpq_cun50f'],
[task 2023-05-03T14:14:17.506Z] 14:14:17     INFO -                                          'binary': '/builds/worker/workspace/build/application/firefox/firefox'},
[task 2023-05-03T14:14:17.506Z] 14:14:17     INFO -                   'webSocketUrl': True},
[task 2023-05-03T14:14:17.506Z] 14:14:17     INFO -  'host': '127.0.0.1',
[task 2023-05-03T14:14:17.506Z] 14:14:17     INFO -  'port': 56758,
[task 2023-05-03T14:14:17.506Z] 14:14:17     INFO -  'timeout_multiplier': 3,
[task 2023-05-03T14:14:17.507Z] 14:14:17     INFO -  'webdriver': {'args': ['-vv'], 'binary': '/builds/worker/fetches/geckodriver'}}
[task 2023-05-03T14:14:17.507Z] 14:14:17     INFO - STDOUT: configuration = {'capabilities': {'moz:firefoxOptions': {'args': ['--profile',
[task 2023-05-03T14:14:17.507Z] 14:14:17     INFO -                                                   '/tmp/tmpvxhloda4.mozrunner'],
[task 2023-05-03T14:14:17.507Z] 14:14:17     INFO -                                          'binary': '/builds/worker/workspace/build/application/firefox/firefox'}},
[task 2023-05-03T14:14:17.508Z] 14:14:17     INFO -  'host': '127.0.0.1',
[task 2023-05-03T14:14:17.508Z] 14:14:17     INFO -  'port': 56758,
[task 2023-05-03T14:14:17.508Z] 14:14:17     INFO -  'timeout_multiplier': 3,
[task 2023-05-03T14:14:17.508Z] 14:14:17     INFO -  'webdriver': {'args': ['-vv'], 'binary': '/builds/worker/fetches/geckodriver'}}
[task 2023-05-03T14:14:17.508Z] 14:14:17     INFO - STDOUT: custom_profile = <mozprofile.profile.Profile object at 0x7f99aa6cdf50>
[task 2023-05-03T14:14:17.509Z] 14:14:17     INFO - STDOUT: driver     = <support.fixtures.Geckodriver object at 0x7f99aa6cdd50>
[task 2023-05-03T14:14:17.509Z] 14:14:17     INFO - STDOUT: geckodriver = <function geckodriver.<locals>._geckodriver at 0x7f99aa9eb830>
[task 2023-05-03T14:14:17.510Z] 14:14:17     INFO - STDOUT: url        = <function url.<locals>.url at 0x7f99aa707e60>
[task 2023-05-03T14:14:17.510Z] 14:14:17     INFO - STDOUT: tests/web-platform/mozilla/tests/webdriver/bidi/browsing_context/navigate/error.py
[task 2023-05-03T14:14:17.511Z] 14:14:17     INFO - STDOUT: :28: 
[task 2023-05-03T14:14:17.511Z] 14:14:17     INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2023-05-03T14:14:17.512Z] 14:14:17     INFO - STDOUT: tests/web-platform/mozilla/tests/webdriver/support/fixtures.py
[task 2023-05-03T14:14:17.512Z] 14:14:17     INFO - STDOUT: :253: in new_session
[task 2023-05-03T14:14:17.512Z] 14:14:17     INFO - STDOUT:     self.session.start()
[task 2023-05-03T14:14:17.513Z] 14:14:17     INFO - STDOUT:         self       = <support.fixtures.Geckodriver object at 0x7f99aa6cdd50>
[task 2023-05-03T14:14:17.513Z] 14:14:17     INFO - STDOUT: tests/web-platform/tests/tools/webdriver/webdriver/client.py
[task 2023-05-03T14:14:17.514Z] 14:14:17     INFO - STDOUT: :558: in start
[task 2023-05-03T14:14:17.514Z] 14:14:17     INFO - STDOUT:     value = self.send_command("POST", "session", body=body)
[task 2023-05-03T14:14:17.515Z] 14:14:17     INFO - STDOUT:         body       = {'capabilities': {'alwaysMatch': {'acceptInsecureCerts': False,
[task 2023-05-03T14:14:17.515Z] 14:14:17     INFO -                                   'moz:firefoxOptions': {'args': ['--profile',
[task 2023-05-03T14:14:17.515Z] 14:14:17     INFO -                                                                   '/tmp/tmpq_cun50f'],
[task 2023-05-03T14:14:17.516Z] 14:14:17     INFO -                                                          'binary': '/builds/worker/workspace/build/application/firefox/firefox'},
[task 2023-05-03T14:14:17.516Z] 14:14:17     INFO -                                   'webSocketUrl': True}}}
[task 2023-05-03T14:14:17.516Z] 14:14:17     INFO - STDOUT:         self       = <Session (disconnected)>
[task 2023-05-03T14:14:17.517Z] 14:14:17     INFO - STDOUT: tests/web-platform/tests/tools/webdriver/webdriver/client.py
[task 2023-05-03T14:14:17.517Z] 14:14:17     INFO - STDOUT: :613: in send_command
[task 2023-05-03T14:14:17.518Z] 14:14:17     INFO - STDOUT:     session=self, timeout=timeout)
[task 2023-05-03T14:14:17.520Z] 14:14:17     INFO - STDOUT:         body       = {'capabilities': {'alwaysMatch': {'acceptInsecureCerts': False,
[task 2023-05-03T14:14:17.520Z] 14:14:17     INFO -                                   'moz:firefoxOptions': {'args': ['--profile',
[task 2023-05-03T14:14:17.520Z] 14:14:17     INFO -                                                                   '/tmp/tmpq_cun50f'],
[task 2023-05-03T14:14:17.520Z] 14:14:17     INFO -                                                          'binary': '/builds/worker/workspace/build/application/firefox/firefox'},
[task 2023-05-03T14:14:17.520Z] 14:14:17     INFO -                                   'webSocketUrl': True}}}
[task 2023-05-03T14:14:17.520Z] 14:14:17     INFO - STDOUT:         method     = 'POST'
[task 2023-05-03T14:14:17.520Z] 14:14:17     INFO - STDOUT:         self       = <Session (disconnected)>
[task 2023-05-03T14:14:17.520Z] 14:14:17     INFO - Closing logging queue
[task 2023-05-03T14:14:17.521Z] 14:14:17     INFO - STDOUT:         timeout    = None
[task 2023-05-03T14:14:17.521Z] 14:14:17     INFO - STDOUT:         url        = 'session'
[task 2023-05-03T14:14:17.521Z] 14:14:17     INFO - STDOUT: tests/web-platform/tests/tools/webdriver/webdriver/transport.py
[task 2023-05-03T14:14:17.522Z] 14:14:17     INFO - STDOUT: :234: in send
[task 2023-05-03T14:14:17.522Z] 14:14:17     INFO - STDOUT:     response = self._request(method, uri, payload, headers, timeout=None)
[task 2023-05-03T14:14:17.523Z] 14:14:17     INFO - STDOUT:         body       = {'capabilities': {'alwaysMatch': {'acceptInsecureCerts': False,
[task 2023-05-03T14:14:17.523Z] 14:14:17     INFO -                                   'moz:firefoxOptions': {'args': ['--profile',
[task 2023-05-03T14:14:17.523Z] 14:14:17     INFO -                                                                   '/tmp/tmpq_cun50f'],
[task 2023-05-03T14:14:17.524Z] 14:14:17     INFO -                                                          'binary': '/builds/worker/workspace/build/application/firefox/firefox'},
[task 2023-05-03T14:14:17.524Z] 14:14:17     INFO -                                   'webSocketUrl': True}}}
[task 2023-05-03T14:14:17.524Z] 14:14:17     INFO - STDOUT:         codec_kwargs = {'session': <Session (disconnected)>}
[task 2023-05-03T14:14:17.524Z] 14:14:17     INFO - STDOUT:         decoder    = <class 'webdriver.protocol.Decoder'>
[task 2023-05-03T14:14:17.525Z] 14:14:17     INFO - STDOUT:         encoder    = <class 'webdriver.protocol.Encoder'>
[task 2023-05-03T14:14:17.525Z] 14:14:17     INFO - STDOUT:         headers    = None
[task 2023-05-03T14:14:17.526Z] 14:14:17     INFO - STDOUT:         method     = 'POST'
[task 2023-05-03T14:14:17.527Z] 14:14:17     INFO - STDOUT:         payload    = ('{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": '
[task 2023-05-03T14:14:17.527Z] 14:14:17     INFO -  '["--profile", "/tmp/tmpq_cun50f"], "binary": '
[task 2023-05-03T14:14:17.527Z] 14:14:17     INFO -  '"/builds/worker/workspace/build/application/firefox/firefox"}, '
[task 2023-05-03T14:14:17.527Z] 14:14:17     INFO -  '"acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.527Z] 14:14:17     INFO - STDOUT:         self       = <webdriver.transport.HTTPWireProtocol object at 0x7f99aa6cdd90>
[task 2023-05-03T14:14:17.528Z] 14:14:17     INFO - STDOUT:         timeout    = None
[task 2023-05-03T14:14:17.528Z] 14:14:17     INFO - STDOUT:         uri        = 'session'
[task 2023-05-03T14:14:17.528Z] 14:14:17     INFO - STDOUT: tests/web-platform/tests/tools/webdriver/webdriver/transport.py
[task 2023-05-03T14:14:17.529Z] 14:14:17     INFO - STDOUT: :251: in _request
[task 2023-05-03T14:14:17.529Z] 14:14:17     INFO - STDOUT:     self.connection.request(method, url, payload, headers)
[task 2023-05-03T14:14:17.534Z] 14:14:17     INFO - STDOUT:         headers    = {'Connection': 'keep-alive'}
[task 2023-05-03T14:14:17.535Z] 14:14:17     INFO - STDOUT:         method     = 'POST'
[task 2023-05-03T14:14:17.535Z] 14:14:17     INFO - STDOUT:         payload    = (b'{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile'
[task 2023-05-03T14:14:17.536Z] 14:14:17     INFO -  b'", "/tmp/tmpq_cun50f"], "binary": "/builds/worker/workspace/build/applicatio'
[task 2023-05-03T14:14:17.536Z] 14:14:17     INFO -  b'n/firefox/firefox"}, "acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.536Z] 14:14:17     INFO - STDOUT:         self       = <webdriver.transport.HTTPWireProtocol object at 0x7f99aa6cdd90>
[task 2023-05-03T14:14:17.536Z] 14:14:17     INFO - STDOUT:         timeout    = None
[task 2023-05-03T14:14:17.537Z] 14:14:17     INFO - STDOUT:         uri        = 'session'
[task 2023-05-03T14:14:17.537Z] 14:14:17     INFO - STDOUT:         url        = '/session'
[task 2023-05-03T14:14:17.537Z] 14:14:17     INFO - STDOUT: /usr/lib/python3.7/http/client.py
[task 2023-05-03T14:14:17.538Z] 14:14:17     INFO - STDOUT: :1256: in request
[task 2023-05-03T14:14:17.538Z] 14:14:17     INFO - STDOUT:     self._send_request(method, url, body, headers, encode_chunked)
[task 2023-05-03T14:14:17.539Z] 14:14:17     INFO - STDOUT:         body       = (b'{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile'
[task 2023-05-03T14:14:17.539Z] 14:14:17     INFO -  b'", "/tmp/tmpq_cun50f"], "binary": "/builds/worker/workspace/build/applicatio'
[task 2023-05-03T14:14:17.539Z] 14:14:17     INFO -  b'n/firefox/firefox"}, "acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.539Z] 14:14:17     INFO - STDOUT:         encode_chunked = False
[task 2023-05-03T14:14:17.540Z] 14:14:17     INFO - STDOUT:         headers    = {'Connection': 'keep-alive'}
[task 2023-05-03T14:14:17.540Z] 14:14:17     INFO - STDOUT:         method     = 'POST'
[task 2023-05-03T14:14:17.540Z] 14:14:17     INFO - STDOUT:         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.540Z] 14:14:17     INFO - STDOUT:         url        = '/session'
[task 2023-05-03T14:14:17.540Z] 14:14:17     INFO - STDOUT: /usr/lib/python3.7/http/client.py
[task 2023-05-03T14:14:17.541Z] 14:14:17     INFO - STDOUT: :1302: in _send_request
[task 2023-05-03T14:14:17.541Z] 14:14:17     INFO - STDOUT:     self.endheaders(body, encode_chunked=encode_chunked)
[task 2023-05-03T14:14:17.541Z] 14:14:17     INFO - STDOUT:         body       = (b'{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile'
[task 2023-05-03T14:14:17.541Z] 14:14:17     INFO -  b'", "/tmp/tmpq_cun50f"], "binary": "/builds/worker/workspace/build/applicatio'
[task 2023-05-03T14:14:17.542Z] 14:14:17     INFO -  b'n/firefox/firefox"}, "acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.542Z] 14:14:17     INFO - STDOUT:         content_length = 226
[task 2023-05-03T14:14:17.542Z] 14:14:17     INFO - STDOUT:         encode_chunked = False
[task 2023-05-03T14:14:17.543Z] 14:14:17     INFO - STDOUT:         hdr        = 'Connection'
[task 2023-05-03T14:14:17.543Z] 14:14:17     INFO - STDOUT:         header_names = frozenset({'connection'})
[task 2023-05-03T14:14:17.543Z] 14:14:17     INFO - STDOUT:         headers    = {'Connection': 'keep-alive'}
[task 2023-05-03T14:14:17.543Z] 14:14:17     INFO - STDOUT:         method     = 'POST'
[task 2023-05-03T14:14:17.544Z] 14:14:17     INFO - STDOUT:         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.547Z] 14:14:17     INFO - STDOUT:         skips      = {}
[task 2023-05-03T14:14:17.547Z] 14:14:17     INFO - STDOUT:         url        = '/session'
[task 2023-05-03T14:14:17.548Z] 14:14:17     INFO - STDOUT:         value      = 'keep-alive'
[task 2023-05-03T14:14:17.548Z] 14:14:17     INFO - STDOUT: /usr/lib/python3.7/http/client.py
[task 2023-05-03T14:14:17.549Z] 14:14:17     INFO - STDOUT: :1251: in endheaders
[task 2023-05-03T14:14:17.549Z] 14:14:17     INFO - STDOUT:     self._send_output(message_body, encode_chunked=encode_chunked)
[task 2023-05-03T14:14:17.549Z] 14:14:17     INFO - STDOUT:         encode_chunked = False
[task 2023-05-03T14:14:17.550Z] 14:14:17     INFO - STDOUT:         message_body = (b'{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile'
[task 2023-05-03T14:14:17.550Z] 14:14:17     INFO -  b'", "/tmp/tmpq_cun50f"], "binary": "/builds/worker/workspace/build/applicatio'
[task 2023-05-03T14:14:17.550Z] 14:14:17     INFO -  b'n/firefox/firefox"}, "acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.550Z] 14:14:17     INFO - STDOUT:         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.550Z] 14:14:17     INFO - STDOUT: /usr/lib/python3.7/http/client.py
[task 2023-05-03T14:14:17.550Z] 14:14:17     INFO - STDOUT: :1030: in _send_output
[task 2023-05-03T14:14:17.550Z] 14:14:17     INFO - STDOUT:     self.send(msg)
[task 2023-05-03T14:14:17.550Z] 14:14:17     INFO - STDOUT:         encode_chunked = False
[task 2023-05-03T14:14:17.551Z] 14:14:17     INFO - STDOUT:         message_body = (b'{"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile'
[task 2023-05-03T14:14:17.551Z] 14:14:17     INFO -  b'", "/tmp/tmpq_cun50f"], "binary": "/builds/worker/workspace/build/applicatio'
[task 2023-05-03T14:14:17.551Z] 14:14:17     INFO -  b'n/firefox/firefox"}, "acceptInsecureCerts": false, "webSocketUrl": true}}}')
[task 2023-05-03T14:14:17.551Z] 14:14:17     INFO - STDOUT:         msg        = (b'POST /session HTTP/1.1\r\nHost: 127.0.0.1:56308\r\nAccept-Encoding: identity'
[task 2023-05-03T14:14:17.551Z] 14:14:17     INFO -  b'\r\nContent-Length: 226\r\nConnection: keep-alive\r\n\r\n')
[task 2023-05-03T14:14:17.552Z] 14:14:17     INFO - STDOUT:         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.552Z] 14:14:17     INFO - STDOUT: /usr/lib/python3.7/http/client.py
[task 2023-05-03T14:14:17.552Z] 14:14:17     INFO - STDOUT: :970: in send
[task 2023-05-03T14:14:17.553Z] 14:14:17     INFO - STDOUT:     self.connect()
[task 2023-05-03T14:14:17.553Z] 14:14:17     INFO - STDOUT:         data       = (b'POST /session HTTP/1.1\r\nHost: 127.0.0.1:56308\r\nAccept-Encoding: identity'
[task 2023-05-03T14:14:17.553Z] 14:14:17     INFO -  b'\r\nContent-Length: 226\r\nConnection: keep-alive\r\n\r\n')
[task 2023-05-03T14:14:17.553Z] 14:14:17     INFO - STDOUT:         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.553Z] 14:14:17     INFO - STDOUT: /usr/lib/python3.7/http/client.py
[task 2023-05-03T14:14:17.554Z] 14:14:17     INFO - STDOUT: :942: in connect
[task 2023-05-03T14:14:17.554Z] 14:14:17     INFO - STDOUT:     (self.host,self.port), self.timeout, self.source_address)
[task 2023-05-03T14:14:17.555Z] 14:14:17     INFO - STDOUT:         self       = <http.client.HTTPConnection object at 0x7f99aa6cdfd0>
[task 2023-05-03T14:14:17.555Z] 14:14:17     INFO - STDOUT: /usr/lib/python3.7/socket.py
[task 2023-05-03T14:14:17.555Z] 14:14:17     INFO - STDOUT: :727: in create_connection
[task 2023-05-03T14:14:17.556Z] 14:14:17     INFO - STDOUT:     raise err
[task 2023-05-03T14:14:17.556Z] 14:14:17     INFO - STDOUT:         address    = ('127.0.0.1', 56308)
[task 2023-05-03T14:14:17.557Z] 14:14:17     INFO - STDOUT:         af         = <AddressFamily.AF_INET: 2>
[task 2023-05-03T14:14:17.559Z] 14:14:17     INFO - STDOUT:         canonname  = ''
[task 2023-05-03T14:14:17.559Z] 14:14:17     INFO - STDOUT:         err        = ConnectionRefusedError(111, 'Connection refused')
[task 2023-05-03T14:14:17.559Z] 14:14:17     INFO - STDOUT:         host       = '127.0.0.1'
[task 2023-05-03T14:14:17.560Z] 14:14:17     INFO - STDOUT:         port       = 56308
[task 2023-05-03T14:14:17.560Z] 14:14:17     INFO - STDOUT:         proto      = 6
[task 2023-05-03T14:14:17.560Z] 14:14:17     INFO - STDOUT:         res        = (<AddressFamily.AF_INET: 2>,
[task 2023-05-03T14:14:17.560Z] 14:14:17     INFO -  <SocketKind.SOCK_STREAM: 1>,
[task 2023-05-03T14:14:17.560Z] 14:14:17     INFO -  6,
[task 2023-05-03T14:14:17.561Z] 14:14:17     INFO -  '',
[task 2023-05-03T14:14:17.561Z] 14:14:17     INFO -  ('127.0.0.1', 56308))
[task 2023-05-03T14:14:17.561Z] 14:14:17     INFO - STDOUT:         sa         = ('127.0.0.1', 56308)
[task 2023-05-03T14:14:17.561Z] 14:14:17     INFO - STDOUT:         sock       = <socket.socket [closed] fd=-1, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6>
[task 2023-05-03T14:14:17.561Z] 14:14:17     INFO - STDOUT:         socktype   = <SocketKind.SOCK_STREAM: 1>
[task 2023-05-03T14:14:17.561Z] 14:14:17     INFO - STDOUT:         source_address = None
[task 2023-05-03T14:14:17.562Z] 14:14:17     INFO - STDOUT:         timeout    = <object object at 0x7f99bf018d60>
[task 2023-05-03T14:14:17.563Z] 14:14:17     INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2023-05-03T14:14:17.563Z] 14:14:17     INFO - STDOUT: address = ('127.0.0.1', 56308), timeout = <object object at 0x7f99bf018d60>
[task 2023-05-03T14:14:17.564Z] 14:14:17     INFO - STDOUT: source_address = None
[task 2023-05-03T14:14:17.564Z] 14:14:17     INFO - STDOUT:     def create_connection(address, timeout=_GLOBAL_DEFAULT_TIMEOUT,
[task 2023-05-03T14:14:17.565Z] 14:14:17     INFO - STDOUT:                           source_address=None):
[task 2023-05-03T14:14:17.565Z] 14:14:17     INFO - STDOUT:         """Connect to *address* and return the socket object.
[task 2023-05-03T14:14:17.565Z] 14:14:17     INFO - STDOUT:     
[task 2023-05-03T14:14:17.566Z] 14:14:17     INFO - STDOUT:         Convenience function.  Connect to *address* (a 2-tuple ``(host,
[task 2023-05-03T14:14:17.567Z] 14:14:17     INFO - STDOUT:         port)``) and return the socket object.  Passing the optional
[task 2023-05-03T14:14:17.567Z] 14:14:17     INFO - STDOUT:         *timeout* parameter will set the timeout on the socket instance
[task 2023-05-03T14:14:17.568Z] 14:14:17     INFO - STDOUT:         before attempting to connect.  If no *timeout* is supplied, the
[task 2023-05-03T14:14:17.568Z] 14:14:17     INFO - STDOUT:         global default timeout setting returned by :func:`getdefaulttimeout`
[task 2023-05-03T14:14:17.569Z] 14:14:17     INFO - STDOUT:         is used.  If *source_address* is set it must be a tuple of (host, port)
[task 2023-05-03T14:14:17.569Z] 14:14:17     INFO - STDOUT:         for the socket to bind as a source address before making the connection.
[task 2023-05-03T14:14:17.570Z] 14:14:17     INFO - STDOUT:         A host of '' or port 0 tells the OS to use the default.
[task 2023-05-03T14:14:17.570Z] 14:14:17     INFO - STDOUT:         """
[task 2023-05-03T14:14:17.571Z] 14:14:17     INFO - STDOUT:     
[task 2023-05-03T14:14:17.571Z] 14:14:17     INFO - STDOUT:         host, port = address
[task 2023-05-03T14:14:17.572Z] 14:14:17     INFO - STDOUT:         err = None
[task 2023-05-03T14:14:17.572Z] 14:14:17     INFO - STDOUT:         for res in getaddrinfo(host, port, 0, SOCK_STREAM):
[task 2023-05-03T14:14:17.573Z] 14:14:17     INFO - STDOUT:             af, socktype, proto, canonname, sa = res
[task 2023-05-03T14:14:17.573Z] 14:14:17     INFO - STDOUT:             sock = None
[task 2023-05-03T14:14:17.573Z] 14:14:17     INFO - STDOUT:             try:
[task 2023-05-03T14:14:17.574Z] 14:14:17     INFO - STDOUT:                 sock = socket(af, socktype, proto)
[task 2023-05-03T14:14:17.575Z] 14:14:17     INFO - STDOUT:                 if timeout is not _GLOBAL_DEFAULT_TIMEOUT:
[task 2023-05-03T14:14:17.575Z] 14:14:17     INFO - STDOUT:                     sock.settimeout(timeout)
[task 2023-05-03T14:14:17.575Z] 14:14:17     INFO - STDOUT:                 if source_address:
[task 2023-05-03T14:14:17.576Z] 14:14:17     INFO - STDOUT:                     sock.bind(source_address)
[task 2023-05-03T14:14:17.576Z] 14:14:17     INFO - STDOUT: >               sock.connect(sa)
[task 2023-05-03T14:14:17.577Z] 14:14:17     INFO - STDOUT: E               ConnectionRefusedError: [Errno 111] Connection refused
[task 2023-05-03T14:14:17.577Z] 14:14:17     INFO - STDOUT: address    = ('127.0.0.1', 56308)
[task 2023-05-03T14:14:17.578Z] 14:14:17     INFO - STDOUT: af         = <AddressFamily.AF_INET: 2>
[task 2023-05-03T14:14:17.578Z] 14:14:17     INFO - STDOUT: canonname  = ''
[task 2023-05-03T14:14:17.579Z] 14:14:17     INFO - STDOUT: err        = ConnectionRefusedError(111, 'Connection refused')
[task 2023-05-03T14:14:17.579Z] 14:14:17     INFO - STDOUT: host       = '127.0.0.1'
[task 2023-05-03T14:14:17.580Z] 14:14:17     INFO - STDOUT: port       = 56308
[task 2023-05-03T14:14:17.580Z] 14:14:17     INFO - STDOUT: proto      = 6
[task 2023-05-03T14:14:17.581Z] 14:14:17     INFO - STDOUT: res        = (<AddressFamily.AF_INET: 2>,
[task 2023-05-03T14:14:17.581Z] 14:14:17     INFO -  <SocketKind.SOCK_STREAM: 1>,
[task 2023-05-03T14:14:17.581Z] 14:14:17     INFO -  6,
[task 2023-05-03T14:14:17.581Z] 14:14:17     INFO -  '',
[task 2023-05-03T14:14:17.582Z] 14:14:17     INFO -  ('127.0.0.1', 56308))
[task 2023-05-03T14:14:17.582Z] 14:14:17     INFO - STDOUT: sa         = ('127.0.0.1', 56308)
[task 2023-05-03T14:14:17.583Z] 14:14:17     INFO - STDOUT: sock       = <socket.socket [closed] fd=-1, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6>
[task 2023-05-03T14:14:17.583Z] 14:14:17     INFO - STDOUT: socktype   = <SocketKind.SOCK_STREAM: 1>
[task 2023-05-03T14:14:17.584Z] 14:14:17     INFO - STDOUT: source_address = None
[task 2023-05-03T14:14:17.584Z] 14:14:17     INFO - STDOUT: timeout    = <object object at 0x7f99bf018d60>
[task 2023-05-03T14:14:17.585Z] 14:14:17     INFO - STDOUT: /usr/lib/python3.7/socket.py
[task 2023-05-03T14:14:17.585Z] 14:14:17     INFO - STDOUT: :716: ConnectionRefusedError
[task 2023-05-03T14:14:17.586Z] 14:14:17     INFO - STDOUT: =========================== short test summary info ============================
[task 2023-05-03T14:14:17.586Z] 14:14:17     INFO - STDOUT: FAILED tests/web-platform/mozilla/tests/webdriver/bidi/browsing_context/navigate/error.py::test_insecure_certificate
[task 2023-05-03T14:14:17.587Z] 14:14:17     INFO - STDOUT: ========================= 1 failed, 1 passed in 14.37s =========================
[task 2023-05-03T14:14:17.587Z] 14:14:17     INFO - queue closed
[task 2023-05-03T14:14:17.591Z] 14:14:17     INFO - Starting runner
[task 2023-05-03T14:14:17.591Z] 14:14:17     INFO - PID 22698 | 1683123257529	geckodriver	INFO	Listening on 127.0.0.1:56758
[task 2023-05-03T14:14:17.787Z] 14:14:17     INFO - TEST-START | /_mozilla/webdriver/get_window_handles/chrome.py
Status: NEW → RESOLVED
Closed: 2 years ago
Duplicate of bug: 1571426
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.