Closed Bug 1828526 Opened 3 years ago Closed 2 years ago

Intermittent [tier 2] /css/CSS2/pagination/rowgroup-page-break-inside-avoid-6-print.html | single tracking bug

Categories

(Core :: CSS Parsing and Computation, defect, P5)

Product:
Core
Component:
CSS Parsing and Computation
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=412762347&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/YVq-N171TbqJGbJM4AF1_A/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/YVq-N171TbqJGbJM4AF1_A/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2023-04-17T20:15:26.748Z] 20:15:26     INFO - TEST-START | /css/CSS2/pagination/rowgroup-page-break-inside-avoid-6-print.html
[task 2023-04-17T20:15:26.751Z] 20:15:26     INFO - PID 4196 | 1681762526750	Marionette	INFO	Testing http://web-platform.test:8000/css/CSS2/pagination/rowgroup-page-break-inside-avoid-6-print.html == http://web-platform.test:8000/css/CSS2/pagination/rowgroup-page-break-inside-avoid-5-print-ref.html
[task 2023-04-17T20:15:26.759Z] 20:15:26     INFO - PID 4196 | [Child 6652, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (MarionetteReftest, MarionetteReftestParent:reftestWait) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-04-17T20:15:37.906Z] 20:15:37     INFO - TEST-UNEXPECTED-TIMEOUT | /css/CSS2/pagination/rowgroup-page-break-inside-avoid-6-print.html | expected PASS
[task 2023-04-17T20:15:37.906Z] 20:15:37     INFO - TEST-INFO took 11143ms
[task 2023-04-17T20:15:37.922Z] 20:15:37     INFO - PID 4196 | 1681762537929	Marionette	INFO	Stopped listening on port 52771
[task 2023-04-17T20:15:37.939Z] 20:15:37     INFO - PID 4196 | [Child 5212, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-04-17T20:15:37.939Z] 20:15:37     INFO - PID 4196 | [Child 5212, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-04-17T20:15:37.954Z] 20:15:37     INFO - PID 4196 | [Child 5212, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-04-17T20:15:37.955Z] 20:15:37     INFO - PID 4196 | [Child 5212, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-04-17T20:15:37.956Z] 20:15:37     INFO - PID 4196 | [Child 5212, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-04-17T20:15:37.959Z] 20:15:37     INFO - PID 4196 | [Child 5212, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-04-17T20:15:37.960Z] 20:15:37     INFO - PID 4196 | [Child 5212, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-04-17T20:15:46.509Z] 20:15:46     INFO - PID 4196 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-04-17T20:15:46.516Z] 20:15:46     INFO - PID 4196 |           Blocker:  Waiting for ping task
[task 2023-04-17T20:15:46.517Z] 20:15:46     INFO - PID 4196 |           Phase: TelemetryController: Waiting for pending ping activity
[task 2023-04-17T20:15:46.517Z] 20:15:46     INFO - PID 4196 |           State: (none)
[task 2023-04-17T20:15:46.519Z] 20:15:46     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-04-17T20:15:46.519Z] 20:15:46     INFO - PID 4196 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-04-17T20:15:46.520Z] 20:15:46     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-04-17T20:15:46.520Z] 20:15:46     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-04-17T20:15:46.521Z] 20:15:46     INFO - PID 4196 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-04-17T20:15:46.521Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-04-17T20:15:46.522Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-04-17T20:15:46.523Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-04-17T20:15:46.528Z] 20:15:46     INFO - PID 4196 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:859:17
[task 2023-04-17T20:15:46.528Z] 20:15:46     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:799:18
[task 2023-04-17T20:15:46.529Z] 20:15:46     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:237:30
[task 2023-04-17T20:15:46.530Z] 20:15:46     INFO - PID 4196 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:824:36
[task 2023-04-17T20:15:46.530Z] 20:15:46     INFO - PID 4196 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-04-17T20:15:46.531Z] 20:15:46     INFO - PID 4196 | console.error: "TelemetryScheduler.shutdown - Already shut down"
[task 2023-04-17T20:15:46.532Z] 20:15:46     INFO - PID 4196 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-04-17T20:15:46.532Z] 20:15:46     INFO - PID 4196 |           Blocker:  Waiting for ping task
[task 2023-04-17T20:15:46.533Z] 20:15:46     INFO - PID 4196 |           Phase: TelemetryController: Waiting for pending ping activity
[task 2023-04-17T20:15:46.533Z] 20:15:46     INFO - PID 4196 |           State: (none)
[task 2023-04-17T20:15:46.534Z] 20:15:46     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-04-17T20:15:46.535Z] 20:15:46     INFO - PID 4196 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-04-17T20:15:46.535Z] 20:15:46     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-04-17T20:15:46.536Z] 20:15:46     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-04-17T20:15:46.536Z] 20:15:46     INFO - PID 4196 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-04-17T20:15:46.537Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-04-17T20:15:46.537Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-04-17T20:15:46.538Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-04-17T20:15:46.538Z] 20:15:46     INFO - PID 4196 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:859:17
[task 2023-04-17T20:15:46.539Z] 20:15:46     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:799:18
[task 2023-04-17T20:15:46.539Z] 20:15:46     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:237:30
[task 2023-04-17T20:15:46.540Z] 20:15:46     INFO - PID 4196 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:824:36
[task 2023-04-17T20:15:46.541Z] 20:15:46     INFO - PID 4196 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-04-17T20:15:46.541Z] 20:15:46     INFO - PID 4196 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-04-17T20:15:46.542Z] 20:15:46     INFO - PID 4196 |           Blocker:  TelemetryController: shutting down
[task 2023-04-17T20:15:46.542Z] 20:15:46     INFO - PID 4196 |           Phase: profile-before-change-telemetry
[task 2023-04-17T20:15:46.543Z] 20:15:46     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-04-17T20:15:46.544Z] 20:15:46     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-04-17T20:15:46.544Z] 20:15:46     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-04-17T20:15:46.545Z] 20:15:46     INFO - PID 4196 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-04-17T20:15:46.546Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-04-17T20:15:46.546Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-04-17T20:15:46.547Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-04-17T20:15:46.547Z] 20:15:46     INFO - PID 4196 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:859:17
[task 2023-04-17T20:15:46.548Z] 20:15:46     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:799:18
[task 2023-04-17T20:15:46.548Z] 20:15:46     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:237:30
[task 2023-04-17T20:15:46.549Z] 20:15:46     INFO - PID 4196 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:824:36
[task 2023-04-17T20:15:46.549Z] 20:15:46     INFO - PID 4196 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-04-17T20:15:46.550Z] 20:15:46     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-04-17T20:15:46.550Z] 20:15:46     INFO - PID 4196 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-04-17T20:15:46.551Z] 20:15:46     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-04-17T20:15:46.551Z] 20:15:46     INFO - PID 4196 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-04-17T20:15:46.552Z] 20:15:46     INFO - PID 4196 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-04-17T20:15:46.552Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-04-17T20:15:46.553Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-04-17T20:15:46.553Z] 20:15:46     INFO - PID 4196 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-04-17T20:15:46.554Z] 20:15:46     INFO - PID 4196 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:859:17
[task 2023-04-17T20:15:46.555Z] 20:15:46     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:799:18
[task 2023-04-17T20:15:46.555Z] 20:15:46     INFO - PID 4196 | setup@resource://gre/modules/TelemetrySend.sys.mjs:237:30
[task 2023-04-17T20:15:46.557Z] 20:15:46     INFO - PID 4196 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:824:36
[task 2023-04-17T20:15:46.557Z] 20:15:46     INFO - PID 4196 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-04-17T20:15:46.906Z] 20:15:46     INFO - PID 4196 | 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-04-17T20:15:46.907Z] 20:15:46     INFO - PID 4196 | 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-04-17T20:15:46.908Z] 20:15:46     INFO - PID 4196 | 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-04-17T20:15:46.909Z] 20:15:46     INFO - PID 4196 | 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-04-17T20:15:46.910Z] 20:15:46     INFO - PID 4196 | 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-04-17T20:15:47.188Z] 20:15:47     INFO - Browser exited with return code 0
[task 2023-04-17T20:15:47.193Z] 20:15:47     INFO - Closing logging queue
[task 2023-04-17T20:15:47.194Z] 20:15:47     INFO - queue closed
[task 2023-04-17T20:15:47.236Z] 20:15:47     INFO - Application command: Z:\task_168176137391115\build\application\firefox\firefox.exe -marionette about:blank --wait-for-browser -profile C:\Users\task_168176137391115\AppData\Local\Temp\tmpd5qtn4gd
[task 2023-04-17T20:15:47.246Z] 20:15:47     INFO - PID 7992 | 1681762404683	Marionette	INFO	Marionette enabled
[task 2023-04-17T20:15:47.247Z] 20:15:47     INFO - PID 7992 | 1681762404687	Marionette	INFO	Listening on port 52772
[task 2023-04-17T20:15:47.248Z] 20:15:47     INFO - PID 7992 | console.error: "readUpdateConfig: Migration failed: " (new NotAllowedError("Could not open the file at C:\\ProgramData\\Mozilla-1de4eec8-1241-4177-a864-e594e8d1fb38\\updates\\AA6C1B139C92AAC0\\update-config.json.tmp for writing", (void 0)))
[task 2023-04-17T20:15:47.249Z] 20:15:47     INFO - PID 7992 | JavaScript error: resource://gre/modules/XULStore.sys.mjs, line 58: Error: Can't find profile directory.
[task 2023-04-17T20:15:47.250Z] 20:15:47     INFO - PID 7992 | [Child 6880, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-04-17T20:15:47.251Z] 20:15:47     INFO - PID 7992 | [Child 6880, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:57
[task 2023-04-17T20:15:47.252Z] 20:15:47     INFO - PID 7992 | [ERROR glean_core] Error setting metrics feature config: Json(Error("EOF while parsing a value", line: 1, column: 0))
[task 2023-04-17T20:15:47.253Z] 20:15:47     INFO - PID 7992 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-04-17T20:15:47.253Z] 20:15:47     INFO - PID 7992 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-04-17T20:15:47.255Z] 20:15:47     INFO - PID 7992 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-04-17T20:15:47.255Z] 20:15:47     INFO - PID 7992 | console.error: (new Error("Polling for changes failed: Unexpected content-type \"text/plain;charset=US-ASCII\".", "resource://services-settings/remote-settings.sys.mjs", 324))
[task 2023-04-17T20:15:47.256Z] 20:15:47     INFO - Starting runner
[task 2023-04-17T20:15:48.366Z] 20:15:48     INFO - TEST-START | /css/CSS2/pagination/rowgroup-page-break-inside-avoid-7-print.html

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.

Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE

Tier 1 failure: https://treeherder.mozilla.org/logviewer?job_id=436582475&repo=mozilla-central&lineNumber=2021

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.

Status: REOPENED → RESOLVED
Closed: 2 years ago → 2 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.