Closed Bug 764369 Opened 13 years ago Closed 12 years ago

Intermittent crash during test_fileReadSlice.xul [@ xul.dll@0x177f0b3] [@ xul.dll@0x2214737], or | Assertion count 1 is greater than expected range 0-0 assertions (ASSERTION: QueryInterface needed: 'query_result.get() == mRawPtr')

Categories

(Core :: XPCOM, defect)

Product:
Core
Component:
XPCOM
Platform:
x86
Windows 7
Type:
defect
Priority:
Not set
Severity:
critical

Tracking

()

Status:
RESOLVED FIXED

People

(Reporter: emorley, Unassigned)

References

Details

(Keywords: crash, intermittent-failure)

Crash Data

Rev3 WINNT 6.1 mozilla-inbound debug test mochitest-other on 2012-06-12 11:34:58 PDT for push 22796d93c42e slave: talos-r3-w7-060 https://tbpl.mozilla.org/php/getParsedLog.php?id=12597280&tree=Mozilla-Inbound { 10293 INFO TEST-START | chrome://mochitests/content/chrome/dom/workers/test/test_fileReadSlice.xul ++DOMWINDOW == 73 (1156AE08) [serial = 881] [outer = 0D128ED8] JavaScript warning: chrome://mochitests/content/chrome/dom/workers/test/test_fileReadSlice.xul, line 43: octal literals and octal escape sequences are deprecated JavaScript warning: chrome://mochitests/content/chrome/dom/workers/test/test_fileReadSlice.xul, line 43: octal literals and octal escape sequences are deprecated JavaScript warning: chrome://mochitests/content/chrome/dom/workers/test/test_fileReadSlice.xul, line 43: octal literals and octal escape sequences are deprecated Couldn't convert chrome URL: chrome://mochitests/tests/SimpleTest/test.css [Parent 1548] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file e:/builds/moz2_slave/m-in-w32-dbg/build/netwerk/base/src/nsIOService.cpp, line 658 [Parent 1548] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file e:/builds/moz2_slave/m-in-w32-dbg/build/layout/style/Loader.cpp, line 1928 [Parent 1548] WARNING: No outer window available!: file e:/builds/moz2_slave/m-in-w32-dbg/build/dom/base/nsGlobalWindow.cpp, line 8576 [Parent 1548] WARNING: No outer window available!: file e:/builds/moz2_slave/m-in-w32-dbg/build/dom/base/nsGlobalWindow.cpp, line 8576 [Parent 1548] WARNING: No outer window available!: file e:/builds/moz2_slave/m-in-w32-dbg/build/dom/base/nsGlobalWindow.cpp, line 8576 [Parent 1548] WARNING: No outer window available!: file e:/builds/moz2_slave/m-in-w32-dbg/build/dom/base/nsGlobalWindow.cpp, line 8576 [Parent 1548] WARNING: No outer window available!: file e:/builds/moz2_slave/m-in-w32-dbg/build/dom/base/nsGlobalWindow.cpp, line 8576 [Parent 1548] WARNING: No outer window available!: file e:/builds/moz2_slave/m-in-w32-dbg/build/dom/base/nsGlobalWindow.cpp, line 8576 [Parent 1548] WARNING: No outer window available!: file e:/builds/moz2_slave/m-in-w32-dbg/build/dom/base/nsGlobalWindow.cpp, line 8576 [Parent 1548] WARNING: No outer window available!: file e:/builds/moz2_slave/m-in-w32-dbg/build/dom/base/nsGlobalWindow.cpp, line 8576 [Parent 1548] ###!!! ASSERTION: QueryInterface needed: 'query_result.get() == mRawPtr', file e:\builds\moz2_slave\m-in-w32-dbg\build\obj-firefox\dist\include\nsCOMPtr.h, line 498 xul!NS_GetTraceRefcnt_P+0x0000000001110858 xul!NS_GetTraceRefcnt_P+0x000000000111154C xul!NS_GetTraceRefcnt_P+0x00000000010C63B6 xul!NS_GetTraceRefcnt_P+0x00000000010C64B3 xul!NS_GetTraceRefcnt_P+0x0000000000486389 xul!NS_GetTraceRefcnt_P+0x0000000000487B5D xul!NS_GetTraceRefcnt_P+0x0000000000487FBF xul!NS_GetTraceRefcnt_P+0x00000000007F6527 xul!NS_GetTraceRefcnt_P+0x00000000007F5190 mozjs!JS_ResumeRequest+0x00000000000EACD1 mozjs!JS_ResumeRequest+0x00000000000EECB5 mozjs!JS_ResumeRequest+0x00000000000F43BB mozjs!JS_ResumeRequest+0x00000000000EEA7A mozjs!JS_ResumeRequest+0x00000000000EED22 mozjs!JS_ResumeRequest+0x00000000000EEF43 mozjs!JS_ResumeRequest+0x0000000000043B75 xul!NS_GetTraceRefcnt_P+0x00000000007F2F13 xul!NS_GetTraceRefcnt_P+0x00000000010A454F xul!NS_GetTraceRefcnt_P+0x00000000010A54B4 mozjs!JS_ResumeRequest+0x00000000000EACD1 mozjs!JS_ResumeRequest+0x00000000000EECB5 mozjs!JS_ResumeRequest+0x00000000000EEF43 mozjs!JS_ResumeRequest+0x00000000000439B0 xul!NS_GetTraceRefcnt_P+0x00000000007F1427 xul!NS_GetTraceRefcnt_P+0x000000000080A2BB xul!NS_GetTraceRefcnt_P+0x00000000008066CE xul!NS_GetTraceRefcnt_P+0x000000000080CE10 xul!NS_GetTraceRefcnt_P+0x00000000007F8848 xul!NS_GetTraceRefcnt_P+0x0000000001118472 xul!NS_GetTraceRefcnt_P+0x00000000010CA9D1 xul!NS_GetTraceRefcnt_P+0x0000000001117B2C nspr4!PRP_TryLock+0x000000000000062B MSVCR100D!beginthreadex+0x00000000000001D4 kernel32!BaseThreadInitThunk+0x0000000000000012 ntdll!RtlInitializeExceptionChain+0x0000000000000063 ntdll!RtlInitializeExceptionChain+0x0000000000000036 [Parent 1548] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x8000FFFF: file e:/builds/moz2_slave/m-in-w32-dbg/build/content/base/src/nsContentUtils.cpp, line 2901 [Parent 1548] WARNING: NS_ENSURE_TRUE(pusher.Push(aBoundElement)) failed: file e:/builds/moz2_slave/m-in-w32-dbg/build/content/xbl/src/nsXBLProtoImplMethod.cpp, line 324 WARNING: shutting down early because of crash!: file e:/builds/moz2_slave/m-in-w32-dbg/build/dom/plugins/ipc/PluginModuleChild.cpp, line 699 WARNING: plugin process _exit()ing: file e:/builds/moz2_slave/m-in-w32-dbg/build/dom/plugins/ipc/PluginModuleChild.cpp, line 664 NPP_Destroy NPP_Destroy NPP_Destroy NPP_Destroy NPP_Destroy nsStringStats => mAllocCount: 121 => mReallocCount: 1 => mFreeCount: 54 -- LEAKED 67 !!! => mShareCount: 131 => mAdoptCount: 0 => mAdoptFreeCount: 0 TEST-UNEXPECTED-FAIL | chrome://mochitests/content/chrome/dom/workers/test/test_fileReadSlice.xul | Exited with code -1073741819 during test run INFO | automation.py | Application ran for: 0:04:15.445000 INFO | automation.py | Reading PID log: c:\users\cltbld\appdata\local\temp\tmpviwz6npidlog ==> process 1548 launched child process 3616 ==> process 1548 launched child process 1968 ==> process 1548 launched child process 256 ==> process 1548 launched child process 332 ==> process 1548 launched child process 2064 INFO | automation.py | Checking for orphan process with PID: 3616 INFO | automation.py | Checking for orphan process with PID: 1968 INFO | automation.py | Checking for orphan process with PID: 256 INFO | automation.py | Checking for orphan process with PID: 332 INFO | automation.py | Checking for orphan process with PID: 2064 Downloading symbols from: http://ftp.mozilla.org/pub/mozilla.org/firefox/tinderbox-builds/mozilla-inbound-win32-debug/1339521083/firefox-16.0a1.en-US.win32.crashreporter-symbols.zip PROCESS-CRASH | chrome://mochitests/content/chrome/dom/workers/test/test_fileReadSlice.xul | application crashed (minidump found) Crash dump filename: c:\users\cltbld\appdata\local\temp\tmpkeacdu\minidumps\e96fc76f-6649-48c9-8a0b-6a924df465af.dmp Operating system: Windows NT 6.1.7600 CPU: x86 GenuineIntel family 6 model 23 stepping 10 2 CPUs Crash reason: EXCEPTION_ACCESS_VIOLATION_READ Crash address: 0x65 Thread 47 (crashed) 0 xul.dll + 0x177f0b3 eip = 0x6caff0b3 esp = 0x1c8ff0a9 ebp = 0x1c8ff0c8 ebx = 0x00000000 esi = 0x1a740ee9 edi = 0x00000000 eax = 0x05a1af58 ecx = 0x1a740ee8 edx = 0x6aeae4d8 efl = 0x00010202 Found by: given as instruction pointer in context 1 xul.dll!nsFactoryEntry::GetFactory() [nsComponentManager.cpp:22796d93c42e : 1713 + 0x2d] eip = 0x6c5831d0 esp = 0x1c8ff0d0 ebp = 0x1c8ff0e0 Found by: previous frame's frame pointer 2 xul.dll!nsComponentManagerImpl::CreateInstanceByContractID(char const *,nsISupports *,nsID const &,void * *) [nsComponentManager.cpp:22796d93c42e : 1027 + 0xa] eip = 0x6c583ec4 esp = 0x1c8ff0e8 ebp = 0x1c8ff0fc Found by: call frame info 3 xul.dll!CallCreateInstance(char const *,nsISupports *,nsID const &,void * *) [nsComponentManagerUtils.cpp:22796d93c42e : 138 + 0x11] eip = 0x6c538d2e esp = 0x1c8ff104 ebp = 0x1c8ff118 Found by: call frame info 4 xul.dll!nsCreateInstanceByContractID::operator()(nsID const &,void * *) [nsComponentManagerUtils.cpp:22796d93c42e : 178 + 0x11] eip = 0x6c538e2b esp = 0x1c8ff120 ebp = 0x1c8ff138 Found by: call frame info 5 xul.dll!nsCOMPtr<nsIPartialFileInputStream>::assign_from_helper(nsCOMPtr_helper const &,nsID const &) [nsCOMPtr.h:22796d93c42e : 1198 + 0xd] eip = 0x6b8f8d01 esp = 0x1c8ff140 ebp = 0x1c8ff148 Found by: call frame info 6 xul.dll!NS_NewPartialLocalFileInputStream(nsIInputStream * *,nsIFile *,unsigned __int64,unsigned __int64,int,int,int) [nsNetUtil.h:22796d93c42e : 938 + 0x2d] eip = 0x6b8fa4d5 esp = 0x1c8ff150 ebp = 0x1c8ff174 Found by: call frame info 7 xul.dll!nsDOMFileFile::GetInternalStream(nsIInputStream * *) [nsDOMFile.cpp:22796d93c42e : 554 + 0x37] eip = 0x6b8fa937 esp = 0x1c8ff17c ebp = 0x1c8ff1a0 Found by: call frame info 8 xul.dll!mozilla::dom::workers::FileReaderSyncPrivate::ReadAsText(nsIDOMBlob *,nsAString_internal const &,nsAString_internal &) [FileReaderSyncPrivate.cpp:22796d93c42e : 87 + 0x23] eip = 0x6bc68e9f esp = 0x1c8ff1a8 ebp = 0x1c8ff1e0 Found by: call frame info 9 xul.dll!`anonymous namespace'::FileReaderSync::ReadAsText(JSContext *,unsigned int,JS::Value *) [FileReaderSync.cpp:22796d93c42e : 292 + 0x13] eip = 0x6bc67b08 esp = 0x1c8ff1e8 ebp = 0x1c8ff224 Found by: call frame info 10 mozjs.dll!js::CallJSNative(JSContext *,int (*)(JSContext *,unsigned int,JS::Value *),js::CallArgs const &) [jscntxtinlines.h:22796d93c42e : 395 + 0xe] eip = 0x6afd09a6 esp = 0x1c8ff22c ebp = 0x1c8ff254 Found by: call frame info }
Summary: Intermittent crashing during test_fileReadSlice.xul [@ xul.dll@0x177f0b3] → Intermittent crash during test_fileReadSlice.xul [@ xul.dll@0x177f0b3]
We're crashing in nsFactoryEntry::GetFactory. This seems like an XPCOM problem.
Component: DOM: Workers → XPCOM
Whiteboard: [orange]
Crash Signature: [@ xul.dll@0x177f0b3] → [@ xul.dll@0x177f0b3] [@ xul.dll@0x2214737]
Summary: Intermittent crash during test_fileReadSlice.xul [@ xul.dll@0x177f0b3] → Intermittent crash during test_fileReadSlice.xul [@ xul.dll@0x177f0b3] [@ xul.dll@0x2214737] (ASSERTION: QueryInterface needed: 'query_result.get() == mRawPtr')
bsmedberg, any idea what would have made this so much more frequent in February or so?
Flags: needinfo?(benjamin)
I suspect this is running into the root problem in bug 684887, a threading/lock issue in the component manager. I'd really love help making a fatal assertion in that bug so it can land with confidence. Basically all we need is a way to have the following stack crash before it deadlocks: Mozilla::Mutex lock -> Call something on the same thread -> same mutex lock again
Flags: needinfo?(benjamin)
(In reply to Benjamin Smedberg [:bsmedberg] from comment #150) > I suspect this is running into the root problem in bug 684887, a > threading/lock issue in the component manager. I'd really love help making a > fatal assertion in that bug so it can land with confidence. Basically all we > need is a way to have the following stack crash before it deadlocks: > > Mozilla::Mutex lock > -> Call something on the same thread > -> same mutex lock again So just store the owning thread pointer in mozilla::Mutex and check it before attempting to lock? Doesn't sound hard. Am I missing something?
Summary: Intermittent crash during test_fileReadSlice.xul [@ xul.dll@0x177f0b3] [@ xul.dll@0x2214737] (ASSERTION: QueryInterface needed: 'query_result.get() == mRawPtr') → Intermittent crash during test_fileReadSlice.xul [@ xul.dll@0x177f0b3] [@ xul.dll@0x2214737], or | Assertion count 1 is greater than expected range 0-0 assertions (ASSERTION: QueryInterface needed: 'query_result.get() == mRawPtr')
(In reply to Kyle Huey [:khuey] (khuey@mozilla.com) from comment #151) > (In reply to Benjamin Smedberg [:bsmedberg] from comment #150) > > I suspect this is running into the root problem in bug 684887, a > > threading/lock issue in the component manager. I'd really love help making a > > fatal assertion in that bug so it can land with confidence. Basically all we > > need is a way to have the following stack crash before it deadlocks: > > > > Mozilla::Mutex lock > > -> Call something on the same thread > > -> same mutex lock again > > So just store the owning thread pointer in mozilla::Mutex and check it > before attempting to lock? Doesn't sound hard. Am I missing something?
Flags: needinfo?(benjamin)
Wrong bug? That one is now fixed.
Flags: needinfo?(benjamin)
(In reply to Benjamin Smedberg [:bsmedberg] from comment #233) > Wrong bug? That one is now fixed.
Flags: needinfo?(khuey)
I'm confused.
Flags: needinfo?(khuey) → needinfo?(emorley)
(In reply to Kyle Huey [:khuey] (khuey@mozilla.com) from comment #235) > I'm confused. * You asked bsmedberg a question, which he didn't see (presumably due to tbplbot spam). * I needinfo'd him with your question * He's now replied, so back to you :-) (This is a top orange)
Flags: needinfo?(emorley)
(In reply to Ed Morley [:edmorley UTC+0] from comment #236) > (In reply to Kyle Huey [:khuey] (khuey@mozilla.com) from comment #235) > > I'm confused. > > * You asked bsmedberg a question, which he didn't see (presumably due to > tbplbot spam). > * I needinfo'd him with your question Ah, he answered the question by fixing Bug 684887 ;-) > * He's now replied, so back to you :-) > > (This is a top orange) Well we're at 18 hours without it happening now ... so it's not a top orange anymore!
Status: NEW → RESOLVED
Closed: 12 years ago
Resolution: --- → FIXED
I'm loving bug 684887 more and more every day!
You need to log in before you can comment on or make changes to this bug.