Closed Bug 910435 Opened 11 years ago Closed 9 years ago

Intermittent test_Http.js | test failed (with xpcshell return code: 1) | application crashed [@ nsContentUtils::IsSystemPrincipal(nsIPrincipal*)]

Categories

(Core :: XPConnect, defect)

Product:
Core
Component:
XPConnect
Platform:
x86_64
macOS
Type:
defect
Priority:
Not set
Severity:
normal

Tracking

()

Status:
RESOLVED WORKSFORME
Tracking Flags:
Tracking Status
firefox25 --- unaffected
firefox26 --- affected
firefox27 --- affected
firefox-esr24 --- unaffected

People

(Reporter: RyanVM, Unassigned)

References

Details

(Keywords: crash, intermittent-failure) 

Starting with bholley based on the crash signature.

https://tbpl.mozilla.org/php/getParsedLog.php?id=27125937&tree=Mozilla-Central

Rev4 MacOSX Snow Leopard 10.6 mozilla-central debug test xpcshell on 2013-08-28 10:04:19 PDT for push dc7b76fcf7e4
slave: talos-r4-snow-005

10:30:28     INFO -  TEST-INFO | /builds/slave/talos-slave/test/build/tests/xpcshell/tests/toolkit/modules/tests/xpcshell/test_Http.js | running test ...
10:30:28  WARNING -  TEST-UNEXPECTED-FAIL | /builds/slave/talos-slave/test/build/tests/xpcshell/tests/toolkit/modules/tests/xpcshell/test_Http.js | test failed (with xpcshell return code: 1), see following log:
10:30:28     INFO -  >>>>>>>
10:30:28     INFO -  TEST-INFO | (xpcshell/head.js) | test MAIN run_test pending (1)
10:30:28     INFO -  TEST-INFO | (xpcshell/head.js) | test run_next_test 0 pending (2)
10:30:28     INFO -  TEST-INFO | (xpcshell/head.js) | test MAIN run_test finished (2)
10:30:28     INFO -  TEST-INFO | (xpcshell/head.js) | running event loop

blah blah blah...

