1437170 - Intermittent test_prefs_enforce.py TestEnforcePreferences.test_change_preference | IOError: Process killed after 120s because no connection to Marionette server could be established. Check gecko.log for errors

Status: RESOLVED INCOMPLETE

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

Description

[Treeherder Bug Filer]

Filed by: ccoroiu [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=161380379&repo=mozilla-inbound

https://queue.taskcluster.net/v1/task/Is9I0MNhQzaJ8WabYBWACg/runs/0/artifacts/public/test_info/marionette_errorsummary.log

18:22:04     INFO -  1518200524253	Marionette	DEBUG	Received observer notification profile-after-change
18:24:04    ERROR -  TEST-UNEXPECTED-ERROR | testing\marionette\harness\marionette_harness\tests\unit\test_prefs_enforce.py TestEnforcePreferences.test_change_preference | IOError: Process killed after 120s because no connection to Marionette server could be established. Check gecko.log for errors
18:24:04     INFO -  Traceback (most recent call last):
18:24:04     INFO -    File "Z:\task_1518200112\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 190, in run
18:24:04     INFO -      self.tearDown()
18:24:04     INFO -    File "Z:\task_1518200112\build\tests\marionette\tests\testing\marionette\harness\marionette_harness\tests\unit\test_prefs_enforce.py", line 25, in tearDown
18:24:04     INFO -      super(TestEnforcePreferences, self).tearDown()
18:24:04     INFO -    File "Z:\task_1518200112\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 338, in tearDown
18:24:04     INFO -      self.marionette.start_session()
18:24:04     INFO -    File "Z:\task_1518200112\build\venv\lib\site-packages\marionette_driver\decorators.py", line 26, in _
18:24:04     INFO -      return func(*args, **kwargs)
18:24:04     INFO -    File "Z:\task_1518200112\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1211, in start_session
18:24:04     INFO -      self.start_binary(timeout)
18:24:04     INFO -    File "Z:\task_1518200112\build\venv\lib\site-packages\marionette_driver\marionette.py", line 645, in start_binary
18:24:04     INFO -      reraise(IOError, msg.format(timeout), tb)
18:24:04     INFO -    File "Z:\task_1518200112\build\venv\lib\site-packages\marionette_driver\marionette.py", line 636, in start_binary
18:24:04     INFO -      self.raise_for_port(timeout=timeout)
18:24:04     INFO -    File "Z:\task_1518200112\build\venv\lib\site-packages\marionette_driver\marionette.py", line 716, in raise_for_port
18:24:04     INFO -      self.host, self.port))
18:24:04     INFO -  TEST-INFO took 125655ms

Comment 1

[Henrik Skupin [:whimboo][⌚️UTC+2]]

There has no "sessionstore-windows-restored" observer notification be received and as such Marionette didn't start.

Comment 2

[Intermittent Failures Robot]

1 failures in 702 pushes (0.001 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* windows10-64: 1

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1437170&startday=2018-02-05&endday=2018-02-11&tree=all

Comment 3

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 4

[Bogdan Tara[:bogdan_tara | bogdant]]

This is still happening.

Recent failure: https://treeherder.mozilla.org/logviewer.html#?job_id=212526453&repo=autoland&lineNumber=38012

23:50:16     INFO -  Application command: Z:\task_1542583818\build\application\firefox\firefox.exe -no-remote -marionette --wait-for-browser -profile c:\users\task_1542583818\appdata\local\temp\tmppzhawg.mozrunner
23:50:16     INFO -  *** You are running in headless mode.
23:50:17     INFO -  1542585017037	[e-mail]	WARN	Loading extension '[e-mail]': Reading manifest: Invalid host permission: resource://pdf.js/
23:50:17     INFO -  1542585017037	[e-mail]	WARN	Loading extension '[e-mail]': Reading manifest: Invalid host permission: about:reader*
23:50:17     INFO -  1542585017192	Marionette	DEBUG	Received observer notification profile-after-change
23:50:17     INFO -  1542585017230	Marionette	DEBUG	Received observer notification toplevel-window-ready
23:50:17     INFO -  1542585017264	Marionette	DEBUG	Received observer notification command-line-startup
23:50:17     INFO -  1542585017264	Marionette	DEBUG	Received observer notification nsPref:changed
23:50:17     INFO -  1542585017264	Marionette	DEBUG	Init aborted (running=false, enabled=true, finalUIStartup=false)
23:52:16    ERROR -  TEST-UNEXPECTED-ERROR | testing\marionette\harness\marionette_harness\tests\unit\test_prefs_enforce.py TestEnforcePreferences.test_change_preference | IOError: Process killed after 120s because no connection to Marionette server could be established. Check gecko.log for errors
23:52:16     INFO -  Traceback (most recent call last):
23:52:16     INFO -    File "Z:\task_1542583818\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 190, in run
23:52:16     INFO -      self.tearDown()
23:52:16     INFO -    File "Z:\task_1542583818\build\tests\marionette\tests\testing\marionette\harness\marionette_harness\tests\unit\test_prefs_enforce.py", line 25, in tearDown
23:52:16     INFO -      super(TestEnforcePreferences, self).tearDown()
23:52:16     INFO -    File "Z:\task_1542583818\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 338, in tearDown
23:52:16     INFO -      self.marionette.start_session()
23:52:16     INFO -    File "Z:\task_1542583818\build\venv\lib\site-packages\marionette_driver\decorators.py", line 26, in _
23:52:16     INFO -      return func(*args, **kwargs)
23:52:16     INFO -    File "Z:\task_1542583818\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1269, in start_session
23:52:16     INFO -      self.start_binary(timeout)
23:52:16     INFO -    File "Z:\task_1542583818\build\venv\lib\site-packages\marionette_driver\marionette.py", line 658, in start_binary
23:52:16     INFO -      reraise(IOError, msg.format(timeout), tb)
23:52:16     INFO -    File "Z:\task_1542583818\build\venv\lib\site-packages\marionette_driver\marionette.py", line 649, in start_binary
23:52:16     INFO -      self.raise_for_port(timeout=timeout)
23:52:16     INFO -    File "Z:\task_1542583818\build\venv\lib\site-packages\marionette_driver\marionette.py", line 735, in raise_for_port
23:52:16     INFO -      self.host, self.port))
23:52:16     INFO -  TEST-INFO took 125482ms

Comment 5

[Intermittent Failures Robot]

1 failures in 2917 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1

Platform breakdown:
* windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1437170&startday=2018-11-12&endday=2018-11-18&tree=all

Comment 6

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 7

[BMO Automation]

Moving bug to Testing::Marionette Client and Harness component per bug 1815831.