Push with failures:https://treeherder.mozilla.org/jobs?repo=mozilla-central&group_state=expanded&selectedTaskRun=V_Ec0ol3QZyB2Ywcl5_LJg.0&revision=c03e05cad1390acfdb74e1085503396522b8cbbb&searchStr=linux%2C18.04%2Cx64%2Cwebrender%2Cshippable%2Copt%2Cweb%2Cplatform%2Ctests%2Ctest-linux1804-64-shippable-qr%2Fopt-web-platform-tests%2Cwpt7
Failure log: https://treeherder.mozilla.org/logviewer?job_id=400769434&repo=mozilla-central&lineNumber=18052
[task 2022-12-26T17:57:07.681Z] 17:57:07 INFO - TEST-START | /uievents/mouse/mouseenter-mouseleave-on-drag.html
[task 2022-12-26T17:57:07.684Z] 17:57:07 INFO - Closing window 0ea81535-0fd1-465b-accf-096356a580cd
[task 2022-12-26T17:57:07.943Z] 17:57:07 INFO - {'actions': [{'type': 'none', 'actions': [{'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}], 'id': '0'}, {'type': 'pointer', 'actions': [{'type': 'pointerMove', 'x': 110, 'y': 150, 'origin': 'viewport'}, {'type': 'pointerDown', 'button': 0}, {'type': 'pointerMove', 'x': 190, 'y': 150, 'origin': 'viewport'}, {'type': 'pointerUp', 'button': 0}, {'type': 'pointerMove', 'x': 0, 'y': 0, 'origin': 'viewport'}], 'parameters': {'pointerType': 'mouse'}, 'id': '1'}]}
[task 2022-12-26T17:57:08.123Z] 17:57:08 INFO - {'actions': [{'type': 'none', 'actions': [{'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}], 'id': '2'}, {'type': 'pointer', 'actions': [{'type': 'pointerMove', 'x': 110, 'y': 150, 'origin': 'viewport'}, {'type': 'pointerDown', 'button': 0}, {'type': 'pointerMove', 'x': 140, 'y': 150, 'origin': 'viewport'}, {'type': 'pointerUp', 'button': 0}, {'type': 'pointerMove', 'x': 0, 'y': 0, 'origin': 'viewport'}], 'parameters': {'pointerType': 'mouse'}, 'id': '3'}]}
[task 2022-12-26T17:57:08.275Z] 17:57:08 INFO - {'actions': [{'type': 'none', 'actions': [{'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}], 'id': '4'}, {'type': 'pointer', 'actions': [{'type': 'pointerMove', 'x': 140, 'y': 150, 'origin': 'viewport'}, {'type': 'pointerDown', 'button': 0}, {'type': 'pointerMove', 'x': 180, 'y': 150, 'origin': 'viewport'}, {'type': 'pointerUp', 'button': 0}, {'type': 'pointerMove', 'x': 0, 'y': 0, 'origin': 'viewport'}], 'parameters': {'pointerType': 'mouse'}, 'id': '5'}]}
[task 2022-12-26T17:57:08.383Z] 17:57:08 INFO -
[task 2022-12-26T17:57:08.383Z] 17:57:08 INFO - TEST-UNEXPECTED-FAIL | /uievents/mouse/mouseenter-mouseleave-on-drag.html | Test dragging across inner div - assert_equals: Drag across outer element: Event mismatch expected "mousemove@outer" but got "mouseout@outer"
[task 2022-12-26T17:57:08.383Z] 17:57:08 INFO - assert_next_events@http://web-platform.test:8000/uievents/mouse/mouseenter-mouseleave-on-drag.html:48:18
[task 2022-12-26T17:57:08.383Z] 17:57:08 INFO - window.onload/<@http://web-platform.test:8000/uievents/mouse/mouseenter-mouseleave-on-drag.html:126:23
[task 2022-12-26T17:57:08.386Z] 17:57:08 INFO -
[task 2022-12-26T17:57:08.386Z] 17:57:08 INFO - TEST-UNEXPECTED-FAIL | /uievents/mouse/mouseenter-mouseleave-on-drag.html | Test dragging into inner div - assert_equals: Move over outer element: Event mismatch expected "mouseover@outer" but got "mouseleave@outer"
[task 2022-12-26T17:57:08.386Z] 17:57:08 INFO - assert_next_events@http://web-platform.test:8000/uievents/mouse/mouseenter-mouseleave-on-drag.html:48:18
[task 2022-12-26T17:57:08.386Z] 17:57:08 INFO - window.onload/<@http://web-platform.test:8000/uievents/mouse/mouseenter-mouseleave-on-drag.html:146:23
[task 2022-12-26T17:57:08.386Z] 17:57:08 INFO -
[task 2022-12-26T17:57:08.386Z] 17:57:08 INFO - TEST-UNEXPECTED-FAIL | /uievents/mouse/mouseenter-mouseleave-on-drag.html | Test dragging out of inner div - assert_equals: Move over inner element: Event mismatch expected "mouseover@inner" but got "mouseover@outer"
[task 2022-12-26T17:57:08.387Z] 17:57:08 INFO - assert_next_events@http://web-platform.test:8000/uievents/mouse/mouseenter-mouseleave-on-drag.html:48:18
[task 2022-12-26T17:57:08.387Z] 17:57:08 INFO - window.onload/<@http://web-platform.test:8000/uievents/mouse/mouseenter-mouseleave-on-drag.html:173:23
[task 2022-12-26T17:57:08.388Z] 17:57:08 INFO - TEST-OK | /uievents/mouse/mouseenter-mouseleave-on-drag.html | took 704ms
[task 2022-12-26T17:57:08.389Z] 17:57:08 INFO - PID 24777 | 1672077428384 Marionette INFO Stopped listening on port 51266
[task 2022-12-26T17:57:08.594Z] 17:57:08 INFO - PID 24777 | WARNING: A blocker encountered an error while we were waiting.
[task 2022-12-26T17:57:08.594Z] 17:57:08 INFO - PID 24777 | Blocker: Waiting for ping task
[task 2022-12-26T17:57:08.594Z] 17:57:08 INFO - PID 24777 | Phase: TelemetryController: Waiting for pending ping activity
[task 2022-12-26T17:57:08.594Z] 17:57:08 INFO - PID 24777 | State: (none)
[task 2022-12-26T17:57:08.595Z] 17:57:08 INFO - PID 24777 | WARNING: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2022-12-26T17:57:08.595Z] 17:57:08 INFO - PID 24777 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:712:15
[task 2022-12-26T17:57:08.595Z] 17:57:08 INFO - PID 24777 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:517:26
[task 2022-12-26T17:57:08.595Z] 17:57:08 INFO - PID 24777 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:456:15
[task 2022-12-26T17:57:08.595Z] 17:57:08 INFO - PID 24777 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2022-12-26T17:57:08.595Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2022-12-26T17:57:08.595Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/osfile.jsm:12:30
[task 2022-12-26T17:57:08.595Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2022-12-26T17:57:08.595Z] 17:57:08 INFO - PID 24777 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2022-12-26T17:57:08.595Z] 17:57:08 INFO - PID 24777 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2022-12-26T17:57:08.596Z] 17:57:08 INFO - PID 24777 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2022-12-26T17:57:08.596Z] 17:57:08 INFO - PID 24777 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2022-12-26T17:57:08.596Z] 17:57:08 INFO - PID 24777 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:566:16
[task 2022-12-26T17:57:08.604Z] 17:57:08 INFO - PID 24777 | WARNING: A blocker encountered an error while we were waiting.
[task 2022-12-26T17:57:08.605Z] 17:57:08 INFO - PID 24777 | Blocker: Waiting for ping task
[task 2022-12-26T17:57:08.605Z] 17:57:08 INFO - PID 24777 | Phase: TelemetryController: Waiting for pending ping activity
[task 2022-12-26T17:57:08.605Z] 17:57:08 INFO - PID 24777 | State: (none)
[task 2022-12-26T17:57:08.607Z] 17:57:08 INFO - PID 24777 | WARNING: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2022-12-26T17:57:08.609Z] 17:57:08 INFO - PID 24777 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:712:15
[task 2022-12-26T17:57:08.610Z] 17:57:08 INFO - PID 24777 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:517:26
[task 2022-12-26T17:57:08.611Z] 17:57:08 INFO - PID 24777 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:456:15
[task 2022-12-26T17:57:08.612Z] 17:57:08 INFO - PID 24777 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2022-12-26T17:57:08.613Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2022-12-26T17:57:08.619Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/osfile.jsm:12:30
[task 2022-12-26T17:57:08.620Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2022-12-26T17:57:08.620Z] 17:57:08 INFO - PID 24777 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2022-12-26T17:57:08.621Z] 17:57:08 INFO - PID 24777 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2022-12-26T17:57:08.621Z] 17:57:08 INFO - PID 24777 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2022-12-26T17:57:08.622Z] 17:57:08 INFO - PID 24777 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2022-12-26T17:57:08.622Z] 17:57:08 INFO - PID 24777 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:566:16
[task 2022-12-26T17:57:08.623Z] 17:57:08 INFO - PID 24777 | WARNING: A blocker encountered an error while we were waiting.
[task 2022-12-26T17:57:08.624Z] 17:57:08 INFO - PID 24777 | Blocker: TelemetryController: shutting down
[task 2022-12-26T17:57:08.624Z] 17:57:08 INFO - PID 24777 | Phase: profile-before-change-telemetry
[task 2022-12-26T17:57:08.625Z] 17:57:08 INFO - PID 24777 | State: Error getting state: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange" at addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:712:15
[task 2022-12-26T17:57:08.625Z] 17:57:08 INFO - PID 24777 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:517:26
[task 2022-12-26T17:57:08.626Z] 17:57:08 INFO - PID 24777 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:456:15
[task 2022-12-26T17:57:08.626Z] 17:57:08 INFO - PID 24777 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2022-12-26T17:57:08.627Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2022-12-26T17:57:08.627Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/osfile.jsm:12:30
[task 2022-12-26T17:57:08.628Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2022-12-26T17:57:08.628Z] 17:57:08 INFO - PID 24777 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2022-12-26T17:57:08.629Z] 17:57:08 INFO - PID 24777 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2022-12-26T17:57:08.629Z] 17:57:08 INFO - PID 24777 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2022-12-26T17:57:08.630Z] 17:57:08 INFO - PID 24777 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2022-12-26T17:57:08.630Z] 17:57:08 INFO - PID 24777 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:566:16
[task 2022-12-26T17:57:08.631Z] 17:57:08 INFO - PID 24777 | WARNING: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2022-12-26T17:57:08.631Z] 17:57:08 INFO - PID 24777 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:712:15
[task 2022-12-26T17:57:08.632Z] 17:57:08 INFO - PID 24777 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:517:26
[task 2022-12-26T17:57:08.632Z] 17:57:08 INFO - PID 24777 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:456:15
[task 2022-12-26T17:57:08.633Z] 17:57:08 INFO - PID 24777 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2022-12-26T17:57:08.633Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2022-12-26T17:57:08.634Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/osfile.jsm:12:30
[task 2022-12-26T17:57:08.634Z] 17:57:08 INFO - PID 24777 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2022-12-26T17:57:08.635Z] 17:57:08 INFO - PID 24777 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2022-12-26T17:57:08.635Z] 17:57:08 INFO - PID 24777 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2022-12-26T17:57:08.636Z] 17:57:08 INFO - PID 24777 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2022-12-26T17:57:08.637Z] 17:57:08 INFO - PID 24777 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2022-12-26T17:57:08.637Z] 17:57:08 INFO - PID 24777 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:566:16
[task 2022-12-26T17:57:08.638Z] 17:57:08 INFO - PID 24777 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 712: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2022-12-26T17:57:08.639Z] 17:57:08 INFO - PID 24777 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 712: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2022-12-26T17:57:08.640Z] 17:57:08 INFO - PID 24777 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 712: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2022-12-26T17:57:08.641Z] 17:57:08 INFO - PID 24777 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 712: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2022-12-26T17:57:08.641Z] 17:57:08 INFO - PID 24777 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 712: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2022-12-26T17:57:08.968Z] 17:57:08 INFO - Browser exited with return code 0
[task 2022-12-26T17:57:08.971Z] 17:57:08 INFO - Closing logging queue
[task 2022-12-26T17:57:08.971Z] 17:57:08 INFO - queue closed
[task 2022-12-26T17:57:08.987Z] 17:57:08 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmp64ur9atz
[task 2022-12-26T17:57:09.009Z] 17:57:09 INFO - PID 25084 | 1672077425701 Marionette INFO Marionette enabled
[task 2022-12-26T17:57:09.010Z] 17:57:09 INFO - PID 25084 | 1672077425703 Marionette INFO Listening on port 56706
[task 2022-12-26T17:57:09.010Z] 17:57:09 INFO - PID 25084 | console.error: (new TypeError("NetworkError: Network request failed", "resource://services-settings/Utils.jsm", 237))
[task 2022-12-26T17:57:09.010Z] 17:57:09 INFO - Starting runner
[task 2022-12-26T17:57:10.291Z] 17:57:10 INFO - PID 25084 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmph8x98a6r/search.json.mozlz4", (void 0)))
[task 2022-12-26T17:57:11.451Z] 17:57:11 INFO - PID 25084 | console.error: (new TypeError("NetworkError: Network request failed", "resource://services-settings/Utils.jsm", 237))
[task 2022-12-26T17:57:11.453Z] 17:57:11 INFO - PID 25084 | console.error: (new TypeError("NetworkError: Network request failed", "resource://services-settings/Utils.jsm", 237))
[task 2022-12-26T17:57:11.453Z] 17:57:11 INFO - PID 25084 | console.error: (new TypeError("NetworkError: Network request failed", "resource://services-settings/Utils.jsm", 237))
[task 2022-12-26T17:57:11.736Z] 17:57:11 INFO - TEST-START | /uievents/mouse/mouseevent_move_button.html
[task 2022-12-26T17:57:11.987Z] 17:57:11 INFO - {'actions': [{'type': 'none', 'actions': [{'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}], 'id': '0'}, {'type': 'pointer', 'actions': [{'type': 'pointerMove', 'x': 0, 'y': 0, 'origin': {'element-6066-11e4-a52e-4f735466cecf': '0f191edf-3c59-485f-876b-b2a5cbd9a520'}}, {'type': 'pointerDown', 'button': 1}, {'type': 'pointerMove', 'x': 0, 'y': 0, 'origin': {'element-6066-11e4-a52e-4f735466cecf': '8454bb71-752c-4dce-b798-d3236c4e9a97'}}, {'type': 'pointerMove', 'x': 0, 'y': 0, 'origin': {'element-6066-11e4-a52e-4f735466cecf': 'e7c9b887-a12f-4701-a225-da3248d2f276'}}, {'type': 'pointerUp', 'button': 1}], 'parameters': {'pointerType': 'mouse'}, 'id': '1'}]}
[task 2022-12-26T17:57:12.101Z] 17:57:12 INFO - .
[task 2022-12-26T17:57:12.101Z] 17:57:12 INFO - TEST-OK | /uievents/mouse/mouseevent_move_button.html | took 365ms
[task 2022-12-26T17:57:12.103Z] 17:57:12 INFO - TEST-START | /uievents/mouse/mousemove_prevent_default_action.tentative.html
Description
•