Closed Bug 1814861 Opened 3 years ago Closed 2 years ago

Intermittent /performance-timeline/not-restored-reasons/performance-navigation-timing-attributes.tentative.window.html | single tracking bug

Categories

(Core :: DOM: Performance APIs, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase, Whiteboard: [retriggered])

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


INFO - TEST-START | /editing/other/typing-around-link-element-at-non-collapsed-selection.tentative.html?target=ContentEditable&child=b
[task 2023-02-03T10:49:45.020Z] 10:49:45     INFO - Closing window 9b309097-c851-483a-903d-3fc13f87a147
<..>
INFO - {'actions': [{'type': 'none', 'actions': [{'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}], 'id': '80'}, {'type': 'key', 'actions': [{'type': 'keyDown', 'value': 'X'}, {'type': 'keyUp', 'value': 'X'}], 'id': '81'}]}
[task 2023-02-03T10:49:47.380Z] 10:49:47     INFO - 
[task 2023-02-03T10:49:47.381Z] 10:49:47     INFO - TEST-UNEXPECTED-TIMEOUT | /performance-timeline/not-restored-reasons/performance-navigation-timing-attributes.tentative.window.html | RemoteContextHelper navigation using BFCache - Test timed out
[task 2023-02-03T10:49:47.381Z] 10:49:47     INFO - TEST-INFO | expected FAIL
[task 2023-02-03T10:49:47.381Z] 10:49:47     INFO - TEST-UNEXPECTED-TIMEOUT | /performance-timeline/not-restored-reasons/performance-navigation-timing-attributes.tentative.window.html | expected OK
[task 2023-02-03T10:49:47.381Z] 10:49:47     INFO - TEST-INFO took 10694ms
[task 2023-02-03T10:49:47.385Z] 10:49:47     INFO - PID 27739 | 1675421387375	Marionette	INFO	Stopped listening on port 60982
[task 2023-02-03T10:49:47.416Z] 10:49:47     INFO - {'actions': [{'type': 'none', 'actions': [{'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}], 'id': '82'}, {'type': 'key', 'actions': [{'type': 'keyDown', 'value': 'Y'}, {'type': 'keyUp', 'value': 'Y'}], 'id': '83'}]}
[task 2023-02-03T10:49:47.534Z] 10:49:47     INFO - {'actions': [{'type': 'none', 'actions': [{'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}], 'id': '84'}, {'type': 'key', 'actions': [{'type': 'keyDown', 'value': 'X'}, {'type': 'keyUp', 'value': 'X'}], 'id': '85'}]}
[task 2023-02-03T10:49:47.619Z] 10:49:47     INFO - {'actions': [{'type': 'none', 'actions': [{'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}], 'id': '86'}, {'type': 'key', 'actions': [{'type': 'keyDown', 'value': 'Y'}, {'type': 'keyUp', 'value': 'Y'}], 'id': '87'}]}
[task 2023-02-03T10:49:47.704Z] 10:49:47     INFO - {'actions': [{'type': 'none', 'actions': [{'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}], 'id': '88'}, {'type': 'key', 'actions': [{'type': 'keyDown', 'value': 'X'}, {'type': 'keyUp', 'value': 'X'}], 'id': '89'}]}
[task 2023-02-03T10:49:47.765Z] 10:49:47     INFO - {'actions': [{'type': 'none', 'actions': [{'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}], 'id': '90'}, {'type': 'key', 'actions': [{'type': 'keyDown', 'value': 'Y'}, {'type': 'keyUp', 'value': 'Y'}], 'id': '91'}]}
[task 2023-02-03T10:49:47.846Z] 10:49:47     INFO - {'actions': [{'type': 'none', 'actions': [{'type': 'pause', 'duration': 16}, {'type': 'pause', 'duration': 16}], 'id': '92'}, {'type': 'key', 'actions': [{'type': 'keyDown', 'value': 'X'}, {'type': 'keyUp', 'value': 'X'}], 'id': '93'}]}
[task 2023-02-03T10:49:47.873Z] 10:49:47     INFO - PID 27739 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-02-03T10:49:47.874Z] 10:49:47     INFO - PID 27739 |           Blocker:  Waiting for ping task
[task 2023-02-03T10:49:47.874Z] 10:49:47     INFO - PID 27739 |           Phase: TelemetryController: Waiting for pending ping activity
[task 2023-02-03T10:49:47.874Z] 10:49:47     INFO - PID 27739 |           State: (none)
[task 2023-02-03T10:49:47.875Z] 10:49:47     INFO - PID 27739 | 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:49:47.886Z] 10:49:47     INFO - PID 27739 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-02-03T10:49:47.888Z] 10:49:47     INFO - PID 27739 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-02-03T10:49:47.888Z] 10:49:47     INFO - PID 27739 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-02-03T10:49:47.890Z] 10:49:47     INFO - PID 27739 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-02-03T10:49:47.890Z] 10:49:47     INFO - PID 27739 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-02-03T10:49:47.891Z] 10:49:47     INFO - PID 27739 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-02-03T10:49:47.891Z] 10:49:47     INFO - PID 27739 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-02-03T10:49:47.892Z] 10:49:47     INFO - PID 27739 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-02-03T10:49:47.892Z] 10:49:47     INFO - PID 27739 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-02-03T10:49:47.893Z] 10:49:47     INFO - PID 27739 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-02-03T10:49:47.893Z] 10:49:47     INFO - PID 27739 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2023-02-03T10:49:47.894Z] 10:49:47     INFO - PID 27739 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-02-03T10:49:47.896Z] 10:49:47     INFO - PID 27739 | console.error: "TelemetryScheduler.shutdown - Already shut down

First occurrence so far: range of retriggers and backfills

Whiteboard: [retriggered]
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 3 years ago2 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.