Closed Bug 1538391 Opened 3 years ago Closed 3 years ago

windows/aarch64 - Intermittent dom/media/mediasource/test/test_ExperimentalAsync.html | Test timed out.

Categories

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

defect

Tracking

()

RESOLVED FIXED

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 2 open bugs)

Details

(Keywords: intermittent-failure)

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

https://treeherder.mozilla.org/logviewer.html#?job_id=235572155&repo=try

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

Test: mda1

Platform: windows10-aarch64

Context:
22:21:49 INFO - TEST-PASS | dom/media/mediasource/test/test_ExperimentalAsync.html | fetchWithXHR load uri='bipbop/bipbop_audio1.m4s' status=200
22:21:49 INFO - TEST-PASS | dom/media/mediasource/test/test_ExperimentalAsync.html | fetchWithXHR load uri='bipbop/bipbop_audio2.m4s' status=200
22:21:49 INFO - TEST-PASS | dom/media/mediasource/test/test_ExperimentalAsync.html | fetchWithXHR load uri='bipbop/bipbop_audio3.m4s' status=200
22:21:49 INFO - Loading buffer2: [0, 694)
22:21:49 INFO - SourceBuffer buffered ranges grew from TimeRanges: to TimeRanges: [0, 0.975238)
22:21:49 INFO - Loading buffer2: [0, 750)
22:21:49 INFO - SourceBuffer buffered ranges grew from TimeRanges: [0, 0.975238) to TimeRanges: [0, 1.950476)
22:21:49 INFO - Loading buffer2: [0, 724)
22:21:49 INFO - SourceBuffer buffered ranges grew from TimeRanges: [0, 1.950476) to TimeRanges: [0, 2.925714)
22:21:49 INFO - Buffered messages finished
22:21:49 INFO - TEST-UNEXPECTED-FAIL | dom/media/mediasource/test/test_ExperimentalAsync.html | Test timed out.
22:21:49 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:275:18
22:21:49 INFO - reportError@SimpleTest/TestRunner.js:121:22
22:21:49 INFO - TestRunner._checkForHangs@SimpleTest/TestRunner.js:142:7
22:21:49 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
22:21:49 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
22:21:49 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
22:21:49 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
22:21:49 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
22:21:49 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
22:21:49 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
22:21:49 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
22:21:49 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
22:21:49 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
22:21:49 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
22:21:49 INFO - TestRunner.runTests/<@SimpleTest/TestRunner.js:381:20
22:21:49 INFO - promise callback*TestRunner.runTests@SimpleTest/TestRunner.js:368:50
22:21:49 INFO - RunSet.runtests@SimpleTest/setup.js:201:14
22:21:49 INFO - RunSet.runall@SimpleTest/setup.js:180:12
22:21:49 INFO - hookupTests@SimpleTest/setup.js:273:12
22:21:49 INFO - parseTestManifest@http://mochi.test:8888/manifestLibrary.js:36:5
22:21:49 INFO - getTestManifest/req.onload@http://mochi.test:8888/manifestLibrary.js:49:11
22:21:49 INFO - EventHandlerNonNull*getTestManifest@http://mochi.test:8888/manifestLibrary.js:45:3
22:21:49 INFO - hookup@SimpleTest/setup.js:253:5
22:21:49 INFO - EventHandlerNonNull*@http://mochi.test:8888/tests?autorun=1&closeWhenDone=1&consoleLevel=INFO&manifestFile=tests.json&dumpOutputDirectory=c%3A%5Cusers%5Ctestdr%7E1%5Cappdata%5Clocal%5Ctemp&cleanupCrashes=true:11:1
22:21:50 INFO - GECKO(4448) | MEMORY STAT | vsize 5601MB | vsizeMaxContiguous 82928308MB | residentFast 94MB | heapAllocated 9MB
22:21:50 INFO - GECKO(4448) | MediaDecoder=2413b9e9c00: channels=2 rate=22050 hasAudio=1 hasVideo=0 mPlayState=PLAYING
22:21:50 INFO - GECKO(4448) | reader data:
22:21:50 INFO - GECKO(4448) | Container Type: MediaSource
22:21:50 INFO - GECKO(4448) | Audio Decoder(audio/mp4a-latm, 2 channels @ 22.0kHz): wmf audio decoder
22:21:50 INFO - GECKO(4448) | Audio Frames Decoded: 121
22:21:50 INFO - GECKO(4448) | Audio State: ni=0 no=0 wp=0 demuxr=0 demuxq=0 decoder=0 tt=-1.0 tths=-1 in=45 out=44 qs=1 pending=0 wfd=0 eos=0 ds=0 wfk=0 sid=20
22:21:50 INFO - GECKO(4448) | Video Decoder(none, 0x0 @ 0.00): unavailable
22:21:50 INFO - GECKO(4448) | Hardware Video Decoding: disabled
22:21:50 INFO - GECKO(4448) | Video Frames Decoded: 0 (skipped=0)
22:21:50 INFO - GECKO(4448) | Dumping Data for Demuxer: 2413b8d6400
22:21:50 INFO - GECKO(4448) | Dumping Audio Track Buffer(audio/mp4): mLastAudioTime=2.089795
22:21:50 INFO - GECKO(4448) | Audio Track Buffer Details: NumSamples=63 Size=25490 Evictable=17768 NextGetSampleIndex=45 NextInsertionIndex=63
22:21:50 INFO - GECKO(4448) | Audio Track Buffered: ranges=[(0.000000, 2.925714)]
22:21:50 INFO - GECKO(4448) | MDSM: duration=63390470 GetMediaTime=0 GetClock=302673363 mMediaSink=24136576c80 state=DECODING mPlayState=3 mSentFirstFrameLoadedEvent=1 IsPlaying=1 mAudioStatus=idle mVideoStatus=idle mDecodedAudioEndTime=2043355 mDecodedVideoEndTime=0 mAudioCompleted=1 mVideoCompleted=0 mIsPrerolling=0
22:21:50 INFO - GECKO(4448) | VideoSink: IsStarted=1 IsPlaying=1 VideoQueue(finished=0 size=0) mVideoFrameEndTime=0 mHasVideo=0 mVideoSinkEndRequest.Exists()=0 mEndPromiseHolder.IsEmpty()=1
22:21:50 INFO - GECKO(4448) | AudioSinkWrapper: IsStarted=1 IsPlaying=1 AudioEnded=1
22:21:50 INFO - GECKO(4448) | AudioSink: StartTime=0 LastGoodPosition=0 Playing=1 OutputRate=44100 Written=0 Errored=0 PlaybackComplete=0
22:21:50 INFO - TEST-OK | dom/media/mediasource/test/test_ExperimentalAsync.html | took 303157ms

This bug no longer occurs on windows10-aarch64 as of https://phabricator.services.mozilla.com/D45887.

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