Closed Bug 1401358 Opened 7 years ago Closed 5 years ago

Intermittent test_quit_restart.py TestQuitRestart.test_force_clean_quit | IOError: Process killed after 120s because no connection to Marionette server could be established. Check gecko.log for errors

Categories

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

Version 3
Unspecified
Windows 10
defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Depends on 1 open bug)

Details

(Keywords: intermittent-failure)

Filed by: archaeopteryx [at] coole-files.de

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

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

15:49:43     INFO -  1505836183032	Marionette	TRACE	2 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":["startup.homepage_welcome_url",false,"nsISupportsString"],"filename":"marionette.py","script":"\n                Components.utils.import(\"resource://gre/modules/Preferences.jsm\");\n\n                let pref = arguments[0];\n                let defaultBranch = arguments[1];\n                let valueType = arguments[2];\n\n                prefs = new Preferences({defaultBranch: defaultBranch});\n                return prefs.get(pref, null, Components.interfaces[valueType]);\n                ","sandbox":"default","line":906}]
15:49:43     INFO -  1505836183033	Marionette	TRACE	2 <- [1,8,null,{"value":"about:blank"}]
15:49:43     INFO -  1505836183034	Marionette	TRACE	2 -> [0,9,"setContext",{"value":"content"}]
15:49:43     INFO -  1505836183034	Marionette	TRACE	2 <- [1,9,null,{}]
15:49:43     INFO -  1505836183036	Marionette	TRACE	2 -> [0,10,"getContext",{}]
15:49:43     INFO -  1505836183036	Marionette	TRACE	2 <- [1,10,null,{"value":"content"}]
15:49:43     INFO -  1505836183037	Marionette	TRACE	2 -> [0,11,"setContext",{"value":"chrome"}]
15:49:43     INFO -  1505836183037	Marionette	TRACE	2 <- [1,11,null,{}]
15:49:43     INFO -  1505836183038	Marionette	TRACE	2 -> [0,12,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":["startup.homepage_welcome_url","about:",false],"filename":"marionette.py","script":"\n                Components.utils.import(\"resource://gre/modules/Preferences.jsm\");\n\n                let pref = arguments[0];\n                let value = arguments[1];\n                let defaultBranch = arguments[2];\n\n                prefs = new Preferences({defaultBranch: defaultBranch});\n                prefs.set(pref, value);\n                ","sandbox":"default","line":940}]
15:49:43     INFO -  1505836183040	Marionette	TRACE	2 <- [1,12,null,{"value":null}]
15:49:43     INFO -  1505836183041	Marionette	TRACE	2 -> [0,13,"setContext",{"value":"content"}]
15:49:43     INFO -  1505836183042	Marionette	TRACE	2 <- [1,13,null,{}]
15:49:43     INFO -  1505836183043	Marionette	TRACE	2 -> [0,14,"deleteSession",{}]
15:49:43     INFO -  1505836183044	Marionette	TRACE	2 <- [1,14,null,{}]
15:49:43     INFO -  Application command: Z:\task_1505835820\build\application\firefox\firefox.exe -no-remote -marionette -profile c:\users\genericworker\appdata\local\temp\tmp7yrabk.mozrunner
15:49:43     INFO -  1505836183558	Marionette	DEBUG	Received observer notification "profile-after-change"
15:51:43    ERROR -  TEST-UNEXPECTED-ERROR | test_quit_restart.py TestQuitRestart.test_force_clean_quit | IOError: Process killed after 120s because no connection to Marionette server could be established. Check gecko.log for errors
The relevant part here is:

15:49:43     INFO -  Application command: Z:\task_1505835820\build\application\firefox\firefox.exe -no-remote -marionette -profile c:\users\genericworker\appdata\local\temp\tmp7yrabk.mozrunner
15:49:43     INFO -  1505836183558	Marionette	DEBUG	Received observer notification "profile-after-change"
15:51:43    ERROR -  TEST-UNEXPECTED-ERROR | test_quit_restart.py TestQuitRestart.test_force_clean_quit | IOError: Process killed after 120s because no connection to Marionette server could be established. Check gecko.log for errors

So Firefox started but beside `profile-after-change` no other observer notification is received. Looks like a hang during startup, and Marionette kills the process 120s later.
Blocks: 1386590
OS: Unspecified → Windows 10

(In reply to Intermittent Failures Robot from comment #11)

18 failures in 509 pushes (0.035 failures/push) were associated with this bug yesterday.

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1401358&startday=2019-07-01&endday=2019-07-01&tree=all

None of those classified failures have anything to do with Marionette and its unit tests. Victor, please have a look given that you set all those classifications. Thanks.

Flags: needinfo?(vporof)

Actually there are no more failures since a couple of months. Going to close this bug as incomplete.

Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → INCOMPLETE
Flags: needinfo?(vporof)
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.