1483259 - Intermittent dom/media/test/test_playback.html | ambisonics.mp4 should not fire 'error' event NS_ERROR_DOM_MEDIA_DECODE_ERR (0x806e0004) - virtual mozilla::MediaResult mozilla::FFmpegAudioDecoder<55>::DoDecod

Reporter

Description

•

6 years ago

treeherder

Filed by: apavel [at] mozilla.com

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

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

[task 2018-08-14T13:34:40.694Z] 13:34:40     INFO - [finished opus-sample.mp4-60] remaining= ambisonics.mp4-59
[task 2018-08-14T13:34:40.694Z] 13:34:40     INFO - TEST-PASS | dom/media/test/test_playback.html | [finished opus-sample.mp4-60 t=110.404] Length of array should match number of running tests 
[task 2018-08-14T13:34:40.698Z] 13:34:40     INFO - TEST-PASS | dom/media/test/test_playback.html | [started opus-mapping2.mp4-61 t=110.407] Length of array should match number of running tests 
[task 2018-08-14T13:34:40.709Z] 13:34:40     INFO - Buffered messages finished
[task 2018-08-14T13:34:40.718Z] 13:34:40     INFO - TEST-UNEXPECTED-FAIL | dom/media/test/test_playback.html | ambisonics.mp4 should not fire 'error' event NS_ERROR_DOM_MEDIA_DECODE_ERR (0x806e0004) - virtual mozilla::MediaResult mozilla::FFmpegAudioDecoder<55>::DoDecode(mozilla::MediaRawData*, uint8_t*, int, bool*, mozilla::MediaDataDecoder::DecodedData&): FFmpeg audio error:-1094995529 
[task 2018-08-14T13:34:40.722Z] 13:34:40     INFO -     startTest/noError</<@dom/media/test/test_playback.html:43:5
[task 2018-08-14T13:34:40.723Z] 13:34:40     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_playback.html:91:3
[task 2018-08-14T13:34:40.725Z] 13:34:40     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1779:7
[task 2018-08-14T13:34:40.729Z] 13:34:40     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1758:7
[task 2018-08-14T13:34:40.731Z] 13:34:40     INFO -     finish@dom/media/test/test_playback.html:50:5
[task 2018-08-14T13:34:40.732Z] 13:34:40     INFO -     mayFinish@dom/media/test/test_playback.html:56:7
[task 2018-08-14T13:34:40.734Z] 13:34:40     INFO -     startTest/checkEnded</<@dom/media/test/test_playback.html:69:5
[task 2018-08-14T13:34:40.737Z] 13:34:40     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_playback.html:96:3
[task 2018-08-14T13:34:40.738Z] 13:34:40     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1779:7
[task 2018-08-14T13:34:40.739Z] 13:34:40     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1758:7
[task 2018-08-14T13:34:40.741Z] 13:34:40     INFO -     finish@dom/media/test/test_playback.html:50:5
[task 2018-08-14T13:34:40.742Z] 13:34:40     INFO -     mayFinish@dom/media/test/test_playback.html:56:7
[task 2018-08-14T13:34:40.745Z] 13:34:40     INFO -     startTest/checkEnded</<@dom/media/test/test_playback.html:69:5
[task 2018-08-14T13:34:40.746Z] 13:34:40     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_playback.html:96:3
[task 2018-08-14T13:34:40.747Z] 13:34:40     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1779:7
[task 2018-08-14T13:34:40.749Z] 13:34:40     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1758:7
[task 2018-08-14T13:34:40.749Z] 13:34:40     INFO -     finish@dom/media/test/test_playback.html:50:5
[task 2018-08-14T13:34:40.751Z] 13:34:40     INFO -     mayFinish@dom/media/test/test_playback.html:56:7
[task 2018-08-14T13:34:40.753Z] 13:34:40     INFO -     startTest/checkEnded</<@dom/media/test/test_playback.html:69:5
[task 2018-08-14T13:34:40.753Z] 13:34:40     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_playback.html:96:3
[task 2018-08-14T13:34:40.754Z] 13:34:40     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1779:7
[task 2018-08-14T13:34:40.755Z] 13:34:40     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1758:7
[task 2018-08-14T13:34:40.755Z] 13:34:40     INFO -     finish@dom/media/test/test_playback.html:50:5
[task 2018-08-14T13:34:40.755Z] 13:34:40     INFO -     mayFinish@dom/media/test/test_playback.html:56:7
[task 2018-08-14T13:34:40.756Z] 13:34:40     INFO -     startTest/checkEnded</<@dom/media/test/test_playback.html:69:5
[task 2018-08-14T13:34:40.756Z] 13:34:40     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_playback.html:96:3
[task 2018-08-14T13:34:40.756Z] 13:34:40     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1779:7
[task 2018-08-14T13:34:40.757Z] 13:34:40     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1758:7
[task 2018-08-14T13:34:40.757Z] 13:34:40     INFO -     finish@dom/media/test/test_playback.html:50:5
[task 2018-08-14T13:34:40.759Z] 13:34:40     INFO -     mayFinish@dom/media/test/test_playback.html:56:7
[task 2018-08-14T13:34:40.760Z] 13:34:40     INFO -     startTest/checkEnded</<@dom/media/test/test_playback.html:69:5
[task 2018-08-14T13:34:40.761Z] 13:34:40     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_playback.html:96:3
[task 2018-08-14T13:34:40.761Z] 13:34:40     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1779:7
[task 2018-08-14T13:34:40.761Z] 13:34:40     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1758:7
[task 2018-08-14T13:34:40.762Z] 13:34:40     INFO -     finish@dom/media/test/test_playback.html:50:5
[task 2018-08-14T13:34:40.763Z] 13:34:40     INFO -     mayFinish@dom/media/test/test_playback.html:56:7
[task 2018-08-14T13:34:40.763Z] 13:34:40     INFO -     startTest/checkEnded</<@dom/media/test/test_playback.html:69:5
[task 2018-08-14T13:34:40.764Z] 13:34:40     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_playback.html:96:3
[task 2018-08-14T13:34:40.765Z] 13:34:40     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1779:7
[task 2018-08-14T13:34:40.767Z] 13:34:40     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1758:7
[task 2018-08-14T13:34:40.767Z] 13:34:40     INFO -     finish@dom/media/test/test_playback.html:50:5
[task 2018-08-14T13:34:40.773Z] 13:34:40     INFO -     mayFinish@dom/media/test/test_playback.html:56:7
[task 2018-08-14T13:34:40.774Z] 13:34:40     INFO -     startTest/checkEnded</<@dom/media/test/test_playback.html:69:5
[task 2018-08-14T13:34:40.775Z] 13:34:40     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_playback.html:96:3
[task 2018-08-14T13:34:40.775Z] 13:34:40     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1779:7
[task 2018-08-14T13:34:40.775Z] 13:34:40     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1758:7
[task 2018-08-14T13:34:40.775Z] 13:34:40     INFO -     finish@dom/media/test/test_playback.html:50:5
[task 2018-08-14T13:34:40.776Z] 13:34:40     INFO -     mayFinish@dom/media/test/test_playback.html:56:7
[task 2018-08-14T13:34:40.776Z] 13:34:40     INFO -     startTest/checkEnded</<@dom/media/test/test_playback.html:69:5
[task 2018-08-14T13:34:40.776Z] 13:34:40     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_playback.html:96:3
[task 2018-08-14T13:34:40.776Z] 13:34:40     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1779:7
[task 2018-08-14T13:34:40.776Z] 13:34:40     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1758:7
[task 2018-08-14T13:34:40.776Z] 13:34:40     INFO -     finish@dom/media/test/test_playback.html:50:5
[task 2018-08-14T13:34:40.777Z] 13:34:40     INFO -     mayFinish@dom/media/test/test_playback.html:56:7
[task 2018-08-14T13:34:40.777Z] 13:34:40     INFO -     startTest/checkEnded</<@dom/media/test/test_playback.html:69:5
[task 2018-08-14T13:34:40.777Z] 13:34:40     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_playback.html:96:3
[task 2018-08-14T13:34:40.777Z] 13:34:40     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1779:7
[task 2018-08-14T13:34:40.778Z] 13:34:40     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1758:7
[task 2018-08-14T13:34:40.778Z] 13:34:40     INFO -     finish@dom/media/test/test_playback.html:50:5
[task 2018-08-14T13:34:40.778Z] 13:34:40     INFO -     mayFinish@dom/media/test/test_playback.html:56:7
[task 2018-08-14T13:34:40.778Z] 13:34:40     INFO -     startTest/checkEnded</<@dom/media/test/test_playback.html:69:5
[task 2018-08-14T13:34:40.778Z] 13:34:40     INFO -     EventListener.handleEvent*startTest@dom/media/test/test_playback.html:96:3
[task 2018-08-14T13:34:40.778Z] 13:34:40     INFO -     MediaTestManager/this.nextTest@dom/media/test/manifest.js:1779:7
[task 2018-08-14T13:34:40.779Z] 13:34:40     INFO -     MediaTestManager/this.finished@dom/media/test/manifest.js:1758:7
[task 2018-08-14T13:34:40.779Z] 13:34:40     INFO -     finish@dom/media/test/test_playback.html:50:5
[task 2018-08-14T13:34:40.779Z] 13:34:40     INFO -     mayFinish@dom/media/test/test_playback.html:56:7
[task 2018-08-14T13:34:40.779Z] 13:34:40     INFO -     startTest/checkEnded</<@dom/media/test/test_playback.html:69:5

Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)

Comment 1

•

6 years ago

Directly before the failure this gets printed:
> [started opus-mapping2.mp4-61 t=110.407]
That test got added in bug 1482605 - the push for which the failure occurred the first time.

Blocks: 1482605

Jean-Yves Avenard [:jya]

Comment 2

•

6 years ago

It's ambisonic.mp4 that cause a decoding error. Not he one recently added

Comment hidden (Intermittent Failures Robot)

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

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

Platform breakdown:
* linux64-ccov: 2
* linux32: 2

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

Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)

Updated

•

6 years ago

See Also: → 1484451

Comment hidden (Intermittent Failures Robot)

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

Repository breakdown:
* mozilla-central: 3

Platform breakdown:
* linux64-ccov: 3

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

Comment hidden (Intermittent Failures Robot)

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

Repository breakdown:
* mozilla-central: 4

Platform breakdown:
* linux64-ccov: 4

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

Comment hidden (Intermittent Failures Robot)

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

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

Platform breakdown:
* osx-10-10: 1
* linux64: 1

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

Comment hidden (Intermittent Failures Robot)

1 failures in 2902 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* linux64: 1

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

Comment hidden (Intermittent Failures Robot)

1 failures in 2773 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* try: 1

Platform breakdown:
* linux64: 1

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

Comment hidden (Intermittent Failures Robot)

1 failures in 2708 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1483259&startday=2018-10-01&endday=2018-10-07&tree=all

Comment hidden (Intermittent Failures Robot)

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

Repository breakdown:
* autoland: 2
* mozilla-central: 1

Platform breakdown:
* linux32: 1
* linux64: 1
* linux64-qr: 1

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

Comment hidden (Intermittent Failures Robot)

5 failures in 2759 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 3
* try: 2

Platform breakdown:
* linux64-qr: 1
* linux64-ccov: 1
* linux64: 1
* linux32-devedition: 1
* linux32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1483259&startday=2018-10-15&endday=2018-10-21&tree=all

Comment hidden (Intermittent Failures Robot)

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

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

Platform breakdown:
* linux64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1483259&startday=2018-10-22&endday=2018-10-28&tree=all

Comment hidden (Intermittent Failures Robot)

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

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

Platform breakdown:
* linux64-qr: 1
* linux32-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1483259&startday=2018-10-29&endday=2018-11-04&tree=all

Comment hidden (Intermittent Failures Robot)

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

Repository breakdown:
* mozilla-inbound: 1
* autoland: 2

Platform breakdown:
* linux64: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1483259&startday=2018-11-05&endday=2018-11-11&tree=all

Comment hidden (Intermittent Failures Robot)

1 failures in 2917 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1483259&startday=2018-11-12&endday=2018-11-18&tree=all

Comment hidden (Intermittent Failures Robot)

1 failures in 2917 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1483259&startday=2018-11-12&endday=2018-11-18&tree=all

Comment hidden (Intermittent Failures Robot)

4 failures in 2387 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

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

Platform breakdown:
* osx-10-10: 2
* linux64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1483259&startday=2018-11-19&endday=2018-11-25&tree=all

Comment hidden (Intermittent Failures Robot)

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

Repository breakdown:
* mozilla-central: 1

Platform breakdown:
* linux64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1483259&startday=2018-12-31&endday=2019-01-06&tree=all

Comment hidden (Intermittent Failures Robot)

Treeherder Bug Filer

Reporter

Updated

•

5 years ago

Updated

•

3 years ago

Comment 61

•

3 years ago

There have been 37 total failures in the last 7 days:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?startday=2021-02-01&endday=2021-02-08&tree=trunk&bug=1483259

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=329155635&repo=autoland&lineNumber=3455

Only affects linux1804-64-tsan.
Bryce, could you redirect this to someone who can take a look?

Flags: needinfo?(bvandyk)

Comment hidden (Intermittent Failures Robot)

Bryce Seager van Dyk [:bryce] (he/him) - Not reading bugmail

Comment 63

•

3 years ago

Looking at the errors it looks like ffmpeg is giving a couple of different errors

