Closed Bug 1587246 Opened 5 years ago Closed 3 years ago

Intermittent /mediacapture-streams/MediaStream-removetrack.https.html | Test that removal from a MediaStream fires ended on media elements (video first) - assert_equals: go audio ended event expected true but got false

Categories

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

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: csabou [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=270368965&repo=mozilla-central
Full log: https://queue.taskcluster.net/v1/task/ZT7OcQiySB6udDxVNIoUSA/runs/0/artifacts/public/logs/live_backing.log


[task 2019-10-09T00:10:40.077Z] 00:10:40 INFO - TEST-OK | /mediacapture-streams/MediaStream-idl.https.html | took 2055ms
[task 2019-10-09T00:10:40.078Z] 00:10:40 INFO - TEST-START | /mediacapture-streams/MediaStream-removetrack.https.html
[task 2019-10-09T00:10:40.087Z] 00:10:40 INFO - Closing window 73
[task 2019-10-09T00:10:40.214Z] 00:10:40 INFO - PID 6796 | [Parent 1400, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-09T00:10:40.214Z] 00:10:40 INFO - PID 6796 | [Child 10544, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-09T00:10:40.214Z] 00:10:40 INFO - PID 6796 | [Child 10544, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-09T00:10:40.232Z] 00:10:40 INFO - PID 6796 | [Parent 1400, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-09T00:10:40.233Z] 00:10:40 INFO - PID 6796 | [GPU 8368, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-09T00:10:40.233Z] 00:10:40 INFO - PID 6796 | [GPU 8368, Chrome_ChildThread] WARNING: pipe err
[task 2019-10-09T00:10:40.233Z] 00:10:40 INFO - PID 6796 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-10-09T00:10:40.233Z] 00:10:40 INFO - PID 6796 | or: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-09T00:10:40.234Z] 00:10:40 INFO - PID 6796 | [GPU 8368, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-09T00:10:40.234Z] 00:10:40 INFO - PID 6796 | [GPU 8368, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-09T00:10:40.234Z] 00:10:40 INFO - PID 6796 | [Parent 1400, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-09T00:10:40.234Z] 00:10:40 INFO - PID 6796 | [Parent 1400, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-09T00:10:40.234Z] 00:10:40 INFO - PID 6796 | [Parent 1400, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-09T00:10:40.256Z] 00:10:40 INFO - PID 6796 | ++DOCSHELL 00000109A217F000 == 1 [pid = 4756] [id = {93734f73-17cd-403d-acae-beb4f3193e45}]
[task 2019-10-09T00:10:40.258Z] 00:10:40 INFO - PID 6796 | ++DOMWINDOW == 1 (00000109A763D020) [pid = 4756] [serial = 1] [outer = 0000000000000000]
[task 2019-10-09T00:10:40.262Z] 00:10:40 INFO - PID 6796 | ++DOMWINDOW == 2 (00000109A6383400) [pid = 4756] [serial = 2] [outer = 00000109A763D020]
[task 2019-10-09T00:10:40.556Z] 00:10:40 INFO - PID 6796 | DLL blocklist was unable to intercept AppInit DLLs.
[task 2019-10-09T00:10:40.575Z] 00:10:40 INFO - PID 6796 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to c:\users\task_1570575545\appdata\local\temp\tmpqjt0ef.mozrunner\runtests_leaks_10808_tab_pid4280.log
[task 2019-10-09T00:10:40.616Z] 00:10:40 INFO - PID 6796 | --DOCSHELL 000001B9BE77F000 == 0 [pid = 10544] [id = {016e97dd-7ef4-4ca9-948c-47f96c31fd81}] [url = https://web-platform.test:8443/mediacapture-streams/MediaStream-idl.https.html]
[task 2019-10-09T00:10:40.839Z] 00:10:40 INFO - PID 6796 | --DOMWINDOW == 3 (000001B9C3C38020) [pid = 10544] [serial = 1] [outer = 0000000000000000] [url = https://web-platform.test:8443/mediacapture-streams/MediaStream-idl.https.html]
[task 2019-10-09T00:10:40.839Z] 00:10:40 INFO - PID 6796 | --DOMWINDOW == 2 (000001B9C2985400) [pid = 10544] [serial = 2] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-09T00:10:40.840Z] 00:10:40 INFO - PID 6796 | --DOMWINDOW == 1 (000001B9C5382C00) [pid = 10544] [serial = 4] [outer = 0000000000000000] [url = https://web-platform.test:8443/mediacapture-streams/MediaStream-idl.https.html]
[task 2019-10-09T00:10:40.840Z] 00:10:40 INFO - PID 6796 | --DOMWINDOW == 0 (000001B9BE7EB000) [pid = 10544] [serial = 3] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-09T00:10:40.850Z] 00:10:40 INFO - PID 6796 | ++DOMWINDOW == 3 (00000109A21E4C00) [pid = 4756] [serial = 3] [outer = 00000109A763D020]
[task 2019-10-09T00:10:40.889Z] 00:10:40 INFO - PID 6796 | [Child 4756, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80070057: file z:/build/build/src/dom/base/ThirdPartyUtil.cpp, line 217
[task 2019-10-09T00:10:40.928Z] 00:10:40 INFO - PID 6796 | [Child 4756, Main Thread] WARNING: '!aWin', file z:/build/build/src/dom/base/Document.cpp, line 1386
[task 2019-10-09T00:10:40.928Z] 00:10:40 INFO - PID 6796 | [Child 4756, Main Thread] WARNING: '!aWin', file z:/build/build/src/dom/base/Document.cpp, line 1386
[task 2019-10-09T00:10:41.075Z] 00:10:41 INFO - PID 6796 | ++DOMWINDOW == 4 (00000109A8D80C00) [pid = 4756] [serial = 4] [outer = 00000109A763D020]
[task 2019-10-09T00:10:41.113Z] 00:10:41 INFO - PID 6796 | nsStringStats
[task 2019-10-09T00:10:41.113Z] 00:10:41 INFO - PID 6796 | => mAllocCount: 6838
[task 2019-10-09T00:10:41.113Z] 00:10:41 INFO - PID 6796 | => mReallocCount: 0
[task 2019-10-09T00:10:41.113Z] 00:10:41 INFO - PID 6796 | => mFreeCount: 6838
[task 2019-10-09T00:10:41.114Z] 00:10:41 INFO - PID 6796 | => mShareCount: 7192
[task 2019-10-09T00:10:41.114Z] 00:10:41 INFO - PID 6796 | => mAdoptCount: 519
[task 2019-10-09T00:10:41.114Z] 00:10:41 INFO - PID 6796 | => mAdoptFreeCount: 523
[task 2019-10-09T00:10:41.114Z] 00:10:41 INFO - PID 6796 | => Process ID: 10544, Thread ID: 7216
[task 2019-10-09T00:10:41.688Z] 00:10:41 INFO -
[task 2019-10-09T00:10:41.688Z] 00:10:41 INFO - TEST-PASS | /mediacapture-streams/MediaStream-removetrack.https.html | Tests that a removal from a MediaStream works as expected
[task 2019-10-09T00:10:41.688Z] 00:10:41 INFO - TEST-UNEXPECTED-FAIL | /mediacapture-streams/MediaStream-removetrack.https.html | Test that removal from a MediaStream fires ended on media elements (video first) - assert_equals: go audio ended event expected true but got false
[task 2019-10-09T00:10:41.689Z] 00:10:41 INFO - @https://web-platform.test:8443/mediacapture-streams/MediaStream-removetrack.https.html:89:18
[task 2019-10-09T00:10:41.689Z] 00:10:41 INFO - asyncTest.prototype.step@https://web-platform.test:8443/resources/testharness.js:1908:25
[task 2019-10-09T00:10:41.689Z] 00:10:41 INFO - promise_test/tests.promise_tests</<@https://web-platform.test:8443/resources/testharness.js:591:36
[task 2019-10-09T00:10:41.689Z] 00:10:41 INFO - promise_test/tests.promise_tests<@https://web-platform.test:8443/resources/testharness.js:590:20
[task 2019-10-09T00:10:41.689Z] 00:10:41 INFO - promise callback
promise_test@https://web-platform.test:8443/resources/testharness.js:589:51
[task 2019-10-09T00:10:41.689Z] 00:10:41 INFO - @https://web-platform.test:8443/mediacapture-streams/MediaStream-removetrack.https.html:56:13
[task 2019-10-09T00:10:41.689Z] 00:10:41 INFO - .
[task 2019-10-09T00:10:41.689Z] 00:10:41 INFO - TEST-OK | /mediacapture-streams/MediaStream-removetrack.https.html | took 1605ms

Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 4 years ago4 years ago
Resolution: --- → INCOMPLETE
Status: REOPENED → RESOLVED
Closed: 4 years ago4 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 4 years ago4 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 4 years ago3 years ago
Resolution: --- → INCOMPLETE

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=340979845&repo=mozilla-central&lineNumber=18974

[task 2021-05-27T17:09:50.099Z] 17:09:50 INFO - TEST-START | /mediacapture-streams/MediaStream-removetrack.https.html
[task 2021-05-27T17:09:50.290Z] 17:09:50 INFO - Closing window 0edd4946-cb20-4a6a-86f7-b095f9471c1d
[task 2021-05-27T17:09:50.355Z] 17:09:50 INFO - PID 6128 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-05-27T17:09:50.769Z] 17:09:50 INFO - PID 6128 | [Child 6648, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-05-27T17:09:50.792Z] 17:09:50 INFO - PID 6128 | [Child 6648, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4442
[task 2021-05-27T17:09:50.947Z] 17:09:50 INFO -
[task 2021-05-27T17:09:50.947Z] 17:09:50 INFO - TEST-PASS | /mediacapture-streams/MediaStream-removetrack.https.html | Tests that a removal from a MediaStream works as expected
[task 2021-05-27T17:09:50.947Z] 17:09:50 INFO - TEST-UNEXPECTED-FAIL | /mediacapture-streams/MediaStream-removetrack.https.html | Test that removal from a MediaStream fires ended on media elements (video first) - assert_equals: go audio ended event expected true but got false
[task 2021-05-27T17:09:50.947Z] 17:09:50 INFO - @https://web-platform.test:8443/mediacapture-streams/MediaStream-removetrack.https.html:89:18
[task 2021-05-27T17:09:50.948Z] 17:09:50 INFO - .
[task 2021-05-27T17:09:50.948Z] 17:09:50 INFO - TEST-OK | /mediacapture-streams/MediaStream-removetrack.https.html | took 848ms

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 3 years ago3 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.