Open Bug 1951674 Opened 11 months ago Updated 11 months ago

Intermittent TV TEST-UNEXPECTED-TIMEOUT | toolkit/mozapps/extensions/test/xpcshell/test_system_upgrades.js | Test timed out

Categories

(Toolkit :: Add-ons Manager, defect, P5)

Product:
Toolkit
Component:
Add-ons Manager
Type:
defect

Tracking

()

Tracking Flags:
Tracking Status
firefox-esr128 --- unaffected
firefox136 --- unaffected
firefox137 --- unaffected
firefox138 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression, test-verify-fail)

Filed by: agoloman [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=497455060&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/QgEI_2MKQS6fJJ5IFps_Ww/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/QgEI_2MKQS6fJJ5IFps_Ww/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2025-03-04T13:02:45.114Z] 13:02:45     INFO -  TEST-PASS | xpcshell.toml:toolkit/mozapps/extensions/test/xpcshell/test_system_upgrades.js | took 11214ms
[task 2025-03-04T13:02:45.154Z] 13:02:45     INFO -  TEST-START | xpcshell.toml:toolkit/mozapps/extensions/test/xpcshell/test_system_upgrades.js
[task 2025-03-04T13:07:45.162Z] 13:07:45  WARNING -  TEST-UNEXPECTED-TIMEOUT | xpcshell.toml:toolkit/mozapps/extensions/test/xpcshell/test_system_upgrades.js | Test timed out
[task 2025-03-04T13:07:45.163Z] 13:07:45     INFO -  TEST-INFO took 300008ms
[task 2025-03-04T13:07:45.163Z] 13:07:45     INFO -  >>>>>>>
[task 2025-03-04T13:07:45.163Z] 13:07:45     INFO -  PID 7608 | DLL blocklist was unable to intercept AppInit DLLs.
[task 2025-03-04T13:07:45.164Z] 13:07:45     INFO -  PID 7608 | [Parent 7608, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp:148
[task 2025-03-04T13:07:45.164Z] 13:07:45     INFO -  PID 7608 | [Parent 7608, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp:148
[task 2025-03-04T13:07:45.165Z] 13:07:45     INFO -  PID 7608 | [Parent 7608, Main Thread] WARNING: Couldn't get the user appdata directory. Crash events may not be produced.: file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp:2922
[task 2025-03-04T13:07:45.165Z] 13:07:45     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2025-03-04T13:07:45.165Z] 13:07:45     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2025-03-04T13:07:45.165Z] 13:07:45     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2025-03-04T13:07:45.166Z] 13:07:45     INFO -  running event loop
[task 2025-03-04T13:07:45.166Z] 13:07:45     INFO -  xpcshell.toml:toolkit/mozapps/extensions/test/xpcshell/test_system_upgrades.js | Starting test_system_addon_upgrades
[task 2025-03-04T13:07:45.166Z] 13:07:45     INFO -  (xpcshell/head.js) | test test_system_addon_upgrades pending (2)
[task 2025-03-04T13:07:45.166Z] 13:07:45     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2025-03-04T13:07:45.166Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365607	addons.manager	DEBUG	Application has been upgraded"
[task 2025-03-04T13:07:45.167Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365613	addons.manager	DEBUG	Loaded provider scope for resource://gre/modules/addons/GMPProvider.sys.mjs"
[task 2025-03-04T13:07:45.167Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365615	addons.manager	DEBUG	Loaded provider scope for resource://gre/modules/addons/ModelHubProvider.sys.mjs"
[task 2025-03-04T13:07:45.167Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365619	addons.manager	DEBUG	Loaded provider scope for resource://gre/modules/addons/SitePermsAddonProvider.sys.mjs"
[task 2025-03-04T13:07:45.168Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365619	addons.manager	DEBUG	Starting provider: XPIProvider"
[task 2025-03-04T13:07:45.168Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365619	addons.xpi	DEBUG	startup"
[task 2025-03-04T13:07:45.168Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365621	addons.xpi	INFO	SystemAddonLocation directory is missing"
[task 2025-03-04T13:07:45.169Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365637	addons.xpi	INFO	Removing all system add-on upgrades."
[task 2025-03-04T13:07:45.169Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365638	addons.xpi	DEBUG	checkForChanges"
[task 2025-03-04T13:07:45.169Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365638	addons.xpi	DEBUG	Loaded add-on state: ${}"
[task 2025-03-04T13:07:45.169Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365641	addons.xpi	DEBUG	New add-on updates@test in app-system-defaults"
[task 2025-03-04T13:07:45.170Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365643	addons.xpi	DEBUG	scanForChanges changed: true, state: {}"
[task 2025-03-04T13:07:45.170Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365658	addons.xpi-utils	DEBUG	Synchronously loading the add-ons database"
[task 2025-03-04T13:07:45.170Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365659	addons.xpi-utils	DEBUG	Starting async load of XPI database C:\\Users\\task_174109150625078\\AppData\\Local\\Temp\\xpc-profile-sv1dt277\\extensions.json"
[task 2025-03-04T13:07:45.170Z] 13:07:45     INFO -  "CONSOLE_MESSAGE: (info) 1741093365666	addons.xpi-utils	DEBUG	New add-on updates@test installed in app-system-defaults"
[task 2025-03-04T13:07:45.171Z] 13:07:45     INFO -  PID 7608 | [WARN  rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2025-03-04T13:07:45.171Z] 13:07:45     INFO -  "Bootstrap method install 5 for updates@test version 1.0"
[task 2025-03-04T13:07:45.172Z] 13:07:45     INFO -  TEST-PASS | xpcshell.toml:toolkit/mozapps/extensions/test/xpcshell/test_system_upgrades.js | test_system_addon_upgrades - [test_system_addon_upgrades : 148] Should not have seen install method call for updates@test - true == true

:baku, since you are the author of the regressor, bug 1938155, could you take a look?

For more information, please visit BugBot documentation.

Flags: needinfo?(amarchesini)

Set release status flags based on info from the regressing bug 1938155

status-firefox136: --- → unaffected
status-firefox137: --- → unaffected
status-firefox138: --- → affected
status-firefox-esr128: --- → unaffected

I can work on this in case it becomes more often reproducible.

Flags: needinfo?(amarchesini)
You need to log in before you can comment on or make changes to this bug.