Closed Bug 1471718 Opened 7 years ago Closed 5 years ago

Intermittent GECKO(2285) | FATAL ERROR: AsyncShutdown timeout in xpcom-will-shutdown Conditions: [{"name":"MediaShutdownManager: shutdown","state":"(none)","filename":"/builds/worker/workspace/build/src/dom/media/MediaShutdownManager.cpp"...

Categories

(Core :: Audio/Video: Playback, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

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

Filed by: aciure [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=185203432&repo=autoland https://queue.taskcluster.net/v1/task/SF88eA4zRdyzrQAFt0pTIQ/runs/0/artifacts/public/logs/live_backing.log 0:46:29 INFO - GECKO(2285) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2D00FA,name=PContent::Msg_AccumulateChildHistograms) Closed channel: cannot send/recv 10:46:29 INFO - GECKO(2285) | [Child 2286, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2396 10:46:29 INFO - GECKO(2285) | [Child 2286, Main Thread] WARNING: '!ipcActor->SendAccumulateChildHistograms(histogramsToSend)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 296 10:46:29 INFO - GECKO(2285) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2D00FF,name=PContent::Msg_RecordDiscardedData) Closed channel: cannot send/recv 10:46:29 INFO - GECKO(2285) | [Child 2286, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2396 10:46:29 INFO - GECKO(2285) | [Child 2286, Main Thread] WARNING: '!ipcActor->SendRecordDiscardedData(discardedData)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 315 10:46:32 INFO - GECKO(2285) | FATAL ERROR: AsyncShutdown timeout in xpcom-will-shutdown Conditions: [{"name":"MediaShutdownManager: shutdown","state":"(none)","filename":"/builds/worker/workspace/build/src/dom/media/MediaShutdownManager.cpp","lineNumber":83,"stack":"MediaShutdownManager shutdown"}] 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. 10:46:32 INFO - GECKO(2285) | [Child 2286, Main Thread] ###!!! ABORT: file /builds/worker/workspace/build/src/dom/media/MediaShutdownManager.cpp, line 83 10:46:32 INFO - GECKO(2285) | [Child 2286, Main Thread] ###!!! ABORT: file /builds/worker/workspace/build/src/dom/media/MediaShutdownManager.cpp, line 83 10:46:32 INFO - GECKO(2285) | Hit MOZ_CRASH() at /builds/worker/workspace/build/src/memory/mozalloc/mozalloc_abort.cpp:34 10:46:32 INFO - GECKO(2285) | [Child 2286, ImageBridgeChild] WARNING: long timeout didn't get an id (ipc/rcv) timed out 10004003 10:46:32 INFO - GECKO(2285) | : file /builds/worker/workspace/build/src/ipc/glue/SharedMemoryBasic_mach.mm, line 621 10:46:32 INFO - GECKO(2285) | [Child 2286, MediaPDecoder #4] WARNING: SharedPlanarYCbCrImage::Allocate failed.: file /builds/worker/workspace/build/src/gfx/layers/ipc/SharedPlanarYCbCrImage.cpp, line 161 10:46:32 INFO - GECKO(2285) | [Parent 2285, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 794 10:46:33 INFO - GECKO(2285) | --DOMWINDOW == 7 (0x11aff3800) [pid = 2285] [serial = 2] [outer = 0x0] [url = about:blank] 10:46:33 INFO - GECKO(2285) | --DOMWINDOW == 6 (0x11787e800) [pid = 2285] [serial = 4] [outer = 0x0] [url = about:blank] 10:46:33 INFO - GECKO(2285) | --DOMWINDOW == 5 (0x117e9b800) [pid = 2285] [serial = 3] [outer = 0x0] [url = chrome://browser/content/browser.xul] 10:46:33 INFO - GECKO(2285) | --DOMWINDOW == 4 (0x10655d800) [pid = 2285] [serial = 1] [outer = 0x0] [url = chrome://browser/content/hiddenWindow.xul] 10:46:33 INFO - GECKO(2285) | --DOMWINDOW == 3 (0x124a93800) [pid = 2285] [serial = 9] [outer = 0x0] [url = chrome://extensions/content/dummy.xul] 10:46:33 INFO - GECKO(2285) | --DOMWINDOW == 2 (0x1288a8c00) [pid = 2285] [serial = 12] [outer = 0x0] [url = chrome://extensions/content/dummy.xul] 10:46:33 INFO - GECKO(2285) | --DOMWINDOW == 1 (0x125a48c00) [pid = 2285] [serial = 8] [outer = 0x0] [url = about:blank] 10:46:33 INFO - GECKO(2285) | --DOMWINDOW == 0 (0x124929000) [pid = 2285] [serial = 5] [outer = 0x0] [url = about:blank] 10:46:33 INFO - GECKO(2285) | nsStringStats 10:46:33 INFO - GECKO(2285) | => mAllocCount: 113855 10:46:33 INFO - GECKO(2285) | => mReallocCount: 11578 10:46:33 INFO - GECKO(2285) | => mFreeCount: 113855 10:46:33 INFO - GECKO(2285) | => mShareCount: 110372 10:46:33 INFO - GECKO(2285) | => mAdoptCount: 4200 10:46:33 INFO - GECKO(2285) | => mAdoptFreeCount: 4472 10:46:33 INFO - GECKO(2285) | => Process ID: 2285, Thread ID: 140735126074112 10:46:34 INFO - TEST-INFO | Main app process: exit 0
Component: Audio/Video → Audio/Video: Playback
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → INCOMPLETE
Recent failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=198472956&repo=mozilla-central&lineNumber=6108 18:05:51 INFO - [Parent 6116, LoadRoots] WARNING: This method is lossy. Use GetCanonicalPath !: file z:/build/build/src/xpcom/io/nsLocalFileWin.cpp, line 3460 18:05:51 INFO - [Parent 6116, LoadRoots] WARNING: This method is lossy. Use GetCanonicalPath !: file z:/build/build/src/xpcom/io/nsLocalFileWin.cpp, line 3460 18:05:52 INFO - 1536602752215 Marionette DEBUG Waiting for startup tests... 18:05:52 INFO - FATAL ERROR: AsyncShutdown timeout in xpcom-will-shutdown Conditions: [{"name":"MediaShutdownManager: shutdown","state":"(none)","filename":"z:/build/build/src/dom/media/MediaShutdownManager.cpp","lineNumber":83,"stack":"MediaShutdownManager shutdown"}] 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. 18:05:52 INFO - [Child 5188, Main Thread] ###!!! ABORT: file z:/build/build/src/dom/media/MediaShutdownManager.cpp, line 83 18:05:53 INFO - 1536602752805 Marionette INFO Listening on port 2828 18:05:53 INFO - 1536602752808 Marionette DEBUG Remote service is active 18:05:53 INFO - 1536602753352 Marionette DEBUG Accepted connection 0 from 127.0.0.1:49976 18:05:53 INFO - 1536602753359 Marionette DEBUG Accepted connection 1 from 127.0.0.1:49977 18:05:53 INFO - 1536602753494 Marionette DEBUG Closed connection 1 18:05:53 INFO - 1536602753499 Marionette DEBUG Closed connection 0 18:05:53 INFO - 1536602753533 Marionette DEBUG Accepted connection 2 from 127.0.0.1:49978 18:05:53 INFO - [Parent 6116, Main Thread] WARNING: Suboptimal indexes for the SQL statement 0x1266ec40 (http://mzl.la/1FuID0j).: file z:/build/build/src/storage/mozStoragePrivateHelpers.cpp, line 114
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 7 years ago6 years ago
Resolution: --- → INCOMPLETE

Since this was reopened, 6 days ago, there are 40 failures.
They occur on osx-10-10 debug, windows10-64 asan.
Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=224909904&repo=autoland&lineNumber=88809

Whiteboard: [stockwell needswork]

There are 20 total failures in the last 7 days on osx-10-10 debug.

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=242139699&repo=autoland&lineNumber=88778

21:46:36 INFO - TEST-START | /service-workers/service-worker/fetch-frame-resource.https.html
21:46:59 INFO - PID 3704 | FATAL ERROR: AsyncShutdown timeout in xpcom-will-shutdown Conditions: [{"name":"MediaShutdownManager: shutdown","state":"(none)","filename":"/builds/worker/workspace/build/src/dom/media/MediaShutdownManager.cpp","lineNumber":75,"stack":"MediaShutdownManager shutdown"}] 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.
21:46:59 INFO - PID 3704 | [Child 3747, Main Thread] ###!!! ABORT: file /builds/worker/workspace/build/src/dom/media/MediaShutdownManager.cpp, line 75
21:46:59 INFO - PID 3704 | [Child 3747, Main Thread] ###!!! ABORT: file /builds/worker/workspace/build/src/dom/media/MediaShutdownManager.cpp, line 75
21:46:59 INFO - PID 3704 | Hit MOZ_CRASH() at /builds/worker/workspace/build/src/memory/mozalloc/mozalloc_abort.cpp:33
21:46:59 INFO - PID 3704 | [Child 3772, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 574
21:46:59 INFO - PID 3704 | [Child 3772, Main Thread] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/workspace/build/src/dom/workers/WorkerPrivate.cpp, line 1355
21:46:59 INFO - PID 3704 | [Child 3772, Main Thread] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/workspace/build/src/dom/workers/WorkerPrivate.cpp, line 1355
21:46:59 INFO - PID 3704 | [Child 3706, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 574
21:46:59 INFO - PID 3704 | [Child 3707, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 574
21:46:59 INFO - PID 3704 | [Child 3709, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 574
21:46:59 INFO - PID 3704 | [Child 3773, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 574
21:46:59 INFO - PID 3704 | [Parent 3704, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 574
21:46:59 INFO - mozcrash ......
21:46:59 INFO - mozcrash Copy/paste: /Users/cltbld/tasks/task_1556051635/build/macosx64-minidump_stackwalk /var/folders/gg/mblncdk92817dw3x4n81dg8400000x/T/tmphCszR3.mozrunner/minidumps/E39A89A9-029F-4E0B-B00F-656EA2E59B69.dmp /Users/cltbld/tasks/task_1556051635/build/symbols
21:46:59 INFO - mozcrash Saved minidump as /Users/cltbld/tasks/task_1556051635/build/blobber_upload_dir/E39A89A9-029F-4E0B-B00F-656EA2E59B69.dmp
21:46:59 INFO - PROCESS-CRASH | /service-workers/service-worker/fetch-frame-resource.https.html | application crashed [None]
21:46:59 INFO - Crash dump filename: /var/folders/gg/mblncdk92817dw3x4n81dg8400000x/T/tmphCszR3.mozrunner/minidumps/E39A89A9-029F-4E0B-B00F-656EA2E59B69.dmp
21:46:59 INFO - stderr from minidump_stackwalk:
21:46:59 INFO - 2019-04-23 21:46:59: minidump.cc:5209: ERROR: Minidump header signature mismatch: (0x0, 0x0) != 0x504d444d
21:46:59 INFO - 2019-04-23 21:46:59: minidump_stackwalk.cc:139: ERROR: Minidump /var/folders/gg/mblncdk92817dw3x4n81dg8400000x/T/tmphCszR3.mozrunner/minidumps/E39A89A9-029F-4E0B-B00F-656EA2E59B69.dmp could not be read
21:46:59 INFO - Found a crash dump; should change status from OK to CRASH but this causes instability
21:46:59 INFO - TEST-OK | /service-workers/service-worker/fetch-frame-resource.https.html | took 22662ms

Nils, could you please assign this to someone?

Flags: needinfo?(drno)
Whiteboard: [stockwell unknown] → [stockwell unknown][stockwell needswork:owner]
Flags: needinfo?(drno)
Whiteboard: [stockwell unknown][stockwell needswork:owner] → [stockwell unknown]
Status: REOPENED → RESOLVED
Closed: 6 years ago5 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 5 years ago5 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 5 years ago5 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.