Closed Bug 1818843 Opened 2 years ago Closed 2 years ago

Intermittent toolkit/modules/tests/xpcshell/test_FinderIterator.js | single tracking bug

Categories

(Toolkit :: Find Toolbar, defect, P5)

defect

Tracking

()

RESOLVED FIXED
112 Branch
Tracking Status
firefox-esr102 --- unaffected
firefox110 --- unaffected
firefox111 --- unaffected
firefox112 --- fixed

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, intermittent-testcase, regression, Whiteboard: [retriggered])

Filed by: nerli [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=406893205&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/JXq8OU1ZStWskOtByvrc1w/runs/0/artifacts/public/logs/live_backing.log


[task 2023-02-24T23:37:29.384Z] 23:37:29     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2023-02-24T23:37:29.384Z] 23:37:29     INFO -  running event loop
[task 2023-02-24T23:37:29.385Z] 23:37:29     INFO -  toolkit/modules/tests/xpcshell/test_FinderIterator.js | Starting test_start
[task 2023-02-24T23:37:29.385Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_start pending (2)
[task 2023-02-24T23:37:29.385Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (2)
Duplicate of this bug: 1818844

Hi Justin! Can you please take a look at this? This seems to be regressed by your recent changes from Bug 1770658.
Backfill range and retriggers

Flags: needinfo?(jlink)

Log snippet for the failure:

[task 2023-02-24T23:37:28.563Z] 23:37:28     INFO -  TEST-START | toolkit/modules/tests/xpcshell/test_FinderIterator.js
[task 2023-02-24T23:37:29.383Z] 23:37:29  WARNING -  TEST-UNEXPECTED-FAIL | toolkit/modules/tests/xpcshell/test_FinderIterator.js | xpcshell return code: 0
[task 2023-02-24T23:37:29.384Z] 23:37:29     INFO -  TEST-INFO took 820ms
[task 2023-02-24T23:37:29.384Z] 23:37:29     INFO -  >>>>>>>
[task 2023-02-24T23:37:29.384Z] 23:37:29     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2023-02-24T23:37:29.384Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2023-02-24T23:37:29.384Z] 23:37:29     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2023-02-24T23:37:29.384Z] 23:37:29     INFO -  running event loop
[task 2023-02-24T23:37:29.385Z] 23:37:29     INFO -  toolkit/modules/tests/xpcshell/test_FinderIterator.js | Starting test_start
[task 2023-02-24T23:37:29.385Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_start pending (2)
[task 2023-02-24T23:37:29.385Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2023-02-24T23:37:29.385Z] 23:37:29     INFO -  PID 5944 | console.error: "FinderIterator Error: " (new TypeError("listener[callback] is not a function", "resource://gre/modules/FinderIterator.sys.mjs", 364))
[task 2023-02-24T23:37:29.385Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_start - [test_start : 58] Text content should match - "test" == "test"
[task 2023-02-24T23:37:29.386Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_start - [test_start : 58] Text content should match - "test" == "test"
[task 2023-02-24T23:37:29.386Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_start - [test_start : 58] Text content should match - "test" == "test"
<...>
[task 2023-02-24T23:37:29.469Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_start - [test_start : 58] Text content should match - "test" == "test"
[task 2023-02-24T23:37:29.469Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_start - [test_start : 65] Amount of ranges yielded should match! - 300 == 300
[task 2023-02-24T23:37:29.470Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_start - [test_start : 66] Running state should match - true == true
[task 2023-02-24T23:37:29.470Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_start - [test_start : 67] Ranges cache should match - 300 == 300
[task 2023-02-24T23:37:29.470Z] 23:37:29     INFO -  PID 5944 | console.error: "FinderIterator Error: " (new TypeError("listener[callback] is not a function", "resource://gre/modules/FinderIterator.sys.mjs", 364))
[task 2023-02-24T23:37:29.470Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 1 pending (2)
[task 2023-02-24T23:37:29.471Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_start finished (2)
[task 2023-02-24T23:37:29.471Z] 23:37:29     INFO -  toolkit/modules/tests/xpcshell/test_FinderIterator.js | Starting test_subframes
[task 2023-02-24T23:37:29.471Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_subframes pending (2)
[task 2023-02-24T23:37:29.471Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 1 finished (2)
[task 2023-02-24T23:37:29.471Z] 23:37:29     INFO -  PID 5944 | console.error: "FinderIterator Error: " (new TypeError("listener[callback] is not a function", "resource://gre/modules/FinderIterator.sys.mjs", 364))
[task 2023-02-24T23:37:29.472Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_subframes - [test_subframes : 89] Text content should match - "test" == "test"
[task 2023-02-24T23:37:29.472Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_subframes - [test_subframes : 89] Text content should match - "test" == "test"
[task 2023-02-24T23:37:29.472Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_subframes - [test_subframes : 89] Text content should match - "test" == "test"
[task 2023-02-24T23:37:29.473Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_subframes - [test_subframes : 89] Text content should match - "test" == "test"
[task 2023-02-24T23:37:29.473Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_subframes - [test_subframes : 89] Text content should match - "test" == "test"
[task 2023-02-24T23:37:29.473Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_subframes - [test_subframes : 89] Text content should match - "test" == "test"
<...>
[task 2023-02-24T23:37:29.557Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_subframes - [test_subframes : 98] Running state should match - true == true
[task 2023-02-24T23:37:29.558Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_subframes - [test_subframes : 99] Ranges cache should match - 300 == 300
[task 2023-02-24T23:37:29.558Z] 23:37:29     INFO -  PID 5944 | console.error: "FinderIterator Error: " (new TypeError("listener[callback] is not a function", "resource://gre/modules/FinderIterator.sys.mjs", 364))
[task 2023-02-24T23:37:29.558Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 2 pending (2)
[task 2023-02-24T23:37:29.558Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_subframes finished (2)
[task 2023-02-24T23:37:29.559Z] 23:37:29     INFO -  toolkit/modules/tests/xpcshell/test_FinderIterator.js | Starting test_valid_arguments
[task 2023-02-24T23:37:29.559Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_valid_arguments pending (2)
[task 2023-02-24T23:37:29.559Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 2 finished (2)
[task 2023-02-24T23:37:29.559Z] 23:37:29     INFO -  PID 5944 | console.error: "FinderIterator Error: " (new TypeError("listener[callback] is not a function", "resource://gre/modules/FinderIterator.sys.mjs", 364))
[task 2023-02-24T23:37:29.560Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_valid_arguments - [test_valid_arguments : 129] Default for linksOnly is false - true == true
[task 2023-02-24T23:37:29.560Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_valid_arguments - [test_valid_arguments : 130] Default for useCache is false - true == true
[task 2023-02-24T23:37:29.560Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_valid_arguments - [test_valid_arguments : 131] Words should match - "foo" == "foo"
[task 2023-02-24T23:37:29.560Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_valid_arguments - [test_valid_arguments : 134] . Should throw when missing an argument
[task 2023-02-24T23:37:29.561Z] 23:37:29     INFO -  PID 5944 | console.error: "FinderIterator Error: " (new TypeError("listener[callback] is not a function", "resource://gre/modules/FinderIterator.sys.mjs", 364))
[task 2023-02-24T23:37:29.561Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_valid_arguments - [test_valid_arguments : 151] . Should throw when missing an argument
[task 2023-02-24T23:37:29.561Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_valid_arguments - [test_valid_arguments : 168] . Should throw when missing an argument
[task 2023-02-24T23:37:29.561Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_valid_arguments - [test_valid_arguments : 185] . Should throw when missing an argument
[task 2023-02-24T23:37:29.562Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_valid_arguments - [test_valid_arguments : 203] . Should throw when missing an argument
[task 2023-02-24T23:37:29.562Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_valid_arguments - [test_valid_arguments : 217] . Should throw when missing an argument
[task 2023-02-24T23:37:29.562Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_valid_arguments - [test_valid_arguments : 235] No ranges should've been counted - 0 == 0
[task 2023-02-24T23:37:29.563Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 3 pending (2)
[task 2023-02-24T23:37:29.563Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_valid_arguments finished (2)
[task 2023-02-24T23:37:29.563Z] 23:37:29     INFO -  toolkit/modules/tests/xpcshell/test_FinderIterator.js | Starting test_stop
[task 2023-02-24T23:37:29.563Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_stop pending (2)
[task 2023-02-24T23:37:29.563Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 3 finished (2)
[task 2023-02-24T23:37:29.564Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_stop - [test_stop : 261] Number of ranges should be 0 - 0 == 0
[task 2023-02-24T23:37:29.564Z] 23:37:29     INFO -  PID 5944 | console.error: "FinderIterator Error: " (new TypeError("listener[callback] is not a function", "resource://gre/modules/FinderIterator.sys.mjs", 364))
[task 2023-02-24T23:37:29.564Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 4 pending (2)
[task 2023-02-24T23:37:29.564Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_stop finished (2)
[task 2023-02-24T23:37:29.565Z] 23:37:29     INFO -  toolkit/modules/tests/xpcshell/test_FinderIterator.js | Starting test_reset
[task 2023-02-24T23:37:29.565Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_reset pending (2)
[task 2023-02-24T23:37:29.565Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_reset - [test_reset : 285] Yup, running we are - true == true
[task 2023-02-24T23:37:29.565Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_reset - [test_reset : 286] Number of ranges should match 0 - 0 == 0
[task 2023-02-24T23:37:29.566Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_reset - [test_reset : 287] Number of ranges should match 0 - 0 == 0
[task 2023-02-24T23:37:29.566Z] 23:37:29     INFO -  PID 5944 | console.error: "FinderIterator Error: " (new TypeError("listener[callback] is not a function", "resource://gre/modules/FinderIterator.sys.mjs", 364))
[task 2023-02-24T23:37:29.566Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_reset - [test_reset : 295] Nope, running we are not - true == true
[task 2023-02-24T23:37:29.566Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_reset - [test_reset : 296] No ranges after reset - 0 == 0
[task 2023-02-24T23:37:29.567Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_reset - [test_reset : 297] No ranges after reset - 0 == 0
[task 2023-02-24T23:37:29.567Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 4 finished (2)
[task 2023-02-24T23:37:29.567Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_reset - [test_reset : 305] Number of ranges should match 0 - 0 == 0
[task 2023-02-24T23:37:29.567Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 5 pending (2)
[task 2023-02-24T23:37:29.568Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_reset finished (2)
[task 2023-02-24T23:37:29.568Z] 23:37:29     INFO -  toolkit/modules/tests/xpcshell/test_FinderIterator.js | Starting test_parallel_starts
[task 2023-02-24T23:37:29.568Z] 23:37:29     INFO -  (xpcshell/head.js) | test test_parallel_starts pending (2)
[task 2023-02-24T23:37:29.568Z] 23:37:29     INFO -  (xpcshell/head.js) | test run_next_test 5 finished (2)
[task 2023-02-24T23:37:29.569Z] 23:37:29     INFO -  PID 5944 | console.error: "FinderIterator Error: " (new TypeError("listener[callback] is not a function", "resource://gre/modules/FinderIterator.sys.mjs", 364))
[task 2023-02-24T23:37:29.569Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_parallel_starts - [test_parallel_starts : 329] We ought to be running here - true == true
[task 2023-02-24T23:37:29.569Z] 23:37:29     INFO -  PID 5944 | console.error: "FinderIterator Error: " (new TypeError("listener[callback] is not a function", "resource://gre/modules/FinderIterator.sys.mjs", 364))
[task 2023-02-24T23:37:29.569Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_parallel_starts - [test_parallel_starts : 349] Stop means stop - true == true
[task 2023-02-24T23:37:29.570Z] 23:37:29     INFO -  TEST-PASS | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_parallel_starts - [test_parallel_starts : 354] At least one range should've been found - 2143 > 100
[task 2023-02-24T23:37:29.570Z] 23:37:29  WARNING -  TEST-UNEXPECTED-FAIL | toolkit/modules/tests/xpcshell/test_FinderIterator.js | test_parallel_starts - [test_parallel_starts : 359] Not all ranges should've been found - 2143 < 2143
[task 2023-02-24T23:37:29.570Z] 23:37:29     INFO -  /opt/worker/tasks/task_167728085325058/build/tests/xpcshell/tests/toolkit/modules/tests/xpcshell/test_FinderIterator.js:test_parallel_starts:359
[task 2023-02-24T23:37:29.570Z] 23:37:29     INFO -  /opt/worker/tasks/task_167728085325058/build/tests/xpcshell/head.js:_do_main:238
[task 2023-02-24T23:37:29.571Z] 23:37:29     INFO -  /opt/worker/tasks/task_167728085325058/build/tests/xpcshell/head.js:_execute_test:585
[task 2023-02-24T23:37:29.571Z] 23:37:29     INFO -  -e:null:1
[task 2023-02-24T23:37:29.571Z] 23:37:29     INFO -  exiting test
[task 2023-02-24T23:37:29.571Z] 23:37:29     INFO -  Unexpected exception NS_ERROR_ABORT:
[task 2023-02-24T23:37:29.571Z] 23:37:29     INFO -  _abort_failed_test@/opt/worker/tasks/task_167728085325058/build/tests/xpcshell/head.js:863:20
[task 2023-02-24T23:37:29.572Z] 23:37:29     INFO -  do_report_result@/opt/worker/tasks/task_167728085325058/build/tests/xpcshell/head.js:964:5
[task 2023-02-24T23:37:29.572Z] 23:37:29     INFO -  Assert<@/opt/worker/tasks/task_167728085325058/build/tests/xpcshell/head.js:71:21
[task 2023-02-24T23:37:29.572Z] 23:37:29     INFO -  Assert.prototype.report@resource://testing-common/Assert.sys.mjs:240:10
[task 2023-02-24T23:37:29.572Z] 23:37:29     INFO -  compareNumbers@resource://testing-common/Assert.sys.mjs:546:10
[task 2023-02-24T23:37:29.572Z] 23:37:29     INFO -  less@resource://testing-common/Assert.sys.mjs:601:18
[task 2023-02-24T23:37:29.573Z] 23:37:29     INFO -  test_parallel_starts@/opt/worker/tasks/task_167728085325058/build/tests/xpcshell/tests/toolkit/modules/tests/xpcshell/test_FinderIterator.js:359:10
[task 2023-02-24T23:37:29.573Z] 23:37:29     INFO -  _do_main@/opt/worker/tasks/task_167728085325058/build/tests/xpcshell/head.js:238:6
[task 2023-02-24T23:37:29.573Z] 23:37:29     INFO -  _execute_test@/opt/worker/tasks/task_167728085325058/build/tests/xpcshell/head.js:585:5
[task 2023-02-24T23:37:29.573Z] 23:37:29     INFO -  @-e:1:1
[task 2023-02-24T23:37:29.573Z] 23:37:29     INFO -  exiting test
[task 2023-02-24T23:37:29.573Z] 23:37:29     INFO -  <<<<<<<
[task 2023-02-24T23:37:29.574Z] 23:37:29     INFO -  TEST-START | netwerk/test/unit/test_altsvc_http3.js
Keywords: regression
Regressed by: 1770658
Whiteboard: [retriggered]

This is now fixed by backout of Bug 1770658. Backout link: https://hg.mozilla.org/integration/autoland/rev/5993cfba79ab5a154d48c6a1b02c5374fb7aa33e
Still, please take a look at this before re-landing Bug 1770658.

Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → FIXED
Flags: needinfo?(jlink)
Target Milestone: --- → 112 Branch
You need to log in before you can comment on or make changes to this bug.