Closed Bug 1675177 Opened 4 years ago Closed 4 years ago

Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_navigation.py TestPageLoadStrategy.test_none | IOError: Process killed because the connection to Marionette server is lost. Check gecko.log for errors (Reason: Connection timed ou

Categories

(Testing :: Marionette Client and Harness, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED DUPLICATE of bug 1675173

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2020-11-04T03:13:44.330Z] 03:13:44     INFO -  TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_navigation.py TestPageLoadStrategy.test_none
[task 2020-11-04T03:19:44.648Z] 03:19:44     INFO -  1604459984637	Marionette	DEBUG	Closed connection 27
[task 2020-11-04T03:20:55.795Z] 03:20:55    ERROR -  TEST-UNEXPECTED-ERROR | testing/marionette/harness/marionette_harness/tests/unit/test_navigation.py TestPageLoadStrategy.test_none | IOError: Process killed because the connection to Marionette server is lost. Check gecko.log for errors (Reason: Connection timed out after 360.0s)
[task 2020-11-04T03:20:55.795Z] 03:20:55     INFO -  Traceback (most recent call last):
[task 2020-11-04T03:20:55.795Z] 03:20:55     INFO -    File "Z:\task_1604459126\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 214, in run
[task 2020-11-04T03:20:55.795Z] 03:20:55     INFO -      testMethod()
[task 2020-11-04T03:20:55.795Z] 03:20:55     INFO -    File "Z:\task_1604459126\build\tests\marionette\tests\testing\marionette\harness\marionette_harness\tests\unit\test_navigation.py", line 925, in test_none
[task 2020-11-04T03:20:55.796Z] 03:20:55     INFO -      message="Target page has not been loaded",
[task 2020-11-04T03:20:55.796Z] 03:20:55     INFO -    File "Z:\task_1604459126\build\venv\lib\site-packages\marionette_driver\wait.py", line 134, in until
[task 2020-11-04T03:20:55.796Z] 03:20:55     INFO -      rv = condition(self.marionette)
[task 2020-11-04T03:20:55.796Z] 03:20:55     INFO -    File "Z:\task_1604459126\build\tests\marionette\tests\testing\marionette\harness\marionette_harness\tests\unit\test_navigation.py", line 924, in <lambda>
[task 2020-11-04T03:20:55.796Z] 03:20:55     INFO -      lambda _: self.marionette.get_url() == self.test_page_slow_resource,
[task 2020-11-04T03:20:55.796Z] 03:20:55     INFO -    File "Z:\task_1604459126\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1464, in get_url
[task 2020-11-04T03:20:55.796Z] 03:20:55     INFO -      return self._send_message("WebDriver:GetCurrentURL", key="value")
[task 2020-11-04T03:20:55.796Z] 03:20:55     INFO -    File "Z:\task_1604459126\build\venv\lib\site-packages\marionette_driver\decorators.py", line 37, in _
[task 2020-11-04T03:20:55.796Z] 03:20:55     INFO -      m._handle_socket_failure()
[task 2020-11-04T03:20:55.797Z] 03:20:55     INFO -    File "Z:\task_1604459126\build\venv\lib\site-packages\marionette_driver\marionette.py", line 712, in _handle_socket_failure
[task 2020-11-04T03:20:55.797Z] 03:20:55     INFO -      IOError, IOError(message.format(returncode=returncode, reason=exc)), tb
[task 2020-11-04T03:20:55.797Z] 03:20:55     INFO -    File "Z:\task_1604459126\build\venv\lib\site-packages\marionette_driver\decorators.py", line 27, in _
[task 2020-11-04T03:20:55.797Z] 03:20:55     INFO -      return func(*args, **kwargs)
[task 2020-11-04T03:20:55.797Z] 03:20:55     INFO -    File "Z:\task_1604459126\build\venv\lib\site-packages\marionette_driver\marionette.py", line 617, in _send_message
[task 2020-11-04T03:20:55.797Z] 03:20:55     INFO -      msg = self.client.request(name, params)
[task 2020-11-04T03:20:55.798Z] 03:20:55     INFO -    File "Z:\task_1604459126\build\venv\lib\site-packages\marionette_driver\transport.py", line 288, in request
[task 2020-11-04T03:20:55.798Z] 03:20:55     INFO -      return self.receive()
[task 2020-11-04T03:20:55.798Z] 03:20:55     INFO -    File "Z:\task_1604459126\build\venv\lib\site-packages\marionette_driver\transport.py", line 192, in receive
[task 2020-11-04T03:20:55.798Z] 03:20:55     INFO -      "Connection timed out after {}s".format(self.socket_timeout)
[task 2020-11-04T03:20:55.798Z] 03:20:55     INFO -  TEST-INFO took 431460ms
[task 2020-11-04T03:20:55.798Z] 03:20:55     INFO -  Application command: Z:\task_1604459126\build\application\firefox\firefox.exe -no-remote -marionette --wait-for-browser -profile c:\users\task_1604459126\appdata\local\temp\tmp1tj4en.mozrunner
[task 2020-11-04T03:20:56.133Z] 03:20:56     INFO -  DEBUG: Adding blocker OS.File: flush pending requests, warn about unclosed files, shut down service. for phase xpcom-will-shutdown
[task 2020-11-04T03:20:56.133Z] 03:20:56     INFO -  DEBUG: Adding blocker OS.File: flush I/O queued before profileBeforeChange for phase profile-before-change
[task 2020-11-04T03:20:56.133Z] 03:20:56     INFO -  DEBUG: Adding blocker AddonManager: shutting down. for phase profile-before-change
[task 2020-11-04T03:20:56.168Z] 03:20:56     INFO -  DEBUG: Adding blocker ClientManagerService: start destroying IPC actors early for phase xpcom-will-shutdown
[task 2020-11-04T03:20:56.229Z] 03:20:56     INFO -  DEBUG: Adding blocker Flush WebExtension StartupCache for phase profile-before-change
[task 2020-11-04T03:20:56.356Z] 03:20:56     INFO -  DEBUG: Adding blocker JSON store: writing data for phase AddonManager: Waiting for providers to shut down.
[task 2020-11-04T03:20:56.356Z] 03:20:56     INFO -  DEBUG: Adding blocker Update add-on blocklist state into add-on DB for phase AddonManager: Waiting to start provider shutdown.
[task 2020-11-04T03:20:56.356Z] 03:20:56     INFO -  DEBUG: Completed blocker Update add-on blocklist state into add-on DB for phase AddonManager: Waiting to start provider shutdown.
[task 2020-11-04T03:20:56.371Z] 03:20:56     INFO -  DEBUG: Adding blocker XPIProvider shutdown for phase quit-application-granted
[task 2020-11-04T03:20:56.371Z] 03:20:56     INFO -  DEBUG: Adding blocker XPIProvider for phase AddonManager: Waiting for providers to shut down.
[task 2020-11-04T03:20:56.371Z] 03:20:56     INFO -  DEBUG: Adding blocker PluginProvider for phase AddonManager: Waiting for providers to shut down.
[task 2020-11-04T03:20:56.371Z] 03:20:56     INFO -  DEBUG: Adding blocker ServiceWorkerRegistrar: Flushing data for phase profile-before-change
[task 2020-11-04T03:20:56.371Z] 03:20:56     INFO -  DEBUG: Adding blocker CrashMonitor: Writing notifications to file after receiving profile-before-change for phase OS.File: Waiting for clients before profileBeforeChange
[task 2020-11-04T03:20:56.391Z] 03:20:56     INFO -  DEBUG: Adding blocker TelemetryController: shutting down for phase profile-before-change-telemetry
[task 2020-11-04T03:20:56.411Z] 03:20:56     INFO -  DEBUG: Adding blocker EnvironmentAddonBuilder for phase AddonManager: Waiting to start provider shutdown.
[task 2020-11-04T03:20:56.426Z] 03:20:56     INFO -  DEBUG: Adding blocker RemoteSettingsClient - finish IDB access. for phase profile-before-change```
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → DUPLICATE
Product: Testing → Remote Protocol
Moving bug to Testing::Marionette Client and Harness component per bug 1815831.
Component: Marionette → Marionette Client and Harness
Product: Remote Protocol → Testing
You need to log in before you can comment on or make changes to this bug.