Closed
Bug 1887345
Opened 2 years ago
Closed 1 year ago
Intermittent toolkit/xre/test/marionette/test_exitcode.py TestFissionAutostart.test_normal_exit | single tracking bug
Categories
(Toolkit :: Startup and Profile System, defect, P5)
Toolkit
Startup and Profile System
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure, intermittent-testcase)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=452018829&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Fff9qjdwQS6gWp9XTv6_2w/runs/0/artifacts/public/logs/live_backing.log
[task 2024-03-23T16:40:46.855Z] 16:40:46 INFO - TEST-START | toolkit/xre/test/marionette/test_exitcode.py TestFissionAutostart.test_normal_exit
[task 2024-03-23T16:40:46.857Z] 16:40:46 INFO - 1711212046857 Marionette DEBUG Accepted connection 3 from 127.0.0.1:57043
[task 2024-03-23T16:40:46.866Z] 16:40:46 INFO - 1711212046865 Marionette DEBUG 3 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2024-03-23T16:40:46.867Z] 16:40:46 INFO - 1711212046867 Marionette DEBUG Waiting for initial application window
[task 2024-03-23T16:40:46.868Z] 16:40:46 INFO - 1711212046868 RemoteAgent TRACE [3] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=40000 waitForExplicitStart=false
[task 2024-03-23T16:40:46.869Z] 16:40:46 INFO - 1711212046868 RemoteAgent TRACE [3] ProgressListener Setting unload timer (40000ms)
[task 2024-03-23T16:40:46.869Z] 16:40:46 INFO - 1711212046869 RemoteAgent TRACE [3] Document already finished loading: about:blank
[task 2024-03-23T16:40:46.869Z] 16:40:46 INFO - 1711212046869 RemoteAgent TRACE [3] ProgressListener Stop: has error=false
[task 2024-03-23T16:40:46.874Z] 16:40:46 INFO - 1711212046873 Marionette DEBUG 3 <- [1,1,null,{"sessionId":"62a95510-6356-4cb9-94d8-1390bb6b2dec","capabilities":{"browserName":"firefox","browserVersion":"126.0a1","platformName":"windows","acceptInsecureCerts":false,"pageLoadStrategy":"normal","setWindowRect":true,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"strictFileInteractability":true,"unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:126.0) Gecko/20100101 Firefox/126.0","moz:accessibilityChecks":false,"moz:buildID":"20240323151659","moz:headless":false,"moz:platformVersion":"10.0","moz:processID":4756,"moz:profile":"C:\\Users\\task_171120759233918\\AppData\\Local\\Temp\\tmp6euksmsr.mozrunner","moz:shutdownTimeout":60000,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2024-03-23T16:40:46.878Z] 16:40:46 INFO - 1711212046878 Marionette DEBUG 3 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2024-03-23T16:40:46.879Z] 16:40:46 INFO - 1711212046880 Marionette DEBUG 3 <- [1,2,null,{"value":null}]
[task 2024-03-23T16:40:46.881Z] 16:40:46 INFO - 1711212046881 Marionette DEBUG 3 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2024-03-23T16:40:46.883Z] 16:40:46 INFO - 1711212046883 Marionette DEBUG 3 <- [1,3,null,{"value":null}]
[task 2024-03-23T16:40:46.885Z] 16:40:46 INFO - 1711212046884 Marionette DEBUG 3 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2024-03-23T16:40:46.886Z] 16:40:46 INFO - 1711212046885 Marionette DEBUG 3 <- [1,4,null,{"value":null}]
[task 2024-03-23T16:40:46.889Z] 16:40:46 INFO - 1711212046889 Marionette DEBUG 3 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-03-23T16:40:46.889Z] 16:40:46 INFO - 1711212046889 Marionette DEBUG 3 <- [1,5,null,{"value":null}]
[task 2024-03-23T16:40:46.942Z] 16:40:46 INFO - 1711212046947 Marionette DEBUG 3 -> [0,6,"Marionette:AcceptConnections",{"value":false}]
[task 2024-03-23T16:40:46.948Z] 16:40:46 INFO - 1711212046948 Marionette INFO Stopped listening on port 2828
[task 2024-03-23T16:40:46.965Z] 16:40:46 INFO - 1711212046972 Marionette DEBUG 3 <- [1,6,null,{"value":null}]
[task 2024-03-23T16:40:47.043Z] 16:40:47 INFO - 1711212047049 Marionette DEBUG 3 -> [0,7,"WebDriver:ExecuteScript",{"script":"Services.startup.quit(Ci.nsIAppStartup.eAttemptQuit);","args":[],"newSandbox":true,"sandbox":"system","line":9,"filename":"Z:\\task_171120759233918\\build\\tests\\marionette\\tests\\toolkit\\xre\\test\\marionette\\test_exitcode.py"}]
[task 2024-03-23T16:40:47.058Z] 16:40:47 INFO - 1711212047058 RemoteAgent TRACE WebDriverProcessData actor created for PID 4756
[task 2024-03-23T16:40:47.059Z] 16:40:47 INFO - 1711212047059 Marionette TRACE [1] MarionetteCommands actor created for window id 2
[task 2024-03-23T16:40:47.215Z] 16:40:47 INFO - [Child 1492, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2024-03-23T16:40:47.227Z] 16:40:47 INFO - [Child 1492, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2024-03-23T16:40:47.238Z] 16:40:47 INFO - [Child 1492, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2024-03-23T16:40:47.244Z] 16:40:47 INFO - [Child 1492, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2024-03-23T16:40:47.245Z] 16:40:47 INFO - [Child 1492, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2024-03-23T16:40:47.245Z] 16:40:47 INFO - [Child 1492, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2024-03-23T16:40:47.248Z] 16:40:47 INFO - [Child 1492, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2024-03-23T16:40:47.262Z] 16:40:47 INFO - [Parent 4756, Main Thread] WARNING: WebProgress Ignored: BrowsingContext is null or discarded: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3119
[task 2024-03-23T16:40:47.341Z] 16:40:47 INFO - [GPU 3432, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:395
[task 2024-03-23T16:40:47.356Z] 16:40:47 INFO - 1711212047356 Marionette TRACE Received observer notification quit-application
[task 2024-03-23T16:40:47.357Z] 16:40:47 INFO - 1711212047357 Marionette DEBUG Marionette stopped listening
[task 2024-03-23T16:40:47.359Z] 16:40:47 INFO - [Parent 4756, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (MarionetteCommands, MarionetteCommandsParent:executeScript) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2024-03-23T16:40:47.365Z] 16:40:47 INFO - 1711212047365 Marionette TRACE [1] Querying "executeScript" failed with AbortError, returning "null" as fallback
[task 2024-03-23T16:40:47.365Z] 16:40:47 INFO - 1711212047365 Marionette DEBUG 3 <- [1,7,null,{"value":null}]
[task 2024-03-23T16:40:47.369Z] 16:40:47 INFO - 1711212047369 Marionette TRACE [1] MarionetteCommands actor destroyed for window id 2
[task 2024-03-23T16:40:47.373Z] 16:40:47 INFO - JavaScript error: chrome://remote/content/marionette/cert.sys.mjs, line 47: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsICertOverrideService.setDisableAllSecurityChecksAndLetAttackersInterceptMyData]
[task 2024-03-23T16:40:47.671Z] 16:40:47 INFO - [Child 9748, Main Thread] WARNING: IPC message 'PContent::Msg_CleanupPendingLoadState' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:539
[task 2024-03-23T16:40:47.687Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: startCrashBrowserTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.687Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: initiateShutdownWorkThreads', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.687Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.687Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: cache: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.687Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: sdb: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.687Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: fs: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.687Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: ls: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.687Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: startKillActorsTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.733Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.047000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.740Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.047000s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.741Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.047000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.741Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.047000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.741Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.047000s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.742Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.047000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.742Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.047000s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.742Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: Expected empty mFiles when transaction has not been invalidated: '!mFiles.IsEmpty() && !Transaction().IsInvalidated()', file /builds/worker/checkouts/gecko/dom/indexedDB/ActorsParent.cpp:19586
[task 2024-03-23T16:40:47.743Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: Expected empty mFiles when transaction has not been invalidated: '!mFiles.IsEmpty() && !Transaction().IsInvalidated()', file /builds/worker/checkouts/gecko/dom/indexedDB/ActorsParent.cpp:19586
[task 2024-03-23T16:40:47.743Z] 16:40:47 INFO - console.error: PushService:
[task 2024-03-23T16:40:47.745Z] 16:40:47 INFO - stateChangeProcessEnqueue: Error transitioning state
[task 2024-03-23T16:40:47.745Z] 16:40:47 INFO - AbortError
[task 2024-03-23T16:40:47.746Z] 16:40:47 INFO - console.error: PushService:
[task 2024-03-23T16:40:47.747Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.062000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.747Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.062000s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.747Z] 16:40:47 INFO - clearOriginData: Error clearing origin data:
[task 2024-03-23T16:40:47.748Z] 16:40:47 INFO - AbortError
[task 2024-03-23T16:40:47.765Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.078000s: An element was removed from gFactoryOps', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.844Z] 16:40:47 INFO - console.error: (new AbortError("IndexedDB: main/hijack-blocklists list() IndexedDB: execute() A request was aborted, for example through a call to IDBTransaction.abort.", "resource://services-settings/IDBHelpers.sys.mjs", 16))
[task 2024-03-23T16:40:47.858Z] 16:40:47 INFO - Hit MOZ_CRASH(CachingDatabaseConnection not thread-safe) at /builds/worker/checkouts/gecko/xpcom/base/nsISupportsImpl.cpp:76
[task 2024-03-23T16:40:47.858Z] 16:40:47 INFO - console.error: (new AbortError("IndexedDB: main/search-telemetry-v2 list() IndexedDB: execute() A request was aborted, for example through a call to IDBTransaction.abort.", "resource://services-settings/IDBHelpers.sys.mjs", 16))
[task 2024-03-23T16:40:47.859Z] 16:40:47 INFO - console.error: (new AbortError("IndexedDB: main/search-config-v2 list() IndexedDB: execute() A request was aborted, for example through a call to IDBTransaction.abort.", "resource://services-settings/IDBHelpers.sys.mjs", 16))
[task 2024-03-23T16:40:47.861Z] 16:40:47 INFO - console.error: (new AbortError("IndexedDB: main/search-config-overrides-v2 list() IndexedDB: execute() A request was aborted, for example through a call to IDBTransaction.abort.", "resource://services-settings/IDBHelpers.sys.mjs", 16))
[task 2024-03-23T16:40:47.862Z] 16:40:47 INFO - console.error: (new AbortError("IndexedDB: main/top-sites list() IndexedDB: execute() A request was aborted, for example through a call to IDBTransaction.abort.", "resource://services-settings/IDBHelpers.sys.mjs", 16))
[task 2024-03-23T16:40:47.863Z] 16:40:47 INFO - console.error: (new AbortError("IndexedDB: blocklists/gfx list() IndexedDB: execute() A request was aborted, for example through a call to IDBTransaction.abort.", "resource://services-settings/IDBHelpers.sys.mjs", 16))
[task 2024-03-23T16:40:47.864Z] 16:40:47 INFO - console.error: (new AbortError("IndexedDB: main/message-groups getLastModified() IndexedDB: execute() A request was aborted, for example through a call to IDBTransaction.abort.", "resource://services-settings/IDBHelpers.sys.mjs", 16))
[task 2024-03-23T16:40:47.869Z] 16:40:47 INFO - console.error: (new Error("IndexedDB: main/cfr getLastModified() IndexedDB: execute() The application is shutting down", "resource://services-settings/IDBHelpers.sys.mjs", 16))
[task 2024-03-23T16:40:47.872Z] 16:40:47 INFO - console.error: (new Error("IndexedDB: main/message-groups getLastModified() IndexedDB: execute() The application is shutting down", "resource://services-settings/IDBHelpers.sys.mjs", 16))
[task 2024-03-23T16:40:47.891Z] 16:40:47 INFO - console.error: (new UnknownError("IDBDatabase.transaction: Can't start IndexedDB transaction during shutdown", (void 0), 364))
[task 2024-03-23T16:40:47.985Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.297000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:47.991Z] 16:40:47 INFO - [Parent 4756, IPDL Background] WARNING: idb: '0.297000s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2223
[task 2024-03-23T16:40:48.016Z] 16:40:48 INFO - console.error: WebExtensions:
[task 2024-03-23T16:40:48.023Z] 16:40:48 INFO - Message: [Exception... "#init: abandoning init due to shutting down" nsresult: "0x80004004 (NS_ERROR_ABORT)" location: "JS frame :: resource://gre/modules/SearchService.sys.mjs :: #init :: line 1397" data: no]
[task 2024-03-23T16:40:48.023Z] 16:40:48 INFO - Stack:
[task 2024-03-23T16:40:48.024Z] 16:40:48 INFO - #init@resource://gre/modules/SearchService.sys.mjs:1397:27
[task 2024-03-23T16:40:48.025Z] 16:40:48 INFO - console.error: URLBar - Provider.UrlbarProviderSearchTips: ({})
[task 2024-03-23T16:40:48.028Z] 16:40:48 INFO - JavaScript error: resource://gre/modules/SearchService.sys.mjs, line 1397: NS_ERROR_ABORT: #init: abandoning init due to shutting down
[task 2024-03-23T16:40:48.029Z] 16:40:48 INFO - JavaScript error: resource://gre/modules/SearchService.sys.mjs, line 1397: NS_ERROR_ABORT: #init: abandoning init due to shutting down
[task 2024-03-23T16:40:48.029Z] 16:40:48 INFO - JavaScript error: resource://gre/modules/SearchService.sys.mjs, line 1397: NS_ERROR_ABORT: #init: abandoning init due to shutting down
[task 2024-03-23T16:40:48.029Z] 16:40:48 INFO - JavaScript error: resource://gre/modules/Sqlite.sys.mjs, line 1127: Error: Connection is not open.
[task 2024-03-23T16:40:48.029Z] 16:40:48 INFO - JavaScript error: resource://gre/modules/Sqlite.sys.mjs, line 1127: Error: Connection is not open.
[task 2024-03-23T16:40:48.047Z] 16:40:48 INFO - #01: ???[Z:\task_171120759233918\build\application\firefox\xul.dll +0x2e521f]
[task 2024-03-23T16:40:48.054Z] 16:40:48 INFO - #02: VR_RuntimePath[Z:\task_171120759233918\build\application\firefox\xul.dll +0x4600547]
[task 2024-03-23T16:40:48.054Z] 16:40:48 INFO - #03: VR_RuntimePath[Z:\task_171120759233918\build\application\firefox\xul.dll +0x4604a8d]
[task 2024-03-23T16:40:48.055Z] 16:40:48 INFO - #04: VR_RuntimePath[Z:\task_171120759233918\build\application\firefox\xul.dll +0x4611229]
[task 2024-03-23T16:40:48.055Z] 16:40:48 INFO - #05: ???[Z:\task_171120759233918\build\application\firefox\xul.dll +0x3f6f99]
[task 2024-03-23T16:40:48.055Z] 16:40:48 INFO - #06: ???[Z:\task_171120759233918\build\application\firefox\xul.dll +0x3fe775]
[task 2024-03-23T16:40:48.055Z] 16:40:48 INFO - #07: VR_RuntimePath[Z:\task_171120759233918\build\application\firefox\xul.dll +0x460e362]
[task 2024-03-23T16:40:48.056Z] 16:40:48 INFO - #08: ???[Z:\task_171120759233918\build\application\firefox\xul.dll +0x3f6f99]
[task 2024-03-23T16:40:48.056Z] 16:40:48 INFO - #09: ???[Z:\task_171120759233918\build\application\firefox\xul.dll +0x3fe775]
[task 2024-03-23T16:40:48.056Z] 16:40:48 INFO - #10: ???[Z:\task_171120759233918\build\application\firefox\xul.dll +0xf1908e]
[task 2024-03-23T16:40:48.056Z] 16:40:48 INFO - #11: ???[Z:\task_171120759233918\build\application\firefox\xul.dll +0xe956b0]
[task 2024-03-23T16:40:48.057Z] 16:40:48 INFO - #12: ???[Z:\task_171120759233918\build\application\firefox\xul.dll +0xe9556f]
[task 2024-03-23T16:40:48.057Z] 16:40:48 INFO - #13: ???[Z:\task_171120759233918\build\application\firefox\xul.dll +0x3f1ecb]
[task 2024-03-23T16:40:48.057Z] 16:40:48 INFO - #14: PRP_TryLock[Z:\task_171120759233918\build\application\firefox\nss3.dll +0x180371]
[task 2024-03-23T16:40:48.057Z] 16:40:48 INFO - #15: PR_MD_UNLOCK[Z:\task_171120759233918\build\application\firefox\nss3.dll +0x1713d1]
[task 2024-03-23T16:40:48.058Z] 16:40:48 INFO - #16: recalloc[C:\Windows\System32\ucrtbase.dll +0x29363]
[task 2024-03-23T16:40:48.058Z] 16:40:48 INFO - #17: BaseThreadInitThunk[C:\Windows\System32\KERNEL32.DLL +0x1257d]
[task 2024-03-23T16:40:48.058Z] 16:40:48 INFO - #18: DllBlocklist_Initialize[Z:\task_171120759233918\build\application\firefox\mozglue.dll +0x8f9d5]
[task 2024-03-23T16:40:48.058Z] 16:40:48 INFO - #19: RtlUserThreadStart[C:\Windows\SYSTEM32\ntdll.dll +0x5aa58]
[task 2024-03-23T16:40:48.267Z] 16:40:48 ERROR - TEST-UNEXPECTED-FAIL | toolkit/xre/test/marionette/test_exitcode.py TestFissionAutostart.test_normal_exit | AssertionError: 2147483651 != 0
[task 2024-03-23T16:40:48.271Z] 16:40:48 INFO - Traceback (most recent call last):
[task 2024-03-23T16:40:48.271Z] 16:40:48 INFO - File "Z:\task_171120759233918\build\venv\Lib\site-packages\marionette_harness\marionette_test\testcases.py", line 198, in run
[task 2024-03-23T16:40:48.271Z] 16:40:48 INFO - testMethod()
[task 2024-03-23T16:40:48.271Z] 16:40:48 INFO - File "Z:\task_171120759233918\build\tests\marionette\tests\toolkit\xre\test\marionette\test_exitcode.py", line 17, in test_normal_exit
[task 2024-03-23T16:40:48.272Z] 16:40:48 INFO - self.assertEqual(self.marionette.instance.runner.returncode, 0)
[task 2024-03-23T16:40:48.272Z] 16:40:48 INFO - TEST-INFO took 1412ms
[task 2024-03-23T16:40:48.272Z] 16:40:48 INFO - Application command: Z:\task_171120759233918\build\application\firefox\firefox.exe -no-remote -marionette --wait-for-browser -profile C:\Users\task_171120759233918\AppData\Local\Temp\tmp6euksmsr.mozrunner
[task 2024-03-23T16:40:48.573Z] 16:40:48 INFO - [Parent 3688, Main Thread] WARNING: '!mColorFilterWatcher', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp:69
[task 2024-03-23T16:40:48.622Z] 16:40:48 INFO - 1711212048631 Marionette INFO Marionette enabled
[task 2024-03-23T16:40:48.633Z] 16:40:48 INFO - 1711212048633 Marionette TRACE Received observer notification final-ui-startup
[task 2024-03-23T16:40:48.747Z] 16:40:48 INFO - Initializing context 1daabecc000 surface 1daabe51ca0 on display 1daabe87100
[task 2024-03-23T16:40:48.759Z] 16:40:48 INFO - [GPU 1488, Renderer] WARNING: Failed to make GL context current!: file /builds/worker/checkouts/gecko/gfx/gl/GLContextProviderEGL.cpp:469
[task 2024-03-23T16:40:48.759Z] 16:40:48 INFO - EGL Error: 0x3009
[task 2024-03-23T16:40:48.759Z] 16:40:48 INFO - [GPU 1488, Renderer] WARNING: GLContext::InitWithPrefix failed!: file /builds/worker/checkouts/gecko/gfx/gl/GLContext.cpp:337
[task 2024-03-23T16:40:48.760Z] 16:40:48 INFO - Destroying context 1daabecc000 surface 1daabe51ca0 on display 1daabe87100
[task 2024-03-23T16:40:48.760Z] 16:40:48 INFO - [GPU 1488, Renderer] WARNING: Failed to create GLContext from PBuffer: file /builds/worker/checkouts/gecko/gfx/gl/GLContextProviderEGL.cpp:1189
[task 2024-03-23T16:40:48.760Z] 16:40:48 INFO - Initializing context 1daaf228000 surface 1daabe506b0 on display 1daabe87100
[task 2024-03-23T16:40:48.761Z] 16:40:48 INFO - GL_VENDOR: Google Inc. (Microsoft)
[task 2024-03-23T16:40:48.761Z] 16:40:48 INFO - mVendor: Unknown
[task 2024-03-23T16:40:48.761Z] 16:40:48 INFO - GL_RENDERER: ANGLE (Microsoft, Microsoft Basic Render Driver Direct3D11 vs_5_0 ps_5_0, D3D11-10.0.22621.2506)
[task 2024-03-23T16:40:48.761Z] 16:40:48 INFO - mRenderer: Microsoft Basic Render Driver
[task 2024-03-23T16:40:48.762Z] 16:40:48 INFO - mIsMesa: 0
[task 2024-03-23T16:40:48.762Z] 16:40:48 INFO - [GPU 1488, Renderer] WARNING: framebuffer_multisample marked as unsupported: file /builds/worker/checkouts/gecko/gfx/gl/GLContextFeatures.cpp:638
[task 2024-03-23T16:40:48.779Z] 16:40:48 INFO - 1711212048793 Marionette INFO Listening on port 2828
[task 2024-03-23T16:40:48.794Z] 16:40:48 INFO - [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-03-23T16:40:48.794Z] 16:40:48 INFO - [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-03-23T16:40:48.794Z] 16:40:48 INFO - [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-03-23T16:40:48.794Z] 16:40:48 INFO - 1711212048794 Marionette DEBUG Marionette is listening
[task 2024-03-23T16:40:48.810Z] 16:40:48 INFO - 1711212048816 Marionette DEBUG Accepted connection 0 from 127.0.0.1:57044
[task 2024-03-23T16:40:48.821Z] 16:40:48 INFO - 1711212048821 Marionette DEBUG Closed connection 0
[task 2024-03-23T16:40:48.841Z] 16:40:48 INFO - [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-03-23T16:40:48.843Z] 16:40:48 INFO - [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-03-23T16:40:48.844Z] 16:40:48 INFO - [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-03-23T16:40:48.889Z] 16:40:48 INFO - 1711212048894 Marionette DEBUG Accepted connection 1 from 127.0.0.1:57047
[task 2024-03-23T16:40:48.967Z] 16:40:48 INFO - [Parent 3688, Main Thread] WARNING: Please do not use mouseenter/leave events in chrome. They are slower than mouseover/out!: '!nsContentUtils::IsChromeDoc(window->GetExtantDoc())', file /builds/worker/checkouts/gecko/dom/events/EventListenerManager.cpp:437
[task 2024-03-23T16:40:49.046Z] 16:40:49 INFO - 1711212049051 Marionette DEBUG Closed connection 1
[task 2024-03-23T16:40:49.052Z] 16:40:49 INFO - 1711212049052 Marionette DEBUG Accepted connection 2 from 127.0.0.1:57048
[task 2024-03-23T16:40:49.063Z] 16:40:49 INFO - 1711212049067 Marionette DEBUG 2 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2024-03-23T16:40:49.071Z] 16:40:49 INFO - 1711212049071 Marionette DEBUG Waiting for initial application window
[task 2024-03-23T16:40:49.359Z] 16:40:49 INFO - [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-03-23T16:40:49.359Z] 16:40:49 INFO - [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-03-23T16:40:49.364Z] 16:40:49 INFO - [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-03-23T16:40:49.405Z] 16:40:49 INFO - [Parent 3688, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp:1616
[task 2024-03-23T16:40:49.436Z] 16:40:49 INFO - [Parent 3688, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp:1616
[task 2024-03-23T16:40:50.279Z] 16:40:50 INFO - [Parent 3688, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp:1616
[task 2024-03-23T16:40:50.488Z] 16:40:50 INFO - [Parent 3688, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1215
[task 2024-03-23T16:40:50.707Z] 16:40:50 INFO - [Child 1656, Main Thread] WARNING: Fallback to FallbackRenderer: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2634
[task 2024-03-23T16:40:50.723Z] 16:40:50 INFO - [Child 1656, Main Thread] WARNING: Fallback to FallbackRenderer: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2634
[task 2024-03-23T16:40:50.728Z] 16:40:50 INFO - [Child 1656, Main Thread] WARNING: Fallback to FallbackRenderer: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2634
[task 2024-03-23T16:40:50.733Z] 16:40:50 INFO - [Child 1656, Main Thread] WARNING: Fallback to FallbackRenderer: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2634
[task 2024-03-23T16:40:50.738Z] 16:40:50 INFO - [Child 1656, Main Thread] WARNING: Fallback to FallbackRenderer: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2634
[task 2024-03-23T16:40:50.817Z] 16:40:50 INFO - [Parent 3688, BgIOThreadPool #1] WARNING: 'GetLastError() != ERROR_FILE_NOT_FOUND', file /builds/worker/checkouts/gecko/browser/components/shell/nsWindowsShellService.cpp:1297
[task 2024-03-23T16:40:50.820Z] 16:40:50 INFO - [Parent 3688, BgIOThreadPool #1] WARNING: 'GetLastError() != ERROR_FILE_NOT_FOUND', file /builds/worker/checkouts/gecko/browser/components/shell/nsWindowsShellService.cpp:1297
[task 2024-03-23T16:40:50.980Z] 16:40:50 INFO - Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2024-03-23T16:40:50.980Z] 16:40:50 INFO - [Child 8, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:408
[task 2024-03-23T16:40:51.011Z] 16:40:51 INFO - 1711212051010 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2024-03-23T16:40:51.019Z] 16:40:51 INFO - 1711212051019 RemoteAgent TRACE [3] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=40000 waitForExplicitStart=false
[task 2024-03-23T16:40:51.020Z] 16:40:51 INFO - 1711212051020 RemoteAgent TRACE [3] ProgressListener Setting unload timer (40000ms)
[task 2024-03-23T16:40:51.020Z] 16:40:51 INFO - 1711212051020 RemoteAgent TRACE [3] Document already finished loading: about:blank
[task 2024-03-23T16:40:51.021Z] 16:40:51 INFO - 1711212051020 RemoteAgent TRACE [3] ProgressListener Stop: has error=false
[task 2024-03-23T16:40:51.035Z] 16:40:51 INFO - 1711212051034 Marionette DEBUG 2 <- [1,1,null,{"sessionId":"5acc840f-6eba-4d3b-aa9a-c9fd8d20ae27","capabilities":{"browserName":"firefox","browserVersion":"126.0a1","platformName":"windows","acceptInsecureCerts":false,"pageLoadStrategy":"normal","setWindowRect":true,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"strictFileInteractability":true,"unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:126.0) Gecko/20100101 Firefox/126.0","moz:accessibilityChecks":false,"moz:buildID":"20240323151659","moz:headless":false,"moz:platformVersion":"10.0","moz:processID":3688,"moz:profile":"C:\\Users\\task_171120759233918\\AppData\\Local\\Temp\\tmp6euksmsr.mozrunner","moz:shutdownTimeout":60000,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2024-03-23T16:40:51.052Z] 16:40:51 INFO - 1711212051059 Marionette DEBUG 2 -> [0,2,"WebDriver:DeleteSession",{}]
[task 2024-03-23T16:40:51.064Z] 16:40:51 INFO - 1711212051064 Marionette DEBUG 2 <- [1,2,null,{"value":null}]
[task 2024-03-23T16:40:51.074Z] 16:40:51 INFO - 1711212051072 Marionette DEBUG Closed connection 2
[task 2024-03-23T16:40:51.075Z] 16:40:51 INFO - TEST-START | toolkit/xre/test/marionette/test_fission_autostart.py TestFissionAutostart.test_fission_precedence
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•1 year ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•