Closed
Bug 1777963
Opened 3 years ago
Closed 2 years ago
Intermittent [tier 2] CCOV testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py <test-name> | OSError: Process has been unexpectedly closed (Exit code: -15) [initial load]
Categories
(Testing :: Marionette Client and Harness, defect, P5)
Testing
Marionette Client and Harness
Tracking
(Not tracked)
RESOLVED
WORKSFORME
People
(Reporter: intermittent-bug-filer, Unassigned)
References
Details
(Keywords: intermittent-failure, Whiteboard: [retriggered])
Filed by: bszekely [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=383266005&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/IV6L89QfRIGN3UcLPIBWtA/runs/0/artifacts/public/logs/live_backing.log
[task 2022-07-04T10:41:45.021Z] 10:41:45 INFO - DEBUG: Adding blocker PlacesUtils read-only connection must be closed before Sqlite.jsm for phase Sqlite.jsm: wait until all clients have completed their task
[task 2022-07-04T10:41:45.025Z] 10:41:45 INFO - DEBUG: Completed blocker places.sqlite#1: PlacesExpiration.jsm: setup (0) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:41:45.167Z] 10:41:45 INFO - DEBUG: Adding blocker JSON store: writing data for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2022-07-04T10:41:45.211Z] 10:41:45 INFO - DEBUG: Adding blocker JSON store: writing data for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2022-07-04T10:41:45.506Z] 10:41:45 INFO - DEBUG: Adding blocker OS.File: flush pending requests, warn about unclosed files, shut down service. for phase xpcom-will-shutdown
[task 2022-07-04T10:41:45.508Z] 10:41:45 INFO - DEBUG: Adding blocker OS.File: flush I/O queued before profileBeforeChange for phase profile-before-change
[task 2022-07-04T10:41:45.672Z] 10:41:45 INFO - DEBUG: Adding blocker DownloadAutoSaveView: writing data for phase profile-before-change
[task 2022-07-04T10:41:45.690Z] 10:41:45 INFO - 1656931305689 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2022-07-04T10:41:45.692Z] 10:41:45 INFO - DEBUG: Adding blocker ScriptPreloader: Saving bytecode cache for phase xpcom-will-shutdown
[task 2022-07-04T10:41:45.702Z] 10:41:45 INFO - 1656931305701 RemoteAgent TRACE [30] ProgressListener state=start: about:blank
[task 2022-07-04T10:41:45.766Z] 10:41:45 INFO - [CodeCoverage] Setting handlers for process 16018.
[task 2022-07-04T10:41:59.449Z] 10:41:59 INFO - DEBUG: Adding blocker SessionFile: Finish writing Session Restore data for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2022-07-04T10:41:59.453Z] 10:41:59 INFO - DEBUG: Completed blocker SessionFile: Finish writing Session Restore data for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2022-07-04T10:42:04.372Z] 10:42:04 INFO - DEBUG: Adding blocker JSON store: writing data for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2022-07-04T10:45:44.362Z] 10:45:44 INFO - DEBUG: Adding blocker places.sqlite#1: PlacesUtils: promiseKeywordsCache (1) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:45:44.363Z] 10:45:44 INFO - DEBUG: Completed blocker places.sqlite#1: PlacesUtils: promiseKeywordsCache (1) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:47:42.192Z] 10:47:42 INFO - JavaScript error: chrome://remote/content/marionette/driver.js, line 2273: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIObserverService.removeObserver]
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - TEST-UNEXPECTED-ERROR | testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py TestQuitRestart.test_in_app_quit_with_dismissed_beforeunload_prompt | OSError: Process has been unexpectedly closed (Exit code: -15) (Reason: Process killed because the connection to Marionette server is lost. Check gecko.log for errors (Reason: Connection timed out after 360.0s))
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - Traceback (most recent call last):
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_harness/marionette_test/testcases.py", line 202, in run
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - testMethod()
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/tests/marionette/tests/testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py", line 426, in test_in_app_quit_with_dismissed_beforeunload_prompt
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - self.marionette.start_session()
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/decorators.py", line 37, in _
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - m._handle_socket_failure()
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 744, in _handle_socket_failure
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - IOError, IOError(message.format(returncode=returncode, reason=exc)), tb
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/six.py", line 702, in reraise
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - raise value.with_traceback(tb)
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/decorators.py", line 27, in _
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - return func(*args, **kwargs)
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 1238, in start_session
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - resp = self._send_message("WebDriver:NewSession", capabilities)
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/decorators.py", line 37, in _
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - m._handle_socket_failure()
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 744, in _handle_socket_failure
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - IOError, IOError(message.format(returncode=returncode, reason=exc)), tb
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/six.py", line 702, in reraise
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - raise value.with_traceback(tb)
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/decorators.py", line 27, in _
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - return func(*args, **kwargs)
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 659, in _send_message
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - msg = self.client.request(name, params)
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/transport.py", line 383, in request
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - return self.receive()
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/transport.py", line 221, in receive
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - "Connection timed out after {}s".format(self.socket_timeout)
[task 2022-07-04T10:48:53.258Z] 10:48:53 INFO - TEST-INFO took 437802ms
[task 2022-07-04T10:48:53.260Z] 10:48:53 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -no-remote -marionette -profile /tmp/tmpt3fihdjd.mozrunner
[task 2022-07-04T10:48:53.335Z] 10:48:53 INFO - [CodeCoverage] Setting handlers for process 16075.
[task 2022-07-04T10:48:53.587Z] 10:48:53 INFO - DEBUG: Adding blocker AddonManager: shutting down. for phase profile-before-change
[task 2022-07-04T10:48:53.643Z] 10:48:53 INFO - DEBUG: Adding blocker IOUtils Blocker (profile-before-change) for phase profile-before-change
[task 2022-07-04T10:48:53.645Z] 10:48:53 INFO - DEBUG: Adding blocker IOUtils Blocker (xpcom-will-shutdown) for phase xpcom-will-shutdown
[task 2022-07-04T10:48:53.755Z] 10:48:53 INFO - DEBUG: Adding blocker Flush WebExtension StartupCache for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2022-07-04T10:48:54.090Z] 10:48:54 INFO - DEBUG: Adding blocker JSON store: writing data for phase AddonManager: Waiting for providers to shut down.
[task 2022-07-04T10:48:54.103Z] 10:48:54 INFO - DEBUG: Adding blocker Update add-on blocklist state into add-on DB for phase AddonManager: Waiting to start provider shutdown.
[task 2022-07-04T10:48:54.118Z] 10:48:54 INFO - DEBUG: Adding blocker XPIProvider shutdown for phase quit-application-granted
[task 2022-07-04T10:48:54.125Z] 10:48:54 INFO - DEBUG: Adding blocker XPIProvider for phase AddonManager: Waiting for providers to shut down.
[task 2022-07-04T10:48:54.127Z] 10:48:54 INFO - DEBUG: Adding blocker ServiceWorkerRegistrar: Flushing data for phase profile-before-change
[task 2022-07-04T10:48:54.134Z] 10:48:54 INFO - DEBUG: Adding blocker CrashMonitor: Writing notifications to file after receiving profile-before-change and awaiting all checkpoints written for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2022-07-04T10:48:54.181Z] 10:48:54 INFO - DEBUG: Adding blocker TelemetryController: shutting down for phase profile-before-change-telemetry
[task 2022-07-04T10:48:54.573Z] 10:48:54 INFO - DEBUG: Adding blocker EnvironmentAddonBuilder for phase AddonManager: Waiting to start provider shutdown.
[task 2022-07-04T10:48:54.581Z] 10:48:54 INFO - DEBUG: Adding blocker RemoteSettingsClient - finish IDB access. for phase profile-before-change
[task 2022-07-04T10:48:54.589Z] 10:48:54 INFO - 1656931734589 Marionette INFO Marionette enabled
[task 2022-07-04T10:48:54.595Z] 10:48:54 INFO - 1656931734592 Marionette TRACE Received observer notification final-ui-startup
[task 2022-07-04T10:48:54.600Z] 10:48:54 INFO - 1656931734596 Marionette INFO Listening on port 2828
[task 2022-07-04T10:48:54.604Z] 10:48:54 INFO - 1656931734596 Marionette DEBUG Marionette is listening
[task 2022-07-04T10:48:54.716Z] 10:48:54 INFO - DEBUG: Adding blocker PermissionManager: Flushing data for phase xpcom-will-shutdown
[task 2022-07-04T10:48:54.751Z] 10:48:54 INFO - DEBUG: Completed blocker Update add-on blocklist state into add-on DB for phase AddonManager: Waiting to start provider shutdown.
[task 2022-07-04T10:48:54.782Z] 10:48:54 INFO - 1656931734781 Marionette DEBUG Accepted connection 0 from 127.0.0.1:43718
[task 2022-07-04T10:48:54.790Z] 10:48:54 INFO - DEBUG: Adding blocker ClientManagerService: start destroying IPC actors early for phase xpcom-will-shutdown
[task 2022-07-04T10:48:54.850Z] 10:48:54 INFO - 1656931734849 Marionette DEBUG Closed connection 0
[task 2022-07-04T10:48:54.856Z] 10:48:54 INFO - 1656931734850 Marionette DEBUG Accepted connection 1 from 127.0.0.1:43720
[task 2022-07-04T10:48:54.920Z] 10:48:54 INFO - DEBUG: Adding blocker JSON store: writing data for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2022-07-04T10:48:55.093Z] 10:48:55 INFO - DEBUG: Adding blocker MediaShutdownManager: shutdown for phase profile-before-change
[task 2022-07-04T10:48:55.133Z] 10:48:55 INFO - 1656931735132 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2022-07-04T10:48:55.146Z] 10:48:55 INFO - 1656931735145 Marionette DEBUG Waiting for initial application window
[task 2022-07-04T10:48:55.159Z] 10:48:55 INFO - DEBUG: Adding blocker Remote Settings profile-before-change for phase profile-before-change
[task 2022-07-04T10:48:55.285Z] 10:48:55 INFO - DEBUG: Adding blocker JSON store: writing data for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2022-07-04T10:48:55.294Z] 10:48:55 INFO - DEBUG: Adding blocker ServiceWorkerShutdownBlocker: shutting down Service Workers for phase profile-change-teardown
[task 2022-07-04T10:48:55.302Z] 10:48:55 INFO - DEBUG: Adding blocker ContentParent: id=7fe0443a6800 for phase xpcom-will-shutdown
[task 2022-07-04T10:48:55.302Z] 10:48:55 INFO - DEBUG: Adding blocker ContentParent: id=7fe0443a6800 for phase profile-before-change
[task 2022-07-04T10:48:55.334Z] 10:48:55 INFO - DEBUG: Adding blocker GMPProvider for phase AddonManager: Waiting for providers to shut down.
[task 2022-07-04T10:48:55.596Z] 10:48:55 INFO - DEBUG: Adding blocker ContentParent: id=7fe043273000 for phase xpcom-will-shutdown
[task 2022-07-04T10:48:55.598Z] 10:48:55 INFO - DEBUG: Adding blocker ContentParent: id=7fe043273000 for phase profile-before-change
[task 2022-07-04T10:48:55.992Z] 10:48:55 INFO - DEBUG: Adding blocker UrlbarProviderQuickSuggest: Record impression counters reset telemetry for phase profile-change-teardown
[task 2022-07-04T10:48:56.505Z] 10:48:56 INFO - [CodeCoverage] Setting handlers for process 16137.
[task 2022-07-04T10:48:56.721Z] 10:48:56 INFO - [CodeCoverage] Setting handlers for process 16141.
[task 2022-07-04T10:48:59.299Z] 10:48:59 INFO - DEBUG: Adding blocker PageActions: purging unregistered actions from cache for phase profile-before-change
[task 2022-07-04T10:48:59.318Z] 10:48:59 INFO - DEBUG: Adding blocker Places Clients shutdown for phase profile-change-teardown
[task 2022-07-04T10:48:59.320Z] 10:48:59 INFO - DEBUG: Adding blocker Places Connection shutdown for phase profile-before-change
[task 2022-07-04T10:48:59.352Z] 10:48:59 INFO - DEBUG: Adding blocker sanitize.js: Sanitize on shutdown for phase Places Clients shutdown
[task 2022-07-04T10:48:59.403Z] 10:48:59 INFO - console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmpt3fihdjd.mozrunner/search.json.mozlz4", (void 0)))
[task 2022-07-04T10:48:59.547Z] 10:48:59 INFO - DEBUG: Adding blocker Sqlite.jsm shutdown blocker for phase profile-before-change
[task 2022-07-04T10:48:59.548Z] 10:48:59 INFO - DEBUG: Adding blocker content-prefs.sqlite#0: waiting for shutdown for phase Sqlite.jsm: wait until all connections are closed
[task 2022-07-04T10:48:59.550Z] 10:48:59 INFO - DEBUG: Adding blocker Closing ContentPrefService2 connection. for phase Sqlite.jsm: wait until all clients have completed their task
[task 2022-07-04T10:48:59.640Z] 10:48:59 INFO - DEBUG: Adding blocker Transaction (0) for phase content-prefs.sqlite#0: waiting for clients
[task 2022-07-04T10:48:59.754Z] 10:48:59 INFO - DEBUG: Completed blocker Transaction (0) for phase content-prefs.sqlite#0: waiting for clients
[task 2022-07-04T10:48:59.757Z] 10:48:59 INFO - DEBUG: Adding blocker Transaction (1) for phase content-prefs.sqlite#0: waiting for clients
[task 2022-07-04T10:48:59.758Z] 10:48:59 INFO - DEBUG: Adding blocker Transaction (2) for phase content-prefs.sqlite#0: waiting for clients
[task 2022-07-04T10:48:59.760Z] 10:48:59 INFO - DEBUG: Completed blocker Transaction (1) for phase content-prefs.sqlite#0: waiting for clients
[task 2022-07-04T10:48:59.765Z] 10:48:59 INFO - DEBUG: Completed blocker Transaction (2) for phase content-prefs.sqlite#0: waiting for clients
[task 2022-07-04T10:49:00.392Z] 10:49:00 INFO - DEBUG: Adding blocker ContentParent: id=7fe0386b1400 for phase xpcom-will-shutdown
[task 2022-07-04T10:49:00.395Z] 10:49:00 INFO - DEBUG: Adding blocker ContentParent: id=7fe0386b1400 for phase profile-before-change
[task 2022-07-04T10:49:00.496Z] 10:49:00 INFO - DEBUG: Adding blocker Search service: shutting down for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2022-07-04T10:49:00.589Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: waiting for shutdown for phase Sqlite.jsm: wait until all connections are closed
[task 2022-07-04T10:49:00.591Z] 10:49:00 INFO - DEBUG: Adding blocker Places Expiration: shutdown for phase Places Connection shutdown
[task 2022-07-04T10:49:00.597Z] 10:49:00 INFO - DEBUG: Adding blocker PlacesUtils wrapped connection closing as part of Places shutdown for phase Places Connection shutdown
[task 2022-07-04T10:49:00.598Z] 10:49:00 INFO - DEBUG: Adding blocker PlacesUtils wrapped connection must be closed before Sqlite.jsm for phase Sqlite.jsm: wait until all clients have completed their task
[task 2022-07-04T10:49:00.600Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: PlacesExpiration.jsm: setup (0) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.609Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#0: waiting for shutdown for phase Sqlite.jsm: wait until all connections are closed
[task 2022-07-04T10:49:00.612Z] 10:49:00 INFO - DEBUG: Adding blocker PlacesUtils read-only connection closing as part of Places shutdown for phase Places Connection shutdown
[task 2022-07-04T10:49:00.629Z] 10:49:00 INFO - DEBUG: Adding blocker PlacesUtils read-only connection must be closed before Sqlite.jsm for phase Sqlite.jsm: wait until all clients have completed their task
[task 2022-07-04T10:49:00.639Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: PlacesExpiration.jsm: setup (0) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.689Z] 10:49:00 INFO - DEBUG: Adding blocker ContextualIdentityService: writing data for phase profile-before-change
[task 2022-07-04T10:49:00.702Z] 10:49:00 INFO - DEBUG: Adding blocker Transaction (1) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.704Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: eraseEverything (2) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.726Z] 10:49:00 INFO - DEBUG: Completed blocker Transaction (1) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.733Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: eraseEverything (2) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.735Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: fetchBookmark (3) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.738Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: fetchBookmark (3) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.740Z] 10:49:00 INFO - DEBUG: Adding blocker Transaction (4) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.741Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: insertBookmarkTree (5) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.756Z] 10:49:00 INFO - DEBUG: Completed blocker Transaction (4) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.758Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: insertBookmarkTree (5) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.759Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: GuidHelper.getItemId (6) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.777Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: GuidHelper.getItemId (6) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.779Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: PlacesUtils.keywords.insert (7) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.781Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: PlacesUtils: promiseKeywordsCache (8) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.783Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: PlacesUtils: promiseKeywordsCache (8) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.784Z] 10:49:00 INFO - DEBUG: Adding blocker Transaction (9) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.790Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: fetchBookmarksByURL (10) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.791Z] 10:49:00 INFO - DEBUG: Completed blocker Transaction (9) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.794Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: fetchBookmarksByURL (10) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.795Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: PlacesUtils.keywords.insert (7) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.796Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: PlacesUtils.keywords.insert (11) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.797Z] 10:49:00 INFO - DEBUG: Adding blocker Transaction (12) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.802Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: fetchBookmarksByURL (13) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.804Z] 10:49:00 INFO - DEBUG: Completed blocker Transaction (12) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.805Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: fetchBookmarksByURL (13) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.807Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: PlacesUtils.keywords.insert (11) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.823Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: fetchBookmark (14) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.825Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: fetchBookmark (14) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.827Z] 10:49:00 INFO - DEBUG: Adding blocker Transaction (15) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.828Z] 10:49:00 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: insertBookmarkTree (16) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.885Z] 10:49:00 INFO - DEBUG: Completed blocker Transaction (15) for phase places.sqlite#1: waiting for clients
[task 2022-07-04T10:49:00.886Z] 10:49:00 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: insertBookmarkTree (16) for phase places.sqlite#1: waiting for clients
|
||
Comment 1•3 years ago
|
||
The failure here is from a CCOV build and most likely comes from waiting for the initial navigation of the tab to finish. After around 6 minutes Marionette assumes the browser hangs and kills it.
Summary: Intermittent [tier 2] testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py TestQuitRestart.test_in_app_quit_with_dismissed_beforeunload_prompt | OSError: Process has been unexpectedly closed (Exit code: -15) (Reason: Process kill → Intermittent [tier 2] CCOV testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py TestQuitRestart.test_in_app_quit_with_dismissed_beforeunload_prompt | OSError: Process has been unexpectedly closed (Exit code: -15) [initial load]
|
||
Comment 2•3 years ago
•
|
||
First occurrence in this backfill range and retriggers: https://treeherder.mozilla.org/jobs?repo=mozilla-central&group_state=expanded&resultStatus=retry%2Ctestfailed%2Cbusted%2Cexception%2Csuccess%2Crunning%2Cpending%2Crunnable&tochange=f7c192231f501313a03d2a4c0b687de699abb306&fromchange=bf25f538f4ff086f65958fb77b5c04f890df4398&searchStr=linux%2C18.04%2Cx64%2Cccov%2Cwebrender%2Copt%2Ctest-linux1804-64-ccov-qr%2Fopt-marionette%2Cmn&selectedTaskRun=IV6L89QfRIGN3UcLPIBWtA.0
Whiteboard: [retriggered]
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 4•3 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
|
|
||
Comment 5•3 years ago
|
||
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Summary: Intermittent [tier 2] CCOV testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py TestQuitRestart.test_in_app_quit_with_dismissed_beforeunload_prompt | OSError: Process has been unexpectedly closed (Exit code: -15) [initial load] → Intermittent [tier 2] CCOV testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py <test-name> | OSError: Process has been unexpectedly closed (Exit code: -15) [initial load]
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 8•3 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: REOPENED → RESOLVED
Closed: 3 years ago → 3 years ago
Resolution: --- → INCOMPLETE
|
||
Updated•3 years ago
|
Product: Testing → Remote Protocol
|
|
||
Comment 9•3 years ago
|
||
Moving bug to Testing::Marionette Client and Harness component per bug 1815831.
Component: Marionette → Marionette Client and Harness
Product: Remote Protocol → Testing
|
Reporter | |
Comment 10•3 years ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=412152710&repo=mozilla-central
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 12•2 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: REOPENED → RESOLVED
Closed: 3 years ago → 2 years ago
Resolution: --- → INCOMPLETE
|
|
Reporter | |
Comment 13•2 years ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=444244872&repo=mozilla-central
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
|
|
||
Comment 14•2 years ago
|
||
(In reply to Treeherder Bug Filer from comment #13)
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=444244872&repo=mozilla-central
This is actually bug 1816223.
Status: REOPENED → RESOLVED
Closed: 2 years ago → 2 years ago
Resolution: --- → WORKSFORME
You need to log in
before you can comment on or make changes to this bug.
Description
•