Closed Bug 2016937 Opened 7 months ago Closed 5 months ago

Perma testAddTaskTestRejectedUndefined | expected PASS

Categories

(Testing :: XPCShell Harness, defect, P5)

defect

Tracking

(firefox152 fixed)

RESOLVED FIXED
152 Branch
Tracking Status
firefox152 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: RyanVM)

References

Details

(Keywords: intermittent-failure)

Attachments

(1 file)

Filed by: agoloman [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=548834764&repo=mozilla-central&task=PE_9SadtSyiB8yn-6oicOg.0
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/PE_9SadtSyiB8yn-6oicOg/runs/0/artifacts/public/logs/live_backing.log


[task 2026-02-14T19:11:26.913+00:00] 19:11:26     INFO - TEST-START | testDoReportForeignObject
[task 2026-02-14T19:11:26.950+00:00] 19:11:26     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_177109586373477\\AppData\\Local\\Temp\\tmpqaqpp2ae',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2026-02-14T19:11:27.050+00:00] 19:11:27     INFO - TEST-UNEXPECTED-FAIL | testAddTaskTestRejectedUndefined | expected PASS
[task 2026-02-14T19:11:27.050+00:00] 19:11:27     INFO - TEST-INFO took 35371ms
[task 2026-02-14T19:11:27.051+00:00] 19:11:27     INFO - TEST-START | testDoReportNonSyntaxError
[task 2026-02-14T19:11:27.051+00:00] 19:11:27    ERROR - FAIL: testAddTaskTestRejectedUndefined
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR -   Failure: Traceback (most recent call last):
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR -   File "D:\task_177109586373477\build\tests\xpcshell\selftest.py", line 1116, in testAddTaskTestRejectedUndefined
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR -     self.assertNotInLog("TEST-UNEXPECTED-TIMEOUT")
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR -   File "D:\task_177109586373477\build\tests\xpcshell\selftest.py", line 591, in assertNotInLog
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR -     self._assertLog(s, False)
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR -   File "D:\task_177109586373477\build\tests\xpcshell\selftest.py", line 571, in _assertLog
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR -     self.assertEqual(
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR - AssertionError: False != True : Value TEST-UNEXPECTED-TIMEOUT not expected in log:
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR - ========
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR - Using harness timeout of 30s (base=30s, factor=1.0)
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR - These variables are available in the mozinfo environment and can be used to skip tests conditionally:
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR -     apple_catalina: False
[task 2026-02-14T19:11:27.059+00:00] 19:11:27    ERROR -     apple_silicon: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     appname: firefox
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     arch: x86_64
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     artifact: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     asan: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     automation: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     bin_suffix: .exe
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     bits: 64
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     buildapp: browser
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     buildtype: ccov
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     buildtype_guess: ccov
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     cc_type: clang-cl
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     ccov: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     condprof: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     crashreporter: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     datareporting: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     dbus_enabled: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     debug: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     devedition: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     display: None
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     e10s: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     early_beta_or_earlier: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     fission: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     gecko_profiler: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     has_sandbox: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     healthreport: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     inc_origin_init: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     is_ubuntu: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     isolated_process: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     mingw: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     mozconfig: D:/task_177109073272255/build/src/.mozconfig
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     msix: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     nightly_build: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     normandy: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     official: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     opt: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     os: win
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     os_version: 11.26100
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     pgo: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     platform_guess: win64
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     processor: x86_64
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     release_or_beta: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     require_signing: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     sessionHistoryInParent: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     socketprocess_networking: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     stylo: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     sync: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     telemetry: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     tests_enabled: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     toolkit: windows
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     topobjdir: D:/task_177109073272255/workspace/obj-build
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     topsrcdir: D:/task_177109073272255/build/src
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     tsan: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     ubsan: False
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     updater: True
[task 2026-02-14T19:11:27.060+00:00] 19:11:27    ERROR -     verify: False
[task 2026-02-14T19:11:27.062+00:00] 19:11:27    ERROR -     version: 10.0.26100
[task 2026-02-14T19:11:27.062+00:00] 19:11:27    ERROR -     win10_2009: False
[task 2026-02-14T19:11:27.062+00:00] 19:11:27    ERROR -     win11_2009: False
[task 2026-02-14T19:11:27.062+00:00] 19:11:27    ERROR - Found node at D:/task_177109586373477/fetches\node/node.exe
[task 2026-02-14T19:11:27.062+00:00] 19:11:27    ERROR - Found moz-http2 at D:\task_177109586373477\build\tests\xpcshell\moz-http2\moz-http2.js
[task 2026-02-14T19:11:27.062+00:00] 19:11:27    ERROR - node moz-http2 [stderr] (node:9432) [DEP0060] DeprecationWarning: The `util._extend` API is deprecated. Please use Object.assign() instead.
[task 2026-02-14T19:11:27.062+00:00] 19:11:27    ERROR - 
[task 2026-02-14T19:11:27.062+00:00] 19:11:27    ERROR - node moz-http2 [stderr] (Use `node --trace-deprecation ...` to show where the warning was created)
[task 2026-02-14T19:11:27.062+00:00] 19:11:27    ERROR - 
[task 2026-02-14T19:11:27.062+00:00] 19:11:27    ERROR - mozserve | Found Http3Server path: D:\task_177109586373477\build\tests\xpcshell\http3server\http3server.exe
[task 2026-02-14T19:11:27.062+00:00] 19:11:27    ERROR - mozserve | cert db path: D:\task_177109586373477\build\tests\xpcshell\http3server\http3serverDB
[task 2026-02-14T19:11:27.063+00:00] 19:11:27    ERROR - mozserve | http3 server msg: HTTP3 server listening on ports 57187, 57198, 57206, 57214, 57219 and 57225. EchConfig is @AE3+DQBJBwAgACBH3/FO9Bd6+VWJDhE4Yi25K72KC5sTzx5TOOOiW+CAUAAQAAEAAQABAAMAAgABAAIAA0AOcHVibGljLmV4YW1wbGUAAA==@
[task 2026-02-14T19:11:27.063+00:00] 19:11:27    ERROR - 
[task 2026-02-14T19:11:27.063+00:00] 19:11:27    ERROR - Using at most 20 threads.
[task 2026-02-14T19:11:27.063+00:00] 19:11:27    ERROR - SUITE-START | Running 1 tests
[task 2026-02-14T19:11:27.063+00:00] 19:11:27    ERROR - profile dir is C:\Users\task_177109586373477\AppData\Local\Temp\xpc-profile-vam93eic
[task 2026-02-14T19:11:27.063+00:00] 19:11:27    ERROR - TEST-START | test_add_task_rejected_undefined.js
See Also: → 2018450
Summary: Intermittent testAddTaskTestRejectedUndefined | expected PASS → Perma testAddTaskTestRejectedUndefined | expected PASS

selftest.py: pass timeoutFactor to runTests() so the per-sub-test timeout
is not silently reset to 30s. Previously, setUp() set
self.x.harness_timeout=60 for ccov, but runTests() unconditionally
overwrites harness_timeout from HARNESS_TIMEOUT*timeoutFactor, so that
assignment had no effect.

Coverage flushing (flushCounters + IOUtils.move) before and after each
sub-test adds significant overhead on ccov builds - on Windows this
consistently pushes the sub-test past the 30s default timeout, causing
TEST-UNEXPECTED-TIMEOUT. A 1.5x factor is applied universally to
provide headroom on slow workers; ccov builds get 2.0x to account for
the extra overhead.

Assignee: nobody → ryanvm
Status: NEW → ASSIGNED
Status: ASSIGNED → RESOLVED
Closed: 5 months ago
Resolution: --- → FIXED
Target Milestone: --- → 152 Branch
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: