Closed Bug 1695126 Opened 2 years ago Closed 2 years ago

[M-fis-xorig] Intermittent TEST-UNEXPECTED-TIMEOUT | http://mochi.test:8888/tests/testing/mochitest/tests/Harness_sanity/test_sanityEventUtils.html | application timed out after 370 seconds with no output

Categories

(Testing :: Mochitest, defect, P2)

defect

Tracking

(Fission Milestone:M8, firefox88 disabled, firefox89 disabled, firefox90 disabled, firefox91 affected)

RESOLVED WORKSFORME
Fission Milestone M8
Tracking Status
firefox88 --- disabled
firefox89 --- disabled
firefox90 --- disabled
firefox91 --- affected

People

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

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure)

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


[task 2021-02-26T04:52:13.958Z] 04:52:13     INFO - TEST-START | http://mochi.test:8888/tests/testing/mochitest/tests/Harness_sanity/test_sanityEventUtils.html
[task 2021-02-26T04:52:13.974Z] 04:52:13     INFO - GECKO(26729) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-26T04:52:14.216Z] 04:52:14     INFO - GECKO(26729) | [Child 27376, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3365
[task 2021-02-26T04:52:14.297Z] 04:52:14     INFO - GECKO(26729) | [Child 27376, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4380
[task 2021-02-26T04:52:15.268Z] 04:52:15     INFO - GECKO(26729) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpuFZ0Lj.mozrunner/runtests_leaks_tab_pid27491.log
[task 2021-02-26T04:52:15.269Z] 04:52:15     INFO - GECKO(26729) | [27491, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:251
[task 2021-02-26T04:52:15.330Z] 04:52:15     INFO - GECKO(26729) | [Child 27491, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:619
[task 2021-02-26T04:57:15.472Z] 04:57:15     INFO - GECKO(26729) | JavaScript error: http://mochi.xorigin-test:8888/tests/SimpleTest/TestRunner.js, line 167: SecurityError: Permission denied to access property "wrappedJSObject" on cross-origin object
[task 2021-02-26T05:00:07.853Z] 05:00:07     INFO - GECKO(26729) | 1614315607842	addons.xpi	ERROR	System addon update list error Error: got node name: html, expected: updates
[task 2021-02-26T05:06:17.855Z] 05:06:17     INFO - Buffered messages logged at 04:52:14
[task 2021-02-26T05:06:17.855Z] 05:06:17     INFO - 
[task 2021-02-26T05:06:17.856Z] 05:06:17     INFO - Profile::EventUtilsLoadTime: 18
[task 2021-02-26T05:06:17.857Z] 05:06:17     INFO - 
[task 2021-02-26T05:06:17.857Z] 05:06:17     INFO - TEST-PASS | testing/mochitest/tests/Harness_sanity/test_sanityEventUtils.html | sendMouseEvent should dispatch click event 
[task 2021-02-26T05:06:17.858Z] 05:06:17     INFO - testSynthesizeNativeMouseEvent: sending native mouse click (ShiftLeft)
[task 2021-02-26T05:06:17.859Z] 05:06:17     INFO - Buffered messages finished
[task 2021-02-26T05:06:17.861Z] 05:06:17    ERROR - TEST-UNEXPECTED-TIMEOUT | http://mochi.test:8888/tests/testing/mochitest/tests/Harness_sanity/test_sanityEventUtils.html | application timed out after 370 seconds with no output
[task 2021-02-26T05:06:17.861Z] 05:06:17    ERROR - Force-terminating active process(es).```

ahal hit this test failure when trying to enable mochitest-plain in fission-xorigin mode on more platforms in bug 1694835:

https://treeherder.mozilla.org/jobs?repo=try&revision=a4813c46eff128482994870bf8a06677022cee24&selectedTaskRun=C1y16x7yRSywNzYI9tB75Q.0

Though it looks like this is not a new Fission regression because this mochitests-plain fissin-xorigin test failure is already getting hit intermittently on central (comment 0):

https://treeherder.mozilla.org/jobs?repo=mozilla-central&revision=b556a43111afaa5979aab482dbeb8329698c3bda&selectedJob=331293819

Fission Milestone: --- → M7a
Summary: Intermittent TEST-UNEXPECTED-TIMEOUT | http://mochi.test:8888/tests/testing/mochitest/tests/Harness_sanity/test_sanityEventUtils.html | application timed out after 370 seconds with no output → [M-fis-xorig] Intermittent TEST-UNEXPECTED-TIMEOUT | http://mochi.test:8888/tests/testing/mochitest/tests/Harness_sanity/test_sanityEventUtils.html | application timed out after 370 seconds with no output
Priority: P5 → P3
Fission Milestone: M7a → M8
Flags: needinfo?(hsivonen)

I see comments "focus trick enables us to run this in iframes". I should probably look at those parts first.

(In reply to Henri Sivonen (:hsivonen) from comment #7)

I see comments "focus trick enables us to run this in iframes". I should probably look at those parts first.

Henri, I'm tentatively assigning this bug to you since your comment above says this test failure might be a focus issue.

This bug is blocking bug 1700781 to enable mochitest-plain for Fission+xorigin mode on more platforms. If this bug looks like a lot of work, we can add a skip-if = fission annotation for this test_sanityEventUtils.html test so we can enable all the other xorigin tests sooner in bug 1700781.

Assignee: nobody → hsivonen
Priority: P3 → P2

We haven't seen this test fail in almost two months. When it used to fail 2–3 months ago, it failed about 7–14 times per week. If you can't reproduce this failure locally, then we can probably close this bug as WORKSFORME.

We currently run this test only on linux1804-64/debug on autoland, so we might see failures again when we enable the test on Windows, macOS, and Linux ASan/TSan in bug 1700781.

No recent treeherder failures. Can't repro locally. (Tried the whole directory multiple times.)

Marking WFM.

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