Closed Bug 802471 Opened 12 years ago Closed 12 years ago

Intermittent Assertion failure: this != runtime->mReleaseRunnable, at XPCJSRuntime.cpp:603 during test_smilCSSFromTo.xhtml, test_smilBackwardsSeeking.xhtml, test_smilCSSInvalidValues.xhtml

Categories

(Core :: XPConnect, defect)

x86
Linux
defect
Not set
normal

Tracking

()

RESOLVED WORKSFORME

People

(Reporter: tbsaunde, Assigned: mccr8)

References

Details

(Keywords: intermittent-failure)

Log

Rev3 Fedora 12 mozilla-central debug test mochitests-1/5 on 2012-10-16 18:29:26 PDT for push 044d1b974385

slave: talos-r3-fed-014

View Full Log

Download Full Log
Summary

Assertion failure: this != runtime->mReleaseRunnable, at ../../../../js/xpconnect/src/XPCJSRuntime.cpp:603
TEST-UNEXPECTED-FAIL | /tests/content/smil/test/test_smilCSSFromTo.xhtml | Exited with code 11 during test run
PROCESS-CRASH | /tests/content/smil/test/test_smilCSSFromTo.xhtml | application crashed (minidump found)
Thread 0 (crashed)
TEST-UNEXPECTED-FAIL | automationutils.processLeakLog() | missing output line for total leaks!
TEST-UNEXPECTED-FAIL | tab process 2458 | automationutils.processLeakLog() | missing output line for total leaks!
TEST-UNEXPECTED-FAIL | plugin process 2491 | automationutils.processLeakLog() | missing output line for total leaks!

Relevant Parts of the Log

Skipping 151217 lines...

