Closed Bug 1533648 Opened 6 years ago Closed 2 months ago

Intermittent /html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html | TextTrack's cues are indexed and updated in order during video playback - assert_equals: expected (undefined) undefined but got (object) ob

Categories

(Core :: Audio/Video, defect, P2)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Assigned: alwu)

Details

(Keywords: intermittent-failure, regression, Whiteboard: [stockwell disabled])

Attachments

(1 file)

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

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

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

06:00:54 INFO - TEST-START | /html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html
06:00:54 INFO - Setting pref dom.security.featurePolicy.enabled (true)
06:00:54 INFO - Setting pref dom.security.featurePolicy.header.enabled (true)
06:00:54 INFO - Setting pref dom.security.featurePolicy.webidl.enabled (true)
06:00:57 INFO -
06:00:57 INFO - TEST-UNEXPECTED-FAIL | /html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html | TextTrack's cues are indexed and updated in order during video playback - assert_equals: expected (undefined) undefined but got (object) object "[object VTTCue]"
06:00:57 INFO - cueEntered@http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html:32:13
06:00:57 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1587:25
06:00:57 INFO - Test.prototype.step_func/<@http://web-platform.test:8000/resources/testharness.js:1611:35
06:00:57 INFO - EventHandlerNonNull*attemptTests@http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html:21:53
06:00:57 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1587:25
06:00:57 INFO - Test.prototype.step_func/<@http://web-platform.test:8000/resources/testharness.js:1611:35
06:00:57 INFO - EventHandlerNonNull*@http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html:16:36
06:00:57 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1587:25
06:00:57 INFO - async_test@http://web-platform.test:8000/resources/testharness.js:576:22
06:00:57 INFO - @http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html:10:5
06:00:57 INFO - TEST-OK | /html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html | took 2390ms

Summary: Intermittent [TVw] /html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html | TextTrack's cues are indexed and updated in order during video playback - assert_equals: expected (undefined) undefined but got (object) ob → Intermittent /html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html | TextTrack's cues are indexed and updated in order during video playback - assert_equals: expected (undefined) undefined but got (object) ob
Component: DOM → Audio/Video

Alastor, can you please take a look at Comment 1?

Flags: needinfo?(alwu)

Will take a look.

Assignee: nobody → alwu
Flags: needinfo?(alwu)

According to the fail log, all the test fails are failed at the same assertion,

assert_equals: expected (undefined) undefined but got (object) object "[object VTTCue]

This error occured at [1], which means the currentCue is undefined. However, currentCue is a event.target, which shouldn't be null at that time. All these failures happened on the Windows, so I'm wondering whehther there is any bug for event dispatching on Windows.

[1] https://searchfox.org/mozilla-central/rev/8ff2cd0a27e3764d9540abdc5a66b2fb1e4e9644/testing/web-platform/tests/html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html#32


Hi, Smaug,

Do you have any idea why event.target would be null in this case? Is it possible there are something wrong on Windows causing the incorrect event dispatching, which results in the null event target?

Thank you!

Flags: needinfo?(bugs)

But undefined isn't null.
DOM event dispatch doesn't have anything platform specific.

Do we possibly get 'enter' event after the page has been already unloaded and then wrapping the event fails?

Flags: needinfo?(bugs)

Alastor are you working on this or should we disable it?

There are 109 total failures in the last 7 days mostly on windows10-64 debug and pgo, but also on windows7-32, windows10-64-qr

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=234254430&repo=mozilla-central&lineNumber=28089

23:18:10 INFO - TEST-START | /html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html
23:18:10 INFO - Closing window 57982058497
23:18:10 INFO - PID 9448 | [Parent 4948, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
23:18:10 INFO - PID 9448 | [Child 4904, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
23:18:10 INFO - PID 9448 | [Child 4904, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
23:18:10 INFO - PID 9448 | [Parent 4948, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
23:18:10 INFO - PID 9448 | [GPU 4428, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
23:18:10 INFO - PID 9448 | [GPU 4428, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
23:18:10 INFO - PID 9448 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
23:18:10 INFO - PID 9448 | [GPU 4428, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chr++DOCSHELL 0000012643E4D000 == 1 [pid = 10000] [id = {0e25ae7e-2339-455b-b311-63510fe1656e}]
23:18:10 INFO - PID 9448 | ome/common/ipc_channel_win.cc, line 341
23:18:10 INFO - PID 9448 | ++DOMWINDOW == 1 (0000012649CE8020) [pid = 10000] [serial = 1] [outer = 0000000000000000]
23:18:10 INFO - PID 9448 | [Parent 4948, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
23:18:10 INFO - PID 9448 | [Parent 4948, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
23:18:10 INFO - PID 9448 | [Parent 4948, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
23:18:10 INFO - PID 9448 | ++DOMWINDOW == 2 (0000012649C68000) [pid = 10000] [serial = 2] [outer = 0000012649CE8020]
23:18:10 INFO - PID 9448 | --DOMWINDOW == 1 (0000026DC2AE8020) [pid = 4904] [serial = 1] [outer = 0000000000000000] [url = http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-cues-cuechange.html]
23:18:10 INFO - PID 9448 | --DOCSHELL 0000026DBCA4D000 == 0 [pid = 4904] [id = {69c5ed33-0d0a-4e7e-802e-ef8d7e3cd215}] [url = http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-cues-cuechange.html]
23:18:10 INFO - PID 9448 | --DOMWINDOW == 0 (0000026DC4551400) [pid = 4904] [serial = 4] [outer = 0000000000000000] [url = http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-cues-cuechange.html]
23:18:10 INFO - PID 9448 | nsStringStats
23:18:10 INFO - PID 9448 | => mAllocCount: 7902
23:18:10 INFO - PID 9448 | => mReallocCount: 0
23:18:10 INFO - PID 9448 | => mFreeCount: 7902
23:18:10 INFO - PID 9448 | => mShareCount: 6704
23:18:10 INFO - PID 9448 | => mAdoptCount: 590
23:18:10 INFO - PID 9448 | => mAdoptFreeCount: 594
23:18:10 INFO - PID 9448 | => Process ID: 4904, Thread ID: 9316
23:18:10 INFO - PID 9448 | ++DOMWINDOW == 3 (000001264A27A000) [pid = 10000] [serial = 3] [outer = 0000012649CE8020]
23:18:10 INFO - PID 9448 | [Child 10000, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file z:/build/build/src/xpcom/base/nsSystemInfo.cpp, line 111
23:18:10 INFO - PID 9448 | [Child 10000, Main Thread] WARNING: site security information will not be persisted: file z:/build/build/src/security/manager/ssl/nsSiteSecurityService.cpp, line 506
23:18:10 INFO - PID 9448 | [Parent 4948, Main Thread] WARNING:### XPC'NS_FAILED(rv)', fileOM_MEM_BLOAT_LOG defined -- logging bloat/ z:/build/build/src/netwleaks to c:\users\task_1552688370\erk/url-classifappdata\local\temp\ier/UrlClassifierCommon.cpp, line 117
23:18:10 INFO - PID 9448 | tmpadfmgy.mozrunner\runtests_leaks_1520_tab_pid8788.log
23:18:10 INFO - PID 9448 | ++DOMWINDOW == 4 (000001264BB4D400) [pid = 10000] [serial = 4] [outer = 0000012649CE8020]
23:18:10 INFO - PID 9448 | [Parent 4948, Main Thread] WARNING: '!parent', file z:/build/build/src/netwerk/ipc/NeckoParent.cpp, line 954
23:18:12 INFO -
23:18:12 INFO - TEST-UNEXPECTED-FAIL | /html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html | TextTrack's cues are indexed and updated in order during video playback - assert_equals: expected (undefined) undefined but got (object) object "[object VTTCue]"
23:18:12 INFO - cueEntered@http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html:32:13
23:18:12 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1587:25
23:18:12 INFO - Test.prototype.step_func/<@http://web-platform.test:8000/resources/testharness.js:1611:35
23:18:12 INFO - EventHandlerNonNullattemptTests@http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html:21:53
23:18:12 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1587:25
23:18:12 INFO - Test.prototype.step_func/<@http://web-platform.test:8000/resources/testharness.js:1611:35
23:18:12 INFO - EventHandlerNonNull
@http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html:16:36
23:18:12 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1587:25
23:18:12 INFO - async_test@http://web-platform.test:8000/resources/testharness.js:576:22
23:18:12 INFO - @http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html:10:5
23:18:12 INFO - TEST-OK | /html/semantics/embedded-content/media-elements/track/track-element/track-cues-enter-exit.html | took 2674ms

Flags: needinfo?(alwu)
Whiteboard: [stockwell disable-recommended] → [stockwell needswork]
Whiteboard: [stockwell disable-recommended] → [stockwell needswork]

Hi, Andreea,
Could you help me disable this test for now? because I haven't found the root cause so we should disable it first and I will keep investigate it.
Thank you!

Flags: needinfo?(alwu) → needinfo?(apavel)
Keywords: leave-open
Whiteboard: [stockwell disable-recommended] → [stockwell disabled]
Pushed by ccoroiu@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/117ee5068079 disable track-cues-enter-exit.html on windows for frequent failures r=jmaher

Cristina disabled the patch, let us know if you need anything else Alastor.

Flags: needinfo?(apavel)
Priority: -- → P2
Severity: normal → S3
Status: NEW → RESOLVED
Closed: 2 months ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: