859348 - Intermittent dom/indexedDB/test/test_bfcache.html | Assertion count 1 is greater than expected range (User did not call nsIContentViewer::Destroy: '!mPresShell && !mPresContext')

Reporter

Description

•

12 years ago

https://tbpl.mozilla.org/php/getParsedLog.php?id=21539254&tree=Mozilla-Inbound Rev3 WINNT 5.1 mozilla-inbound debug test mochitest-3 on 2013-04-07 20:26:35 PDT for push bd072e286fc0 slave: talos-r3-xp-078 03:41:25 INFO - 9396 INFO TEST-START | /tests/dom/indexedDB/test/test_bfcache.html 03:41:25 INFO - ++DOMWINDOW == 22 (0AA32D80) [serial = 63] [outer = 0AC93EA0] 03:41:25 INFO - ++DOCSHELL 0C632148 == 7 [id = 16] 03:41:25 INFO - ++DOMWINDOW == 23 (072BDDB0) [serial = 64] [outer = 00000000] 03:41:25 INFO - [Parent 3200] WARNING: NS_ENSURE_TRUE(NS_SUCCEEDED(rv) && subjPrincipal) failed: file e:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/docshell/base/nsDocShell.cpp, line 8387 03:41:25 INFO - [Parent 3200] WARNING: Subdocument container has no frame: file e:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/layout/base/nsDocumentViewer.cpp, line 2388 03:41:25 INFO - ++DOMWINDOW == 24 (0A030070) [serial = 65] [outer = 072BDDB0] 03:41:25 INFO - 9397 INFO TEST-PASS | /tests/dom/indexedDB/test/test_bfcache.html | don't double-enable bfcache 03:41:25 INFO - ++DOMWINDOW == 25 (0A24D140) [serial = 66] [outer = 072BDDB0] 03:41:26 INFO - 9398 INFO TEST-PASS | /tests/dom/indexedDB/test/test_bfcache.html | set up database successfully 03:41:26 INFO - ++DOMWINDOW == 26 (07EA68E0) [serial = 67] [outer = 072BDDB0] 03:41:26 INFO - [Parent 3200] ###!!! ASSERTION: User did not call nsIContentViewer::Destroy: '!mPresShell && !mPresContext', file e:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/layout/base/nsDocumentViewer.cpp, line 577 03:41:26 INFO - 9399 INFO TEST-PASS | /tests/dom/indexedDB/test/test_bfcache.html | version was set correctly 03:41:26 INFO - 9400 INFO TEST-PASS | /tests/dom/indexedDB/test/test_bfcache.html | correct set of stores 03:41:26 INFO - 9401 INFO TEST-PASS | /tests/dom/indexedDB/test/test_bfcache.html | blocked shouldn't fire 03:41:26 INFO - 9402 INFO TEST-PASS | /tests/dom/indexedDB/test/test_bfcache.html | correct value found in store 03:41:26 INFO - 9403 INFO TEST-PASS | /tests/dom/indexedDB/test/test_bfcache.html | don't double-disable bfcache 03:41:26 INFO - 9404 INFO TEST-END | /tests/dom/indexedDB/test/test_bfcache.html | finished in 1027ms 03:41:26 INFO - ++DOMWINDOW == 27 (0727E6F8) [serial = 68] [outer = 0AC93EA0] 03:41:26 INFO - 9405 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/indexedDB/test/test_bfcache.html | Assertion count 1 is greater than expected range 0-0 assertions.

Mats Palmgren (inactive)

Comment 1

•

12 years ago

A stack trace for the assertion would help. If I change this NS_ASSERTION to a fatal MOZ_ASSERT would that make mochitest-3 give me a stack?

Severity: normal → critical

Keywords: crash

Comment hidden (Legacy TBPL/Treeherder Robot)

(not currently active) Ted Mielczarek

Comment 5

•

12 years ago

There is a stack, it's just hidden because Windows is horrible at stream buffering: 03:41:46 INFO - nsDocumentViewer::Release() [layout/base/nsDocumentViewer.cpp:555] 03:41:46 INFO - nsCOMPtr<nsIContentViewer>::~nsCOMPtr<nsIContentViewer>() [obj-firefox/dist/include/nsCOMPtr.h:494] 03:41:46 INFO - nsPresContext::EnsureVisible() [layout/base/nsPresContext.cpp:1860] 03:41:46 INFO - PresShell::UnsuppressAndInvalidate() [layout/base/nsPresShell.cpp:3609] 03:41:46 INFO - nsDocShell::EndPageLoad(nsIWebProgress *,nsIChannel *,tag_nsresult) [docshell/base/nsDocShell.cpp:6711] 03:41:46 INFO - nsDocShell::OnStateChange(nsIWebProgress *,nsIRequest *,unsigned int,tag_nsresult) [docshell/base/nsDocShell.cpp:6530] 03:41:46 INFO - nsDocLoader::DoFireOnStateChange(nsIWebProgress * const,nsIRequest * const,int &,tag_nsresult) [uriloader/base/nsDocLoader.cpp:1293] 03:41:46 INFO - nsDocLoader::doStopDocumentLoad(nsIRequest *,tag_nsresult) [uriloader/base/nsDocLoader.cpp:870] 03:41:46 INFO - nsDocLoader::DocLoaderIsEmpty(bool) [uriloader/base/nsDocLoader.cpp:762] 03:41:46 INFO - nsDocLoader::OnStopRequest(nsIRequest *,nsISupports *,tag_nsresult) [uriloader/base/nsDocLoader.cpp:648] 03:41:46 INFO - nsLoadGroup::RemoveRequest(nsIRequest *,nsISupports *,tag_nsresult) [netwerk/base/src/nsLoadGroup.cpp:676] 03:41:46 INFO - nsDocument::DoUnblockOnload() [content/base/src/nsDocument.cpp:7968] 03:41:46 INFO - nsDocument::UnblockOnload(bool) [content/base/src/nsDocument.cpp:7895] 03:41:46 INFO - nsDocument::DispatchContentLoadedEvents() [content/base/src/nsDocument.cpp:4525] 03:41:46 INFO - nsRunnableMethodImpl<void ( nsDocument::*)(void),1>::Run() [obj-firefox/dist/include/nsThreadUtils.h:351] 03:41:46 INFO - nsThread::ProcessNextEvent(bool,bool *) [xpcom/threads/nsThread.cpp:627] 03:41:46 INFO - NS_ProcessNextEvent(nsIThread *,bool) [obj-firefox/xpcom/build/nsThreadUtils.cpp:238] 03:41:46 INFO - mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate *) [ipc/glue/MessagePump.cpp:82] 03:41:46 INFO - MessageLoop::RunInternal() [ipc/chromium/src/base/message_loop.cc:216] 03:41:46 INFO - MessageLoop::RunHandler() [ipc/chromium/src/base/message_loop.cc:210] 03:41:46 INFO - MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:184] 03:41:46 INFO - nsBaseAppShell::Run() [widget/xpwidgets/nsBaseAppShell.cpp:165] 03:41:46 INFO - nsAppShell::Run() [widget/windows/nsAppShell.cpp:113] 03:41:46 INFO - nsAppStartup::Run() [toolkit/components/startup/nsAppStartup.cpp:269] 03:41:46 INFO - XREMain::XRE_mainRun() [toolkit/xre/nsAppRunner.cpp:3880] 03:41:46 INFO - XREMain::XRE_main(int,char * * const,nsXREAppData const *) [toolkit/xre/nsAppRunner.cpp:3947] 03:41:46 INFO - XRE_main [toolkit/xre/nsAppRunner.cpp:4163] 03:41:46 INFO - do_main [browser/app/nsBrowserApp.cpp:274] 03:41:46 INFO - NS_internal_main(int,char * *) [browser/app/nsBrowserApp.cpp:639] 03:41:46 INFO - wmain [toolkit/xre/nsWindowsWMain.cpp:112] 03:41:46 INFO - __tmainCRTStartup [f:/dd/vctools/crt_bld/self_x86/crt/src/crtexe.c:552] 03:41:46 INFO - wmainCRTStartup [f:/dd/vctools/crt_bld/self_x86/crt/src/crtexe.c:371] 03:41:46 INFO - kernel32 + 0x16d4f

Comment hidden (Legacy TBPL/Treeherder Robot)

Mats Palmgren (inactive)

Comment 7

•

12 years ago

I can reproduce this assertion locally by loading the mochitest dom/indexedDB/test/test_bfcache.html in several tabs and then doing "Reload all Tabs". mPresShell and mPresContext are both non-null and mIsSticky=1. mPresShell has mFrozen=1 so it looks like the prevViewer->Destroy() in Show() on line 1929: http://hg.mozilla.org/mozilla-central/annotate/a6fb03a70c9d/layout/base/nsDocumentViewer.cpp#l1924 executed the "if (mSHEntry)" block here: http://hg.mozilla.org/mozilla-central/annotate/a6fb03a70c9d/layout/base/nsDocumentViewer.cpp#l1527 I guess we called Show() on a viewer before Hide() on its mPreviousViewer? (it looks like ~nsDocumentViewer() has fallback code to deal with this situation though)

Comment hidden (Legacy TBPL/Treeherder Robot)

RyanVM https://tbpl.mozilla.org/php/getParsedLog.php?id=22156256&tree=Mozilla-Central Rev3 WINNT 5.1 mozilla-central debug test mochitest-3 on 2013-04-23 13:31:39 slave: talos-r3-xp-111 13:46:48 INFO - 9575 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/indexedDB/test/test_bfcache.html | Assertion count 1 is greater than expected range 0-0 assertions. 13:57:22 INFO - 18711 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_bug751809.html | Test timed out. 13:57:24 INFO - 18712 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_bug751809.html | [SimpleTest.finish()] waitForFocus() was called a different number of times from the number of callbacks run. Maybe the test terminated prematurely -- be sure to use SimpleTest.waitForExplicitFinish(). - got 1, expected 0 13:57:30 INFO - 18717 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_bug771202.html | uncaught exception - TypeError: plugin.getObjectValue is not a function at http://mochi.test:8888/tests/dom/plugins/test/mochitest/test_bug771202.html:24 13:57:37 INFO - 18722 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_bug777098.html | uncaught exception - TypeError: plugin.getObjectValue is not a function at http://mochi.test:8888/tests/dom/plugins/test/mochitest/test_bug777098.html:24 13:57:43 INFO - 18727 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_bug784131.html | body plugin spawned - didn't expect null, but got it 13:57:43 INFO - 18728 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_bug784131.html | nested plugin spawned - didn't expect null, but got it 13:57:43 INFO - 18729 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_bug784131.html | uncaught exception - TypeError: body_embed.checkObjectValue is not a function at http://mochi.test:8888/tests/dom/plugins/test/mochitest/test_bug784131.html:42 14:02:53 INFO - 18734 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_bug813906.html | Test timed out. 14:03:00 INFO - 18739 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_cookies.html | uncaught exception - TypeError: pluginElement.setCookie is not a function at http://mochi.test:8888/tests/dom/plugins/test/mochitest/test_cookies.html:16 14:08:23 INFO - 18745 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_crashing.html | Test timed out. 14:08:24 INFO - 18746 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_crashing.html | This test did not leave any crash dumps behind, but we were expecting some! 14:08:37 INFO - 18967 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_enumerate.html | Should have enumerated .setColor 14:13:53 INFO - 18972 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/plugins/test/mochitest/test_fullpage.html | Test timed out. 14:13:53 INFO - 18973 ERROR TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | 4 test timeouts, giving up. 14:13:53 INFO - 18974 ERROR TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | Skipping 1673 remaining tests. 14:13:54 INFO - 18975 ERROR TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | /tests/dom/plugins/test/mochitest/test_fullpage.html finished in a non-clean fashion, probably because it didn't call SimpleTest.finish()

Comment hidden (Legacy TBPL/Treeherder Robot)

Mats Palmgren (inactive)

Updated

•

11 years ago

Priority: -- → P5

Comment hidden (Legacy TBPL/Treeherder Robot)

Ed Morley [:emorley]

Comment 28

•

10 years ago

Closing bugs where TBPLbot has previously commented, but have now not been modified for >3 months & do not contain the whiteboard strings for disabled/annotated tests or use the keyword leave-open. Filter on: mass-intermittent-bug-closure-2014-07

Status: NEW → RESOLVED

Closed: 10 years ago

Resolution: --- → WORKSFORME