1486254 - Intermittent dom/media/test/test_reset_src.html | Test timed out!

Status: RESOLVED DUPLICATE of bug 1344391

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

Description

[Treeherder Bug Filer]

Filed by: ncsoregi [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=195948882&repo=mozilla-central

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

23:47:07     INFO - TEST-PASS | dom/media/test/test_reset_src.html | gizmo.mp4: We should have a videoWidth. 
23:47:07     INFO - Buffered messages finished
23:47:07     INFO - TEST-UNEXPECTED-FAIL | dom/media/test/test_reset_src.html | Test timed out! 
23:47:07     INFO -     onTimeout@dom/media/test/manifest.js:1736:7
23:47:07     INFO -     setTimeout handler*MediaTestManager/this.started@dom/media/test/manifest.js:1743:26
23:47:07     INFO -     startTest@dom/media/test/test_reset_src.html:91:3
23:47:07     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1792:7
23:47:07     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1771:7
23:47:07     INFO -     finish@dom/media/test/test_reset_src.html:26:3
23:47:07     INFO -     onLoadedData_Audio@dom/media/test/test_reset_src.html:40:5
23:47:07     INFO -     EventListener.handleEvent*onTimeUpdate_Video@dom/media/test/test_reset_src.html:68:7
23:47:07     INFO -     EventListener.handleEvent*onLoadedData_Video@dom/media/test/test_reset_src.html:78:3
23:47:07     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_reset_src.html:86:3
23:47:07     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1792:7
23:47:07     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1771:7
23:47:07     INFO -     finish@dom/media/test/test_reset_src.html:26:3
23:47:07     INFO -     onLoadedData_Audio@dom/media/test/test_reset_src.html:40:5
23:47:07     INFO -     EventListener.handleEvent*onTimeUpdate_Video@dom/media/test/test_reset_src.html:68:7
23:47:07     INFO -     EventListener.handleEvent*onLoadedData_Video@dom/media/test/test_reset_src.html:78:3
23:47:07     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_reset_src.html:86:3
23:47:07     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1792:7
23:47:07     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1771:7
23:47:07     INFO -     finish@dom/media/test/test_reset_src.html:26:3
23:47:07     INFO -     onLoadedData_Audio@dom/media/test/test_reset_src.html:40:5
23:47:07     INFO -     EventListener.handleEvent*onTimeUpdate_Video@dom/media/test/test_reset_src.html:68:7
23:47:07     INFO -     EventListener.handleEvent*onLoadedData_Video@dom/media/test/test_reset_src.html:78:3
23:47:07     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_reset_src.html:86:3
23:47:07     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1792:7
23:47:07     INFO -     MediaTestManager/this.runTests/<@dom/media/test/manifest.js:1712:7
23:47:07     INFO - bug516323.indexed.ogv-7 timed out!
23:47:07     INFO - GECKO(5400) | MediaDecoder=282443c5c00: channels=1 rate=44100 hasAudio=1 hasVideo=1 mPlayState=PLAYING
23:47:07     INFO - GECKO(5400) | ChannelMediaResource: mStreamLength=162193 mChannelOffset=162193 mCacheSuspended=0 mChannelEnded=1 mLoadID=2
23:47:07     INFO - GECKO(5400) | reader data:
23:47:07     INFO - GECKO(5400) | Container Type: application/ogg
23:47:07     INFO - GECKO(5400) | Audio Decoder(audio/vorbis, 1 channels @ 44.1kHz): vorbis audio decoder
23:47:07     INFO - GECKO(5400) | Audio Frames Decoded: 173
23:47:07     INFO - GECKO(5400) | Audio State: ni=0 no=0 wp=0 demuxr=0 demuxq=0 decoder=0 tt=-1.0 tths=-1 in=173 out=172 qs=1 pending=0 wfd=0 eos=0 ds=0 wfk=0 sid=4294967295
23:47:07     INFO - GECKO(5400) | Video Decoder(video/theora, 426x240 @ 24.00): theora video decoder
23:47:07     INFO - GECKO(5400) | Hardware Video Decoding: disabled
23:47:07     INFO - GECKO(5400) | Video Frames Decoded: 35 (skipped=0)
23:47:07     INFO - GECKO(5400) | Video State: ni=0 no=0 wp=0 demuxr=0 demuxq=0 decoder=0 tt=-1.0 tths=-1 in=34 out=34 qs=0 pending:0 wfd=0 eos=0 ds=0 wfk=0 sid=4294967295
23:47:07     INFO - GECKO(5400) | MDSM: duration=4208333 GetMediaTime=990000 GetClock=990000 mMediaSink=28246c466d0 state=DECODING mPlayState=3 mSentFirstFrameLoadedEvent=1 IsPlaying=1 mAudioStatus=idle mVideoStatus=idle mDecodedAudioEndTime=2967800 mDecodedVideoEndTime=1416666 mAudioCompleted=0 mVideoCompleted=0 mIsPrerolling=0
23:47:07     INFO - GECKO(5400) | VideoSink: IsStarted=1 IsPlaying=1 VideoQueue(finished=0 size=11) mVideoFrameEndTime=1000000 mHasVideo=1 mVideoSinkEndRequest.Exists()=0 mEndPromiseHolder.IsEmpty()=0
23:47:07     INFO - GECKO(5400) | AudioSinkWrapper: IsStarted=1 IsPlaying=1 AudioEnded=0
23:47:07     INFO - GECKO(5400) | AudioSink: StartTime=0 LastGoodPosition=990000 Playing=1  OutputRate=44100 Written=48069 Errored=0 PlaybackComplete=0
23:47:07     INFO - [finished bug516323.indexed.ogv-7] remaining= gizmo.mp4-9

Comment 1

[Intermittent Failures Robot]

2 failures in 2568 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 1
* mozilla-inbound: 1

Platform breakdown:
* windows10-64-ccov: 1
* windows10-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1486254&startday=2018-08-20&endday=2018-08-26&tree=all

Comment 3

[Intermittent Failures Robot]

8 failures in 2545 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* try: 1
* mozilla-central: 1
* mozilla-inbound: 4
* autoland: 2

Platform breakdown:
* windows10-64-msvc: 1
* windows10-64-qr: 4
* windows10-64: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1486254&startday=2018-08-27&endday=2018-09-02&tree=all