1539191 - Intermittent Android dom/media/test/test_play_promise_8.html | Test timed out!

Status: RESOLVED INCOMPLETE

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

Description

[Treeherder Bug Filer]

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

https://treeherder.mozilla.org/logviewer.html#?job_id=236137566&repo=autoland

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

15:59:05 INFO - 266 INFO TEST-START | dom/media/test/test_play_promise_8.html
16:02:13 INFO - Buffered messages logged at 15:59:04
16:02:13 INFO - 267 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | A valid string reason is expected
16:02:13 INFO - 268 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | Reason cannot be empty
16:02:13 INFO - 269 INFO Started Tue Mar 26 2019 08:59:04 GMT-0700 (Pacific Daylight Time) (1553615944.238s)
16:02:13 INFO - 270 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started small-shot.ogg-0 t=0.03] Length of array should match number of running tests
16:02:13 INFO - 271 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started small-shot.m4a-1 t=0.031] Length of array should match number of running tests
16:02:13 INFO - 272 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(small-shot.ogg-0) element should not be paused.
16:02:13 INFO - 273 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(small-shot.ogg-0) element should be paused.
16:02:13 INFO - 274 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | small-shot.ogg-0 is resolved with undefined.
16:02:13 INFO - 275 INFO [finished small-shot.ogg-0] remaining= small-shot.m4a-1
16:02:13 INFO - 276 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished small-shot.ogg-0 t=0.076] Length of array should match number of running tests
16:02:13 INFO - 277 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started small-shot.mp3-2 t=0.077] Length of array should match number of running tests
16:02:13 INFO - 278 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(small-shot.m4a-1) element should not be paused.
16:02:13 INFO - 279 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(small-shot.m4a-1) element should be paused.
16:02:13 INFO - 280 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | small-shot.m4a-1 is resolved with undefined.
16:02:13 INFO - 281 INFO [finished small-shot.m4a-1] remaining= small-shot.mp3-2
16:02:13 INFO - 282 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished small-shot.m4a-1 t=0.097] Length of array should match number of running tests
16:02:13 INFO - 283 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started small-shot-mp3.mp4-3 t=0.097] Length of array should match number of running tests
16:02:13 INFO - 284 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(small-shot-mp3.mp4-3) element should not be paused.
16:02:13 INFO - 285 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(small-shot-mp3.mp4-3) element should be paused.
16:02:13 INFO - 286 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | small-shot-mp3.mp4-3 is resolved with undefined.
16:02:13 INFO - 287 INFO [finished small-shot-mp3.mp4-3] remaining= small-shot.mp3-2
16:02:13 INFO - 288 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished small-shot-mp3.mp4-3 t=0.137] Length of array should match number of running tests
16:02:13 INFO - 289 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started small-shot.flac-4 t=0.138] Length of array should match number of running tests
16:02:13 INFO - 290 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(small-shot.flac-4) element should not be paused.
16:02:13 INFO - 291 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(small-shot.flac-4) element should be paused.
16:02:13 INFO - 292 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | small-shot.flac-4 is resolved with undefined.
16:02:13 INFO - 293 INFO [finished small-shot.flac-4] remaining= small-shot.mp3-2
16:02:13 INFO - 294 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished small-shot.flac-4 t=0.151] Length of array should match number of running tests
16:02:13 INFO - 295 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started r11025_s16_c1-short.wav-5 t=0.152] Length of array should match number of running tests
16:02:13 INFO - 296 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(r11025_s16_c1-short.wav-5) element should not be paused.
16:02:13 INFO - 297 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(r11025_s16_c1-short.wav-5) element should be paused.
16:02:13 INFO - 298 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | r11025_s16_c1-short.wav-5 is resolved with undefined.
16:02:13 INFO - 299 INFO [finished r11025_s16_c1-short.wav-5] remaining= small-shot.mp3-2
16:02:13 INFO - 300 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished r11025_s16_c1-short.wav-5 t=0.181] Length of array should match number of running tests
16:02:13 INFO - 301 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started 320x240.ogv-6 t=0.182] Length of array should match number of running tests
16:02:13 INFO - 302 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(320x240.ogv-6) element should not be paused.
16:02:13 INFO - 303 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(320x240.ogv-6) element should be paused.
16:02:13 INFO - 304 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | 320x240.ogv-6 is resolved with undefined.
16:02:13 INFO - 305 INFO [finished 320x240.ogv-6] remaining= small-shot.mp3-2
16:02:13 INFO - 306 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished 320x240.ogv-6 t=0.248] Length of array should match number of running tests
16:02:13 INFO - 307 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started seek-short.webm-7 t=0.248] Length of array should match number of running tests
16:02:13 INFO - 308 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(seek-short.webm-7) element should not be paused.
16:02:13 INFO - 309 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(seek-short.webm-7) element should be paused.
16:02:13 INFO - 310 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | seek-short.webm-7 is resolved with undefined.
16:02:13 INFO - 311 INFO [finished seek-short.webm-7] remaining= small-shot.mp3-2
16:02:13 INFO - 312 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished seek-short.webm-7 t=0.365] Length of array should match number of running tests
16:02:13 INFO - 313 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started vp9-short.webm-8 t=0.368] Length of array should match number of running tests
16:02:13 INFO - 314 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(vp9-short.webm-8) element should not be paused.
16:02:13 INFO - 315 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(vp9-short.webm-8) element should be paused.
16:02:13 INFO - 316 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | vp9-short.webm-8 is resolved with undefined.
16:02:13 INFO - 317 INFO [finished vp9-short.webm-8] remaining= small-shot.mp3-2
16:02:13 INFO - 318 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished vp9-short.webm-8 t=0.444] Length of array should match number of running tests
16:02:13 INFO - 319 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started detodos-short.opus-9 t=0.444] Length of array should match number of running tests
16:02:13 INFO - 320 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(detodos-short.opus-9) element should not be paused.
16:02:13 INFO - 321 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(detodos-short.opus-9) element should be paused.
16:02:13 INFO - 322 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | detodos-short.opus-9 is resolved with undefined.
16:02:13 INFO - 323 INFO [finished detodos-short.opus-9] remaining= small-shot.mp3-2
16:02:13 INFO - 324 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished detodos-short.opus-9 t=0.467] Length of array should match number of running tests
16:02:13 INFO - 325 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started gizmo-short.mp4-10 t=0.467] Length of array should match number of running tests
16:02:13 INFO - 326 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(gizmo-short.mp4-10) element should not be paused.
16:02:13 INFO - 327 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(gizmo-short.mp4-10) element should be paused.
16:02:13 INFO - 328 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | gizmo-short.mp4-10 is resolved with undefined.
16:02:13 INFO - 329 INFO [finished gizmo-short.mp4-10] remaining= small-shot.mp3-2
16:02:13 INFO - 330 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished gizmo-short.mp4-10 t=0.593] Length of array should match number of running tests
16:02:13 INFO - 331 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [started flac-s24.flac-11 t=0.593] Length of array should match number of running tests
16:02:13 INFO - 332 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(flac-s24.flac-11) element should not be paused.
16:02:13 INFO - 333 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | playAndPauseWhenCanplay(flac-s24.flac-11) element should be paused.
16:02:13 INFO - 334 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | flac-s24.flac-11 is resolved with undefined.
16:02:13 INFO - 335 INFO [finished flac-s24.flac-11] remaining= small-shot.mp3-2
16:02:13 INFO - 336 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished flac-s24.flac-11 t=0.74] Length of array should match number of running tests
16:02:13 INFO - Buffered messages finished
16:02:13 INFO - 337 INFO TEST-UNEXPECTED-FAIL | dom/media/test/test_play_promise_8.html | Test timed out!
16:02:13 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:275:18
16:02:13 INFO - onTimeout@dom/media/test/manifest.js:1778:7
16:02:13 INFO - 338 INFO small-shot.mp3-2 timed out!
16:02:13 INFO - 339 INFO [finished small-shot.mp3-2] remaining=
16:02:13 INFO - 340 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished small-shot.mp3-2 t=180.099] Length of array should match number of running tests
16:02:13 INFO - 341 INFO Finished at Tue Mar 26 2019 09:02:04 GMT-0700 (Pacific Daylight Time) (1553616124.543s)
16:02:13 INFO - 342 INFO Running time: 180.306s
16:02:13 INFO - 343 INFO TEST-OK | dom/media/test/test_play_promise_8.html | took 180385ms

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• android-hw-p2-8-0-arm7-api-16-pgo: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1539191&startday=2019-03-25&endday=2019-03-31&tree=all

