1706896 - Intermittent devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as

Status: RESOLVED FIXED

(DevTools :: Inspector: Animations, defect, P5)

Description

[Treeherder Bug Filer]

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

---

INFO - TEST-START | devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path.js
[task 2021-04-22T06:30:47.346Z] 06:30:47     INFO - GECKO(2391) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpQaUcV6.mozrunner/runtests_leaks_tab_pid3934.log
[task 2021-04-22T06:30:47.347Z] 06:30:47     INFO - GECKO(2391) | [3934, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:254
[task 2021-04-22T06:30:47.450Z] 06:30:47     INFO - GECKO(2391) | [Child 3909: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f1e58b94400 == 0 [pid = 3909] [id = 0] [url = http://example.com/browser/devtools/client/inspector/animation/test/doc_simple_animation.html]
[task 2021-04-22T06:30:47.687Z] 06:30:47     INFO - GECKO(2391) | [Child 3934, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:619
[task 2021-04-22T06:30:47.853Z] 06:30:47     INFO - GECKO(2391) | [Parent 2391: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f56fbeee000 == 7 [pid = 2391] [id = 166] [url = chrome://devtools/content/inspector/index.xhtml]
[task 2021-04-22T06:30:47.854Z] 06:30:47     INFO - GECKO(2391) | [Parent 2391: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f56fa926800 == 6 [pid = 2391] [id = 167] [url = chrome://devtools/content/inspector/markup/markup.xhtml]
[task 2021-04-22T06:30:47.857Z] 06:30:47     INFO - GECKO(2391) | [Parent 2391: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f56fa98a800 == 5 [pid = 2391] [id = 165] [url = about:devtools-toolbox]
[task 2021-04-22T06:30:47.946Z] 06:30:47     INFO - GECKO(2391) | [Child 3909: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f1e6f264200) [pid = 3909] [serial = 1] [outer = 0] [url = http://example.com/browser/devtools/client/inspector/animation/test/doc_simple_animation.html]
[task 2021-04-22T06:30:47.947Z] 06:30:47     INFO - GECKO(2391) | [Child 3909: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f1e529bdc00) [pid = 3909] [serial = 3] [outer = 0] [url = http://example.com/browser/devtools/client/inspector/animation/test/doc_simple_animation.html]
[task 2021-04-22T06:30:47.948Z] 06:30:47     INFO - GECKO(2391) | [Child 3909, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3361
[task 2021-04-22T06:30:47.966Z] 06:30:47     INFO - GECKO(2391) | [Child 3909, Main Thread] WARNING: '!obs', file /builds/worker/checkouts/gecko/toolkit/components/sessionstore/RestoreTabContentObserver.cpp:58
[task 2021-04-22T06:30:48.054Z] 06:30:48     INFO - GECKO(2391) | [Child 3909, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4442
[task 2021-04-22T06:30:48.130Z] 06:30:48     INFO - GECKO(2391) | [Child 3934: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7ff35a594400 == 1 [pid = 3934] [id = 0]
<...>
INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path.js | The main process DevToolsServer has no pending connection when the test ends - 
[task 2021-04-22T06:32:34.578Z] 06:32:34     INFO - Buffered messages finished
[task 2021-04-22T06:32:34.578Z] 06:32:34     INFO - TEST-UNEXPECTED-FAIL | devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. - 
[task 2021-04-22T06:32:34.579Z] 06:32:34     INFO - GECKO(2391) | MEMORY STAT | vsize 3014MB | residentFast 438MB | heapAllocated 143MB
[task 2021-04-22T06:32:34.580Z] 06:32:34     INFO - TEST-OK | devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path.js | took 106887ms
[task 2021-04-22T06:32:34.583Z] 06:32:34     INFO - GECKO(2391) | [Child 2536: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f5fd669f000 == 1 [pid = 2536] [id = 28]
[task 2021-04-22T06:32:34.584Z] 06:32:34     INFO - GECKO(2391) | [Child 2536: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f5ff3864ac0) [pid = 2536] [serial = 58] [outer = 0]
[task 2021-04-22T06:32:34.584Z] 06:32:34     INFO - GECKO(2391) | [Child 2536: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f5fd66a0000) [pid = 2536] [serial = 59] [outer = 7f5ff3864ac0]
[task 2021-04-22T06:32:34.585Z] 06:32:34     INFO - checking window state
[task 2021-04-22T06:32:34.587Z] 06:32:34     INFO - TEST-START | devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path_different-timescale.js```

Comment 1

[Intermittent Failures Robot]

1 failures in 3224 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: 1
  • debug: 1

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

Comment 2

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

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Comment 3

[Iulian Moraru]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=343455555&repo=autoland&lineNumber=7048

Comment 4

[Intermittent Failures Robot]

1 failures in 3115 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: 1
  • debug: 1

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

Comment 5

[Intermittent Failures Robot]

1 failures in 2224 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: 1
  • debug: 1

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

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1
• autoland: 1

Platform and build breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1706896&startday=2021-07-19&endday=2021-07-25&tree=all

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1
• mozilla-central: 2
• autoland: 4

Platform and build breakdown:

• linux1804-64-qr: 7
  • debug: 7

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

Comment 8

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

Platform and build breakdown:

• linux1804-64-qr: 3
  • debug: 3

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

Comment 9

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 10
• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-qr: 11
  • debug: 11

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

Comment 10

[Intermittent Failures Robot]

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

This is the #47 most frequent failure this week.

Repository breakdown:

• autoland: 22
• mozilla-central: 6

Platform and build breakdown:

• linux1804-64-qr: 28
  • debug: 28

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

Comment 11

[Iulian Moraru]

Update:
There have been 49 failures within the last 7 days, all on Linux 18.04 x64 WebRender debug.
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=349793119&repo=mozilla-central&lineNumber=6300

[task 2021-08-27T22:28:53.013Z] 22:28:53     INFO - TEST-START | devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path.js
[task 2021-08-27T22:28:53.170Z] 22:28:53     INFO - GECKO(1535) | [Child 1740: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f650b12e800 == 20 [pid = 1740] [id = 53]
[task 2021-08-27T22:28:53.172Z] 22:28:53     INFO - GECKO(1535) | [Child 1740: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 87 (7f65105f4740) [pid = 1740] [serial = 133] [outer = 0]
[task 2021-08-27T22:28:53.173Z] 22:28:53     INFO - GECKO(1535) | [Child 1740: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 88 (7f650b131000) [pid = 1740] [serial = 134] [outer = 7f65105f4740]
[task 2021-08-27T22:28:53.445Z] 22:28:53     INFO - GECKO(1535) | [Child 1740: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 89 (7f650b137c00) [pid = 1740] [serial = 135] [outer = 7f65105f4740]
[task 2021-08-27T22:28:53.562Z] 22:28:53     INFO - GECKO(1535) | [Parent 1535: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f0c67217400 == 5 [pid = 1535] [id = 163] [url = about:devtools-toolbox]
[task 2021-08-27T22:28:53.905Z] 22:28:53     INFO - GECKO(1535) | [Parent 1535: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f0c5f298c00 == 6 [pid = 1535] [id = 166]
[task 2021-08-27T22:28:53.906Z] 22:28:53     INFO - GECKO(1535) | [Parent 1535: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 17 (7f0c69d67040) [pid = 1535] [serial = 388] [outer = 0]
[task 2021-08-27T22:28:53.927Z] 22:28:53     INFO - GECKO(1535) | [Parent 1535: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 18 (7f0c6721cc00) [pid = 1535] [serial = 389] [outer = 7f0c69d67040]
[task 2021-08-27T22:28:54.165Z] 22:28:54     INFO - GECKO(1535) | [Parent 1535: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 19 (7f0c6721c400) [pid = 1535] [serial = 390] [outer = 7f0c69d67040]
[task 2021-08-27T22:28:54.471Z] 22:28:54     INFO - GECKO(1535) | [Parent 1535, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:4002
[task 2021-08-27T22:28:55.268Z] 22:28:55     INFO - GECKO(1535) | [Parent 1535: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f0c63195000 == 7 [pid = 1535] [id = 167]
<...>
[task 2021-08-27T22:30:32.009Z] 22:30:32     INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path.js | forwards path should not be existance - 
[task 2021-08-27T22:30:32.011Z] 22:30:32     INFO - Leaving test bound 
[task 2021-08-27T22:30:32.012Z] 22:30:32     INFO - Buffered messages logged at 22:30:31
[task 2021-08-27T22:30:32.013Z] 22:30:32     INFO - Removing tab.
[task 2021-08-27T22:30:32.014Z] 22:30:32     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2021-08-27T22:30:32.016Z] 22:30:32     INFO - Got event: 'TabClose' on [object XULElement].
[task 2021-08-27T22:30:32.017Z] 22:30:32     INFO - Tab removed and finished closing
[task 2021-08-27T22:30:32.018Z] 22:30:32     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSWindowActor 'DevToolsFrame'"]
[task 2021-08-27T22:30:32.020Z] 22:30:32     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSWindowActor 'DevToolsFrame'"]
[task 2021-08-27T22:30:32.021Z] 22:30:32     INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path.js | The main process DevToolsServer has no pending connection when the test ends - 
[task 2021-08-27T22:30:32.022Z] 22:30:32     INFO - Buffered messages finished
[task 2021-08-27T22:30:32.024Z] 22:30:32     INFO - TEST-UNEXPECTED-FAIL | devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. - 
[task 2021-08-27T22:30:32.025Z] 22:30:32     INFO - GECKO(1535) | MEMORY STAT | vsize 3454MB | residentFast 627MB | heapAllocated 285MB
[task 2021-08-27T22:30:32.027Z] 22:30:32     INFO - TEST-OK | devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path.js | took 98485ms
[task 2021-08-27T22:30:32.028Z] 22:30:32     INFO - GECKO(1535) | [Child 1740: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f650b134400 == 21 [pid = 1740] [id = 54]
[task 2021-08-27T22:30:32.029Z] 22:30:32     INFO - GECKO(1535) | [Child 1740: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 90 (7f65105f4c80) [pid = 1740] [serial = 136] [outer = 0]
[task 2021-08-27T22:30:32.031Z] 22:30:32     INFO - GECKO(1535) | [Child 1740: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 91 (7f650b137000) [pid = 1740] [serial = 137] [outer = 7f65105f4c80]
[task 2021-08-27T22:30:32.032Z] 22:30:32     INFO - checking window state
[task 2021-08-27T22:30:32.033Z] 22:30:32     INFO - TEST-START | devtools/client/inspector/animation/test/browser_animation_summary-graph_computed-timing-path_different-timescale.js

Comment 12

[Iulian Moraru]

Daisuke, as the owner of this component, could you help us assign it to someone?
Thank you.

Comment 13

[Intermittent Failures Robot]

52 failures in 2580 pushes (0.02 failures/push) were associated with this bug in the last 7 days.

This is the #17 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:

• autoland: 39
• try: 7
• mozilla-central: 6

Platform and build breakdown:

• linux1804-64-qr: 52
  • debug: 52

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

Comment 14

[Daisuke Akatsuka (:daisuke)]

Thanks. I will take a look at this.

Comment 15

[Daisuke Akatsuka (:daisuke)]

Attachment: Bug 1706896: Split test for computed timing path on summary graph into 2.

Comment 16

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/6207827ca56a
Split test for computed timing path on summary graph into 2. r=jdescottes

Comment 17

[Noemi Erli[:noemi_erli]]

https://hg.mozilla.org/mozilla-central/rev/6207827ca56a

Comment 18

[Intermittent Failures Robot]

12 failures in 3084 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 10
• mozilla-central: 2

Platform and build breakdown:

• linux1804-64-qr: 12
  • debug: 12

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

Comment 19

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr91: 1

Platform and build breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1706896&startday=2021-12-13&endday=2021-12-19&tree=all

Comment 20

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr91: 1

Platform and build breakdown:

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

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

Comment 21

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr91: 2

Platform and build breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1706896&startday=2022-01-17&endday=2022-01-23&tree=all

Comment 22

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr91: 1

Platform and build breakdown:

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

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

Comment 23

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr91: 1

Platform and build breakdown:

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

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

Comment 24

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr91: 1

Platform and build breakdown:

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

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