Closed Bug 1722600 Opened 3 years ago Closed 3 years ago

Intermittent devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: first -

Categories

(DevTools :: Storage Inspector, defect, P5)

defect

Tracking

(firefox-esr78 unaffected, firefox-esr91 unaffected, firefox90 unaffected, firefox91 unaffected, firefox92 wontfix, firefox93 fixed)

RESOLVED FIXED
93 Branch
Tracking Status
firefox-esr78 --- unaffected
firefox-esr91 --- unaffected
firefox90 --- unaffected
firefox91 --- unaffected
firefox92 --- wontfix
firefox93 --- fixed

People

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

References

(Regression)

Details

(Keywords: intermittent-failure, regression, Whiteboard: [stockwell unknown])

Attachments

(1 file, 1 obsolete file)

[task 2021-07-27T17:21:36.622Z] 17:21:36 INFO - TEST-START | devtools/client/storage/test/browser_storage_dfpi.js
[task 2021-07-27T17:21:36.756Z] 17:21:36 INFO - GECKO(1548) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp_29hicl8.mozrunner/runtests_leaks_tab_pid4056.log
(7f4188127000) [pid = 4056] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:42.099Z] 17:21:42 INFO - GECKO(1548) | [Child 4056: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f418812cc00) [pid = 4056] [serial = 3] [outer = 0] [url = http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html]
[task 2021-07-27T17:21:42.168Z] 17:21:42 INFO - GECKO(1548) | [Child 4080, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-07-27T17:21:42.187Z] 17:21:42 INFO - GECKO(1548) | [Child 4080, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-07-27T17:21:42.218Z] 17:21:42 INFO - GECKO(1548) | [Child 4105, Main Thread] WARNING: NS_ENSURE_TRUE(currentInner) failed: file /builds/worker/checkouts/gecko/dom/base/WindowDestroyedEvent.cpp:113

