Closed Bug 1590378 Opened 5 years ago Closed 5 years ago

Intermittent GECKO(4528) | FATAL ERROR: AsyncShutdown timeout in profile-before-change Conditions: [{"name":"SessionFile: Finish writing Session Restore data","state":{"options":{"isFinalWrite":true,"performShutdownCleanup":true},"attempts":12,"successes"

Categories

(Firefox :: Session Restore, defect, P5)

Product:
Firefox
Component:
Session Restore
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: btara [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=272358724&repo=mozilla-inbound
Full log: https://queue.taskcluster.net/v1/task/WSftR7aKQ0eZLNqaSWSDDQ/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://queue.taskcluster.net/v1/task/WSftR7aKQ0eZLNqaSWSDDQ/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

This is Tier 2 Test Verify at the time of making this bug.

[task 2019-10-22T11:37:56.154Z] 11:37:56 INFO - TEST-START | layout/style/test/test_value_cloning.html
[task 2019-10-22T11:37:56.249Z] 11:37:56 INFO - GECKO(4528) | ++DOMWINDOW == 15 (082BA800) [pid = 5512] [serial = 61] [outer = 08296DC0]
[task 2019-10-22T11:37:56.692Z] 11:37:56 INFO - GECKO(4528) | --DOCSHELL 0AB1C000 == 3 [pid = 5512] [id = {056a2606-243e-45aa-908d-9d489df702d7}] [url = data:text/html,%3C%21DOCTYPE%20HTML%3E%0A%3Clink%20rel%3D%27stylesheet%27%20type%3D%27text/css%27%20href%3D%27data%3Atext/css%2C%2523parent0%252C%2520%2523test0%2520%257B%2520%2520%257D%2523parent0%2520%257B%2520%257D%2523test0%2520%257B%2520backdrop-filter%253A%2520sepia%25284.567%2529%257D%2523parent1%252C%2520%2523test1%2520%257B%2520%2520%257D%2523parent1%2520%257B%2520%257D%2523test1%2520%257B%2520backdrop-filter%253A%2520sepia%2528350%2525%2529%257D%2523parent2%252C%2520%2523test2%2520%257B%2520%2520%257D%2523parent2%2520%257B%2520%257D%2523test2%2520%257B%2520backdrop-filter%253A%2520sepia%25282%2529%257D%2523parent3%252C%2520%2523test3%2520%257B%2520%2520%257D%2523parent3%2520%257B%2520%257D%2523test3%2520%257B%2520backdrop-filter%253A%2520sepia%25281.0%2529%257D%2523parent4%252C%2520%2523test4%2520%257B%2520%2520%257D%2523parent4%2520%257B%2520%257D%2523test4%2520%257B%2520backdrop-filter%253A%2520sepia%25281%2529%257D%2523parent5%252C%2520%2523test5%2520%257B%2520%2520%257D%2]
[task 2019-10-22T11:37:56.727Z] 11:37:56 INFO - GECKO(4528) | ++DOCSHELL 0086C400 == 4 [pid = 5512] [id = {d5502242-7bb2-4b5d-b349-8b911493b42d}]
[task 2019-10-22T11:37:56.727Z] 11:37:56 INFO - GECKO(4528) | ++DOMWINDOW == 16 (082963A0) [pid = 5512] [serial = 62] [outer = 00000000]
[task 2019-10-22T11:37:56.742Z] 11:37:56 INFO - GECKO(4528) | ++DOMWINDOW == 17 (0C90C400) [pid = 5512] [serial = 63] [outer = 082963A0]
[task 2019-10-22T11:37:57.077Z] 11:37:57 INFO - GECKO(4528) | ++DOMWINDOW == 18 (0CFC2800) [pid = 5512] [serial = 64] [outer = 082963A0]
[task 2019-10-22T11:37:57.232Z] 11:37:57 INFO - GECKO(4528) | [Child 5512, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80070057: file z:/build/build/src/dom/base/ThirdPartyUtil.cpp, line 217
...
[task 2019-10-22T11:37:57.948Z] 11:37:57 INFO - GECKO(4528) | [Child 5512, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80070057: file z:/build/build/src/dom/base/ThirdPartyUtil.cpp, line 217
[task 2019-10-22T11:37:58.035Z] 11:37:58 INFO - GECKO(4528) | [Child 5512, Main Thread] WARNING: We shouldn't be backing up more than once! Someone must have set a break opportunity beyond the available width, even though there were better break opportunities before it: file z:/build/build/src/layout/generic/nsBlockFrame.cpp, line 4184
[task 2019-10-22T11:37:58.090Z] 11:37:58 INFO - GECKO(4528) | [Child 5512, Main Thread] WARNING: Leadings should be non-negative (because adding ruby annotation can only increase the size): 'startLeading >= 0 && endLeading >= 0', file z:/build/build/src/layout/generic/nsRubyFrame.cpp, line 372
[task 2019-10-22T11:37:58.090Z] 11:37:58 INFO - GECKO(4528) | [Child 5512, Main Thread] WARNING: Leadings should be non-negative (because adding ruby annotation can only increase the size): 'startLeading >= 0 && endLeading >= 0', file z:/build/build/src/layout/generic/nsRubyFrame.cpp, line 372
[task 2019-10-22T11:37:58.265Z] 11:37:58 INFO - GECKO(4528) | [Child 5512, Main Thread] WARNING: We shouldn't be backing up more than once! Someone must have set a break opportunity beyond the available width, even though there were better break opportunities before it: file z:/build/build/src/layout/generic/nsBlockFrame.cpp, line 4184
[task 2019-10-22T11:37:58.320Z] 11:37:58 INFO - GECKO(4528) | [Child 5512, Main Thread] WARNING: Leadings should be non-negative (because adding ruby annotation can only increase the size): 'startLeading >= 0 && endLeading >= 0', file z:/build/build/src/layout/generic/nsRubyFrame.cpp, line 372
[task 2019-10-22T11:37:58.320Z] 11:37:58 INFO - GECKO(4528) | [Child 5512, Main Thread] WARNING: Leadings should be non-negative (because adding ruby annotation can only increase the size): 'startLeading >= 0 && endLeading >= 0', file z:/build/build/src/layout/generic/nsRubyFrame.cpp, line 372
[task 2019-10-22T11:38:07.215Z] 11:38:07 INFO - GECKO(4528) | [Parent 4876, Jump List] WARNING: NS_ENSURE_SUCCES
[task 2019-10-22T11:38:07.215Z] 11:38:07 INFO - GECKO(4528) | S(r
[task 2019-10-22T11:38:07.215Z] 11:38:07 INFO - GECKO(4528) | v, rv) failed with result 0x80520012: file z:/build/buil
[task 2019-10-22T11:38:07.215Z] 11:38:07 INFO - GECKO(4528) | d/src/widget/windows/WinUtils.cpp, line 1346
[task 2019-10-22T11:38:09.050Z] 11:38:09 INFO - GECKO(4528) | [Child 5512, Main Thread] WARNING: We shouldn't be backing up more than once! Someone must have set a break opportunity beyond the available width, even though there were better break opportunities before it: file z:/build/build/src/layout/generic/nsBlockFrame.cpp, line 4184
[task 2019-10-22T11:38:09.109Z] 11:38:09 INFO - GECKO(4528) | [Child 5512, Main Thread] WARNING: Leadings should be non-negative (because adding ruby annotation can only increase the size): 'startLeading >= 0 && endLeading >= 0', file z:/build/build/src/layout/generic/nsRubyFrame.cpp, line 372
[task 2019-10-22T11:38:09.109Z] 11:38:09 INFO - GECKO(4528) | [Child 5512, Main Thread] WARNING: Leadings should be non-negative (because adding ruby annotation can only increase the size): 'startLeading >= 0 && endLeading >= 0', file z:/build/build/src/layout/generic/nsRubyFrame.cpp, line 372
[task 2019-10-22T11:38:15.884Z] 11:38:15 INFO - GECKO(4528) | MEMORY STAT | vsize 1477MB | vsizeMaxContiguous 86MB | residentFast 816MB | heapAllocated 605MB
[task 2019-10-22T11:38:17.619Z] 11:38:17 INFO - GECKO(4528) | out of memory: 0x0000000000001000 bytes requested
[task 2019-10-22T11:38:17.619Z] 11:38:17 INFO - GECKO(4528) | Hit MOZ_CRASH() at z:/build/build/src/memory/mozalloc/mozalloc_abort.cpp:33
[task 2019-10-22T11:38:17.620Z] 11:38:17 INFO - GECKO(4528) | out of memory: 0x0000000000001000 bytes requested
[task 2019-10-22T11:38:17.620Z] 11:38:17 INFO - GECKO(4528) | Hit MOZ_CRASH() at z:/build/build/src/memory/mozalloc/mozalloc_abort.cpp:33
[task 2019-10-22T11:38:17.635Z] 11:38:17 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: IPC message discarded: actor cannot send: file z:/build/build/src/ipc/glue/ProtocolUtils.cpp, line 481
[task 2019-10-22T11:38:17.635Z] 11:38:17 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: IPC message discarded: actor cannot send: file z:/build/build/src/ipc/glue/ProtocolUtils.cpp, line 481
[task 2019-10-22T11:38:17.635Z] 11:38:17 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: IPC message discarded: actor cannot send: file z:/build/build/src/ipc/glue/ProtocolUtils.cpp, line 481
[task 2019-10-22T11:38:17.635Z] 11:38:17 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: IPC message discarded: actor cannot send: file z:/build/build/src/ipc/glue/ProtocolUtils.cpp, line 481
[task 2019-10-22T11:38:17.636Z] 11:38:17 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: IPC message discarded: actor cannot send: file z:/build/build/src/ipc/glue/ProtocolUtils.cpp, line 481
[task 2019-10-22T11:38:17.637Z] 11:38:17 INFO - GECKO(4528) | ++DOCSHELL 0ECBF800 == 5 [pid = 4876] [id = {24a573a3-c721-419d-8b67-1441cb667872}]
[task 2019-10-22T11:38:17.637Z] 11:38:17 INFO - GECKO(4528) | ++DOMWINDOW == 11 (18E71160) [pid = 4876] [serial = 13] [outer = 00000000]
[task 2019-10-22T11:38:17.652Z] 11:38:17 INFO - GECKO(4528) | ++DOMWINDOW == 12 (0ECC1000) [pid = 4876] [serial = 14] [outer = 18E71160]
[task 2019-10-22T11:38:17.659Z] 11:38:17 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: NS_ENSURE_TRUE(frame) failed: file z:/build/build/src/layout/base/nsPresContext.cpp, line 821
[task 2019-10-22T11:38:17.718Z] 11:38:17 ERROR - GECKO(4528) | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2019-10-22T11:38:17.825Z] 11:38:17 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: IPC message discarded: actor cannot send: file z:/build/build/src/ipc/glue/ProtocolUtils.cpp, line 481
[task 2019-10-22T11:38:17.860Z] 11:38:17 INFO - GECKO(4528) | ++DOMWINDOW == 13 (1C0A8800) [pid = 4876] [serial = 15] [outer = 18E71160]
[task 2019-10-22T11:38:17.867Z] 11:38:17 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80070057: file z:/build/build/src/dom/base/ThirdPartyUtil.cpp, line 217
[task 2019-10-22T11:38:17.867Z] 11:38:17 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: NS_ENSURE_TRUE(frame) failed: file z:/build/build/src/layout/base/nsPresContext.cpp, line 821
[task 2019-10-22T11:38:17.902Z] 11:38:17 INFO - GECKO(4528) | --DOCSHELL 08BD5400 == 2 [pid = 5064] [id = {f477fdd2-da6f-4f52-9c9a-57154425e71d}] [url = moz-extension://e60cdbc0-122e-49b1-b777-1e98a6ffc294/_generated_background_page.html]
[task 2019-10-22T11:38:17.902Z] 11:38:17 INFO - GECKO(4528) | --DOCSHELL 08BD3000 == 1 [pid = 5064] [id = {84285c12-f16c-4ea0-b6ef-1d77a513187f}] [url = moz-extension://e06f2527-948d-4251-8204-60edb54d7b6e/_generated_background_page.html]
[task 2019-10-22T11:38:17.902Z] 11:38:17 INFO - GECKO(4528) | --DOCSHELL 00E65C00 == 0 [pid = 5064] [id = {90e39739-7620-4d6e-81c7-21e89caaa532}] [url = moz-extension://cef2aa75-6b99-4646-aebf-a104977bcb3e/_generated_background_page.html]
[task 2019-10-22T11:38:18.979Z] 11:38:18 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:18.994Z] 11:38:18 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: '!inner', file z:/build/build/src/dom/ipc/JSWindowActorService.cpp, line 172
[task 2019-10-22T11:38:19.001Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: file z:/build/build/src/ipc/chromium/src/base/process_util_win.cc, line 160
[task 2019-10-22T11:38:19.002Z] 11:38:19 INFO - GECKO(4528) | --DOCSHELL 1E279C00 == 4 [pid = 4876] [id = {6c2f466b-47ec-4d83-b33f-3e9ab487196d}] [url = chrome://extensions/content/dummy.xul]
[task 2019-10-22T11:38:19.002Z] 11:38:19 INFO - GECKO(4528) | --DOCSHELL 19483C00 == 3 [pid = 4876] [id = {29b3e081-197f-4213-9750-cf376ea368c6}] [url = about:blank]
[task 2019-10-22T11:38:19.009Z] 11:38:19 INFO - GECKO(4528) | [Child 5064, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.009Z] 11:38:19 INFO - GECKO(4528) | [Child 5064, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.019Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.019Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.019Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.020Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.028Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.028Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.043Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file z:/build/build/src/netwerk/cache/nsCacheService.cpp, line 859
[task 2019-10-22T11:38:19.043Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file z:/build/build/src/netwerk/cache/nsCacheService.cpp, line 822
[task 2019-10-22T11:38:19.044Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file z:/build/build/src/netwerk/cache/nsApplicationCacheService.cpp, line 159
[task 2019-10-22T11:38:19.147Z] 11:38:19 INFO - GECKO(4528) | --DOMWINDOW == 5 (08BB75E0) [pid = 5064] [serial = 5] [outer = 00000000] [url = moz-extension://e60cdbc0-122e-49b1-b777-1e98a6ffc294/_generated_background_page.html]
[task 2019-10-22T11:38:19.148Z] 11:38:19 INFO - GECKO(4528) | --DOMWINDOW == 4 (08BB73A0) [pid = 5064] [serial = 3] [outer = 00000000] [url = moz-extension://e06f2527-948d-4251-8204-60edb54d7b6e/_generated_background_page.html]
[task 2019-10-22T11:38:19.148Z] 11:38:19 INFO - GECKO(4528) | --DOMWINDOW == 3 (08BB7040) [pid = 5064] [serial = 1] [outer = 00000000] [url = moz-extension://cef2aa75-6b99-4646-aebf-a104977bcb3e/_generated_background_page.html]
[task 2019-10-22T11:38:19.148Z] 11:38:19 INFO - GECKO(4528) | --DOMWINDOW == 2 (08BDE400) [pid = 5064] [serial = 9] [outer = 00000000] [url = moz-extension://cef2aa75-6b99-4646-aebf-a104977bcb3e/_generated_background_page.html]
[task 2019-10-22T11:38:19.149Z] 11:38:19 INFO - GECKO(4528) | --DOMWINDOW == 1 (08BDF800) [pid = 5064] [serial = 10] [outer = 00000000] [url = moz-extension://e06f2527-948d-4251-8204-60edb54d7b6e/_generated_background_page.html]
[task 2019-10-22T11:38:19.149Z] 11:38:19 INFO - GECKO(4528) | --DOMWINDOW == 0 (08BE0C00) [pid = 5064] [serial = 11] [outer = 00000000] [url = moz-extension://e60cdbc0-122e-49b1-b777-1e98a6ffc294/_generated_background_page.html]
[task 2019-10-22T11:38:19.184Z] 11:38:19 INFO - GECKO(4528) | [2019-10-22T11:38:19Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2019-10-22T11:38:19.184Z] 11:38:19 INFO - GECKO(4528) | [2019-10-22T11:38:19Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2019-10-22T11:38:19.185Z] 11:38:19 INFO - GECKO(4528) | nsStringStats
[task 2019-10-22T11:38:19.186Z] 11:38:19 INFO - GECKO(4528) | => mAllocCount: 15234
[task 2019-10-22T11:38:19.186Z] 11:38:19 INFO - GECKO(4528) | => mReallocCount: 0
[task 2019-10-22T11:38:19.187Z] 11:38:19 INFO - GECKO(4528) | => mFreeCount: 15234
[task 2019-10-22T11:38:19.188Z] 11:38:19 INFO - GECKO(4528) | => mShareCount: 12668
[task 2019-10-22T11:38:19.188Z] 11:38:19 INFO - GECKO(4528) | => mAdoptCount: 390
[task 2019-10-22T11:38:19.188Z] 11:38:19 INFO - GECKO(4528) | => mAdoptFreeCount: 414
[task 2019-10-22T11:38:19.188Z] 11:38:19 INFO - GECKO(4528) | => Process ID: 5064, Thread ID: 2412
[task 2019-10-22T11:38:19.348Z] 11:38:19 INFO - GECKO(4528) | --DOCSHELL 1E40B800 == 2 [pid = 4876] [id = {8b2bad18-8adc-418b-b524-6705e566cbaf}] [url = resource://gre-resources/hiddenWindow.html]
[task 2019-10-22T11:38:19.349Z] 11:38:19 INFO - GECKO(4528) | --DOCSHELL 19952800 == 1 [pid = 4876] [id = {be9b3481-ec63-477a-ac8d-dbd23329af03}] [url = chrome://browser/content/browser.xhtml]
[task 2019-10-22T11:38:19.351Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.351Z] 11:38:19 INFO - GECKO(4528) | [Child 1856, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.351Z] 11:38:19 INFO - GECKO(4528) | [Child 1856, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.366Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.366Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.367Z] 11:38:19 INFO - GECKO(4528) | [Parent 48
[task 2019-10-22T11:38:19.367Z] 11:38:19 INFO - GECKO(4528) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-10-22T11:38:19.367Z] 11:38:19 INFO - GECKO(4528) | 76, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.367Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.368Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.368Z] 11:38:19 INFO - GECKO(4528) | [Parent 4876, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-10-22T11:38:19.429Z] 11:38:19 INFO - GECKO(4528) | nsStringStats
[task 2019-10-22T11:38:19.430Z] 11:38:19 INFO - GECKO(4528) | => mAllocCount: 8382
[task 2019-10-22T11:38:19.430Z] 11:38:19 INFO - GECKO(4528) | => mReallocCount: 0
[task 2019-10-22T11:38:19.431Z] 11:38:19 INFO - GECKO(4528) | => mFreeCount: 8382
[task 2019-10-22T11:38:19.431Z] 11:38:19 INFO - GECKO(4528) | => mShareCount: 9216
[task 2019-10-22T11:38:19.431Z] 11:38:19 INFO - GECKO(4528) | => mAdoptCount: 292
[task 2019-10-22T11:38:19.431Z] 11:38:19 INFO - GECKO(4528) | => mAdoptFreeCount: 292
[task 2019-10-22T11:38:19.432Z] 11:38:19 INFO - GECKO(4528) | => Process ID: 1856, Thread ID: 1636
[task 2019-10-22T11:38:19.475Z] 11:38:19 INFO - GECKO(4528) | console.error: "Could not write session state file " (new Error("TypeError: cannot use 'in' operator to search for "toMsg" in "out of memory"", "resource://gre/modules/workers/require.js line 137 > Function line 3 > eval", 184)) "postMessage@resource://gre/modules/PromiseWorker.jsm:349:17\nAsyncpost@resource://gre/modules/PromiseWorker.jsm:388:17\n_postToWorker@resource:///modules/sessionstore/SessionFile.jsm:411:26\nasyncwrite@resource:///modules/sessionstore/SessionFile.jsm:448:24\nwrite@resource:///modules/sessionstore/SessionFile.jsm:75:32\n_writeState@resource:///modules/sessionstore/SessionSaver.jsm:360:24\n_saveState@resource:///modules/sessionstore/SessionSaver.jsm:294:17\n_saveStateAsync@resource:///modules/sessionstore/SessionSaver.jsm:344:10\nsaveStateAsyncWhenIdle@resource:///modules/sessionstore/SessionSaver.jsm:191:14\ncallback@resource://gre/modules/Timer.jsm:125:16\nChromeUtils::IdleDispatch handler*requestIdleCallback@resource://gre/modules/Timer.jsm:129:15\nrunDelayed/this._timeoutID<@resource:///modules/sessionstore/SessionSaver.jsm:194:30\nnotify@resource://gre/modules/Timer.jsm:62:17\n"
[task 2019-10-22T11:38:29.375Z] 11:38:29 INFO - GECKO(4528) | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"SessionFile: Finish writing Session Restore data","state":{"options":{"isFinalWrite":true,"performShutdownCleanup":true},"attempts":12,"successes":4,"failures":7},"filename":"resource:///modules/sessionstore/SessionFile.jsm","lineNumber":478,"stack":["resource:///modules/sessionstore/SessionFile.jsm:write:478","resource:///modules/sessionstore/SessionFile.jsm:write:75","resource:///modules/sessionstore/SessionSaver.jsm:_writeState:360","resource:///modules/sessionstore/SessionSaver.jsm:_saveState:294","resource:///modules/sessionstore/SessionSaver.jsm:run:154","resource:///modules/sessionstore/SessionSaver.jsm:run:69","resource:///modules/sessionstore/SessionStore.jsm:ssi_uninit:844","resource:///modules/sessionstore/SessionStore.jsm:ssi_onQuitApplication:1980","resource:///modules/sessionstore/SessionStore.jsm:ssi_observe:878","resource:///modules/ContentCrashHandlers.jsm:observe:177"]}] Barrier: profile-before-change
[task 2019-10-22T11:39:20.382Z] 11:39:20 INFO - GECKO(4528) | FATAL ERROR: AsyncShutdown timeout in profile-before-change Conditions: [{"name":"SessionFile: Finish writing Session Restore data","state":{"options":{"isFinalWrite":true,"performShutdownCleanup":true},"attempts":12,"successes":4,"failures":7},"filename":"resource:///modules/sessionstore/SessionFile.jsm","lineNumber":478,"stack":["resource:///modules/sessionstore/SessionFile.jsm:write:478","resource:///modules/sessionstore/SessionFile.jsm:write:75","resource:///modules/sessionstore/SessionSaver.jsm:_writeState:360","resource:///modules/sessionstore/SessionSaver.jsm:_saveState:294","resource:///modules/sessionstore/SessionSaver.jsm:run:154","resource:///modules/sessionstore/SessionSaver.jsm:run:69","resource:///modules/sessionstore/SessionStore.jsm:ssi_uninit:844","resource:///modules/sessionstore/SessionStore.jsm:ssi_onQuitApplication:1980","resource:///modules/sessionstore/SessionStore.jsm:ssi_observe:878","resource:///modules/ContentCrashHandlers.jsm:observe:177"]}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources.
[task 2019-10-22T11:39:20.382Z] 11:39:20 INFO - GECKO(4528) | [Parent 4876, Main Thread] ###!!! ABORT: file resource:///modules/sessionstore/SessionFile.jsm, line 478
[task 2019-10-22T11:39:20.669Z] 11:39:20 INFO - TEST-INFO | Main app process: exit 1
[task 2019-10-22T11:39:20.669Z] 11:39:20 INFO - Buffered messages logged at 11:38:07
[task 2019-10-22T11:39:20.670Z] 11:39:20 INFO - TEST-PASS | layout/style/test/test_value_cloning.html | serialization should match when cloning backdrop-filter: sepia(4.567)

Sorry, not sure about the product and component here.

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

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