Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=460246662&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/MD_0E-zWTaS5ZTvjP6W7xA/runs/0/artifacts/public/logs/live_backing.log
[task 2024-05-30T01:01:57.929Z] 01:01:57 INFO - TEST-PASS | accessible/tests/browser/fission/browser_take_focus.js | Received focus event -
[task 2024-05-30T01:01:57.929Z] 01:01:57 INFO - Focusing outerButton
[task 2024-05-30T01:01:57.929Z] 01:01:57 INFO - Buffered messages finished
[task 2024-05-30T01:01:57.930Z] 01:01:57 INFO - TEST-UNEXPECTED-FAIL | accessible/tests/browser/fission/browser_take_focus.js | Test timed out -
[task 2024-05-30T01:01:57.930Z] 01:01:57 INFO - GECKO(7908) | Completed ShutdownLeaks collections in process 9804
[task 2024-05-30T01:01:57.931Z] 01:01:57 INFO - TEST-START | Shutdown
[task 2024-05-30T01:01:57.931Z] 01:01:57 INFO - Browser Chrome Test Summary
[task 2024-05-30T01:01:57.932Z] 01:01:57 INFO - Passed: 609
[task 2024-05-30T01:01:57.932Z] 01:01:57 INFO - Failed: 1
[task 2024-05-30T01:01:57.932Z] 01:01:57 INFO - Todo: 0
[task 2024-05-30T01:01:57.933Z] 01:01:57 INFO - Mode: e10s
[task 2024-05-30T01:01:57.934Z] 01:01:57 INFO - *** End BrowserChrome Test Results ***
[task 2024-05-30T01:01:58.251Z] 01:01:58 INFO - GECKO(7908) | 1717030918250 Marionette TRACE Received observer notification quit-application
[task 2024-05-30T01:01:58.252Z] 01:01:58 INFO - GECKO(7908) | 1717030918250 Marionette INFO Stopped listening on port 2828
[task 2024-05-30T01:01:58.255Z] 01:01:58 INFO - GECKO(7908) | 1717030918254 Marionette DEBUG Marionette stopped listening
[task 2024-05-30T01:02:00.105Z] 01:02:00 INFO - GECKO(7908) | [Parent 9804, IPC I/O Parent] WARNING: Process 10136 may be hanging at shutdown; will wait for up to 80000ms: file D:/task_171702496857505/build/src/ipc/chromium/src/chrome/common/process_watcher_win.cc:129
[task 2024-05-30T01:02:00.434Z] 01:02:00 INFO - GECKO(7908) | [Parent 9804, IPC I/O Parent] WARNING: Process 9816 may be hanging at shutdown; will wait for up to 79672ms: file D:/task_171702496857505/build/src/ipc/chromium/src/chrome/common/process_watcher_win.cc:129
[task 2024-05-30T01:02:01.997Z] 01:02:01 INFO - GECKO(7908) | [Parent 9804, IPC I/O Parent] WARNING: Process 2324 may be hanging at shutdown; will wait for up to 78110ms: file D:/task_171702496857505/build/src/ipc/chromium/src/chrome/common/process_watcher_win.cc:129
[task 2024-05-30T01:02:03.217Z] 01:02:03 INFO - TEST-INFO | Main app process: exit 0
[task 2024-05-30T01:02:03.218Z] 01:02:03 INFO - runtests.py | Application ran for: 0:01:09.820172
[task 2024-05-30T01:02:03.219Z] 01:02:03 INFO - zombiecheck | Reading PID log: C:\Users\task_171702996880426\AppData\Local\Temp\tmprypfoqfhpidlog
[task 2024-05-30T01:02:03.220Z] 01:02:03 INFO - ==> process 9804 launched child process 2320 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=2264 -parentBuildID 20240529214854 -prefsHandle 2192 -prefMapHandle 2172 -prefsLen 23406 -prefMapSize 263072 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {6d90437c-ea52-450c-9c8f-0821518fc68b} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" gpu)
[task 2024-05-30T01:02:03.221Z] 01:02:03 INFO - ==> process 9804 launched child process 7928 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=2820 -childID 1 -isForBrowser -prefsHandle 2592 -prefMapHandle 2796 -prefsLen 23164 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {fddcb664-5024-4598-9129-d7ec0e133500} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.222Z] 01:02:03 INFO - ==> process 9804 launched child process 10136 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=3148 -childID 2 -isForBrowser -prefsHandle 3140 -prefMapHandle 3136 -prefsLen 24728 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {e7c5b04e-2cc3-448e-b7a5-6aef541b7962} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.224Z] 01:02:03 INFO - ==> process 9804 launched child process 5664 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=3308 -childID 3 -isForBrowser -prefsHandle 3372 -prefMapHandle 3368 -prefsLen 24567 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {d51943c9-a3d3-494f-b0d1-4e5359ffc465} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.225Z] 01:02:03 INFO - ==> process 9804 launched child process 8060 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=3228 -parentBuildID 20240529214854 -sandboxingKind 0 -prefsHandle 2492 -prefMapHandle 3736 -prefsLen 32813 -prefMapSize 263072 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {cb8dadff-8b38-4d38-974e-a3ef06e5ee5a} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" utility)
[task 2024-05-30T01:02:03.226Z] 01:02:03 INFO - ==> process 9804 launched child process 9240 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=4088 -childID 4 -isForBrowser -prefsHandle 4080 -prefMapHandle 4072 -prefsLen 30438 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {04c4524b-e5c3-4b03-a7f6-ff83dd88ba79} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.227Z] 01:02:03 INFO - ==> process 9804 launched child process 9816 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=4216 -childID 5 -isForBrowser -prefsHandle 4136 -prefMapHandle 4140 -prefsLen 30438 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {f81ec030-951f-4853-841c-755b51752c2f} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.228Z] 01:02:03 INFO - ==> process 9804 launched child process 3560 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=4396 -childID 6 -isForBrowser -prefsHandle 4388 -prefMapHandle 4384 -prefsLen 30438 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {10a040a2-c119-407f-adc9-442b229306d9} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.228Z] 01:02:03 INFO - ==> process 9804 launched child process 2324 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=4316 -childID 7 -isForBrowser -prefsHandle 4444 -prefMapHandle 4448 -prefsLen 32813 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {41b60c39-84e3-42ff-9baf-0b680819a429} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.229Z] 01:02:03 INFO - ==> process 9804 launched child process 1224 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=4880 -childID 8 -isForBrowser -prefsHandle 4872 -prefMapHandle 4868 -prefsLen 30524 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {64a287eb-0d38-474f-b91c-ad983f649082} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.230Z] 01:02:03 INFO - ==> process 9804 launched child process 9460 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=5024 -childID 9 -isForBrowser -prefsHandle 5040 -prefMapHandle 5036 -prefsLen 30524 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {68fe96bf-3eb6-4449-a33e-995b0ad41fa8} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.232Z] 01:02:03 INFO - ==> process 9804 launched child process 8976 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=5020 -childID 10 -isForBrowser -prefsHandle 4880 -prefMapHandle 4720 -prefsLen 30524 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {f62f71c5-eb91-44d4-a928-8c4a9786f3d2} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.233Z] 01:02:03 INFO - ==> process 9804 launched child process 6668 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=5056 -childID 11 -isForBrowser -prefsHandle 4284 -prefMapHandle 4280 -prefsLen 30559 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {c307aa2b-cc44-42ca-a760-497254a7db8f} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.234Z] 01:02:03 INFO - ==> process 9804 launched child process 2080 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=4944 -childID 12 -isForBrowser -prefsHandle 4900 -prefMapHandle 4904 -prefsLen 30559 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {f808e47f-fc3a-424f-97bc-30e12976cf16} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.235Z] 01:02:03 INFO - ==> process 9804 launched child process 2868 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=5064 -childID 13 -isForBrowser -prefsHandle 4824 -prefMapHandle 4888 -prefsLen 30559 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {11e5eedf-3237-4b1e-8e52-91e3f09a62a6} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.236Z] 01:02:03 INFO - ==> process 9804 launched child process 9760 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=5324 -childID 14 -isForBrowser -prefsHandle 5380 -prefMapHandle 5376 -prefsLen 30559 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {00fa1763-f8a6-40dd-8e8f-6e4f87eadcfc} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.237Z] 01:02:03 INFO - ==> process 9804 launched child process 1376 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=4916 -childID 15 -isForBrowser -prefsHandle 5024 -prefMapHandle 5468 -prefsLen 30559 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {06394205-1e73-4b09-8dce-e8b9dc02e492} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.239Z] 01:02:03 INFO - ==> process 9804 launched child process 6416 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=5592 -childID 16 -isForBrowser -prefsHandle 5096 -prefMapHandle 5092 -prefsLen 30559 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {bde28eab-00b0-4073-ae32-f035da71e3a2} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.240Z] 01:02:03 INFO - ==> process 9804 launched child process 2860 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=5292 -childID 17 -isForBrowser -prefsHandle 4952 -prefMapHandle 5364 -prefsLen 30559 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {0998d116-e6dd-41a4-bd7c-49f82a77228e} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.240Z] 01:02:03 INFO - ==> process 9804 launched child process 7424 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=5352 -childID 18 -isForBrowser -prefsHandle 5776 -prefMapHandle 4092 -prefsLen 30559 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {1d3e3ece-790f-4f36-aa36-6bf682fb8fa1} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.241Z] 01:02:03 INFO - ==> process 9804 launched child process 4244 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=4108 -childID 19 -isForBrowser -prefsHandle 5904 -prefMapHandle 4964 -prefsLen 30638 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {5dd47312-5472-432d-b16e-eb405b9bce9b} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.243Z] 01:02:03 INFO - ==> process 9804 launched child process 7952 ("D:\task_171702996880426\build\application\firefox\firefox.exe" -contentproc --channel=5600 -childID 20 -isForBrowser -prefsHandle 4828 -prefMapHandle 3772 -prefsLen 30684 -prefMapSize 263072 -jsInitHandle 1464 -jsInitLen 234488 -parentBuildID 20240529214854 -appDir "D:\task_171702996880426\build\application\firefox\browser" - {b208d4c6-07f8-49db-9fad-a5b5a296171f} 9804 "\\.\pipe\gecko-crash-server-pipe.9804" tab)
[task 2024-05-30T01:02:03.243Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 7424
[task 2024-05-30T01:02:03.243Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 6668
[task 2024-05-30T01:02:03.244Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 2320
[task 2024-05-30T01:02:03.244Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 8976
[task 2024-05-30T01:02:03.245Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 6416
[task 2024-05-30T01:02:03.245Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 7952
[task 2024-05-30T01:02:03.246Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 2324
[task 2024-05-30T01:02:03.246Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 4244
[task 2024-05-30T01:02:03.247Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 10136
[task 2024-05-30T01:02:03.247Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 9240
[task 2024-05-30T01:02:03.247Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 5664
[task 2024-05-30T01:02:03.248Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 2080
[task 2024-05-30T01:02:03.249Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 9760
[task 2024-05-30T01:02:03.249Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 2860
[task 2024-05-30T01:02:03.250Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 2868
[task 2024-05-30T01:02:03.250Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 1224
[task 2024-05-30T01:02:03.250Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 9816
[task 2024-05-30T01:02:03.251Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 1376
[task 2024-05-30T01:02:03.251Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 3560
[task 2024-05-30T01:02:03.251Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 9460
[task 2024-05-30T01:02:03.252Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 7928
[task 2024-05-30T01:02:03.252Z] 01:02:03 INFO - zombiecheck | Checking for orphan process with PID: 8060
[task 2024-05-30T01:02:03.252Z] 01:02:03 INFO - Stopping web server
[task 2024-05-30T01:02:03.252Z] 01:02:03 INFO - Server shut down.
[task 2024-05-30T01:02:03.254Z] 01:02:03 INFO - Web server killed.
[task 2024-05-30T01:02:03.255Z] 01:02:03 INFO - Stopping web socket server
[task 2024-05-30T01:02:03.255Z] 01:02:03 INFO - Stopping ssltunnel
[task 2024-05-30T01:02:03.256Z] 01:02:03 WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2024-05-30T01:02:03.256Z] 01:02:03 INFO - runtests.py | Running tests: end.
[task 2024-05-30T01:02:03.312Z] 01:02:03 INFO - Buffered messages finished
[task 2024-05-30T01:02:03.324Z] 01:02:03 INFO - Running manifest: accessible/tests/browser/general/browser.toml
[task 2024-05-30T01:02:03.324Z] 01:02:03 INFO - The following extra prefs will be set:
[task 2024-05-30T01:02:03.324Z] 01:02:03 INFO - javascript.options.asyncstack_capture_debuggee_only=false
[task 2024-05-30T01:02:03.984Z] 01:02:03 INFO - PID 5512 | D:\task_171702996880426\build\tests\bin\pk12util.exe: PKCS12 IMPORT SUCCESSFUL
[task 2024-05-30T01:02:03.984Z] 01:02:03 INFO -
[task 2024-05-30T01:02:04.156Z] 01:02:04 INFO - MochitestServer : launching ['D:\\task_171702996880426\\build\\tests\\bin\\xpcshell.exe', '-g', 'D:\\task_171702996880426\\build\\application\\firefox', '-e', "const _PROFILE_PATH = 'C:\\\\Users\\\\task_171702996880426\\\\AppData\\\\Local\\\\Temp\\\\tmpw70j3sxx.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false; const _HTTPD_PATH = 'D:\\\\task_171702996880426\\\\build\\\\tests\\\\bin\\\\components';", '-f', 'D:\\task_171702996880426\\build\\tests\\mochitest\\server.js']
[task 2024-05-30T01:02:04.162Z] 01:02:04 INFO - runtests.py | Server pid: 4272
[task 2024-05-30T01:02:04.170Z] 01:02:04 INFO - runtests.py | Websocket server pid: 3264
[task 2024-05-30T01:02:04.179Z] 01:02:04 INFO - runtests.py | SSL tunnel pid: 2756
[task 2024-05-30T01:02:04.380Z] 01:02:04 INFO - use http3 server: 0
[task 2024-05-30T01:02:04.384Z] 01:02:04 INFO - runtests.py | Running with scheme: http
[task 2024-05-30T01:02:04.384Z] 01:02:04 INFO - runtests.py | Running with e10s: True
[task 2024-05-30T01:02:04.385Z] 01:02:04 INFO - runtests.py | Running with fission: True
[task 2024-05-30T01:02:04.386Z] 01:02:04 INFO - runtests.py | Running with cross-origin iframes: False
[task 2024-05-30T01:02:04.386Z] 01:02:04 INFO - runtests.py | Running with serviceworker_e10s: True
[task 2024-05-30T01:02:04.387Z] 01:02:04 INFO - runtests.py | Running with socketprocess_e10s: False
[task 2024-05-30T01:02:04.387Z] 01:02:04 INFO - runtests.py | Running tests: start.
[task 2024-05-30T01:02:04.387Z] 01:02:04 INFO -
[task 2024-05-30T01:02:04.502Z] 01:02:04 INFO - Application command: D:\task_171702996880426\build\application\firefox\firefox.exe -marionette --wait-for-browser -foreground -profile C:\Users\task_171702996880426\AppData\Local\Temp\tmpw70j3sxx.mozrunner
[task 2024-05-30T01:02:04.521Z] 01:02:04 INFO - runtests.py | Application pid: 10032
[task 2024-05-30T01:02:04.522Z] 01:02:04 INFO - TEST-INFO | started process GECKO(10032)
[task 2024-05-30T01:02:05.533Z] 01:02:05 INFO - GECKO(10032) | 1717030925532 Marionette INFO Marionette enabled
[task 2024-05-30T01:02:05.539Z] 01:02:05 INFO - GECKO(10032) | 1717030925537 Marionette TRACE Received observer notification final-ui-startup
[task 2024-05-30T01:02:05.658Z] 01:02:05 INFO - GECKO(10032) | console.error: "Warning: unrecognized command line flag" "-foreground"
[task 2024-05-30T01:02:05.705Z] 01:02:05 INFO - GECKO(10032) | 1717030925714 Marionette INFO Listening on port 2828
[task 2024-05-30T01:02:05.720Z] 01:02:05 INFO - GECKO(10032) | 1717030925719 Marionette DEBUG Marionette is listening
[task 2024-05-30T01:02:05.815Z] 01:02:05 INFO - GECKO(10032) | 1717030925815 Marionette DEBUG Accepted connection 0 from 127.0.0.1:50354
[task 2024-05-30T01:02:05.909Z] 01:02:05 INFO - GECKO(10032) | 1717030925912 Marionette DEBUG Closed connection 0
[task 2024-05-30T01:02:05.909Z] 01:02:05 INFO - GECKO(10032) | 1717030925913 Marionette DEBUG Accepted connection 1 from 127.0.0.1:50355
[task 2024-05-30T01:02:06.441Z] 01:02:06 INFO - GECKO(10032) | 1717030926448 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2024-05-30T01:02:06.461Z] 01:02:06 INFO - GECKO(10032) | 1717030926460 Marionette DEBUG Waiting for initial application window
[task 2024-05-30T01:02:10.682Z] 01:02:10 INFO - GECKO(10032) | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-05-30T01:02:10.708Z] 01:02:10 INFO - GECKO(10032) | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Ingest error: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base"
[task 2024-05-30T01:02:10.806Z] 01:02:10 INFO - GECKO(10032) | 1717030930804 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2024-05-30T01:02:10.823Z] 01:02:10 INFO - GECKO(10032) | 1717030930822 RemoteAgent TRACE [11] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=80000 waitForExplicitStart=false
[task 2024-05-30T01:02:10.824Z] 01:02:10 INFO - GECKO(10032) | 1717030930822 RemoteAgent TRACE [11] ProgressListener Setting unload timer (80000ms)
[task 2024-05-30T01:02:10.825Z] 01:02:10 INFO - GECKO(10032) | 1717030930822 RemoteAgent TRACE [11] Wait for initial navigation: isInitial=false, isLoadingDocument=false
[task 2024-05-30T01:02:10.826Z] 01:02:10 INFO - GECKO(10032) | 1717030930823 RemoteAgent TRACE [11] Document already finished loading: about:blank
[task 2024-05-30T01:02:10.826Z] 01:02:10 INFO - GECKO(10032) | 1717030930823 RemoteAgent TRACE [11] ProgressListener Stop: has error=false url=about:blank
[task 2024-05-30T01:02:10.868Z] 01:02:10 INFO - GECKO(10032) | 1717030930864 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"0102cec7-de99-4213-b487-8415ffc7e4da","capabilities":{"browserName":"firefox","browserVersion":"128.0a1","platformName":"windows","acceptInsecureCerts":false,"unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:128.0) Gecko/20100101 Firefox/128.0","pageLoadStrategy":"normal","timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"setWindowRect":true,"strictFileInteractability":true,"moz:accessibilityChecks":false,"moz:buildID":"20240529214854","moz:headless":false,"moz:platformVersion":"10.0","moz:processID":8332,"moz:profile":"C:\\Users\\task_171702996880426\\AppData\\Local\\Temp\\tmpw70j3sxx.mozrunner","moz:shutdownTimeout":180000,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2024-05-30T01:02:10.911Z] 01:02:10 INFO - GECKO(10032) | 1717030930900 Marionette DEBUG 1 -> [0,2,"Addon:Install",{"path":"C:\\Users\\task_171702996880426\\AppData\\Local\\Temp\\tmppcdhy79w.zip","temporary":false}]
[task 2024-05-30T01:02:11.051Z] 01:02:11 INFO - GECKO(10032) | 1717030931050 Marionette DEBUG 1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2024-05-30T01:02:11.109Z] 01:02:11 INFO - GECKO(10032) | 1717030931107 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"C:\\Users\\task_171702996880426\\AppData\\Local\\Temp\\tmpzbk3w90x.zip","temporary":false}]
[task 2024-05-30T01:02:11.163Z] 01:02:11 INFO - GECKO(10032) | 1717030931162 Marionette DEBUG 1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2024-05-30T01:02:11.177Z] 01:02:11 INFO - GECKO(10032) | 1717030931175 Marionette DEBUG 1 -> [0,4,"Marionette:GetContext",{}]
[task 2024-05-30T01:02:11.178Z] 01:02:11 INFO - GECKO(10032) | 1717030931176 Marionette DEBUG 1 <- [1,4,null,{"value":"content"}]
[task 2024-05-30T01:02:11.179Z] 01:02:11 INFO - GECKO(10032) | 1717030931178 Marionette DEBUG 1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-05-30T01:02:11.180Z] 01:02:11 INFO - GECKO(10032) | 1717030931179 Marionette DEBUG 1 <- [1,5,null,{"value":null}]
[task 2024-05-30T01:02:11.184Z] 01:02:11 INFO - GECKO(10032) | 1717030931181 Marionette DEBUG 1 -> [0,6,"WebDriver:ExecuteScript",{"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distr ... s which flavor and url to load.\nlet ev = new CustomEvent(\"mochitest-load\", { detail: [flavor, url] });\nwin.dispatchEvent(ev);","args":[{"flavor":"browser-chrome","testUrl":"about:blank"}],"newSandbox":true,"sandbox":"default","line":2167,"filename":"D:\\task_171702996880426\\build\\tests\\mochitest\\runtests.py"}]
[task 2024-05-30T01:02:11.197Z] 01:02:11 INFO - GECKO(10032) | 1717030931197 RemoteAgent TRACE WebDriverProcessData actor created for PID 8332
[task 2024-05-30T01:02:11.201Z] 01:02:11 INFO - GECKO(10032) | 1717030931199 Marionette TRACE [2] MarionetteCommands actor created for window id 4
[task 2024-05-30T01:02:11.262Z] 01:02:11 INFO - GECKO(10032) | 1717030931261 RemoteAgent TRACE Received observer notification domwindowopened
[task 2024-05-30T01:02:11.273Z] 01:02:11 INFO - GECKO(10032) | 1717030931272 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2024-05-30T01:02:11.281Z] 01:02:11 INFO - GECKO(10032) | 1717030931279 Marionette DEBUG 1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2024-05-30T01:02:11.282Z] 01:02:11 INFO - GECKO(10032) | 1717030931280 Marionette DEBUG 1 <- [1,7,null,{"value":null}]
[task 2024-05-30T01:02:11.323Z] 01:02:11 INFO - GECKO(10032) | 1717030931322 Marionette DEBUG 1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2024-05-30T01:02:11.324Z] 01:02:11 INFO - GECKO(10032) | 1717030931323 Marionette TRACE [2] MarionetteCommands actor destroyed for window id 4
[task 2024-05-30T01:02:11.329Z] 01:02:11 INFO - GECKO(10032) | 1717030931328 Marionette DEBUG 1 <- [1,8,null,{"value":null}]
[task 2024-05-30T01:02:11.377Z] 01:02:11 INFO - runtests.py | Waiting for browser...
[task 2024-05-30T01:02:11.381Z] 01:02:11 INFO - GECKO(10032) | 1717030931380 Marionette DEBUG Closed connection 1
[task 2024-05-30T01:02:11.663Z] 01:02:11 INFO - *** Start BrowserChrome Test Results ***
[task 2024-05-30T01:02:11.729Z] 01:02:11 INFO - checking window state
[task 2024-05-30T01:02:11.816Z] 01:02:11 INFO - TEST-START | accessible/tests/browser/general/browser_test_doc_creation.js
Description
•