Closed Bug 1040900 Opened 10 years ago Closed 9 years ago

Intermittent test_iframe_sandbox_popups.html | application timed out after 330 seconds with no output after "Assertion failure: !ipc::ProcessingUrgentMessages(), at xpcom/threads/nsThread.cpp:690"

Categories

(Core :: Security, defect)

x86
Linux
defect
Not set
normal

Tracking

()

RESOLVED WORKSFORME

People

(Reporter: RyanVM, Unassigned)

Details

(Keywords: assertion, crash, intermittent-failure)

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

Ubuntu VM 12.04 mozilla-inbound pgo test mochitest-e10s-1 on 2014-07-18 09:25:23 PDT for push ecdb409898a6
slave: tst-linux32-spot-092

09:36:22     INFO -  1996 INFO TEST-START | /tests/content/html/content/test/test_iframe_sandbox_popups.html
09:36:23     INFO -  1997 INFO Assertion failure: !ipc::ProcessingUrgentMessages(), at /builds/slave/m-in-lx-pgo-000000000000000000/build/xpcom/threads/nsThread.cpp:690
09:36:23     INFO -  1998 INFO UNKNOWN [/builds/slave/test/build/application/firefox/libxul.so +0x00305EC5]
09:36:23     INFO -  1999 INFO UNKNOWN [/builds/slave/test/build/application/firefox/libxul.so +0x00840047]
09:36:23     INFO -  2000 INFO UNKNOWN [/builds/slave/test/build/application/firefox/libxul.so +0x0082F53D]
09:36:23     INFO -  2001 INFO UNKNOWN [/builds/slave/test/build/application/firefox/libxul.so +0x0062BC8B]
09:36:23     INFO -  2002 INFO UNKNOWN [/builds/slave/test/build/application/firefox/libnspr4.so +0x000256B1]
09:36:23     INFO -  2003 INFO UNKNOWN [/lib/i386-linux-gnu/libpthread.so.0 +0x00006D4C]
09:36:24     INFO -  2004 INFO ###!!! [Parent][MessageChannel::SendAndWait] Error: Channel error: cannot send/recv
09:36:24     INFO -  2005 INFO System JS : ERROR resource://app/modules/sessionstore/TabState.jsm:92 - Error: child process crashed or timedout
09:36:24     INFO -  2006 INFO ###!!! [Parent][MessageChannel] Error: Channel error: cannot send/recv
09:36:24     INFO -  2007 INFO ###!!! [Parent][MessageChannel] Error: Channel error: cannot send/recv
09:36:24     INFO -  2008 INFO ###!!! [Parent][MessageChannel] Error: Channel error: cannot send/recv
09:36:24     INFO -  2009 INFO ###!!! [Parent][MessageChannel] Error: Channel error: cannot send/recv
09:36:24     INFO -  2010 INFO System JS : ERROR chrome://global/content/bindings/remote-browser.xml:37 - NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIMessageSender.sendAsyncMessage]
09:36:24     INFO -  2011 INFO ###!!! [Parent][MessageChannel] Error: Channel error: cannot send/recv
09:36:24     INFO -  2012 INFO ###!!! [Parent][MessageChannel] Error: Channel error: cannot send/recv
09:36:24     INFO -  2013 INFO ###!!! [Parent][MessageChannel] Error: Channel error: cannot send/recv
09:36:24     INFO -  2014 INFO ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv
09:36:24     INFO -  2015 INFO ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv
09:36:24     INFO -  2016 INFO ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv
09:36:24     INFO -  2017 INFO ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv
09:36:24     INFO -  2018 INFO ###!!! [Parent][MessageChannel] Error: Channel error: cannot send/recv
09:36:24     INFO -  2019 INFO ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv
09:36:24     INFO -  2020 INFO ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv
09:36:24     INFO -  2021 INFO ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv
09:36:24     INFO -  2022 INFO ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv
09:36:24     INFO -  2023 INFO ###!!! [Parent][MessageChannel] Error: Channel error: cannot send/recv
09:36:27     INFO -  2024 INFO 1405701387835	Browser.Experiments.Experiments	TRACE	Experiments #0::updateManifest()
09:36:27     INFO -  2025 INFO 1405701387836	Browser.Experiments.Experiments	TRACE	Experiments #0::_run
09:36:27     INFO -  2026 INFO 1405701387838	Browser.Experiments.Experiments	TRACE	Experiments #0::_main iteration
09:36:27     INFO -  2027 INFO 1405701387839	Browser.Experiments.Experiments	TRACE	Experiments #0::_loadManifest
09:36:27     INFO -  2028 INFO 1405701387840	Browser.Experiments.Experiments	TRACE	Experiments #0::httpGetRequest(http://127.0.0.1:8888/experiments-dummy/manifest)
09:36:27     INFO -  2029 INFO 1405701387853	Browser.Experiments.Experiments	ERROR	Experiments #0::httpGetRequest::onLoad() - Request to http://127.0.0.1:8888/experiments-dummy/manifest returned status 404
09:36:27     INFO -  2030 INFO 1405701387855	Browser.Experiments.Experiments	ERROR	Experiments #0::_loadManifest - failure to fetch/parse manifest (continuing anyway): Error: Experiments - XHR status for http://127.0.0.1:8888/experiments-dummy/manifest is 404
09:36:27     INFO -  2031 INFO 1405701387856	Browser.Experiments.Experiments	TRACE	Experiments #0::_evaluateExperiments
09:36:27     INFO -  2032 INFO 1405701387860	Browser.Experiments.Experiments	TRACE	Experiments #0::_main finished, scheduling next run
09:41:57     INFO -  2033 INFO TEST-PASS | /tests/content/html/content/test/test_iframe_sandbox_popups.html | sandboxed documents should be able to open windows when "allow-popups" is specified
09:41:57     INFO -  2034 INFO TEST-PASS | /tests/content/html/content/test/test_iframe_sandbox_popups.html | sandboxed documents should be able to open windows when "allow-popups" is specified
09:41:57     INFO -  2035 INFO TEST-PASS | /tests/content/html/content/test/test_iframe_sandbox_popups.html | sandboxed documents should be able to open windows when "allow-popups" is specified
09:41:57     INFO -  2036 INFO TEST-PASS | /tests/content/html/content/test/test_iframe_sandbox_popups.html | There are 3 popups tests that should pass
09:41:57     INFO -  2037 INFO MEMORY STAT vsize after test: 533299200
09:41:57     INFO -  2038 INFO MEMORY STAT residentFast after test: 148963328
09:41:57     INFO -  2039 INFO MEMORY STAT heapAllocated after test: 43362692
09:41:57     INFO -  2040 INFO TEST-UNEXPECTED-TIMEOUT | /tests/content/html/content/test/test_iframe_sandbox_popups.html | application timed out after 330 seconds with no output
09:41:57     INFO -  Xlib:  extension "RANDR" missing on display ":0".
09:41:58     INFO -  TEST-INFO | screentopng: exit 0
09:41:59     INFO -  TEST-INFO | Main app process: killed by SIGIOT
09:41:59     INFO -  2041 INFO TEST-UNEXPECTED-FAIL | /tests/content/html/content/test/test_iframe_sandbox_popups.html | application terminated with exit code 6
09:41:59     INFO -  2042 INFO runtests.py | Application ran for: 0:13:32.695332
09:41:59     INFO -  2043 INFO zombiecheck | Reading PID log: /tmp/tmpT2pa5Opidlog
09:41:59     INFO -  2044 INFO ==> process 1839 launched child process 1879
09:41:59     INFO -  2045 INFO zombiecheck | Checking for orphan process with PID: 1879
09:41:59     INFO -  mozcrash INFO | Downloading symbols from: https://ftp-ssl.mozilla.org/pub/mozilla.org/firefox/tinderbox-builds/mozilla-inbound-linux-pgo/1405693813/firefox-33.0a1.en-US.linux-i686.crashreporter-symbols.zip
09:42:24  WARNING -  PROCESS-CRASH | /tests/content/html/content/test/test_iframe_sandbox_popups.html | application crashed [@ nsThread::ProcessNextEvent(bool, bool*)]
09:42:24     INFO -  Crash dump filename: /tmp/tmpJ6Qg4A.mozrunner/minidumps/6a807e42-c230-5857-3d23f598-172dc311.dmp
09:42:24     INFO -  Operating system: Linux
09:42:24     INFO -                    0.0.0 Linux 3.2.0-23-generic-pae #36-Ubuntu SMP Tue Apr 10 22:19:09 UTC 2012 i686
09:42:24     INFO -  CPU: x86
09:42:24     INFO -       GenuineIntel family 6 model 45 stepping 7
09:42:24     INFO -       1 CPU
09:42:24     INFO -  Crash reason:  SIGSEGV
09:42:24     INFO -  Crash address: 0x0
09:42:24     INFO -  Thread 15 (crashed)
09:42:24     INFO -   0  libxul.so!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:ecdb409898a6 : 690 + 0x0]
09:42:24     INFO -      eip = 0xb3df5623   esp = 0xa92fefa0   ebp = 0xa92ff018   ebx = 0xb75d0ee4
09:42:24     INFO -      esi = 0xb395c980   edi = 0xb395cd9c   eax = 0x00000000   ecx = 0xb395d8ac
09:42:24     INFO -      edx = 0x00000000   efl = 0x00210286
09:42:24     INFO -      Found by: given as instruction pointer in context
09:42:24     INFO -   1  libxul.so!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:ecdb409898a6 : 265 + 0x12]
09:42:24     INFO -      eip = 0xb3dddec5   esp = 0xa92ff020   ebp = 0xa92ff058   ebx = 0xb75d0ee4
09:42:24     INFO -      esi = 0xa92ff04c   edi = 0xaa5fcd60
09:42:24     INFO -      Found by: call frame info
09:42:24     INFO -   2  libxul.so!mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [MessagePump.cpp:ecdb409898a6 : 326 + 0x12]
09:42:24     INFO -      eip = 0xb4318047   esp = 0xa92ff060   ebp = 0xa92ff0a8   ebx = 0xb75d0ee4
09:42:24     INFO -      esi = 0xab0a66a0   edi = 0xaa5fcd60
09:42:24     INFO -      Found by: call frame info
09:42:24     INFO -   3  libxul.so!MessageLoop::Run() [message_loop.cc:ecdb409898a6 : 229 + 0xb]
09:42:24     INFO -      eip = 0xb430753d   esp = 0xa92ff0b0   ebp = 0xa92ff0d8   ebx = 0xb75d0ee4
09:42:24     INFO -      esi = 0xaa5c3970   edi = 0xab0a66a0
09:42:24     INFO -      Found by: call frame info
09:42:24     INFO -   4  libxul.so!nsThread::ThreadFunc(void*) [nsThread.cpp:ecdb409898a6 : 347 + 0x7]
09:42:24     INFO -      eip = 0xb4103c8b   esp = 0xa92ff0e0   ebp = 0xa92ff128   ebx = 0xb75d0ee4
09:42:24     INFO -      esi = 0xaa5c3970   edi = 0xab0a66a0
09:42:24     INFO -      Found by: call frame info
09:42:24     INFO -   5  libnspr4.so!_pt_root [ptthread.c:ecdb409898a6 : 212 + 0x8]
09:42:24     INFO -      eip = 0xb3abe6b1   esp = 0xa92ff130   ebp = 0xa92ff168   ebx = 0xb3ad154c
09:42:24     INFO -      esi = 0x00000000   edi = 0xab097ac0
09:42:24     INFO -      Found by: call frame info
09:42:24     INFO -   6  libpthread-2.15.so + 0x6d4b
09:42:24     INFO -      eip = 0xb77b0d4c   esp = 0xa92ff170   ebp = 0xa92ff268   ebx = 0xb77c1ff4
09:42:24     INFO -      esi = 0x00000000   edi = 0x003d0f00
09:42:24     INFO -      Found by: call frame info
Move process sandboxing bugs to their new, separate component.

(Sorry for the bugspam; filter on 3c21328c-8cfb-4819-9d88-f6e965067350.)
Component: Security → Security: Process Sandboxing
Inactive; closing (see bug 1180138).
Status: NEW → RESOLVED
Closed: 9 years ago
Resolution: --- → WORKSFORME
(In reply to Jed Davis [:jld] {UTC-7} from comment #1)
> Move process sandboxing bugs to their new, separate component.

That's wrong; this is an <iframe sandbox> bug, not a process sandboxing bug.
Component: Security: Process Sandboxing → Security
You need to log in before you can comment on or make changes to this bug.