Closed Bug 1941408 Opened 1 month ago Closed 2 days ago

Intermittent dom/media/test/test_play_twice.html | single tracking bug

Categories

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

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

Filed by: sstanca [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=489950925&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/DuwPvjTvSFOeqsH8--rm-A/runs/0/artifacts/public/logs/live_backing.log


[task 2025-01-13T21:09:18.909Z] 21:09:18     INFO -  TEST-PASS | dom/media/test/test_play_twice.html | [finished bug533822.ogg-14 t=17.637] Length of array should match number of running tests
[task 2025-01-13T21:09:18.909Z] 21:09:18     INFO -  Buffered messages finished
[task 2025-01-13T21:09:18.909Z] 21:09:18  WARNING -  TEST-UNEXPECTED-FAIL | dom/media/test/test_play_twice.html | Test timed out!
[task 2025-01-13T21:09:18.909Z] 21:09:18     INFO -      SimpleTest.ok@SimpleTest/SimpleTest.js:426:16
[task 2025-01-13T21:09:18.909Z] 21:09:18     INFO -      onTimeout@dom/media/test/manifest.js:2174:9
[task 2025-01-13T21:09:18.910Z] 21:09:18     INFO -      setTimeout handler*MediaTestManager/this.started@dom/media/test/manifest.js:2181:57
[task 2025-01-13T21:09:18.910Z] 21:09:18     INFO -      startTest@dom/media/test/test_play_twice.html:18:11
[task 2025-01-13T21:09:18.910Z] 21:09:18     INFO -      MediaTestManager/this.nextTest@dom/media/test/manifest.js:2255:12
[task 2025-01-13T21:09:18.910Z] 21:09:18     INFO -      MediaTestManager/this.finished@dom/media/test/manifest.js:2227:12
[task 2025-01-13T21:09:18.910Z] 21:09:18     INFO -      finish@dom/media/test/test_play_twice.html:34:13
[task 2025-01-13T21:09:18.910Z] 21:09:18     INFO -      mayFinish@dom/media/test/test_play_twice.html:39:13
[task 2025-01-13T21:09:18.910Z] 21:09:18     INFO -      startTest/checkEnded</<@dom/media/test/test_play_twice.html:56:16
[task 2025-01-13T21:09:18.910Z] 21:09:18     INFO -      EventListener.handleEvent*startTest@dom/media/test/test_play_twice.html:83:9
[task 2025-01-13T21:09:18.910Z] 21:09:18     INFO -      MediaTestManager/this.nextTest@dom/media/test/manifest.js:2255:12
[task 2025-01-13T21:09:18.910Z] 21:09:18     INFO -      MediaTestManager/this.finished@dom/media/test/manifest.js:2227:12
[task 2025-01-13T21:09:18.910Z] 21:09:18     INFO -      finish@dom/media/test/test_play_twice.html:34:13
[task 2025-01-13T21:09:18.911Z] 21:09:18     INFO -      mayFinish@dom/media/test/test_play_twice.html:39:13
[task 2025-01-13T21:09:18.911Z] 21:09:18     INFO -      startTest/checkEnded</<@dom/media/test/test_play_twice.html:56:16
[task 2025-01-13T21:09:18.911Z] 21:09:18     INFO -      EventListener.handleEvent*startTest@dom/media/test/test_play_twice.html:83:9
[task 2025-01-13T21:09:18.911Z] 21:09:18     INFO -      MediaTestManager/this.nextTest@dom/media/test/manifest.js:2255:12
[task 2025-01-13T21:09:18.911Z] 21:09:18     INFO -      MediaTestManager/this.finished@dom/media/test/manifest.js:2227:12
[task 2025-01-13T21:09:18.911Z] 21:09:18     INFO -      finish@dom/media/test/test_play_twice.html:34:13
[task 2025-01-13T21:09:18.911Z] 21:09:18     INFO -      mayFinish@dom/media/test/test_play_twice.html:39:13
[task 2025-01-13T21:09:18.911Z] 21:09:18     INFO -      startTest/checkEnded</<@dom/media/test/test_play_twice.html:56:16
[task 2025-01-13T21:09:18.911Z] 21:09:18     INFO -      EventListener.handleEvent*startTest@dom/media/test/test_play_twice.html:83:9
[task 2025-01-13T21:09:18.911Z] 21:09:18     INFO -      MediaTestManager/this.nextTest@dom/media/test/manifest.js:2255:12
[task 2025-01-13T21:09:18.912Z] 21:09:18     INFO -      MediaTestManager/this.runTests/<@dom/media/test/manifest.js:2150:12
[task 2025-01-13T21:09:18.912Z] 21:09:18     INFO -      Async*MediaTestManager/this.runTests@dom/media/test/manifest.js:2149:19
[task 2025-01-13T21:09:18.912Z] 21:09:18     INFO -      @dom/media/test/test_play_twice.html:90:9
[task 2025-01-13T21:09:18.912Z] 21:09:18     INFO -  vp9-short.webm-7 timed out!
[task 2025-01-13T21:09:18.914Z] 21:09:18     INFO -  {"EMEInfo":{"keySystem":"","sessionsInfo":""},"compositorDroppedFrames":0,"decoder":{"PlayState":"PLAY_STATE_PLAYING","channels":0,"containerType":"video/webm","hasAudio":false,"hasVideo":true,"instance":"762b76377700","rate":0,"reader":{"audioChannels":0,"audioDecoderName":"unavailable","audioFramesDecoded":0,"audioRate":0,"audioState":{"demuxEOS":0,"demuxQueueSize":0,"drainState":0,"hasDecoder":false,"hasDemuxRequest":false,"hasPromise":false,"lastStreamSourceID":0,"needInput":false,"numSamplesInput":0,"numSamplesOutput":0,"pending":0,"queueSize":0,"timeTreshold":0,"timeTresholdHasSeeked":false,"waitingForData":false,"waitingForKey":false,"waitingPromise":false},"audioType":"none","frameStats":{"droppedCompositorFrames":0,"droppedDecodedFrames":0,"droppedSinkFrames":0},"totalReadMetadataTimeMs":2.6948499999999997,"totalWaitingForVideoDataTimeMs":0,"videoDecoderName":"android decoder (remote)","videoHardwareAccelerated":false,"videoHeight":240,"videoNumSamplesOutputTotal":1,"videoNumSamplesSkippedTotal":0,"videoRate":30.08021354675293,"videoState":{"demuxEOS":0,"demuxQueueSize":0,"drainState":0,"hasDecoder":false,"hasDemuxRequest":false,"hasPromise":false,"lastStreamSourceID":4294967295,"needInput":false,"numSamplesInput":3,"numSamplesOutput":1,"pending":0,"queueSize":2,"timeTreshold":-1,"timeTresholdHasSeeked":false,"waitingForData":false,"waitingForKey":false,"waitingPromise":false},"videoType":"video/vp9","videoWidth":320},"resource":{"cacheStream":{"cacheSuspended":false,"channelEnded":false,"channelOffset":0,"loadID":0,"streamLength":0}},"stateMachine":{"audioCompleted":false,"audioRequestStatus":"idle","clock":-1,"decodedAudioEndTime":0,"decodedVideoEndTime":33000,"duration":200000,"isPlaying":false,"mediaSink":{"audioSinkWrapper":{"audioEnded":true,"audioSink":{"audioEnded":false,"hasErrored":false,"isPlaying":false,"isStarted":false,"lastGoodPosition":0,"outputRate":0,"playbackComplete":false,"startTime":0,"written":0},"isPlaying":false,"isStarted":false},"decodedStream":{"audioQueueFinished":false,"audioQueueSize":0,"data":{"audioFramesWritten":0,"haveSentFinishAudio":false,"haveSentFinishVideo":false,"instance":"","lastVideoEndTime":0,"lastVideoStartTime":0,"nextAudioTime":0,"streamAudioWritten":0,"streamVideoWritten":0},"instance":"","lastAudio":0,"lastOutputTime":0,"playing":0,"startTime":0},"videoSink":{"endPromiseHolderIsEmpty":true,"finished":false,"hasVideo":false,"isPlaying":false,"isStarted":false,"size":1,"videoFrameEndTime":0,"videoSinkEndRequestExists":false}},"mediaTime":0,"playState":2,"sentFirstFrameLoadedEvent":true,"state":"","stateObj":{"isPrerolling":true},"totalBufferingTimeMs":0,"videoCompleted":false,"videoRequestStatus":"idle"}}}
[task 2025-01-13T21:09:18.914Z] 21:09:18     INFO -  [finished vp9-short.webm-7] remaining=
[task 2025-01-13T21:09:18.914Z] 21:09:18     INFO -  TEST-PASS | dom/media/test/test_play_twice.html | [finished vp9-short.webm-7 t=182.99] Length of array should match number of running tests
Status: NEW → RESOLVED
Closed: 2 days ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.