Comment 2

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 3

[Razvan Maries]

New occurrence: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=255626081&repo=mozilla-inbound&lineNumber=3401

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-inbound: 1

Platform breakdown:

• android-hw-p2-8-0-arm7-api-16: 1

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

Comment 5

[Cristina Coroiu [:ccoroiu]]

Recent failure log:
https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=289231657&repo=mozilla-beta&lineNumber=2599

task 2020-02-17T15:12:45.825Z] 15:11:00 INFO - 443 INFO TEST-PASS | dom/media/test/test_play_promise_8.html | [finished flac-s24.flac-11 t=0.669] Length of array should match number of running tests
[task 2020-02-17T15:12:45.825Z] 15:11:00 INFO - Buffered messages finished
[task 2020-02-17T15:12:45.825Z] 15:11:00 WARNING - 444 INFO TEST-UNEXPECTED-FAIL | dom/media/test/test_play_promise_8.html | Test timed out!
[task 2020-02-17T15:12:45.825Z] 15:11:00 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:277:18
[task 2020-02-17T15:12:45.825Z] 15:11:00 INFO - onTimeout@dom/media/test/manifest.js:2088:9
[task 2020-02-17T15:12:45.825Z] 15:11:00 INFO - 445 INFO gizmo-short.mp4-10 timed out!
[task 2020-02-17T15:12:45.825Z] 15:11:00 INFO - 446 INFO [finished gizmo-short.mp4-10] remaining=

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-beta: 1

Platform breakdown:

• android-hw-p2-8-0-android-aarch64: 1

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

Comment 7

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

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