Closed Bug 1814877 Opened 3 years ago Closed 1 year ago

Intermittent /css/css-fonts/test_datafont_same_origin.html | single tracking bug

Categories

(Core :: Layout: Text and Fonts, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

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


INFO - TEST-START | /css/css-fonts/test_datafont_same_origin.html
[task 2023-02-03T10:58:59.590Z] 10:58:59     INFO - Closing window a6deac74-a25f-46fa-a8c8-69213acc8ba7
[task 2023-02-03T10:59:00.135Z] 10:59:00     INFO - PID 4196 | JavaScript error: http://web-platform.test:8000/resources/testharness.js, line 1448: uncaught exception: Error: assert_equals: Same origin font should be loaded. expected 1 but got 0
[task 2023-02-03T10:59:30.105Z] 10:59:30     INFO - 
[task 2023-02-03T10:59:30.105Z] 10:59:30     INFO - TEST-UNEXPECTED-TIMEOUT | /css/css-fonts/test_datafont_same_origin.html | Test if data:font would be treated same origin. - Test timed out
[task 2023-02-03T10:59:30.107Z] 10:59:30     INFO - TEST-UNEXPECTED-ERROR | /css/css-fonts/test_datafont_same_origin.html | uncaught exception: Error: assert_equals: Same origin font should be loaded. expected 1 but got 0
[task 2023-02-03T10:59:30.107Z] 10:59:30     INFO - document.fonts.onloadingdone@http://web-platform.test:8000/css/css-fonts/test_datafont_same_origin.html:34:20
[task 2023-02-03T10:59:30.107Z] 10:59:30     INFO - TEST-INFO took 30528ms
[task 2023-02-03T10:59:30.109Z] 10:59:30     INFO - PID 4196 | 1675421970108	Marionette	INFO	Stopped listening on port 33564
[task 2023-02-03T10:59:30.744Z] 10:59:30     INFO - PID 4196 | -----------------------------------------------------
[task 2023-02-03T10:59:30.745Z] 10:59:30     INFO - PID 4196 | Suppressions used:
[task 2023-02-03T10:59:30.746Z] 10:59:30     INFO - PID 4196 |   count      bytes template
[task 2023-02-03T10:59:30.747Z] 10:59:30     INFO - PID 4196 |       2        288 libfontconfig.so
[task 2023-02-03T10:59:30.748Z] 10:59:30     INFO - PID 4196 | -----------------------------------------------------
[task 2023-02-03T10:59:30.759Z] 10:59:30     INFO - PID 4196 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-02-03T10:59:30.759Z] 10:59:30     INFO - PID 4196 |           Blocker:  Waiting for ping task
[task 2023-02-03T10:59:30.759Z] 10:59:30     INFO - PID 4196 |           Phase: TelemetryController: Waiting for pending ping activity
[task 2023-02-03T10:59:30.759Z] 10:59:30     INFO - PID 4196 |           State: (none)
[task 2023-02-03T10:59:30.764Z] 10:59:30     INFO - PID 4196 | 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-02-03T10:59:30.765Z] 10:59:30     INFO - PID 4196 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-02-03T10:59:30.765Z] 10:59:30     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-02-03T10:59:30.765Z] 10:59:30     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-02-03T10:59:30.765Z] 10:59:30     INFO - PID 4196 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-02-03T10:59:30.765Z] 10:59:30     INFO - PID 4196 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-02-03T10:59:30.767Z] 10:59:30     INFO - PID 4196 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-02-03T10:59:30.767Z] 10:59:30     INFO - PID 4196 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-02-03T10:59:30.767Z] 10:59:30     INFO - PID 4196 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-02-03T10:59:30.767Z] 10:59:30     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-02-03T10:59:30.767Z] 10:59:30     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-02-03T10:59:30.767Z] 10:59:30     INFO - PID 4196 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2023-02-03T10:59:30.767Z] 10:59:30     INFO - PID 4196 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-02-03T10:59:30.791Z] 10:59:30     INFO - PID 4196 | -----------------------------------------------------
[task 2023-02-03T10:59:30.791Z] 10:59:30     INFO - PID 4196 | Suppressions used:
[task 2023-02-03T10:59:30.792Z] 10:59:30     INFO - PID 4196 |   count      bytes template
[task 2023-02-03T10:59:30.793Z] 10:59:30     INFO - PID 4196 |       2        288 libfontconfig.so
[task 2023-02-03T10:59:30.794Z] 10:59:30     INFO - PID 4196 | -----------------------------------------------------
[task 2023-02-03T10:59:30.795Z] 10:59:30     INFO - PID 4196 | console.error: "TelemetryScheduler.shutdown - Already shut down"
[task 2023-02-03T10:59:30.806Z] 10:59:30     INFO - PID 4196 | -----------------------------------------------------
[task 2023-02-03T10:59:30.808Z] 10:59:30     INFO - PID 4196 | Suppressions used:
INFO - PID 4196 |   count      bytes template
[task 2023-02-03T10:59:30.809Z] 10:59:30     INFO - PID 4196 |       2        288 libfontconfig.so
[task 2023-02-03T10:59:30.809Z] 10:59:30     INFO - PID 4196 | -----------------------------------------------------
[task 2023-02-03T10:59:30.822Z] 10:59:30     INFO - PID 4196 | -----------------------------------------------------
[task 2023-02-03T10:59:30.822Z] 10:59:30     INFO - PID 4196 | Suppressions used:
[task 2023-02-03T10:59:30.822Z] 10:59:30     INFO - PID 4196 |   count      bytes template
[task 2023-02-03T10:59:30.822Z] 10:59:30     INFO - PID 4196 |       2        288 libfontconfig.so
[task 2023-02-03T10:59:30.822Z] 10:59:30     INFO - PID 4196 | -----------------------------------------------------
[task 2023-02-03T10:59:30.877Z] 10:59:30     INFO - PID 4196 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-02-03T10:59:30.877Z] 10:59:30     INFO - PID 4196 |           Blocker:  Waiting for ping task
[task 2023-02-03T10:59:30.877Z] 10:59:30     INFO - PID 4196 |           Phase: TelemetryController: Waiting for pending ping activity
[task 2023-02-03T10:59:30.877Z] 10:59:30     INFO - PID 4196 |           State: (none)
[task 2023-02-03T10:59:30.881Z] 10:59:30     INFO - PID 4196 | 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-02-03T10:59:30.882Z] 10:59:30     INFO - PID 4196 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-02-03T10:59:30.883Z] 10:59:30     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-02-03T10:59:30.884Z] 10:59:30     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-02-03T10:59:30.886Z] 10:59:30     INFO - PID 4196 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-02-03T10:59:30.889Z] 10:59:30     INFO - PID 4196 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-02-03T10:59:30.889Z] 10:59:30     INFO - PID 4196 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-02-03T10:59:30.889Z] 10:59:30     INFO - PID 4196 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-02-03T10:59:30.889Z] 10:59:30     INFO - PID 4196 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-02-03T10:59:30.889Z] 10:59:30     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-02-03T10:59:30.889Z] 10:59:30     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-02-03T10:59:30.891Z] 10:59:30     INFO - PID 4196 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2023-02-03T10:59:30.891Z] 10:59:30     INFO - PID 4196 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-02-03T10:59:30.891Z] 10:59:30     INFO - PID 4196 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-02-03T10:59:30.894Z] 10:59:30     INFO - PID 4196 |           Blocker:  TelemetryController: shutting down
[task 2023-02-03T10:59:30.894Z] 10:59:30     INFO - PID 4196 |           Phase: profile-before-change-telemetry
[task 2023-02-03T10:59:30.895Z] 10:59:30     INFO - PID 4196 |           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-02-03T10:59:30.896Z] 10:59:30     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-02-03T10:59:30.897Z] 10:59:30     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-02-03T10:59:30.897Z] 10:59:30     INFO - PID 4196 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-02-03T10:59:30.898Z] 10:59:30     INFO - PID 4196 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-02-03T10:59:30.898Z] 10:59:30     INFO - PID 4196 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-02-03T10:59:30.899Z] 10:59:30     INFO - PID 4196 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-02-03T10:59:30.900Z] 10:59:30     INFO - PID 4196 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-02-03T10:59:30.901Z] 10:59:30     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-02-03T10:59:30.902Z] 10:59:30     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-02-03T10:59:30.903Z] 10:59:30     INFO - PID 4196 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2023-02-03T10:59:30.903Z] 10:59:30     INFO - PID 4196 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
<..>
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago1 year ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.