Open Bug 2035726 Opened 6 months ago Updated 1 month ago

TV browser/components/preferences/tests/home/browser_homepage_firefox_home_disabled_windows_on.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout

Categories

(Firefox :: Settings UI, defect, P5)

Product:
Firefox
Component:
Settings UI
Type:
defect

Tracking

()

Tracking Flags:
Tracking Status
firefox-esr140 --- unaffected
firefox150 --- unaffected
firefox151 --- unaffected
firefox152 --- affected
firefox153 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned, NeedInfo)

References

(Regression)

Details

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

Filed by: asilaghi [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=563215965&repo=autoland&task=XVXtY61VR86HaB5gnL3s-g.0
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/XVXtY61VR86HaB5gnL3s-g/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/default/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/XVXtY61VR86HaB5gnL3s-g/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2026-04-29T04:41:36.070+00:00] 04:41:36     INFO - TEST-PASS | browser/components/preferences/tests/home/browser_homepage_firefox_home_disabled_windows_on.js | test_firefox_home_enabled_when_windows_is_home_classic - recentActivity is enabled when New windows is Firefox Home
[task 2026-04-29T04:41:36.071+00:00] 04:41:36     INFO - Leaving test test_firefox_home_enabled_when_windows_is_home_classic
[task 2026-04-29T04:41:36.071+00:00] 04:41:36     INFO - Buffered messages finished
[task 2026-04-29T04:41:36.072+00:00] 04:41:36     INFO - TEST-UNEXPECTED-FAIL | browser/components/preferences/tests/home/browser_homepage_firefox_home_disabled_windows_on.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. Test ran for 109s, limit was 90s (timeout factor 1).
[task 2026-04-29T04:41:36.073+00:00] 04:41:36     INFO - GECKO(1876) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2026-04-29T04:41:36.073+00:00] 04:41:36     INFO - GECKO(1876) | MEMORY STAT | vsize 45683MB | residentFast 445MB | heapAllocated 195MB
[task 2026-04-29T04:41:36.074+00:00] 04:41:36     INFO - checking for open sidebars
[task 2026-04-29T04:41:36.075+00:00] 04:41:36     INFO - checking window state
[task 2026-04-29T04:41:36.075+00:00] 04:41:36     INFO - Not taking screenshot here: see the one that was previously logged
[task 2026-04-29T04:41:36.076+00:00] 04:41:36     INFO - TEST-UNEXPECTED-FAIL | browser/components/preferences/tests/home/browser_homepage_firefox_home_disabled_windows_on.js | finished in 108007ms
[task 2026-04-29T04:41:36.076+00:00] 04:41:36     INFO - TEST-INFO took 108017ms
[task 2026-04-29T04:41:36.329+00:00] 04:41:36     INFO - GECKO(1876) | Completed ShutdownLeaks collections in process 1876
[task 2026-04-29T04:41:36.330+00:00] 04:41:36     INFO - TEST-START | Shutdown
<...>
[task 2026-04-29T04:54:17.861+00:00] 04:54:17     INFO - ::: Test verification summary for:
[task 2026-04-29T04:54:17.861+00:00] 04:54:17     INFO - :::
[task 2026-04-29T04:54:17.862+00:00] 04:54:17     INFO - ::: browser/components/preferences/tests/home/browser_homepage_firefox_home_disabled_tabs_on.js
[task 2026-04-29T04:54:17.862+00:00] 04:54:17     INFO - :::
[task 2026-04-29T04:54:17.863+00:00] 04:54:17     INFO - ::: 1. Run each test 10 times in one browser. : Pass
[task 2026-04-29T04:54:17.863+00:00] 04:54:17     INFO - ::: 2. Run each test 5 times in a new browser each time. : Pass
[task 2026-04-29T04:54:17.863+00:00] 04:54:17     INFO - ::: 3. Run each test 10 times in one browser, in chaos mode. : FAIL
[task 2026-04-29T04:54:17.864+00:00] 04:54:17     INFO - ::: 4. Run each test 5 times in a new browser each time, in chaos mode. : not run / incomplete
[task 2026-04-29T04:54:17.864+00:00] 04:54:17     INFO - :::
[task 2026-04-29T04:54:17.865+00:00] 04:54:17     INFO - ::: Test verification FAILED!
[task 2026-04-29T04:54:17.865+00:00] 04:54:17     INFO - :::
[task 2026-04-29T04:54:17.865+00:00] 04:54:17     INFO - Buffered messages finished
[task 2026-04-29T04:54:17.866+00:00] 04:54:17     INFO - SUITE-END | took 0s
[task 2026-04-29T04:54:17.890+00:00] 04:54:17     INFO - Return code: 0
[task 2026-04-29T04:54:17.890+00:00] 04:54:17  WARNING - Got 2 unexpected statuses
[task 2026-04-29T04:54:17.890+00:00] 04:54:17     INFO - TinderboxPrint: mochitest-mochitest-browser-chrome<br/>53/<em class="testfail">2</em>/2
[task 2026-04-29T04:54:17.891+00:00] 04:54:17  WARNING - TinderboxPrint: Per-test run of .../browser_homepage_firefox_home_disabled_tabs_on.js<br/>: WARNING
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - Per-test suites: {}
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - Per-test suites: {}
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - Running post-action listener: _package_coverage_data
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - Running post-action listener: _resource_record_post_action
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - Running post-action listener: process_java_coverage_data
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - [mozharness: 2026-04-29 04:54:17.891409Z] Finished run-tests step (success)
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - [mozharness: 2026-04-29 04:54:17.891511Z] Running uninstall step.
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - Running pre-action listener: _resource_record_pre_action
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - Running main action method: uninstall
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - Skipping uninstall for non-MSIX test
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - Running post-action listener: _resource_record_post_action
[task 2026-04-29T04:54:17.891+00:00] 04:54:17     INFO - [mozharness: 2026-04-29 04:54:17.891775Z] Finished uninstall step (success)
[task 2026-04-29T04:54:17.892+00:00] 04:54:17     INFO - Running post-run listener: _resource_record_post_run
[task 2026-04-29T04:54:18.079+00:00] 04:54:18     INFO - instance_metadata.json not found; unable to determine instance type
[task 2026-04-29T04:54:18.118+00:00] 04:54:18     INFO - Validating Perfherder data against /opt/worker/tasks/task_177743707988403/mozharness/external_tools/performance-artifact-schema.json
[task 2026-04-29T04:54:18.120+00:00] 04:54:18     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": ".overall", "extraOptions": ["e10s", "buildbot-unknown"], "subtests": [{"name": "cpu_percent", "value": 17.44002037796944}, {"name": "io_write_bytes", "value": 2158465024}, {"name": "io.read_bytes", "value": 3549818880}, {"name": "io_write_time", "value": 6130}, {"name": "io_read_time", "value": 101555}]}, {"name": ".start-pulseaudio", "subtests": [{"name": "time", "value": 0.0002157170000032238}, {"name": "cpu_percent", "value": 0}]}, {"name": ".unlock-keyring", "subtests": [{"name": "time", "value": 0.00018710599999849364}, {"name": "cpu_percent", "value": 0}]}, {"name": ".install", "subtests": [{"name": "time", "value": 28.533765887000015}, {"name": "cpu_percent", "value": 9.123998822143701}]}, {"name": ".stage-files", "subtests": [{"name": "time", "value": 0.0003969699999970544}, {"name": "cpu_percent", "value": 0}]}, {"name": ".run-tests", "subtests": [{"name": "time", "value": 1184.151884884}, {"name": "cpu_percent", "value": 17.64232363958706}]}, {"name": ".uninstall", "subtests": [{"name": "time", "value": 0.0001254720000360976}, {"name": "cpu_percent", "value": 0}]}]}
[task 2026-04-29T04:54:18.121+00:00] 04:54:18     INFO - Total resource usage - Wall time: 1213s; CPU: Can't collect data; Read bytes: 3549818880; Write bytes: 2158465024; Read time: 101555; Write time: 6130
[task 2026-04-29T04:54:18.121+00:00] 04:54:18     INFO - TinderboxPrint: I/O read bytes / time<br/>3,549,818,880 / 101,555
[task 2026-04-29T04:54:18.121+00:00] 04:54:18     INFO - TinderboxPrint: I/O write bytes / time<br/>2,158,465,024 / 6,130
[task 2026-04-29T04:54:18.121+00:00] 04:54:18     INFO - TinderboxPrint: CPU idle<br/>11,989.7 (82.5%)
[task 2026-04-29T04:54:18.121+00:00] 04:54:18     INFO - TinderboxPrint: CPU system<br/>623.5 (4.3%)
[task 2026-04-29T04:54:18.121+00:00] 04:54:18     INFO - TinderboxPrint: CPU user<br/>1,923.7 (13.2%)
[task 2026-04-29T04:54:18.121+00:00] 04:54:18     INFO - TinderboxPrint: Swap in / out<br/>516,939,776 / 0
[task 2026-04-29T04:54:18.125+00:00] 04:54:18     INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2026-04-29T04:54:18.127+00:00] 04:54:18     INFO - unlock-keyring - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0

:nina-py, since you are the author of the regressor, bug 2026456, could you take a look?

For more information, please visit BugBot documentation.

Flags: needinfo?(npypchenko)

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

status-firefox150: --- → unaffected
status-firefox151: --- → unaffected
status-firefox152: --- → affected
status-firefox-esr140: --- → unaffected

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

status-firefox153: --- → affected
You need to log in before you can comment on or make changes to this bug.