Closed Bug 1677286 Opened 5 years ago Closed 5 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | dom/media/test/test_eme_unsetMediaKeys_then_capture.html | application timed out after 370 seconds with no output

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: ncsoregi [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=321779767&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/U8_sTGkmRAmCsSvGFO6MFw/runs/0/artifacts/public/logs/live_backing.log

[task 2020-11-14T08:18:13.983Z] 08:18:13     INFO - Buffered messages logged at 08:10:08
[task 2020-11-14T08:18:13.983Z] 08:18:13     INFO - [08:10:08.7]   640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 audio: fetch of bipbop_480_959kbps-cenc-audio-key1-4.m4s complete, appending
[task 2020-11-14T08:18:13.983Z] 08:18:13     INFO - [08:10:08.11]  640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 audio: updateend for bipbop_480_959kbps-cenc-audio-key1-4.m4s, SourceBuffer{AppendMode=-, updating=false, buffered=0-1.578956, audioTracks=-, videoTracks=-}
[task 2020-11-14T08:18:13.983Z] 08:18:13     INFO - [08:10:08.12]  640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 audio: end of track
[task 2020-11-14T08:18:13.983Z] 08:18:13     INFO - [08:10:08.298] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 video: fetch of bipbop_480_624kbps-cenc-video-key2-2.m4s complete, appending
[task 2020-11-14T08:18:13.983Z] 08:18:13     INFO - [08:10:08.305] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 video: updateend for bipbop_480_624kbps-cenc-video-key2-2.m4s, SourceBuffer{AppendMode=-, updating=false, buffered=0-1.601666, audioTracks=-, videoTracks=-}
[task 2020-11-14T08:18:13.984Z] 08:18:13     INFO - [08:10:08.305] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 video: end of track
[task 2020-11-14T08:18:13.985Z] 08:18:13     INFO - [08:10:08.305] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 Tracks loaded, calling MediaSource.endOfStream()
[task 2020-11-14T08:18:13.985Z] 08:18:13     INFO - [08:10:08.309] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 session[].generateRequest(cenc, 0000003470737368010000001077efecc0b24d02ace33c1e52e2fb4b000000017e571d047e571d047e571d047e571d2100000000)
[task 2020-11-14T08:18:13.985Z] 08:18:13     INFO - [08:10:08.311] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 session[].generateRequest(cenc, 0000003470737368010000001077efecc0b24d02ace33c1e52e2fb4b000000017e571d037e571d037e571d037e571d1100000000)
[task 2020-11-14T08:18:13.985Z] 08:18:13     INFO - [08:10:08.313] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 session[].generateRequest(cenc, 0000003470737368010000001077efecc0b24d02ace33c1e52e2fb4b000000017e571d037e571d037e571d037e571d1200000000)
[task 2020-11-14T08:18:13.985Z] 08:18:13     INFO - [08:10:08.323] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 sending update message to CDM: {"keys":[{"kty":"oct","kid":"flcdBH5XHQR-Vx0EflcdIQ","k":"fldERH5XRER-V0REfldEIQ"}],"type":"temporary"}
[task 2020-11-14T08:18:13.987Z] 08:18:13     INFO - [08:10:08.325] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 sending update message to CDM: {"keys":[{"kty":"oct","kid":"flcdA35XHQN-Vx0DflcdEQ","k":"flczM35XMzN-VzMzflczEQ"}],"type":"temporary"}
[task 2020-11-14T08:18:13.987Z] 08:18:13     INFO - [08:10:08.326] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 sending update message to CDM: {"keys":[{"kty":"oct","kid":"flcdA35XHQN-Vx0DflcdEg","k":"flczM35XMzN-VzMzflczEg"}],"type":"temporary"}
[task 2020-11-14T08:18:13.987Z] 08:18:13     INFO - [08:10:08.327] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 MediaKeySession update ok!
[task 2020-11-14T08:18:13.987Z] 08:18:13     INFO - [08:10:08.328] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 MediaKeySession update ok!
[task 2020-11-14T08:18:13.987Z] 08:18:13     INFO - [08:10:08.331] 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 MediaKeySession update ok!
[task 2020-11-14T08:18:13.987Z] 08:18:13     INFO - Buffered messages finished
[task 2020-11-14T08:18:13.987Z] 08:18:13    ERROR - TEST-UNEXPECTED-TIMEOUT | dom/media/test/test_eme_unsetMediaKeys_then_capture.html | application timed out after 370 seconds with no output
[task 2020-11-14T08:18:13.988Z] 08:18:13    ERROR - Force-terminating active process(es).


--[task 2020-11-14T08:18:13.960Z] 08:18:13     INFO - TEST-PASS | dom/media/test/test_eme_unsetMediaKeys_then_capture.html | [started 640x480@959kbps with 1st keys then 640x480@624kbps with 2nd keys-12 t=20.475] Length of array should match number of running tests --```

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.