133200 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking that 'from' value is set at start of animation
133201 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking value halfway through animation
133202 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [remove-mode] checking that animation is cleared at end of animation
133203 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [remove-mode] checking that animation is cleared after end of animation
133204 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking that base value is set before start of animation
133205 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking that 'from' value is set at start of animation
133206 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking value halfway through animation
133207 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [freeze-mode] checking that final value is set at end of animation
133208 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [freeze-mode] checking that final value is set after end of animation
133209 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking that base value is set before start of animation
133210 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking that 'from' value is set at start of animation
133211 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking value halfway through animation
133212 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [remove-mode] checking that animation is cleared at end of animation
133213 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [remove-mode] checking that animation is cleared after end of animation
133214 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking that base value is set before start of animation
133215 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking that 'from' value is set at start of animation
133216 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking value halfway through animation
133217 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [freeze-mode] checking that final value is set at end of animation
133218 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [freeze-mode] checking that final value is set after end of animation
133219 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking that base value is set before start of animation
133220 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking that 'from' value is set at start of animation
133221 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking value halfway through animation
133222 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [remove-mode] checking that animation is cleared at end of animation
133223 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [remove-mode] checking that animation is cleared after end of animation
133224 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking that base value is set before start of animation
133225 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking that 'from' value is set at start of animation
133226 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: checking value halfway through animation
133227 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [freeze-mode] checking that final value is set at end of animation
133228 INFO TEST-PASS | /tests/content/smil/test/test_smilCSSFromBy.xhtml | stroke-width: [freeze-mode] checking that final value is set after end of animation
133229 INFO TEST-END | /tests/content/smil/test/test_smilCSSFromBy.xhtml | finished in 1041ms
133230 INFO TEST-START | /tests/content/smil/test/test_smilCSSFromTo.xhtml
++DOMWINDOW == 29 (0xded20f4) [serial = 3114] [outer = 0xaa1c070]
--DOMWINDOW == 28 (0xaab6624) [serial = 3112] [outer = 0xaa1c070] [url = http://mochi.test:8888/tests/content/smil/test/test_smilCSSFontStretchRelative.xhtml]
--DOMWINDOW == 27 (0x9e0c3a4) [serial = 3111] [outer = 0xaa1c070] [url = http://mochi.test:8888/tests/content/smil/test/test_smilBackwardsSeeking.xhtml]
--DOMWINDOW == 26 (0xaabf9e4) [serial = 3107] [outer = 0xaa1c070] [url = http://mochi.test:8888/tests/content/smil/test/test_smilAccessKey.xhtml]
--DOMWINDOW == 25 (0x9d8471c) [serial = 3101] [outer = (nil)] [url = http://mochi.test:8888/tests/content/media/test/test_wave_data_s16.html]
--DOMWINDOW == 24 (0x9bb31bc) [serial = 3100] [outer = (nil)] [url = http://mochi.test:8888/tests/content/media/test/test_volume.html]
--DOMWINDOW == 23 (0xdea2e7c) [serial = 3099] [outer = (nil)] [url = http://mochi.test:8888/tests/content/media/test/test_video_to_canvas.html]
--DOMWINDOW == 22 (0xa86de2c) [serial = 3098] [outer = (nil)] [url = http://mochi.test:8888/tests/content/media/test/test_too_many_elements.html]
--DOMWINDOW == 21 (0xbed31f4) [serial = 3097] [outer = (nil)] [url = http://mochi.test:8888/tests/content/media/test/test_timeupdate_small_files.html]
Assertion failure: this != runtime->mReleaseRunnable, at ../../../../js/xpconnect/src/XPCJSRuntime.cpp:603
[Child 2458] WARNING: shutting down early because of crash!: file ../../../dom/ipc/ContentChild.cpp, line 802
[Child 2458] WARNING: content process _exit()ing: file ../../../dom/ipc/ContentChild.cpp, line 847
WARNING: shutting down early because of crash!: file ../../../../dom/plugins/ipc/PluginModuleChild.cpp, line 704
WARNING: plugin process _exit()ing: file ../../../../dom/plugins/ipc/PluginModuleChild.cpp, line 669
TEST-UNEXPECTED-FAIL | /tests/content/smil/test/test_smilCSSFromTo.xhtml | Exited with code 11 during test run
INFO | automation.py | Application ran for: 0:32:24.577649
INFO | automation.py | Reading PID log: /tmp/tmpD-j2cdpidlog
==> process 2367 launched child process 2435
==> process 2367 launched child process 2446
==> process 2367 launched child process 2458
==> process 2367 launched child process 2469
==> process 2367 launched child process 2480
==> process 2367 launched child process 2491
INFO | automation.py | Checking for orphan process with PID: 2435
INFO | automation.py | Checking for orphan process with PID: 2446
INFO | automation.py | Checking for orphan process with PID: 2458
INFO | automation.py | Checking for orphan process with PID: 2469
INFO | automation.py | Checking for orphan process with PID: 2480
INFO | automation.py | Checking for orphan process with PID: 2491
Downloading symbols from: http://ftp.mozilla.org/pub/mozilla.org/firefox/tinderbox-builds/mozilla-central-linux-debug/1350433325/firefox-19.0a1.en-US.linux-i686.crashreporter-symbols.zip
PROCESS-CRASH | /tests/content/smil/test/test_smilCSSFromTo.xhtml | application crashed (minidump found)
Crash dump filename: /tmp/tmpsjHlkZ/minidumps/2ef59684-5df7-c663-7f31c13f-72d87a3c.dmp
Operating system: Linux
                  0.0.0 Linux 2.6.31.5-127.fc12.i686.PAE #1 SMP Sat Nov 7 21:25:57 EST 2009 i686
CPU: x86
     GenuineInte family 6 model 23 stepping 10
     2 CPUs

Crash reason:  SIGSEGV
Crash address: 0x0

Thread 0 (crashed)
 0  libxul.so!XPCIncrementalReleaseRunnable::~XPCIncrementalReleaseRunnable [XPCJSRuntime.cpp : 603 + 0x19]
    eip = 0x01bd87d7   esp = 0xbffb9060   ebp = 0xbffb9078   ebx = 0x0311bba0
    esi = 0x0bc7aac0   edi = 0x00000000   eax = 0x00000000   ecx = 0x00c5a32c
    edx = 0x00000000   efl = 0x00210286
    Found by: given as instruction pointer in context
 1  libxul.so!XPCIncrementalReleaseRunnable::~XPCIncrementalReleaseRunnable [XPCJSRuntime.cpp : 605 + 0x8]
    eip = 0x01bd8830   esp = 0xbffb9080   ebp = 0xbffb9098   ebx = 0x0311bba0
    esi = 0x0bc7aac0   edi = 0x00000000
    Found by: call frame info
 2  libxul.so!nsRunnable::Release() [nsThreadUtils.cpp : 30 + 0x3]
    eip = 0x02156f95   esp = 0xbffb90a0   ebp = 0xbffb90c8   ebx = 0x0311bba0
    esi = 0x0bc7aac0   edi = 0x00000000
    Found by: call frame info
 3  libxul.so!nsCOMPtr<nsIRunnable>::~nsCOMPtr [nsCOMPtr.h : 492 + 0x8]
    eip = 0x010c72fe   esp = 0xbffb90d0   ebp = 0xbffb90e8   ebx = 0x0311bba0
    esi = 0xbffb9130   edi = 0x00000000
    Found by: call frame info
 4  libxul.so!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp : 603 + 0xe]
    eip = 0x0219d1a4   esp = 0xbffb90f0   ebp = 0xbffb9158   ebx = 0x0311bba0
    esi = 0x081f9da0   edi = 0x00000000
    Found by: call frame info
 5  libxul.so!NS_ProcessNextEvent_P(nsIThread*, bool) [nsThreadUtils.cpp : 220 + 0x11]
    eip = 0x02157193   esp = 0xbffb9160   ebp = 0xbffb9188   ebx = 0x0311bba0
    esi = 0x00000000   edi = 0x081f9460
    Found by: call frame info
 6  libxul.so!mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) [MessagePump.cpp : 82 + 0xb]
    eip = 0x01fe1864   esp = 0xbffb9190   ebp = 0xbffb91d8   ebx = 0x0311bba0
    esi = 0x081f9188   edi = 0x081f9460
    Found by: call frame info
 7  libxul.so!MessageLoop::RunInternal() [message_loop.cc : 215 + 0x8]
    eip = 0x021ce782   esp = 0xbffb91e0   ebp = 0xbffb9208   ebx = 0x0311bba0
    esi = 0x081f9460   edi = 0x081f9da0
    Found by: call frame info
 8  libxul.so!MessageLoop::Run() [message_loop.cc : 208 + 0x6]
    eip = 0x021ce7a7   esp = 0xbffb9210   ebp = 0xbffb9238   ebx = 0x0311bba0
    esi = 0x081f9460   edi = 0x081f9da0
    Found by: call frame info
 9  libxul.so!nsBaseAppShell::Run() [nsBaseAppShell.cpp : 163 + 0xd]
    eip = 0x01eed239   esp = 0xbffb9240   ebp = 0xbffb9268   ebx = 0x0311bba0

Skipping 1612 lines...

0xb4bbb000 - 0xb4bddfff  LiberationSans-Regular.ttf  ???
0xb5714000 - 0xb5725fff  n019004l.pfb  ???
0xb5730000 - 0xb5747fff  mime.cache  ???
0xb5748000 - 0xb57a7fff  SYSV00000000 (deleted)  ???
0xb61a9000 - 0xb69fffff  omni.ja  ???
0xb6b0a000 - 0xb6b0afff  mime.cache  ???
0xb6b0c000 - 0xb6b13fff  places.sqlite-shm  ???
0xb6b14000 - 0xb6babfff  DejaVuSans.ttf  ???
0xb6bac000 - 0xb6baefff  87f5e051180a7a75f16eb6fe7dbd3749-x86.cache-2  ???
0xb6baf000 - 0xb6bb4fff  b79f3aaa7d385a141ab53ec885cc22a8-x86.cache-2  ???
0xb6bb5000 - 0xb6bb6fff  2e1514a9fdd499050989183bb65136db-x86.cache-2  ???
0xb6bb7000 - 0xb6bb8fff  5c755b2f27115486aa6359c84dd3cbda-x86.cache-2  ???
0xb6bb9000 - 0xb6bb9fff  3f821257dd33660ba7bbb45c32deb84c-x86.cache-2  ???
0xb6bba000 - 0xb6bbbfff  830f035fa84a65ce80e050178dbb630d-x86.cache-2  ???
0xb6bbc000 - 0xb6bbcfff  81a173283b451552b599cfaafd6236bd-x86.cache-2  ???
0xb6bbd000 - 0xb6bbdfff  6cfc7d49b27ba7d3eb71ab86e04def2c-x86.cache-2  ???
0xb6bbe000 - 0xb6bbefff  b887eea8f1b96e1d899b44ed6681fc27-x86.cache-2  ???
0xb6bbf000 - 0xb6bbffff  860639f272b8b4b3094f9e399e41bccd-x86.cache-2  ???
0xb6bc0000 - 0xb6bc0fff  211368abcb0ff835c229ff05c9ec01dc-x86.cache-2  ???
0xb6bc1000 - 0xb6bc1fff  c46020d7221988a13df853d2b46304fc-x86.cache-2  ???
0xb6bc2000 - 0xb6bc2fff  d290456e58f67f52b0f8f224126f9ea8-x86.cache-2  ???
0xb6bc3000 - 0xb6bc3fff  b63c21b9c3e5b4a4009aa5966b421593-x86.cache-2  ???
0xb6bc4000 - 0xb6bc4fff  df893b4576ad6107f9397134092c4059-x86.cache-2  ???
0xb6bc5000 - 0xb6bc5fff  ff627ea95a65192232277bf7c8a56f23-x86.cache-2  ???
0xb6bc6000 - 0xb6bc6fff  900402270e15d763a6e008bb2d4c7686-x86.cache-2  ???
0xb6bc7000 - 0xb6bc7fff  2881ed3fd21ca306ddad6f9b0dd3189f-x86.cache-2  ???
0xb6bc8000 - 0xb6bc8fff  3c3fb04d32a5211b073874b125d29701-x86.cache-2  ???
0xb6bc9000 - 0xb6bc9fff  e61abf8156cc476151baa07d67337cae-x86.cache-2  ???
0xb6bca000 - 0xb6bccfff  b67b32625a2bb51b023d3814a918f351-x86.cache-2  ???
0xb6bcd000 - 0xb6bcdfff  d3379abda271c4acd2ad0c01f565d0b0-x86.cache-2  ???
0xb6bce000 - 0xb6bd0fff  46b47dbc682d2ca4191e148ea7bde7f2-x86.cache-2  ???
0xb6bd1000 - 0xb6bd1fff  b4d0b56f766d89640448751fcd18ec1e-x86.cache-2  ???
0xb6bd2000 - 0xb6bd8fff  12b26b760a24f8b4feb03ad48a333a72-x86.cache-2  ???
0xb6bd9000 - 0xb6be0fff  18db0204b1f108dd01663673626fcd3d-x86.cache-2  ???
0xb75e2000 - 0xb77e1fff  locale-archive  ???
0xb77e4000 - 0xb77e9fff  928306c3ad40271d946e41014a49fc28-x86.cache-2  ???
0xb77ea000 - 0xb77eafff  1248881498ac025e45c3042f6afe9284-x86.cache-2  ???
0xb77eb000 - 0xb77f1fff  gconv-modules.cache  ???

Saved dump as /home/cltbld/talos-slave/test/minidumps/2ef59684-5df7-c663-7f31c13f-72d87a3c.dmp
TEST-UNEXPECTED-FAIL | automationutils.processLeakLog() | missing output line for total leaks!
==> process 2435 will purposefully crash
INFO | automationutils.processLeakLog() | process 2435 was deliberately crashed and thus has no leak log
TEST-UNEXPECTED-FAIL | tab process 2458 | automationutils.processLeakLog() | missing output line for total leaks!
==> process 2480 will purposefully crash
INFO | automationutils.processLeakLog() | process 2480 was deliberately crashed and thus has no leak log
==> process 2469 will purposefully crash
INFO | automationutils.processLeakLog() | process 2469 was deliberately crashed and thus has no leak log
TEST-UNEXPECTED-FAIL | plugin process 2491 | automationutils.processLeakLog() | missing output line for total leaks!
==> process 2446 will purposefully crash
INFO | automationutils.processLeakLog() | process 2446 was deliberately crashed and thus has no leak log

INFO | runtests.py | Running tests: end.
program finished with exit code 11
elapsedTime=1966.331567
TinderboxPrint: mochitest-plain-1<br/><em class="testfail">T-FAIL</em>&nbsp;<em class="testfail">L-FAIL</em>
Unknown Error: command finished with exit code: 11
========= Finished 'python mochitest/runtests.py ...' warnings (results: 1, elapsed: 32 mins, 49 secs) (at 2012-10-16 19:02:57.311004) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2012-10-16 19:02:57.312925) =========
rm -rf build
 in dir /home/cltbld/talos-slave/test/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'build']
 environment:
  CVS_RSH=ssh
  DISPLAY=:0.0
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoreboth
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=talos-r3-fed-014.build.mozilla.org
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/home/cltbld/bin:/tools/buildbot-0.8.0/bin:/usr/kerberos/sbin:/usr/kerberos/bin:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin
  PWD=/home/cltbld/talos-slave/test
  SHELL=/bin/bash
  SHLVL=1
  SSH_ASKPASS=/usr/libexec/openssh/gnome-ssh-askpass
  TERM=xterm
  USER=cltbld
  _=/home/cltbld/bin/python
 using PTY: False
program finished with exit code 0
elapsedTime=0.302210
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2012-10-16 19:02:57.660117) =========

Skipping 5 lines...
https://tbpl.mozilla.org/php/getParsedLog.php?id=16220843&tree=Fx-Team
Summary: intermitant Assertion failure: this != runtime->mReleaseRunnable, at ../../../../js/xpconnect → Intermittent Assertion failure: this != runtime->mReleaseRunnable, at ../../../../js/xpconnect/src/XPCJSRuntime.cpp:603 during test_smilCSSFromTo.xhtml
https://tbpl.mozilla.org/php/getParsedLog.php?id=16244689&tree=Try

Might be needing that extra space in the summary...
Summary: Intermittent Assertion failure: this != runtime->mReleaseRunnable, at ../../../../js/xpconnect/src/XPCJSRuntime.cpp:603 during test_smilCSSFromTo.xhtml → Intermittent Assertion failure: this != runtime->mReleaseRunnable, at XPCJSRuntime.cpp:603 during test_smilCSSFromTo.xhtml, test_smilBackwardsSeeking.xhtml
Component: SVG → XPConnect
https://tbpl.mozilla.org/php/getParsedLog.php?id=16524870&tree=Mozilla-Inbound
Summary: Intermittent Assertion failure: this != runtime->mReleaseRunnable, at XPCJSRuntime.cpp:603 during test_smilCSSFromTo.xhtml, test_smilBackwardsSeeking.xhtml → Intermittent Assertion failure: this != runtime->mReleaseRunnable, at XPCJSRuntime.cpp:603 during test_smilCSSFromTo.xhtml, test_smilBackwardsSeeking.xhtml, test_smilCSSInvalidValues.xhtml
Assignee: nobody → continuation
We've gone about 5 days without hitting this, marking WFM.
Status: NEW → RESOLVED
Closed: 12 years ago
Resolution: --- → WORKSFORME
Whiteboard: [orange]
You need to log in before you can comment on or make changes to this bug.