Closed Bug 951288 Opened 6 years ago Closed 9 months ago

Intermittent test_bug495300.html | Assertion count 1 is greater than expected range (Start time must be before end time: 'startTime < endTime')

Categories

(Core :: Audio/Video: Playback, defect, P5)

defect

Tracking

()

RESOLVED WORKSFORME
Tracking Status
firefox27 --- unaffected
firefox28 --- affected
firefox29 --- affected
firefox30 --- affected
firefox-esr24 --- unaffected

People

(Reporter: RyanVM, Unassigned, NeedInfo)

References

Details

(Keywords: assertion, intermittent-failure)

Attachments

(1 obsolete file)

+++ This bug was initially created as a clone of Bug #846769 +++

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

Rev4 MacOSX Snow Leopard 10.6 mozilla-inbound debug test mochitest-1 on 2013-12-06 05:56:38 PST for push 099f65a712a8
slave: talos-r4-snow-075

06:25:46     INFO -  154112 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | [started bug516323.indexed.ogv-5] Length of array should match number of running tests
06:25:46     INFO -  [Parent 898] WARNING: Need a principal to compare this to!: file ../../../caps/src/nsPrincipal.cpp, line 264
06:25:46     INFO -  System JS : ERROR (null):0 - uncaught exception: 2147746065
06:25:46     INFO -  [Parent 898] ###!!! ASSERTION: Start time must be before end time: 'startTime < endTime', file ../../../../content/media/ogg/OggReader.cpp, line 1154
06:25:46     INFO -  JSPrincipals::dump()+0x0068f2af [/builds/slave/talos-slave/test/build/application/FirefoxNightlyDebug.app/Contents/MacOS/XUL +0x016cd19f]
06:25:46     INFO -  JSPrincipals::dump()+0x006197f4 [/builds/slave/talos-slave/test/build/application/FirefoxNightlyDebug.app/Contents/MacOS/XUL +0x016576e4]
06:25:46     INFO -  JSPrincipals::dump()+0x00617f4e [/builds/slave/talos-slave/test/build/application/FirefoxNightlyDebug.app/Contents/MacOS/XUL +0x01655e3e]
06:25:46     INFO -  nsRunnableMethodImpl<void (mozilla::MediaDecoderStateMachine::*)(), void, true>::Run() [obj-firefox/dist/include/nsThreadUtils.h:383]
06:25:46     INFO -  XRE_AddJarManifestLocation+0x0000e0ee [/builds/slave/talos-slave/test/build/application/FirefoxNightlyDebug.app/Contents/MacOS/XUL +0x001b513e]
06:25:46     INFO -  UNKNOWN [/builds/slave/talos-slave/test/build/application/FirefoxNightlyDebug.app/Contents/MacOS/XUL +0x0012d623]
06:25:46     INFO -  XRE_AddJarManifestLocation+0x0000cdad [/builds/slave/talos-slave/test/build/application/FirefoxNightlyDebug.app/Contents/MacOS/XUL +0x001b3dfd]
06:25:47     INFO -  System JS : ERROR (null):0 - uncaught exception: 2147746065
06:25:47     INFO -  _pt_root
06:25:47     INFO -  _pthread_start+0x0000014b [/usr/lib/libSystem.B.dylib +0x00039fd6]
06:25:47     INFO -  154113 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | Got expected 'ended' event: bug516323.indexed.ogv
06:25:47     INFO -  154114 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | currentTime equals duration: bug516323.indexed.ogv
06:25:47     INFO -  154115 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | [finished bug516323.indexed.ogv-5] Length of array should match number of running tests
06:25:47     INFO -  System JS : ERROR (null):0 - uncaught exception: 2147746065
06:25:47     INFO -  154116 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | [started split.webm-6] Length of array should match number of running tests
06:25:47     INFO -  154117 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | Got expected 'ended' event: seek.ogv
06:25:47     INFO -  154118 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | currentTime equals duration: seek.ogv
06:25:47     INFO -  154119 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | [finished seek.ogv-2] Length of array should match number of running tests
06:25:48     INFO -  [Parent 898] WARNING: Need a principal to compare this to!: file ../../../caps/src/nsPrincipal.cpp, line 264
06:25:48     INFO -  System JS : ERROR (null):0 - uncaught exception: 2147746065
06:25:48     INFO -  154120 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | [started detodos.opus-7] Length of array should match number of running tests
06:25:48     INFO -  [Parent 898] WARNING: Need a principal to compare this to!: file ../../../caps/src/nsPrincipal.cpp, line 264
06:25:48     INFO -  154121 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | Got expected 'ended' event: split.webm
06:25:48     INFO -  154122 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | currentTime equals duration: split.webm
06:25:48     INFO -  154123 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | [finished split.webm-6] Length of array should match number of running tests
06:25:48     INFO -  154124 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | Got expected 'ended' event: detodos.opus
06:25:48     INFO -  154125 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | currentTime equals duration: detodos.opus
06:25:48     INFO -  154126 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | [finished detodos.opus-7] Length of array should match number of running tests
06:25:48     INFO -  System JS : ERROR (null):0 - uncaught exception: 2147746065
06:25:49     INFO -  System JS : ERROR (null):0 - uncaught exception: 2147746065
06:25:49     INFO -  154127 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | [started owl.mp3-9] Length of array should match number of running tests
06:25:49     INFO -  System JS : ERROR (null):0 - uncaught exception: 2147746065
06:25:49     INFO -  [Parent 898] WARNING: Need a principal to compare this to!: file ../../../caps/src/nsPrincipal.cpp, line 264
06:25:50     INFO -  154128 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | Got expected 'ended' event: owl.mp3
06:25:50     INFO -  154129 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | currentTime equals duration: owl.mp3
06:25:50     INFO -  154130 INFO TEST-PASS | /tests/content/media/test/test_bug495300.html | [finished owl.mp3-9] Length of array should match number of running tests
06:25:50     INFO -  System JS : ERROR (null):0 - uncaught exception: 2147746065
06:25:50     INFO -  System JS : ERROR (null):0 - uncaught exception: 2147746065
06:25:50     INFO -  154131 INFO TEST-INFO | /tests/content/media/test/test_bug495300.html | Finished at Fri Dec 06 2013 06:25:50 GMT-0800 (PST) (1386339950.955s)
06:25:50     INFO -  154132 INFO TEST-INFO | /tests/content/media/test/test_bug495300.html | Running time: 8.589s
06:25:50     INFO -  154133 INFO TEST-INFO | MEMORY STAT vsize after test: 3854565376
06:25:50     INFO -  154134 INFO TEST-INFO | MEMORY STAT residentFast after test: 384225280
06:25:51     INFO -  154135 INFO TEST-END | /tests/content/media/test/test_bug495300.html | finished in 8823ms
06:25:51     INFO -  ++DOMWINDOW == 18 (0x14e659bd8) [pid = 898] [serial = 4898] [outer = 0x126acb6a8]
06:25:51     INFO -  154136 ERROR TEST-UNEXPECTED-FAIL | /tests/content/media/test/test_bug495300.html | Assertion count 1 is greater than expected range 0-0 assertions.
Chris, you seem like a good candidate for this review :)

This will make the oranges stop, but IIUC, the warnings will still hit the logs when tests hit this. Seems like our best short-term option here since 3 months have gone by without a fix.
Attachment #8378235 - Flags: review?(cpearce)
Comment on attachment 8378235 [details] [diff] [review]
convert NS_ASSERTION to NS_WARNING

Review of attachment 8378235 [details] [diff] [review]:
-----------------------------------------------------------------

Change the commit message from "fix" to "hide".
Attachment #8378235 - Flags: review?(cpearce) → review+
Keywords: leave-open
Assignee: ryanvm → nobody
So NS_WARN_IF_FALSE would have been a better idea. My bad.
https://hg.mozilla.org/integration/mozilla-inbound/rev/1acdcb671497
Component: Audio/Video → Audio/Video: Playback
P5
Priority: -- → P5
Attachment #8378235 - Attachment is obsolete: true
The leave-open keyword is there and there is no activity for 6 months.
:drno, maybe it's time to close this bug?
Flags: needinfo?(drno)
Status: NEW → RESOLVED
Closed: 9 months ago
Resolution: --- → WORKSFORME
You need to log in before you can comment on or make changes to this bug.