Closed Bug 1646729 Opened 5 years ago Closed 1 year ago

Intermittent toolkit/mozapps/extensions/test/xpcshell/test_cacheflush.js | application crashed [@ static mozilla::dom::indexedDB::`anonymous namespace'::NormalTransactionOp::ObjectStoreHasIndexes(mozilla::dom::indexedDB::`anonymous namespace'::NormalTrans

Categories

(Toolkit :: Add-ons Manager, defect)

Product:
Toolkit
Component:
Add-ons Manager
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: crash, intermittent-failure)

Crash Data

Filed by: abutkovits [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=306769335&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/MHFgLiwsSvyyeMN8pGbWxQ/runs/0/artifacts/public/logs/live_backing.log

[task 2020-06-18T12:29:32.512Z] 12:29:32 INFO - TEST-PASS | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_cacheflush.js | test_flush_uninstall - [test_flush_uninstall : 83] true == true
[task 2020-06-18T12:29:32.512Z] 12:29:32 INFO - (xpcshell/head.js) | test run_next_test 3 pending (2)
[task 2020-06-18T12:29:32.512Z] 12:29:32 INFO - (xpcshell/head.js) | test test_flush_uninstall finished (2)
[task 2020-06-18T12:29:32.512Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (info) 1592483372038 addons.xpi DEBUG Calling bootstrap method uninstall on addon2@tests.mozilla.org version 2.0"
[task 2020-06-18T12:29:32.512Z] 12:29:32 INFO - PID 1888 | [1888, QuotaManager IO] WARNING: 'NS_FAILED(directory->GetDirectoryEntries(getter_AddRefs(entries)))', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 9833
[task 2020-06-18T12:29:32.512Z] 12:29:32 INFO - PID 1888 | [1888, QuotaManager IO] WARNING: 'NS_FAILED(directory->GetDirectoryEntries(getter_AddRefs(entries)))', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 9833
[task 2020-06-18T12:29:32.512Z] 12:29:32 INFO - PID 1888 | [1888, QuotaManager IO] WARNING: 'NS_FAILED(directory->GetDirectoryEntries(getter_AddRefs(entries)))', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 9833
[task 2020-06-18T12:29:32.512Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (info) 1592483372042 addons.xpi DEBUG Disabling XPIState for addon2@tests.mozilla.org"
[task 2020-06-18T12:29:32.512Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (info) 1592483372042 addons.xpi DEBUG uninstallAddon: flushing jar cache c:\users\task_1592480430\appdata\local\temp\xpc-profile-5x9a0u\extensions\addon2@tests.mozilla.org.xpi for addon addon2@tests.mozilla.org"
[task 2020-06-18T12:29:32.513Z] 12:29:32 INFO - (xpcshell/head.js) | test run_next_test 3 finished (1)
[task 2020-06-18T12:29:32.513Z] 12:29:32 INFO - exiting test
[task 2020-06-18T12:29:32.513Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (info) 1592483372146 addons.xpi-utils DEBUG XPI Database saved, setting schema version preference to 32"
[task 2020-06-18T12:29:32.513Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (info) 1592483372147 addons.manager DEBUG before shutdown"
[task 2020-06-18T12:29:32.513Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (info) 1592483372148 addons.manager DEBUG shutdown"
[task 2020-06-18T12:29:32.513Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (info) 1592483372148 addons.manager DEBUG Calling shutdown blocker for XPIProvider"
[task 2020-06-18T12:29:32.513Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (info) 1592483372149 addons.xpi DEBUG shutdown"
[task 2020-06-18T12:29:32.513Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (info) 1592483372149 addons.xpi-utils DEBUG shutdown"
[task 2020-06-18T12:29:32.513Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (info) 1592483372149 addons.manager DEBUG Calling shutdown blocker for PluginProvider"
[task 2020-06-18T12:29:32.513Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (info) 1592483372156 addons.manager DEBUG Async provider shutdown done"
[task 2020-06-18T12:29:32.514Z] 12:29:32 INFO - PID 1888 | console.log: "RemoteSettingsWorker error: AbortError: IndexedDB: execute() A request was aborted, for example through a call to IDBTransaction.abort."
[task 2020-06-18T12:29:32.514Z] 12:29:32 INFO - PID 1888 | console.warn: services.settings: Error retrieving the getLastModified timestamp from blocklists/plugins RemoteSettingsClient Message: Error: IndexedDB: blocklists/plugins getLastModified() IndexedDB: execute() The application is shutting down
[task 2020-06-18T12:29:32.514Z] 12:29:32 INFO - PID 1888 | [1888, In
[task 2020-06-18T12:29:32.514Z] 12:29:32 INFO - "CONSOLE_MESSAGE: (error) [JavaScript Error: "AbortError: IndexedDB: execute() A request was aborted, for example through a call to IDBTransaction.abort." {file: "resource://services-settings/RemoteSettingsWorker.jsm" line: 46}]
[task 2020-06-18T12:29:32.514Z] 12:29:32 INFO - RemoteSettingsWorkerError@resource://services-settings/RemoteSettingsWorker.jsm:46:5
[task 2020-06-18T12:29:32.514Z] 12:29:32 INFO - _onWorkerMessage@resource://services-settings/RemoteSettingsWorker.jsm:114:14
[task 2020-06-18T12:29:32.514Z] 12:29:32 INFO - observe@resource://gre/modules/AsyncShutdown.jsm:554:16
[task 2020-06-18T12:29:32.514Z] 12:29:32 INFO - _execute_test@Z:\task_1592480430\build\tests\xpcshell\head.js:673:19
[task 2020-06-18T12:29:32.514Z] 12:29:32 INFO - @-e:1:1
[task 2020-06-18T12:29:32.515Z] 12:29:32 INFO - "
[task 2020-06-18T12:29:32.515Z] 12:29:32 INFO - PID 1888 | dexedDB #1] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/indexedDB/ActorsParent.cpp, line 20023
[task 2020-06-18T12:29:32.515Z] 12:29:32 INFO - PID 1888 | Assertion failure: (
[task 2020-06-18T12:29:32.515Z] 12:29:32 INFO - PID 1888 | {"action":"log","time":1592483372183,"thread":null,"pid":null,"source":"xpcshell/head.js","level":"INFO","message":"\"CONSOLE_MESSAGE: (error) [JavaScript Error: \"IndexedDB UnknownErr: ActorsParent.cpp:13699\"]\""}(bool)(__b
[task 2020-06-18T12:29:32.515Z] 12:29:32 INFO - PID 1888 | uiltin_expect(!!(!NS_FAILED_impl(DatabaseOperationBase::ObjectStoreHasIndexes( aConnection, aObjectStoreId, &hasIndexes))), 1))), at /builds/worker/checkouts/gecko/dom/indexedDB/ActorsParent.cpp:24816
[task 2020-06-18T12:29:32.522Z] 12:29:32 INFO - Initializing stack-fixing for the first stack frame, this may take a while...
[task 2020-06-18T12:29:48.229Z] 12:29:48 INFO - PID 1888 | #01: mozilla::dom::indexedDB::anonymous namespace'::ObjectStoreAddOrPutRequestOp::DoDatabaseWork(mozilla::dom::indexedDB::anonymous namespace'::DatabaseConnection*) [dom/indexedDB/ActorsParent.cpp:25165]
[task 2020-06-18T12:29:48.229Z] 12:29:48 INFO - PID 1888 | #02: mozilla::dom::indexedDB::anonymous namespace'::TransactionDatabaseOperationBase::RunOnConnectionThread() [dom/indexedDB/ActorsParent.cpp:22874] [task 2020-06-18T12:29:48.229Z] 12:29:48 INFO - PID 1888 | #03: mozilla::dom::indexedDB::anonymous namespace'::TransactionDatabaseOperationBase::Run() [dom/indexedDB/ActorsParent.cpp:23038]
[task 2020-06-18T12:29:48.229Z] 12:29:48 INFO - PID 1888 | #04: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1236]
[task 2020-06-18T12:29:48.230Z] 12:29:48 INFO - PID 1888 | #05: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:501]
[task 2020-06-18T12:29:48.230Z] 12:29:48 INFO - PID 1888 | #06: mozilla::dom::indexedDB::anonymous namespace'::ConnectionPool::ThreadRunnable::Run() [dom/indexedDB/ActorsParent.cpp:13096] [task 2020-06-18T12:29:48.230Z] 12:29:48 INFO - PID 1888 | #07: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1236] [task 2020-06-18T12:29:48.230Z] 12:29:48 INFO - PID 1888 | #08: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:501] [task 2020-06-18T12:29:48.230Z] 12:29:48 INFO - PID 1888 | #09: mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:332] [task 2020-06-18T12:29:48.230Z] 12:29:48 INFO - PID 1888 | #10: MessageLoop::RunInternal() [ipc/chromium/src/base/message_loop.cc:315] [task 2020-06-18T12:29:48.230Z] 12:29:48 INFO - PID 1888 | #11: MessageLoop::RunHandler() [ipc/chromium/src/base/message_loop.cc:309] [task 2020-06-18T12:29:48.230Z] 12:29:48 INFO - PID 1888 | #12: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:291] [task 2020-06-18T12:29:48.230Z] 12:29:48 INFO - PID 1888 | #13: static nsThread::ThreadFunc(void*) [xpcom/threads/nsThread.cpp:449] [task 2020-06-18T12:29:48.525Z] 12:29:48 INFO - PID 1888 | #14: _PR_NativeRunThread(void*) [nsprpub/pr/src/threads/combined/pruthr.c:399] [task 2020-06-18T12:29:48.525Z] 12:29:48 INFO - PID 1888 | #15: pr_root(void*) [nsprpub/pr/src/md/windows/w95thred.c:139] [task 2020-06-18T12:29:48.525Z] 12:29:48 INFO - fix-stacks error: failed to read breakpad symbols dir Z:\task_1592480430\build\symbols\ucrtbase.DLLforZ:\task_1592480430\build\application\firefox\ucrtbase.DLL[task 2020-06-18T12:29:48.525Z] 12:29:48 INFO - fix-stacks note: this is expected and harmless for system libraries on debug automation runs [task 2020-06-18T12:29:48.525Z] 12:29:48 INFO - PID 1888 | #16: o____lc_collate_cp_func [Z:\\task_1592480430\\build\\application\\firefox\\ucrtbase.DLL + 0x3e16f] [task 2020-06-18T12:29:48.525Z] 12:29:48 INFO - fix-stacks error: failed to read breakpad symbols dirZ:\task_1592480430\build\symbols\kernel32.pdbforC:\windows\system32\kernel32.dll[task 2020-06-18T12:29:48.525Z] 12:29:48 INFO - fix-stacks note: this is expected and harmless for system libraries on debug automation runs [task 2020-06-18T12:29:48.525Z] 12:29:48 INFO - PID 1888 | #17: BaseThreadInitThunk [C:\\windows\\system32\\kernel32.dll + 0x4ef3c] [task 2020-06-18T12:29:48.600Z] 12:29:48 INFO - PID 1888 | #18: DllBlocklist_Initialize [Z:\\task_1592480430\\build\\application\\firefox\\mozglue.dll + 0x202a7] [task 2020-06-18T12:29:48.600Z] 12:29:48 INFO - fix-stacks error: failed to read breakpad symbols dirZ:\task_1592480430\build\symbols\ntdll.pdbforC:\windows\SYSTEM32\ntdll.dll [task 2020-06-18T12:29:48.600Z] 12:29:48 INFO - fix-stacks note: this is expected and harmless for system libraries on debug automation runs [task 2020-06-18T12:29:48.600Z] 12:29:48 INFO - PID 1888 | #19: RtlInitializeExceptionChain [C:\\windows\\SYSTEM32\\ntdll.dll + 0x63618] [task 2020-06-18T12:29:48.601Z] 12:29:48 INFO - PID 1888 | #20: RtlInitializeExceptionChain [C:\\windows\\SYSTEM32\\ntdll.dll + 0x635eb] [task 2020-06-18T12:29:48.601Z] 12:29:48 INFO - <<<<<<< [task 2020-06-18T12:29:48.602Z] 12:29:48 INFO - mozcrash Copy/paste: Z:/task_1592480430/fetches\minidump_stackwalk\minidump_stackwalk.exe c:\users\task_1592480430\appdata\local\temp\xpc-other-fn3afl\0f9ddba4-6667-43f4-87bd-9e49e0012607.dmp Z:\task_1592480430\build\symbols [task 2020-06-18T12:30:09.457Z] 12:30:09 INFO - mozcrash Saved minidump as Z:\task_1592480430\build\blobber_upload_dir\0f9ddba4-6667-43f4-87bd-9e49e0012607.dmp [task 2020-06-18T12:30:09.457Z] 12:30:09 INFO - mozcrash Saved app info as Z:\task_1592480430\build\blobber_upload_dir\0f9ddba4-6667-43f4-87bd-9e49e0012607.extra [task 2020-06-18T12:30:09.458Z] 12:30:09 WARNING - PROCESS-CRASH | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_cacheflush.js | application crashed [@ static mozilla::dom::indexedDB::anonymous namespace'::NormalTransactionOp::ObjectStoreHasIndexes(mozilla::dom::indexedDB::anonymous namespace'::NormalTransactionOp*, mozilla::dom::indexedDB::anonymous namespace'::DatabaseConnection*, long long, const bool, bool*)]

Severity: normal → S4
Crash Signature: [@ static mozilla::dom::indexedDB::`anonymous namespace'::NormalTransactionOp::ObjectStoreHasIndexes(mozilla::dom::indexedDB::`anonymous namespace'::NormalTransactionOp*, mozilla::dom::indexedDB::`anonymous namespace'::DatabaseConnection*, long long, cons… → [@ static mozilla::dom::indexedDB::`anonymous namespace'::NormalTransactionOp::ObjectStoreHasIndexes]

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.