New issue
Advanced search Search tips

Issue 753876 link

Starred by 0 users

Issue metadata

Status: Archived
Owner:
Closed: Aug 2017
Cc:
Components:
EstimatedDays: ----
NextAction: ----
OS: Chrome
Pri: 1
Type: Bug

Blocking:
issue 753116



Sign in to add a comment

login_CryptohomeIncognito failures due to devtools ephemeral port

Project Member Reported by achuith@chromium.org, Aug 9 2017

Issue description

Stack:
Traceback (most recent call last):
  File "/usr/local/autotest/common_lib/test.py", line 606, in _exec
    _call_test_function(self.execute, *p_args, **p_dargs)
  File "/usr/local/autotest/common_lib/test.py", line 812, in _call_test_function
    raise error.UnhandledTestFail(e)
UnhandledTestFail: Unhandled error: [Errno 111] Connection refused
Traceback (most recent call last):
  File "/usr/local/autotest/common_lib/test.py", line 806, in _call_test_function
    return func(*args, **dargs)
  File "/usr/local/autotest/common_lib/test.py", line 470, in execute
    dargs)
  File "/usr/local/autotest/common_lib/test.py", line 347, in _call_run_once_with_retry
    postprocess_profiled_run, args, dargs)
  File "/usr/local/autotest/common_lib/test.py", line 380, in _call_run_once
    self.run_once(*args, **dargs)
  File "/usr/local/autotest/tests/login_CryptohomeIncognito/login_CryptohomeIncognito.py", line 17, in run_once
    with chrome.Chrome(logged_in=False):
  File "/usr/local/autotest/common_lib/cros/chrome.py", line 164, in __init__
    self._browser = browser_to_create.Create(finder_options)
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome/cros_browser_finder.py", line 48, in Create
    browser_backend, self._platform_backend, self._credentials_path)
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome/cros_browser_with_oobe.py", line 14, in __init__
    backend, platform_backend, credentials_path)
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/browser/browser.py", line 60, in __init__
    self._LogBrowserInfo()
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/browser/browser.py", line 124, in _LogBrowserInfo
    if self.supports_system_info:
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/browser/browser.py", line 337, in supports_system_info
    return self._browser_backend.supports_system_info
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome/chrome_browser_backend.py", line 273, in supports_system_info
    return self.GetSystemInfo() != None
  File "/usr/local/telemetry/src/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 52, in traced_function
    return func(*args, **kwargs)
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome/chrome_browser_backend.py", line 279, in GetSystemInfo
    return self.devtools_client.GetSystemInfo(timeout=30)
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/devtools_client_backend.py", line 398, in GetSystemInfo
    return self._system_info_backend.GetSystemInfo(timeout)
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/system_info_backend.py", line 18, in GetSystemInfo
    websocket.Connect(self._browser_target_ws, timeout)
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/inspector_websocket.py", line 64, in Connect
    self._socket = websocket.create_connection(url, timeout=timeout)
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/websocket.py", line 25, in create_connection
    return _create_connection(*args, **kwargs)
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/third_party/websocket-client/websocket/_core.py", line 487, in create_connection
    websock.connect(url, **options)
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/third_party/websocket-client/websocket/_core.py", line 211, in connect
    options.pop('socket', None))
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/third_party/websocket-client/websocket/_http.py", line 71, in connect
    sock = _open_socket(addrinfo_list, options.sockopt, options.timeout)
  File "/usr/local/telemetry/src/third_party/catapult/telemetry/third_party/websocket-client/websocket/_http.py", line 125, in _open_socket
    raise err
error: [Errno 111] Connection refused


First failing run:
https://uberchromegw.corp.google.com/i/chromiumos.chromium/builders/amd64-generic-tot-chromium-pfq-informational/builds/12861


 
Blocking: 753116
Complete log is below. We start the browser, establish the ws connection, then for some reason we kill the browser and the error you report is due to attempt to connect post-killing.


  Discovered ephemeral port 43940
  Browser target: /devtools/browser/145546a1-133d-4336-8431-1cfce7087416
  Invoking Oobe.guestLoginForTesting
  Discovered ephemeral port 43940
  Browser target: /devtools/browser/145546a1-133d-4336-8431-1cfce7087416
  Websocket at port 43940 not yet available: [Errno 111] Connection refused
  Discovered ephemeral port 43940
  Browser target: /devtools/browser/145546a1-133d-4336-8431-1cfce7087416
  Websocket at port 43940 not yet available: [Errno 111] Connection refused
  Discovered ephemeral port 43940
  Browser target: /devtools/browser/145546a1-133d-4336-8431-1cfce7087416
  Websocket at port 43940 not yet available: [Errno 111] Connection refused
  Discovered ephemeral port 43940
  Browser target: /devtools/browser/145546a1-133d-4336-8431-1cfce7087416
  Websocket at port 43940 not yet available: [Errno 111] Connection refused
  Discovered ephemeral port 43940
  Browser target: /devtools/browser/145546a1-133d-4336-8431-1cfce7087416
  Websocket at port 43940 not yet available: [Errno 111] Connection refused
  Discovered ephemeral port 38684
  Browser target: /devtools/browser/2e7029f8-7f2c-4a58-8f62-f36fd2445183
  Discovered ephemeral port 38684
  Browser target: /devtools/browser/2e7029f8-7f2c-4a58-8f62-f36fd2445183
  Browser is up!
  Browser started (pid=8148).
  OS: chromeos 
  Failed with error while starting the browser backend.
  Closing browser (pid=8148) ...
  (Re)starting the ui (logs the user out)
  Browser is closed.
  Traceback (most recent call last):
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/testing/browser_test_case.py", line 92, in setUpClass
      current_browser = browser_to_create.Create(options)
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome/cros_browser_finder.py", line 50, in Create
      self._credentials_path)
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/browser/browser.py", line 60, in __init__
      self._LogBrowserInfo()
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/browser/browser.py", line 124, in _LogBrowserInfo
      if self.supports_system_info:
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/browser/browser.py", line 337, in supports_system_info
      return self._browser_backend.supports_system_info
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome/chrome_browser_backend.py", line 273, in supports_system_info
      return self.GetSystemInfo() != None
    File "/usr/local/telemetry/src/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 52, in traced_function
      return func(*args, **kwargs)
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome/chrome_browser_backend.py", line 279, in GetSystemInfo
      return self.devtools_client.GetSystemInfo(timeout=30)
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/devtools_client_backend.py", line 398, in GetSystemInfo
      return self._system_info_backend.GetSystemInfo(timeout)
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/system_info_backend.py", line 18, in GetSystemInfo
      websocket.Connect(self._browser_target_ws, timeout)
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/inspector_websocket.py", line 64, in Connect
      self._socket = websocket.create_connection(url, timeout=timeout)
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/websocket.py", line 25, in create_connection
      return _create_connection(*args, **kwargs)
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/third_party/websocket-client/websocket/_core.py", line 487, in create_connection
      websock.connect(url, **options)
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/third_party/websocket-client/websocket/_core.py", line 211, in connect
      options.pop('socket', None))
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/third_party/websocket-client/websocket/_http.py", line 71, in connect
      sock = _open_socket(addrinfo_list, options.sockopt, options.timeout)
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/third_party/websocket-client/websocket/_http.py", line 125, in _open_socket
      raise err
  error: [Errno 111] Connection refused

I believe I now know what is wrong, following up with a fix.
Status: Fixed (was: Assigned)

Comment 5 by dchan@chromium.org, Jan 22 2018

Status: Archived (was: Fixed)

Sign in to add a comment