10:30:28     INFO -  TEST-INFO | (xpcshell/head.js) | exiting test
10:30:28     INFO -  TEST-PASS | (xpcshell/head.js) | 11 (+ 0) check(s) passed
10:30:28     INFO -  TEST-INFO | (xpcshell/head.js) | 0 check(s) todo
10:30:28     INFO -  WARNING: NS_ENSURE_TRUE(mThread != PR_GetCurrentThread()) failed: file ../../../xpcom/threads/nsThread.cpp, line 435
10:30:28     INFO -  WARNING: cannot post event if not initialized: file ../../../../netwerk/protocol/http/nsHttpConnectionMgr.cpp, line 176
10:30:28     INFO -  WARNING: nsExceptionService ignoring thread destruction after shutdown: file ../../../xpcom/base/nsExceptionService.cpp, line 151
10:30:28     INFO -  <<<<<<<
10:30:46  WARNING -  PROCESS-CRASH | /builds/slave/talos-slave/test/build/tests/xpcshell/tests/toolkit/modules/tests/xpcshell/test_Http.js | application crashed [@ nsContentUtils::IsSystemPrincipal(nsIPrincipal*)]
10:30:46     INFO -  Crash dump filename: /var/folders/kH/kH8XRecoHhayQfYjkUZ1HE+++-k/-Tmp-/tmp8PBVeY/2C61FBAC-4B68-4DD7-9398-53598045189C.dmp
10:30:46     INFO -  Operating system: Mac OS X
10:30:46     INFO -                    10.6.8 10K549
10:30:46     INFO -  CPU: amd64
10:30:46     INFO -       family 6 model 23 stepping 10
10:30:46     INFO -       2 CPUs
10:30:46     INFO -  Crash reason:  EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
10:30:46     INFO -  Crash address: 0x0
10:30:46     INFO -  Thread 0 (crashed)
10:30:46     INFO -   0  XUL!nsContentUtils::IsSystemPrincipal(nsIPrincipal*) [nsContentUtils.cpp:dc7b76fcf7e4 : 4405 + 0x7]
10:30:46     INFO -      rbx = 0x0000000000000000   r12 = 0x0000000000000000
10:30:46     INFO -      r13 = 0x00000001054e2670   r14 = 0x0000000105a04258
10:30:46     INFO -      r15 = 0x0000000105a04258   rip = 0x00000001007e7292
10:30:46     INFO -      rsp = 0x00007fff5fbfe0b0   rbp = 0x00007fff5fbfe0c0
10:30:46     INFO -      Found by: given as instruction pointer in context
10:30:46     INFO -   1  XUL!nsXMLHttpRequest::OnStartRequest(nsIRequest*, nsISupports*) [nsXMLHttpRequest.cpp:dc7b76fcf7e4 : 1497 + 0x4]
10:30:46     INFO -      rbx = 0x0000000000000000   r12 = 0x0000000000000000
10:30:46     INFO -      r13 = 0x00000001054e2670   r14 = 0x0000000105a04258
10:30:46     INFO -      r15 = 0x0000000105a04258   rip = 0x00000001008f168b
10:30:46     INFO -      rsp = 0x00007fff5fbfe0d0   rbp = 0x00007fff5fbfe2b0
10:30:46     INFO -      Found by: call frame info
10:30:46     INFO -   2  XUL!mozilla::net::nsHttpChannel::CallOnStartRequest() [nsHttpChannel.cpp:dc7b76fcf7e4 : 1005 + 0x9]
10:30:46     INFO -      rbx = 0x0000000105a04200   r12 = 0x0000000102c6154b
10:30:46     INFO -      r13 = 0x0000000102c60d73   r14 = 0x0000000105a04200
10:30:46     INFO -      r15 = 0x000000010013b55c   rip = 0x000000010022b61d
10:30:46     INFO -      rsp = 0x00007fff5fbfe2c0   rbp = 0x00007fff5fbfe320
10:30:46     INFO -      Found by: call frame info
10:30:46     INFO -   3  XUL!mozilla::net::nsHttpChannel::OnStartRequest(nsIRequest*, nsISupports*) [nsHttpChannel.cpp:dc7b76fcf7e4 : 5097 + 0x7]
10:30:46     INFO -      rbx = 0x0000000105a04200   r12 = 0x0000000102c6154b
10:30:46     INFO -      r13 = 0x0000000102c60d73   r14 = 0x000000010546f660
10:30:46     INFO -      r15 = 0x000000010013b55c   rip = 0x000000010023a3dd
10:30:46     INFO -      rsp = 0x00007fff5fbfe330   rbp = 0x00007fff5fbfe360
10:30:46     INFO -      Found by: call frame info
10:30:46     INFO -   4  XUL!nsInputStreamPump::OnStateStart() [nsInputStreamPump.cpp:dc7b76fcf7e4 : 463 + 0x8]
10:30:46     INFO -      rbx = 0x000000010546f660   r12 = 0x0000000102c6154b
10:30:46     INFO -      r13 = 0x0000000102c60d73   r14 = 0x0000000000000001
10:30:46     INFO -      r15 = 0x000000010013b55c   rip = 0x000000010013b644
10:30:46     INFO -      rsp = 0x00007fff5fbfe370   rbp = 0x00007fff5fbfe390
10:30:46     INFO -      Found by: call frame info
Looks like Necko is invoking nsXMLHttpRequest::OnStartRequest during XPCOM shutdown, which invokes nsContentUtils::IsSystemPrincipal after nsContentUtils has been torn down.
Flags: needinfo?(jduell.mcbugs)
A regression range would be very useful here.  

Also, Steve, can you think of anything in the off-main ODA changes that could have changed whether we deliver OnStart during shutdown?  I'm not actually familiar with how we choke off necko events during shutdown so I don't know what mechanism we might be jumping over now.
Flags: needinfo?(jduell.mcbugs) → needinfo?(sworkman)
(In reply to Jason Duell (:jduell) from comment #17)
> A regression range would be very useful here.  

Retriggers on TBPL are pointing to this push as when it regressed. Can you get it from here or do you need me to try to whittle it down further?

https://hg.mozilla.org/mozilla-central/pushloghtml?startID=25170&endID=25171
status-firefox25: --- → unaffected
status-firefox26: --- → affected
status-firefox27: --- → affected
status-firefox-esr24: --- → unaffected
Flags: needinfo?(jduell.mcbugs)
From the crash signature, this is almost certainly bug 913138. I have a fix for that bug, but it's orange on windows, and needs someone to investigate it.
Depends on: 913138
sounds from comment 26 that bholly has this covered.  Re-ping me as needed
Flags: needinfo?(sworkman)
Flags: needinfo?(jduell.mcbugs)
Inactive; closing (see bug 1180138).
Status: NEW → RESOLVED
Closed: 9 years ago
Resolution: --- → WORKSFORME
You need to log in before you can comment on or make changes to this bug.