1678813 - High frequency dom/media/mediacontrol/tests/browser/browser_nosrc_and_error_media.js | Test timed out -

Status: RESOLVED FIXED

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

Description

[Treeherder Bug Filer]

Filed by: rmaries [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=322519098&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/C8GQMdurRg6XnbbQK3R2Ow/runs/1/artifacts/public/logs/live_backing.log

---

[task 2020-11-21T11:12:34.351Z] 11:12:34     INFO - TEST-START | dom/media/mediacontrol/tests/browser/browser_nosrc_and_error_media.js
[task 2020-11-21T11:12:34.668Z] 11:12:34     INFO - GECKO(7528) | 1605957154661	Marionette	TRACE	Received observer notification toplevel-window-ready
[task 2020-11-21T11:12:34.769Z] 11:12:34     INFO - GECKO(7528) | JavaScript error: resource://gre/actors/PictureInPictureChild.jsm, line 298: InvalidStateError: JSWindowActorChild.contentWindow getter: Cannot access property 'contentWindow' after actor 'PictureInPictureToggle' has been destroyed
[task 2020-11-21T11:12:34.786Z] 11:12:34     INFO - GECKO(7528) | JavaScript error: resource://gre/actors/PictureInPictureChild.jsm, line 298: InvalidStateError: JSWindowActorChild.contentWindow getter: Cannot access property 'contentWindow' after actor 'PictureInPictureToggle' has been destroyed
[task 2020-11-21T11:13:19.351Z] 11:13:19     INFO - TEST-INFO | started process screentopng
[task 2020-11-21T11:13:19.733Z] 11:13:19     INFO - TEST-INFO | screentopng: exit 0
[task 2020-11-21T11:13:19.733Z] 11:13:19     INFO - Buffered messages logged at 11:12:34
[task 2020-11-21T11:13:19.733Z] 11:13:19     INFO - Entering test bound setupTestingPref
[task 2020-11-21T11:13:19.733Z] 11:13:19     INFO - Leaving test bound setupTestingPref
[task 2020-11-21T11:13:19.733Z] 11:13:19     INFO - Entering test bound testNoSrcOrErrorMediaEntersPIPMode
[task 2020-11-21T11:13:19.734Z] 11:13:19     INFO - open media page https://example.com/browser/dom/media/mediacontrol/tests/browser/file_no_src_media.html
[task 2020-11-21T11:13:19.734Z] 11:13:19     INFO - Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "https://example.com/browser/dom/media/mediacontrol/tests/browser/file_no_src_media.html" line: 0}]
[task 2020-11-21T11:13:19.734Z] 11:13:19     INFO - controller should always inactive
[task 2020-11-21T11:13:19.734Z] 11:13:19     INFO - enter and leave PIP mode which would not affect controller
[task 2020-11-21T11:13:19.735Z] 11:13:19     INFO - TEST-PASS | dom/media/mediacontrol/tests/browser/browser_nosrc_and_error_media.js | Should be able to find Picture-in-Picture overlay. - {} == true - 
[task 2020-11-21T11:13:19.736Z] 11:13:19     INFO - TEST-PASS | dom/media/mediacontrol/tests/browser/browser_nosrc_and_error_media.js | Video should be showing the expected state. - true == true - 
[task 2020-11-21T11:13:19.737Z] 11:13:19     INFO - TEST-PASS | dom/media/mediacontrol/tests/browser/browser_nosrc_and_error_media.js | controller is still inactive - 
[task 2020-11-21T11:13:19.738Z] 11:13:19     INFO - remove tab
[task 2020-11-21T11:13:19.738Z] 11:13:19     INFO - wait until finishing close tab wrapper
[task 2020-11-21T11:13:19.738Z] 11:13:19     INFO - must wait for focus
[task 2020-11-21T11:13:19.739Z] 11:13:19     INFO - Console message: [JavaScript Error: "InvalidStateError: JSWindowActorChild.contentWindow getter: Cannot access property 'contentWindow' after actor 'PictureInPictureToggle' has been destroyed" {file: "resource://gre/actors/PictureInPictureChild.jsm" line: 298}]
[task 2020-11-21T11:13:19.739Z] 11:13:19     INFO - handleEvent@resource://gre/actors/PictureInPictureChild.jsm:298:9
[task 2020-11-21T11:13:19.740Z] 11:13:19     INFO - 
[task 2020-11-21T11:13:19.741Z] 11:13:19     INFO - Console message: [JavaScript Error: "InvalidStateError: JSWindowActorChild.contentWindow getter: Cannot access property 'contentWindow' after actor 'PictureInPictureToggle' has been destroyed" {file: "resource://gre/actors/PictureInPictureChild.jsm" line: 298}]
[task 2020-11-21T11:13:19.742Z] 11:13:19     INFO - handleEvent@resource://gre/actors/PictureInPictureChild.jsm:298:9
[task 2020-11-21T11:13:19.742Z] 11:13:19     INFO - 
[task 2020-11-21T11:13:19.743Z] 11:13:19     INFO - Buffered messages finished
[task 2020-11-21T11:13:19.744Z] 11:13:19     INFO - TEST-UNEXPECTED-FAIL | dom/media/mediacontrol/tests/browser/browser_nosrc_and_error_media.js | Test timed out - 
[task 2020-11-21T11:13:19.744Z] 11:13:19     INFO - GECKO(7528) | MEMORY STAT | vsize 3263MB | residentFast 310MB | heapAllocated 90MB
[task 2020-11-21T11:13:19.745Z] 11:13:19     INFO - TEST-OK | dom/media/mediacontrol/tests/browser/browser_nosrc_and_error_media.js | took 45007ms
[task 2020-11-21T11:13:19.745Z] 11:13:19     INFO - checking window state
[task 2020-11-21T11:13:19.746Z] 11:13:19     INFO - GECKO(7528) | must wait for focus
[task 2020-11-21T11:13:19.747Z] 11:13:19     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-11-21T11:13:19.750Z] 11:13:19     INFO - TEST-UNEXPECTED-FAIL | dom/media/mediacontrol/tests/browser/browser_nosrc_and_error_media.js | Uncaught exception received from previously timed out test - at chrome://mochitests/content/browser/dom/media/mediacontrol/tests/browser/browser_nosrc_and_error_media.js:27 - ReferenceError: info is not defined
[task 2020-11-21T11:13:19.751Z] 11:13:19     INFO - Stack trace:
[task 2020-11-21T11:13:19.751Z] 11:13:19     INFO - testNoSrcOrErrorMediaEntersPIPMode@chrome://mochitests/content/browser/dom/media/mediacontrol/tests/browser/browser_nosrc_and_error_media.js:27:5```

Comment 1

[Andreea Pavel [:apavel]]

Alastor I believe this is a regression of Bug 1659064, can you please take a look?

Comment 2

[Intermittent Failures Robot]

27 failures in 4810 pushes (0.006 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 20
• try: 3
• mozilla-central: 4

Platform breakdown:

• linux1804-64: 20
• linux1804-64-shippable: 6
• linux1804-64-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1678813&startday=2020-11-16&endday=2020-11-22&tree=all

Comment 3

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

Set release status flags based on info from the regressing bug 1659064

Comment 4

[Alastor Wu [:alwu]]

Attachment: Bug 1678813 - to ensure we would create promise focus before tab is closed.

Comment 5

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/1c8480affdfd
to ensure we would create promise focus before tab is closed. r=bryce

Comment 6

[Dorel Luca [:dluca]]

https://hg.mozilla.org/mozilla-central/rev/1c8480affdfd

Comment 7

[Cristina Coroiu [:ccoroiu]]

This is not fixed: https://treeherder.mozilla.org/jobs?repo=mozilla-central&resultStatus=testfailed%2Cbusted%2Cexception&classifiedState=unclassified&selectedTaskRun=HvmVqKD-SrOXBWCu6N9_dg.0

Reopening the bug, since it's almost perma failing.

Comment 8

[Intermittent Failures Robot]

20 failures in 105 pushes (0.19 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 12
• try: 4
• mozilla-central: 4

Platform breakdown:

• linux1804-64: 10
• linux1804-64-asan: 6
• linux1804-64-shippable: 2
• linux1804-64-devedition: 1
• linux1804-64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1678813&startday=2020-11-28&endday=2020-11-28&tree=all

Comment 9

[Intermittent Failures Robot]

99 failures in 1479 pushes (0.067 failures/push) were associated with this bug in the last 7 days.

This is the #1 most frequent failure this week.

** This failure happened more than 75 times this week! Resolving this bug is a very high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 1 week, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 46
• mozilla-central: 30
• try: 23

Platform breakdown:

• linux1804-64-asan: 21
• linux1804-64-shippable: 24
• linux1804-64: 44
• linux1804-64-devedition: 6
• linux1804-64-qr: 1
• linux1804-64-ccov: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1678813&startday=2020-11-23&endday=2020-11-29&tree=all

Comment 10

[Alastor Wu [:alwu]]

Will have a patch today.

Comment 11

[Alastor Wu [:alwu]]

Attachment: Bug 1678813 - part1 : use `waitForFocus()` to ensure the window is focus before entering fullscreen.

Comment 12

[Alastor Wu [:alwu]]

Attachment: Bug 1678813 - part2 : await all promises to ensure window is focus and loaded.

Depends on D98282

Comment 13

[Intermittent Failures Robot]

42 failures in 601 pushes (0.07 failures/push) were associated with this bug yesterday.

** This test has failed more than 150 times in the last 21 days. It should be disabled until it can be fixed. **

Repository breakdown:

• autoland: 27
• mozilla-central: 8
• try: 6
• mozilla-beta: 1

Platform breakdown:

• linux1804-64: 24
• linux1804-64-asan: 11
• linux1804-64-ccov: 2
• linux1804-64-shippable: 3
• linux1804-64-devedition: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1678813&startday=2020-11-30&endday=2020-11-30&tree=all

Comment 14

[Alastor Wu [:alwu]]

The patch 1 is the main patch to solve this intermittent failure, so I'm going to land it first because current intermittent failure rare is quite high. Patch2 is for solving another lower chance intermittent faliure, which I would land later after getting r+.

Comment 15

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/7ba52193a4f3
part1 : use `waitForFocus()` to ensure the window is focus before entering fullscreen. r=bryce

Comment 16

[Natalia Csoregi [:nataliaCs]]

https://hg.mozilla.org/mozilla-central/rev/7ba52193a4f3

Comment 17

[Intermittent Failures Robot]

68 failures in 705 pushes (0.096 failures/push) were associated with this bug yesterday.

Repository breakdown:

• try: 11
• autoland: 34
• mozilla-central: 23

Platform breakdown:

• linux1804-64: 37
• linux1804-64-asan: 16
• linux1804-64-ccov: 5
• linux1804-64-shippable: 8
• linux1804-64-devedition: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1678813&startday=2020-12-01&endday=2020-12-01&tree=all

Comment 18

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/66e7944bb19a
part2 : await all promises to ensure window is focus and loaded. r=mconley

Comment 19

[Razvan Maries]

https://hg.mozilla.org/mozilla-central/rev/66e7944bb19a

Comment 20

[Intermittent Failures Robot]

114 failures in 3712 pushes (0.031 failures/push) were associated with this bug in the last 7 days.

This is the #3 most frequent failure this week.

** This failure happened more than 75 times this week! Resolving this bug is a very high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 1 week, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 61
• mozilla-central: 31
• try: 21
• mozilla-beta: 1

Platform breakdown:

• linux1804-64: 64
• linux1804-64-asan: 28
• linux1804-64-ccov: 7
• linux1804-64-shippable: 11
• linux1804-64-devedition: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1678813&startday=2020-11-30&endday=2020-12-06&tree=all