1724557 - Intermittent toolkit/content/tests/browser/browser_media_wakelock.js | Test timed out -

Status: RESOLVED DUPLICATE of bug 1775550

(Toolkit :: General, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2021-08-07T03:34:17.858Z] 03:34:17     INFO - TEST-START | toolkit/content/tests/browser/browser_media_wakelock.js
[task 2021-08-07T03:34:18.266Z] 03:34:18     INFO - GECKO(6324) | [Child 6755, MediaDecoderStateMachine #1] WARNING: 10aee4200 Could not set cubeb stream name.: file /builds/worker/checkouts/gecko/dom/media/AudioStream.cpp:367
[task 2021-08-07T03:34:19.122Z] 03:34:19     INFO - GECKO(6324) | JavaScript error: resource://gre/actors/AudioPlaybackParent.jsm, line 24: TypeError: can't access property "audioPlaybackStopped", browser is null
[task 2021-08-07T03:34:19.128Z] 03:34:19     INFO - GECKO(6324) | [Parent 6324, IPC I/O Parent] WARNING: FileDescriptorSet destroyed with unconsumed descriptors: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/file_descriptor_set_posix.cc:19
[task 2021-08-07T03:34:19.612Z] 03:34:19     INFO - GECKO(6324) | [Child 6756, MediaDecoderStateMachine #1] WARNING: 116ed7600 Could not set cubeb stream name.: file /builds/worker/checkouts/gecko/dom/media/AudioStream.cpp:367
[task 2021-08-07T03:34:20.576Z] 03:34:20     INFO - GECKO(6324) | [Child 6757, MediaDecoderStateMachine #1] WARNING: 10dae5000 Could not set cubeb stream name.: file /builds/worker/checkouts/gecko/dom/media/AudioStream.cpp:367
[task 2021-08-07T03:34:22.891Z] 03:34:22     INFO - GECKO(6324) | [Child 6767, MediaDecoderStateMachine #1] WARNING: 118dd7b00 Could not set cubeb stream name.: file /builds/worker/checkouts/gecko/dom/media/AudioStream.cpp:367
[task 2021-08-07T03:34:23.791Z] 03:34:23     INFO - GECKO(6324) | JavaScript error: resource://gre/actors/AudioPlaybackParent.jsm, line 24: TypeError: can't access property "audioPlaybackStopped", browser is null
[task 2021-08-07T03:34:24.155Z] 03:34:24     INFO - GECKO(6324) | [Child 6768, MediaDecoderStateMachine #1] WARNING: 10f5e2c00 OpenCubeb() failed to init cubeb: file /builds/worker/checkouts/gecko/dom/media/AudioStream.cpp:324
[task 2021-08-07T03:34:24.156Z] 03:34:24     INFO - GECKO(6324) | [Child 6768, MediaDecoderStateMachine #1] WARNING: Decoder=11b5b8000 [OnMediaSinkAudioError]: file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp:3980
[task 2021-08-07T03:34:24.156Z] 03:34:24     INFO - GECKO(6324) | [Child 6768, MediaDecoderStateMachine #1] WARNING: Decoder=11b5b8000 Decode error: NS_ERROR_DOM_MEDIA_MEDIASINK_ERR (0x806e000b) - OnMediaSinkAudioError: file /builds/worker/checkouts/gecko/dom/media/MediaDecoderStateMachine.cpp:3541
[task 2021-08-07T03:35:02.975Z] 03:35:02     INFO - TEST-INFO | started process screencapture
[task 2021-08-07T03:35:03.111Z] 03:35:03     INFO - TEST-INFO | screencapture: exit 0
[task 2021-08-07T03:35:03.111Z] 03:35:03     INFO - Buffered messages logged at 03:34:17
[task 2021-08-07T03:35:03.111Z] 03:35:03     INFO - Entering test bound testCheckWakelockWhenChangeTabVisibility
[task 2021-08-07T03:35:03.112Z] 03:35:03     INFO - start a new tab for 'playing video'
[task 2021-08-07T03:35:03.112Z] 03:35:03     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/toolkit/content/tests/browser/file_video.html" line: 0}]
[task 2021-08-07T03:35:03.112Z] 03:35:03     INFO - Buffered messages logged at 03:34:18
[task 2021-08-07T03:35:03.112Z] 03:35:03     INFO - wait for media starting playing
[task 2021-08-07T03:35:03.112Z] 03:35:03     INFO - TEST-PASS | toolkit/content/tests/browser/browser_media_wakelock.js | video started playing. - true == true - 
<...>
[task 2021-08-07T03:35:03.124Z] 03:35:03     INFO - TEST-PASS | toolkit/content/tests/browser/browser_media_wakelock.js | video started playing. - true == true - 
[task 2021-08-07T03:35:03.124Z] 03:35:03     INFO - wait until wakelock becomes locked-foreground
[task 2021-08-07T03:35:03.124Z] 03:35:03     INFO - Console message: [JavaScript Warning: "Media resource https://example.com/browser/toolkit/content/tests/browser/audio.ogg could not be decoded, error: Error Code: NS_ERROR_DOM_MEDIA_MEDIASINK_ERR (0x806e000b)
[task 2021-08-07T03:35:03.124Z] 03:35:03     INFO - Details: OnMediaSinkAudioError" {file: "https://example.com/browser/toolkit/content/tests/browser/file_mediaPlayback2.html" line: 0}]
[task 2021-08-07T03:35:03.124Z] 03:35:03     INFO - Buffered messages finished
[task 2021-08-07T03:35:03.125Z] 03:35:03     INFO - TEST-UNEXPECTED-FAIL | toolkit/content/tests/browser/browser_media_wakelock.js | Test timed out - 
[task 2021-08-07T03:35:03.125Z] 03:35:03     INFO - GECKO(6324) | MEMORY STAT | vsize 410618MB | residentFast 427MB | heapAllocated 133MB
[task 2021-08-07T03:35:03.125Z] 03:35:03     INFO - TEST-OK | toolkit/content/tests/browser/browser_media_wakelock.js | took 45122ms
[task 2021-08-07T03:35:03.125Z] 03:35:03     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-07T03:35:03.125Z] 03:35:03     INFO - TEST-UNEXPECTED-FAIL | toolkit/content/tests/browser/browser_media_wakelock.js | Found a tab after previous test timed out: https://example.com/browser/toolkit/content/tests/browser/file_mediaPlayback2.html - 
[task 2021-08-07T03:35:03.125Z] 03:35:03     INFO - checking window state
[task 2021-08-07T03:35:03.125Z] 03:35:03     INFO - TEST-START | toolkit/content/tests/browser/browser_media_wakelock_PIP.js
[task 2021-08-07T03:35:03.181Z] 03:35:03     INFO - GECKO(6324) | must wait for focus
[task 2021-08-07T03:35:03.320Z] 03:35:03     INFO - GECKO(6324) | [Child 6773, MediaDecoderStateMachine #1] WARNING: 11907ed00 Could not set cubeb stream name.: file /builds/worker/checkouts/gecko/dom/media/AudioStream.cpp:367
[task 2021-08-07T03:35:03.368Z] 03:35:03     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-07T03:35:03.368Z] 03:35:03     INFO - Buffered messages logged at 03:35:03
[task 2021-08-07T03:35:03.368Z] 03:35:03     INFO - Entering test bound testCheckWakelockForPIPVideo
[task 2021-08-07T03:35:03.368Z] 03:35:03     INFO - start a new tab for 'playing a PIP video'
[task 2021-08-07T03:35:03.369Z] 03:35:03     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/toolkit/content/tests/browser/file_video.html" line: 0}]
[task 2021-08-07T03:35:03.369Z] 03:35:03     INFO - wait for PIP video starting playing
[task 2021-08-07T03:35:03.369Z] 03:35:03     INFO - TEST-PASS | toolkit/content/tests/browser/browser_media_wakelock_PIP.js | video started playing. - true == true - 
[task 2021-08-07T03:35:03.369Z] 03:35:03     INFO - wait until wakelock becomes locked-foreground
[task 2021-08-07T03:35:03.369Z] 03:35:03     INFO - TEST-PASS | toolkit/content/tests/browser/browser_media_wakelock_PIP.js | the wakelock state for 'audio-playing' is equal to 'locked-foreground' - 
[task 2021-08-07T03:35:03.369Z] 03:35:03     INFO - TEST-PASS | toolkit/content/tests/browser/browser_media_wakelock_PIP.js | the wakelock state for 'video-playing' is equal to 'locked-foreground' - 
[task 2021-08-07T03:35:03.370Z] 03:35:03     INFO - switch tab to background and still own foreground locks due to visible PIP video
[task 2021-08-07T03:35:03.370Z] 03:35:03     INFO - Buffered messages finished
[task 2021-08-07T03:35:03.370Z] 03:35:03     INFO - TEST-UNEXPECTED-FAIL | toolkit/content/tests/browser/browser_media_wakelock.js | Uncaught exception received from previously timed out test - at chrome://mochitests/content/browser/toolkit/content/tests/browser/head.js:342 - ReferenceError: is is not defined
[task 2021-08-07T03:35:03.370Z] 03:35:03     INFO - Stack trace:
[task 2021-08-07T03:35:03.370Z] 03:35:03     INFO - waitForExpectedWakeLockState@chrome://mochitests/content/browser/toolkit/content/tests/browser/head.js:342:3
[task 2021-08-07T03:35:03.685Z] 03:35:03     INFO - TEST-PASS | toolkit/content/tests/browser/browser_media_wakelock_PIP.js | the wakelock state for 'audio-playing' is equal to 'locked-foreground' - 
[task 2021-08-07T03:35:03.686Z] 03:35:03     INFO - TEST-PASS | toolkit/content/tests/browser/browser_media_wakelock_PIP.js | the wakelock state for 'video-playing' is equal to 'locked-foreground' - 

Comment 1

[Intermittent Failures Robot]

3 failures in 2829 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2
• mozilla-central: 1

Platform and build breakdown:

• macosx1100-64-shippable-qr: 2
  • opt: 2
• linux1804-64-clang-trunk: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1724557&startday=2021-08-02&endday=2021-08-08&tree=all

Comment 2

[Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)]

Attachment: Bug 1724557 - skip browser_media_wakelock.js on macOS 11 with Apple Silicon for failing frequently. r=Mossop DONTBUILD

Bug 1714200 had enabled e.g. mochitests on macOS 11.

Comment 3

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/9398dfc25347
skip browser_media_wakelock.js on macOS 11 with Apple Silicon for failing frequently. r=mossop DONTBUILD

Comment 4

[Iulian Moraru]

https://hg.mozilla.org/mozilla-central/rev/9398dfc25347

Comment 5

[Intermittent Failures Robot]

1 failures in 3025 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• macosx1100-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1724557&startday=2021-08-09&endday=2021-08-15&tree=all

Comment 6

[Alexandru Michis [:malexandru]]

Recent occurrence: https://treeherder.mozilla.org/logviewer?job_id=348896536&repo=autoland&lineNumber=11146

Comment 7

[Intermittent Failures Robot]

3 failures in 2899 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2
• mozilla-central: 1

Platform and build breakdown:

• macosx1100-64-shippable-qr: 3
  • opt: 3

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

Comment 8

[Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)]

Attachment: Bug 1724557 - skip test browser_media_wakelock.js again on Apple Silicon for intermittent failures. DONTBUILD

skip condition got removed in bug 1726309 but test is not as stable as
expected.

Comment 9

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/75a7ce28bb47
skip test browser_media_wakelock.js again on Apple Silicon for intermittent failures. DONTBUILD

Comment 10

[Natalia Csoregi [:nataliaCs]]

https://hg.mozilla.org/mozilla-central/rev/75a7ce28bb47

Comment 11

[Intermittent Failures Robot]

2 failures in 2873 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• linux1804-64-qr: 2
  • debug: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1724557&startday=2021-09-20&endday=2021-09-26&tree=all

Comment 12

[Intermittent Failures Robot]

2 failures in 3376 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• linux1804-64-qr: 2
  • debug: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1724557&startday=2021-09-27&endday=2021-10-03&tree=all

Comment 13

[Intermittent Failures Robot]

2 failures in 3626 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1
• linux1804-64-tsan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1724557&startday=2021-10-04&endday=2021-10-10&tree=all

Comment 14

[Intermittent Failures Robot]

5 failures in 3315 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 2
• autoland: 3

Platform and build breakdown:

• linux1804-64-qr: 4
  • debug: 4
• linux1804-64-tsan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1724557&startday=2021-10-11&endday=2021-10-17&tree=all

Comment 15

[Intermittent Failures Robot]

1 failures in 3323 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1724557&startday=2022-03-28&endday=2022-04-03&tree=all

Comment 16

[Intermittent Failures Robot]

1 failures in 3540 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1724557&startday=2022-05-02&endday=2022-05-08&tree=all

Comment 17

[Intermittent Failures Robot]

1 failures in 2694 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• macosx1015-64-shippable-qr: 1
  • opt: 1

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