1733090 - Intermittent devtools/shared/commands/target/tests/browser_target_command_bfcache.js | leaked 2 window(s) until shutdown [url = about:blank]

Status: RESOLVED INCOMPLETE

(DevTools :: General, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2021-09-29T11:13:17.322Z] 11:13:17     INFO - TEST-OK | devtools/shared/commands/target/tests/browser_watcher_actor_getter_caching.js | took 693ms
[task 2021-09-29T11:13:17.327Z] 11:13:17     INFO - GECKO(832) | [Child 6644: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 21439efbc00 == 2 [pid = 6644] [id = 1]
[task 2021-09-29T11:13:17.327Z] 11:13:17     INFO - GECKO(832) | [Child 6644: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (214406ce200) [pid = 6644] [serial = 3] [outer = 0]
[task 2021-09-29T11:13:17.328Z] 11:13:17     INFO - GECKO(832) | [Child 6644: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (214406c3400) [pid = 6644] [serial = 4] [outer = 214406ce200]
[task 2021-09-29T11:13:17.341Z] 11:13:17     INFO - checking window state
<...>
[task 2021-09-29T11:13:23.268Z] 11:13:23     INFO - TEST-START | Shutdown
[task 2021-09-29T11:13:23.269Z] 11:13:23     INFO - Browser Chrome Test Summary
[task 2021-09-29T11:13:23.269Z] 11:13:23     INFO - Passed:  588
[task 2021-09-29T11:13:23.270Z] 11:13:23     INFO - Failed:  0
[task 2021-09-29T11:13:23.270Z] 11:13:23     INFO - Todo:    0
[task 2021-09-29T11:13:23.271Z] 11:13:23     INFO - Mode:    e10s
[task 2021-09-29T11:13:23.272Z] 11:13:23     INFO - *** End BrowserChrome Test Results ***
[task 2021-09-29T11:13:23.301Z] 11:13:23     INFO - GECKO(832) | [Child 8824, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2021-09-29T11:13:23.312Z] 11:13:23     INFO - GECKO(832) | [Child 8824, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2021-09-29T11:13:23.317Z] 11:13:23     INFO - GECKO(832) | [Child 8824, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2021-09-29T11:13:23.324Z] 11:13:23     INFO - GECKO(832) | [Child 8824, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2021-09-29T11:13:23.332Z] 11:13:23     INFO - GECKO(832) | [Child 8824, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2021-09-29T11:13:23.333Z] 11:13:23     INFO - GECKO(832) | [Child 8824, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2021-09-29T11:13:23.361Z] 11:13:23     INFO - GECKO(832) | [Parent 908, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:931
[task 2021-09-29T11:13:23.363Z] 11:13:23     INFO - GECKO(832) | [Parent 908, Main Thread] WARNING: IPDL resolver dropped without being called!: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:959
[task 2021-09-29T11:13:23.364Z] 11:13:23     INFO - GECKO(832) | [Parent 908, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:931
[task 2021-09-29T11:13:23.365Z] 11:13:23     INFO - GECKO(832) | [Parent 908: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 2b77842cc00 == 4 [pid = 908] [id = 2] [url = chrome://extensions/content/dummy.xhtml]
[task 2021-09-29T11:13:23.366Z] 11:13:23     INFO - GECKO(832) | [Parent 908, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:931
[task 2021-09-29T11:13:23.366Z] 11:13:23     INFO - GECKO(832) | [Parent 908, Main Thread] WARNING: IPDL resolver dropped without being called!: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:959
[task 2021-09-29T11:13:23.367Z] 11:13:23     INFO - GECKO(832) | [Parent 908, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:931
[task 2021-09-29T11:13:23.368Z] 11:13:23     INFO - GECKO(832) | [Parent 908, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:931
[task 2021-09-29T11:13:23.368Z] 11:13:23     INFO - GECKO(832) | [Parent 908, Main Thread] WARNING: IPDL resolver dropped without being called!: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:959
[task 2021-09-29T11:13:23.369Z] 11:13:23     INFO - GECKO(832) | [Parent 908, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:931
[task 2021-09-29T11:13:23.416Z] 11:13:23     INFO - GECKO(832) | 1632914003428	Marionette	TRACE	Received observer notification quit-application
[task 2021-09-29T11:13:23.429Z] 11:13:23     INFO - GECKO(832) | 1632914003428	Marionette	INFO	Stopped listening on port 2828
[task 2021-09-29T11:13:23.429Z] 11:13:23     INFO - GECKO(832) | 1632914003429	Marionette	DEBUG	Marionette stopped listening
<...>
[task 2021-09-29T11:13:25.368Z] 11:13:25     INFO - TEST-INFO | Main app process: exit 0
[task 2021-09-29T11:13:25.369Z] 11:13:25     INFO - TEST-INFO | Confirming we saw 121 DOCSHELL created and 121 destroyed log strings.
[task 2021-09-29T11:13:25.370Z] 11:13:25     INFO - TEST-INFO | Confirming we saw 344 DOMWINDOW created and 344 destroyed log strings.
[task 2021-09-29T11:13:25.370Z] 11:13:25    ERROR - TEST-UNEXPECTED-FAIL | devtools/shared/commands/target/tests/browser_target_command_bfcache.js | leaked 2 window(s) until shutdown [url = about:blank]
[task 2021-09-29T11:13:25.371Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_bfcache.js | windows(s) leaked: [pid = 6644] [serial = 3], [pid = 6644] [serial = 4]
[task 2021-09-29T11:13:25.371Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_bfcache.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.372Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_bfcache.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.372Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_browser_workers.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.373Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_browser_workers.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.373Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_frames.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.374Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_frames.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.375Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_frames_reload_server_side_targets.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.375Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_frames_reload_server_side_targets.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.376Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_getAllTargets.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.376Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_getAllTargets.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.377Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_invalid_api_usage.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.377Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_invalid_api_usage.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.378Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_reload.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.378Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_reload.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.379Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_service_workers.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.379Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_service_workers.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.380Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_service_workers_navigation.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.380Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_service_workers_navigation.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.381Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_switchToTarget.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.381Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_switchToTarget.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.382Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_tab_workers.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.382Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_tab_workers.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.383Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_various_descriptors.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.383Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_various_descriptors.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.384Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_watchTargets.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.384Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_target_command_watchTargets.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.384Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_watcher_actor_getter_caching.js | This test created 1 hidden window(s)
[task 2021-09-29T11:13:25.385Z] 11:13:25     INFO - TEST-INFO | devtools/shared/commands/target/tests/browser_watcher_actor_getter_caching.js | This test created 1 hidden docshell(s)
[task 2021-09-29T11:13:25.385Z] 11:13:25     INFO - runtests.py | Application ran for: 0:01:07.638175
[task 2021-09-29T11:13:25.386Z] 11:13:25     INFO - zombiecheck | Reading PID log: C:\Users\task_163291090278088\AppData\Local\Temp\tmpe8wpir0upidlog
<...>
task 2021-09-29T11:13:25.537Z] 11:13:25     INFO - TEST-INFO | leakcheck | default process: leak threshold set at 0 bytes
[task 2021-09-29T11:13:25.537Z] 11:13:25     INFO - TEST-INFO | leakcheck | forkserver process: leak threshold set at 0 bytes
[task 2021-09-29T11:13:25.538Z] 11:13:25     INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2021-09-29T11:13:25.539Z] 11:13:25     INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 0 bytes
[task 2021-09-29T11:13:25.539Z] 11:13:25     INFO - TEST-INFO | leakcheck | plugin process: leak threshold set at 0 bytes
[task 2021-09-29T11:13:25.540Z] 11:13:25     INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 0 bytes
[task 2021-09-29T11:13:25.540Z] 11:13:25     INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2021-09-29T11:13:25.541Z] 11:13:25     INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 1000 bytes
[task 2021-09-29T11:13:25.541Z] 11:13:25     INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2021-09-29T11:13:25.542Z] 11:13:25     INFO - leakcheck | Processing leak log file C:\Users\task_163291090278088\AppData\Local\Temp\tmpmj71yb19.mozrunner\runtests_leaks.log
[task 2021-09-29T11:13:25.542Z] 11:13:25     INFO - 
[task 2021-09-29T11:13:25.542Z] 11:13:25     INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, default process 908
[task 2021-09-29T11:13:25.543Z] 11:13:25     INFO - 
[task 2021-09-29T11:13:25.543Z] 11:13:25     INFO -      |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2021-09-29T11:13:25.544Z] 11:13:25     INFO -      |                                      | Per-Inst   Leaked|   Total      Rem|
[task 2021-09-29T11:13:25.544Z] 11:13:25     INFO -    0 |TOTAL                                 |       60        0| 7734928        0|
[task 2021-09-29T11:13:25.545Z] 11:13:25     INFO - 
[task 2021-09-29T11:13:25.545Z] 11:13:25     INFO - nsTraceRefcnt::DumpStatistics: 2259 entries
[task 2021-09-29T11:13:25.545Z] 11:13:25     INFO - TEST-PASS | leakcheck | default no leaks detected!

Comment 1

[Intermittent Failures Robot]

2 failures in 3376 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:

• windows10-64-2004-qr: 2
  • debug: 2

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

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-2004-qr: 1
  • debug: 1

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

Comment 3

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

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

Comment 4

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=366652757&repo=autoland

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-2004-qr: 1
  • debug: 1

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

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-2004-qr: 1
  • debug: 1

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

Comment 7

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

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

Comment 8

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=374629321&repo=autoland

Comment 9

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-2004-qr: 1
  • debug: 1

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

Comment 10

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

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

Comment 11

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=381915752&repo=mozilla-esr102

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr102: 1

Platform and build breakdown:

• windows10-64-2004-qr: 1
  • debug: 1

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

Comment 13

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

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