Closed Bug 1821846 Opened 1 year ago Closed 1 year ago

Perma [tier 2] /scroll-to-text-fragment/force-load-at-top.html | single tracking bug

Categories

(Testing :: web-platform-tests, defect, P5)

Product:
Testing
Component:
web-platform-tests
Type:
defect

Tracking

(firefox-esr102 unaffected, firefox110 unaffected, firefox111 unaffected, firefox112 fixed, firefox113 fixed)

Status:
RESOLVED FIXED
Milestone:
113 Branch
Tracking Flags:
Tracking Status
firefox-esr102 --- unaffected
firefox110 --- unaffected
firefox111 --- unaffected
firefox112 --- fixed
firefox113 --- fixed

People

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

References

(Regression)

Details

(Keywords: intermittent-failure, intermittent-testcase, regression)

Attachments

(1 file)

Bug 1821846 - Mark force-load-at-top.html subtest as intermittent on mac. r=aryx,jgraham
48 bytes, text/x-phabricator-request
Details | Review

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

[task 2023-03-11T12:28:57.732Z] 12:28:57     INFO - TEST-START | /scroll-to-text-fragment/force-load-at-top.html
[task 2023-03-11T12:28:57.733Z] 12:28:57     INFO - Closing window bcbbb334-f4f4-48d0-bc6b-ddade2f96ec2
[task 2023-03-11T12:29:00.306Z] 12:29:00     INFO - 
[task 2023-03-11T12:29:00.306Z] 12:29:00     INFO - TEST-PASS | /scroll-to-text-fragment/force-load-at-top.html | force-load-at-top must block scroll on load from text fragment. 
[task 2023-03-11T12:29:00.306Z] 12:29:00     INFO - TEST-PASS | /scroll-to-text-fragment/force-load-at-top.html | force-load-at-top must block scroll on load from text fragment with element fallback. 
[task 2023-03-11T12:29:00.306Z] 12:29:00     INFO - TEST-FAIL | /scroll-to-text-fragment/force-load-at-top.html | force-load-at-top must block scroll on load from element fragment. - assert_equals: expected false but got true
[task 2023-03-11T12:29:00.306Z] 12:29:00     INFO - @http://web-platform.test:8000/scroll-to-text-fragment/force-load-at-top.html:56:20
[task 2023-03-11T12:29:00.306Z] 12:29:00     INFO - TEST-FAIL | /scroll-to-text-fragment/force-load-at-top.html | force-load-at-top must block scroll on load from history scroll restoration. - assert_equals: expected false but got true
[task 2023-03-11T12:29:00.307Z] 12:29:00     INFO - @http://web-platform.test:8000/scroll-to-text-fragment/force-load-at-top.html:56:20
[task 2023-03-11T12:29:00.307Z] 12:29:00     INFO - TEST-FAIL | /scroll-to-text-fragment/force-load-at-top.html | no-force-load-at-top must not block scroll on load from text fragment. - assert_equals: expected true but got false
[task 2023-03-11T12:29:00.307Z] 12:29:00     INFO - @http://web-platform.test:8000/scroll-to-text-fragment/force-load-at-top.html:56:20
[task 2023-03-11T12:29:00.307Z] 12:29:00     INFO - TEST-FAIL | /scroll-to-text-fragment/force-load-at-top.html | no-force-load-at-top must not block scroll on load from text fragment with element fallback. - assert_equals: expected true but got false
[task 2023-03-11T12:29:00.307Z] 12:29:00     INFO - @http://web-platform.test:8000/scroll-to-text-fragment/force-load-at-top.html:56:20
[task 2023-03-11T12:29:00.307Z] 12:29:00     INFO - TEST-PASS | /scroll-to-text-fragment/force-load-at-top.html | no-force-load-at-top must not block scroll on load from element fragment. 
[task 2023-03-11T12:29:00.307Z] 12:29:00     INFO - TEST-UNEXPECTED-TIMEOUT | /scroll-to-text-fragment/force-load-at-top.html | no-force-load-at-top must not block scroll on load from history scroll restoration. - Test timed out
[task 2023-03-11T12:29:00.307Z] 12:29:00     INFO - TEST-INFO | expected NOTRUN
[task 2023-03-11T12:29:00.308Z] 12:29:00     INFO - TEST-TIMEOUT | /scroll-to-text-fragment/force-load-at-top.html | took 2593ms
[task 2023-03-11T12:29:00.310Z] 12:29:00     INFO - PID 3015 | 1678537740308	Marionette	INFO	Stopped listening on port 54123
[task 2023-03-11T12:29:00.430Z] 12:29:00     INFO - PID 3015 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-03-11T12:29:00.431Z] 12:29:00     INFO - PID 3015 |           Blocker:  Waiting for ping task
[task 2023-03-11T12:29:00.432Z] 12:29:00     INFO - PID 3015 |           Phase: TelemetryController: Waiting for pending ping activity
[task 2023-03-11T12:29:00.433Z] 12:29:00     INFO - PID 3015 |           State: (none)
[task 2023-03-11T12:29:00.433Z] 12:29:00     INFO - PID 3015 | 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 2023-03-11T12:29:00.434Z] 12:29:00     INFO - PID 3015 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-03-11T12:29:00.435Z] 12:29:00     INFO - PID 3015 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-03-11T12:29:00.436Z] 12:29:00     INFO - PID 3015 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-03-11T12:29:00.437Z] 12:29:00     INFO - PID 3015 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-03-11T12:29:00.437Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-03-11T12:29:00.438Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-03-11T12:29:00.439Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-03-11T12:29:00.440Z] 12:29:00     INFO - PID 3015 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-03-11T12:29:00.440Z] 12:29:00     INFO - PID 3015 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-03-11T12:29:00.441Z] 12:29:00     INFO - PID 3015 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-03-11T12:29:00.442Z] 12:29:00     INFO - PID 3015 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:824:36
[task 2023-03-11T12:29:00.442Z] 12:29:00     INFO - PID 3015 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-03-11T12:29:00.443Z] 12:29:00     INFO - PID 3015 | console.error: "TelemetryScheduler.shutdown - Already shut down"
[task 2023-03-11T12:29:00.445Z] 12:29:00     INFO - PID 3015 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-03-11T12:29:00.446Z] 12:29:00     INFO - PID 3015 |           Blocker:  Waiting for ping task
[task 2023-03-11T12:29:00.447Z] 12:29:00     INFO - PID 3015 |           Phase: TelemetryController: Waiting for pending ping activity
[task 2023-03-11T12:29:00.447Z] 12:29:00     INFO - PID 3015 |           State: (none)
[task 2023-03-11T12:29:00.448Z] 12:29:00     INFO - PID 3015 | 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 2023-03-11T12:29:00.449Z] 12:29:00     INFO - PID 3015 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-03-11T12:29:00.450Z] 12:29:00     INFO - PID 3015 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-03-11T12:29:00.451Z] 12:29:00     INFO - PID 3015 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-03-11T12:29:00.452Z] 12:29:00     INFO - PID 3015 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-03-11T12:29:00.452Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-03-11T12:29:00.453Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-03-11T12:29:00.454Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-03-11T12:29:00.455Z] 12:29:00     INFO - PID 3015 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-03-11T12:29:00.456Z] 12:29:00     INFO - PID 3015 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-03-11T12:29:00.457Z] 12:29:00     INFO - PID 3015 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-03-11T12:29:00.458Z] 12:29:00     INFO - PID 3015 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:824:36
[task 2023-03-11T12:29:00.458Z] 12:29:00     INFO - PID 3015 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-03-11T12:29:00.459Z] 12:29:00     INFO - PID 3015 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-03-11T12:29:00.459Z] 12:29:00     INFO - PID 3015 |           Blocker:  TelemetryController: shutting down
[task 2023-03-11T12:29:00.460Z] 12:29:00     INFO - PID 3015 |           Phase: profile-before-change-telemetry
[task 2023-03-11T12:29:00.461Z] 12:29:00     INFO - PID 3015 |           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:727:15
[task 2023-03-11T12:29:00.462Z] 12:29:00     INFO - PID 3015 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-03-11T12:29:00.463Z] 12:29:00     INFO - PID 3015 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-03-11T12:29:00.464Z] 12:29:00     INFO - PID 3015 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-03-11T12:29:00.465Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-03-11T12:29:00.465Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-03-11T12:29:00.466Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-03-11T12:29:00.467Z] 12:29:00     INFO - PID 3015 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-03-11T12:29:00.467Z] 12:29:00     INFO - PID 3015 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-03-11T12:29:00.468Z] 12:29:00     INFO - PID 3015 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-03-11T12:29:00.469Z] 12:29:00     INFO - PID 3015 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:824:36
[task 2023-03-11T12:29:00.469Z] 12:29:00     INFO - PID 3015 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-03-11T12:29:00.470Z] 12:29:00     INFO - PID 3015 | 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 2023-03-11T12:29:00.471Z] 12:29:00     INFO - PID 3015 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-03-11T12:29:00.472Z] 12:29:00     INFO - PID 3015 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-03-11T12:29:00.472Z] 12:29:00     INFO - PID 3015 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-03-11T12:29:00.473Z] 12:29:00     INFO - PID 3015 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-03-11T12:29:00.474Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-03-11T12:29:00.474Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-03-11T12:29:00.475Z] 12:29:00     INFO - PID 3015 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-03-11T12:29:00.476Z] 12:29:00     INFO - PID 3015 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-03-11T12:29:00.477Z] 12:29:00     INFO - PID 3015 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-03-11T12:29:00.477Z] 12:29:00     INFO - PID 3015 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-03-11T12:29:00.478Z] 12:29:00     INFO - PID 3015 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:824:36
[task 2023-03-11T12:29:00.479Z] 12:29:00     INFO - PID 3015 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-03-11T12:29:00.480Z] 12:29:00     INFO - PID 3015 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 727: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-03-11T12:29:00.481Z] 12:29:00     INFO - PID 3015 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 727: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-03-11T12:29:00.481Z] 12:29:00     INFO - PID 3015 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 727: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-03-11T12:29:00.482Z] 12:29:00     INFO - PID 3015 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 727: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-03-11T12:29:00.483Z] 12:29:00     INFO - PID 3015 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 727: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-03-11T12:29:00.949Z] 12:29:00     INFO - Browser exited with return code 0
[task 2023-03-11T12:29:00.952Z] 12:29:00     INFO - Closing logging queue
[task 2023-03-11T12:29:00.953Z] 12:29:00     INFO - queue closed
[task 2023-03-11T12:29:01.038Z] 12:29:01     INFO - Application command: /opt/worker/tasks/task_167853691745890/build/application/Firefox Nightly.app/Contents/MacOS/firefox --marionette about:blank -foreground -profile /var/folders/zq/sf0yhflx4pq218pmspqvrt0h000014/T/tmpsbdmxq7i
[task 2023-03-11T12:29:01.053Z] 12:29:01     INFO - PID 3028 | 1678537723184	Marionette	INFO	Marionette enabled
[task 2023-03-11T12:29:01.053Z] 12:29:01     INFO - PID 3028 | 1678537723399	Marionette	INFO	Listening on port 54204
[task 2023-03-11T12:29:01.054Z] 12:29:01     INFO - PID 3028 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-03-11T12:29:01.055Z] 12:29:01     INFO - PID 3028 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /var/folders/zq/sf0yhflx4pq218pmspqvrt0h000014/T/tmpv2x8w5cd/search.json.mozlz4", (void 0)))
[task 2023-03-11T12:29:01.056Z] 12:29:01     INFO - PID 3028 | [ERROR glean_core] Error setting metrics feature config: Json(Error("EOF while parsing a value", line: 1, column: 0))
[task 2023-03-11T12:29:01.057Z] 12:29:01     INFO - PID 3028 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-03-11T12:29:01.058Z] 12:29:01     INFO - PID 3028 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-03-11T12:29:01.059Z] 12:29:01     INFO - PID 3028 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-03-11T12:29:01.059Z] 12:29:01     INFO - Starting runner
[task 2023-03-11T12:29:01.454Z] 12:29:01     INFO - PID 3028 | 2023-03-11 12:29:01.419 firefox[3028:87039] Persistent UI failed to open file file:///Users/cltbld/Library/Saved%20Application%20State/org.mozilla.nightly.savedState/window_1.data: No such file or directory (2)
[task 2023-03-11T12:29:01.835Z] 12:29:01     INFO - TEST-START | /scroll-to-text-fragment/idlharness.window.html
Flags: needinfo?(james)

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

status-firefox110: --- → unaffected
status-firefox111: --- → unaffected
status-firefox112: --- → affected
status-firefox-esr102: --- → unaffected
Assignee: nobody → csabou
Status: NEW → ASSIGNED
Attachment #9322616 - Attachment description: Bug 1821846 - Mark force-load-at-top.html subtest as intermittent on mac shippable. r=aryx,jgraham → Bug 1821846 - Mark force-load-at-top.html subtest as intermittent on mac. r=aryx,jgraham
Pushed by csabou@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/e78947e1a216
Mark force-load-at-top.html subtest as intermittent on mac. r=aryx

https://hg.mozilla.org/mozilla-central/rev/e78947e1a216

Status: ASSIGNED → RESOLVED
Closed: 1 year ago
status-firefox113: --- → fixed
Resolution: --- → FIXED
Target Milestone: --- → 113 Branch
Flags: needinfo?(james)
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: