Closed Bug 1448614 Opened 8 years ago Closed 8 years ago

Intermittent LeakSanitizer | leak at Alloc, nsTSubstring, nsTSubstring, AssignASCII

Categories

(Core :: XML, defect, P5)

Product:
Core
Component:
XML
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: apavel [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=170076272&repo=autoland https://queue.taskcluster.net/v1/task/dh5fAJ-9TfOAiukwyqrxaA/runs/0/artifacts/public/logs/live_backing.log [task 2018-03-25T00:00:55.183Z] 00:00:55 INFO - TEST-START | parser/htmlparser/tests/mochitest/test_xml_mislabeled.html [task 2018-03-25T00:00:58.470Z] 00:00:58 INFO - GECKO(3197) | MEMORY STAT | vsize 20973725MB | residentFast 996MB [task 2018-03-25T00:00:58.508Z] 00:00:58 INFO - TEST-OK | parser/htmlparser/tests/mochitest/test_xml_mislabeled.html | took 3316ms [task 2018-03-25T00:00:58.619Z] 00:00:58 INFO - TEST-START | Shutdown [task 2018-03-25T00:00:58.620Z] 00:00:58 INFO - Passed: 2015 [task 2018-03-25T00:00:58.620Z] 00:00:58 INFO - Failed: 0 [task 2018-03-25T00:00:58.620Z] 00:00:58 INFO - Todo: 8 [task 2018-03-25T00:00:58.620Z] 00:00:58 INFO - Mode: e10s [task 2018-03-25T00:00:58.621Z] 00:00:58 INFO - Slowest: 41802ms - /tests/parser/htmlparser/tests/mochitest/test_html5_tree_construction_part2.html [task 2018-03-25T00:00:58.622Z] 00:00:58 INFO - SimpleTest FINISHED [task 2018-03-25T00:00:58.623Z] 00:00:58 INFO - TEST-INFO | Ran 1 Loops [task 2018-03-25T00:00:58.624Z] 00:00:58 INFO - SimpleTest FINISHED [task 2018-03-25T00:00:59.450Z] 00:00:59 INFO - GECKO(3197) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2D00F9,name=PContent::Msg_AccumulateChildHistograms) Closed channel: cannot send/recv [task 2018-03-25T00:00:59.451Z] 00:00:59 INFO - GECKO(3197) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2D00FA,name=PContent::Msg_AccumulateChildKeyedHistograms) Closed channel: cannot send/recv [task 2018-03-25T00:00:59.452Z] 00:00:59 INFO - GECKO(3197) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2D00FE,name=PContent::Msg_RecordDiscardedData) Closed channel: cannot send/recv [task 2018-03-25T00:01:00.478Z] 00:01:00 INFO - GECKO(3197) | 1521936060472 Marionette DEBUG Received observer notification xpcom-will-shutdown [task 2018-03-25T00:01:00.482Z] 00:01:00 INFO - GECKO(3197) | 1521936060477 Marionette DEBUG New connections will no longer be accepted [task 2018-03-25T00:01:00.724Z] 00:01:00 INFO - GECKO(3197) | ----------------------------------------------------- [task 2018-03-25T00:01:00.724Z] 00:01:00 INFO - GECKO(3197) | Suppressions used: [task 2018-03-25T00:01:00.725Z] 00:01:00 INFO - GECKO(3197) | count bytes template [task 2018-03-25T00:01:00.725Z] 00:01:00 INFO - GECKO(3197) | 665 21216 nsComponentManagerImpl [task 2018-03-25T00:01:00.725Z] 00:01:00 INFO - GECKO(3197) | 2 416 mozJSComponentLoader::LoadModule [task 2018-03-25T00:01:00.725Z] 00:01:00 INFO - GECKO(3197) | 2 288 libfontconfig.so [task 2018-03-25T00:01:00.725Z] 00:01:00 INFO - GECKO(3197) | ----------------------------------------------------- [task 2018-03-25T00:01:02.626Z] 00:01:02 INFO - GECKO(3197) | ================================================================= [task 2018-03-25T00:01:02.627Z] 00:01:02 ERROR - GECKO(3197) | ==3249==ERROR: LeakSanitizer: detected memory leaks [task 2018-03-25T00:01:02.631Z] 00:01:02 INFO - GECKO(3197) | Indirect leak of 64 byte(s) in 1 object(s) allocated from: [task 2018-03-25T00:01:02.631Z] 00:01:02 INFO - GECKO(3197) | #0 0x4c1c93 in malloc /builds/worker/workspace/moz-toolchain/src/llvm/projects/compiler-rt/lib/asan/asan_malloc_linux.cc:88:3 [task 2018-03-25T00:01:02.631Z] 00:01:02 INFO - GECKO(3197) | #1 0x7f6cf56b1be1 in Alloc /builds/worker/workspace/build/src/xpcom/string/nsSubstring.cpp:257:22 [task 2018-03-25T00:01:02.631Z] 00:01:02 INFO - GECKO(3197) | #2 0x7f6cf56b1be1 in nsTSubstring<char>::MutatePrep(unsigned int, char**, mozilla::detail::StringDataFlags*) /builds/worker/workspace/build/src/xpcom/string/nsTSubstring.cpp:167 [task 2018-03-25T00:01:02.632Z] 00:01:02 INFO - GECKO(3197) | #3 0x7f6cf56c3f2b in nsTSubstring<char>::ReplacePrepInternal(unsigned int, unsigned int, unsigned int, unsigned int) /builds/worker/workspace/build/src/xpcom/string/nsTSubstring.cpp:230:8 [task 2018-03-25T00:01:02.632Z] 00:01:02 INFO - GECKO(3197) | #4 0x7f6cf56c17b7 in AssignASCII /builds/worker/workspace/build/src/xpcom/string/nsTSubstring.cpp:421:8 [task 2018-03-25T00:01:02.633Z] 00:01:02 INFO - GECKO(3197) | #5 0x7f6cf56c17b7 in nsTSubstring<char>::AssignASCII(char const*, unsigned int) /builds/worker/workspace/build/src/xpcom/string/nsTSubstring.cpp:403 [task 2018-03-25T00:01:02.633Z] 00:01:02 INFO - GECKO(3197) | #6 0x7f6d0109b262 in AssignASCII /builds/worker/workspace/build/src/obj-firefox/dist/include/nsTSubstring.h:231:5 [task 2018-03-25T00:01:02.633Z] 00:01:02 INFO - GECKO(3197) | #7 0x7f6d0109b262 in GetStack /builds/worker/workspace/build/src/toolkit/components/backgroundhangmonitor/ThreadStackHelper.cpp:148 [task 2018-03-25T00:01:02.635Z] 00:01:02 INFO - GECKO(3197) | #8 0x7f6d0109b262 in mozilla::BackgroundHangManager::RunMonitorThread() /builds/worker/workspace/build/src/toolkit/components/backgroundhangmonitor/BackgroundHangMonitor.cpp:387 [task 2018-03-25T00:01:02.635Z] 00:01:02 INFO - GECKO(3197) | #9 0x7f6d0109a813 in mozilla::BackgroundHangManager::MonitorThread(void*) /builds/worker/workspace/build/src/toolkit/components/backgroundhangmonitor/BackgroundHangMonitor.cpp:79:49 [task 2018-03-25T00:01:02.636Z] 00:01:02 INFO - GECKO(3197) | #10 0x7f6d12cd647e in _pt_root /builds/worker/workspace/build/src/nsprpub/pr/src/pthreads/ptthread.c:201:5 [task 2018-03-25T00:01:02.636Z] 00:01:02 INFO - GECKO(3197) | #11 0x7f6d1707a6b9 in start_thread (/lib/x86_64-linux-gnu/libpthread.so.0+0x76b9) [task 2018-03-25T00:01:02.637Z] 00:01:02 INFO - GECKO(3197) | ----------------------------------------------------- [task 2018-03-25T00:01:02.638Z] 00:01:02 INFO - GECKO(3197) | Suppressions used: [task 2018-03-25T00:01:02.639Z] 00:01:02 INFO - GECKO(3197) | count bytes template [task 2018-03-25T00:01:02.639Z] 00:01:02 INFO - GECKO(3197) | 1 32 libc.so [task 2018-03-25T00:01:02.640Z] 00:01:02 INFO - GECKO(3197) | 665 21216 nsComponentManagerImpl [task 2018-03-25T00:01:02.640Z] 00:01:02 INFO - GECKO(3197) | 7 1456 mozJSComponentLoader::LoadModule [task 2018-03-25T00:01:02.640Z] 00:01:02 INFO - GECKO(3197) | 611 17713 libfontconfig.so [task 2018-03-25T00:01:02.641Z] 00:01:02 INFO - GECKO(3197) | 4 221 libglib-2.0.so [task 2018-03-25T00:01:02.641Z] 00:01:02 INFO - GECKO(3197) | ----------------------------------------------------- [task 2018-03-25T00:01:02.643Z] 00:01:02 INFO - GECKO(3197) | SUMMARY: AddressSanitizer: 64 byte(s) leaked in 1 allocation(s). [task 2018-03-25T00:01:03.841Z] 00:01:03 INFO - GECKO(3197) | ----------------------------------------------------- [task 2018-03-25T00:01:03.841Z] 00:01:03 INFO - GECKO(3197) | Suppressions used: [task 2018-03-25T00:01:03.841Z] 00:01:03 INFO - GECKO(3197) | count bytes template [task 2018-03-25T00:01:03.841Z] 00:01:03 INFO - GECKO(3197) | 681 21704 nsComponentManagerImpl [task 2018-03-25T00:01:03.843Z] 00:01:03 INFO - GECKO(3197) | 45 9360 mozJSComponentLoader::LoadModule [task 2018-03-25T00:01:03.846Z] 00:01:03 INFO - GECKO(3197) | 611 17509 libfontconfig.so [task 2018-03-25T00:01:03.847Z] 00:01:03 INFO - GECKO(3197) | 4 176 _PR_Getfd [task 2018-03-25T00:01:03.847Z] 00:01:03 INFO - GECKO(3197) | 1 29 libglib-2.0.so [task 2018-03-25T00:01:03.849Z] 00:01:03 INFO - GECKO(3197) | ----------------------------------------------------- [task 2018-03-25T00:01:04.027Z] 00:01:04 INFO - TEST-INFO | Main app process: exit 0 [task 2018-03-25T00:01:04.029Z] 00:01:04 INFO - TEST-INFO | LeakSanitizer | To show the addresses of leaked objects add report_objects=1 to LSAN_OPTIONS [task 2018-03-25T00:01:04.030Z] 00:01:04 INFO - TEST-INFO | LeakSanitizer | This can be done in testing/mozbase/mozrunner/mozrunner/utils.py [task 2018-03-25T00:01:04.031Z] 00:01:04 ERROR - TEST-UNEXPECTED-FAIL | LeakSanitizer | leak at Alloc, nsTSubstring, nsTSubstring, AssignASCII [task 2018-03-25T00:01:04.032Z] 00:01:04 INFO - runtests.py | Application ran for: 0:02:04.675273 [task 2018-03-25T00:01:04.032Z] 00:01:04 INFO - zombiecheck | Reading PID log: /tmp/tmpso4QIYpidlog [task 2018-03-25T00:01:04.032Z] 00:01:04 INFO - ==> process 3197 launched child process 3218 [task 2018-03-25T00:01:04.033Z] 00:01:04 INFO - ==> process 3197 launched child process 3249 [task 2018-03-25T00:01:04.033Z] 00:01:04 INFO - ==> process 3197 launched child process 3302 [task 2018-03-25T00:01:04.034Z] 00:01:04 INFO - zombiecheck | Checking for orphan process with PID: 3249 [task 2018-03-25T00:01:04.034Z] 00:01:04 INFO - zombiecheck | Checking for orphan process with PID: 3218 [task 2018-03-25T00:01:04.035Z] 00:01:04 INFO - zombiecheck | Checking for orphan process with PID: 3302 [task 2018-03-25T00:01:04.035Z] 00:01:04 INFO - Stopping web server [task 2018-03-25T00:01:04.042Z] 00:01:04 INFO - Stopping web socket server [task 2018-03-25T00:01:04.063Z] 00:01:04 INFO - Stopping ssltunnel [task 2018-03-25T00:01:04.084Z] 00:01:04 WARNING - leakcheck | refcount logging is off, so leaks can't be detected! [task 2018-03-25T00:01:04.086Z] 00:01:04 INFO - runtests.py | Running tests: end. [task 2018-03-25T00:01:04.110Z] 00:01:04 INFO - Buffered messages finished [task 2018-03-25T00:01:04.111Z] 00:01:04 INFO - Running manifest: security/manager/ssl/tests/mochitest/mixedcontent/mochitest.ini [task 2018-03-25T00:01:04.112Z] 00:01:04 INFO - The following extra prefs will be set: [task 2018-03-25T00:01:04.114Z] 00:01:04 INFO - security.mixed_content.upgrade_display_content=false [task 2018-03-25T00:01:04.156Z] 00:01:04 INFO - Setting pipeline to PAUSED ... [task 2018-03-25T00:01:04.157Z] 00:01:04 INFO - Pipeline is PREROLLING ... [task 2018-03-25T00:01:04.161Z] 00:01:04 INFO - Pipeline is PREROLLED ... [task 2018-03-25T00:01:04.161Z] 00:01:04 INFO - Setting pipeline to PLAYING ... [task 2018-03-25T00:01:04.162Z] 00:01:04 INFO - New clock: GstSystemClock [task 2018-03-25T00:01:04.201Z] 00:01:04 INFO - Got EOS from element "pipeline0". [task 2018-03-25T00:01:04.201Z] 00:01:04 INFO - Execution ended after 0:00:00.033260270 [task 2018-03-25T00:01:04.201Z] 00:01:04 INFO - Setting pipeline to PAUSED ... [task 2018-03-25T00:01:04.202Z] 00:01:04 INFO - Setting pipeline to READY ... [task 2018-03-25T00:01:04.202Z] 00:01:04 INFO - (gst-launch-1.0:3352): GStreamer-CRITICAL **: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed [task 2018-03-25T00:01:04.202Z] 00:01:04 INFO - Setting pipeline to NULL ... [task 2018-03-25T00:01:04.202Z] 00:01:04 INFO - Freeing pipeline ... [task 2018-03-25T00:01:04.278Z] 00:01:04 INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer [task 2018-03-25T00:01:04.286Z] 00:01:04 INFO - INFO | runtests.py | ASan running in default memory configuration [task 2018-03-25T00:01:04.512Z] 00:01:04 INFO - pk12util: PKCS12 IMPORT SUCCESSFUL [task 2018-03-25T00:01:04.791Z] 00:01:04 INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer [task 2018-03-25T00:01:04.799Z] 00:01:04 INFO - LSan enabled. [task 2018-03-25T00:01:04.801Z] 00:01:04 INFO - LSan using suppression file /builds/worker/workspace/build/tests/mochitest/lsan_suppressions.txt [task 2018-03-25T00:01:04.804Z] 00:01:04 INFO - INFO | runtests.py | ASan running in default memory configuration [task 2018-03-25T00:01:04.804Z] 00:01:04 INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer [task 2018-03-25T00:01:04.812Z] 00:01:04 INFO - INFO | runtests.py | ASan running in default memory configuration [task 2018-03-25T00:01:04.829Z] 00:01:04 INFO - MochitestServer : launching [u'/builds/worker/workspace/build/tests/bin/xpcshell', '-g', '/builds/worker/workspace/build/application/firefox', '-f', '/builds/worker/workspace/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmp5lFBE2.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/worker/workspace/build/tests/mochitest/server.js'] [task 2018-03-25T00:01:04.829Z] 00:01:04 INFO - runtests.py | Server pid: 3384 [task 2018-03-25T00:01:04.865Z] 00:01:04 INFO - runtests.py | Websocket server pid: 3387 [task 2018-03-25T00:01:04.867Z] 00:01:04 INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer [task 2018-03-25T00:01:04.904Z] 00:01:04 INFO - INFO | runtests.py | ASan running in default memory configuration [task 2018-03-25T00:01:04.945Z] 00:01:04 INFO - runtests.py | SSL tunnel pid: 3392 [task 2018-03-25T00:01:05.348Z] 00:01:05 INFO - runtests.py | Running with e10s: True [task 2018-03-25T00:01:05.348Z] 00:01:05 INFO - runtests.py | Running tests: start. [task 2018-03-25T00:01:05.348Z] 00:01:05 INFO - [task 2018-03-25T00:01:05.376Z] 00:01:05 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -foreground -profile /tmp/tmp5lFBE2.mozrunner [task 2018-03-25T00:01:05.405Z] 00:01:05 INFO - runtests.py | Application pid: 3411 [task 2018-03-25T00:01:05.405Z] 00:01:05 INFO - TEST-INFO | started process GECKO(3411)
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: 8 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.