Closed Bug 1739183 Opened 3 years ago Closed 3 years ago

Intermittent macOS Automation Error: Received unexpected exception while running application

Categories

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

defect

Tracking

(Not tracked)

RESOLVED DUPLICATE of bug 1739008

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

Filed by: archaeopteryx [at] coole-files.de
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=356869204&repo=try
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/YLW4VrdqQUm03byANbpzkg/runs/0/artifacts/public/logs/live_backing.log


[task 2021-11-03T12:39:19.902Z] 12:39:19     INFO - Application command: /opt/worker/tasks/task_163594220153428/build/application/Firefox.app/Contents/MacOS/firefox -marionette -foreground -profile /var/folders/ph/mplszy552x733kh_2m2kvx0h000014/T/tmpkwvkhjdz.mozrunner
[task 2021-11-03T12:39:19.907Z] 12:39:19     INFO - runtests.py | Application pid: 1986
[task 2021-11-03T12:39:19.907Z] 12:39:19     INFO - TEST-INFO | started process GECKO(1986)
[task 2021-11-03T12:39:20.052Z] 12:39:20     INFO - GECKO(1986) | 1635943160051	Marionette	INFO	Marionette enabled
[task 2021-11-03T12:39:20.118Z] 12:39:20     INFO - GECKO(1986) | 1635943160117	Marionette	TRACE	Received observer notification toplevel-window-ready
[task 2021-11-03T12:39:20.893Z] 12:39:20     INFO - GECKO(1986) | 1635943160892	Marionette	TRACE	Received observer notification marionette-startup-requested
[task 2021-11-03T12:39:20.894Z] 12:39:20     INFO - GECKO(1986) | 1635943160892	Marionette	TRACE	Waiting until startup recorder finished recording startup scripts...
[task 2021-11-03T12:39:20.896Z] 12:39:20     INFO - GECKO(1986) | 1635943160895	Marionette	TRACE	All scripts recorded.
[task 2021-11-03T12:39:20.897Z] 12:39:20     INFO - GECKO(1986) | 1635943160896	Marionette	INFO	Listening on port 2828
[task 2021-11-03T12:39:20.897Z] 12:39:20     INFO - GECKO(1986) | 1635943160896	Marionette	DEBUG	Marionette is listening
[task 2021-11-03T12:39:21.057Z] 12:39:21     INFO - GECKO(1986) | 1635943161056	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:55410
[task 2021-11-03T12:39:21.058Z] 12:39:21     INFO - GECKO(1986) | 1635943161057	Marionette	DEBUG	Closed connection 0
[task 2021-11-03T12:39:21.058Z] 12:39:21     INFO - GECKO(1986) | 1635943161057	Marionette	DEBUG	Accepted connection 1 from 127.0.0.1:55411
[task 2021-11-03T12:39:21.060Z] 12:39:21     INFO - GECKO(1986) | 1635943161059	Marionette	DEBUG	1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2021-11-03T12:39:22.351Z] 12:39:22     INFO - GECKO(1986) | JavaScript error: resource://gre/modules/XULStore.jsm, line 66: Error: Can't find profile directory.
[task 2021-11-03T12:39:50.174Z] 12:39:50     INFO - GECKO(1986) | 2021-11-03 12:39:50.173 firefox[1986:31638] Persistent UI failed to open file file:///Users/cltbld/Library/Saved%20Application%20State/org.mozilla.firefox.savedState/window_1.data: No such file or directory (2)
[task 2021-11-03T12:43:50.507Z] 12:43:50     INFO - GECKO(1986) | 1635943430506	addons.xpi	ERROR	System addon update list error Error: got node name: html, expected: updates
[task 2021-11-03T12:44:21.280Z] 12:44:21     INFO - GECKO(1986) | 1635943461277	Marionette	DEBUG	1 <- [1,1,{"error":"session not created","message":"TimeoutError: TimedPromise timed out after 300000 ms","stacktrace":"WebDriverE ... r@chrome://remote/content/shared/webdriver/Errors.jsm:450:5\nbail@chrome://remote/content/marionette/sync.js:230:19\n"},null]
[task 2021-11-03T12:44:21.280Z] 12:44:21     INFO -  Traceback (most recent call last):
[task 2021-11-03T12:44:21.281Z] 12:44:21     INFO -    File "/opt/worker/tasks/task_163594220153428/build/tests/mochitest/runtests.py", line 3237, in doTests
[task 2021-11-03T12:44:21.281Z] 12:44:21     INFO -      crashAsPass=options.crashAsPass,
[task 2021-11-03T12:44:21.281Z] 12:44:21     INFO -    File "/opt/worker/tasks/task_163594220153428/build/tests/mochitest/runtests.py", line 2502, in runApp
[task 2021-11-03T12:44:21.281Z] 12:44:21     INFO -      self.marionette.start_session()
[task 2021-11-03T12:44:21.282Z] 12:44:21     INFO -    File "/opt/worker/tasks/task_163594220153428/build/venv/lib/python3.7/site-packages/marionette_driver/decorators.py", line 27, in _
[task 2021-11-03T12:44:21.282Z] 12:44:21     INFO -      return func(*args, **kwargs)
[task 2021-11-03T12:44:21.282Z] 12:44:21     INFO -    File "/opt/worker/tasks/task_163594220153428/build/venv/lib/python3.7/site-packages/marionette_driver/marionette.py", line 1187, in start_session
[task 2021-11-03T12:44:21.282Z] 12:44:21     INFO -      resp = self._send_message("WebDriver:NewSession", capabilities)
[task 2021-11-03T12:44:21.283Z] 12:44:21     INFO -    File "/opt/worker/tasks/task_163594220153428/build/venv/lib/python3.7/site-packages/marionette_driver/decorators.py", line 27, in _
[task 2021-11-03T12:44:21.283Z] 12:44:21     INFO -      return func(*args, **kwargs)
[task 2021-11-03T12:44:21.283Z] 12:44:21     INFO -    File "/opt/worker/tasks/task_163594220153428/build/venv/lib/python3.7/site-packages/marionette_driver/marionette.py", line 630, in _send_message
[task 2021-11-03T12:44:21.284Z] 12:44:21     INFO -      self._handle_error(err)
[task 2021-11-03T12:44:21.284Z] 12:44:21     INFO -    File "/opt/worker/tasks/task_163594220153428/build/venv/lib/python3.7/site-packages/marionette_driver/marionette.py", line 652, in _handle_error
[task 2021-11-03T12:44:21.284Z] 12:44:21     INFO -      raise errors.lookup(error)(message, stacktrace=stacktrace)
[task 2021-11-03T12:44:21.284Z] 12:44:21     INFO -  marionette_driver.errors.SessionNotCreatedException: TimeoutError: TimedPromise timed out after 300000 ms
[task 2021-11-03T12:44:21.284Z] 12:44:21     INFO -  stacktrace:
[task 2021-11-03T12:44:21.285Z] 12:44:21     INFO -  	WebDriverError@chrome://remote/content/shared/webdriver/Errors.jsm:181:5
[task 2021-11-03T12:44:21.285Z] 12:44:21     INFO -  	TimeoutError@chrome://remote/content/shared/webdriver/Errors.jsm:450:5
[task 2021-11-03T12:44:21.285Z] 12:44:21     INFO -  	bail@chrome://remote/content/marionette/sync.js:230:19
[task 2021-11-03T12:44:21.285Z] 12:44:21    ERROR - Automation Error: Received unexpected exception while running application

Same underlying issue as bug 1739008.

Status: NEW → RESOLVED
Closed: 3 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.