Closed Bug 1624169 Opened 5 years ago Closed 5 years ago

Intermittent dom/media/test/test_playback_errors.html | Test timed out!

Tracking

()

Status:

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Treeherder Bug Filer

Reporter

Description

•

5 years ago

treeherder

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

[task 2020-03-22T01:02:46.372Z] 01:02:46 [task 2020-03-22T01:02:46.515Z] 01:02:46 [task 2020-03-22T01:02:46.515Z] 01:02:46 [task 2020-03-22T01:02:46.516Z] 01:02:46 [task 2020-03-22T01:02:46.516Z] 01:02:46 [task 2020-03-22T01:02:46.534Z] 01:02:46 [task 2020-03-22T01:02:46.534Z] 01:02:46 [task 2020-03-22T01:02:46.617Z] 01:02:46 [task 2020-03-22T01:02:46.617Z] 01:02:46 [task 2020-03-22T01:02:46.636Z] 01:02:46 [task 2020-03-22T01:02:46.654Z] 01:02:46 [task 2020-03-22T01:02:46.654Z] 01:02:46 [task 2020-03-22T01:02:46.654Z] 01:02:46 [task 2020-03-22T01:02:46.664Z] 01:02:46 [task 2020-03-22T01:02:46.683Z] 01:02:46 [task 2020-03-22T01:02:46.683Z] 01:02:46 [task 2020-03-22T01:02:46.687Z] 01:02:46 [task 2020-03-22T01:02:46.872Z] 01:02:46 [task 2020-03-22T01:02:46.872Z] 01:02:46 [task 2020-03-22T01:02:46.872Z] 01:02:46 [task 2020-03-22T01:03:17.013Z] 01:03:17 [task 2020-03-22T01:05:17.036Z] 01:05:17 [task 2020-03-22T01:05:46.693Z] 01:05:46 [task 2020-03-22T01:05:46.759Z] 01:05:46 [task 2020-03-22T01:05:46.760Z] 01:05:46 [task 2020-03-22T01:05:46.760Z] 01:05:46 [task 2020-03-22T01:05:46.760Z] 01:05:46 [task 2020-03-22T01:05:46.761Z] 01:05:46 [task 2020-03-22T01:05:46.761Z] 01:05:46 [task 2020-03-22T01:05:46.761Z] 01:05:46 [task 2020-03-22T01:05:46.762Z] 01:05:46 [task 2020-03-22T01:05:46.762Z] 01:05:46 [task 2020-03-22T01:05:46.763Z] 01:05:46 [task 2020-03-22T01:05:46.763Z] 01:05:46 [task 2020-03-22T01:05:46.763Z] 01:05:46 [task 2020-03-22T01:05:46.763Z] 01:05:46 [task 2020-03-22T01:05:46.764Z] 01:05:46 [task 2020-03-22T01:05:46.764Z] 01:05:46 bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.765Z] 01:05:46 [task 2020-03-22T01:05:46.765Z] 01:05:46 bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.765Z] 01:05:46 [task 2020-03-22T01:05:46.766Z] 01:05:46 bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.766Z] 01:05:46 bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.766Z] 01:05:46 bz_status_RESOLVED bz_closed" bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.767Z] 01:05:46 bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.767Z] 01:05:46 bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.767Z] 01:05:46 bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.768Z] 01:05:46 bz_status_RESOLVED bz_closed" bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.768Z] 01:05:46 bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.768Z] 01:05:46 bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.769Z] 01:05:46 [task 2020-03-22T01:05:46.769Z] 01:05:46 [task 2020-03-22T01:05:46.769Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.770Z] 01:05:46 [task 2020-03-22T01:05:46.771Z] 01:05:46 bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.771Z] 01:05:46 bz_status_RESOLVED bz_closed" bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.771Z] 01:05:46 bz_status_RESOLVED bz_closed" [task 2020-03-22T01:05:46.771Z] 01:05:46 INFO - TEST-START | dom/media/test/test_playback_errors.html
INFO - GECKO(8092) | [Child 908, MediaDecoderStateMachine #1] WARNING: Decoder=1a88094cc00 state=DECODING_METADATA Decode metadata failed, shutting down decoder: file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp, line 359
INFO - GECKO(8092) | [Child 908, MediaDecoderStateMachine #1] WARNING: Decoder=1a88094cc00 Decode error: NS_ERROR_DOM_MEDIA_METADATA_ERR (0x806e0006): file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp, line 3367
INFO - GECKO(8092) | [Child 908, MediaDecoderStateMachine #1] WARNING: Decoder=1a880a9dc00 state=DECODING_METADATA Decode metadata failed, shutting down decoder: file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp, line 359
INFO - GECKO(8092) | [Child 908, MediaDecoderStateMachine #1] WARNING: Decoder=1a880a9dc00 Decode error: NS_ERROR_DOM_MEDIA_METADATA_ERR (0x806e0006): file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp, line 3367
INFO - GECKO(8092) | JavaScript error: , line 0: NotSupportedError: The media resource indicated by the src attribute or assigned media provider object was not suitable.
INFO - GECKO(8092) | JavaScript error: , line 0: NotSupportedError: The media resource indicated by the src attribute or assigned media provider object was not suitable.
INFO - GECKO(8092) | [Child 908, MediaDecoderStateMachine #1] WARNING: Decoder=1a880948800 state=DECODING_METADATA Decode metadata failed, shutting down decoder: file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp, line 359
INFO - GECKO(8092) | [Child 908, MediaDecoderStateMachine #1] WARNING: Decoder=1a880948800 Decode error: NS_ERROR_DOM_MEDIA_METADATA_ERR (0x806e0006): file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp, line 3367
INFO - GECKO(8092) | JavaScript error: , line 0: NotSupportedError: The media resource indicated by the src attribute or assigned media provider object was not suitable.
INFO - GECKO(8092) | [Child 908, MediaPDecoder #1] WARNING: vorbis_synthesis_init() failed initializing vorbis bitstream: file /builds/worker/checkouts/gecko/dom/media/ogg/OggCodecState.cpp, line 644
INFO - GECKO(8092) | [Child 908, MediaDecoderStateMachine #1] WARNING: Decoder=1a880aa1000 state=DECODING_METADATA Decode metadata failed, shutting down decoder: file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp, line 359
INFO - GECKO(8092) | [Child 908, MediaDecoderStateMachine #1] WARNING: Decoder=1a880aa1000 Decode error: NS_ERROR_DOM_MEDIA_METADATA_ERR (0x806e0006): file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp, line 3367
INFO - GECKO(8092) | JavaScript error: , line 0: NotSupportedError: The media resource indicated by the src attribute or assigned media provider object was not suitable.
INFO - GECKO(8092) | [Child 908, MediaDecoderStateMachine #1] WARNING: Decoder=1a88094cc00 state=DECODING_METADATA Decode metadata failed, shutting down decoder: file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp, line 359
INFO - GECKO(8092) | [Child 908, MediaDecoderStateMachine #1] WARNING: Decoder=1a88094cc00 Decode error: NS_ERROR_DOM_MEDIA_METADATA_ERR (0x806e0006): file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp, line 3367
INFO - GECKO(8092) | JavaScript error: , line 0: NotSupportedError: The media resource indicated by the src attribute or assigned media provider object was not suitable.
INFO - GECKO(8092) | [Parent 10224, StreamTrans #218] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/xpcom/io/nsAnonymousTemporaryFile.cpp, line 108
INFO - GECKO(8092) | [Parent 10224, StreamTrans #218] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/xpcom/io/nsAnonymousTemporaryFile.cpp, line 119
INFO - GECKO(8092) | [Parent 10224, Main Thread] WARNING: 'NS_FAILED(mRv)', file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp, line 4343
INFO - GECKO(8092) | [Parent 10224, Jump List] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/worker/checkouts/gecko/widget/windows/WinUtils.cpp, line 1347
INFO - GECKO(8092) | [Parent 10224, Jump List] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/worker/checkouts/gecko/widget/windows/WinUtils.cpp, line 1347
INFO - TEST-INFO | started process screenshot
INFO - TEST-INFO | screenshot: exit 0
INFO - Buffered messages logged at 01:02:46
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | A valid string reason is expected
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | Reason cannot be empty
INFO - Started Sun Mar 22 2020 01:02:46 GMT+0000 (Greenwich Mean Time) (1584838966.462s)
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [started bogus.wav-0 t=0.005] Length of array should match number of running tests
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [started bogus.ogv-1 t=0.01] Length of array should match number of running tests
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | bogus.wav only one error fired
INFO - [finished bogus.wav-0] remaining= bogus.ogv-1
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [finished bogus.wav-0 t=0.05] Length of array should match number of running tests
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [started 448636.ogv-2 t=0.051] Length of array should match number of running tests
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | bogus.ogv only one error fired
INFO - [finished bogus.ogv-1] remaining= 448636.ogv-2
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [finished bogus.ogv-1 t=0.055] Length of array should match number of running tests
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [started bug504843.ogv-3 t=0.056] Length of array should match number of running tests
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | 448636.ogv only one error fired
INFO - [finished 448636.ogv-2] remaining= bug504843.ogv-3
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [finished 448636.ogv-2 t=0.155] Length of array should match number of running tests
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [started bug501279.ogg-4 t=0.156] Length of array should match number of running tests
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | bug504843.ogv only one error fired
INFO - [finished bug504843.ogv-3] remaining= bug501279.ogg-4
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [finished bug504843.ogv-3 t=0.188] Length of array should match number of running tests
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [started bug603918.webm-5 t=0.189] Length of array should match number of running tests
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | bug501279.ogg only one error fired
INFO - [finished bug501279.ogg-4] remaining= bug603918.webm-5
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [finished bug501279.ogg-4 t=0.217] Length of array should match number of running tests
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [started bug604067.webm-6 t=0.217] Length of array should match number of running tests
INFO - Buffered messages finished
INFO - TEST-UNEXPECTED-FAIL | dom/media/test/test_playback_errors.html | Test timed out!
INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:299:16
INFO - onTimeout@dom/media/test/manifest.js:2088:9
INFO - setTimeout handlerMediaTestManager/this.started@dom/media/test/manifest.js:2095:57
INFO - startTest@dom/media/test/test_playback_errors.html:17:11
INFO - MediaTestManager/this.nextTest@dom/media/test/manifest.js:2169:12
INFO - MediaTestManager/this.finished@dom/media/test/manifest.js:2141:12
INFO - endedTest@dom/media/test/test_playback_errors.html:25:13
INFO - startTest/checkError</<@dom/media/test/test_playback_errors.html:30:14
INFO - EventListener.handleEventstartTest@dom/media/test/test_playback_errors.html:36:9
INFO - MediaTestManager/this.nextTest@dom/media/test/manifest.js:2169:12
INFO - MediaTestManager/this.finished@dom/media/test/manifest.js:2141:12
INFO - endedTest@dom/media/test/test_playback_errors.html:25:13
INFO - startTest/checkError</<@dom/media/test/test_playback_errors.html:30:14
INFO - EventListener.handleEventstartTest@dom/media/test/test_playback_errors.html:36:9
INFO - MediaTestManager/this.nextTest@dom/media/test/manifest.js:2169:12
INFO - MediaTestManager/this.runTests/<@dom/media/test/manifest.js:2064:12
INFO - AsyncMediaTestManager/this.runTests@dom/media/test/manifest.js:2063:19
INFO - @dom/media/test/test_playback_errors.html:43:9
INFO - bug603918.webm-5 timed out!
INFO - [finished bug603918.webm-5] remaining= bug604067.webm-6
INFO - TEST-PASS | dom/media/test/test_playback_errors.html | [finished bug603918.webm-5 t=180.229] Length of array should match number of running tests
INFO - Not taking screenshot here: see the one that was previously logged

Comment hidden (Intermittent Failures Robot)

BugBot [:suhaib / :marco/ :calixte]

Comment 2

•

5 years ago

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED

Closed: 5 years ago

Resolution: --- → INCOMPLETE

You need to log in before you can comment on or make changes to this bug.

Bugzilla

Intermittent dom/media/test/test_playback_errors.html | Test timed out!

Categories

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

Tracking

()

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

Crash Data

Security

(public)

User Story

Description

Comment 1

Comment 2