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 - -----------------------------------------------------

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 ?

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.

(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.

(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.

(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.

P2 because Jean-Yves started to look into this leak and saw more leaks than he expected.

this bug would be fixed if the ancient libav found in Ubuntu 12.04 got upgraded...

Mass change P2 -> P3

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.