1776285 - Intermittent [TV-fis] editor/spellchecker/tests/test_bug1773802.html | Test timed out. -

Status: RESOLVED INCOMPLETE

(Core :: Spelling checker, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2022-06-23T19:53:28.256Z] 19:53:28     INFO - TEST-START | editor/spellchecker/tests/test_bug1773802.html
[task 2022-06-23T19:53:34.820Z] 19:53:34     INFO - GECKO(4660) | [Child 4786, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:197
[task 2022-06-23T19:58:58.256Z] 19:58:58     INFO - TEST-INFO | started process screentopng
[task 2022-06-23T19:58:58.541Z] 19:58:58     INFO - TEST-INFO | screentopng: exit 0
[task 2022-06-23T19:58:58.541Z] 19:58:58     INFO - Buffered messages logged at 19:53:29
[task 2022-06-23T19:58:58.541Z] 19:58:58     INFO - TEST-PASS | editor/spellchecker/tests/test_bug1773802.html | true expected (ru_RU directory should exist) 
[task 2022-06-23T19:58:58.541Z] 19:58:58     INFO - Buffered messages finished
[task 2022-06-23T19:58:58.542Z] 19:58:58     INFO - TEST-UNEXPECTED-FAIL | editor/spellchecker/tests/test_bug1773802.html | Test timed out. - 
[task 2022-06-23T19:58:59.263Z] 19:58:59     INFO - GECKO(4660) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2022-06-23T19:58:59.265Z] 19:58:59     INFO - GECKO(4660) | MEMORY STAT | vsize 3994MB | residentFast 1597MB | heapAllocated 1452MB
[task 2022-06-23T19:59:28.256Z] 19:59:28     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-06-23T19:59:28.257Z] 19:59:28     INFO - TEST-UNEXPECTED-FAIL | editor/spellchecker/tests/test_bug1773802.html | Test timed out. - 
[task 2022-06-23T19:59:29.257Z] 19:59:29    ERROR - TEST-UNEXPECTED-FAIL | SimpleTest | this test already called finish!
[task 2022-06-23T19:59:29.261Z] 19:59:29     INFO - TEST-UNEXPECTED-ERROR | editor/spellchecker/tests/test_bug1773802.html | called finish() multiple times
[task 2022-06-23T19:59:29.262Z] 19:59:29     INFO - TEST-INFO took 361005ms
[task 2022-06-23T19:59:44.941Z] 19:59:44     INFO - GECKO(4660) | [2022-06-23T19:59:44Z WARN  rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2022-06-23T19:59:58.257Z] 19:59:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-06-23T19:59:58.257Z] 19:59:58     INFO - TEST-UNEXPECTED-FAIL | editor/spellchecker/tests/test_bug1773802.html | Test timed out. - 
[task 2022-06-23T19:59:59.257Z] 19:59:59    ERROR - TEST-UNEXPECTED-FAIL | SimpleTest | this test already called finish!
[task 2022-06-23T19:59:59.262Z] 19:59:59     INFO - TEST-UNEXPECTED-ERROR | editor/spellchecker/tests/test_bug1773802.html | called finish() multiple times
[task 2022-06-23T19:59:59.262Z] 19:59:59     INFO - TEST-INFO 
[task 2022-06-23T20:00:28.258Z] 20:00:28     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-06-23T20:00:28.258Z] 20:00:28     INFO - TEST-UNEXPECTED-FAIL | editor/spellchecker/tests/test_bug1773802.html | Test timed out. - 
[task 2022-06-23T20:00:28.259Z] 20:00:28     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-06-23T20:00:28.260Z] 20:00:28     INFO - TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | 4 test timeouts, giving up. - 
[task 2022-06-23T20:00:28.261Z] 20:00:28     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-06-23T20:00:28.262Z] 20:00:28     INFO - TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | Skipping 1 remaining tests. - 
[task 2022-06-23T20:00:29.258Z] 20:00:29    ERROR - TEST-UNEXPECTED-FAIL | SimpleTest | this test already called finish!
[task 2022-06-23T20:00:29.263Z] 20:00:29     INFO - TEST-UNEXPECTED-ERROR | (SimpleTest/TestRunner.js) | called finish() multiple times
[task 2022-06-23T20:00:29.263Z] 20:00:29     INFO - TEST-INFO 
[task 2022-06-23T20:01:44.984Z] 20:01:44     INFO - GECKO(4660) | 1656014504983	addons.xpi	ERROR	System addon update list error Error: got node name: html, expected: updates
[task 2022-06-23T20:07:54.995Z] 20:07:54     INFO - Buffered messages finished
[task 2022-06-23T20:07:54.995Z] 20:07:54    ERROR - TEST-UNEXPECTED-TIMEOUT | (SimpleTest/TestRunner.js) (finished) | application timed out after 370 seconds with no output
[task 2022-06-23T20:07:54.995Z] 20:07:54    ERROR - Force-terminating active process(es).
[task 2022-06-23T20:07:54.995Z] 20:07:54     INFO - Determining child pids from psutil...
[task 2022-06-23T20:07:55.000Z] 20:07:55     INFO - [4727, 4751, 4784, 4786, 4788, 4864, 4895]

Comment 1

[BugBot [:suhaib / :marco/ :calixte]]

:dminor, since you are the author of the regressor, bug 1773802, could you take a look?
For more information, please visit auto_nag documentation.

Comment 2

[BugBot [:suhaib / :marco/ :calixte]]

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

Comment 3

[Dan Minor [:dminor]]

Unfortunately, the spellchecker tests are already affected by intermittents failures. The new test here was based upon an existing test.

Comment 4

[Intermittent Failures Robot]

3 failures in 3075 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• macosx1015-64-qr: 2
  • debug: 1
  • opt: 1
• linux1804-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1776285&startday=2022-06-20&endday=2022-06-26&tree=all

Comment 5

[BugBot [:suhaib / :marco/ :calixte]]

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

Comment 6

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.