Open
Bug 1962058
Opened 21 days ago
Updated 14 days ago
Intermittent browser/base/content/test/tabcrashed/browser_launchFail.js | single tracking bug
Categories
(Firefox :: Tabbed Browser, defect, P5)
Firefox
Tabbed Browser
Tracking
()
NEW
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure, intermittent-testcase)
Filed by: amarc [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=505108183&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/U2M-8ttTSgWunZDxh6gXPw/runs/0/artifacts/public/logs/live_backing.log
[task 2025-04-23T07:07:11.443Z] 07:07:11 INFO - TEST-START | browser/base/content/test/tabcrashed/browser_launchFail.js
[task 2025-04-23T07:07:11.776Z] 07:07:11 INFO - GECKO(6088) | console.error:
[task 2025-04-23T07:07:11.777Z] 07:07:11 INFO - GECKO(6088) | remote browser crashed while on
[task 2025-04-23T07:07:11.778Z] 07:07:11 INFO - GECKO(6088) | https://example.com/
[task 2025-04-23T07:07:12.174Z] 07:07:12 INFO - GECKO(6088) | console.error:
[task 2025-04-23T07:07:12.174Z] 07:07:12 INFO - GECKO(6088) | remote browser crashed while on
[task 2025-04-23T07:07:12.175Z] 07:07:12 INFO - GECKO(6088) | about:blank
[task 2025-04-23T07:07:56.468Z] 07:07:56 INFO - TEST-INFO | started process screenshot
[task 2025-04-23T07:07:56.657Z] 07:07:56 INFO - TEST-INFO | screenshot: exit 0
[task 2025-04-23T07:07:56.657Z] 07:07:56 INFO - Buffered messages logged at 07:07:11
[task 2025-04-23T07:07:56.658Z] 07:07:56 INFO - Entering test bound test_launchfail_foreground
[task 2025-04-23T07:07:56.659Z] 07:07:56 INFO - Console message: [JavaScript Warning: "HTTPS-First Mode: Upgrading insecure speculative TCP connection http://example.com/ to use https."]
[task 2025-04-23T07:07:56.660Z] 07:07:56 INFO - Console message: [JavaScript Warning: "HTTPS-First Mode: Upgrading insecure request http://example.com/ to use https."]
[task 2025-04-23T07:07:56.660Z] 07:07:56 INFO - TEST-PASS | browser/base/content/test/tabcrashed/browser_launchFail.js | No crashed browsers should be queued. - 0 == 0 -
[task 2025-04-23T07:07:56.661Z] 07:07:56 INFO - Leaving test bound test_launchfail_foreground
[task 2025-04-23T07:07:56.661Z] 07:07:56 INFO - Entering test bound test_launchfail_background
[task 2025-04-23T07:07:56.663Z] 07:07:56 INFO - Console message: [JavaScript Warning: "HTTPS-First Mode: Upgrading insecure speculative TCP connection http://example.com/ to use https."]
[task 2025-04-23T07:07:56.663Z] 07:07:56 INFO - Console message: [JavaScript Warning: "HTTPS-First Mode: Upgrading insecure request http://example.com/ to use https."]
[task 2025-04-23T07:07:56.664Z] 07:07:56 INFO - Buffered messages finished
[task 2025-04-23T07:07:56.664Z] 07:07:56 INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/tabcrashed/browser_launchFail.js | Test timed out -
[task 2025-04-23T07:07:56.665Z] 07:07:56 INFO - GECKO(6088) | Completed ShutdownLeaks collections in process 3660
[task 2025-04-23T07:07:56.665Z] 07:07:56 INFO - TEST-START | Shutdown
[task 2025-04-23T07:07:56.666Z] 07:07:56 INFO - Browser Chrome Test Summary
[task 2025-04-23T07:07:56.666Z] 07:07:56 INFO - Passed: 12
[task 2025-04-23T07:07:56.667Z] 07:07:56 INFO - Failed: 1
[task 2025-04-23T07:07:56.667Z] 07:07:56 INFO - Todo: 0
[task 2025-04-23T07:07:56.668Z] 07:07:56 INFO - Mode: e10s
[task 2025-04-23T07:07:56.668Z] 07:07:56 INFO - *** End BrowserChrome Test Results ***
[task 2025-04-23T07:07:56.669Z] 07:07:56 INFO - GECKO(6088) | Exiting due to channel error.
[task 2025-04-23T07:07:56.670Z] 07:07:56 INFO - GECKO(6088) | Exiting due to channel error.
[task 2025-04-23T07:07:56.670Z] 07:07:56 INFO - GECKO(6088) | Exiting due to channel error.
[task 2025-04-23T07:07:56.670Z] 07:07:56 INFO - TEST-INFO | Main app process: exit 0
[task 2025-04-23T07:07:56.671Z] 07:07:56 INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/tabcrashed/browser_launchFail.js | Application shut down (without crashing) in the middle of a test!
[task 2025-04-23T07:07:56.671Z] 07:07:56 INFO - TEST-INFO took 44560ms
[task 2025-04-23T07:07:56.671Z] 07:07:56 INFO - runtests.py | Application ran for: 0:00:54.585935
[task 2025-04-23T07:07:56.672Z] 07:07:56 INFO - zombiecheck | Reading PID log: C:\Users\task_174539159889316\AppData\Local\Temp\tmpm_kc2fw6pidlog
[task 2025-04-23T07:07:56.672Z] 07:07:56 INFO - ==> process 3660 launched child process 9188 ("D:\task_174539159889316\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250423061652 -prefsHandle 2240:27422 -prefMapHandle 2256:289074 -ipcHandle 2276 -initialChannelId {57a2176d-daf8-4d60-a3d9-d64cafa6770b} -parentPid 3660 -crashReporter "\\.\pipe\gecko-crash-server-pipe.3660" -appDir "D:\task_174539159889316\build\application\firefox\browser" - 1 gpu)
<...>
[task 2025-04-23T07:07:56.698Z] 07:07:56 INFO - zombiecheck | Checking for orphan process with PID: 3676
[task 2025-04-23T07:07:56.698Z] 07:07:56 INFO - Stopping web server
[task 2025-04-23T07:07:56.698Z] 07:07:56 INFO - Server shut down.
[task 2025-04-23T07:07:56.698Z] 07:07:56 INFO - Web server killed.
[task 2025-04-23T07:07:56.699Z] 07:07:56 INFO - Stopping web socket server
[task 2025-04-23T07:07:56.700Z] 07:07:56 INFO - Stopping ssltunnel
[task 2025-04-23T07:07:56.700Z] 07:07:56 WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2025-04-23T07:07:56.701Z] 07:07:56 INFO - runtests.py | Running tests: end.
[task 2025-04-23T07:07:56.758Z] 07:07:56 INFO - Buffered messages finished
[task 2025-04-23T07:07:56.760Z] 07:07:56 INFO - Running manifest: browser/components/asrouter/tests/browser/browser.toml
[task 2025-04-23T07:07:57.018Z] 07:07:57 INFO - PID 4044 | D:\task_174539159889316\build\tests\bin\pk12util.exe: PKCS12 IMPORT SUCCESSFUL
[task 2025-04-23T07:07:57.018Z] 07:07:57 INFO -
[task 2025-04-23T07:07:57.082Z] 07:07:57 INFO - MochitestServer : launching ['D:\\task_174539159889316\\build\\tests\\bin\\xpcshell.exe', '-g', 'D:\\task_174539159889316\\build\\application\\firefox', '-e', "const _PROFILE_PATH = 'C:\\\\Users\\\\task_174539159889316\\\\AppData\\\\Local\\\\Temp\\\\tmpsv9fq4kf.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_174539159889316\\\\build\\\\tests\\\\bin\\\\components';", '-f', 'D:\\task_174539159889316\\build\\tests\\mochitest\\server.js']
[task 2025-04-23T07:07:57.083Z] 07:07:57 INFO - runtests.py | Server pid: 2260
[task 2025-04-23T07:07:57.085Z] 07:07:57 INFO - runtests.py | Websocket server pid: 7516
[task 2025-04-23T07:07:57.088Z] 07:07:57 INFO - runtests.py | SSL tunnel pid: 7824
[task 2025-04-23T07:07:57.239Z] 07:07:57 INFO - use http3 server: 0
[task 2025-04-23T07:07:57.243Z] 07:07:57 INFO - runtests.py | Running with scheme: http
[task 2025-04-23T07:07:57.243Z] 07:07:57 INFO - runtests.py | Running with e10s: True
[task 2025-04-23T07:07:57.244Z] 07:07:57 INFO - runtests.py | Running with fission: True
[task 2025-04-23T07:07:57.244Z] 07:07:57 INFO - runtests.py | Running with cross-origin iframes: False
[task 2025-04-23T07:07:57.245Z] 07:07:57 INFO - runtests.py | Running with socketprocess_e10s: False
[task 2025-04-23T07:07:57.245Z] 07:07:57 INFO - runtests.py | Running tests: start.
[task 2025-04-23T07:07:57.245Z] 07:07:57 INFO -
[task 2025-04-23T07:07:57.371Z] 07:07:57 INFO - Application command: D:\task_174539159889316\build\application\firefox\firefox.exe -marionette --wait-for-browser -foreground -profile C:\Users\task_174539159889316\AppData\Local\Temp\tmpsv9fq4kf.mozrunner
[task 2025-04-23T07:07:57.375Z] 07:07:57 INFO - runtests.py | Application pid: 5092
[task 2025-04-23T07:07:57.376Z] 07:07:57 INFO - TEST-INFO | started process GECKO(5092)
[task 2025-04-23T07:07:57.942Z] 07:07:57 INFO - GECKO(5092) | 1745392077940 Marionette INFO Marionette enabled
[task 2025-04-23T07:07:57.944Z] 07:07:57 INFO - GECKO(5092) | 1745392077943 Marionette TRACE Received observer notification final-ui-startup
[task 2025-04-23T07:07:58.013Z] 07:07:58 INFO - GECKO(5092) | console.error: "Warning: unrecognized command line flag" "-foreground"
[task 2025-04-23T07:07:58.034Z] 07:07:58 INFO - GECKO(5092) | 1745392078035 Marionette INFO Listening on port 2828
[task 2025-04-23T07:07:58.038Z] 07:07:58 INFO - GECKO(5092) | 1745392078037 Marionette DEBUG Marionette is listening
[task 2025-04-23T07:07:58.057Z] 07:07:58 INFO - GECKO(5092) | 1745392078057 Marionette DEBUG Accepted connection 0 from 127.0.0.1:53533
[task 2025-04-23T07:07:58.083Z] 07:07:58 INFO - GECKO(5092) | 1745392078083 Marionette DEBUG Closed connection 0
[task 2025-04-23T07:07:58.085Z] 07:07:58 INFO - GECKO(5092) | 1745392078084 Marionette DEBUG Accepted connection 1 from 127.0.0.1:53534
[task 2025-04-23T07:07:58.237Z] 07:07:58 INFO - GECKO(5092) | 1745392078236 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2025-04-23T07:07:58.241Z] 07:07:58 INFO - GECKO(5092) | 1745392078240 Marionette DEBUG Waiting for initial application window
[task 2025-04-23T07:08:00.637Z] 07:08:00 INFO - GECKO(5092) | 1745392080637 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2025-04-23T07:08:00.648Z] 07:08:00 INFO - GECKO(5092) | 1745392080647 RemoteAgent TRACE [11] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=5000 waitForExplicitStart=false
[task 2025-04-23T07:08:00.649Z] 07:08:00 INFO - GECKO(5092) | 1745392080647 RemoteAgent TRACE [11] ProgressListener Setting unload timer (5000ms)
[task 2025-04-23T07:08:00.650Z] 07:08:00 INFO - GECKO(5092) | 1745392080648 RemoteAgent TRACE [11] Wait for initial navigation: isInitial=false, isLoadingDocument=false
[task 2025-04-23T07:08:00.650Z] 07:08:00 INFO - GECKO(5092) | 1745392080648 RemoteAgent TRACE [11] Document already finished loading: about:blank
[task 2025-04-23T07:08:00.651Z] 07:08:00 INFO - GECKO(5092) | 1745392080648 RemoteAgent TRACE [11] ProgressListener Stop: has error=false url=about:blank
[task 2025-04-23T07:08:00.670Z] 07:08:00 INFO - GECKO(5092) | 1745392080666 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"dd406bfd-fb75-4087-b935-659ec9421232","capabilities":{"acceptInsecureCerts":false,"browserName":"firefox","browserVersion":"139.0a1","platformName":"windows","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:139.0) Gecko/20100101 Firefox/139.0","moz:buildID":"20250423061652","moz:headless":false,"moz:platformVersion":"10.0","moz:processID":5344,"moz:profile":"C:\\Users\\task_174539159889316\\AppData\\Local\\Temp\\tmpsv9fq4kf.mozrunner","moz:shutdownTimeout":60000,"pageLoadStrategy":"normal","timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"setWindowRect":true,"strictFileInteractability":true,"moz:accessibilityChecks":false,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2025-04-23T07:08:00.690Z] 07:08:00 INFO - GECKO(5092) | 1745392080690 Marionette DEBUG 1 -> [0,2,"Addon:Install",{"path":"C:\\Users\\task_174539159889316\\AppData\\Local\\Temp\\tmp69_w6up5.zip","temporary":false}]
[task 2025-04-23T07:08:00.755Z] 07:08:00 INFO - GECKO(5092) | 1745392080754 Marionette DEBUG 1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2025-04-23T07:08:00.807Z] 07:08:00 INFO - GECKO(5092) | 1745392080806 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"C:\\Users\\task_174539159889316\\AppData\\Local\\Temp\\tmpuvafyk9j.zip","temporary":false}]
[task 2025-04-23T07:08:00.848Z] 07:08:00 INFO - GECKO(5092) | 1745392080847 Marionette DEBUG 1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2025-04-23T07:08:00.850Z] 07:08:00 INFO - GECKO(5092) | 1745392080849 Marionette DEBUG 1 -> [0,4,"Marionette:GetContext",{}]
[task 2025-04-23T07:08:00.851Z] 07:08:00 INFO - GECKO(5092) | 1745392080850 Marionette DEBUG 1 <- [1,4,null,{"value":"content"}]
[task 2025-04-23T07:08:00.851Z] 07:08:00 INFO - GECKO(5092) | 1745392080851 Marionette DEBUG 1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2025-04-23T07:08:00.853Z] 07:08:00 INFO - GECKO(5092) | 1745392080851 Marionette DEBUG 1 <- [1,5,null,{"value":null}]
[task 2025-04-23T07:08:00.855Z] 07:08:00 INFO - GECKO(5092) | 1745392080852 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_174539159889316\\build\\tests\\mochitest\\runtests.py"}]
[task 2025-04-23T07:08:00.859Z] 07:08:00 INFO - GECKO(5092) | 1745392080859 RemoteAgent TRACE WebDriverProcessData actor created for PID 5344
[task 2025-04-23T07:08:00.861Z] 07:08:00 INFO - GECKO(5092) | 1745392080860 Marionette TRACE [2] MarionetteCommands actor created for window id 4
[task 2025-04-23T07:08:00.884Z] 07:08:00 INFO - GECKO(5092) | 1745392080883 RemoteAgent TRACE Received observer notification domwindowopened
[task 2025-04-23T07:08:00.888Z] 07:08:00 INFO - GECKO(5092) | 1745392080887 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2025-04-23T07:08:00.890Z] 07:08:00 INFO - GECKO(5092) | 1745392080889 Marionette DEBUG 1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2025-04-23T07:08:00.891Z] 07:08:00 INFO - GECKO(5092) | 1745392080890 Marionette DEBUG 1 <- [1,7,null,{"value":null}]
[task 2025-04-23T07:08:00.916Z] 07:08:00 INFO - GECKO(5092) | 1745392080914 Marionette DEBUG 1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2025-04-23T07:08:00.916Z] 07:08:00 INFO - GECKO(5092) | 1745392080915 Marionette TRACE [2] MarionetteCommands actor destroyed for window id 4
[task 2025-04-23T07:08:00.919Z] 07:08:00 INFO - GECKO(5092) | 1745392080918 Marionette DEBUG 1 <- [1,8,null,{"value":null}]
[task 2025-04-23T07:08:00.919Z] 07:08:00 INFO - runtests.py | Waiting for browser...
[task 2025-04-23T07:08:00.920Z] 07:08:00 INFO - GECKO(5092) | 1745392080919 Marionette DEBUG Closed connection 1
[task 2025-04-23T07:08:01.046Z] 07:08:01 INFO - *** Start BrowserChrome Test Results ***
[task 2025-04-23T07:08:01.075Z] 07:08:01 INFO - checking window state
[task 2025-04-23T07:08:01.116Z] 07:08:01 INFO - TEST-START | browser/components/asrouter/tests/browser/browser_asrouter_bug1761522.js
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•14 days ago
|
||
This passed when run in confirm failure mode (rerun the test 4x in the same session).
This indicates that the test is probably a lower frequency intermittent and harder to reproduce/debug.
Whiteboard: [collect_confirm_failure]
You need to log in
before you can comment on or make changes to this bug.
Description
•