Closed
Bug 1241773
Opened 9 years ago
Closed 8 years ago
Intermittent LeakSanitizer | leak at __interceptor_posix_memalign, av_malloc, av_mallocz, avcodec_get_context_defaults3
Categories
(Core :: Audio/Video: Playback, defect, P3)
Core
Audio/Video: Playback
Tracking
()
RESOLVED
WORKSFORME
People
(Reporter: nigelb, Unassigned)
References
(Blocks 1 open bug, )
Details
(Keywords: intermittent-failure, memory-leak)
https://treeherder.mozilla.org/logviewer.html#?job_id=20263889&repo=mozilla-inbound
20:30:05 INFO - ######################## extensions.js loaded
20:30:06 INFO - [Child 9105] WARNING: g_path_get_basename: assertion `file_name != NULL' failed: 'glib warning', file /builds/slave/m-in-l64-asan-0000000000000000/build/src/toolkit/xre/nsSigHandlers.cpp, line 142
20:30:06 INFO - (process:9105): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed
20:30:07 INFO - ###################################### BrowserElementCopyPaste.js loaded
20:30:07 INFO - ############################### browserElementPanning.js loaded
20:30:07 INFO - ######################## BrowserElementChildPreload.js loaded
20:30:07 INFO - ######################## extensions.js loaded
20:30:08 INFO - XPCOM_MEM_BLOAT_LOG: /tmp/tmp5wcLh4.mozrunner/runtests_leaks.log
20:30:08 INFO - Writing to log: /tmp/tmp5wcLh4.mozrunner/runtests_leaks_tab_pid9082.log
20:30:08 INFO - ASAN:SIGSEGV
20:30:08 INFO - =================================================================
20:30:08 INFO - ==9082==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000008 (pc 0x7fa07124a498 sp 0x7fffe672a6e0 bp 0x7fffe672b0f0 T0)
20:30:09 INFO - #0 0x7fa07124a497 in js::ctypes::ConvertToJS(JSContext*, JS::Handle<JSObject*>, JS::Handle<JSObject*>, void*, bool, bool, JS::MutableHandle<JS::Value>) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/ctypes/CTypes.cpp:2745
20:30:09 INFO - #1 0x7fa0712499ec in js::ctypes::PointerType::ContentsGetter(JSContext*, JS::CallArgs const&) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/ctypes/CTypes.cpp:4874
20:30:09 INFO - #2 0x7fa0712a539f in CallNonGenericMethod<&js::ctypes::PointerType::IsPointer, &js::ctypes::PointerType::ContentsGetter> /builds/slave/m-in-l64-asan-0000000000000000/build/src/obj-firefox/dist/include/js/CallNonGenericMethod.h:100
20:30:09 INFO - #3 0x7fa0712a539f in js::ctypes::Property<&js::ctypes::PointerType::IsPointer, &js::ctypes::PointerType::ContentsGetter>::Fun(JSContext*, unsigned int, JS::Value*) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/ctypes/CTypes.cpp:223
20:30:09 INFO - #4 0x7fa071f3268c in CallJSNative /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/jscntxtinlines.h:235
20:30:09 INFO - #5 0x7fa071f3268c in js::Invoke(JSContext*, JS::CallArgs const&, js::MaybeConstruct) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/Interpreter.cpp:475
20:30:09 INFO - #6 0x7fa071f83df4 in js::Invoke(JSContext*, JS::Value const&, JS::Value const&, unsigned int, JS::Value const*, JS::MutableHandle<JS::Value>) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/Interpreter.cpp:527
20:30:09 INFO - #7 0x7fa071f849b6 in js::InvokeGetter(JSContext*, JS::Value const&, JS::Value, JS::MutableHandle<JS::Value>) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/Interpreter.cpp:636
20:30:09 INFO - #8 0x7fa072026a17 in CallGetter /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/NativeObject.cpp:1672
20:30:09 INFO - #9 0x7fa072026a17 in GetExistingProperty<1> /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/NativeObject.cpp:1720
20:30:09 INFO - #10 0x7fa072026a17 in NativeGetPropertyInline<1> /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/NativeObject.cpp:1939
20:30:09 INFO - #11 0x7fa072026a17 in js::NativeGetProperty(JSContext*, JS::Handle<js::NativeObject*>, JS::Handle<JS::Value>, JS::Handle<jsid>, JS::MutableHandle<JS::Value>) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/NativeObject.cpp:1973
20:30:09 INFO - #12 0x7fa071e1bfbe in GetProperty /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/NativeObject.h:1471
20:30:09 INFO - #13 0x7fa071e1bfbe in js::DirectProxyHandler::get(JSContext*, JS::Handle<JSObject*>, JS::Handle<JS::Value>, JS::Handle<jsid>, JS::MutableHandle<JS::Value>) const /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/proxy/DirectProxyHandler.cpp:232
20:30:09 INFO - #14 0x7fa071deaf66 in js::CrossCompartmentWrapper::get(JSContext*, JS::Handle<JSObject*>, JS::Handle<JS::Value>, JS::Handle<jsid>, JS::MutableHandle<JS::Value>) const /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/proxy/CrossCompartmentWrapper.cpp:165
20:30:09 INFO - #15 0x7fa071e20bb1 in js::Proxy::get(JSContext*, JS::Handle<JSObject*>, JS::Handle<JS::Value>, JS::Handle<jsid>, JS::MutableHandle<JS::Value>) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/proxy/Proxy.cpp:300
20:30:09 INFO - #16 0x7fa071f89145 in GetProperty /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/NativeObject.h:1470
20:30:09 INFO - #17 0x7fa071f89145 in GetProperty /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/jsobj.h:822
20:30:09 INFO - #18 0x7fa071f89145 in js::GetProperty(JSContext*, JS::Handle<JS::Value>, JS::Handle<js::PropertyName*>, JS::MutableHandle<JS::Value>) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/Interpreter.cpp:4067
20:30:09 INFO - #19 0x7fa071f7372b in GetPropertyOperation /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/Interpreter.cpp:219
20:30:09 INFO - #20 0x7fa071f7372b in Interpret(JSContext*, js::RunState&) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/Interpreter.cpp:2517
20:30:09 INFO - #21 0x7fa071f535bd in js::RunScript(JSContext*, js::RunState&) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/Interpreter.cpp:425
20:30:09 INFO - #22 0x7fa071f8523b in js::ExecuteKernel(JSContext*, JS::Handle<JSScript*>, JSObject&, JS::Value const&, js::AbstractFramePtr, JS::Value*) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/vm/Interpreter.cpp:680
20:30:09 INFO - #23 0x7fa071351a0a in js::ExecuteInGlobalAndReturnScope(JSContext*, JS::Handle<JSObject*>, JS::Handle<JSScript*>, JS::MutableHandle<JSObject*>) /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/builtin/Eval.cpp:485
20:30:09 INFO - #24 0x7fa06a2ae7d4 in nsMessageManagerScriptExecutor::LoadScriptInternal(nsAString_internal const&, bool) /builds/slave/m-in-l64-asan-0000000000000000/build/src/dom/base/nsFrameMessageManager.cpp:1686
20:30:09 INFO - #25 0x7fa06d66f4b8 in RecvLoadRemoteScript /builds/slave/m-in-l64-asan-0000000000000000/build/src/dom/ipc/TabChild.cpp:2198
20:30:09 INFO - #26 0x7fa06d66f4b8 in non-virtual thunk to mozilla::dom::TabChild::RecvLoadRemoteScript(nsString const&, bool const&) /builds/slave/m-in-l64-asan-0000000000000000/build/src/obj-firefox/dom/ipc/Unified_cpp_dom_ipc1.cpp:2200
20:30:09 INFO - #27 0x7fa069000b99 in mozilla::dom::PBrowserChild::OnMessageReceived(IPC::Message const&) /builds/slave/m-in-l64-asan-0000000000000000/build/src/obj-firefox/ipc/ipdl/PBrowserChild.cpp:3824
20:30:09 INFO - #28 0x7fa0690fbf95 in mozilla::dom::PContentBridgeChild::OnMessageReceived(IPC::Message const&) /builds/slave/m-in-l64-asan-0000000000000000/build/src/obj-firefox/ipc/ipdl/PContentBridgeChild.cpp:626
20:30:09 INFO - #29 0x7fa06895167c in mozilla::ipc::MessageChannel::DispatchAsyncMessage(IPC::Message const&) /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/glue/MessageChannel.cpp:1447
20:30:09 INFO - #30 0x7fa06894f08c in mozilla::ipc::MessageChannel::DispatchMessage(IPC::Message const&) /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/glue/MessageChannel.cpp:1382
20:30:09 INFO - #31 0x7fa06893ff22 in mozilla::ipc::MessageChannel::OnMaybeDequeueOne() /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/glue/MessageChannel.cpp:1351
20:30:09 INFO - #32 0x7fa0688c5894 in RunTask /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/chromium/src/base/message_loop.cc:364
20:30:09 INFO - #33 0x7fa0688c5894 in MessageLoop::DeferOrRunPendingTask(MessageLoop::PendingTask const&) /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/chromium/src/base/message_loop.cc:372
20:30:09 INFO - #34 0x7fa0688c6947 in MessageLoop::DoWork() /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/chromium/src/base/message_loop.cc:459
20:30:09 INFO - #35 0x7fa068958e62 in mozilla::ipc::DoWorkRunnable::Run() /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/glue/MessagePump.cpp:220
20:30:09 INFO - #36 0x7fa067f348bf in nsThread::ProcessNextEvent(bool, bool*) /builds/slave/m-in-l64-asan-0000000000000000/build/src/xpcom/threads/nsThread.cpp:997
20:30:09 INFO - #37 0x7fa067fb028a in NS_ProcessNextEvent(nsIThread*, bool) /builds/slave/m-in-l64-asan-0000000000000000/build/src/xpcom/glue/nsThreadUtils.cpp:297
20:30:09 INFO - #38 0x7fa068958478 in mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/glue/MessagePump.cpp:127
20:30:09 INFO - #39 0x7fa0688c441c in RunInternal /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/chromium/src/base/message_loop.cc:234
20:30:09 INFO - #40 0x7fa0688c441c in RunHandler /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/chromium/src/base/message_loop.cc:227
20:30:09 INFO - #41 0x7fa0688c441c in MessageLoop::Run() /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/chromium/src/base/message_loop.cc:201
20:30:09 INFO - #42 0x7fa06dc9ef17 in nsBaseAppShell::Run() /builds/slave/m-in-l64-asan-0000000000000000/build/src/widget/nsBaseAppShell.cpp:156
20:30:09 INFO - #43 0x7fa06fbd7582 in XRE_RunAppShell /builds/slave/m-in-l64-asan-0000000000000000/build/src/toolkit/xre/nsEmbedFunctions.cpp:789
20:30:09 INFO - #44 0x7fa0688c441c in RunInternal /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/chromium/src/base/message_loop.cc:234
20:30:09 INFO - #45 0x7fa0688c441c in RunHandler /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/chromium/src/base/message_loop.cc:227
20:30:09 INFO - #46 0x7fa0688c441c in MessageLoop::Run() /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/chromium/src/base/message_loop.cc:201
20:30:09 INFO - #47 0x7fa06fbd6c71 in XRE_InitChildProcess /builds/slave/m-in-l64-asan-0000000000000000/build/src/toolkit/xre/nsEmbedFunctions.cpp:625
20:30:10 INFO - #48 0x48d760 in content_process_main(int, char**) /builds/slave/m-in-l64-asan-0000000000000000/build/src/ipc/app/../contentproc/plugin-container.cpp:237
20:30:10 INFO - #49 0x7fa06580176c (/lib/x86_64-linux-gnu/libc.so.6+0x2176c)
20:30:10 INFO - #50 0x48cabc in _start (/builds/slave/test/build/application/firefox/plugin-container+0x48cabc)
20:30:10 INFO - AddressSanitizer can not provide additional info.
20:30:10 INFO - SUMMARY: AddressSanitizer: SEGV /builds/slave/m-in-l64-asan-0000000000000000/build/src/js/src/ctypes/CTypes.cpp:2745 js::ctypes::ConvertToJS(JSContext*, JS::Handle<JSObject*>, JS::Handle<JSObject*>, void*, bool, bool, JS::MutableHandle<JS::Value>)
20:30:10 INFO - ==9082==ABORTING
20:30:10 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0084,name=PBrowser::Msg_Destroy) Channel error: cannot send/recv
20:30:10 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0042,name=PBrowser::Msg_UpdateZoomConstraints) Channel error: cannot send/recv
20:30:10 INFO - -- InterAppCommService: 1453437010431: Finish updating registered/allowed connections for an uninstalled app.
20:30:10 INFO - MEMORY STAT | vsize 20972390MB | residentFast 266MB
20:30:10 INFO - 2322 INFO TEST-OK | dom/ipc/tests/test_permission_when_oop_app_crashes.html | took 13542ms
20:30:11 INFO - 1453437011398 addons.xpi WARN Exception running bootstrap method shutdown on special-powers@mozilla.org: [Exception... "Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIObserverService.removeObserver]" nsresult: "0x80070057 (NS_ERROR_ILLEGAL_VALUE)" location: "JS frame :: resource://gre/modules/RemoteAddonsParent.jsm :: ObserverInterposition.methods.removeObserver :: line 388" data: no] Stack trace: ObserverInterposition.methods.removeObserver()@resource://gre/modules/RemoteAddonsParent.jsm:388 < AddonInterpositionService.prototype.interposeProperty/desc.value()@resource://gre/components/multiprocessShims.js:160 < SpecialPowersObserver.prototype.uninit/<()@SpecialPowersObserver.jsm:139 < SpecialPowersObserver.prototype.uninit()@SpecialPowersObserver.jsm:138 < shutdown()@resource://gre/modules/addons/XPIProvider.jsm -> file:///tmp/tmp5wcLh4.mozrunner/extensions/special-powers@mozilla.org/bootstrap.js:35 < this.XPIProvider.callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4645 < this.XPIProvider.startup/<.observe()@resource://gre/modules/addons/XPIProvider.jsm:2757 < SpecialPowersObserver.prototype.receiveMessage()@SpecialPowersObserver.jsm:247 < permitUnload()@remote-browser.xml:329 < CanCloseWindow()@browser.js:6232 < canClose()@browser.js:4971 < SpecialPowersObserver.prototype.receiveMessage()@SpecialPowersObserver.jsm:247
20:30:11 INFO - JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank]
20:30:12 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost
20:30:13 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost
20:30:15 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost
20:30:15 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost
20:30:15 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost
20:30:15 INFO - -----------------------------------------------------
20:30:15 INFO - Suppressions used:
20:30:15 INFO - count bytes template
20:30:15 INFO - 821 26248 nsComponentManagerImpl
20:30:15 INFO - 6 816 mozJSComponentLoader::LoadModule
20:30:15 INFO - 1 384 pixman_implementation_lookup_composite
20:30:15 INFO - 360 15936 libfontconfig.so
20:30:15 INFO - 8 1816 MessageLoop::MessageLoop
20:30:15 INFO - 1 24 base::WaitableEvent::TimedWait
20:30:15 INFO - 6 192 libcairo.so
20:30:15 INFO - 1 32 libdl.so
20:30:15 INFO - 26 6492 libglib-2.0.so
20:30:15 INFO - -----------------------------------------------------
20:30:16 INFO - -----------------------------------------------------
20:30:16 INFO - Suppressions used:
20:30:16 INFO - count bytes template
20:30:16 INFO - 824 26336 nsComponentManagerImpl
20:30:16 INFO - 9 1224 mozJSComponentLoader::LoadModule
20:30:16 INFO - 1 384 pixman_implementation_lookup_composite
20:30:16 INFO - 360 15936 libfontconfig.so
20:30:16 INFO - 8 1816 MessageLoop::MessageLoop
20:30:16 INFO - 1 24 base::WaitableEvent::TimedWait
20:30:16 INFO - 6 192 libcairo.so
20:30:16 INFO - 1 32 libdl.so
20:30:16 INFO - 26 6492 libglib-2.0.so
20:30:16 INFO - -----------------------------------------------------
20:30:20 INFO - -----------------------------------------------------
20:30:20 INFO - Suppressions used:
20:30:20 INFO - count bytes template
20:30:20 INFO - 40 986 libc.so
20:30:20 INFO - 832 26584 nsComponentManagerImpl
20:30:20 INFO - 51 6936 mozJSComponentLoader::LoadModule
20:30:20 INFO - 1 384 pixman_implementation_lookup_composite
20:30:20 INFO - 360 15936 libfontconfig.so
20:30:20 INFO - 1 32 libdl.so
20:30:20 INFO - 26 6492 libglib-2.0.so
20:30:20 INFO - 2 56 libresolv.so
20:30:20 INFO - -----------------------------------------------------
20:30:20 INFO - TEST-INFO | Main app process: exit 0
20:30:20 INFO - runtests.py | Application ran for: 0:01:08.977297
20:30:20 INFO - zombiecheck | Reading PID log: /tmp/tmp_zqaNNpidlog
20:30:20 INFO - ==> process 8844 launched child process 8901
20:30:20 INFO - ==> process 8844 launched child process 8934
20:30:20 INFO - ==> process 8844 launched child process 8957
20:30:20 INFO - ==> process 8844 launched child process 8984
20:30:20 INFO - ==> process 8844 launched child process 9007
20:30:20 INFO - ==> process 8844 launched child process 9010
20:30:20 INFO - ==> process 8844 launched child process 9051
20:30:20 INFO - ==> process 8844 launched child process 9082
20:30:20 INFO - ==> process 8844 launched child process 9105
20:30:20 INFO - zombiecheck | Checking for orphan process with PID: 8901
20:30:20 INFO - zombiecheck | Checking for orphan process with PID: 8934
20:30:20 INFO - zombiecheck | Checking for orphan process with PID: 8957
20:30:20 INFO - zombiecheck | Checking for orphan process with PID: 8984
20:30:20 INFO - zombiecheck | Checking for orphan process with PID: 9007
20:30:20 INFO - zombiecheck | Checking for orphan process with PID: 9010
20:30:20 INFO - zombiecheck | Checking for orphan process with PID: 9051
20:30:20 INFO - zombiecheck | Checking for orphan process with PID: 9082
20:30:20 INFO - zombiecheck | Checking for orphan process with PID: 9105
20:30:20 INFO - Stopping web server
20:30:20 INFO - Stopping web socket server
20:30:20 INFO - Stopping ssltunnel
20:30:20 INFO - WARNING | leakcheck | refcount logging is off, so leaks can't be detected!
20:30:20 INFO - runtests.py | Running tests: end.
20:30:20 INFO - 2323 INFO TEST-START | Shutdown
20:30:20 INFO - 2324 INFO Passed: 11
20:30:20 INFO - 2325 INFO Failed: 0
20:30:20 INFO - 2326 INFO Todo: 0
20:30:20 INFO - 2327 INFO Slowest: 13541ms - /tests/dom/ipc/tests/test_permission_when_oop_app_crashes.html
20:30:20 INFO - 2328 INFO SimpleTest FINISHED
20:30:20 INFO - 2329 INFO TEST-INFO | Ran 1 Loops
20:30:20 INFO - 2330 INFO SimpleTest FINISHED
20:30:20 INFO - dir: dom/json/test
20:30:20 INFO - Setting pipeline to PAUSED ...
20:30:20 INFO - Pipeline is PREROLLING ...
20:30:20 INFO - Pipeline is PREROLLED ...
20:30:20 INFO - Setting pipeline to PLAYING ...
20:30:20 INFO - New clock: GstSystemClock
20:30:20 INFO - Got EOS from element "pipeline0".
20:30:20 INFO - Execution ended after 32676987 ns.
20:30:20 INFO - Setting pipeline to PAUSED ...
20:30:20 INFO - Setting pipeline to READY ...
20:30:20 INFO - Setting pipeline to NULL ...
20:30:20 INFO - Freeing pipeline ...
20:30:20 INFO - mozprofile.addons WARNING | Could not install /builds/slave/test/build/tests/mochitest/extensions/mozscreenshots: [Errno 2] No such file or directory: '/builds/slave/test/build/tests/mochitest/extensions/mozscreenshots/install.rdf'
20:30:20 INFO - INFO | runtests.py | ASan using symbolizer at /builds/slave/test/build/application/firefox/llvm-symbolizer
20:30:20 INFO - INFO | runtests.py | ASan running in low-memory configuration
20:30:21 INFO - pk12util: PKCS12 IMPORT SUCCESSFUL
20:30:21 INFO - INFO | runtests.py | ASan using symbolizer at /builds/slave/test/build/application/firefox/llvm-symbolizer
20:30:21 INFO - LSan enabled.
20:30:21 INFO - LSan using suppression file /builds/slave/test/build/tests/mochitest/lsan_suppressions.txt
20:30:21 INFO - INFO | runtests.py | ASan running in low-memory configuration
20:30:21 INFO - INFO | runtests.py | ASan using symbolizer at /builds/slave/test/build/application/firefox/llvm-symbolizer
20:30:21 INFO - INFO | runtests.py | ASan running in low-memory configuration
20:30:21 INFO - MochitestServer : launching [u'/builds/slave/test/build/tests/bin/xpcshell', '-g', '/builds/slave/test/build/application/firefox', '-v', '170', '-f', '/builds/slave/test/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmpKCRpJg.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/slave/test/build/tests/mochitest/server.js']
20:30:21 INFO - runtests.py | Server pid: 9167
20:30:21 INFO - runtests.py | Websocket server pid: 9170
20:30:21 INFO - INFO | runtests.py | ASan using symbolizer at /builds/slave/test/build/application/firefox/llvm-symbolizer
20:30:21 INFO - INFO | runtests.py | ASan running in low-memory configuration
20:30:21 INFO - runtests.py | SSL tunnel pid: 9175
20:30:22 INFO - runtests.py | Running tests: start.
20:30:22 INFO - runtests.py | Application pid: 9197
20:30:22 INFO - TEST-INFO | started process Main app process
20:30:33 INFO - [Child 9254] WARNING: g_path_get_basename: assertion `file_name != NULL' failed: 'glib warning', file /builds/slave/m-in-l64-asan-0000000000000000/build/src/toolkit/xre/nsSigHandlers.cpp, line 142
20:30:33 INFO - (process:9254): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed
20:30:39 INFO - 2331 INFO TEST-START | dom/json/test/test_json.html
20:30:40 INFO - MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
20:30:40 INFO - MEMORY STAT heapAllocated not supported in this build configuration.
20:30:40 INFO - MEMORY STAT | vsize 20972388MB | residentFast 231MB
20:30:40 INFO - 2332 INFO TEST-OK | dom/json/test/test_json.html | took 1733ms
20:30:41 INFO - JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank]
20:30:41 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost
20:30:42 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost
20:30:43 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost
20:30:43 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost
20:30:43 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost
20:30:44 INFO - -----------------------------------------------------
20:30:44 INFO - Suppressions used:
20:30:44 INFO - count bytes template
20:30:44 INFO - 821 26248 nsComponentManagerImpl
20:30:44 INFO - 6 816 mozJSComponentLoader::LoadModule
20:30:44 INFO - 1 384 pixman_implementation_lookup_composite
20:30:44 INFO - 360 15936 libfontconfig.so
20:30:44 INFO - 8 1816 MessageLoop::MessageLoop
20:30:44 INFO - 1 24 base::WaitableEvent::TimedWait
20:30:44 INFO - 6 192 libcairo.so
20:30:44 INFO - 1 32 libdl.so
20:30:44 INFO - 26 6492 libglib-2.0.so
20:30:44 INFO - -----------------------------------------------------
20:30:47 INFO - -----------------------------------------------------
20:30:47 INFO - Suppressions used:
20:30:47 INFO - count bytes template
20:30:47 INFO - 40 986 libc.so
20:30:47 INFO - 832 26584 nsComponentManagerImpl
20:30:47 INFO - 50 6800 mozJSComponentLoader::LoadModule
20:30:47 INFO - 1 384 pixman_implementation_lookup_composite
20:30:47 INFO - 360 15936 libfontconfig.so
20:30:47 INFO - 1 32 libdl.so
20:30:47 INFO - 26 6492 libglib-2.0.so
20:30:47 INFO - 2 56 libresolv.so
20:30:47 INFO - -----------------------------------------------------
Comment 1•9 years ago
|
||
hopefully, the underlying cause for this will be corrected in bug 1240995
Explanation in bug 1240995 comment 7
But why isn't ASAN finding those leaks all the time like it did for bug 1240995 ?
Blocks: 1240995
Updated•9 years ago
|
Component: General → Audio/Video: Playback
Product: Firefox → Core
Comment 2•9 years ago
|
||
There appear to be more leaks here than I had first assumed.
I don't really understand how that's possible however as glancing at FFmpeg code allocation and shutdown appear all good to me, I didn't see any miss.
Comment 3•9 years ago
|
||
(In reply to Jean-Yves Avenard [:jya] from comment #1)
> But why isn't ASAN finding those leaks all the time like it did for bug 1240995 ?
I have seen intermittent media leaks before. I'd guess they are due to some kind of raciness. Also, this leak can't be a regression from bug 1240995, because that never made it to mozilla-central, and if you click on the orange factor link, you can see that it happened on m-c once:
https://treeherder.mozilla.org/logviewer.html#?repo=mozilla-central&job_id=3144432
At least this leak has some reasonable stacks.
Comment 4•9 years ago
|
||
(In reply to Andrew McCreight [:mccr8] from comment #3)
> (In reply to Jean-Yves Avenard [:jya] from comment #1)
> > But why isn't ASAN finding those leaks all the time like it did for bug 1240995 ?
>
> I have seen intermittent media leaks before. I'd guess they are due to some
> kind of raciness. Also, this leak can't be a regression from bug 1240995,
This is not what I meant.
The leaks occur due to the new use of our own ffmpeg decoder for VP8 and VP9 ; previously this was done with the system ffmpeg which on the try machine is very old (version 0.8.5 which had no locking of any kind). So at least the races you mentioned wouldn't be unheard of.
However, the trace indicates mozilla::FFmpegDataDecoder<46465650>::InitDecoder
Now *that* is the new code. Bug 1240995 is just a refactoring of the bug introducing that change (bug 1240630).
Fundamentally, there is no logic difference between bug 1240995 and bug 1240630. They both use the same ffmpeg version, use exactly the same API. It's just how the symbols is resolved that is different.
So whatever leaks found in bug 1240995 by ASAN also exists in bug 1240630 (this treeherder long). Yet, it never found the leak of the pthread mutexes.
> At least this leak has some reasonable stacks.
indeed.
Comment 5•9 years ago
|
||
(In reply to Jean-Yves Avenard [:jya] from comment #4)
> So whatever leaks found in bug 1240995 by ASAN also exists in bug 1240630
> (this treeherder long). Yet, it never found the leak of the pthread mutexes.
Ah, I see. My only guess would be that the old stacks somehow ended up matching something in build/sanitizers/lsan_suppressions.txt, but the new ones don't (the external library related suppressions are near the end of the file). However, I don't see anything that is obviously video related in there, so I don't know.
Comment hidden (Intermittent Failures Robot) |
Comment 7•9 years ago
|
||
P2 because Jean-Yves started to look into this leak and saw more leaks than he expected.
Priority: -- → P2
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 18•9 years ago
|
||
this bug would be fixed if the ancient libav found in Ubuntu 12.04 got upgraded...
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Mass change P2 -> P3
Priority: P2 → P3
Comment 24•8 years ago
|
||
The last entry on orange factor is 7 Jul 2016, 04:48 mozilla-beta.
The logs say "The job does not exist or has expired." without even providing a summary.
Status: NEW → RESOLVED
Closed: 8 years ago
Resolution: --- → WORKSFORME
You need to log in
before you can comment on or make changes to this bug.
Description
•