Closed Bug 1609384 Opened 6 years ago Closed 5 years ago

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

Categories

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

Product:
Core
Component:
Audio/Video: Playback
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

[task 2020-01-15T07:05:10.155Z] 07:02:00 INFO - 148 INFO TEST-START | dom/media/test/test_bug495300.html
[task 2020-01-15T07:05:10.155Z] 07:05:10 INFO - Buffered messages logged at 07:02:00
[task 2020-01-15T07:05:10.155Z] 07:05:10 INFO - 149 INFO TEST-PASS | dom/media/test/test_bug495300.html | A valid string reason is expected
[task 2020-01-15T07:05:10.155Z] 07:05:10 INFO - 150 INFO TEST-PASS | dom/media/test/test_bug495300.html | Reason cannot be empty
[task 2020-01-15T07:05:10.155Z] 07:05:10 INFO - 151 INFO Started Wed Jan 15 2020 07:02:00 GMT+0000 (Coordinated Universal Time) (1579071720.363s)
[task 2020-01-15T07:05:10.155Z] 07:05:10 INFO - 152 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started r11025_s16_c1.wav-0 t=0.008] Length of array should match number of running tests
[task 2020-01-15T07:05:10.155Z] 07:05:10 INFO - 153 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started audio.wav-1 t=0.01] Length of array should match number of running tests
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 154 INFO TEST-PASS | dom/media/test/test_bug495300.html | Got expected 'ended' event: audio.wav
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 155 INFO TEST-PASS | dom/media/test/test_bug495300.html | currentTime equals duration: audio.wav
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 156 INFO [finished audio.wav-1] remaining= r11025_s16_c1.wav-0
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 157 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished audio.wav-1 t=0.069] Length of array should match number of running tests
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 158 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started seek.ogv-2 t=0.071] Length of array should match number of running tests
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 159 INFO TEST-PASS | dom/media/test/test_bug495300.html | Got expected 'ended' event: r11025_s16_c1.wav
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 160 INFO TEST-PASS | dom/media/test/test_bug495300.html | currentTime equals duration: r11025_s16_c1.wav
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 161 INFO [finished r11025_s16_c1.wav-0] remaining= seek.ogv-2
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 162 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished r11025_s16_c1.wav-0 t=0.077] Length of array should match number of running tests
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 163 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started 320x240.ogv-3 t=0.079] Length of array should match number of running tests
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 164 INFO TEST-PASS | dom/media/test/test_bug495300.html | Got expected 'ended' event: 320x240.ogv
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 165 INFO TEST-PASS | dom/media/test/test_bug495300.html | currentTime equals duration: 320x240.ogv
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 166 INFO [finished 320x240.ogv-3] remaining= seek.ogv-2
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 167 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished 320x240.ogv-3 t=0.216] Length of array should match number of running tests
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 168 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started seek.webm-4 t=0.217] Length of array should match number of running tests
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 169 INFO TEST-PASS | dom/media/test/test_bug495300.html | Got expected 'ended' event: seek.ogv
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 170 INFO TEST-PASS | dom/media/test/test_bug495300.html | currentTime equals duration: seek.ogv
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 171 INFO [finished seek.ogv-2] remaining= seek.webm-4
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 172 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished seek.ogv-2 t=0.261] Length of array should match number of running tests
[task 2020-01-15T07:05:10.156Z] 07:05:10 INFO - 173 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started sine.webm-5 t=0.262] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 174 INFO TEST-PASS | dom/media/test/test_bug495300.html | Got expected 'ended' event: sine.webm
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 175 INFO TEST-PASS | dom/media/test/test_bug495300.html | currentTime equals duration: sine.webm
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 176 INFO [finished sine.webm-5] remaining= seek.webm-4
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 177 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished sine.webm-5 t=0.366] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 178 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started bug516323.indexed.ogv-6 t=0.368] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - Buffered messages finished
[task 2020-01-15T07:23:05.793Z] 07:05:10 WARNING - 179 INFO TEST-UNEXPECTED-FAIL | dom/media/test/test_bug495300.html | Test timed out!
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:277:18
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - onTimeout@dom/media/test/manifest.js:2088:9
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 180 INFO seek.webm-4 timed out!
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 181 INFO [finished seek.webm-4] remaining= bug516323.indexed.ogv-6
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 182 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished seek.webm-4 t=180.243] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 183 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started split.webm-7 t=180.246] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:05:10 WARNING - 184 INFO TEST-UNEXPECTED-FAIL | dom/media/test/test_bug495300.html | Test timed out!
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:277:18
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - onTimeout@dom/media/test/manifest.js:2088:9
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 185 INFO bug516323.indexed.ogv-6 timed out!
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 186 INFO [finished bug516323.indexed.ogv-6] remaining= split.webm-7
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 187 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished bug516323.indexed.ogv-6 t=180.378] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:05:10 INFO - 188 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started detodos.opus-8 t=180.381] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:08:08 WARNING - 189 INFO TEST-UNEXPECTED-FAIL | dom/media/test/test_bug495300.html | Test timed out!
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:277:18
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - onTimeout@dom/media/test/manifest.js:2088:9
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - 190 INFO split.webm-7 timed out!
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - 191 INFO [finished split.webm-7] remaining= detodos.opus-8
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - 192 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished split.webm-7 t=360.252] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - 193 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started gizmo.mp4-9 t=360.253] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:08:08 WARNING - 194 INFO TEST-UNEXPECTED-FAIL | dom/media/test/test_bug495300.html | Test timed out!
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:277:18
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - onTimeout@dom/media/test/manifest.js:2088:9
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - 195 INFO detodos.opus-8 timed out!
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - 196 INFO [finished detodos.opus-8] remaining= gizmo.mp4-9
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - 197 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished detodos.opus-8 t=360.383] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:08:08 INFO - 198 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started owl.mp3-10 t=360.385] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:11:08 WARNING - 199 INFO TEST-UNEXPECTED-FAIL | dom/media/test/test_bug495300.html | Test timed out!
[task 2020-01-15T07:23:05.793Z] 07:11:08 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:277:18
[task 2020-01-15T07:23:05.793Z] 07:11:08 INFO - onTimeout@dom/media/test/manifest.js:2088:9
[task 2020-01-15T07:23:05.793Z] 07:11:08 INFO - 200 INFO gizmo.mp4-9 timed out!
[task 2020-01-15T07:23:05.793Z] 07:11:08 INFO - 201 INFO [finished gizmo.mp4-9] remaining= owl.mp3-10
[task 2020-01-15T07:23:05.793Z] 07:11:08 INFO - 202 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished gizmo.mp4-9 t=540.262] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:11:08 INFO - 203 INFO TEST-PASS | dom/media/test/test_bug495300.html | [started bug482461-theora.ogv-12 t=540.265] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:11:08 WARNING - 204 INFO TEST-UNEXPECTED-FAIL | dom/media/test/test_bug495300.html | Test timed out!
[task 2020-01-15T07:23:05.793Z] 07:11:08 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:277:18
[task 2020-01-15T07:23:05.793Z] 07:11:08 INFO - onTimeout@dom/media/test/manifest.js:2088:9
[task 2020-01-15T07:23:05.793Z] 07:11:08 INFO - 205 INFO owl.mp3-10 timed out!
[task 2020-01-15T07:23:05.793Z] 07:11:08 INFO - 206 INFO [finished owl.mp3-10] remaining= bug482461-theora.ogv-12
[task 2020-01-15T07:23:05.793Z] 07:11:08 INFO - 207 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished owl.mp3-10 t=540.392] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:14:07 WARNING - 208 INFO TEST-UNEXPECTED-FAIL | dom/media/test/test_bug495300.html | Test timed out!
[task 2020-01-15T07:23:05.793Z] 07:14:07 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:277:18
[task 2020-01-15T07:23:05.793Z] 07:14:07 INFO - onTimeout@dom/media/test/manifest.js:2088:9
[task 2020-01-15T07:23:05.793Z] 07:14:07 INFO - 209 INFO bug482461-theora.ogv-12 timed out!
[task 2020-01-15T07:23:05.793Z] 07:14:07 INFO - 210 INFO [finished bug482461-theora.ogv-12] remaining=
[task 2020-01-15T07:23:05.793Z] 07:14:07 INFO - 211 INFO TEST-PASS | dom/media/test/test_bug495300.html | [finished bug482461-theora.ogv-12 t=720.275] Length of array should match number of running tests
[task 2020-01-15T07:23:05.793Z] 07:14:07 INFO - 212 INFO Finished at Wed Jan 15 2020 07:14:00 GMT+0000 (Coordinated Universal Time) (1579072440.799s)
[task 2020-01-15T07:23:05.793Z] 07:14:07 INFO - 213 INFO Running time: 720.437s
[task 2020-01-15T07:23:05.793Z] 07:14:07 INFO - 214 INFO TEST-OK | dom/media/test/test_bug495300.html | took 720527ms

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.