1792516 - High frequency dom/ipc/tests/browser_content_shutdown_with_endless_js.js | single tracking bug

Status: RESOLVED FIXED

(Core :: DOM: Content Processes, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2022-09-27T06:23:36.459Z] 06:23:36     INFO - TEST-PASS | dom/ipc/tests/browser_content_shutdown_with_endless_js.js | Shutdown of content process. - 
[task 2022-09-27T06:23:36.460Z] 06:23:36     INFO - Create and shutdown a content process for http://mochi.test:8888/browser/dom/ipc/tests/file_endless_js.html
[task 2022-09-27T06:23:36.460Z] 06:23:36     INFO - Buffered messages finished
[task 2022-09-27T06:23:36.461Z] 06:23:36     INFO - TEST-UNEXPECTED-FAIL | dom/ipc/tests/browser_content_shutdown_with_endless_js.js | Test timed out - 
[task 2022-09-27T06:23:41.455Z] 06:23:41     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-09-27T06:23:41.456Z] 06:23:41     INFO - TEST-UNEXPECTED-FAIL | dom/ipc/tests/browser_content_shutdown_with_endless_js.js | waiting for vsync to be disabled - timed out after 50 tries. - false == true - JS frame :: chrome://mochikit/content/browser-test.js :: ensureVsyncDisabled :: line 592
[task 2022-09-27T06:23:41.456Z] 06:23:41     INFO - Stack trace:
[task 2022-09-27T06:23:41.457Z] 06:23:41     INFO - chrome://mochikit/content/browser-test.js:ensureVsyncDisabled:592
[task 2022-09-27T06:23:41.457Z] 06:23:41     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-09-27T06:23:41.458Z] 06:23:41     INFO - TEST-UNEXPECTED-FAIL | dom/ipc/tests/browser_content_shutdown_with_endless_js.js | vsync remained enabled at the end of the test. Is there an animation still running? Consider talking to the performance team for tips to solve this. - false == true - JS frame :: chrome://mochikit/content/browser-test.js :: ensureVsyncDisabled :: line 593
[task 2022-09-27T06:23:41.458Z] 06:23:41     INFO - Stack trace:
[task 2022-09-27T06:23:41.458Z] 06:23:41     INFO - chrome://mochikit/content/browser-test.js:ensureVsyncDisabled:593
[task 2022-09-27T06:23:41.466Z] 06:23:41     INFO - GECKO(9108) | MEMORY STAT | vsize 2104123MB | vsizeMaxContiguous 65677247MB | residentFast 220MB | heapAllocated 82MB
[task 2022-09-27T06:23:41.467Z] 06:23:41     INFO - TEST-OK | dom/ipc/tests/browser_content_shutdown_with_endless_js.js | took 50091ms
[task 2022-09-27T06:23:41.467Z] 06:23:41     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-09-27T06:23:41.469Z] 06:23:41     INFO - TEST-UNEXPECTED-FAIL | dom/ipc/tests/browser_content_shutdown_with_endless_js.js | Found a tab after previous test timed out: http://mochi.test:8888/browser/dom/ipc/tests/file_endless_js.html - 
[task 2022-09-27T06:23:41.475Z] 06:23:41     INFO - GECKO(9108) | JavaScript warning: http://mochi.test:8888/browser/dom/ipc/tests/file_endless_js.html, line 9: Script terminated by timeout at:
[task 2022-09-27T06:23:41.476Z] 06:23:41     INFO - GECKO(9108) | hang@http://mochi.test:8888/browser/dom/ipc/tests/file_endless_js.html:9:12
[task 2022-09-27T06:23:41.485Z] 06:23:41     INFO - checking window state
[task 2022-09-27T06:23:41.496Z] 06:23:41     INFO - TEST-START | dom/ipc/tests/browser_crash_oopiframe.js
[task 2022-09-27T06:23:41.514Z] 06:23:41     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-09-27T06:23:41.524Z] 06:23:41     INFO - Buffered messages logged at 06:23:41
[task 2022-09-27T06:23:41.524Z] 06:23:41     INFO - Entering test bound test_crashframe
[task 2022-09-27T06:23:41.525Z] 06:23:41     INFO - TEST-PASS | dom/ipc/tests/browser_crash_oopiframe.js | This test only makes sense of we can use OOP iframes. - 
[task 2022-09-27T06:23:41.526Z] 06:23:41     INFO - Console message: [JavaScript Warning: "Script terminated by timeout at:
[task 2022-09-27T06:23:41.526Z] 06:23:41     INFO - hang@http://mochi.test:8888/browser/dom/ipc/tests/file_endless_js.html:9:12
[task 2022-09-27T06:23:41.526Z] 06:23:41     INFO - " {file: "http://mochi.test:8888/browser/dom/ipc/tests/file_endless_js.html" line: 9}]
[task 2022-09-27T06:23:41.527Z] 06:23:41     INFO - Buffered messages finished
[task 2022-09-27T06:23:41.528Z] 06:23:41     INFO - TEST-UNEXPECTED-FAIL | dom/ipc/tests/browser_content_shutdown_with_endless_js.js | Uncaught exception received from previously timed out test - at chrome://mochitests/content/browser/dom/ipc/tests/browser_content_shutdown_with_endless_js.js:31 - TypeError: can't access property "frameLoader", otherBrowser is null
[task 2022-09-27T06:23:41.528Z] 06:23:41     INFO - Stack trace:
[task 2022-09-27T06:23:41.528Z] 06:23:41     INFO - createAndShutdownContentProcess/<@chrome://mochitests/content/browser/dom/ipc/tests/browser_content_shutdown_with_endless_js.js:31:23
[task 2022-09-27T06:23:41.528Z] 06:23:41     INFO - withNewTab@resource://testing-common/BrowserTestUtils.jsm:151:24
[task 2022-09-27T06:23:41.529Z] 06:23:41     INFO - GECKO(9108) | JavaScript error: chrome://mochikit/content/browser-test.js, line 1108: TypeError: can't access property "shift", currentScope.__tasks is null
[task 2022-09-27T06:23:41.529Z] 06:23:41     INFO - Console message: [JavaScript Error: "TypeError: can't access property "shift", currentScope.__tasks is null" {file: "chrome://mochikit/content/browser-test.js" line: 1108}]
[task 2022-09-27T06:23:41.557Z] 06:23:41     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to http://example.com/ because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2022-09-27T06:23:41.568Z] 06:23:41     INFO - Console message: [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use <!DOCTYPE html>." {file: "http://example.com/" line: 0}]
[task 2022-09-27T06:23:41.580Z] 06:23:41     INFO - TEST-PASS | dom/ipc/tests/browser_crash_oopiframe.js | oop frame has root as parent 

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1
• mozilla-beta: 1

Platform and build breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1792516&startday=2022-09-26&endday=2022-10-02&tree=all

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

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

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

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1

Platform and build breakdown:

• windows10-64-2004-shippable-qr: 1
  • opt: 1

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

Comment 4

[Intermittent Failures Robot]

2 failures in 3743 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
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1792516&startday=2022-10-24&endday=2022-10-30&tree=all

Comment 5

[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:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1792516&startday=2022-10-31&endday=2022-11-06&tree=all

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• macosx1015-64-qr: 3
  • opt: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1792516&startday=2022-11-07&endday=2022-11-13&tree=all

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1792516&startday=2022-11-21&endday=2022-11-27&tree=all

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1
• mozilla-beta: 3
• autoland: 2
• mozilla-central: 2

Platform and build breakdown:

• windows10-64-2004-devedition-qr: 2
  • opt: 2
• macosx1100-64-shippable-qr: 6
  • opt: 6

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

Comment 9

[Iulian Moraru]

Lately, this is failing frequent with this failure line TEST-UNEXPECTED-FAIL | dom/ipc/tests/browser_content_shutdown_with_endless_js.js | Test timed out -

Hi Artur! Can you please take a look at this?
Thank you!

Comment 10

[Jens Stutte [:jstutte]]

Looking at

[task 2022-12-03T12:34:04.905Z] 12:34:04     INFO - Buffered messages logged at 12:33:20
[task 2022-12-03T12:34:04.905Z] 12:34:04     INFO - TEST-PASS | dom/ipc/tests/browser_content_shutdown_with_endless_js.js | Content process created. - 
[task 2022-12-03T12:34:04.905Z] 12:34:04     INFO - TEST-PASS | dom/ipc/tests/browser_content_shutdown_with_endless_js.js | Shutdown of content process. - 
[task 2022-12-03T12:34:04.905Z] 12:34:04     INFO - Create and shutdown a content process for http://mochi.test:8888/browser/dom/ipc/tests/file_endless_js.html
[task 2022-12-03T12:34:04.905Z] 12:34:04     INFO - Buffered messages finished

suggests, that this is basically the same as we had in bug 1782718, that is we do never get the notification that the tab has loaded. I wonder if we should try to add a real timeout >0 here at <body onload="setTimeout(hang)"> ?

Comment 11

[Olli Pettay [:smaug][[e-mail]]]

Or send an explicit message to the page to trigger the hang?

I wonder if one can reproduce this locally on an opt build, when running with --verify or something.

Comment 12

[Cosmin Sabou [:CosminS]]

Failure rate should go down after the backout of bug 1803966 https://hg.mozilla.org/integration/autoland/rev/07a25d3cdd49528091cdeaf3b958a6ce88c3af3a

Comment 13

[Intermittent Failures Robot]

59 failures in 806 pushes (0.073 failures/push) were associated with this bug yesterday.

Repository breakdown:

• mozilla-central: 17
• autoland: 36
• try: 6

Platform and build breakdown:

• windows10-64-2004-qr: 18
  • debug: 8
  • opt: 10
• macosx1015-64-shippable-qr: 4
  • opt: 4
• macosx1100-64-shippable-qr: 14
  • opt: 14
• windows10-32-2004-qr: 4
  • debug: 4
• macosx1015-64-qr: 9
  • opt: 9
• windows10-64-2004-ccov-qr: 2
  • opt: 2
• windows7-32-qr: 2
  • opt: 2
• windows10-64-2004-shippable-qr: 3
  • opt: 3
• windows10-64-2004-devedition-qr: 1
  • opt: 1
• windows7-32-shippable-qr: 1
  • opt: 1
• macosx1015-64-devedition-qr: 1
  • opt: 1

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

Comment 14

[Jens Stutte [:jstutte]]

Attachment: Bug 1792516 - Have an explicit message to start the hang function. r?smaug

Comment 15

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/5b38548871de
Have an explicit message to start the hang function. r=smaug

Comment 16

[Marian-Vasile Laza]

https://hg.mozilla.org/mozilla-central/rev/5b38548871de

Comment 17

[Intermittent Failures Robot]

65 failures in 3510 pushes (0.019 failures/push) were associated with this bug in the last 7 days.

This is the #13 most frequent failure this week.

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

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

Repository breakdown:

• mozilla-central: 21
• autoland: 38
• try: 6

Platform and build breakdown:

• macosx1100-64-shippable-qr: 19
  • opt: 19
• macosx1015-64-qr: 10
  • opt: 10
• windows10-64-2004-qr: 18
  • debug: 8
  • opt: 10
• macosx1015-64-shippable-qr: 4
  • opt: 4
• windows10-32-2004-qr: 4
  • debug: 4
• windows10-64-2004-ccov-qr: 2
  • opt: 2
• windows7-32-qr: 2
  • opt: 2
• windows10-64-2004-shippable-qr: 3
  • opt: 3
• windows10-64-2004-devedition-qr: 1
  • opt: 1
• windows7-32-shippable-qr: 1
  • opt: 1
• macosx1015-64-devedition-qr: 1
  • opt: 1

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

Comment 18

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-release: 1

Platform and build breakdown:

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

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