1952608 - Intermittent TV devtools/shared/commands/target/tests/browser_target_command_service_workers_navigation_stopped.js | Test timed out -

Status: NEW

(DevTools :: General, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: csabou [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=497722033&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Z7ASP1lzQF-rtUwOPC_Q3w/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Z7ASP1lzQF-rtUwOPC_Q3w/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

---

[task 2025-03-05T20:21:46.075Z] 20:21:46     INFO - TEST-START | devtools/shared/commands/target/tests/browser_target_command_service_workers_navigation_stopped.js
[task 2025-03-05T20:22:31.247Z] 20:22:31     INFO - TEST-INFO | started process screenshot
[task 2025-03-05T20:22:31.689Z] 20:22:31     INFO - TEST-INFO | screenshot: exit 0
[task 2025-03-05T20:22:31.689Z] 20:22:31     INFO - Buffered messages logged at 20:21:46
[task 2025-03-05T20:22:31.690Z] 20:22:31     INFO - Entering test bound test_NavigationToPageWithExistingStoppedWorker
[task 2025-03-05T20:22:31.691Z] 20:22:31     INFO - Adding a new tab with URL: https://example.com/browser/devtools/shared/commands/target/tests/test_sw_page.html
[task 2025-03-05T20:22:31.691Z] 20:22:31     INFO - Tab added and finished loading
[task 2025-03-05T20:22:31.692Z] 20:22:31     INFO - Wait until the service worker registration is registered
[task 2025-03-05T20:22:31.693Z] 20:22:31     INFO - Stop Service Worker: https://example.com/browser/devtools/shared/commands/target/tests/test_sw_page_worker.js
[task 2025-03-05T20:22:31.693Z] 20:22:31     INFO - 
[task 2025-03-05T20:22:31.694Z] 20:22:31     INFO - TEST-PASS | devtools/shared/commands/target/tests/browser_target_command_service_workers_navigation_stopped.js | Found the service worker info - 
[task 2025-03-05T20:22:31.694Z] 20:22:31     INFO - Wait for the worker to be active
[task 2025-03-05T20:22:31.695Z] 20:22:31     INFO - Waiting 0 seconds.
[task 2025-03-05T20:22:31.695Z] 20:22:31     INFO - Create a target list for a tab target
[task 2025-03-05T20:22:31.695Z] 20:22:31     INFO - Buffered messages logged at 20:21:47
[task 2025-03-05T20:22:31.696Z] 20:22:31     INFO -  + Service worker target available for https://example.com/browser/devtools/shared/commands/target/tests/test_sw_page_worker.js
[task 2025-03-05T20:22:31.696Z] 20:22:31     INFO - 
[task 2025-03-05T20:22:31.697Z] 20:22:31     INFO - Waiting 1 seconds.
[task 2025-03-05T20:22:31.697Z] 20:22:31     INFO - Buffered messages logged at 20:21:48
[task 2025-03-05T20:22:31.698Z] 20:22:31     INFO - Verify that no SW is reported after it has been stopped and we start watching for service workers
[task 2025-03-05T20:22:31.698Z] 20:22:31     INFO - Buffered messages finished
[task 2025-03-05T20:22:31.699Z] 20:22:31     INFO - TEST-UNEXPECTED-FAIL | devtools/shared/commands/target/tests/browser_target_command_service_workers_navigation_stopped.js | Test timed out - 
[task 2025-03-05T20:22:31.700Z] 20:22:31     INFO - GECKO(4284) | Completed ShutdownLeaks collections in process 5820
[task 2025-03-05T20:22:31.700Z] 20:22:31     INFO - TEST-START | Shutdown
[task 2025-03-05T20:22:31.701Z] 20:22:31     INFO - Browser Chrome Test Summary
[task 2025-03-05T20:22:31.701Z] 20:22:31     INFO - Passed:  1
[task 2025-03-05T20:22:31.702Z] 20:22:31     INFO - Failed:  1
[task 2025-03-05T20:22:31.702Z] 20:22:31     INFO - Todo:    0
[task 2025-03-05T20:22:31.703Z] 20:22:31     INFO - Mode:    e10s
[task 2025-03-05T20:22:31.703Z] 20:22:31     INFO - *** End BrowserChrome Test Results ***
[task 2025-03-05T20:22:31.704Z] 20:22:31     INFO - GECKO(4284) | Exiting due to channel error.
[task 2025-03-05T20:22:31.704Z] 20:22:31     INFO - GECKO(4284) | Exiting due to channel error.
[task 2025-03-05T20:22:31.704Z] 20:22:31     INFO - TEST-INFO | Main app process: exit 0
[task 2025-03-05T20:22:31.705Z] 20:22:31     INFO - TEST-UNEXPECTED-FAIL | devtools/shared/commands/target/tests/browser_target_command_service_workers_navigation_stopped.js | Application shut down (without crashing) in the middle of a test!
[task 2025-03-05T20:22:31.705Z] 20:22:31     INFO - TEST-INFO took 44928ms
[task 2025-03-05T20:22:31.705Z] 20:22:31     INFO - runtests.py | Application ran for: 0:00:49.88319
[task 2025-03-05T20:22:31.706Z] 20:22:31     INFO - zombiecheck | Reading PID log: C:\Users\task_174120459002540\AppData\Local\Temp\tmpntb5f9kapidlog
[task 2025-03-05T20:22:31.707Z] 20:22:31     INFO - ==> process 5820 launched child process 7408 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250305194200 -prefsHandle 2244:26994 -prefMapHandle 2248:286556 -ipcHandle 2308 -initialChannelId {bac3e093-83dd-4a14-b516-3de2577e1ae5} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -appDir "D:\task_174120459002540\build\application\firefox\browser" - 1 gpu)
[task 2025-03-05T20:22:31.707Z] 20:22:31     INFO - ==> process 5820 launched child process 4792 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 2904:26626 -prefMapHandle 2900:286556 -jsInitHandle 2912:256972 -parentBuildID 20250305194200 -ipcHandle 2920 -initialChannelId {9e701a18-704d-4933-84f1-5eb7d22cd388} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -win32kLockedDown -appDir "D:\task_174120459002540\build\application\firefox\browser" - 2 tab)
[task 2025-03-05T20:22:31.709Z] 20:22:31     INFO - ==> process 5820 launched child process 8464 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250305194200 -prefsHandle 3152:28210 -prefMapHandle 3156:286556 -ipcHandle 3172 -initialChannelId {0bee7502-bfbb-4d98-b65f-f34010e028c6} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -appDir "D:\task_174120459002540\build\application\firefox\browser" - 3 rdd)
[task 2025-03-05T20:22:31.710Z] 20:22:31     INFO - ==> process 5820 launched child process 8296 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 3532:28272 -prefMapHandle 3536:286556 -jsInitHandle 3540:256972 -parentBuildID 20250305194200 -ipcHandle 3248 -initialChannelId {f405179a-6293-49e2-b637-c95a59527282} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -win32kLockedDown -appDir "D:\task_174120459002540\build\application\firefox\browser" - 4 tab)
[task 2025-03-05T20:22:31.711Z] 20:22:31     INFO - ==> process 5820 launched child process 4440 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 3812:27145 -prefMapHandle 3816:286556 -jsInitHandle 3820:256972 -parentBuildID 20250305194200 -ipcHandle 3532 -initialChannelId {b91c9735-e509-4bbb-9e0a-d22fe5ec90b7} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -win32kLockedDown -appDir "D:\task_174120459002540\build\application\firefox\browser" - 5 tab)
[task 2025-03-05T20:22:31.712Z] 20:22:31     INFO - ==> process 5820 launched child process 2528 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250305194200 -sandboxingKind 0 -prefsHandle 4408:39123 -prefMapHandle 4404:286556 -ipcHandle 2676 -initialChannelId {3180a9da-6c83-4cfd-90d8-cd95d8e56a8d} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -win32kLockedDown -appDir "D:\task_174120459002540\build\application\firefox\browser" - 6 utility)
[task 2025-03-05T20:22:31.712Z] 20:22:31     INFO - ==> process 5820 launched child process 7320 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4560:36592 -prefMapHandle 4460:286556 -jsInitHandle 4564:256972 -parentBuildID 20250305194200 -ipcHandle 4580 -initialChannelId {8ad16278-47cc-49b2-bfbc-1ae797947b2e} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -win32kLockedDown -appDir "D:\task_174120459002540\build\application\firefox\browser" - 7 tab)
[task 2025-03-05T20:22:31.713Z] 20:22:31     INFO - ==> process 5820 launched child process 8888 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4612:36592 -prefMapHandle 4632:286556 -jsInitHandle 4640:256972 -parentBuildID 20250305194200 -ipcHandle 4648 -initialChannelId {b1fd97b5-6313-4c31-a578-5cb7d94b11f5} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -win32kLockedDown -appDir "D:\task_174120459002540\build\application\firefox\browser" - 8 tab)
[task 2025-03-05T20:22:31.714Z] 20:22:31     INFO - ==> process 5820 launched child process 2092 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5036:36592 -prefMapHandle 5040:286556 -jsInitHandle 5032:256972 -parentBuildID 20250305194200 -ipcHandle 4460 -initialChannelId {180ac390-3b4d-4ed9-b82c-7d61943f6090} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -win32kLockedDown -appDir "D:\task_174120459002540\build\application\firefox\browser" - 9 tab)
[task 2025-03-05T20:22:31.715Z] 20:22:31     INFO - ==> process 5820 launched child process 2660 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5204:39123 -prefMapHandle 5208:286556 -jsInitHandle 5212:256972 -parentBuildID 20250305194200 -ipcHandle 5272 -initialChannelId {571416ab-9bc7-4d36-b130-6a0a6f8d3dac} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -win32kLockedDown -appDir "D:\task_174120459002540\build\application\firefox\browser" - 10 tab)
[task 2025-03-05T20:22:31.717Z] 20:22:31     INFO - ==> process 5820 launched child process 4776 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5648:36837 -prefMapHandle 5644:286556 -jsInitHandle 5652:256972 -parentBuildID 20250305194200 -ipcHandle 5660 -initialChannelId {ac0f887c-e62b-4e56-8cb3-a53947feec76} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -win32kLockedDown -appDir "D:\task_174120459002540\build\application\firefox\browser" - 11 tab)
[task 2025-03-05T20:22:31.718Z] 20:22:31     INFO - ==> process 5820 launched child process 5964 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4876:36837 -prefMapHandle 4884:286556 -jsInitHandle 5112:256972 -parentBuildID 20250305194200 -ipcHandle 4832 -initialChannelId {ae14ebcf-3032-40ee-b3c9-67a64dbf68ae} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -win32kLockedDown -appDir "D:\task_174120459002540\build\application\firefox\browser" - 12 tab)
[task 2025-03-05T20:22:31.719Z] 20:22:31     INFO - ==> process 5820 launched child process 6096 ("D:\task_174120459002540\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5648:36883 -prefMapHandle 4900:286556 -jsInitHandle 4584:256972 -parentBuildID 20250305194200 -ipcHandle 5092 -initialChannelId {e05c1b07-2ac9-44ae-9e2b-94410b652458} -parentPid 5820 -crashReporter "\\.\pipe\gecko-crash-server-pipe.5820" -win32kLockedDown -appDir "D:\task_174120459002540\build\application\firefox\browser" - 13 tab)
[task 2025-03-05T20:22:31.719Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 2528
[task 2025-03-05T20:22:31.720Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 2660
[task 2025-03-05T20:22:31.720Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 8296
[task 2025-03-05T20:22:31.721Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 4776
[task 2025-03-05T20:22:31.721Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 2092
[task 2025-03-05T20:22:31.722Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 5964
[task 2025-03-05T20:22:31.722Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 4792
[task 2025-03-05T20:22:31.723Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 8888
[task 2025-03-05T20:22:31.723Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 7408
[task 2025-03-05T20:22:31.724Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 8464
[task 2025-03-05T20:22:31.724Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 6096
[task 2025-03-05T20:22:31.725Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 4440
[task 2025-03-05T20:22:31.725Z] 20:22:31     INFO - zombiecheck | Checking for orphan process with PID: 7320
[task 2025-03-05T20:22:31.726Z] 20:22:31     INFO - Stopping web server
[task 2025-03-05T20:22:31.726Z] 20:22:31     INFO - Server shut down.
[task 2025-03-05T20:22:31.728Z] 20:22:31     INFO - Web server killed.
[task 2025-03-05T20:22:31.728Z] 20:22:31     INFO - Stopping web socket server
[task 2025-03-05T20:22:31.729Z] 20:22:31     INFO - Stopping ssltunnel
[task 2025-03-05T20:22:31.729Z] 20:22:31  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2025-03-05T20:22:31.729Z] 20:22:31     INFO - runtests.py | Running tests: end.
[task 2025-03-05T20:22:31.788Z] 20:22:31     INFO - Buffered messages finished
[task 2025-03-05T20:22:31.791Z] 20:22:31     INFO -  TEST-INFO | checking window state
[task 2025-03-05T20:22:31.791Z] 20:22:31     INFO -  Browser Chrome Test Summary
[task 2025-03-05T20:22:31.791Z] 20:22:31     INFO -  	Passed: 1
[task 2025-03-05T20:22:31.791Z] 20:22:31     INFO -  	Failed: 1
[task 2025-03-05T20:22:31.791Z] 20:22:31     INFO -  	Todo: 0
[task 2025-03-05T20:22:31.791Z] 20:22:31     INFO -  	Mode: e10s
[task 2025-03-05T20:22:31.792Z] 20:22:31     INFO -  *** End BrowserChrome Test Results ***

Comment 1

[Intermittent Failures Robot]

Summary

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows11-32-24h2: 1
  • opt: 1

Table

	no_variant
windows11-32-24h2--/opt	1

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1952608&startday=2025-03-03&endday=2025-03-09&tree=all

Comment 2

[Intermittent Failures Robot]

Summary

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows11-32-24h2: 1
  • opt: 1

Table

	no_variant
windows11-32-24h2--/opt	1

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1952608&startday=2025-03-10&endday=2025-03-16&tree=all