Closed Bug 1532827 Opened 6 years ago Closed 6 years ago

Intermittent dom/media/test/test_video_dimensions.html | assertion count 1 is more than expected 0 assertions

Categories

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

Product:
Core
Component:
Audio/Video: Playback
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression)

#[markdown(off)]
Filed by: cbrindusan [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=232015728&repo=autoland

https://queue.taskcluster.net/v1/task/U6dvEWYZQ6ennvqUd28sPg/runs/0/artifacts/public/logs/live_backing.log

[task 2019-03-05T23:55:48.651Z] 23:55:48 INFO - TEST-START | dom/media/test/test_video_dimensions.html
[task 2019-03-05T23:55:48.769Z] 23:55:48 INFO - GECKO(1073) | ++DOMWINDOW == 15 (0x7ff850108c00) [pid = 1184] [serial = 340] [outer = 0x7ff85c79f100]
[task 2019-03-05T23:55:48.846Z] 23:55:48 INFO - GECKO(1073) | ++DOCSHELL 0x7ff8503ac000 == 4 [pid = 1184] [id = {a9db6072-039b-4bd2-a019-6b13f13baafc}]
[task 2019-03-05T23:55:48.847Z] 23:55:48 INFO - GECKO(1073) | ++DOMWINDOW == 16 (0x7ff850c255c0) [pid = 1184] [serial = 341] [outer = (nil)]
[task 2019-03-05T23:55:48.873Z] 23:55:48 INFO - GECKO(1073) | ++DOMWINDOW == 17 (0x7ff850374400) [pid = 1184] [serial = 342] [outer = 0x7ff850c255c0]
[task 2019-03-05T23:55:49.220Z] 23:55:49 INFO - GECKO(1073) | JavaScript error: http://mochi.test:8888/tests/dom/media/test/manifest.js, line 1635: AbortError: The fetching process for the media resource was aborted by the user agent at the user's request.
[task 2019-03-05T23:55:49.420Z] 23:55:49 INFO - GECKO(1073) | [Child 1184, MediaStreamGrph] ###!!! ASSERTION: Timestamps must not decrease: 'aImages[i].mTimeStamp >= aImages[i - 1].mTimeStamp', file /builds/worker/workspace/build/src/gfx/layers/ImageContainer.cpp, line 269
[task 2019-03-05T23:57:28.619Z] 23:57:28 INFO - GECKO(1073) | #01: mozilla::layers::ImageContainer::SetCurrentImages(nsTArray<mozilla::layers::ImageContainer::NonOwningImage> const&) [xpcom/threads/RecursiveMutex.h:84]
[task 2019-03-05T23:57:28.619Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.620Z] 23:57:28 INFO - GECKO(1073) | #02: mozilla::VideoFrameContainer::SetCurrentFramesLocked(mozilla::gfx::IntSizeTyped<mozilla::gfx::UnknownUnits> const&, nsTArray<mozilla::layers::ImageContainer::NonOwningImage> const&) [dom/media/VideoFrameContainer.cpp:274]
[task 2019-03-05T23:57:28.622Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.623Z] 23:57:28 INFO - GECKO(1073) | #03: mozilla::VideoFrameContainer::SetCurrentFrames(mozilla::VideoSegment const&) [memory/mozalloc/mozalloc.h:131]
[task 2019-03-05T23:57:28.624Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.625Z] 23:57:28 INFO - GECKO(1073) | #04: mozilla::SourceMediaStream::AddDirectTrackListenerImpl(already_AddRefed<mozilla::DirectMediaStreamTrackListener>, int) [dom/media/MediaStreamGraph.cpp:0]
[task 2019-03-05T23:57:28.626Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.627Z] 23:57:28 INFO - GECKO(1073) | #05: mozilla::TrackUnionStream::AddDirectTrackListenerImpl(already_AddRefed<mozilla::DirectMediaStreamTrackListener>, int) [dom/media/TrackUnionStream.cpp:391]
[task 2019-03-05T23:57:28.628Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.629Z] 23:57:28 INFO - GECKO(1073) | #06: mozilla::TrackUnionStream::AddDirectTrackListenerImpl(already_AddRefed<mozilla::DirectMediaStreamTrackListener>, int) [dom/media/TrackUnionStream.cpp:391]
[task 2019-03-05T23:57:28.630Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.631Z] 23:57:28 INFO - GECKO(1073) | #07: mozilla::MediaStream::AddVideoOutputImpl(already_AddRefed<mozilla::MediaStreamVideoSink>, int) [dom/media/MediaStreamGraph.cpp:2141]
[task 2019-03-05T23:57:28.632Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.633Z] 23:57:28 INFO - GECKO(1073) | #08: mozilla::MediaStream::AddVideoOutput(mozilla::MediaStreamVideoSink*, int)::Message::Run() [dom/media/MediaStreamGraph.cpp:2170]
[task 2019-03-05T23:57:28.633Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.634Z] 23:57:28 INFO - GECKO(1073) | #09: mozilla::MediaStreamGraphImpl::RunMessagesInQueue() [dom/media/MediaStreamGraph.cpp:1174]
[task 2019-03-05T23:57:28.635Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.637Z] 23:57:28 INFO - GECKO(1073) | #10: mozilla::MediaStreamGraphImpl::OneIteration(long) [dom/media/MediaStreamGraph.cpp:1394]
[task 2019-03-05T23:57:28.639Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.642Z] 23:57:28 INFO - GECKO(1073) | #11: mozilla::ThreadedDriver::RunThread() [dom/media/GraphDriver.cpp:308]
[task 2019-03-05T23:57:28.644Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.645Z] 23:57:28 INFO - GECKO(1073) | #12: mozilla::MediaStreamGraphInitThreadRunnable::Run() [mfbt/RefPtr.h:75]
[task 2019-03-05T23:57:28.647Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.648Z] 23:57:28 INFO - GECKO(1073) | #13: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1153]
[task 2019-03-05T23:57:28.650Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.651Z] 23:57:28 INFO - GECKO(1073) | #14: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:482]
[task 2019-03-05T23:57:28.653Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.654Z] 23:57:28 INFO - GECKO(1073) | #15: mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:304]
[task 2019-03-05T23:57:28.656Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.657Z] 23:57:28 INFO - GECKO(1073) | #16: MessageLoop::RunInternal() [ipc/chromium/src/base/message_loop.cc:315]
[task 2019-03-05T23:57:28.659Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.661Z] 23:57:28 INFO - GECKO(1073) | #17: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:584]
[task 2019-03-05T23:57:28.662Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.664Z] 23:57:28 INFO - GECKO(1073) | #18: nsThread::ThreadFunc(void*) [xpcom/threads/nsThread.cpp:455]
[task 2019-03-05T23:57:28.665Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.972Z] 23:57:28 INFO - GECKO(1073) | #19: _pt_root [nsprpub/pr/src/pthreads/ptthread.c:204]
[task 2019-03-05T23:57:28.974Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.976Z] 23:57:28 INFO - GECKO(1073) | #20: libpthread.so.0 + 0x76ba
[task 2019-03-05T23:57:28.977Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.978Z] 23:57:28 INFO - GECKO(1073) | #21: libc.so.6 + 0x10741d
[task 2019-03-05T23:57:28.979Z] 23:57:28 INFO -
[task 2019-03-05T23:57:28.980Z] 23:57:28 INFO - GECKO(1073) | #22: ??? (???:???)
[task 2019-03-05T23:57:28.983Z] 23:57:28 INFO - GECKO(1073) | [Child 1184, Main Thread] WARNING: Cannot query channel count on a AudioSegment with no chunks.: '!mChunks.IsEmpty()', file /builds/worker/workspace/build/src/dom/media/AudioSegment.h, line 408
[task 2019-03-05T23:57:28.985Z] 23:57:28 INFO - GECKO(1073) | --DOMWINDOW == 16 (0x7ff850c253e0) [pid = 1184] [serial = 337] [outer = (nil)] [url = about:blank]
[task 2019-03-05T23:57:28.990Z] 23:57:28 INFO - GECKO(1073) | --DOCSHELL 0x7ff850c0e800 == 3 [pid = 1184] [id = {2510928a-79c8-423e-a579-7c9a680877e3}]
[task 2019-03-05T23:57:28.991Z] 23:57:28 INFO - GECKO(1073) | --DOMWINDOW == 15 (0x7ff851178400) [pid = 1184] [serial = 338] [outer = (nil)] [url = about:blank]
[task 2019-03-05T23:57:28.993Z] 23:57:28 INFO - GECKO(1073) | --DOMWINDOW == 14 (0x7ff850107800) [pid = 1184] [serial = 339] [outer = (nil)] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
[task 2019-03-05T23:57:28.995Z] 23:57:28 INFO - GECKO(1073) | --DOMWINDOW == 13 (0x7ff851171c00) [pid = 1184] [serial = 336] [outer = (nil)] [url = http://mochi.test:8888/tests/dom/media/test/test_videoPlaybackQuality_totalFrames.html]
[task 2019-03-05T23:57:28.997Z] 23:57:28 INFO - GECKO(1073) | MEMORY STAT | vsize 1682MB | residentFast 186MB | heapAllocated 24MB
[task 2019-03-05T23:57:28.999Z] 23:57:28 INFO - TEST-OK | dom/media/test/test_video_dimensions.html | took 3827ms
[task 2019-03-05T23:57:29.001Z] 23:57:29 INFO - GECKO(1073) | [Child 1184, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x80004005: file /builds/worker/workspace/build/src/docshell/shistory/nsSHistory.cpp, line 1204
[task 2019-03-05T23:57:29.003Z] 23:57:29 INFO - GECKO(1073) | [Child 1184, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x80004005: file /builds/worker/workspace/build/src/docshell/shistory/nsSHistory.cpp, line 1204
[task 2019-03-05T23:57:29.007Z] 23:57:29 INFO - GECKO(1073) | ++DOMWINDOW == 14 (0x7ff850107800) [pid = 1184] [serial = 343] [outer = 0x7ff85c79f100]
[task 2019-03-05T23:57:29.009Z] 23:57:29 INFO - TEST-UNEXPECTED-FAIL | dom/media/test/test_video_dimensions.html | assertion count 1 is more than expected 0 assertions

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.