Closed Bug 1946970 Opened 1 year ago Closed 1 year ago

Intermittent [tier 2] browser/components/places/tests/browser/browser_drag_folder_on_newTab.js | single tracking bug

Categories

(Firefox :: Bookmarks & History, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

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=494020889&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Z3xajsjDRj2fl1gjv8p3CA/runs/0/artifacts/public/logs/live_backing.log


[task 2025-02-08T16:58:03.898Z] 16:58:03     INFO - TEST-START | browser/components/places/tests/browser/browser_drag_folder_on_newTab.js
[task 2025-02-08T16:58:03.981Z] 16:58:03     INFO - GECKO(2027) | JavaScript error: chrome://browser/content/places/browserPlacesViews.js, line 120: Error: No DOM node set for aPlacesNode.
[task 2025-02-08T16:58:03.981Z] 16:58:03     INFO - GECKO(2027) | node.type: 0. node.parent: [xpconnect wrapped nsINavHistoryResultNode]
[task 2025-02-08T16:58:03.982Z] 16:58:03     INFO - GECKO(2027) | JavaScript error: chrome://browser/content/places/browserPlacesViews.js, line 120: Error: No DOM node set for aPlacesNode.
[task 2025-02-08T16:58:03.982Z] 16:58:03     INFO - GECKO(2027) | node.type: 0. node.parent: [xpconnect wrapped nsINavHistoryResultNode]
[task 2025-02-08T16:58:48.909Z] 16:58:48     INFO - TEST-INFO | started process screencapture
[task 2025-02-08T16:58:49.037Z] 16:58:49     INFO - TEST-INFO | screencapture: exit 0
[task 2025-02-08T16:58:49.037Z] 16:58:49     INFO - Buffered messages logged at 16:58:03
[task 2025-02-08T16:58:49.038Z] 16:58:49     INFO - Entering setup bound 
[task 2025-02-08T16:58:49.038Z] 16:58:49     INFO - Leaving setup bound 
[task 2025-02-08T16:58:49.038Z] 16:58:49     INFO - Entering test bound test_change_location_from_Toolbar
[task 2025-02-08T16:58:49.038Z] 16:58:49     INFO - Console message: [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use “<!DOCTYPE html>”." {file: "https://www.example.com/second" line: 0}]
[task 2025-02-08T16:58:49.038Z] 16:58:49     INFO - Console message: [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use “<!DOCTYPE html>”." {file: "https://www.example.com/third" line: 0}]
[task 2025-02-08T16:58:49.038Z] 16:58:49     INFO - Console message: [JavaScript Error: "Error: No DOM node set for aPlacesNode.
[task 2025-02-08T16:58:49.038Z] 16:58:49     INFO - node.type: 0. node.parent: [xpconnect wrapped nsINavHistoryResultNode]" {file: "chrome://browser/content/places/browserPlacesViews.js" line: 120}]
[task 2025-02-08T16:58:49.038Z] 16:58:49     INFO - _getDOMNodeForPlacesNode@chrome://browser/content/places/browserPlacesViews.js:120:13
[task 2025-02-08T16:58:49.038Z] 16:58:49     INFO - nodeTitleChanged@chrome://browser/content/places/browserPlacesViews.js:503:20
[task 2025-02-08T16:58:49.038Z] 16:58:49     INFO - 
[task 2025-02-08T16:58:49.039Z] 16:58:49     INFO - Console message: [JavaScript Error: "Error: No DOM node set for aPlacesNode.
[task 2025-02-08T16:58:49.039Z] 16:58:49     INFO - node.type: 0. node.parent: [xpconnect wrapped nsINavHistoryResultNode]" {file: "chrome://browser/content/places/browserPlacesViews.js" line: 120}]
[task 2025-02-08T16:58:49.039Z] 16:58:49     INFO - _getDOMNodeForPlacesNode@chrome://browser/content/places/browserPlacesViews.js:120:13
[task 2025-02-08T16:58:49.039Z] 16:58:49     INFO - nodeTitleChanged@chrome://browser/content/places/browserPlacesViews.js:503:20
[task 2025-02-08T16:58:49.039Z] 16:58:49     INFO - 
[task 2025-02-08T16:58:49.039Z] 16:58:49     INFO - Buffered messages finished
[task 2025-02-08T16:58:49.039Z] 16:58:49     INFO - TEST-UNEXPECTED-FAIL | browser/components/places/tests/browser/browser_drag_folder_on_newTab.js | Test timed out - 
[task 2025-02-08T16:58:49.039Z] 16:58:49     INFO - GECKO(2027) | Completed ShutdownLeaks collections in process 2027
[task 2025-02-08T16:58:49.039Z] 16:58:49     INFO - TEST-START | Shutdown
[task 2025-02-08T16:58:49.039Z] 16:58:49     INFO - Browser Chrome Test Summary
[task 2025-02-08T16:58:49.039Z] 16:58:49     INFO - Passed:  1666
[task 2025-02-08T16:58:49.040Z] 16:58:49     INFO - Failed:  1
[task 2025-02-08T16:58:49.040Z] 16:58:49     INFO - Todo:    1
[task 2025-02-08T16:58:49.040Z] 16:58:49     INFO - Mode:    e10s
[task 2025-02-08T16:58:49.040Z] 16:58:49     INFO - *** End BrowserChrome Test Results ***
[task 2025-02-08T16:58:49.289Z] 16:58:49     INFO - GECKO(2027) | 1739033929289	Marionette	TRACE	Received observer notification quit-application
[task 2025-02-08T16:58:49.289Z] 16:58:49     INFO - GECKO(2027) | 1739033929289	Marionette	INFO	Stopped listening on port 2828
[task 2025-02-08T16:58:49.290Z] 16:58:49     INFO - GECKO(2027) | 1739033929289	Marionette	DEBUG	Marionette stopped listening
[task 2025-02-08T16:58:49.330Z] 16:58:49     INFO - GECKO(2027) | JavaScript error: resource://testing-common/BrowserTestUtils.sys.mjs, line 512: Error: The window unloaded while we were waiting for the browser to load - this should never happen.
[task 2025-02-08T16:58:49.332Z] 16:58:49     INFO - GECKO(2027) | JavaScript error: resource://testing-common/BrowserTestUtils.sys.mjs, line 512: Error: The window unloaded while we were waiting for the browser to load - this should never happen.
[task 2025-02-08T16:58:49.332Z] 16:58:49     INFO - GECKO(2027) | JavaScript error: resource://testing-common/BrowserTestUtils.sys.mjs, line 512: Error: The window unloaded while we were waiting for the browser to load - this should never happen.
[task 2025-02-08T16:58:49.332Z] 16:58:49     INFO - GECKO(2027) | JavaScript error: resource://testing-common/BrowserTestUtils.sys.mjs, line 512: Error: The window unloaded while we were waiting for the browser to load - this should never happen.
[task 2025-02-08T16:58:49.332Z] 16:58:49     INFO - GECKO(2027) | JavaScript error: resource://testing-common/BrowserTestUtils.sys.mjs, line 512: Error: The window unloaded while we were waiting for the browser to load - this should never happen.
[task 2025-02-08T16:58:49.332Z] 16:58:49     INFO - GECKO(2027) | JavaScript error: resource://testing-common/BrowserTestUtils.sys.mjs, line 512: Error: The window unloaded while we were waiting for the browser to load - this should never happen.
[task 2025-02-08T16:58:49.332Z] 16:58:49     INFO - GECKO(2027) | JavaScript error: resource://testing-common/BrowserTestUtils.sys.mjs, line 512: Error: The window unloaded while we were waiting for the browser to load - this should never happen.
[task 2025-02-08T16:58:49.420Z] 16:58:49     INFO - TEST-INFO | Main app process: exit 0
[task 2025-02-08T16:58:49.420Z] 16:58:49     INFO - TEST-UNEXPECTED-FAIL | browser/components/places/tests/browser/browser_drag_folder_on_newTab.js | Application shut down (without crashing) in the middle of a test!
[task 2025-02-08T16:58:49.420Z] 16:58:49     INFO - TEST-INFO took 45102ms
[task 2025-02-08T16:58:49.420Z] 16:58:49     INFO - runtests.py | Application ran for: 0:02:01.765510
[task 2025-02-08T16:58:49.420Z] 16:58:49     INFO - zombiecheck | Reading PID log: /var/folders/vy/yv6d9jm96z5ctbv2dpphxb44000014/T/tmpl4uaw62opidlog
[task 2025-02-08T16:58:49.420Z] 16:58:49     INFO - ==> process 2027 launched child process 2028
<...>
[task 2025-02-08T16:58:49.427Z] 16:58:49     INFO - zombiecheck | Checking for orphan process with PID: 2044
[task 2025-02-08T16:58:49.428Z] 16:58:49     INFO - Stopping web server
[task 2025-02-08T16:58:49.428Z] 16:58:49     INFO - Server shut down.
[task 2025-02-08T16:58:49.428Z] 16:58:49     INFO - Web server killed.
[task 2025-02-08T16:58:49.428Z] 16:58:49     INFO - Stopping web socket server
[task 2025-02-08T16:58:49.428Z] 16:58:49     INFO - Stopping ssltunnel
[task 2025-02-08T16:58:49.428Z] 16:58:49  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2025-02-08T16:58:49.428Z] 16:58:49     INFO - runtests.py | Running tests: end.
[task 2025-02-08T16:58:49.434Z] 16:58:49     INFO - Buffered messages finished
[task 2025-02-08T16:58:49.434Z] 16:58:49     INFO - Running manifest: browser/components/protections/test/browser/browser.toml
[task 2025-02-08T16:58:49.434Z] 16:58:49     INFO - The following extra prefs will be set:
[task 2025-02-08T16:58:49.434Z] 16:58:49     INFO -   toolkit.telemetry.ipcBatchTimeout=0
[task 2025-02-08T16:58:49.517Z] 16:58:49     INFO - PID 2479 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2025-02-08T16:58:49.517Z] 16:58:49     INFO - 
[task 2025-02-08T16:58:49.537Z] 16:58:49     INFO - MochitestServer : launching ['/opt/worker/tasks/task_173903351903741/build/tests/bin/xpcshell', '-g', '/opt/worker/tasks/task_173903351903741/build/application/Firefox.app/Contents/Resources', '-e', "const _PROFILE_PATH = '/var/folders/vy/yv6d9jm96z5ctbv2dpphxb44000014/T/tmpqrmhhe9a.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false; const _HTTPD_PATH = '/opt/worker/tasks/task_173903351903741/build/tests/bin/components';", '-f', '/opt/worker/tasks/task_173903351903741/build/tests/mochitest/server.js']
[task 2025-02-08T16:58:49.538Z] 16:58:49     INFO - runtests.py | Server pid: 2482
[task 2025-02-08T16:58:49.539Z] 16:58:49     INFO - runtests.py | Websocket server pid: 2483
[task 2025-02-08T16:58:49.541Z] 16:58:49     INFO - runtests.py | SSL tunnel pid: 2484
[task 2025-02-08T16:58:49.741Z] 16:58:49     INFO - use http3 server: 0
[task 2025-02-08T16:58:49.742Z] 16:58:49     INFO - runtests.py | Running with scheme: http
[task 2025-02-08T16:58:49.742Z] 16:58:49     INFO - runtests.py | Running with e10s: True
[task 2025-02-08T16:58:49.742Z] 16:58:49     INFO - runtests.py | Running with fission: True
[task 2025-02-08T16:58:49.743Z] 16:58:49     INFO - runtests.py | Running with cross-origin iframes: False
[task 2025-02-08T16:58:49.743Z] 16:58:49     INFO - runtests.py | Running with socketprocess_e10s: False
[task 2025-02-08T16:58:49.743Z] 16:58:49     INFO - runtests.py | Running tests: start.
[task 2025-02-08T16:58:49.743Z] 16:58:49     INFO - 
[task 2025-02-08T16:58:49.746Z] 16:58:49     INFO - Application command: /opt/worker/tasks/task_173903351903741/build/application/Firefox.app/Contents/MacOS/firefox -marionette -foreground -profile /var/folders/vy/yv6d9jm96z5ctbv2dpphxb44000014/T/tmpqrmhhe9a.mozrunner
[task 2025-02-08T16:58:49.748Z] 16:58:49     INFO - runtests.py | Application pid: 2485
[task 2025-02-08T16:58:49.748Z] 16:58:49     INFO - TEST-INFO | started process GECKO(2485)
[task 2025-02-08T16:58:49.930Z] 16:58:49     INFO - GECKO(2485) | 1739033929929	Marionette	INFO	Marionette enabled
[task 2025-02-08T16:58:50.028Z] 16:58:50     INFO - GECKO(2485) | 1739033930028	Marionette	TRACE	Received observer notification final-ui-startup
[task 2025-02-08T16:58:50.068Z] 16:58:50     INFO - GECKO(2485) | 1739033930067	Marionette	INFO	Listening on port 2828
[task 2025-02-08T16:58:50.069Z] 16:58:50     INFO - GECKO(2485) | 1739033930068	Marionette	DEBUG	Marionette is listening
[task 2025-02-08T16:58:50.073Z] 16:58:50     INFO - GECKO(2485) | 1739033930073	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:49594
[task 2025-02-08T16:58:50.202Z] 16:58:50     INFO - GECKO(2485) | 1739033930202	Marionette	DEBUG	Closed connection 0
[task 2025-02-08T16:58:50.203Z] 16:58:50     INFO - GECKO(2485) | 1739033930202	Marionette	DEBUG	Accepted connection 1 from 127.0.0.1:49595
[task 2025-02-08T16:58:50.255Z] 16:58:50     INFO - GECKO(2485) | 1739033930254	Marionette	DEBUG	1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2025-02-08T16:58:50.256Z] 16:58:50     INFO - GECKO(2485) | 1739033930255	Marionette	DEBUG	Waiting for initial application window
[task 2025-02-08T16:58:50.567Z] 16:58:50     INFO - GECKO(2485) | UNSUPPORTED (log once): POSSIBLE ISSUE: unit 1 GLD_TEXTURE_INDEX_2D is unloadable and bound to sampler type (Float) - using zero texture because texture unloadable
[task 2025-02-08T16:58:51.017Z] 16:58:51     INFO - GECKO(2485) | 1739033931017	Marionette	TRACE	Received observer notification browser-idle-startup-tasks-finished
[task 2025-02-08T16:58:51.020Z] 16:58:51     INFO - GECKO(2485) | 1739033931019	RemoteAgent	TRACE	[10] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=5000 waitForExplicitStart=false
[task 2025-02-08T16:58:51.020Z] 16:58:51     INFO - GECKO(2485) | 1739033931019	RemoteAgent	TRACE	[10] ProgressListener Setting unload timer (5000ms)
[task 2025-02-08T16:58:51.020Z] 16:58:51     INFO - GECKO(2485) | 1739033931019	RemoteAgent	TRACE	[10] Wait for initial navigation: isInitial=false, isLoadingDocument=false
[task 2025-02-08T16:58:51.020Z] 16:58:51     INFO - GECKO(2485) | 1739033931019	RemoteAgent	TRACE	[10] Document already finished loading: about:blank
[task 2025-02-08T16:58:51.021Z] 16:58:51     INFO - GECKO(2485) | 1739033931019	RemoteAgent	TRACE	[10] ProgressListener Stop: has error=false url=about:blank
[task 2025-02-08T16:58:51.025Z] 16:58:51     INFO - GECKO(2485) | 1739033931024	Marionette	DEBUG	1 <- [1,1,null,{"sessionId":"8398b148-e57d-46da-8f5d-e1282632c5c4","capabilities":{"acceptInsecureCerts":false,"browserName":"firefox","browserVersion":"136.0","platformName":"mac","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:136.0) Gecko/20100101 Firefox/136.0","moz:buildID":"20250208132955","moz:headless":false,"moz:platformVersion":"20.3.0","moz:processID":2485,"moz:profile":"/var/folders/vy/yv6d9jm96z5ctbv2dpphxb44000014/T/tmpqrmhhe9a.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-02-08T16:58:51.032Z] 16:58:51     INFO - GECKO(2485) | 1739033931031	Marionette	DEBUG	1 -> [0,2,"Addon:Install",{"path":"/var/folders/vy/yv6d9jm96z5ctbv2dpphxb44000014/T/tmpa1wsu70h.zip","temporary":false}]
[task 2025-02-08T16:58:51.052Z] 16:58:51     INFO - GECKO(2485) | 1739033931051	Marionette	DEBUG	1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2025-02-08T16:58:51.067Z] 16:58:51     INFO - GECKO(2485) | 1739033931066	Marionette	DEBUG	1 -> [0,3,"Addon:Install",{"path":"/var/folders/vy/yv6d9jm96z5ctbv2dpphxb44000014/T/tmpaker4mh5.zip","temporary":false}]
[task 2025-02-08T16:58:51.074Z] 16:58:51     INFO - GECKO(2485) | 1739033931074	Marionette	DEBUG	1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2025-02-08T16:58:51.074Z] 16:58:51     INFO - GECKO(2485) | 1739033931074	Marionette	DEBUG	1 -> [0,4,"Marionette:GetContext",{}]
[task 2025-02-08T16:58:51.075Z] 16:58:51     INFO - GECKO(2485) | 1739033931074	Marionette	DEBUG	1 <- [1,4,null,{"value":"content"}]
[task 2025-02-08T16:58:51.075Z] 16:58:51     INFO - GECKO(2485) | 1739033931075	Marionette	DEBUG	1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2025-02-08T16:58:51.075Z] 16:58:51     INFO - GECKO(2485) | 1739033931075	Marionette	DEBUG	1 <- [1,5,null,{"value":null}]
[task 2025-02-08T16:58:51.076Z] 16:58:51     INFO - GECKO(2485) | 1739033931075	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":2159,"filename":"tests/mochitest/runtests.py"}]
[task 2025-02-08T16:58:51.077Z] 16:58:51     INFO - GECKO(2485) | 1739033931077	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 2485
[task 2025-02-08T16:58:51.077Z] 16:58:51     INFO - GECKO(2485) | 1739033931077	Marionette	TRACE	[2] MarionetteCommands actor created for window id 4
[task 2025-02-08T16:58:51.086Z] 16:58:51     INFO - GECKO(2485) | 1739033931086	RemoteAgent	TRACE	Received observer notification domwindowopened
[task 2025-02-08T16:58:51.089Z] 16:58:51     INFO - GECKO(2485) | 1739033931088	Marionette	DEBUG	1 <- [1,6,null,{"value":null}]
[task 2025-02-08T16:58:51.089Z] 16:58:51     INFO - GECKO(2485) | 1739033931089	Marionette	DEBUG	1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2025-02-08T16:58:51.090Z] 16:58:51     INFO - GECKO(2485) | 1739033931089	Marionette	DEBUG	1 <- [1,7,null,{"value":null}]
[task 2025-02-08T16:58:51.093Z] 16:58:51     INFO - GECKO(2485) | 1739033931092	Marionette	DEBUG	1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2025-02-08T16:58:51.093Z] 16:58:51     INFO - GECKO(2485) | 1739033931093	Marionette	TRACE	[2] MarionetteCommands actor destroyed for window id 4
[task 2025-02-08T16:58:51.093Z] 16:58:51     INFO - GECKO(2485) | 1739033931093	Marionette	DEBUG	1 <- [1,8,null,{"value":null}]
[task 2025-02-08T16:58:51.097Z] 16:58:51     INFO - runtests.py | Waiting for browser...
[task 2025-02-08T16:58:51.098Z] 16:58:51     INFO - GECKO(2485) | 1739033931097	Marionette	DEBUG	Closed connection 1
[task 2025-02-08T16:58:51.160Z] 16:58:51     INFO - *** Start BrowserChrome Test Results ***
[task 2025-02-08T16:58:51.191Z] 16:58:51     INFO - checking window state
[task 2025-02-08T16:58:51.222Z] 16:58:51     INFO - TEST-START | browser/components/protections/test/browser/browser_protections_lockwise.js
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.