1806944 - Perma Wr /css/css-images/image-set/image-set <something> | single tracking bug

Status: RESOLVED FIXED

(Core :: Layout: Images, Video, and HTML Frames, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2022-12-22T03:23:18.843Z] 03:23:18     INFO - TEST-START | /css/css-images/image-set/image-set-empty-url-rendering.html
[task 2022-12-22T03:23:18.844Z] 03:23:18     INFO - PID 14114 | 1671679398818	Marionette	INFO	Testing http://web-platform.test:8000/css/css-images/image-set/image-set-empty-url-rendering.html == http://web-platform.test:8000/css/css-images/image-set/reference/image-set-rendering-ref.html
[task 2022-12-22T03:23:18.845Z] 03:23:18     INFO - PID 14114 | [Child 14351, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-22T03:23:18.937Z] 03:23:18     INFO - PID 14114 | 1671679398936	Marionette	INFO	No differences allowed
[task 2022-12-22T03:23:19.067Z] 03:23:19     INFO - TEST-UNEXPECTED-FAIL | /css/css-images/image-set/image-set-empty-url-rendering.html | Testing http://web-platform.test:8000/css/css-images/image-set/image-set-empty-url-rendering.html == http://web-platform.test:8000/css/css-images/image-set/reference/image-set-rendering-ref.html
[task 2022-12-22T03:23:19.067Z] 03:23:19     INFO - Found 10000 pixels different, maximum difference per channel 255
<...>
[task 2022-12-22T03:23:19.068Z] 03:23:19     INFO - TEST-INFO took 207ms
[task 2022-12-22T03:23:19.070Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:371
[task 2022-12-22T03:23:19.071Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2022-12-22T03:23:19.123Z] 03:23:19     INFO - PID 14114 | 1671679399122	Marionette	INFO	Stopped listening on port 46836
[task 2022-12-22T03:23:19.179Z] 03:23:19     INFO - PID 14114 | [Child 14268, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-22T03:23:19.179Z] 03:23:19     INFO - PID 14114 | [Child 14268, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-22T03:23:19.187Z] 03:23:19     INFO - PID 14114 | [Child 14268, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-22T03:23:19.194Z] 03:23:19     INFO - PID 14114 | [Child 14268, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-22T03:23:19.203Z] 03:23:19     INFO - PID 14114 | [Child 14268, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-22T03:23:19.203Z] 03:23:19     INFO - PID 14114 | [Child 14268, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-22T03:23:19.221Z] 03:23:19     INFO - PID 14114 | [Child 14268, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-22T03:23:19.224Z] 03:23:19     INFO - PID 14114 | [Child 14351, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3384
[task 2022-12-22T03:23:19.227Z] 03:23:19     INFO - PID 14114 | [Child 14351, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-12-22T03:23:19.234Z] 03:23:19     INFO - PID 14114 | [Child 14351, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4663
[task 2022-12-22T03:23:19.398Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:371
[task 2022-12-22T03:23:19.415Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2022-12-22T03:23:19.417Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2022-12-22T03:23:19.428Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2022-12-22T03:23:19.430Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2022-12-22T03:23:19.443Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:204
[task 2022-12-22T03:23:19.465Z] 03:23:19     INFO - PID 14114 | [Child 14291, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3384
[task 2022-12-22T03:23:19.468Z] 03:23:19     INFO - PID 14114 | [Child 14291, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-12-22T03:23:19.472Z] 03:23:19     INFO - PID 14114 | [Child 14291, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4663
[task 2022-12-22T03:23:19.555Z] 03:23:19     INFO - PID 14114 | [2022-12-22T03:23:19Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2022-12-22T03:23:19.555Z] 03:23:19     INFO - PID 14114 | [2022-12-22T03:23:19Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2022-12-22T03:23:19.610Z] 03:23:19     INFO - PID 14114 | [Child 14268, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3384
[task 2022-12-22T03:23:19.612Z] 03:23:19     INFO - PID 14114 | [Child 14268, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-12-22T03:23:19.622Z] 03:23:19     INFO - PID 14114 | [Child 14268, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4663
[task 2022-12-22T03:23:19.770Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2022-12-22T03:23:19.770Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Compositor] WARNING: IPC Connection Error: [Parent][PImageBridgeParent] RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2022-12-22T03:23:19.778Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2022-12-22T03:23:19.778Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2022-12-22T03:23:19.779Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Compositor] WARNING: IPC Connection Error: [Parent][PImageBridgeParent] RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2022-12-22T03:23:19.781Z] 03:23:19     INFO - PID 14114 | [Child 14528, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3384
[task 2022-12-22T03:23:19.782Z] 03:23:19     INFO - PID 14114 | [Child 14528, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-12-22T03:23:19.787Z] 03:23:19     INFO - PID 14114 | [Child 14671, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3384
[task 2022-12-22T03:23:19.788Z] 03:23:19     INFO - PID 14114 | [Child 14667, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3384
[task 2022-12-22T03:23:19.789Z] 03:23:19     INFO - PID 14114 | [Child 14671, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-12-22T03:23:19.791Z] 03:23:19     INFO - PID 14114 | [Child 14528, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4663
[task 2022-12-22T03:23:19.799Z] 03:23:19     INFO - PID 14114 | [Child 14667, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-12-22T03:23:19.802Z] 03:23:19     INFO - PID 14114 | [Child 14671, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4663
[task 2022-12-22T03:23:19.805Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: quota manager shutdown step: '0.000004s: startCrashBrowserTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.807Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: quota manager shutdown step: '0.000028s: initiateShutdownWorkThreads', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.808Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: idb: '0.000035s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.809Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: cache: '0.000043s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.809Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: sdb: '0.000049s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.810Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: fs: '0.000055s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.811Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: ls: '0.000061s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.812Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: quota manager shutdown step: '0.000068s: startKillActorsTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.813Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: idb: '0.000121s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.814Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: idb: '0.000132s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.814Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: idb: '0.000197s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.815Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: idb: '0.000205s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.816Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: idb: '0.000262s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.817Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: idb: '0.000294s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.818Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: idb: '0.000301s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.818Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: idb: '0.002704s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.819Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: idb: '0.002719s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.820Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: quota manager shutdown step: '0.006383s: stopKillActorsTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.821Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: quota manager shutdown step: '0.006400s: shutdownAndJoinWorkThreads', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.822Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: idb: '0.006405s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.823Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: cache: '0.006440s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.824Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: sdb: '0.006447s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.824Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: fs: '0.006452s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.825Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: ls: '0.006456s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.826Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: quota manager shutdown step: '0.006461s: shutdownAndJoinIOThread', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.827Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: quota manager shutdown step: '0.006629s: invalidatePendingDirectoryLocks', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.828Z] 03:23:19     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: quota manager shutdown step: '0.006639s: stopCrashBrowserTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3298
[task 2022-12-22T03:23:19.829Z] 03:23:19     INFO - PID 14114 | [Child 14667, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4663
[task 2022-12-22T03:23:19.891Z] 03:23:19     INFO - PID 14114 | WARNING: A blocker encountered an error while we were waiting.
[task 2022-12-22T03:23:19.891Z] 03:23:19     INFO - PID 14114 |           Blocker:  Waiting for ping task
[task 2022-12-22T03:23:19.892Z] 03:23:19     INFO - PID 14114 |           Phase: TelemetryController: Waiting for pending ping activity
[task 2022-12-22T03:23:19.892Z] 03:23:19     INFO - PID 14114 |           State: (none)
[task 2022-12-22T03:23:19.893Z] 03:23:19     INFO - PID 14114 | 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-22T03:23:19.893Z] 03:23:19     INFO - PID 14114 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.jsm:718:15
[task 2022-12-22T03:23:19.893Z] 03:23:19     INFO - PID 14114 | addBlocker@resource://gre/modules/AsyncShutdown.jsm:523:26
[task 2022-12-22T03:23:19.894Z] 03:23:19     INFO - PID 14114 | addBlocker@resource://gre/modules/AsyncShutdown.jsm:462:15
[task 2022-12-22T03:23:19.895Z] 03:23:19     INFO - PID 14114 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2022-12-22T03:23:19.895Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2022-12-22T03:23:19.895Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/osfile.jsm:12:30
[task 2022-12-22T03:23:19.895Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/TelemetryStorage.jsm:19:28
[task 2022-12-22T03:23:19.896Z] 03:23:19     INFO - PID 14114 | promiseArchivePing@resource://gre/modules/TelemetryArchive.jsm:103:5
[task 2022-12-22T03:23:19.896Z] 03:23:19     INFO - PID 14114 | promiseArchivePing@resource://gre/modules/TelemetryArchive.jsm:63:33
[task 2022-12-22T03:23:19.897Z] 03:23:19     INFO - PID 14114 | _submitPingLogic@resource://gre/modules/TelemetryControllerParent.jsm:540:48
[task 2022-12-22T03:23:19.897Z] 03:23:19     INFO - PID 14114 | send@resource://gre/modules/TelemetryControllerParent.jsm:628:24
[task 2022-12-22T03:23:19.898Z] 03:23:19     INFO - PID 14114 | submitExternalPing@resource://gre/modules/TelemetryControllerParent.jsm:182:17
[task 2022-12-22T03:23:19.898Z] 03:23:19     INFO - PID 14114 | sendPing@resource://gre/modules/EventPing.jsm:51:30
[task 2022-12-22T03:23:19.899Z] 03:23:19     INFO - PID 14114 | _submitPing@resource://gre/modules/EventPing.jsm:229:12
[task 2022-12-22T03:23:19.900Z] 03:23:19     INFO - PID 14114 | shutdown@resource://gre/modules/EventPing.jsm:112:10
[task 2022-12-22T03:23:19.901Z] 03:23:19     INFO - PID 14114 | _cleanupOnShutdown@resource://gre/modules/TelemetryControllerParent.jsm:940:31
[task 2022-12-22T03:23:19.902Z] 03:23:19     INFO - PID 14114 | shutdown/<@resource://gre/modules/TelemetryControllerParent.jsm:1010:24
[task 2022-12-22T03:23:19.903Z] 03:23:19     INFO - PID 14114 | observe@resource://gre/modules/AsyncShutdown.jsm:572:16
[task 2022-12-22T03:23:19.927Z] 03:23:19     INFO - PID 14114 | WARNING: A blocker encountered an error while we were waiting.
[task 2022-12-22T03:23:19.928Z] 03:23:19     INFO - PID 14114 |           Blocker:  Waiting for ping task
[task 2022-12-22T03:23:19.929Z] 03:23:19     INFO - PID 14114 |           Phase: TelemetryController: Waiting for pending ping activity
[task 2022-12-22T03:23:19.929Z] 03:23:19     INFO - PID 14114 |           State: (none)
[task 2022-12-22T03:23:19.930Z] 03:23:19     INFO - PID 14114 | 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-22T03:23:19.930Z] 03:23:19     INFO - PID 14114 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.jsm:718:15
[task 2022-12-22T03:23:19.931Z] 03:23:19     INFO - PID 14114 | addBlocker@resource://gre/modules/AsyncShutdown.jsm:523:26
[task 2022-12-22T03:23:19.932Z] 03:23:19     INFO - PID 14114 | addBlocker@resource://gre/modules/AsyncShutdown.jsm:462:15
[task 2022-12-22T03:23:19.932Z] 03:23:19     INFO - PID 14114 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2022-12-22T03:23:19.933Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2022-12-22T03:23:19.933Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/osfile.jsm:12:30
[task 2022-12-22T03:23:19.934Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/TelemetryStorage.jsm:19:28
[task 2022-12-22T03:23:19.934Z] 03:23:19     INFO - PID 14114 | promiseArchivePing@resource://gre/modules/TelemetryArchive.jsm:103:5
[task 2022-12-22T03:23:19.935Z] 03:23:19     INFO - PID 14114 | promiseArchivePing@resource://gre/modules/TelemetryArchive.jsm:63:33
[task 2022-12-22T03:23:19.935Z] 03:23:19     INFO - PID 14114 | _submitPingLogic@resource://gre/modules/TelemetryControllerParent.jsm:540:48
[task 2022-12-22T03:23:19.936Z] 03:23:19     INFO - PID 14114 | send@resource://gre/modules/TelemetryControllerParent.jsm:628:24
[task 2022-12-22T03:23:19.937Z] 03:23:19     INFO - PID 14114 | submitExternalPing@resource://gre/modules/TelemetryControllerParent.jsm:182:17
[task 2022-12-22T03:23:19.937Z] 03:23:19     INFO - PID 14114 | saveShutdownPings@resource://gre/modules/TelemetrySession.jsm:982:34
[task 2022-12-22T03:23:19.938Z] 03:23:19     INFO - PID 14114 | shutdownChromeProcess/cleanup/<@resource://gre/modules/TelemetrySession.jsm:1232:20
[task 2022-12-22T03:23:19.938Z] 03:23:19     INFO - PID 14114 | cleanup@resource://gre/modules/TelemetrySession.jsm:1239:9
[task 2022-12-22T03:23:19.939Z] 03:23:19     INFO - PID 14114 | shutdownChromeProcess@resource://gre/modules/TelemetrySession.jsm:1256:14
[task 2022-12-22T03:23:19.939Z] 03:23:19     INFO - PID 14114 | shutdown@resource://gre/modules/TelemetrySession.jsm:247:17
[task 2022-12-22T03:23:19.940Z] 03:23:19     INFO - PID 14114 | _cleanupOnShutdown@resource://gre/modules/TelemetryControllerParent.jsm:959:35
[task 2022-12-22T03:23:19.940Z] 03:23:19     INFO - PID 14114 | observe@resource://gre/modules/AsyncShutdown.jsm:572:16
[task 2022-12-22T03:23:19.953Z] 03:23:19     INFO - PID 14114 | WARNING: A blocker encountered an error while we were waiting.
[task 2022-12-22T03:23:19.954Z] 03:23:19     INFO - PID 14114 |           Blocker:  TelemetryController: shutting down
[task 2022-12-22T03:23:19.954Z] 03:23:19     INFO - PID 14114 |           Phase: profile-before-change-telemetry
[task 2022-12-22T03:23:19.955Z] 03:23:19     INFO - PID 14114 |           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.jsm:718:15
[task 2022-12-22T03:23:19.956Z] 03:23:19     INFO - PID 14114 | addBlocker@resource://gre/modules/AsyncShutdown.jsm:523:26
[task 2022-12-22T03:23:19.957Z] 03:23:19     INFO - PID 14114 | addBlocker@resource://gre/modules/AsyncShutdown.jsm:462:15
[task 2022-12-22T03:23:19.957Z] 03:23:19     INFO - PID 14114 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2022-12-22T03:23:19.958Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2022-12-22T03:23:19.958Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/osfile.jsm:12:30
[task 2022-12-22T03:23:19.959Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/TelemetryStorage.jsm:19:28
[task 2022-12-22T03:23:19.959Z] 03:23:19     INFO - PID 14114 | getShutdownState@resource://gre/modules/TelemetrySend.jsm:1692:7
[task 2022-12-22T03:23:19.960Z] 03:23:19     INFO - PID 14114 | getShutdownState@resource://gre/modules/TelemetrySend.jsm:374:30
[task 2022-12-22T03:23:19.960Z] 03:23:19     INFO - PID 14114 | _getState@resource://gre/modules/TelemetryControllerParent.jsm:1058:38
[task 2022-12-22T03:23:19.961Z] 03:23:19     INFO - PID 14114 | setupTelemetry/<@resource://gre/modules/TelemetryControllerParent.jsm:917:18
[task 2022-12-22T03:23:19.961Z] 03:23:19     INFO - PID 14114 | safeGetState@resource://gre/modules/AsyncShutdown.jsm:254:17
[task 2022-12-22T03:23:19.962Z] 03:23:19     INFO - PID 14114 | Barrier/_internalAddBlocker/promise<@resource://gre/modules/AsyncShutdown.jsm:773:20
[task 2022-12-22T03:23:19.962Z] 03:23:19     INFO - PID 14114 | observe@resource://gre/modules/AsyncShutdown.jsm:572:16
[task 2022-12-22T03:23:19.972Z] 03:23:19     INFO - PID 14114 | 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-22T03:23:19.972Z] 03:23:19     INFO - PID 14114 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.jsm:718:15
[task 2022-12-22T03:23:19.974Z] 03:23:19     INFO - PID 14114 | addBlocker@resource://gre/modules/AsyncShutdown.jsm:523:26
[task 2022-12-22T03:23:19.974Z] 03:23:19     INFO - PID 14114 | addBlocker@resource://gre/modules/AsyncShutdown.jsm:462:15
[task 2022-12-22T03:23:19.974Z] 03:23:19     INFO - PID 14114 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2022-12-22T03:23:19.975Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2022-12-22T03:23:19.976Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/osfile.jsm:12:30
[task 2022-12-22T03:23:19.976Z] 03:23:19     INFO - PID 14114 | @resource://gre/modules/TelemetryStorage.jsm:19:28
[task 2022-12-22T03:23:19.976Z] 03:23:19     INFO - PID 14114 | removeAbortedSessionPing@resource://gre/modules/TelemetryControllerParent.jsm:721:5
[task 2022-12-22T03:23:19.977Z] 03:23:19     INFO - PID 14114 | removeAbortedSessionPing@resource://gre/modules/TelemetryControllerParent.jsm:249:17
[task 2022-12-22T03:23:19.977Z] 03:23:19     INFO - PID 14114 | shutdownChromeProcess/cleanup/<@resource://gre/modules/TelemetrySession.jsm:1235:42
[task 2022-12-22T03:23:19.977Z] 03:23:19     INFO - PID 14114 | observe@resource://gre/modules/AsyncShutdown.jsm:572:16
[task 2022-12-22T03:23:19.978Z] 03:23:19     INFO - PID 14114 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 718: 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-22T03:23:19.978Z] 03:23:19     INFO - PID 14114 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 718: 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-22T03:23:19.979Z] 03:23:19     INFO - PID 14114 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 718: 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-22T03:23:19.979Z] 03:23:19     INFO - PID 14114 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 718: 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-22T03:23:19.979Z] 03:23:19     INFO - PID 14114 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 718: 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-22T03:23:19.991Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Main Thread] WARNING: FuncScope not on stack!: file /builds/worker/checkouts/gecko/dom/canvas/WebGLContext.cpp:1763
[task 2022-12-22T03:23:19.992Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Main Thread] WARNING: FuncScope not on stack!: file /builds/worker/checkouts/gecko/dom/canvas/WebGLContext.cpp:1763
[task 2022-12-22T03:23:19.992Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Main Thread] WARNING: FuncScope not on stack!: file /builds/worker/checkouts/gecko/dom/canvas/WebGLContext.cpp:1763
[task 2022-12-22T03:23:19.993Z] 03:23:19     INFO - PID 14114 | [Parent 14114, Main Thread] WARNING: FuncScope not on stack!: file /builds/worker/checkouts/gecko/dom/canvas/WebGLContext.cpp:1763
[task 2022-12-22T03:23:20.006Z] 03:23:20     INFO - PID 14114 | [Parent 14114, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2022-12-22T03:23:20.050Z] 03:23:20     INFO - PID 14114 | [Parent 14114, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:209
[task 2022-12-22T03:23:20.833Z] 03:23:20     INFO - PID 14114 | [Parent 14114, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3384
[task 2022-12-22T03:23:20.864Z] 03:23:20     INFO - PID 14114 | [Parent 14114, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-12-22T03:23:20.888Z] 03:23:20     INFO - PID 14114 | [Parent 14114, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4663
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - Browser exited with return code 0
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - PROCESS LEAKS /tmp/tmpl5r7ayoc/runtests_leaks_1165.log
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - leakcheck | Processing log file /tmp/tmpl5r7ayoc/runtests_leaks_1165.log for scope /css/css-images/image-set
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - TEST-INFO | leakcheck | default process: leak threshold set at 16000 bytes
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 10000 bytes
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 10000 bytes
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 400 bytes
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - TEST-INFO | leakcheck | sandboxbroker process: leak threshold set at 0 bytes
[task 2022-12-22T03:23:20.912Z] 03:23:20     INFO - TEST-INFO | leakcheck | forkserver process: leak threshold set at 0 bytes
[task 2022-12-22T03:23:20.913Z] 03:23:20     INFO - TEST-INFO | leakcheck | utility process: leak threshold set at 0 bytes
[task 2022-12-22T03:23:20.914Z] 03:23:20     INFO - leakcheck | Processing leak log file /tmp/tmpl5r7ayoc/runtests_leaks_1165_tab_pid14268.log
[task 2022-12-22T03:23:20.915Z] 03:23:20     INFO - TEST-PASS | leakcheck | tab no leaks detected!

Comment 1

[BugBot [:suhaib / :marco/ :calixte]]

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

Comment 2

[Iulian Moraru]

Attachment: Bug 1806944 - Set image-set test to intermittent on windows, linux and android. r=jgraham,aryx

Comment 4

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/3bea5ad6bd90
Set image-set test to intermittent on windows, linux and android. a=test-only

Comment 5

[Cosmin Sabou [:CosminS]]

Emilio, when you get the change could you have a look over these latest updates ^ ? Thank you.
If needed we will revert them, they were permafailing on tree since the latest wpt-sync update.

Comment 6

[Sandor Molnar[:smolnar]]

https://hg.mozilla.org/mozilla-central/rev/3bea5ad6bd90

Comment 7

[Cosmin Sabou [:CosminS]]

Needs also this one added /css/css-images/image-set/image-set-invalid-resolution-rendering.html - https://treeherder.mozilla.org/logviewer?job_id=400555240&repo=mozilla-central&lineNumber=15644

Let's see what others fail.

Comment 8

[BugBot [:suhaib / :marco/ :calixte]]

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

Comment 9

[Intermittent Failures Robot]

37 failures in 561 pushes (0.066 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 21
• mozilla-central: 12
• try: 4

Platform and build breakdown:

• linux1804-64-qr: 12
  • debug: 12
• windows10-64-2004-qr: 3
  • debug: 3
• android-em-7-0-x86_64-lite-qr: 2
  • opt: 2
• linux1804-64-tsan-qr: 8
  • opt: 8
• linux1804-64-asan-qr: 5
  • opt: 5
• android-em-7-0-x86_64-qr: 2
  • debug: 2
• windows10-64-2004-ccov-qr: 2
  • opt: 2
• android-em-7-0-x86_64-shippable-qr: 1
  • opt: 1
• linux1804-64-ccov-qr: 1
  • opt: 1
• linux1804-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1806944&startday=2022-12-22&endday=2022-12-22&tree=all

Comment 10

[Emilio Cobos Álvarez (:emilio)]

Attachment: Bug 1806944 - Fix flakiness in image-set tests. r=#layout-reviewers,#style,jgraham

image-set-rendering-helper.js waits for load to create the element that
has the background-image, so there's no guarantee that the image is
loaded before the screenshot is taken.

Set up the test in DOMContentLoaded, to guarantee that the load event is
blocked by the images.

Comment 11

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/6f6ac157ed75
Fix flakiness in image-set tests. r=layout-reviewers,tnikkel

Comment 12

[Web Platform Test Sync Bot [:wpt-sync] (Matrix: #interop:mozilla.org)]

Created web-platform-tests PR https://github.com/web-platform-tests/wpt/pull/37673 for changes under testing/web-platform/tests

Comment 13

[Norisz Fay [:noriszfay]]

https://hg.mozilla.org/mozilla-central/rev/6f6ac157ed75

Comment 14

[Web Platform Test Sync Bot [:wpt-sync] (Matrix: #interop:mozilla.org)]

Upstream PR merged by moz-wptsync-bot

Comment 15

[Intermittent Failures Robot]

17 failures in 433 pushes (0.039 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 9
• mozilla-central: 6
• try: 2

Platform and build breakdown:

• android-em-7-0-x86_64-lite-qr: 2
  • opt: 2
• linux1804-64-tsan-qr: 3
  • opt: 3
• linux1804-64-qr: 7
  • debug: 6
  • opt: 1
• android-em-7-0-x86_64-shippable-qr: 1
  • opt: 1
• windows10-64-2004-qr: 2
  • debug: 2
• linux1804-64-asan-qr: 1
  • opt: 1
• android-em-7-0-x86_64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1806944&startday=2022-12-23&endday=2022-12-23&tree=all

Comment 17

[Intermittent Failures Robot]

56 failures in 2999 pushes (0.019 failures/push) were associated with this bug in the last 7 days.

This is the #8 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 30
• mozilla-central: 20
• try: 6

Platform and build breakdown:

• linux1804-64-qr: 19
  • debug: 18
  • opt: 1
• windows10-64-2004-qr: 5
  • debug: 5
• android-em-7-0-x86_64-lite-qr: 4
  • opt: 4
• linux1804-64-tsan-qr: 11
  • opt: 11
• linux1804-64-asan-qr: 6
  • opt: 6
• android-em-7-0-x86_64-qr: 3
  • debug: 3
• windows10-64-2004-ccov-qr: 2
  • opt: 2
• android-em-7-0-x86_64-shippable-qr: 3
  • opt: 3
• linux1804-64-ccov-qr: 1
  • opt: 1
• linux1804-64-shippable-qr: 1
  • opt: 1
• android-em-7-0-x86_64-shippable-lite-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1806944&startday=2022-12-19&endday=2022-12-25&tree=all

Comment 18

[Intermittent Failures Robot]

1 failures in 3914 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

• linux1804-64-tsan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1806944&startday=2023-01-23&endday=2023-01-29&tree=all