Closed
Bug 1700711
Opened 4 years ago
Closed 3 years ago
Intermittent Win ccov testing/marionette/harness/marionette_harness/tests/unit/test_crash.py TestCrash.test_crash_content_process | AssertionError: "Content process crashed" does not match "Process crashed (Exit code: 3221225477) (Reason: [WinError 10053]
Categories
(Testing :: Marionette Client and Harness, defect, P5)
Testing
Marionette Client and Harness
Tracking
(Not tracked)
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: assertion, intermittent-failure)
Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=334313730&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/THBcN8xOTiuI8iYu1VnkRw/runs/0/artifacts/public/logs/live_backing.log
[task 2021-03-24T18:27:06.721Z] 18:27:06 INFO - TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_profile_management.py TestSwitchProfileWithoutWorkspace.test_new_named_profile_unicode
[task 2021-03-24T18:27:06.722Z] 18:27:06 INFO - 1616610426722 Marionette DEBUG Accepted connection 2 from 127.0.0.1:52033
[task 2021-03-24T18:27:06.724Z] 18:27:06 INFO - 1616610426724 Marionette DEBUG 2 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2021-03-24T18:27:06.728Z] 18:27:06 INFO - 1616610426727 Marionette DEBUG 2 <- [1,1,null,{"sessionId":"93752949-24e5-48cd-99d4-2396af0db054","capabilities":{"browserName":"firefox","browserVersion":"89.0a ... mp\\tmpujdvuj8v.foobar","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
[task 2021-03-24T18:27:06.729Z] 18:27:06 INFO - 1616610426729 Marionette DEBUG 2 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2021-03-24T18:27:06.731Z] 18:27:06 INFO - 1616610426731 Marionette DEBUG 2 <- [1,2,null,{"value":null}]
[task 2021-03-24T18:27:06.732Z] 18:27:06 INFO - 1616610426732 Marionette DEBUG 2 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2021-03-24T18:27:06.733Z] 18:27:06 INFO - 1616610426733 Marionette DEBUG 2 <- [1,3,null,{"value":null}]
[task 2021-03-24T18:27:06.735Z] 18:27:06 INFO - 1616610426735 Marionette DEBUG 2 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2021-03-24T18:27:06.736Z] 18:27:06 INFO - 1616610426736 Marionette DEBUG 2 <- [1,4,null,{"value":null}]
[task 2021-03-24T18:27:06.868Z] 18:27:06 INFO - mozlog.structuredlog: Failure calling log handler:
[task 2021-03-24T18:27:06.870Z] 18:27:06 INFO - Traceback (most recent call last):
[task 2021-03-24T18:27:06.870Z] 18:27:06 INFO - File "C:\Users\task_1616609673\build\venv\lib\site-packages\mozlog\structuredlog.py", line 294, in _handle_log
[task 2021-03-24T18:27:06.870Z] 18:27:06 INFO - handler(data)
[task 2021-03-24T18:27:06.871Z] 18:27:06 INFO - File "C:\Users\task_1616609673\build\venv\lib\site-packages\mozlog\handlers\base.py", line 90, in __call__
[task 2021-03-24T18:27:06.871Z] 18:27:06 INFO - self.stream.write(formatted)
[task 2021-03-24T18:27:06.871Z] 18:27:06 INFO - File "c:\mozilla-build\python3\lib\encodings\cp1252.py", line 19, in encode
[task 2021-03-24T18:27:06.872Z] 18:27:06 INFO - return codecs.charmap_encode(input,self.errors,encoding_table)[0]
[task 2021-03-24T18:27:06.872Z] 18:27:06 INFO - UnicodeEncodeError: 'charmap' codec can't encode character '\U0001f36a' in position 194: character maps to <undefined>
[task 2021-03-24T18:27:07.249Z] 18:27:07 INFO - DEBUG: Adding blocker OS.File: flush pending requests, warn about unclosed files, shut down service. for phase xpcom-will-shutdown
[task 2021-03-24T18:27:07.252Z] 18:27:07 INFO - DEBUG: Adding blocker OS.File: flush I/O queued before profileBeforeChange for phase profile-before-change
[task 2021-03-24T18:27:07.257Z] 18:27:07 INFO - DEBUG: Adding blocker AddonManager: shutting down. for phase profile-before-change
[task 2021-03-24T18:27:07.389Z] 18:27:07 INFO - DEBUG: Adding blocker IOUtils Blocker (profile-before-change) for phase profile-before-change
[task 2021-03-24T18:27:07.390Z] 18:27:07 INFO - DEBUG: Adding blocker IOUtils Blocker (xpcom-will-shutdown) for phase xpcom-will-shutdown
[task 2021-03-24T18:27:07.408Z] 18:27:07 INFO - DEBUG: Adding blocker Flush WebExtension StartupCache for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2021-03-24T18:27:07.633Z] 18:27:07 INFO - DEBUG: Adding blocker ClientManagerService: start destroying IPC actors early for phase xpcom-will-shutdown
[task 2021-03-24T18:27:07.805Z] 18:27:07 INFO - DEBUG: Adding blocker JSON store: writing data for phase AddonManager: Waiting for providers to shut down.
[task 2021-03-24T18:27:07.814Z] 18:27:07 INFO - DEBUG: Adding blocker Update add-on blocklist state into add-on DB for phase AddonManager: Waiting to start provider shutdown.
[task 2021-03-24T18:27:07.816Z] 18:27:07 INFO - DEBUG: Completed blocker Update add-on blocklist state into add-on DB for phase AddonManager: Waiting to start provider shutdown.
[task 2021-03-24T18:27:07.836Z] 18:27:07 INFO - DEBUG: Adding blocker XPIProvider shutdown for phase quit-application-granted
[task 2021-03-24T18:27:07.840Z] 18:27:07 INFO - DEBUG: Adding blocker XPIProvider for phase AddonManager: Waiting for providers to shut down.
[task 2021-03-24T18:27:07.841Z] 18:27:07 INFO - DEBUG: Adding blocker PluginProvider for phase AddonManager: Waiting for providers to shut down.
[task 2021-03-24T18:27:07.842Z] 18:27:07 INFO - DEBUG: Adding blocker ServiceWorkerRegistrar: Flushing data for phase profile-before-change
[task 2021-03-24T18:27:07.846Z] 18:27:07 INFO - DEBUG: Adding blocker CrashMonitor: Writing notifications to file after receiving profile-before-change for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2021-03-24T18:27:07.898Z] 18:27:07 INFO - DEBUG: Adding blocker TelemetryController: shutting down for phase profile-before-change-telemetry
[task 2021-03-24T18:27:07.944Z] 18:27:07 INFO - DEBUG: Adding blocker EnvironmentAddonBuilder for phase AddonManager: Waiting to start provider shutdown.
[task 2021-03-24T18:27:07.971Z] 18:27:07 INFO - DEBUG: Adding blocker RemoteSettingsClient - finish IDB access. for phase profile-before-change
[task 2021-03-24T18:27:07.982Z] 18:27:07 INFO - 1616610427981 Marionette INFO Marionette enabled
[task 2021-03-24T18:27:08.149Z] 18:27:08 INFO - 1616610428148 Marionette TRACE Received observer notification toplevel-window-ready
[task 2021-03-24T18:27:08.680Z] 18:27:08 INFO - DEBUG: Adding blocker MediaShutdownManager: shutdown for phase profile-before-change
[task 2021-03-24T18:27:08.739Z] 18:27:08 INFO - DEBUG: Adding blocker JSON store: writing data for phase profile-before-change
[task 2021-03-24T18:27:08.746Z] 18:27:08 INFO - DEBUG: Adding blocker Remote Settings profile-before-change for phase profile-before-change
[task 2021-03-24T18:27:08.758Z] 18:27:08 INFO - DEBUG: Adding blocker JSON store: writing data for phase profile-before-change
[task 2021-03-24T18:27:08.976Z] 18:27:08 INFO - DEBUG: Adding blocker GMPProvider for phase AddonManager: Waiting for providers to shut down.
[task 2021-03-24T18:27:08.983Z] 18:27:08 INFO - DEBUG: Adding blocker ContentParent: id=24fa251e800 for phase xpcom-will-shutdown
[task 2021-03-24T18:27:08.984Z] 18:27:08 INFO - DEBUG: Adding blocker ContentParent: id=24fa251e800 for phase profile-before-change
[task 2021-03-24T18:27:09.168Z] 18:27:09 INFO - DEBUG: Adding blocker ServiceWorkerShutdownBlocker: shutting down Service Workers for phase profile-change-teardown
[task 2021-03-24T18:27:09.193Z] 18:27:09 INFO - DEBUG: Adding blocker ContentParent: id=24fa2e42000 for phase xpcom-will-shutdown
[task 2021-03-24T18:27:09.194Z] 18:27:09 INFO - DEBUG: Adding blocker ContentParent: id=24fa2e42000 for phase profile-before-change
[task 2021-03-24T18:27:09.979Z] 18:27:09 INFO - DEBUG: Adding blocker ContentParent: id=24fa3f13800 for phase xpcom-will-shutdown
[task 2021-03-24T18:27:09.979Z] 18:27:09 INFO - DEBUG: Adding blocker ContentParent: id=24fa3f13800 for phase profile-before-change
[task 2021-03-24T18:27:10.274Z] 18:27:10 INFO - DEBUG: Adding blocker PageActions: purging unregistered actions from cache for phase profile-before-change
[task 2021-03-24T18:27:10.299Z] 18:27:10 INFO - DEBUG: Adding blocker Places Clients shutdown for phase profile-change-teardown
[task 2021-03-24T18:27:10.299Z] 18:27:10 INFO - DEBUG: Adding blocker Places Connection shutdown for phase profile-before-change
[task 2021-03-24T18:27:10.359Z] 18:27:10 INFO - DEBUG: Adding blocker sanitize.js: Sanitize on shutdown for phase Places Clients shutdown
[task 2021-03-24T18:27:10.464Z] 18:27:10 INFO - console.warn: SearchSettings: "get: No settings file exists, new profile?" (new Error("", "(unknown module)"))
[task 2021-03-24T18:27:10.514Z] 18:27:10 INFO - DEBUG: Adding blocker Sqlite.jsm shutdown blocker for phase profile-before-change
[task 2021-03-24T18:27:10.515Z] 18:27:10 INFO - DEBUG: Adding blocker content-prefs.sqlite#0: waiting for shutdown for phase Sqlite.jsm: wait until all connections are closed
[task 2021-03-24T18:27:10.515Z] 18:27:10 INFO - DEBUG: Adding blocker Closing ContentPrefService2 connection. for phase Sqlite.jsm: wait until all clients have completed their task
[task 2021-03-24T18:27:10.538Z] 18:27:10 INFO - DEBUG: Adding blocker Transaction (0) for phase content-prefs.sqlite#0: waiting for clients
[task 2021-03-24T18:27:10.554Z] 18:27:10 INFO - DEBUG: Adding blocker JSON store: writing data for phase profile-before-change
[task 2021-03-24T18:27:10.639Z] 18:27:10 INFO - DEBUG: Adding blocker DoHController: clear state and remove observers for phase profile-before-change
[task 2021-03-24T18:27:10.695Z] 18:27:10 INFO - DEBUG: Adding blocker DownloadAutoSaveView: writing data for phase profile-before-change
[task 2021-03-24T18:27:10.790Z] 18:27:10 INFO - DEBUG: Adding blocker places.sqlite#1: waiting for shutdown for phase Sqlite.jsm: wait until all connections are closed
[task 2021-03-24T18:27:10.791Z] 18:27:10 INFO - DEBUG: Adding blocker Places Expiration: shutdown for phase Places Connection shutdown
[task 2021-03-24T18:27:10.796Z] 18:27:10 INFO - DEBUG: Adding blocker PlacesUtils wrapped connection closing as part of Places shutdown for phase Places Connection shutdown
[task 2021-03-24T18:27:10.796Z] 18:27:10 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 2021-03-24T18:27:10.797Z] 18:27:10 INFO - DEBUG: Adding blocker places.sqlite#1: PlacesExpiration.jsm: setup (0) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:10.803Z] 18:27:10 INFO - DEBUG: Adding blocker places.sqlite#0: waiting for shutdown for phase Sqlite.jsm: wait until all connections are closed
[task 2021-03-24T18:27:10.803Z] 18:27:10 INFO - DEBUG: Adding blocker PlacesUtils read-only connection closing as part of Places shutdown for phase Places Connection shutdown
[task 2021-03-24T18:27:10.804Z] 18:27:10 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 2021-03-24T18:27:10.818Z] 18:27:10 INFO - DEBUG: Completed blocker places.sqlite#1: PlacesExpiration.jsm: setup (0) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:10.862Z] 18:27:10 INFO - DEBUG: Completed blocker Transaction (0) for phase content-prefs.sqlite#0: waiting for clients
[task 2021-03-24T18:27:10.864Z] 18:27:10 INFO - DEBUG: Adding blocker Transaction (1) for phase content-prefs.sqlite#0: waiting for clients
[task 2021-03-24T18:27:10.865Z] 18:27:10 INFO - DEBUG: Adding blocker Transaction (2) for phase content-prefs.sqlite#0: waiting for clients
[task 2021-03-24T18:27:10.907Z] 18:27:10 INFO - DEBUG: Adding blocker Transaction (1) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:10.908Z] 18:27:10 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: eraseEverything (2) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:10.909Z] 18:27:10 INFO - DEBUG: Completed blocker Transaction (1) for phase content-prefs.sqlite#0: waiting for clients
[task 2021-03-24T18:27:10.937Z] 18:27:10 INFO - DEBUG: Completed blocker Transaction (2) for phase content-prefs.sqlite#0: waiting for clients
[task 2021-03-24T18:27:10.983Z] 18:27:10 INFO - DEBUG: Completed blocker Transaction (1) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:10.989Z] 18:27:10 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: eraseEverything (2) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:10.989Z] 18:27:10 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: fetchBookmark (3) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:10.992Z] 18:27:10 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: fetchBookmark (3) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:10.992Z] 18:27:10 INFO - DEBUG: Adding blocker Transaction (4) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:10.992Z] 18:27:10 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: insertBookmarkTree (5) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.036Z] 18:27:11 INFO - DEBUG: Completed blocker Transaction (4) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.036Z] 18:27:11 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: insertBookmarkTree (5) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.037Z] 18:27:11 INFO - DEBUG: Adding blocker places.sqlite#1: GuidHelper.getItemId (6) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.041Z] 18:27:11 INFO - DEBUG: Completed blocker places.sqlite#1: GuidHelper.getItemId (6) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.042Z] 18:27:11 INFO - DEBUG: Adding blocker places.sqlite#1: PlacesUtils.keywords.insert (7) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.043Z] 18:27:11 INFO - DEBUG: Adding blocker places.sqlite#1: PlacesUtils: promiseKeywordsCache (8) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.045Z] 18:27:11 INFO - DEBUG: Completed blocker places.sqlite#1: PlacesUtils: promiseKeywordsCache (8) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.046Z] 18:27:11 INFO - DEBUG: Adding blocker Transaction (9) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.148Z] 18:27:11 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: fetchBookmarksByURL (10) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.149Z] 18:27:11 INFO - DEBUG: Completed blocker Transaction (9) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.160Z] 18:27:11 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: fetchBookmarksByURL (10) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.161Z] 18:27:11 INFO - DEBUG: Completed blocker places.sqlite#1: PlacesUtils.keywords.insert (7) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.162Z] 18:27:11 INFO - DEBUG: Adding blocker places.sqlite#1: PlacesUtils.keywords.insert (11) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.162Z] 18:27:11 INFO - DEBUG: Adding blocker Transaction (12) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.188Z] 18:27:11 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: fetchBookmarksByURL (13) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.189Z] 18:27:11 INFO - DEBUG: Completed blocker Transaction (12) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.191Z] 18:27:11 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: fetchBookmarksByURL (13) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.191Z] 18:27:11 INFO - DEBUG: Completed blocker places.sqlite#1: PlacesUtils.keywords.insert (11) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.197Z] 18:27:11 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: fetchBookmark (14) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.221Z] 18:27:11 INFO - DEBUG: Adding blocker Search service: shutting down for phase OS.File: Waiting for clients before profileBeforeChange
[task 2021-03-24T18:27:11.234Z] 18:27:11 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: fetchBookmark (14) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.234Z] 18:27:11 INFO - DEBUG: Adding blocker Transaction (15) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.234Z] 18:27:11 INFO - DEBUG: Adding blocker places.sqlite#1: Bookmarks.jsm: insertBookmarkTree (16) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.297Z] 18:27:11 INFO - DEBUG: Completed blocker Transaction (15) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.297Z] 18:27:11 INFO - DEBUG: Completed blocker places.sqlite#1: Bookmarks.jsm: insertBookmarkTree (16) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.298Z] 18:27:11 INFO - DEBUG: Adding blocker places.sqlite#1: GuidHelper.getItemId (17) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.300Z] 18:27:11 INFO - DEBUG: Adding blocker ContextualIdentityService: writing data for phase profile-before-change
[task 2021-03-24T18:27:11.303Z] 18:27:11 INFO - DEBUG: Completed blocker places.sqlite#1: GuidHelper.getItemId (17) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.379Z] 18:27:11 INFO - DEBUG: Adding blocker JSON store: writing data for phase profile-before-change
[task 2021-03-24T18:27:11.417Z] 18:27:11 INFO - DEBUG: Adding blocker JSON store: writing data for phase profile-before-change
[task 2021-03-24T18:27:11.519Z] 18:27:11 INFO - DEBUG: Adding blocker places.sqlite#1: PlacesUIUtils: maybeAddImportButton (18) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.520Z] 18:27:11 INFO - DEBUG: Completed blocker places.sqlite#1: PlacesUIUtils: maybeAddImportButton (18) for phase places.sqlite#1: waiting for clients
[task 2021-03-24T18:27:11.688Z] 18:27:11 INFO - 1616610431688 Marionette TRACE Received observer notification marionette-startup-requested
[task 2021-03-24T18:27:11.689Z] 18:27:11 INFO - 1616610431689 Marionette TRACE Waiting until startup recorder finished recording startup scripts...
[task 2021-03-24T18:27:11.729Z] 18:27:11 INFO - 1616610431729 Marionette TRACE All scripts recorded.
[task 2021-03-24T18:27:11.733Z] 18:27:11 INFO - 1616610431733 Marionette INFO Listening on port 2828
[task 2021-03-24T18:27:11.734Z] 18:27:11 INFO - 1616610431734 Marionette DEBUG Marionette is listening
[task 2021-03-24T18:27:11.873Z] 18:27:11 INFO - DEBUG: Adding blocker ScriptPreloader: Saving bytecode cache for phase xpcom-will-shutdown
[task 2021-03-24T18:27:12.316Z] 18:27:12 INFO - 1616610432316 Marionette DEBUG Accepted connection 0 from 127.0.0.1:52075
[task 2021-03-24T18:27:12.321Z] 18:27:12 INFO - 1616610432321 Marionette DEBUG Closed connection 0
[task 2021-03-24T18:27:12.322Z] 18:27:12 INFO - 1616610432322 Marionette DEBUG Accepted connection 1 from 127.0.0.1:52076
[task 2021-03-24T18:27:12.339Z] 18:27:12 INFO - 1616610432339 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2021-03-24T18:27:12.374Z] 18:27:12 INFO - 1616610432374 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"513b16e6-0815-4dae-a61b-4a6f9d685404","capabilities":{"browserName":"firefox","browserVersion":"89.0a ... emp\\tmp4mggtopb.$\U0001f36a","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
[task 2021-03-24T18:27:12.398Z] 18:27:12 INFO - 1616610432398 Marionette DEBUG 1 -> [0,2,"WebDriver:DeleteSession",{}]
[task 2021-03-24T18:27:12.405Z] 18:27:12 INFO - 1616610432405 Marionette DEBUG 1 <- [1,2,null,{"value":null}]
[task 2021-03-24T18:27:12.407Z] 18:27:12 INFO - TEST-PASS | testing/marionette/harness/marionette_harness/tests/unit/test_profile_management.py TestSwitchProfileWithoutWorkspace.test_new_named_profile_unicode | took 5686ms
[task 2021-03-24T18:27:12.407Z] 18:27:12 INFO - 1616610432407 Marionette DEBUG Closed connection 1
[task 2021-03-24T18:27:12.408Z] 18:27:12 INFO - TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_profile_management.py TestSwitchProfileWithoutWorkspace.test_new_named_profile_unicode_escape_characters
[task 2021-03-24T18:27:12.409Z] 18:27:12 INFO - 1616610432409 Marionette DEBUG Accepted connection 2 from 127.0.0.1:52077
[task 2021-03-24T18:27:12.410Z] 18:27:12 INFO - 1616610432411 Marionette DEBUG 2 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2021-03-24T18:27:12.415Z] 18:27:12 INFO - 1616610432414 Marionette DEBUG 2 <- [1,1,null,{"sessionId":"2c3bd9a0-1348-4f19-9e3a-ee5b23b79718","capabilities":{"browserName":"firefox","browserVersion":"89.0a ... emp\\tmp4mggtopb.$\U0001f36a","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
[task 2021-03-24T18:27:12.417Z] 18:27:12 INFO - 1616610432417 Marionette DEBUG 2 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2021-03-24T18:27:12.418Z] 18:27:12 INFO - 1616610432418 Marionette DEBUG 2 <- [1,2,null,{"value":null}]
[task 2021-03-24T18:27:12.419Z] 18:27:12 INFO - 1616610432419 Marionette DEBUG 2 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2021-03-24T18:27:12.420Z] 18:27:12 INFO - 1616610432420 Marionette DEBUG 2 <- [1,3,null,{"value":null}]
[task 2021-03-24T18:27:12.422Z] 18:27:12 INFO - 1616610432422 Marionette DEBUG 2 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2021-03-24T18:27:12.423Z] 18:27:12 INFO - 1616610432423 Marionette DEBUG 2 <- [1,4,null,{"value":null}]
[task 2021-03-24T18:27:12.540Z] 18:27:12 INFO - mozlog.structuredlog: Failure calling log handler:
[task 2021-03-24T18:27:12.540Z] 18:27:12 INFO - Traceback (most recent call last):
[task 2021-03-24T18:27:12.540Z] 18:27:12 INFO - File "C:\Users\task_1616609673\build\venv\lib\site-packages\mozlog\structuredlog.py", line 294, in _handle_log
[task 2021-03-24T18:27:12.541Z] 18:27:12 INFO - handler(data)
[task 2021-03-24T18:27:12.541Z] 18:27:12 INFO - File "C:\Users\task_1616609673\build\venv\lib\site-packages\mozlog\handlers\base.py", line 90, in __call__
[task 2021-03-24T18:27:12.541Z] 18:27:12 INFO - self.stream.write(formatted)
[task 2021-03-24T18:27:12.542Z] 18:27:12 INFO - File "c:\mozilla-build\python3\lib\encodings\cp1252.py", line 19, in encode
[task 2021-03-24T18:27:12.542Z] 18:27:12 INFO - return codecs.charmap_encode(input,self.errors,encoding_table)[0]
[task 2021-03-24T18:27:12.542Z] 18:27:12 INFO - UnicodeEncodeError: 'charmap' codec can't encode character '\u1f36' in position 194: character maps to <undefined>```
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 7•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 hidden (Intermittent Failures Robot) |
Updated•2 years ago
|
Product: Testing → Remote Protocol
Comment 9•2 years ago
|
||
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.
Description
•