Closed Bug 1709643 Opened 3 years ago Closed 3 years ago

Intermittent dom/media/mediasource/test/test_AVC3_mp4.html | unexpected-crash-dump-found - This test left crash dumps behind, but we weren't expecting it to!

Categories

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

Product:
Core
Component:
Audio/Video
Type:
defect

Tracking

()

Status:
RESOLVED DUPLICATE of bug 1708821

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: imoraru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=338829439&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/QKG961pdRM-Skk6G2cCt5Q/runs/0/artifacts/public/logs/live_backing.log

[task 2021-05-05T14:34:46.276Z] 14:34:46     INFO - TEST-START | dom/media/mediasource/test/test_AVC3_mp4.html
[task 2021-05-05T14:34:47.369Z] 14:34:47     INFO - GECKO(1350) | [Child 1354, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-05T14:34:47.385Z] 14:34:47     INFO - GECKO(1350) | [Child 1354, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-05T14:34:47.389Z] 14:34:47     INFO - GECKO(1350) | [Child 1354, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-05T14:34:47.398Z] 14:34:47     INFO - GECKO(1350) | [Child 1354, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:179
[task 2021-05-05T14:34:47.771Z] 14:34:47     INFO - GECKO(1350) | [Child 1354, MediaSupervisor #1] WARNING: 'aIndex >= GetSize()', file /builds/worker/workspace/obj-build/dist/include/nsDeque.h:361
[task 2021-05-05T14:34:47.778Z] 14:34:47     INFO - GECKO(1350) | [1359, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:204
[task 2021-05-05T14:34:47.779Z] 14:34:47     INFO - GECKO(1350) | [1359, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:204
[task 2021-05-05T14:34:47.780Z] 14:34:47     INFO - GECKO(1350) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/cj/pjxvjcl16q9cjktt0r9pg08m000017/T/tmpkfqd44z6.mozrunner/runtests_leaks_rdd_pid1359.log
[task 2021-05-05T14:34:47.780Z] 14:34:47     INFO - GECKO(1350) | [1359, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:204
[task 2021-05-05T14:34:47.781Z] 14:34:47     INFO - GECKO(1350) | [1359, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:204
[task 2021-05-05T14:34:47.782Z] 14:34:47     INFO - GECKO(1350) | [1359, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:254
[task 2021-05-05T14:34:48.051Z] 14:34:48     INFO - GECKO(1350) | [Parent 1350, Unnamed thread 129269b30] WARNING: Resource acquired is being released in non-LIFO order; why?
[task 2021-05-05T14:34:48.052Z] 14:34:48     INFO - GECKO(1350) | : file /builds/worker/checkouts/gecko/xpcom/threads/BlockingResourceBase.cpp:290
[task 2021-05-05T14:34:48.053Z] 14:34:48     INFO - GECKO(1350) | --- Mutex : dumpSafetyLock (currently acquired)
[task 2021-05-05T14:34:48.054Z] 14:34:48     INFO - GECKO(1350) |  calling context
[task 2021-05-05T14:34:48.054Z] 14:34:48     INFO - GECKO(1350) |   [stack trace unavailable]
[task 2021-05-05T14:34:49.551Z] 14:34:49     INFO - GECKO(1350) | [Child 1356, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8427
[task 2021-05-05T14:34:49.552Z] 14:34:49     INFO - GECKO(1350) | [Child 1356, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8427
[task 2021-05-05T14:34:49.553Z] 14:34:49     INFO - GECKO(1350) | [Child 1356, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8427
[task 2021-05-05T14:34:50.255Z] 14:34:50     INFO - GECKO(1350) | [Child 1354, MediaSupervisor #1] WARNING: 'aIndex >= GetSize()', file /builds/worker/workspace/obj-build/dist/include/nsDeque.h:361
[task 2021-05-05T14:34:50.297Z] 14:34:50     INFO - GECKO(1350) | [1361, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:204
[task 2021-05-05T14:34:50.298Z] 14:34:50     INFO - GECKO(1350) | [1361, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:204
[task 2021-05-05T14:34:50.299Z] 14:34:50     INFO - GECKO(1350) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/cj/pjxvjcl16q9cjktt0r9pg08m000017/T/tmpkfqd44z6.mozrunner/runtests_leaks_rdd_pid1361.log
[task 2021-05-05T14:34:50.300Z] 14:34:50     INFO - GECKO(1350) | [1361, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:204
[task 2021-05-05T14:34:50.300Z] 14:34:50     INFO - GECKO(1350) | [1361, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:204
[task 2021-05-05T14:34:50.301Z] 14:34:50     INFO - GECKO(1350) | [1361, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:254
[task 2021-05-05T14:34:50.323Z] 14:34:50     INFO - GECKO(1350) | _RegisterApplication(), FAILED TO establish the default connection to the WindowServer, _CGSDefaultConnection() is NULL.
[task 2021-05-05T14:34:50.327Z] 14:34:50     INFO - GECKO(1350) | [Parent 1350, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:532
[task 2021-05-05T14:34:50.467Z] 14:34:50     INFO - GECKO(1350) | [2021-05-05T14:34:50Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:50.483Z] 14:34:50     INFO - GECKO(1350) | [2021-05-05T14:34:50Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:50.534Z] 14:34:50     INFO - GECKO(1350) | [2021-05-05T14:34:50Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:50.567Z] 14:34:50     INFO - GECKO(1350) | [2021-05-05T14:34:50Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:50.617Z] 14:34:50     INFO - GECKO(1350) | [2021-05-05T14:34:50Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
<...>
[task 2021-05-05T14:34:53.953Z] 14:34:53     INFO - GECKO(1350) | [2021-05-05T14:34:53Z WARN  rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2021-05-05T14:34:53.967Z] 14:34:53     INFO - GECKO(1350) | [2021-05-05T14:34:53Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:54.018Z] 14:34:54     INFO - GECKO(1350) | [2021-05-05T14:34:54Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:54.050Z] 14:34:54     INFO - GECKO(1350) | [2021-05-05T14:34:54Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:54.099Z] 14:34:54     INFO - GECKO(1350) | [2021-05-05T14:34:54Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:54.133Z] 14:34:54     INFO - GECKO(1350) | [2021-05-05T14:34:54Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:54.167Z] 14:34:54     INFO - GECKO(1350) | [2021-05-05T14:34:54Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:54.217Z] 14:34:54     INFO - GECKO(1350) | [2021-05-05T14:34:54Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:54.250Z] 14:34:54     INFO - GECKO(1350) | [2021-05-05T14:34:54Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:54.300Z] 14:34:54     INFO - GECKO(1350) | [2021-05-05T14:34:54Z WARN  webrender::resource_cache] ERROR: Trying to render deleted / non-existent key
[task 2021-05-05T14:34:54.353Z] 14:34:54     INFO - GECKO(1350) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2021-05-05T14:34:54.353Z] 14:34:54     INFO - GECKO(1350) | MEMORY STAT | vsize 6622MB | residentFast 97MB | heapAllocated 10MB
[task 2021-05-05T14:34:54.370Z] 14:34:54     INFO - Buffered messages logged at 14:34:47
[task 2021-05-05T14:34:54.372Z] 14:34:54     INFO - TEST-PASS | dom/media/mediasource/test/test_AVC3_mp4.html | Receive a sourceopen event 
[task 2021-05-05T14:34:54.372Z] 14:34:54     INFO - TEST-PASS | dom/media/mediasource/test/test_AVC3_mp4.html | fetchWithXHR load uri='avc3/init.mp4' status=200 
[task 2021-05-05T14:34:54.373Z] 14:34:54     INFO - Loading buffer: [0, 687)
[task 2021-05-05T14:34:54.374Z] 14:34:54     INFO - SourceBuffer buffered ranges grew from TimeRanges:  to TimeRanges: 
[task 2021-05-05T14:34:54.374Z] 14:34:54     INFO - Buffered messages logged at 14:34:50
[task 2021-05-05T14:34:54.376Z] 14:34:54     INFO - TEST-PASS | dom/media/mediasource/test/test_AVC3_mp4.html | fetchWithXHR load uri='avc3/segment1.m4s' status=200 
[task 2021-05-05T14:34:54.377Z] 14:34:54     INFO - Loading buffer: [0, 696869)
[task 2021-05-05T14:34:54.377Z] 14:34:54     INFO - SourceBuffer buffered ranges grew from TimeRanges:  to TimeRanges: [0, 3.84)
[task 2021-05-05T14:34:54.377Z] 14:34:54     INFO - TEST-PASS | dom/media/mediasource/test/test_AVC3_mp4.html | continuous buffered range 
[task 2021-05-05T14:34:54.377Z] 14:34:54     INFO - TEST-PASS | dom/media/mediasource/test/test_AVC3_mp4.html | got loadeddata 
[task 2021-05-05T14:34:54.378Z] 14:34:54     INFO - TEST-PASS | dom/media/mediasource/test/test_AVC3_mp4.html | endOfStream completed 
[task 2021-05-05T14:34:54.379Z] 14:34:54     INFO - Buffered messages finished
[task 2021-05-05T14:34:54.380Z] 14:34:54     INFO - TEST-UNEXPECTED-ERROR | dom/media/mediasource/test/test_AVC3_mp4.html | unexpected-crash-dump-found - This test left crash dumps behind, but we weren't expecting it to!
[task 2021-05-05T14:34:54.380Z] 14:34:54     INFO - Found unexpected crash dump file /var/folders/cj/pjxvjcl16q9cjktt0r9pg08m000017/T/tmpkfqd44z6.mozrunner/minidumps/789F8B8A-87B4-4245-BEBC-48A7D5F04A99.dmp.
[task 2021-05-05T14:34:54.384Z] 14:34:54     INFO - TEST-UNEXPECTED-CRASH | dom/media/mediasource/test/test_AVC3_mp4.html | Finished in 8110ms
[task 2021-05-05T14:34:54.384Z] 14:34:54     INFO - {'runtime': 8110}
[task 2021-05-05T14:34:54.384Z] 14:34:54     INFO - TEST-INFO took 8110ms
[task 2021-05-05T14:34:54.455Z] 14:34:54     INFO - TEST-START | dom/media/mediasource/test/test_AbortAfterPartialMediaSegment.html```
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.