Closed
Bug 1747812
Opened 3 years ago
Closed 3 years ago
Intermittent [Tier 2] TEST-UNEXPECTED-TIMEOUT | /mathml/presentation-markup/fractions/frac-bar-001.html | expected PASS
Categories
(Core :: MathML, defect, P5)
Core
MathML
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: ccozmuta [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=362541460&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/SIcdoCu3QkiP28o3DGtTXg/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/SIcdoCu3QkiP28o3DGtTXg/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1
[task 2021-12-28T17:27:31.320Z] 17:27:31 INFO - TEST-START | /mathml/relations/css-styling/transform.html
[task 2021-12-28T17:27:31.324Z] 17:27:31 INFO - PID 15309 | 1640712451322 Marionette INFO Testing http://web-platform.test:8000/mathml/relations/css-styling/transform.html == http://web-platform.test:8000/mathml/relations/css-styling/transform-ref.html
[task 2021-12-28T17:27:31.534Z] 17:27:31 INFO - PID 15309 | 1640712451533 Marionette INFO No differences allowed
[task 2021-12-28T17:27:31.538Z] 17:27:31 INFO - TEST-FAIL | /mathml/relations/css-styling/transform.html | took 219ms
[task 2021-12-28T17:27:31.540Z] 17:27:31 INFO - TEST-START | /mathml/relations/css-styling/visibility-001.html
[task 2021-12-28T17:27:31.543Z] 17:27:31 INFO - PID 15309 | 1640712451542 Marionette INFO Testing http://web-platform.test:8000/mathml/relations/css-styling/visibility-001.html == http://web-platform.test:8000/mathml/relations/css-styling/visibility-001-ref.html
[task 2021-12-28T17:27:31.737Z] 17:27:31 INFO - PID 15309 | 1640712451735 Marionette INFO No differences allowed
[task 2021-12-28T17:27:31.739Z] 17:27:31 INFO - TEST-PASS | /mathml/relations/css-styling/visibility-001.html | took 200ms
[task 2021-12-28T17:27:31.741Z] 17:27:31 INFO - TEST-START | /mathml/relations/css-styling/visibility-002.html
[task 2021-12-28T17:27:31.744Z] 17:27:31 INFO - PID 15309 | 1640712451743 Marionette INFO Testing http://web-platform.test:8000/mathml/relations/css-styling/visibility-002.html == http://web-platform.test:8000/mathml/relations/css-styling/visibility-002-ref.html
[task 2021-12-28T17:27:31.946Z] 17:27:31 INFO - PID 15309 | 1640712451944 Marionette INFO No differences allowed
[task 2021-12-28T17:27:31.953Z] 17:27:31 INFO - TEST-PASS | /mathml/relations/css-styling/visibility-002.html | took 213ms
[task 2021-12-28T17:27:31.953Z] 17:27:31 INFO - TEST-START | /mathml/relations/css-styling/visibility-003.html
[task 2021-12-28T17:27:31.958Z] 17:27:31 INFO - PID 15309 | 1640712451956 Marionette INFO Testing http://web-platform.test:8000/mathml/relations/css-styling/visibility-003.html == http://web-platform.test:8000/mathml/relations/css-styling/visibility-003-ref.html
[task 2021-12-28T17:27:32.178Z] 17:27:32 INFO - PID 15309 | 1640712452177 Marionette INFO No differences allowed
[task 2021-12-28T17:27:32.181Z] 17:27:32 INFO - TEST-PASS | /mathml/relations/css-styling/visibility-003.html | took 228ms
[task 2021-12-28T17:27:32.181Z] 17:27:32 INFO - TEST-START | /mathml/relations/css-styling/visibility-004.tentative.html
[task 2021-12-28T17:27:32.184Z] 17:27:32 INFO - PID 15309 | 1640712452183 Marionette INFO Testing http://web-platform.test:8000/mathml/relations/css-styling/visibility-004.tentative.html == http://web-platform.test:8000/mathml/relations/css-styling/visibility-004.tentative-ref.html
[task 2021-12-28T17:27:32.395Z] 17:27:32 INFO - PID 15309 | 1640712452394 Marionette INFO No differences allowed
[task 2021-12-28T17:27:32.398Z] 17:27:32 INFO - TEST-PASS | /mathml/relations/css-styling/visibility-004.tentative.html | took 217ms
[task 2021-12-28T17:27:32.400Z] 17:27:32 INFO - TEST-START | /mathml/relations/css-styling/visibility-005.html
[task 2021-12-28T17:27:32.404Z] 17:27:32 INFO - PID 15309 | 1640712452401 Marionette INFO Testing http://web-platform.test:8000/mathml/relations/css-styling/visibility-005.html == http://web-platform.test:8000/mathml/relations/css-styling/visibility-005-ref.html
[task 2021-12-28T17:27:32.614Z] 17:27:32 INFO - PID 15309 | 1640712452612 Marionette INFO No differences allowed
[task 2021-12-28T17:27:32.617Z] 17:27:32 INFO - TEST-PASS | /mathml/relations/css-styling/visibility-005.html | took 218ms
[task 2021-12-28T17:27:32.617Z] 17:27:32 INFO - Restarting browser for new test group
[task 2021-12-28T17:27:32.697Z] 17:27:32 INFO - PID 15309 | JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2021-12-28T17:27:32.700Z] 17:27:32 INFO - PID 15309 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-12-28T17:27:32.700Z] 17:27:32 INFO - PID 15309 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-12-28T17:27:32.718Z] 17:27:32 INFO - PID 15309 | 1640712452717 Marionette INFO Stopped listening on port 44715
[task 2021-12-28T17:27:32.974Z] 17:27:32 INFO - PID 15309 | JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2021-12-28T17:27:32.978Z] 17:27:32 INFO - PID 15309 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-12-28T17:27:32.982Z] 17:27:32 INFO - PID 15309 | JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2021-12-28T17:27:32.985Z] 17:27:32 INFO - PID 15309 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-12-28T17:27:32.988Z] 17:27:32 INFO - PID 15309 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-12-28T17:27:32.990Z] 17:27:32 INFO - PID 15309 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-12-28T17:27:33.943Z] 17:27:33 INFO - TEST-UNEXPECTED-TIMEOUT | /mathml/presentation-markup/fractions/frac-bar-001.html | expected PASS
[task 2021-12-28T17:27:33.943Z] 17:27:33 INFO - TEST-INFO took 20330ms
[task 2021-12-28T17:27:33.977Z] 17:27:33 INFO - PID 15142 | 1640712453976 Marionette INFO Stopped listening on port 34254
[task 2021-12-28T17:27:34.218Z] 17:27:34 INFO - PID 15142 | JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2021-12-28T17:27:34.221Z] 17:27:34 INFO - PID 15142 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-12-28T17:27:34.244Z] 17:27:34 INFO - PID 15142 | JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2021-12-28T17:27:34.247Z] 17:27:34 INFO - PID 15142 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-12-28T17:27:34.249Z] 17:27:34 INFO - PID 15142 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-12-28T17:27:47.969Z] 17:27:47 INFO - PID 15309 | console.error: (new Error("SessionFile is closed", "resource:///modules/sessionstore/SessionFile.jsm", 446))
[task 2021-12-28T17:27:49.210Z] 17:27:49 INFO - PID 15142 | console.error: (new Error("SessionFile is closed", "resource:///modules/sessionstore/SessionFile.jsm", 446))
[task 2021-12-28T17:27:50.798Z] 17:27:50 INFO - PID 15309 | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"ContentParent: id=7f504aa5e800","state":{"remoteTypePrefix":"prealloc"},"filename":"/builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp","lineNumber":3509,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162"]}] Barrier: profile-before-change
[task 2021-12-28T17:27:52.049Z] 17:27:52 INFO - PID 15142 | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"ContentParent: id=7f4f94bd3000","state":{"remoteTypePrefix":"web"},"filename":"/builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp","lineNumber":3509,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162"]},{"name":"ContentParent: id=7f4f8d5d6400","state":{"remoteTypePrefix":"prealloc"},"filename":"/builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp","lineNumber":3509,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162"]}] Barrier: profile-before-change
[task 2021-12-28T17:28:02.073Z] 17:28:02 INFO - PID 15142 | JavaScript error: resource://gre/modules/CrashManager.jsm, line 895: AbortError: IOUtils: Shutting down and refusing additional I/O tasks
[task 2021-12-28T17:28:06.090Z] 17:28:06 INFO - PID 15309 | JavaScript error: resource://gre/modules/CrashManager.jsm, line 895: AbortError: IOUtils: Shutting down and refusing additional I/O tasks
[task 2021-12-28T17:28:41.799Z] 17:28:41 INFO - PID 15309 | FATAL ERROR: AsyncShutdown timeout in profile-before-change Conditions: [{"name":"ContentParent: id=7f504aa5e800","state":{"remoteTypePrefix":"prealloc"},"filename":"/builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp","lineNumber":3509,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162"]}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources.
[task 2021-12-28T17:28:41.799Z] 17:28:41 INFO - PID 15309 | [Parent 15309, Main Thread] ###!!! ABORT: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3509
[task 2021-12-28T17:28:41.803Z] 17:28:41 INFO - PID 15309 | ExceptionHandler::GenerateDump cloned child ExceptionHandler::WaitForContinueSignal waiting for continue signal...
[task 2021-12-28T17:28:41.803Z] 17:28:41 INFO - PID 15309 | 15828
[task 2021-12-28T17:28:41.804Z] 17:28:41 INFO - PID 15309 | ExceptionHandler::SendContinueSignalToChild sent continue signal to child
[task 2021-12-28T17:28:43.050Z] 17:28:43 INFO - PID 15142 | FATAL ERROR: AsyncShutdown timeout in profile-before-change Conditions: [{"name":"ContentParent: id=7f4f94bd3000","state":{"remoteTypePrefix":"web"},"filename":"/builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp","lineNumber":3509,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162"]},{"name":"ContentParent: id=7f4f8d5d6400","state":{"remoteTypePrefix":"prealloc"},"filename":"/builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp","lineNumber":3509,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162"]}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources.
[task 2021-12-28T17:28:43.050Z] 17:28:43 INFO - PID 15142 | [Parent 15142, Main Thread] ###!!! ABORT: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3509
[task 2021-12-28T17:28:43.053Z] 17:28:43 INFO - PID 15142 | ExceptionHandler::GenerateDump cloned child ExceptionHandler::WaitForContinueSignal waiting for continue signal...
[task 2021-12-28T17:28:43.054Z] 17:28:43 INFO - PID 15142 | 15829
[task 2021-12-28T17:28:43.054Z] 17:28:43 INFO - PID 15142 | ExceptionHandler::SendContinueSignalToChild sent continue signal to child
[task 2021-12-28T17:28:43.653Z] 17:28:43 INFO - Browser exited with return code 11
[task 2021-12-28T17:28:43.657Z] 17:28:43 INFO - Closing logging queue
[task 2021-12-28T17:28:43.657Z] 17:28:43 INFO - queue closed
[task 2021-12-28T17:28:43.684Z] 17:28:43 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmpizw17m67
[task 2021-12-28T17:28:43.695Z] 17:28:43 INFO - Starting runner
[task 2021-12-28T17:28:43.743Z] 17:28:43 INFO - PID 15831 | [CodeCoverage] Setting handlers for process 15831.
[task 2021-12-28T17:28:44.767Z] 17:28:44 INFO - PID 15831 | 1640712524766 Marionette INFO Marionette enabled
[task 2021-12-28T17:28:44.971Z] 17:28:44 INFO - Browser exited with return code 11
[task 2021-12-28T17:28:44.975Z] 17:28:44 INFO - Closing logging queue
[task 2021-12-28T17:28:44.978Z] 17:28:44 INFO - queue closed
[task 2021-12-28T17:28:45.021Z] 17:28:45 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmpe74s9_4s
[task 2021-12-28T17:28:45.041Z] 17:28:45 INFO - Starting runner
[task 2021-12-28T17:28:45.117Z] 17:28:45 INFO - PID 15911 | [CodeCoverage] Setting handlers for process 15911.
[task 2021-12-28T17:28:46.910Z] 17:28:46 INFO - PID 15831 | [CodeCoverage] Setting handlers for process 15974.
[task 2021-12-28T17:28:46.951Z] 17:28:46 INFO - PID 15911 | 1640712526950 Marionette INFO Marionette enabled
[task 2021-12-28T17:28:47.239Z] 17:28:47 INFO - PID 15831 | [CodeCoverage] Setting handlers for process 15980.
[task 2021-12-28T17:28:48.756Z] 17:28:48 INFO - PID 15911 | [CodeCoverage] Setting handlers for process 16065.
[task 2021-12-28T17:28:49.063Z] 17:28:49 INFO - PID 15911 | [CodeCoverage] Setting handlers for process 16068.
[task 2021-12-28T17:28:50.420Z] 17:28:50 INFO - PID 15911 | [CodeCoverage] Setting handlers for process 16111.
[task 2021-12-28T17:28:50.733Z] 17:28:50 INFO - PID 15831 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmpizw17m67/search.json.mozlz4", (void 0)))
[task 2021-12-28T17:28:52.053Z] 17:28:52 INFO - PID 15831 | [CodeCoverage] Setting handlers for process 16145.
[task 2021-12-28T17:28:52.696Z] 17:28:52 INFO - PID 15831 | 1640712532695 Marionette INFO Listening on port 38079
[task 2021-12-28T17:28:52.925Z] 17:28:52 INFO - TEST-START | /quirks/reference/percentage-height-quirk-excludes-flex-grid-002-ref.html
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•3 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•