[task 2021-07-27T17:21:42.258Z] 17:21:42     INFO - GECKO(1548) | [Child 4056, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-07-27T17:21:42.273Z] 17:21:42     INFO - GECKO(1548) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp_29hicl8.mozrunner/runtests_leaks_tab_pid4129.log
[task 2021-07-27T17:21:42.286Z] 17:21:42     INFO - GECKO(1548) | [4129, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:250
[task 2021-07-27T17:21:42.325Z] 17:21:42     INFO - GECKO(1548) | [Child 4056, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-07-27T17:21:42.331Z] 17:21:42     INFO - GECKO(1548) | [Child 4129, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:619
[task 2021-07-27T17:21:42.493Z] 17:21:42     INFO - GECKO(1548) | [Child 4129: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7fc1e2322800 == 1 [pid = 4129] [id = 0][task 2021-07-27T17:21:42.494Z] 17:21:42     INFO - GECKO(1548) | [Child 4129: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7fc1fd0643c0) [pid = 4129] [serial = 1] [outer = 0]
[task 2021-07-27T17:21:42.495Z] 17:21:42     INFO - GECKO(1548) | [Child 4129: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7fc1e2327000) [pid = 4129] [serial = 2] [outer = 7fc1fd0643c0]
[task 2021-07-27T17:21:42.538Z] 17:21:42     INFO - GECKO(1548) | [Child 4129: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7fc1e232d000) [pid = 4129] [serial = 3] [outer = 7fc1fd0643c0]
[task 2021-07-27T17:21:42.838Z] 17:21:42     INFO - GECKO(1548) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp_29hicl8.mozrunner/runtests_leaks_tab_pid4153.log
[task 2021-07-27T17:21:42.840Z] 17:21:42     INFO - GECKO(1548) | [4153, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:250
[task 2021-07-27T17:21:42.883Z] 17:21:42     INFO - GECKO(1548) | [Child 4153, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:619
[task 2021-07-27T17:21:43.026Z] 17:21:43     INFO - GECKO(1548) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-07-27T17:21:43.032Z] 17:21:43     INFO - GECKO(1548) | [Child 4105: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f9f7b48c400 == 1 [pid = 4105] [id = 1] [url = ]
[task 2021-07-27T17:21:43.033Z] 17:21:43     INFO - GECKO(1548) | [Child 4105: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (7f9f96664740) [pid = 4105] [serial = 4] [outer = 0] [url = ]
[task 2021-07-27T17:21:43.041Z] 17:21:43     INFO - GECKO(1548) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-07-27T17:21:43.165Z] 17:21:43     INFO - GECKO(1548) | [Child 4129: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7fc1e2322800 == 0 [pid = 4129] [id = 0] [url = http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html]
[task 2021-07-27T17:21:43.210Z] 17:21:43     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f9093022800 == 1 [pid = 4153] [id = 0]
[task 2021-07-27T17:21:43.212Z] 17:21:43     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f90add64200) [pid = 4153] [serial = 1] [outer = 0]
[task 2021-07-27T17:21:43.214Z] 17:21:43     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f9093026c00) [pid = 4153] [serial = 2] [outer = 7f90add64200]
[task 2021-07-27T17:21:43.242Z] 17:21:43     INFO - GECKO(1548) | [Child 4105: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f9f7b922800 == 0 [pid = 4105] [id = 0] [url = http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html]
[task 2021-07-27T17:21:43.275Z] 17:21:43     INFO - GECKO(1548) | [Child 4129: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7fc1fd0643c0) [pid = 4129] [serial = 1] [outer = 0] [url = http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html]
[task 2021-07-27T17:21:43.277Z] 17:21:43     INFO - GECKO(1548) | [Child 4129: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7fc1e2327000) [pid = 4129] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:43.279Z] 17:21:43     INFO - GECKO(1548) | [Child 4129: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7fc1e232d000) [pid = 4129] [serial = 3] [outer = 0] [url = http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html]
[task 2021-07-27T17:21:43.280Z] 17:21:43     INFO - GECKO(1548) | [Child 4129, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-07-27T17:21:43.314Z] 17:21:43     INFO - GECKO(1548) | [Child 4129, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-07-27T17:21:43.370Z] 17:21:43     INFO - GECKO(1548) | [Child 4105: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7f9f96664200) [pid = 4105] [serial = 1] [outer = 0] [url = http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html]
[task 2021-07-27T17:21:43.372Z] 17:21:43     INFO - GECKO(1548) | [Child 4105: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f9f7b927c00) [pid = 4105] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:43.374Z] 17:21:43     INFO - GECKO(1548) | [Child 4105: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f9f7b92cc00) [pid = 4105] [serial = 3] [outer = 0] [url = http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html]
[task 2021-07-27T17:21:43.378Z] 17:21:43     INFO - GECKO(1548) | [Child 4105, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-07-27T17:21:43.408Z] 17:21:43     INFO - GECKO(1548) | [Child 4153, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-07-27T17:21:43.409Z] 17:21:43     INFO - GECKO(1548) | [Child 4153, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-07-27T17:21:43.411Z] 17:21:43     INFO - GECKO(1548) | [Child 4153, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-07-27T17:21:43.425Z] 17:21:43     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7f909302d400) [pid = 4153] [serial = 3] [outer = 7f90add64200]
[task 2021-07-27T17:21:43.431Z] 17:21:43     INFO - GECKO(1548) | [Child 4105, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-07-27T17:21:43.528Z] 17:21:43     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f9092b8f800 == 2 [pid = 4153] [id = 1]
[task 2021-07-27T17:21:43.529Z] 17:21:43     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (7f90add64580) [pid = 4153] [serial = 4] [outer = 0]
[task 2021-07-27T17:21:43.663Z] 17:21:43     INFO - GECKO(1548) | [Child 4153, Main Thread] WARNING: NS_ENSURE_TRUE(currentInner) failed: file /builds/worker/checkouts/gecko/dom/base/WindowDestroyedEvent.cpp:113
[task 2021-07-27T17:21:43.750Z] 17:21:43     INFO - GECKO(1548) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp_29hicl8.mozrunner/runtests_leaks_tab_pid4177.log
[task 2021-07-27T17:21:43.753Z] 17:21:43     INFO - GECKO(1548) | [4177, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:250
[task 2021-07-27T17:21:43.821Z] 17:21:43     INFO - GECKO(1548) | [Child 4177, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:619
[task 2021-07-27T17:21:43.965Z] 17:21:43     INFO - GECKO(1548) | [Child 4177: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f699e322800 == 1 [pid = 4177] [id = 0]
[task 2021-07-27T17:21:43.967Z] 17:21:43     INFO - GECKO(1548) | [Child 4177: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f69b90643c0) [pid = 4177] [serial = 1] [outer = 0]
[task 2021-07-27T17:21:43.968Z] 17:21:43     INFO - GECKO(1548) | [Child 4177: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f699e327000) [pid = 4177] [serial = 2] [outer = 7f69b90643c0]
[task 2021-07-27T17:21:44.011Z] 17:21:44     INFO - GECKO(1548) | [Child 4177: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7f699e32d400) [pid = 4177] [serial = 3] [outer = 7f69b90643c0]
[task 2021-07-27T17:21:44.198Z] 17:21:44     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f2c9a9bac00 == 8 [pid = 1548] [id = 61][task 2021-07-27T17:21:44.200Z] 17:21:44     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 18 (7f2cac3b8c80) [pid = 1548] [serial = 152] [outer = 0]
[task 2021-07-27T17:21:44.202Z] 17:21:44     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 19 (7f2c9ad65800) [pid = 1548] [serial = 153] [outer = 7f2cac3b8c80]
[task 2021-07-27T17:21:44.223Z] 17:21:44     INFO - GECKO(1548) | [Child 4153, Main Thread] WARNING: Scrolled rect smaller than scrollport?: file /builds/worker/checkouts/gecko/layout/generic/nsGfxScrollFrame.cpp:7051
[task 2021-07-27T17:21:44.251Z] 17:21:44     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 20 (7f2c9d038400) [pid = 1548] [serial = 154] [outer = 7f2cac3b8c80]
[task 2021-07-27T17:21:44.446Z] 17:21:44     INFO - GECKO(1548) | [Parent 1548, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:4018
[task 2021-07-27T17:21:44.776Z] 17:21:44     INFO - GECKO(1548) | [Child 1691: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7fe7c0164580) [pid = 1691] [serial = 10] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:45.250Z] 17:21:45     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f2c9a94f400 == 9 [pid = 1548] [id = 62]
[task 2021-07-27T17:21:45.250Z] 17:21:45     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 21 (7f2cae7fa580) [pid = 1548] [serial = 155] [outer = 0]
[task 2021-07-27T17:21:45.252Z] 17:21:45     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 22 (7f2c9ad72c00) [pid = 1548] [serial = 156] [outer = 7f2cae7fa580]
[task 2021-07-27T17:21:45.269Z] 17:21:45     INFO - GECKO(1548) | [Parent 1548, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/chrome/nsChromeRegistry.cpp:180
[task 2021-07-27T17:21:45.269Z] 17:21:45     INFO - GECKO(1548) | [Parent 1548, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/security/nsCSPService.cpp:191
[task 2021-07-27T17:21:45.721Z] 17:21:45     INFO - GECKO(1548) | [Parent 1548, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:4018
[task 2021-07-27T17:21:45.976Z] 17:21:45     INFO - GECKO(1548) | console.warn: "Failed to enumerate CacheStorage for host http://sub1.test1.example.com: SecurityError: The operation is insecure."
[task 2021-07-27T17:21:47.305Z] 17:21:47     INFO - GECKO(1548) | console.error: "Tried to send a 'target-destroyed-form' event on an already destroyed actor 'watcher'"
[task 2021-07-27T17:21:47.314Z] 17:21:47     INFO - GECKO(1548) | [Parent 1548, Main Thread] WARNING: '!inner', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorProtocol.cpp:184
[task 2021-07-27T17:21:48.482Z] 17:21:48     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 21 (7f2c9ac0a800) [pid = 1548] [serial = 148] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:48.484Z] 17:21:48     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f2c9a9b7800 == 8 [pid = 1548] [id = 59] [url = about:devtools-toolbox]
[task 2021-07-27T17:21:48.487Z] 17:21:48     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f2c9ac09800 == 7 [pid = 1548] [id = 60] [url = chrome://devtools/content/storage/index.xhtml]
[task 2021-07-27T17:21:48.488Z] 17:21:48     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 20 (7f2c9ac0b800) [pid = 1548] [serial = 146] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:48.488Z] 17:21:48     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 19 (7f2c9ad6f000) [pid = 1548] [serial = 144] [outer = 0] [url = about:devtools-toolbox]
[task 2021-07-27T17:21:48.492Z] 17:21:48     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f2c9a94f400 == 6 [pid = 1548] [id = 62] [url = chrome://devtools/content/storage/index.xhtml]
[task 2021-07-27T17:21:48.496Z] 17:21:48     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f2c9a9bac00 == 5 [pid = 1548] [id = 61] [url = about:devtools-toolbox]
[task 2021-07-27T17:21:48.649Z] 17:21:48     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 18 (7f2ca17863c0) [pid = 1548] [serial = 147] [outer = 0] [url = about:devtools-toolbox]
[task 2021-07-27T17:21:48.649Z] 17:21:48     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 17 (7f2ca320d580) [pid = 1548] [serial = 150] [outer = 0] [url = chrome://devtools/content/storage/index.xhtml]
[task 2021-07-27T17:21:48.753Z] 17:21:48     INFO - GECKO(1548) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp_29hicl8.mozrunner/runtests_leaks_tab_pid4202.log
[task 2021-07-27T17:21:48.754Z] 17:21:48     INFO - GECKO(1548) | [4202, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:250
[task 2021-07-27T17:21:48.791Z] 17:21:48     INFO - GECKO(1548) | [Child 4202, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:619
[task 2021-07-27T17:21:48.838Z] 17:21:48     INFO - GECKO(1548) | [Child 1691: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7fe7a4969800) [pid = 1691] [serial = 11] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:48.880Z] 17:21:48     INFO - GECKO(1548) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-07-27T17:21:48.886Z] 17:21:48     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f9092b8f800 == 1 [pid = 4153] [id = 1] [url = ]
[task 2021-07-27T17:21:48.887Z] 17:21:48     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (7f90add64580) [pid = 4153] [serial = 4] [outer = 0] [url = ]
[task 2021-07-27T17:21:48.958Z] 17:21:48     INFO - GECKO(1548) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-07-27T17:21:48.961Z] 17:21:48     INFO - GECKO(1548) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-07-27T17:21:48.962Z] 17:21:48     INFO - GECKO(1548) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-07-27T17:21:49.203Z] 17:21:49     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f9093022800 == 0 [pid = 4153] [id = 0] [url = http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html]
[task 2021-07-27T17:21:49.265Z] 17:21:49     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f75ba322800 == 1 [pid = 4202] [id = 0][task 2021-07-27T17:21:49.267Z] 17:21:49     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f75d5064200) [pid = 4202] [serial = 1] [outer = 0]
[task 2021-07-27T17:21:49.270Z] 17:21:49     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f75ba327c00) [pid = 4202] [serial = 2] [outer = 7f75d5064200]
[task 2021-07-27T17:21:49.356Z] 17:21:49     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7f9093026c00) [pid = 4153] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:49.358Z] 17:21:49     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f90add64200) [pid = 4153] [serial = 1] [outer = 0] [url = http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html]
[task 2021-07-27T17:21:49.360Z] 17:21:49     INFO - GECKO(1548) | [Child 4153: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f909302d400) [pid = 4153] [serial = 3] [outer = 0] [url = http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html]
[task 2021-07-27T17:21:49.426Z] 17:21:49     INFO - GECKO(1548) | [Child 4177: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f699e322800 == 0 [pid = 4177] [id = 0] [url = http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html]
[task 2021-07-27T17:21:49.468Z] 17:21:49     INFO - GECKO(1548) | [Child 4202, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-07-27T17:21:49.468Z] 17:21:49     INFO - GECKO(1548) | [Child 4202, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-07-27T17:21:49.471Z] 17:21:49     INFO - GECKO(1548) | [Child 4202, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-07-27T17:21:49.476Z] 17:21:49     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7f75ba32d000) [pid = 4202] [serial = 3] [outer = 7f75d5064200]
[task 2021-07-27T17:21:49.552Z] 17:21:49     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f75b9e8c400 == 2 [pid = 4202] [id = 1]
[task 2021-07-27T17:21:49.554Z] 17:21:49     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (7f75d5064740) [pid = 4202] [serial = 4] [outer = 0]
[task 2021-07-27T17:21:49.574Z] 17:21:49     INFO - GECKO(1548) | [Child 4153, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-07-27T17:21:49.622Z] 17:21:49     INFO - GECKO(1548) | [Child 4153, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-07-27T17:21:49.756Z] 17:21:49     INFO - GECKO(1548) | [Child 4177: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7f699e327000) [pid = 4177] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:49.756Z] 17:21:49     INFO - GECKO(1548) | [Child 4177: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f69b90643c0) [pid = 4177] [serial = 1] [outer = 0] [url = http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html]
[task 2021-07-27T17:21:49.756Z] 17:21:49     INFO - GECKO(1548) | [Child 4177: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f699e32d400) [pid = 4177] [serial = 3] [outer = 0] [url = http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html]
[task 2021-07-27T17:21:49.864Z] 17:21:49     INFO - GECKO(1548) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp_29hicl8.mozrunner/runtests_leaks_tab_pid4226.log
[task 2021-07-27T17:21:49.866Z] 17:21:49     INFO - GECKO(1548) | [4226, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:250
[task 2021-07-27T17:21:49.901Z] 17:21:49     INFO - GECKO(1548) | [Child 4226, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:619
[task 2021-07-27T17:21:49.993Z] 17:21:49     INFO - GECKO(1548) | [Child 4202, Main Thread] WARNING: NS_ENSURE_TRUE(currentInner) failed: file /builds/worker/checkouts/gecko/dom/base/WindowDestroyedEvent.cpp:113
[task 2021-07-27T17:21:50.044Z] 17:21:50     INFO - GECKO(1548) | [Child 4177, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-07-27T17:21:50.091Z] 17:21:50     INFO - GECKO(1548) | [Child 4177, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-07-27T17:21:50.141Z] 17:21:50     INFO - GECKO(1548) | [Child 4226: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7fa58cb22800 == 1 [pid = 4226] [id = 0]
[task 2021-07-27T17:21:50.143Z] 17:21:50     INFO - GECKO(1548) | [Child 4226: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7fa5a7864200) [pid = 4226] [serial = 1] [outer = 0]
[task 2021-07-27T17:21:50.146Z] 17:21:50     INFO - GECKO(1548) | [Child 4226: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7fa58cb27000) [pid = 4226] [serial = 2] [outer = 7fa5a7864200]
[task 2021-07-27T17:21:50.199Z] 17:21:50     INFO - GECKO(1548) | [Child 4226: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7fa58cb2d400) [pid = 4226] [serial = 3] [outer = 7fa5a7864200]
[task 2021-07-27T17:21:50.524Z] 17:21:50     INFO - GECKO(1548) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp_29hicl8.mozrunner/runtests_leaks_tab_pid4250.log
[task 2021-07-27T17:21:50.525Z] 17:21:50     INFO - GECKO(1548) | [4250, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:250
[task 2021-07-27T17:21:50.561Z] 17:21:50     INFO - GECKO(1548) | [Child 4250, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:619
[task 2021-07-27T17:21:50.659Z] 17:21:50     INFO - GECKO(1548) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x390076,name=PContent::Msg_DestroyBrowsingContextGroup) Closed channel: cannot send/recv
[task 2021-07-27T17:21:50.668Z] 17:21:50     INFO - GECKO(1548) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-07-27T17:21:50.669Z] 17:21:50     INFO - GECKO(1548) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-07-27T17:21:50.675Z] 17:21:50     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f75b9e8c400 == 1 [pid = 4202] [id = 1] [url = ]
[task 2021-07-27T17:21:50.675Z] 17:21:50     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (7f75d5064740) [pid = 4202] [serial = 4] [outer = 0] [url = ]
[task 2021-07-27T17:21:50.716Z] 17:21:50     INFO - GECKO(1548) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-07-27T17:21:50.803Z] 17:21:50     INFO - GECKO(1548) | [Child 4226: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7fa58cb22800 == 0 [pid = 4226] [id = 0] [url = http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html]
[task 2021-07-27T17:21:50.904Z] 17:21:50     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f75ba322800 == 0 [pid = 4202] [id = 0] [url = http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html]
[task 2021-07-27T17:21:50.946Z] 17:21:50     INFO - GECKO(1548) | [Child 4226: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7fa5a7864200) [pid = 4226] [serial = 1] [outer = 0] [url = http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html]
[task 2021-07-27T17:21:50.946Z] 17:21:50     INFO - GECKO(1548) | [Child 4226: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7fa58cb27000) [pid = 4226] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:50.946Z] 17:21:50     INFO - GECKO(1548) | [Child 4226: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7fa58cb2d400) [pid = 4226] [serial = 3] [outer = 0] [url = http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html]
[task 2021-07-27T17:21:50.946Z] 17:21:50     INFO - GECKO(1548) | [Child 4226, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-07-27T17:21:50.959Z] 17:21:50     INFO - GECKO(1548) | [Child 4250: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f849da22800 == 1 [pid = 4250] [id = 0][task 2021-07-27T17:21:50.959Z] 17:21:50     INFO - GECKO(1548) | [Child 4250: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f84b8764200) [pid = 4250] [serial = 1] [outer = 0]
[task 2021-07-27T17:21:50.964Z] 17:21:50     INFO - GECKO(1548) | [Child 4250: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f849da27000) [pid = 4250] [serial = 2] [outer = 7f84b8764200]
[task 2021-07-27T17:21:50.988Z] 17:21:50     INFO - GECKO(1548) | [Child 4226, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-07-27T17:21:51.014Z] 17:21:51     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7f75d5064200) [pid = 4202] [serial = 1] [outer = 0] [url = http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html]
[task 2021-07-27T17:21:51.020Z] 17:21:51     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f75ba327c00) [pid = 4202] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:51.022Z] 17:21:51     INFO - GECKO(1548) | [Child 4202: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f75ba32d000) [pid = 4202] [serial = 3] [outer = 0] [url = http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html]
[task 2021-07-27T17:21:51.023Z] 17:21:51     INFO - GECKO(1548) | [Child 4202, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-07-27T17:21:51.097Z] 17:21:51     INFO - GECKO(1548) | [Child 4202, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-07-27T17:21:51.179Z] 17:21:51     INFO - GECKO(1548) | [Child 4250, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-07-27T17:21:51.182Z] 17:21:51     INFO - GECKO(1548) | [Child 4250, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-07-27T17:21:51.184Z] 17:21:51     INFO - GECKO(1548) | [Child 4250, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-07-27T17:21:51.194Z] 17:21:51     INFO - GECKO(1548) | [Child 4250: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7f849da2d000) [pid = 4250] [serial = 3] [outer = 7f84b8764200]
[task 2021-07-27T17:21:51.248Z] 17:21:51     INFO - GECKO(1548) | [Child 4250: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f849d58b000 == 2 [pid = 4250] [id = 1]
[task 2021-07-27T17:21:51.250Z] 17:21:51     INFO - GECKO(1548) | [Child 4250: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (7f84b8764740) [pid = 4250] [serial = 4] [outer = 0]
[task 2021-07-27T17:21:51.379Z] 17:21:51     INFO - GECKO(1548) | [Child 4250, Main Thread] WARNING: NS_ENSURE_TRUE(currentInner) failed: file /builds/worker/checkouts/gecko/dom/base/WindowDestroyedEvent.cpp:113
[task 2021-07-27T17:21:51.397Z] 17:21:51     INFO - GECKO(1548) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp_29hicl8.mozrunner/runtests_leaks_tab_pid4274.log
[task 2021-07-27T17:21:51.398Z] 17:21:51     INFO - GECKO(1548) | [4274, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:250
[task 2021-07-27T17:21:51.441Z] 17:21:51     INFO - GECKO(1548) | [Child 4274, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:619
[task 2021-07-27T17:21:51.636Z] 17:21:51     INFO - GECKO(1548) | [Child 4274: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f03e3522800 == 1 [pid = 4274] [id = 0]
[task 2021-07-27T17:21:51.637Z] 17:21:51     INFO - GECKO(1548) | [Child 4274: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f03fe2643c0) [pid = 4274] [serial = 1] [outer = 0]
[task 2021-07-27T17:21:51.639Z] 17:21:51     INFO - GECKO(1548) | [Child 4274: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f03e3527000) [pid = 4274] [serial = 2] [outer = 7f03fe2643c0]
[task 2021-07-27T17:21:51.680Z] 17:21:51     INFO - GECKO(1548) | [Child 4274: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7f03e352d400) [pid = 4274] [serial = 3] [outer = 7f03fe2643c0]
[task 2021-07-27T17:21:51.866Z] 17:21:51     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f2c9a8a9400 == 6 [pid = 1548] [id = 63]
[task 2021-07-27T17:21:51.868Z] 17:21:51     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 18 (7f2ca5341040) [pid = 1548] [serial = 157] [outer = 0]
[task 2021-07-27T17:21:51.874Z] 17:21:51     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 19 (7f2c9ad2a000) [pid = 1548] [serial = 158] [outer = 7f2ca5341040]
[task 2021-07-27T17:21:51.897Z] 17:21:51     INFO - GECKO(1548) | [Child 4250, Main Thread] WARNING: Scrolled rect smaller than scrollport?: file /builds/worker/checkouts/gecko/layout/generic/nsGfxScrollFrame.cpp:7051
[task 2021-07-27T17:21:51.925Z] 17:21:51     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 20 (7f2c9ad6f800) [pid = 1548] [serial = 159] [outer = 7f2ca5341040]
[task 2021-07-27T17:21:52.095Z] 17:21:52     INFO - GECKO(1548) | [Parent 1548, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:4018
[task 2021-07-27T17:21:52.894Z] 17:21:52     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f2c9a8a7800 == 7 [pid = 1548] [id = 64]
[task 2021-07-27T17:21:52.894Z] 17:21:52     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 21 (7f2c9a9b3e40) [pid = 1548] [serial = 160] [outer = 0]
[task 2021-07-27T17:21:52.896Z] 17:21:52     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 22 (7f2c9ac0f400) [pid = 1548] [serial = 161] [outer = 7f2c9a9b3e40]
[task 2021-07-27T17:21:52.912Z] 17:21:52     INFO - GECKO(1548) | [Parent 1548, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/chrome/nsChromeRegistry.cpp:180
[task 2021-07-27T17:21:52.913Z] 17:21:52     INFO - GECKO(1548) | [Parent 1548, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/security/nsCSPService.cpp:191
[task 2021-07-27T17:21:53.377Z] 17:21:53     INFO - GECKO(1548) | [Parent 1548, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:4018
[task 2021-07-27T17:21:53.627Z] 17:21:53     INFO - GECKO(1548) | console.warn: "Failed to enumerate CacheStorage for host http://sub1.test1.example.com: SecurityError: The operation is insecure."
[task 2021-07-27T17:21:54.957Z] 17:21:54     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 21 (7f2c9ad65800) [pid = 1548] [serial = 153] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:54.959Z] 17:21:54     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 20 (7f2c9ad2c800) [pid = 1548] [serial = 149] [outer = 0] [url = about:devtools-toolbox]
[task 2021-07-27T17:21:54.960Z] 17:21:54     INFO - GECKO(1548) | [Parent 1548: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 19 (7f2c9ad2a800) [pid = 1548] [serial = 151] [outer = 0] [url = about:blank]
[task 2021-07-27T17:21:55.432Z] 17:21:55     INFO - TEST-INFO | started process screentopng
[task 2021-07-27T17:21:55.840Z] 17:21:55     INFO - TEST-INFO | screentopng: exit 0
[task 2021-07-27T17:21:55.841Z] 17:21:55     INFO - <snipped 13 output lines - if you need more context, please use SimpleTest.requestCompleteLog() in your test>
[task 2021-07-27T17:21:55.841Z] 17:21:55     INFO - Buffered messages logged at 17:21:39[task 2021-07-27T17:21:55.843Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.844Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.853Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.853Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.853Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.854Z] 17:21:55     INFO - Making sure that the toolbox's frame is focused
[task 2021-07-27T17:21:55.854Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | check origin: http://sub1.test1.example.org - 
[task 2021-07-27T17:21:55.855Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | check origin: moz-extension://c4f9251b-6595-446c-98a6-cb98b7a8add6^userContextId=4294967295 - 
[task 2021-07-27T17:21:55.856Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | http://sub1.test1.example.org is added - 
[task 2021-07-27T17:21:55.856Z] 17:21:55     INFO - Leaving test bound 
[task 2021-07-27T17:21:55.857Z] 17:21:55     INFO - Entering test bound test_partitioned_cookies
[task 2021-07-27T17:21:55.857Z] 17:21:55     INFO - Buffered messages logged at 17:21:41
[task 2021-07-27T17:21:55.857Z] 17:21:55     INFO - Open the test url in a new tab and add storage entries *before* opening the storage panel.
[task 2021-07-27T17:21:55.857Z] 17:21:55     INFO - Buffered messages logged at 17:21:42
[task 2021-07-27T17:21:55.858Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Cookie “contextA” will be soon rejected because it has the “SameSite” attribute set to “None” or an invalid value, without the “secure” attribute. To know more about the “SameSite“ attribute, read https://developer.mozilla.org/docs/Web/HTTP/Headers/Set-Cookie/SameSite" {file: "chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js" line: 64}]
[task 2021-07-27T17:21:55.865Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Cookie “contextA” will be soon rejected because it has the “SameSite” attribute set to “None” or an invalid value, without the “secure” attribute. To know more about the “SameSite“ attribute, read https://developer.mozilla.org/docs/Web/HTTP/Headers/Set-Cookie/SameSite" {file: "chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js" line: 64}]
[task 2021-07-27T17:21:55.866Z] 17:21:55     INFO - Adding a new tab with URL: http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html
[task 2021-07-27T17:21:55.866Z] 17:21:55     INFO - Buffered messages logged at 17:21:43
[task 2021-07-27T17:21:55.867Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.868Z] 17:21:55     INFO - Buffered messages logged at 17:21:44
[task 2021-07-27T17:21:55.869Z] 17:21:55     INFO - Tab added and finished loading
[task 2021-07-27T17:21:55.870Z] 17:21:55     INFO - Found a window: complete
[task 2021-07-27T17:21:55.870Z] 17:21:55     INFO - Found a window: complete
[task 2021-07-27T17:21:55.871Z] 17:21:55     INFO - Opening the storage inspector
[task 2021-07-27T17:21:55.872Z] 17:21:55     INFO - Opening the toolbox
[task 2021-07-27T17:21:55.873Z] 17:21:55     INFO - Buffered messages logged at 17:21:45
[task 2021-07-27T17:21:55.876Z] 17:21:55     INFO - Console message: Invalid chrome URI (need path): chrome://devtools/
[task 2021-07-27T17:21:55.877Z] 17:21:55     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-07-27T17:21:55.878Z] 17:21:55     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-07-27T17:21:55.879Z] 17:21:55     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 75}]
[task 2021-07-27T17:21:55.879Z] 17:21:55     INFO - Buffered messages logged at 17:21:46
[task 2021-07-27T17:21:55.881Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.882Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.883Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.885Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.886Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.887Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.888Z] 17:21:55     INFO - Making sure that the toolbox's frame is focused
[task 2021-07-27T17:21:55.888Z] 17:21:55     INFO - check that both hosts appear in the storage tree[task 2021-07-27T17:21:55.889Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | cookies > http://sub1.test1.example.org is in the tree - 
[task 2021-07-27T17:21:55.890Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | cookies > http://sub1.test1.example.com is in the tree - 
[task 2021-07-27T17:21:55.891Z] 17:21:55     INFO - check that items for both first and third party host have the initial storage entries
[task 2021-07-27T17:21:55.892Z] 17:21:55     INFO - "cookies,http://sub1.test1.example.org" is already selected, returning.
[task 2021-07-27T17:21:55.892Z] 17:21:55     INFO - found first
[task 2021-07-27T17:21:55.893Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: first - 
[task 2021-07-27T17:21:55.894Z] 17:21:55     INFO - Selecting "cookies,http://sub1.test1.example.com".
[task 2021-07-27T17:21:55.895Z] 17:21:55     INFO - found third
[task 2021-07-27T17:21:55.896Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: third - 
[task 2021-07-27T17:21:55.896Z] 17:21:55     INFO - Add more entries while the storage panel is open
[task 2021-07-27T17:21:55.898Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Cookie “contextB” will be soon rejected because it has the “SameSite” attribute set to “None” or an invalid value, without the “secure” attribute. To know more about the “SameSite“ attribute, read https://developer.mozilla.org/docs/Web/HTTP/Headers/Set-Cookie/SameSite" {file: "chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js" line: 64}]
[task 2021-07-27T17:21:55.899Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Cookie “contextB” will be soon rejected because it has the “SameSite” attribute set to “None” or an invalid value, without the “secure” attribute. To know more about the “SameSite“ attribute, read https://developer.mozilla.org/docs/Web/HTTP/Headers/Set-Cookie/SameSite" {file: "chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js" line: 64}]
[task 2021-07-27T17:21:55.900Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.901Z] 17:21:55     INFO - Buffered messages logged at 17:21:47
[task 2021-07-27T17:21:55.902Z] 17:21:55     INFO - check that both hosts appear in the storage tree
[task 2021-07-27T17:21:55.903Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | cookies > http://sub1.test1.example.org is in the tree - 
[task 2021-07-27T17:21:55.904Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | cookies > http://sub1.test1.example.com is in the tree - 
[task 2021-07-27T17:21:55.905Z] 17:21:55     INFO - check that items for both first and third party host have the updated storage entries
[task 2021-07-27T17:21:55.905Z] 17:21:55     INFO - Selecting "cookies,http://sub1.test1.example.org".
[task 2021-07-27T17:21:55.906Z] 17:21:55     INFO - found first
[task 2021-07-27T17:21:55.907Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: first - 
[task 2021-07-27T17:21:55.908Z] 17:21:55     INFO - found first
[task 2021-07-27T17:21:55.909Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextB with value: first - 
[task 2021-07-27T17:21:55.910Z] 17:21:55     INFO - Selecting "cookies,http://sub1.test1.example.com".
[task 2021-07-27T17:21:55.910Z] 17:21:55     INFO - found third
[task 2021-07-27T17:21:55.911Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: third - 
[task 2021-07-27T17:21:55.912Z] 17:21:55     INFO - found third
[task 2021-07-27T17:21:55.913Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextB with value: third - 
[task 2021-07-27T17:21:55.914Z] 17:21:55     INFO - Leaving test bound test_partitioned_cookies
[task 2021-07-27T17:21:55.914Z] 17:21:55     INFO - Entering test bound test_partitioned_localStorage
[task 2021-07-27T17:21:55.915Z] 17:21:55     INFO - Buffered messages logged at 17:21:48
[task 2021-07-27T17:21:55.916Z] 17:21:55     INFO - Open the test url in a new tab and add storage entries *before* opening the storage panel.
[task 2021-07-27T17:21:55.917Z] 17:21:55     INFO - Buffered messages logged at 17:21:50[task 2021-07-27T17:21:55.918Z] 17:21:55     INFO - Adding a new tab with URL: http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html
[task 2021-07-27T17:21:55.919Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.920Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.921Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.922Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.923Z] 17:21:55     INFO - Buffered messages logged at 17:21:51
[task 2021-07-27T17:21:55.923Z] 17:21:55     INFO - Tab added and finished loading
[task 2021-07-27T17:21:55.924Z] 17:21:55     INFO - Found a window: complete
[task 2021-07-27T17:21:55.925Z] 17:21:55     INFO - Found a window: complete
[task 2021-07-27T17:21:55.926Z] 17:21:55     INFO - Opening the storage inspector
[task 2021-07-27T17:21:55.926Z] 17:21:55     INFO - Opening the toolbox
[task 2021-07-27T17:21:55.927Z] 17:21:55     INFO - Buffered messages logged at 17:21:53
[task 2021-07-27T17:21:55.928Z] 17:21:55     INFO - Console message: Invalid chrome URI (need path): chrome://devtools/
[task 2021-07-27T17:21:55.929Z] 17:21:55     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-07-27T17:21:55.930Z] 17:21:55     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-07-27T17:21:55.931Z] 17:21:55     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 75}]
[task 2021-07-27T17:21:55.932Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.933Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.934Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.935Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.936Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.937Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.938Z] 17:21:55     INFO - Buffered messages logged at 17:21:54
[task 2021-07-27T17:21:55.939Z] 17:21:55     INFO - Making sure that the toolbox's frame is focused
[task 2021-07-27T17:21:55.939Z] 17:21:55     INFO - check that both hosts appear in the storage tree
[task 2021-07-27T17:21:55.940Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | localStorage > http://sub1.test1.example.org is in the tree - 
[task 2021-07-27T17:21:55.941Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | localStorage > http://sub1.test1.example.com is in the tree - 
[task 2021-07-27T17:21:55.942Z] 17:21:55     INFO - check that items for both first and third party host have the initial storage entries
[task 2021-07-27T17:21:55.943Z] 17:21:55     INFO - Selecting "localStorage,http://sub1.test1.example.org".
[task 2021-07-27T17:21:55.944Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: first - 
[task 2021-07-27T17:21:55.945Z] 17:21:55     INFO - Selecting "localStorage,http://sub1.test1.example.com".
[task 2021-07-27T17:21:55.945Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: third - 
[task 2021-07-27T17:21:55.946Z] 17:21:55     INFO - Add more entries while the storage panel is open
[task 2021-07-27T17:21:55.947Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.948Z] 17:21:55     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://sub1.test1.example.com/browser/devtools/client/storage/test/storage-blank.html” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-07-27T17:21:55.948Z] 17:21:55     INFO - Buffered messages logged at 17:21:55
[task 2021-07-27T17:21:55.949Z] 17:21:55     INFO - check that both hosts appear in the storage tree
[task 2021-07-27T17:21:55.949Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | localStorage > http://sub1.test1.example.org is in the tree - 
[task 2021-07-27T17:21:55.950Z] 17:21:55     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | localStorage > http://sub1.test1.example.com is in the tree - 
[task 2021-07-27T17:21:55.950Z] 17:21:55     INFO - check that items for both first and third party host have the updated storage entries
[task 2021-07-27T17:21:55.951Z] 17:21:55     INFO - Selecting "localStorage,http://sub1.test1.example.org".
[task 2021-07-27T17:21:55.951Z] 17:21:55     INFO - Buffered messages finished
[task 2021-07-27T17:21:55.953Z] 17:21:55     INFO - TEST-UNEXPECTED-FAIL | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: first -
Keywords: regression
Regressed by: 1721131
Summary: Intermittent [TV] devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: first - → Intermittent devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: first -
Has Regression Range: --- → yes
Assignee: nobody → pbz
Status: NEW → ASSIGNED
Attachment #9235067 - Attachment is obsolete: true

Bug 1706633 seems to be a similar issue. All failing tests have fission enabled. Could there be a race condition in the storage inspector implementation?

See Also: → 1706633

Belén, do you think Bug 1706633 suffers from the same underlying issue as this one?
Looking at the test failures for both bugs it seems to be Fission related.
Using polling to wait for the desired state didn't fix the issue for me.

Flags: needinfo?(balbeza)

Update:
There have been 46 failures within the last 7 days:
• 2 failures on Linux 18.04 x64 WebRender debug
• 3 failures on Linux 18.04 x64 WebRender opt
• 2 failures on Linux 18.04 x64 WebRender Shippable opt
• 10 failures on Windows 10 x64 2004 WebRender debug
• 13 failures on Windows 10 x64 2004 WebRender opt
• 16 failures on Windows 10 x64 2004 WebRender Shippable opt
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=349198523&repo=mozilla-central&lineNumber=10599

[task 2021-08-22T23:22:42.267Z] 23:22:42     INFO - TEST-START | devtools/client/storage/test/browser_storage_dfpi.js
[task 2021-08-22T23:22:42.880Z] 23:22:42     INFO - GECKO(5072) | console.warn: "Failed to enumerate CacheStorage for host http://sub1.test1.example.com: SecurityError: The operation is insecure."
[task 2021-08-22T23:22:43.127Z] 23:22:43     INFO - GECKO(5072) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x390077,name=PContent::Msg_DestroyBrowsingContextGroup) Closed channel: cannot send/recv
[task 2021-08-22T23:22:43.138Z] 23:22:43     INFO - GECKO(5072) | ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-08-22T23:22:44.029Z] 23:22:44     INFO - GECKO(5072) | console.warn: "Failed to enumerate CacheStorage for host http://sub1.test1.example.com: SecurityError: The operation is insecure."
[task 2021-08-22T23:22:44.499Z] 23:22:44     INFO - GECKO(5072) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x390077,name=PContent::Msg_DestroyBrowsingContextGroup) Closed channel: cannot send/recv
[task 2021-08-22T23:22:44.846Z] 23:22:44     INFO - GECKO(5072) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x390077,name=PContent::Msg_DestroyBrowsingContextGroup) Closed channel: cannot send/recv
[task 2021-08-22T23:22:45.401Z] 23:22:45     INFO - GECKO(5072) | console.warn: "Failed to enumerate CacheStorage for host http://sub1.test1.example.com: SecurityError: The operation is insecure."
[task 2021-08-22T23:22:45.686Z] 23:22:45     INFO - TEST-INFO | started process screenshot
[task 2021-08-22T23:22:45.753Z] 23:22:45     INFO - TEST-INFO | screenshot: exit 0
[task 2021-08-22T23:22:45.766Z] 23:22:45     INFO - Buffered messages logged at 23:22:42
[task 2021-08-22T23:22:45.766Z] 23:22:45     INFO - Entering test bound 
[task 2021-08-22T23:22:45.767Z] 23:22:45     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | http://sub1.test1.example.org doesn't exist - 
[task 2021-08-22T23:22:45.768Z] 23:22:45     INFO - Adding a new tab with URL: http://sub1.test1.example.org/browser/devtools/client/storage/test/storage-dfpi.html
[task 2021-08-22T23:22:45.768Z] 23:22:45     INFO - Tab added and finished loading
[task 2021-08-22T23:22:45.768Z] 23:22:45     INFO - Found a window: complete
<...>
[task 2021-08-22T23:22:45.819Z] 23:22:45     INFO - check that both hosts appear in the storage tree
[task 2021-08-22T23:22:45.820Z] 23:22:45     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | localStorage > http://sub1.test1.example.org is in the tree - 
[task 2021-08-22T23:22:45.821Z] 23:22:45     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | localStorage > http://sub1.test1.example.com is in the tree - 
[task 2021-08-22T23:22:45.821Z] 23:22:45     INFO - check that items for both first and third party host have the updated storage entries
[task 2021-08-22T23:22:45.822Z] 23:22:45     INFO - Selecting "localStorage,http://sub1.test1.example.org".
[task 2021-08-22T23:22:45.823Z] 23:22:45     INFO - Buffered messages finished
[task 2021-08-22T23:22:45.825Z] 23:22:45     INFO - TEST-UNEXPECTED-FAIL | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: first - 
[task 2021-08-22T23:22:45.825Z] 23:22:45     INFO - Stack trace:
[task 2021-08-22T23:22:45.825Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:test_ok:1336
[task 2021-08-22T23:22:45.825Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/head.js:checkStorageData:1119
[task 2021-08-22T23:22:45.825Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:checkData:84
[task 2021-08-22T23:22:45.825Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:testPartitionedStorage:139
[task 2021-08-22T23:22:45.825Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:test_partitioned_localStorage:158
[task 2021-08-22T23:22:45.825Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1091
[task 2021-08-22T23:22:45.825Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1131
[task 2021-08-22T23:22:45.825Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:939
[task 2021-08-22T23:22:45.825Z] 23:22:45     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2021-08-22T23:22:45.826Z] 23:22:45     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-22T23:22:45.828Z] 23:22:45     INFO - TEST-UNEXPECTED-FAIL | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextB with value: first - 
[task 2021-08-22T23:22:45.828Z] 23:22:45     INFO - Stack trace:
[task 2021-08-22T23:22:45.828Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:test_ok:1336
[task 2021-08-22T23:22:45.828Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/head.js:checkStorageData:1119
[task 2021-08-22T23:22:45.828Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:checkData:84
[task 2021-08-22T23:22:45.828Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:testPartitionedStorage:140
[task 2021-08-22T23:22:45.828Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:test_partitioned_localStorage:158
[task 2021-08-22T23:22:45.828Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1091
[task 2021-08-22T23:22:45.828Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1131
[task 2021-08-22T23:22:45.828Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:939
[task 2021-08-22T23:22:45.829Z] 23:22:45     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2021-08-22T23:22:45.829Z] 23:22:45     INFO - Selecting "localStorage,http://sub1.test1.example.com".
[task 2021-08-22T23:22:45.829Z] 23:22:45     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-22T23:22:45.831Z] 23:22:45     INFO - TEST-UNEXPECTED-FAIL | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextA with value: third - 
[task 2021-08-22T23:22:45.832Z] 23:22:45     INFO - Stack trace:
[task 2021-08-22T23:22:45.832Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:test_ok:1336
[task 2021-08-22T23:22:45.832Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/head.js:checkStorageData:1119
[task 2021-08-22T23:22:45.832Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:checkData:84
[task 2021-08-22T23:22:45.832Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:testPartitionedStorage:143
[task 2021-08-22T23:22:45.832Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:test_partitioned_localStorage:158
[task 2021-08-22T23:22:45.832Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1091
[task 2021-08-22T23:22:45.832Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1131
[task 2021-08-22T23:22:45.832Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:939
[task 2021-08-22T23:22:45.832Z] 23:22:45     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2021-08-22T23:22:45.833Z] 23:22:45     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-22T23:22:45.834Z] 23:22:45     INFO - TEST-UNEXPECTED-FAIL | devtools/client/storage/test/browser_storage_dfpi.js | Table row has an entry for: contextB with value: third - 
[task 2021-08-22T23:22:45.834Z] 23:22:45     INFO - Stack trace:
[task 2021-08-22T23:22:45.834Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:test_ok:1336
[task 2021-08-22T23:22:45.834Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/head.js:checkStorageData:1119
[task 2021-08-22T23:22:45.834Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:checkData:84
[task 2021-08-22T23:22:45.834Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:testPartitionedStorage:144
[task 2021-08-22T23:22:45.834Z] 23:22:45     INFO - chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:test_partitioned_localStorage:158
[task 2021-08-22T23:22:45.834Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1091
[task 2021-08-22T23:22:45.835Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1131
[task 2021-08-22T23:22:45.835Z] 23:22:45     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:939
[task 2021-08-22T23:22:45.835Z] 23:22:45     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2021-08-22T23:22:45.835Z] 23:22:45     INFO - Leaving test bound test_partitioned_localStorage
[task 2021-08-22T23:22:45.837Z] 23:22:45     INFO - GECKO(5072) | console.error: (new Error("Connection closed, pending request to server0.conn23.windowGlobal107374182401/localStorage24, type getStoreObjects failed\n\nRequest stack:\nrequest@resource://devtools/shared/protocol/Front.js:289:14\ngenerateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:46:19\nfetchStorageObjects@resource://devtools/client/storage/ui.js:844:38\nasync*onHostSelect@resource://devtools/client/storage/ui.js:1164:16\n_emit@resource://devtools/shared/event-emitter.js:244:34\nemit@resource://devtools/shared/event-emitter.js:190:18\nemit@resource://devtools/shared/event-emitter.js:342:18\nset selectedItem@resource://devtools/client/shared/widgets/TreeWidget.js:80:12\nselectTreeItem@chrome://mochitests/content/browser/devtools/client/storage/test/head.js:504:5\ntestPartitionedStorage@chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:142:9\nasync*test_partitioned_localStorage@chrome://mochitests/content/browser/devtools/client/storage/test/browser_storage_dfpi.js:158:9\nTester_execTest/<@chrome://mochikit/content/browser-test.js:1091:34\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1131:11\nnextTest/<@chrome://mochikit/content/browser-test.js:939:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1041:13\n", "resource://devtools/shared/protocol/Front.js", 103))
[task 2021-08-22T23:22:45.837Z] 23:22:45     INFO - GECKO(5072) | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'DevToolsFrame'
[task 2021-08-22T23:22:45.838Z] 23:22:45     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSWindowActor 'DevToolsFrame'"]
[task 2021-08-22T23:22:45.980Z] 23:22:45     INFO - GECKO(5072) | [Parent 8200, IPC I/O Parent] WARNING: file /builds/worker/checkouts/gecko/ipc/chromium/src/base/process_util_win.cc:167
[task 2021-08-22T23:22:45.984Z] 23:22:45     INFO - TEST-PASS | devtools/client/storage/test/browser_storage_dfpi.js | The main process DevToolsServer has no pending connection when the test ends - 
[task 2021-08-22T23:22:46.435Z] 23:22:46     INFO - GECKO(5072) | MEMORY STAT | vsize 2104208MB | vsizeMaxContiguous 65717991MB | residentFast 271MB | heapAllocated 91MB
[task 2021-08-22T23:22:46.443Z] 23:22:46     INFO - TEST-OK | devtools/client/storage/test/browser_storage_dfpi.js | took 4176ms
[task 2021-08-22T23:22:46.455Z] 23:22:46     INFO - checking window state
[task 2021-08-22T23:22:46.464Z] 23:22:46     INFO - TEST-START | devtools/client/storage/test/browser_storage_dom_cache_disabled.js
Whiteboard: [stockwell needswork:owner]
Attachment #9235067 - Attachment is obsolete: false
Pushed by pzuhlcke@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/c4b8d777dda1 [devtools] Make browser_storage_dfpi test more reliable by polling to wait for devtools storage entries to appear. r=ladybenko
Status: ASSIGNED → RESOLVED
Closed: 3 years ago
Resolution: --- → FIXED
Target Milestone: --- → 93 Branch
Attachment #9238427 - Attachment is obsolete: true
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: