1902562 - Perma wmfme mda [tier 2] dom/media/test/<something> | Test timed out.

Status: RESOLVED FIXED

(Release Engineering :: Applications: MozharnessCore, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2024-06-14T00:30:13.115Z] 00:30:13     INFO - TEST-PASS | dom/media/test/test_seek-1.html | r11025_s16_c1.wav seek test 1: Video currentTime should be around 0.5: 0.5 (seeking) 
[task 2024-06-14T00:30:13.116Z] 00:30:13     INFO - Buffered messages finished
[task 2024-06-14T00:30:13.117Z] 00:30:13     INFO - TEST-UNEXPECTED-FAIL | dom/media/test/test_seek-1.html | Test timed out! 
[task 2024-06-14T00:30:13.117Z] 00:30:13     INFO -     SimpleTest.ok@SimpleTest/SimpleTest.js:426:16
[task 2024-06-14T00:30:13.117Z] 00:30:13     INFO -     onTimeout@dom/media/test/manifest.js:2174:9
[task 2024-06-14T00:30:13.117Z] 00:30:13     INFO -     setTimeout handler*MediaTestManager/this.started@dom/media/test/manifest.js:2181:57
[task 2024-06-14T00:30:13.117Z] 00:30:13     INFO -     startTest@dom/media/test/seek_support.js:30:11
[task 2024-06-14T00:30:13.118Z] 00:30:13     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:2255:12
[task 2024-06-14T00:30:13.118Z] 00:30:13     INFO -     MediaTestManager/this.runTests/<@dom/media/test/manifest.js:2150:12
[task 2024-06-14T00:30:13.118Z] 00:30:13     INFO -     Async*MediaTestManager/this.runTests@dom/media/test/manifest.js:2149:19
[task 2024-06-14T00:30:13.118Z] 00:30:13     INFO -     @dom/media/test/test_seek-1.html:79:9
[task 2024-06-14T00:30:13.119Z] 00:30:13     INFO - r11025_s16_c1.wav-0-seek1.js timed out!
[task 2024-06-14T00:30:13.124Z] 00:30:13     INFO - {"EMEInfo":{"keySystem":"","sessionsInfo":""},"compositorDroppedFrames":0,"decoder":{"PlayState":"LOADING","channels":1,"containerType":"audio/x-wav","hasAudio":true,"hasVideo":false,"instance":"1229dd12b080","rate":11025,"reader":{"audioChannels":1,"audioDecoderName":"NS_ERROR_DOM_MEDIA_FATAL_ERR (0x806e0005) - Error no decoder found for audio/wave; codecs=1","audioFramesDecoded":0,"audioRate":11025,"audioState":{"demuxEOS":0,"demuxQueueSize":0,"drainState":0,"hasDecoder":false,"hasDemuxRequest":false,"hasPromise":false,"lastStreamSourceID":4294967295,"needInput":false,"numSamplesInput":0,"numSamplesOutput":0,"pending":0,"queueSize":0,"timeTreshold":-1,"timeTresholdHasSeeked":false,"waitingForData":false,"waitingForKey":false,"waitingPromise":false},"audioType":"audio/wave; codecs=1","frameStats":{"droppedCompositorFrames":0,"droppedDecodedFrames":0,"droppedSinkFrames":0},"totalReadMetadataTimeMs":0,"totalWaitingForVideoDataTimeMs":0,"videoDecoderName":"unavailable","videoHardwareAccelerated":false,"videoHeight":0,"videoNumSamplesOutputTotal":0,"videoNumSamplesSkippedTotal":0,"videoRate":0,"videoState":{"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},"videoType":"none","videoWidth":0},"resource":{"cacheStream":{"cacheSuspended":false,"channelEnded":false,"channelOffset":0,"loadID":0,"streamLength":0}},"stateMachine":{"audioCompleted":false,"audioRequestStatus":"","clock":0,"decodedAudioEndTime":0,"decodedVideoEndTime":0,"duration":0,"isPlaying":false,"mediaSink":{"audioSinkWrapper":{"audioEnded":false,"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":false,"finished":false,"hasVideo":false,"isPlaying":false,"isStarted":false,"size":0,"videoFrameEndTime":0,"videoSinkEndRequestExists":false}},"mediaTime":0,"playState":0,"sentFirstFrameLoadedEvent":false,"state":"","stateObj":{"isPrerolling":false},"totalBufferingTimeMs":0,"videoCompleted":false,"videoRequestStatus":""}}}
[task 2024-06-14T00:30:13.124Z] 00:30:13     INFO - [finished r11025_s16_c1.wav-0-seek1.js] remaining= 
[task 2024-06-14T00:30:13.125Z] 00:30:13     INFO - TEST-PASS | dom/media/test/test_seek-1.html | [finished r11025_s16_c1.wav-0-seek1.js t=181.494] Length of array should match number of running tests 

Comment 1

[BugBot [:suhaib / :marco/ :calixte]]

:jmaher, since you are the author of the regressor, bug 1898051, could you take a look?

For more information, please visit BugBot documentation.

Comment 2

[tszentpeteri]

Hi, the tests are timing out in multiple locations as it can be seen here

Comment 3

[Intermittent Failures Robot]

18 failures in 841 pushes (0.021 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 18

Platform and build breakdown:

• windows11-64-2009-asan-qr: 9
  • opt: 9
• windows11-64-2009-qr: 9
  • debug: 9

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1902562&startday=2024-06-13&endday=2024-06-13&tree=all

Comment 4

[BugBot [:suhaib / :marco/ :calixte]]

Set release status flags based on info from the regressing bug 1898051

Comment 5

[Joel Maher ( :jmaher ) (UTC -8)]

this is related to the tags, it appears that we are running a manifest that doesn't match the wmfme tag, let me look into this...

Comment 6

[Joel Maher ( :jmaher ) (UTC -8)]

ok, narrowing this down, it appears I am missing the --tag=<> parameter in the task command line- this is generated within the decision task; time to figure this out.

Comment 7

[Joel Maher ( :jmaher ) (UTC -8)]

Attachment: Bug 1902562 - ensure we add --tag to command line when paths are specified. r=gbrown

Comment 8

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/93adc871123f
ensure we add --tag to command line when paths are specified. r=gbrown

Comment 9

[Intermittent Failures Robot]

34 failures in 869 pushes (0.039 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 28
• mozilla-central: 6

Platform and build breakdown:

• windows11-64-2009-asan-qr: 9
  • opt: 9
• windows11-64-2009-qr: 16
  • opt: 7
  • debug: 9
• windows11-64-2009-shippable-qr: 8
  • opt: 8
• windows11-64-2009-hw-ref-shippable: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1902562&startday=2024-06-14&endday=2024-06-14&tree=all

Comment 10

[Serban Stanca [:SerbanS]]

https://hg.mozilla.org/mozilla-central/rev/93adc871123f

Comment 11

[Intermittent Failures Robot]

52 failures in 4625 pushes (0.011 failures/push) were associated with this bug in the last 7 days.

This is the #31 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 46
• mozilla-central: 6

Platform and build breakdown:

• windows11-64-2009-asan-qr: 18
  • opt: 18
• windows11-64-2009-qr: 25
  • debug: 18
  • opt: 7
• windows11-64-2009-shippable-qr: 8
  • opt: 8
• windows11-64-2009-hw-ref-shippable: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1902562&startday=2024-06-10&endday=2024-06-16&tree=all