Closed
Bug 1904993
Opened 2 years ago
Closed 2 years ago
Intermittent browser/components/downloads/test/browser/browser_download_opens_policy.js | single tracking bug
Categories
(Firefox :: Downloads Panel, defect, P5)
Firefox
Downloads Panel
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure, intermittent-testcase)
Filed by: pstanciu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=464178126&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/ctPiRBXsRvC0QYgubRxfdQ/runs/0/artifacts/public/logs/live_backing.log
[task 2024-06-26T23:22:50.750Z] 23:22:50 INFO - TEST-START | browser/components/downloads/test/browser/browser_download_opens_policy.js
[task 2024-06-26T23:24:30.556Z] 23:24:30 INFO - TEST-INFO | started process screenshot
[task 2024-06-26T23:24:30.729Z] 23:24:30 INFO - TEST-INFO | screenshot: exit 0
[task 2024-06-26T23:24:30.743Z] 23:24:30 INFO - Buffered messages logged at 23:22:50
[task 2024-06-26T23:24:30.743Z] 23:24:30 INFO - Entering test bound test_download_opens_on_click
[task 2024-06-26T23:24:30.744Z] 23:24:30 INFO - TEST-PASS | browser/components/downloads/test/browser/browser_download_opens_policy.js | Sanity check the temporary file doesn't exist. - true == true -
[task 2024-06-26T23:24:30.745Z] 23:24:30 INFO - Interruptible responses will be blocked midway.
[task 2024-06-26T23:24:30.745Z] 23:24:30 INFO - TEST-PASS | browser/components/downloads/test/browser/browser_download_opens_policy.js | File opened from panel should not be initialized - "undefined" == "undefined" -
[task 2024-06-26T23:24:30.746Z] 23:24:30 INFO - Interruptible request started.
[task 2024-06-26T23:24:30.747Z] 23:24:30 INFO - Download reached 50%
[task 2024-06-26T23:24:30.747Z] 23:24:30 INFO - Buffered messages finished
[task 2024-06-26T23:24:30.748Z] 23:24:30 INFO - TEST-UNEXPECTED-FAIL | browser/components/downloads/test/browser/browser_download_opens_policy.js | Test timed out -
[task 2024-06-26T23:24:30.748Z] 23:24:30 INFO - GECKO(1472) | Completed ShutdownLeaks collections in process 8144
[task 2024-06-26T23:24:30.749Z] 23:24:30 INFO - TEST-START | Shutdown
[task 2024-06-26T23:24:30.749Z] 23:24:30 INFO - Browser Chrome Test Summary
[task 2024-06-26T23:24:30.749Z] 23:24:30 INFO - Passed: 50
[task 2024-06-26T23:24:30.750Z] 23:24:30 INFO - Failed: 1
[task 2024-06-26T23:24:30.750Z] 23:24:30 INFO - Todo: 0
[task 2024-06-26T23:24:30.751Z] 23:24:30 INFO - Mode: e10s
[task 2024-06-26T23:24:30.752Z] 23:24:30 INFO - *** End BrowserChrome Test Results ***
[task 2024-06-26T23:24:30.758Z] 23:24:30 INFO - GECKO(1472) | 1719444270757 Marionette TRACE Received observer notification quit-application
[task 2024-06-26T23:24:30.758Z] 23:24:30 INFO - GECKO(1472) | 1719444270757 Marionette INFO Stopped listening on port 2828
[task 2024-06-26T23:24:30.763Z] 23:24:30 INFO - GECKO(1472) | 1719444270763 Marionette DEBUG Marionette stopped listening
[task 2024-06-26T23:24:31.057Z] 23:24:31 INFO - GECKO(1472) | !!! error running onStopped callback: TypeError: callback is not a function
[task 2024-06-26T23:24:31.070Z] 23:24:31 INFO - GECKO(1472) | JavaScript error: , line 0: uncaught exception: Object
[task 2024-06-26T23:24:33.269Z] 23:24:33 INFO - TEST-INFO | Main app process: exit 0
[task 2024-06-26T23:24:33.270Z] 23:24:33 INFO - runtests.py | Application ran for: 0:02:16.419443
[task 2024-06-26T23:24:33.271Z] 23:24:33 INFO - zombiecheck | Reading PID log: C:\Users\task_171944355272128\AppData\Local\Temp\tmp7fgc4p8ypidlog
[task 2024-06-26T23:24:33.272Z] 23:24:33 INFO - ==> process 8144 launched child process 6476 ("D:\task_171944355272128\build\application\firefox\firefox.exe" -contentproc --channel=2120 -parentBuildID 20240626223406 -prefsHandle 2100 -prefMapHandle 2080 -prefsLen 23370 -prefMapSize 265297 -appDir "D:\task_171944355272128\build\application\firefox\browser" - {f32762a3-3389-45c5-903f-eb19dd1b71e4} 8144 gpu)
[task 2024-06-26T23:24:33.272Z] 23:24:33 INFO - ==> process 8144 launched child process 8540 ("D:\task_171944355272128\build\application\firefox\firefox.exe" -contentproc --channel=2828 -childID 1 -isForBrowser -prefsHandle 2924 -prefMapHandle 2920 -prefsLen 23194 -prefMapSize 265297 -jsInitHandle 1452 -jsInitLen 234780 -parentBuildID 20240626223406 -win32kLockedDown -appDir "D:\task_171944355272128\build\application\firefox\browser" - {145db720-501f-4fda-8214-cd8aa656a6c7} 8144 tab)
[task 2024-06-26T23:24:33.274Z] 23:24:33 INFO - ==> process 8144 launched child process 5912 ("D:\task_171944355272128\build\application\firefox\firefox.exe" -contentproc --channel=3340 -childID 2 -isForBrowser -prefsHandle 3332 -prefMapHandle 3328 -prefsLen 24931 -prefMapSize 265297 -jsInitHandle 1452 -jsInitLen 234780 -parentBuildID 20240626223406 -win32kLockedDown -appDir "D:\task_171944355272128\build\application\firefox\browser" - {f8bad9c8-f8e8-4346-a564-1725bef61cc6} 8144 tab)
[task 2024-06-26T23:24:33.275Z] 23:24:33 INFO - ==> process 8144 launched child process 8768 ("D:\task_171944355272128\build\application\firefox\firefox.exe" -contentproc --channel=3532 -childID 3 -isForBrowser -prefsHandle 3524 -prefMapHandle 3520 -prefsLen 24597 -prefMapSize 265297 -jsInitHandle 1452 -jsInitLen 234780 -parentBuildID 20240626223406 -win32kLockedDown -appDir "D:\task_171944355272128\build\application\firefox\browser" - {5f7a9fc7-db02-4771-9860-8067860e709b} 8144 tab)
[task 2024-06-26T23:24:33.276Z] 23:24:33 INFO - ==> process 8144 launched child process 9504 ("D:\task_171944355272128\build\application\firefox\firefox.exe" -contentproc --channel=3984 -childID 4 -isForBrowser -prefsHandle 3976 -prefMapHandle 3972 -prefsLen 30430 -prefMapSize 265297 -jsInitHandle 1452 -jsInitLen 234780 -parentBuildID 20240626223406 -win32kLockedDown -appDir "D:\task_171944355272128\build\application\firefox\browser" - {f79e3487-78f2-4895-9975-ded1302237ef} 8144 tab)
[task 2024-06-26T23:24:33.276Z] 23:24:33 INFO - ==> process 8144 launched child process 9316 ("D:\task_171944355272128\build\application\firefox\firefox.exe" -contentproc --channel=4164 -childID 5 -isForBrowser -prefsHandle 4012 -prefMapHandle 4108 -prefsLen 30430 -prefMapSize 265297 -jsInitHandle 1452 -jsInitLen 234780 -parentBuildID 20240626223406 -win32kLockedDown -appDir "D:\task_171944355272128\build\application\firefox\browser" - {ecdf89e2-6917-4955-afd8-ea40c482e5d8} 8144 tab)
[task 2024-06-26T23:24:33.277Z] 23:24:33 INFO - ==> process 8144 launched child process 3324 ("D:\task_171944355272128\build\application\firefox\firefox.exe" -contentproc --channel=4576 -parentBuildID 20240626223406 -sandboxingKind 0 -prefsHandle 4600 -prefMapHandle 4596 -prefsLen 33035 -prefMapSize 265297 -win32kLockedDown -appDir "D:\task_171944355272128\build\application\firefox\browser" - {ddce55c5-101d-4a17-887a-f75eab389e0b} 8144 utility)
[task 2024-06-26T23:24:33.278Z] 23:24:33 INFO - ==> process 8144 launched child process 2740 ("D:\task_171944355272128\build\application\firefox\firefox.exe" -contentproc --channel=4600 -childID 6 -isForBrowser -prefsHandle 4716 -prefMapHandle 4712 -prefsLen 30588 -prefMapSize 265297 -jsInitHandle 1452 -jsInitLen 234780 -parentBuildID 20240626223406 -win32kLockedDown -appDir "D:\task_171944355272128\build\application\firefox\browser" - {2a01272e-1b21-49c6-adba-00076defb602} 8144 tab)
[task 2024-06-26T23:24:33.279Z] 23:24:33 INFO - ==> process 8144 launched child process 6216 ("D:\task_171944355272128\build\application\firefox\firefox.exe" -contentproc --channel=4868 -childID 7 -isForBrowser -prefsHandle 4308 -prefMapHandle 4852 -prefsLen 33035 -prefMapSize 265297 -jsInitHandle 1452 -jsInitLen 234780 -parentBuildID 20240626223406 -win32kLockedDown -appDir "D:\task_171944355272128\build\application\firefox\browser" - {55434943-a86f-4a58-b36e-2e835360db50} 8144 tab)
[task 2024-06-26T23:24:33.281Z] 23:24:33 INFO - ==> process 8144 launched child process 5800 ("D:\task_171944355272128\build\application\firefox\firefox.exe" -contentproc --channel=5704 -childID 8 -isForBrowser -prefsHandle 5696 -prefMapHandle 5672 -prefsLen 30785 -prefMapSize 265297 -jsInitHandle 1452 -jsInitLen 234780 -parentBuildID 20240626223406 -win32kLockedDown -appDir "D:\task_171944355272128\build\application\firefox\browser" - {fca20803-d926-4b2c-844c-ea6f5d6b2218} 8144 tab)
[task 2024-06-26T23:24:33.281Z] 23:24:33 INFO - zombiecheck | Checking for orphan process with PID: 9504
[task 2024-06-26T23:24:33.282Z] 23:24:33 INFO - zombiecheck | Checking for orphan process with PID: 8768
[task 2024-06-26T23:24:33.283Z] 23:24:33 INFO - zombiecheck | Checking for orphan process with PID: 9316
[task 2024-06-26T23:24:33.283Z] 23:24:33 INFO - zombiecheck | Checking for orphan process with PID: 6216
[task 2024-06-26T23:24:33.283Z] 23:24:33 INFO - zombiecheck | Checking for orphan process with PID: 5800
[task 2024-06-26T23:24:33.284Z] 23:24:33 INFO - zombiecheck | Checking for orphan process with PID: 6476
[task 2024-06-26T23:24:33.284Z] 23:24:33 INFO - zombiecheck | Checking for orphan process with PID: 3324
[task 2024-06-26T23:24:33.284Z] 23:24:33 INFO - zombiecheck | Checking for orphan process with PID: 2740
[task 2024-06-26T23:24:33.285Z] 23:24:33 INFO - zombiecheck | Checking for orphan process with PID: 5912
[task 2024-06-26T23:24:33.285Z] 23:24:33 INFO - zombiecheck | Checking for orphan process with PID: 8540
[task 2024-06-26T23:24:33.286Z] 23:24:33 INFO - Stopping web server
[task 2024-06-26T23:24:33.286Z] 23:24:33 INFO - Server shut down.
[task 2024-06-26T23:24:33.287Z] 23:24:33 INFO - Web server killed.
[task 2024-06-26T23:24:33.288Z] 23:24:33 INFO - Stopping web socket server
[task 2024-06-26T23:24:33.288Z] 23:24:33 INFO - Stopping ssltunnel
[task 2024-06-26T23:24:33.288Z] 23:24:33 WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2024-06-26T23:24:33.289Z] 23:24:33 INFO - runtests.py | Running tests: end.
[task 2024-06-26T23:24:33.289Z] 23:24:33 INFO - Buffered messages finished
[task 2024-06-26T23:24:33.290Z] 23:24:33 INFO - Running manifest: browser/components/firefoxview/tests/browser/browser.toml
[task 2024-06-26T23:24:33.291Z] 23:24:33 INFO - The following extra prefs will be set:
[task 2024-06-26T23:24:33.291Z] 23:24:33 INFO - browser.sessionstore.closedTabsFromAllWindows=true
[task 2024-06-26T23:24:33.291Z] 23:24:33 INFO - browser.sessionstore.closedTabsFromClosedWindows=true
[task 2024-06-26T23:24:33.291Z] 23:24:33 INFO - browser.tabs.firefox-view.logLevel=All
[task 2024-06-26T23:24:33.303Z] 23:24:33 INFO - INFO | runtests.py | ASan using symbolizer at D:\task_171944355272128\build\application\firefox\llvm-symbolizer.exe
[task 2024-06-26T23:24:33.503Z] 23:24:33 INFO - Failed determine available memory, disabling ASan low-memory configuration
[task 2024-06-26T23:24:34.191Z] 23:24:34 INFO - PID 7020 | D:\task_171944355272128\build\tests\bin\pk12util.exe: PKCS12 IMPORT SUCCESSFUL
[task 2024-06-26T23:24:34.191Z] 23:24:34 INFO -
[task 2024-06-26T23:24:34.347Z] 23:24:34 INFO - Increasing default timeout to 90 seconds (asan or debug)
[task 2024-06-26T23:24:34.349Z] 23:24:34 INFO - INFO | runtests.py | ASan using symbolizer at D:\task_171944355272128\build\application\firefox\llvm-symbolizer.exe
[task 2024-06-26T23:24:34.441Z] 23:24:34 INFO - Failed determine available memory, disabling ASan low-memory configuration
[task 2024-06-26T23:24:34.455Z] 23:24:34 INFO - INFO | runtests.py | ASan using symbolizer at D:\task_171944355272128\build\application\firefox\llvm-symbolizer.exe
[task 2024-06-26T23:24:34.551Z] 23:24:34 INFO - Failed determine available memory, disabling ASan low-memory configuration
[task 2024-06-26T23:24:34.571Z] 23:24:34 INFO - MochitestServer : launching ['D:\\task_171944355272128\\build\\tests\\bin\\xpcshell.exe', '-g', 'D:\\task_171944355272128\\build\\application\\firefox', '-e', "const _PROFILE_PATH = 'C:\\\\Users\\\\task_171944355272128\\\\AppData\\\\Local\\\\Temp\\\\tmph2y8ql7k.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_171944355272128\\\\build\\\\tests\\\\bin\\\\components';", '-f', 'D:\\task_171944355272128\\build\\tests\\mochitest\\server.js']
[task 2024-06-26T23:24:34.575Z] 23:24:34 INFO - runtests.py | Server pid: 1748
[task 2024-06-26T23:24:34.587Z] 23:24:34 INFO - runtests.py | Websocket server pid: 7912
[task 2024-06-26T23:24:34.589Z] 23:24:34 INFO - INFO | runtests.py | ASan using symbolizer at D:\task_171944355272128\build\application\firefox\llvm-symbolizer.exe
[task 2024-06-26T23:24:34.707Z] 23:24:34 INFO - Failed determine available memory, disabling ASan low-memory configuration
[task 2024-06-26T23:24:34.713Z] 23:24:34 INFO - runtests.py | SSL tunnel pid: 4200
[task 2024-06-26T23:24:34.921Z] 23:24:34 INFO - use http3 server: 0
[task 2024-06-26T23:24:34.925Z] 23:24:34 INFO - runtests.py | Running with scheme: http
[task 2024-06-26T23:24:34.925Z] 23:24:34 INFO - runtests.py | Running with e10s: True
[task 2024-06-26T23:24:34.926Z] 23:24:34 INFO - runtests.py | Running with fission: True
[task 2024-06-26T23:24:34.926Z] 23:24:34 INFO - runtests.py | Running with cross-origin iframes: False
[task 2024-06-26T23:24:34.927Z] 23:24:34 INFO - runtests.py | Running with serviceworker_e10s: True
[task 2024-06-26T23:24:34.928Z] 23:24:34 INFO - runtests.py | Running with socketprocess_e10s: False
[task 2024-06-26T23:24:34.928Z] 23:24:34 INFO - runtests.py | Running tests: start.
[task 2024-06-26T23:24:34.928Z] 23:24:34 INFO -
[task 2024-06-26T23:24:35.083Z] 23:24:35 INFO - Application command: D:\task_171944355272128\build\application\firefox\firefox.exe -marionette --wait-for-browser -foreground -profile C:\Users\task_171944355272128\AppData\Local\Temp\tmph2y8ql7k.mozrunner
[task 2024-06-26T23:24:35.097Z] 23:24:35 INFO - runtests.py | Application pid: 4764
[task 2024-06-26T23:24:35.097Z] 23:24:35 INFO - TEST-INFO | started process GECKO(4764)
[task 2024-06-26T23:24:37.086Z] 23:24:37 INFO - GECKO(4764) | 1719444277089 Marionette INFO Marionette enabled
[task 2024-06-26T23:24:37.102Z] 23:24:37 INFO - GECKO(4764) | 1719444277103 Marionette TRACE Received observer notification final-ui-startup
[task 2024-06-26T23:24:37.507Z] 23:24:37 INFO - GECKO(4764) | console.error: "Warning: unrecognized command line flag" "-foreground"
[task 2024-06-26T23:24:37.616Z] 23:24:37 INFO - GECKO(4764) | 1719444277622 Marionette INFO Listening on port 2828
[task 2024-06-26T23:24:37.624Z] 23:24:37 INFO - GECKO(4764) | 1719444277629 Marionette DEBUG Marionette is listening
[task 2024-06-26T23:24:37.710Z] 23:24:37 INFO - GECKO(4764) | 1719444277722 Marionette DEBUG Accepted connection 0 from 127.0.0.1:64361
[task 2024-06-26T23:24:37.788Z] 23:24:37 INFO - GECKO(4764) | 1719444277794 Marionette DEBUG Closed connection 0
[task 2024-06-26T23:24:37.805Z] 23:24:37 INFO - GECKO(4764) | 1719444277803 Marionette DEBUG Accepted connection 1 from 127.0.0.1:64362
[task 2024-06-26T23:24:38.726Z] 23:24:38 INFO - GECKO(4764) | 1719444278740 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2024-06-26T23:24:38.757Z] 23:24:38 INFO - GECKO(4764) | 1719444278758 Marionette DEBUG Waiting for initial application window
[task 2024-06-26T23:24:47.856Z] 23:24:47 INFO - GECKO(4764) | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-06-26T23:24:47.890Z] 23:24:47 INFO - GECKO(4764) | 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-06-26T23:24:48.093Z] 23:24:48 INFO - GECKO(4764) | 1719444288106 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2024-06-26T23:24:48.140Z] 23:24:48 INFO - GECKO(4764) | 1719444288145 RemoteAgent TRACE [11] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=40000 waitForExplicitStart=false
[task 2024-06-26T23:24:48.147Z] 23:24:48 INFO - GECKO(4764) | 1719444288146 RemoteAgent TRACE [11] ProgressListener Setting unload timer (40000ms)
[task 2024-06-26T23:24:48.148Z] 23:24:48 INFO - GECKO(4764) | 1719444288146 RemoteAgent TRACE [11] Wait for initial navigation: isInitial=false, isLoadingDocument=false
[task 2024-06-26T23:24:48.149Z] 23:24:48 INFO - GECKO(4764) | 1719444288146 RemoteAgent TRACE [11] Document already finished loading: about:blank
[task 2024-06-26T23:24:48.149Z] 23:24:48 INFO - GECKO(4764) | 1719444288146 RemoteAgent TRACE [11] ProgressListener Stop: has error=false url=about:blank
[task 2024-06-26T23:24:48.250Z] 23:24:48 INFO - GECKO(4764) | 1719444288250 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"c7df94ba-4403-44cc-a378-265f5c78aaa4","capabilities":{"acceptInsecureCerts":false,"browserName":"firefox","browserVersion":"128.0","platformName":"windows","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:128.0) Gecko/20100101 Firefox/128.0","moz:buildID":"20240626223406","moz:headless":false,"moz:platformVersion":"10.0","moz:processID":2928,"moz:profile":"C:\\Users\\task_171944355272128\\AppData\\Local\\Temp\\tmph2y8ql7k.mozrunner","moz:shutdownTimeout":300000,"pageLoadStrategy":"normal","timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"setWindowRect":true,"strictFileInteractability":true,"moz:accessibilityChecks":false,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2024-06-26T23:24:48.312Z] 23:24:48 INFO - GECKO(4764) | 1719444288316 Marionette DEBUG 1 -> [0,2,"Addon:Install",{"path":"C:\\Users\\task_171944355272128\\AppData\\Local\\Temp\\tmpk5i35j_n.zip","temporary":false}]
[task 2024-06-26T23:24:48.657Z] 23:24:48 INFO - GECKO(4764) | 1719444288658 Marionette DEBUG 1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2024-06-26T23:24:48.688Z] 23:24:48 INFO - GECKO(4764) | 1719444288700 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"C:\\Users\\task_171944355272128\\AppData\\Local\\Temp\\tmpfu8q7njn.zip","temporary":false}]
[task 2024-06-26T23:24:48.782Z] 23:24:48 INFO - GECKO(4764) | 1719444288792 Marionette DEBUG 1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2024-06-26T23:24:48.805Z] 23:24:48 INFO - GECKO(4764) | 1719444288806 Marionette DEBUG 1 -> [0,4,"Marionette:GetContext",{}]
[task 2024-06-26T23:24:48.808Z] 23:24:48 INFO - GECKO(4764) | 1719444288807 Marionette DEBUG 1 <- [1,4,null,{"value":"content"}]
[task 2024-06-26T23:24:48.809Z] 23:24:48 INFO - GECKO(4764) | 1719444288810 Marionette DEBUG 1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-06-26T23:24:48.812Z] 23:24:48 INFO - GECKO(4764) | 1719444288810 Marionette DEBUG 1 <- [1,5,null,{"value":null}]
[task 2024-06-26T23:24:48.816Z] 23:24:48 INFO - GECKO(4764) | 1719444288813 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_171944355272128\\build\\tests\\mochitest\\runtests.py"}]
[task 2024-06-26T23:24:48.845Z] 23:24:48 INFO - GECKO(4764) | 1719444288848 RemoteAgent TRACE WebDriverProcessData actor created for PID 2928
[task 2024-06-26T23:24:48.850Z] 23:24:48 INFO - GECKO(4764) | 1719444288855 Marionette TRACE [2] MarionetteCommands actor created for window id 4
[task 2024-06-26T23:24:48.971Z] 23:24:48 INFO - GECKO(4764) | 1719444288974 RemoteAgent TRACE Received observer notification domwindowopened
[task 2024-06-26T23:24:48.987Z] 23:24:48 INFO - GECKO(4764) | 1719444288995 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2024-06-26T23:24:49.004Z] 23:24:49 INFO - GECKO(4764) | 1719444289002 Marionette DEBUG 1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2024-06-26T23:24:34.347Z] 23:24:34 INFO - Increasing default timeout to 90 seconds (asan or debug)
[task 2024-06-26T23:24:34.349Z] 23:24:34 INFO - INFO | runtests.py | ASan using symbolizer at D:\task_171944355272128\build\application\firefox\llvm-symbolizer.exe
[task 2024-06-26T23:24:34.441Z] 23:24:34 INFO - Failed determine available memory, disabling ASan low-memory configuration
[task 2024-06-26T23:24:34.455Z] 23:24:34 INFO - INFO | runtests.py | ASan using symbolizer at D:\task_171944355272128\build\application\firefox\llvm-symbolizer.exe
[task 2024-06-26T23:24:34.551Z] 23:24:34 INFO - Failed determine available memory, disabling ASan low-memory configuration
[task 2024-06-26T23:24:34.571Z] 23:24:34 INFO - MochitestServer : launching ['D:\\task_171944355272128\\build\\tests\\bin\\xpcshell.exe', '-g', 'D:\\task_171944355272128\\build\\application\\firefox', '-e', "const _PROFILE_PATH = 'C:\\\\Users\\\\task_171944355272128\\\\AppData\\\\Local\\\\Temp\\\\tmph2y8ql7k.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_171944355272128\\\\build\\\\tests\\\\bin\\\\components';", '-f', 'D:\\task_171944355272128\\build\\tests\\mochitest\\server.js']
[task 2024-06-26T23:24:34.575Z] 23:24:34 INFO - runtests.py | Server pid: 1748
[task 2024-06-26T23:24:34.587Z] 23:24:34 INFO - runtests.py | Websocket server pid: 7912
[task 2024-06-26T23:24:34.589Z] 23:24:34 INFO - INFO | runtests.py | ASan using symbolizer at D:\task_171944355272128\build\application\firefox\llvm-symbolizer.exe
[task 2024-06-26T23:24:34.707Z] 23:24:34 INFO - Failed determine available memory, disabling ASan low-memory configuration
[task 2024-06-26T23:24:34.713Z] 23:24:34 INFO - runtests.py | SSL tunnel pid: 4200
[task 2024-06-26T23:24:34.921Z] 23:24:34 INFO - use http3 server: 0
[task 2024-06-26T23:24:34.925Z] 23:24:34 INFO - runtests.py | Running with scheme: http
[task 2024-06-26T23:24:34.925Z] 23:24:34 INFO - runtests.py | Running with e10s: True
[task 2024-06-26T23:24:34.926Z] 23:24:34 INFO - runtests.py | Running with fission: True
[task 2024-06-26T23:24:34.926Z] 23:24:34 INFO - runtests.py | Running with cross-origin iframes: False
[task 2024-06-26T23:24:34.927Z] 23:24:34 INFO - runtests.py | Running with serviceworker_e10s: True
[task 2024-06-26T23:24:34.928Z] 23:24:34 INFO - runtests.py | Running with socketprocess_e10s: False
[task 2024-06-26T23:24:34.928Z] 23:24:34 INFO - runtests.py | Running tests: start.
[task 2024-06-26T23:24:34.928Z] 23:24:34 INFO -
[task 2024-06-26T23:24:35.083Z] 23:24:35 INFO - Application command: D:\task_171944355272128\build\application\firefox\firefox.exe -marionette --wait-for-browser -foreground -profile C:\Users\task_171944355272128\AppData\Local\Temp\tmph2y8ql7k.mozrunner
[task 2024-06-26T23:24:35.097Z] 23:24:35 INFO - runtests.py | Application pid: 4764
[task 2024-06-26T23:24:35.097Z] 23:24:35 INFO - TEST-INFO | started process GECKO(4764)
[task 2024-06-26T23:24:37.086Z] 23:24:37 INFO - GECKO(4764) | 1719444277089 Marionette INFO Marionette enabled
[task 2024-06-26T23:24:37.102Z] 23:24:37 INFO - GECKO(4764) | 1719444277103 Marionette TRACE Received observer notification final-ui-startup
[task 2024-06-26T23:24:37.507Z] 23:24:37 INFO - GECKO(4764) | console.error: "Warning: unrecognized command line flag" "-foreground"
[task 2024-06-26T23:24:37.616Z] 23:24:37 INFO - GECKO(4764) | 1719444277622 Marionette INFO Listening on port 2828
[task 2024-06-26T23:24:37.624Z] 23:24:37 INFO - GECKO(4764) | 1719444277629 Marionette DEBUG Marionette is listening
[task 2024-06-26T23:24:37.710Z] 23:24:37 INFO - GECKO(4764) | 1719444277722 Marionette DEBUG Accepted connection 0 from 127.0.0.1:64361
[task 2024-06-26T23:24:37.788Z] 23:24:37 INFO - GECKO(4764) | 1719444277794 Marionette DEBUG Closed connection 0
[task 2024-06-26T23:24:37.805Z] 23:24:37 INFO - GECKO(4764) | 1719444277803 Marionette DEBUG Accepted connection 1 from 127.0.0.1:64362
[task 2024-06-26T23:24:38.726Z] 23:24:38 INFO - GECKO(4764) | 1719444278740 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2024-06-26T23:24:38.757Z] 23:24:38 INFO - GECKO(4764) | 1719444278758 Marionette DEBUG Waiting for initial application window
[task 2024-06-26T23:24:47.856Z] 23:24:47 INFO - GECKO(4764) | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-06-26T23:24:47.890Z] 23:24:47 INFO - GECKO(4764) | 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-06-26T23:24:48.093Z] 23:24:48 INFO - GECKO(4764) | 1719444288106 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2024-06-26T23:24:48.140Z] 23:24:48 INFO - GECKO(4764) | 1719444288145 RemoteAgent TRACE [11] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=40000 waitForExplicitStart=false
[task 2024-06-26T23:24:48.147Z] 23:24:48 INFO - GECKO(4764) | 1719444288146 RemoteAgent TRACE [11] ProgressListener Setting unload timer (40000ms)
[task 2024-06-26T23:24:48.148Z] 23:24:48 INFO - GECKO(4764) | 1719444288146 RemoteAgent TRACE [11] Wait for initial navigation: isInitial=false, isLoadingDocument=false
[task 2024-06-26T23:24:48.149Z] 23:24:48 INFO - GECKO(4764) | 1719444288146 RemoteAgent TRACE [11] Document already finished loading: about:blank
[task 2024-06-26T23:24:48.149Z] 23:24:48 INFO - GECKO(4764) | 1719444288146 RemoteAgent TRACE [11] ProgressListener Stop: has error=false url=about:blank
[task 2024-06-26T23:24:48.250Z] 23:24:48 INFO - GECKO(4764) | 1719444288250 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"c7df94ba-4403-44cc-a378-265f5c78aaa4","capabilities":{"acceptInsecureCerts":false,"browserName":"firefox","browserVersion":"128.0","platformName":"windows","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:128.0) Gecko/20100101 Firefox/128.0","moz:buildID":"20240626223406","moz:headless":false,"moz:platformVersion":"10.0","moz:processID":2928,"moz:profile":"C:\\Users\\task_171944355272128\\AppData\\Local\\Temp\\tmph2y8ql7k.mozrunner","moz:shutdownTimeout":300000,"pageLoadStrategy":"normal","timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"setWindowRect":true,"strictFileInteractability":true,"moz:accessibilityChecks":false,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2024-06-26T23:24:48.312Z] 23:24:48 INFO - GECKO(4764) | 1719444288316 Marionette DEBUG 1 -> [0,2,"Addon:Install",{"path":"C:\\Users\\task_171944355272128\\AppData\\Local\\Temp\\tmpk5i35j_n.zip","temporary":false}]
[task 2024-06-26T23:24:48.657Z] 23:24:48 INFO - GECKO(4764) | 1719444288658 Marionette DEBUG 1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2024-06-26T23:24:48.688Z] 23:24:48 INFO - GECKO(4764) | 1719444288700 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"C:\\Users\\task_171944355272128\\AppData\\Local\\Temp\\tmpfu8q7njn.zip","temporary":false}]
[task 2024-06-26T23:24:48.782Z] 23:24:48 INFO - GECKO(4764) | 1719444288792 Marionette DEBUG 1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2024-06-26T23:24:48.805Z] 23:24:48 INFO - GECKO(4764) | 1719444288806 Marionette DEBUG 1 -> [0,4,"Marionette:GetContext",{}]
[task 2024-06-26T23:24:48.808Z] 23:24:48 INFO - GECKO(4764) | 1719444288807 Marionette DEBUG 1 <- [1,4,null,{"value":"content"}]
[task 2024-06-26T23:24:48.809Z] 23:24:48 INFO - GECKO(4764) | 1719444288810 Marionette DEBUG 1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-06-26T23:24:48.812Z] 23:24:48 INFO - GECKO(4764) | 1719444288810 Marionette DEBUG 1 <- [1,5,null,{"value":null}]
[task 2024-06-26T23:24:48.816Z] 23:24:48 INFO - GECKO(4764) | 1719444288813 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_171944355272128\\build\\tests\\mochitest\\runtests.py"}]
[task 2024-06-26T23:24:48.845Z] 23:24:48 INFO - GECKO(4764) | 1719444288848 RemoteAgent TRACE WebDriverProcessData actor created for PID 2928
[task 2024-06-26T23:24:48.850Z] 23:24:48 INFO - GECKO(4764) | 1719444288855 Marionette TRACE [2] MarionetteCommands actor created for window id 4
[task 2024-06-26T23:24:48.971Z] 23:24:48 INFO - GECKO(4764) | 1719444288974 RemoteAgent TRACE Received observer notification domwindowopened
[task 2024-06-26T23:24:48.987Z] 23:24:48 INFO - GECKO(4764) | 1719444288995 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2024-06-26T23:24:49.004Z] 23:24:49 INFO - GECKO(4764) | 1719444289002 Marionette DEBUG 1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•2 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•