https://treeherder.mozilla.org/logviewer?job_id=329158882&repo=autoland&lineNumber=3454 is invalid data error ('I','N','D','A')[0]. -1094995529 -> -0x41444E49 -> ascii ADNI -> INDA (the integer version is backwards due to endianness).
https://treeherder.mozilla.org/logviewer?job_id=329157792&repo=autoland&lineNumber=3447 looks like invalid arg, -22 appears to be from errno.h and gets negated by ffmpeg, the 22 line in errno.h is #define EINVAL 22 /* Invalid argument */. avcodec.h has some documentation on which error paths will return AVERROR(EINVAL).

Looks like we could audit the audio decode path and the ffmpeg API and try and figure out where this is going wrong. If this is reproducible locally it would be great to catch an rr recording. I'll hold NI and see if I can find an owner.

[0] http://ffmpeg.org/doxygen/trunk/error_8h_source.html

C.M.Chang[:chunmin]

Comment 64

•

3 years ago

Is there a way to check if the file format is correct? We have a similar bug 1484451 on Mac OS. It's also a decoding error. Not sure why this file causes the same problem on different platforms

Atila Butkovits

Updated

•

3 years ago

Whiteboard: [stockwell needswork:owner]

Comment hidden (Intermittent Failures Robot)

Bryce Seager van Dyk [:bryce] (he/him) - Not reading bugmail

Comment 66

•

3 years ago

(In reply to C.M.Chang[:chunmin] from comment #64)

Is there a way to check if the file format is correct? We have a similar bug 1484451 on Mac OS. It's also a decoding error. Not sure why this file causes the same problem on different platforms

We could audit the mp4 structure against the ISO specs that govern them. Beyond that we could audit the samples against whatever spec governs those, but I'm less familiar with that.

:kinetik, do you have any thoughts on auditing the file or debugging this further?

Flags: needinfo?(bvandyk) → needinfo?(kinetik)

Bogdan Tara[:bogdan_tara | bogdant]

Comment 67

•

3 years ago

In the last 7 days there have been 30 occurrences, all on linux1804-64-tsan opt.

Recent failure: https://treeherder.mozilla.org/logviewer?job_id=330538000&repo=autoland&lineNumber=3494

Comment hidden (Intermittent Failures Robot)

Andreea Pavel [:apavel]

Updated

•

3 years ago

Flags: needinfo?(kinetik)

Andreea Pavel [:apavel]

Comment 70

•

3 years ago

Matthew did you get a chance to take a look at this?

Flags: needinfo?(kinetik)

Atila Butkovits

Comment 71

•

3 years ago

Attached file Bug 1483259 - disable test_playback.html for frequent failures. r=#intermittent-reviewers — Details

Phabricator Automation

Updated

•

3 years ago

Assignee: nobody → abutkovits

Status: NEW → ASSIGNED

Comment hidden (Intermittent Failures Robot)

Atila Butkovits

Updated

•

3 years ago

Assignee: abutkovits → nobody

Status: ASSIGNED → NEW

Keywords: leave-open

Whiteboard: [stockwell needswork:owner] → [stockwell disabled][leave-open]

Pulsebot

Comment 73

•

3 years ago

Pushed by abutkovits@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/e71b7bf786d8
disable test_playback.html for frequent failures. r=intermittent-reviewers,jmaher

Natalia Csoregi [:nataliaCs]

Comment 74

•

3 years ago

bugherder

https://hg.mozilla.org/mozilla-central/rev/e71b7bf786d8

Comment hidden (Intermittent Failures Robot)

Andreea Pavel [:apavel]

Updated

•

3 years ago

Whiteboard: [stockwell disabled][leave-open] → [stockwell disabled]

Bryce Seager van Dyk [:bryce] (he/him) - Not reading bugmail

Updated

•

3 years ago

Comment 76

•

3 years ago

I'm re-enabling the test in bug 1699509, but skipping the problematic file, I'm not sure how this should be reflected in the whiteboard (if at all), so please update as appropriate.

Bryce Seager van Dyk [:bryce] (he/him) - Not reading bugmail

Updated

•

3 years ago

Severity: normal → S4

Priority: P5 → P3

Comment hidden (Intermittent Failures Robot)

Jim Mathies [:jimm]

Updated

•

2 years ago

Flags: needinfo?(kinetik)

Comment hidden (Intermittent Failures Robot)

Joel Maher ( :jmaher ) (UTC -8)

Updated

•

2 years ago

Blocks: 1776941

Joel Maher ( :jmaher ) (UTC -8)

Updated

•

2 years ago

Status: NEW → RESOLVED

Closed: 2 years ago

Resolution: --- → DUPLICATE

BugBot [:suhaib / :marco/ :calixte]

Updated

•

2 years ago

Keywords: leave-open