openldap-bugs

openldap-bugs@openldap.org

1 participants
21003 discussions

Re: (ITS#6330) slapd memory leak
by hyc＠symas.com 16 Oct '09

16 Oct '09

quanah(a)zimbra.com wrote: > --On Friday, October 16, 2009 7:57 AM +0000 masarati(a)aero.polimi.it wrote: > >> hyc(a)symas.com wrote: >>> whm(a)stanford.edu wrote: >>>> Here is the valgrind output. The complete log is at >>>> >>>> http://www.stanford.edu/~whm/files/slapd/valgrind-memcheck.txt >>> >>> All of this indicates memory leaks and errors in the SASL library, not >>> any bug in OpenLDAP. >> >> That was exactly my suspect when you originally stated that the leak >> only appeared after wrapping dynlist requests within a SASL bind/unbind. >> The leak could still be related to an improper use of SASL library >> calls by OpenLDAP, although unlikely. However, that valgrind output >> does not help as leaks related to malloc are too hidden into SASL; you >> should add --num-callers=<more than 12, the default; enough to see >> something related to OpenLDAP's code>. > > > Given that the memory issue is not seen with OpenLDAP 2.3 + dyngroup, I'd > still have to agree there's something wrong with what OpenLDAP 2.4 + > dynlist is doing. Merely increasing --num-callers isn't going to be sufficient to track this. Since valgrind only reports leaks after a program exits, and the Cyrus SASL library unloads the offending plugin before it exits, most of the stack trace will be missing any useful symbols. You'll have to run a modified libsasl2.so that omits its dlclose() calls so that the libgssapiv2 plugin will remain loaded, so that its symbols will still be accessible when slapd exits. Also, since the trace only shows leaks triggered from sasl_client_step and sasl_server_step, which are only executed during SASL Bind processing, you ought to be able to duplicate these leaks regardless of dynlist or any other overlays, since the leaks are occurring before any of these overlays have even started to run. Of course, if you're unable to reproduce these leaks with dynlist out of the picture, then I guess the finger points into dynlist again... -- -- Howard Chu CTO, Symas Corp. http://www.symas.com Director, Highland Sun http://highlandsun.com/hyc/ Chief Architect, OpenLDAP http://www.openldap.org/project/

1 0

Re: (ITS#6330) slapd memory leak
by quanah＠zimbra.com 16 Oct '09

16 Oct '09

--On Friday, October 16, 2009 7:57 AM +0000 masarati(a)aero.polimi.it wrote: > hyc(a)symas.com wrote: >> whm(a)stanford.edu wrote: >>> Here is the valgrind output. The complete log is at >>> >>> http://www.stanford.edu/~whm/files/slapd/valgrind-memcheck.txt >> >> All of this indicates memory leaks and errors in the SASL library, not >> any bug in OpenLDAP. > > That was exactly my suspect when you originally stated that the leak > only appeared after wrapping dynlist requests within a SASL bind/unbind. > The leak could still be related to an improper use of SASL library > calls by OpenLDAP, although unlikely. However, that valgrind output > does not help as leaks related to malloc are too hidden into SASL; you > should add --num-callers=<more than 12, the default; enough to see > something related to OpenLDAP's code>. Given that the memory issue is not seen with OpenLDAP 2.3 + dyngroup, I'd still have to agree there's something wrong with what OpenLDAP 2.4 + dynlist is doing. --Quanah -- Quanah Gibson-Mount Principal Software Engineer Zimbra, Inc -------------------- Zimbra :: the leader in open source messaging and collaboration

1 0

Re: (ITS#6330) slapd memory leak
by masarati＠aero.polimi.it 16 Oct '09

16 Oct '09

hyc(a)symas.com wrote: > whm(a)stanford.edu wrote: >> Here is the valgrind output. The complete log is at >> >> http://www.stanford.edu/~whm/files/slapd/valgrind-memcheck.txt > > All of this indicates memory leaks and errors in the SASL library, not any bug > in OpenLDAP. That was exactly my suspect when you originally stated that the leak only appeared after wrapping dynlist requests within a SASL bind/unbind. The leak could still be related to an improper use of SASL library calls by OpenLDAP, although unlikely. However, that valgrind output does not help as leaks related to malloc are too hidden into SASL; you should add --num-callers=<more than 12, the default; enough to see something related to OpenLDAP's code>. p.

1 0

Re: (ITS#6330) slapd memory leak
by whm＠stanford.edu 16 Oct '09

16 Oct '09

--On Friday, October 16, 2009 12:02:59 AM -0700 Howard Chu <hyc(a)symas.com> wrote: > whm(a)stanford.edu wrote: >> Here is the valgrind output. The complete log is at >> >> http://www.stanford.edu/~whm/files/slapd/valgrind-memcheck.txt > > All of this indicates memory leaks and errors in the SASL library, > not any bug in OpenLDAP. That is what I suspected when I looked at the output, but I wanted confirmation from someone that is more familar with valgrind output and the code than me. Of course, until we resolve the issue it effectively disables OpenLDAP 2.4 for us. Thanks for looking at it, Bill >> >> Bill >> >> # valgrind --leak-check=yes /usr/sbin/slapd -f /e tc/ldap/slapd.conf -d 256 >> ==25500== Memcheck, a memory error detector. >> ==25500== Copyright (C) 2002-2007, and GNU GPL'd, by Julian Seward et al. >> ==25500== Using LibVEX rev 1854, a library for dynamic binary translation. >> ==25500== Copyright (C) 2004-2007, and GNU GPL'd, by OpenWorks LLP. >> ==25500== Using valgrind-3.3.1-Debian, a dynamic binary instrumentation framework. >> ==25500== Copyright (C) 2000-2007, and GNU GPL'd, by Julian Seward et al. >> ==25500== For more details, rerun with: -v >> ==25500== >> @(#) $OpenLDAP: slapd 2.4.18 (Sep 29 2009 07:08:49) $ >> root@leviticus.stanford.edu:/tmp/buildd/openldap-2.4.18/debian/build/servers/slapd >> ==25500== Warning: set address range perms: large range 135020544 (defined) >> ==25500== Warning: set address range perms: large range 5368709120 (defined) >> ==25500== Warning: set address range perms: large range 160000008 (defined) >> slapd starting >> ==25500== Thread 3: >> ==25500== Invalid read of size 1 >> ==25500== at 0x4C22B72: strcat (mc_replace_strmem.c:186) >> ==25500== by 0x8A67DDE: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) >> ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) >> ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) >> ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) >> ==25500== by 0x4336B3: slap_client_connect (config.c:1803) >> ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) >> ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) >> ==25500== by 0x4E3800C: ldap_int_thread_pool_wrapper (tpool.c:685) >> ==25500== by 0x6B56FC6: start_thread (in /lib/libpthread-2.7.so) >> ==25500== Address 0xb2581c1 is 0 bytes after a block of size 33 alloc'd >> ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) >> ==25500== by 0x8C848AC: (within /usr/lib/libgssapi.so.2.0.0) >> ==25500== by 0x8C85EA7: gss_display_status (in /usr/lib/libgssapi.so.2.0.0) >> ==25500== by 0x8A67D8E: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) >> ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) >> ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) >> ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) >> ==25500== by 0x4336B3: slap_client_connect (config.c:1803) >> ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) >> ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) >> ==25500== >> ==25500== Invalid read of size 1 >> ==25500== at 0x4C22B72: strcat (mc_replace_strmem.c:186) >> ==25500== by 0x8A67EDA: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) >> ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) >> ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) >> ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) >> ==25500== by 0x4336B3: slap_client_connect (config.c:1803) >> ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) >> ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) >> ==25500== by 0x4E3800C: ldap_int_thread_pool_wrapper (tpool.c:685) >> ==25500== by 0x6B56FC6: start_thread (in /lib/libpthread-2.7.so) >> ==25500== Address 0xb258227 is 0 bytes after a block of size 47 alloc'd >> ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) >> ==25500== by 0x8C848F4: (within /usr/lib/libgssapi.so.2.0.0) >> ==25500== by 0x8C85EA7: gss_display_status (in /usr/lib/libgssapi.so.2.0.0) >> ==25500== by 0x8A67E8A: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) >> ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) >> ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) >> ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) >> ==25500== by 0x4336B3: slap_client_connect (config.c:1803) >> ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) >> ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) >> slap_client_connect: URI=ldap://ldap-uatmaster.stanford.edu:389 ldap_sasl_interactive_bind_s failed (-2) >> ==25500== Warning: invalid file descriptor -1 in syscall close() >> do_syncrepl: rid=000 rc -2 retrying >> conn=0 fd=12 ACCEPT from IP=172.20.196.4:48599 (IP=0.0.0.0:389) >> conn=0 op=0 BIND dn="" method=163 >> conn=0 op=0 RESULT tag=97 err=14 text=SASL(0): successful result: >> connection_input: conn=0 deferring operation: binding >> conn=0 op=1 BIND dn="" method=163 >> conn=0 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: >> conn=0 op=2 BIND dn="" method=163 >> conn=0 op=2 BIND authcid="service/course-regis-test(a)stanford.edu" authzid="service/course-regis-test(a)stanford.edu" >> conn=0 op=2 BIND dn="cn=course-regis-test,cn=service,cn=applications,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 >> conn=0 op=2 RESULT tag=97 err=0 text= >> conn=0 op=3 UNBIND >> conn=0 fd=12 closed >> conn=1 fd=12 ACCEPT from IP=171.64.11.53:34814 (IP=0.0.0.0:389) >> conn=1 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" >> conn=1 op=0 SRCH attr=supportedSASLMechanisms >> conn=1 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= >> conn=1 op=1 BIND dn="" method=163 >> conn=1 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: >> conn=1 op=2 BIND dn="" method=163 >> conn=1 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: >> conn=1 op=3 BIND dn="" method=163 >> conn=1 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" >> conn=1 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 >> conn=1 op=3 RESULT tag=97 err=0 text= >> conn=1 op=4 SRCH base="cn=groups,dc=stanford,dc=edu" scope=1 deref=0 filter="(objectClass=suWorkgroup)" >> conn=1 op=4 SRCH attr=cn >> conn=2 fd=16 ACCEPT from IP=127.0.0.1:56960 (IP=0.0.0.0:389) >> conn=2 op=0 BIND dn="" method=128 >> conn=2 op=0 RESULT tag=97 err=0 text= >> conn=2 op=1 SRCH base="dc=stanford,dc=edu" scope=2 deref=2 filter="(uid=johnjacobjingleheimerschmidt)" >> conn=2 op=1 SRCH attr=suPtsUid >> conn=2 op=1 SEARCH RESULT tag=101 err=0 nentries=0 text= >> conn=2 op=2 UNBIND >> conn=2 fd=16 closed >> conn=1 op=4 SEARCH RESULT tag=101 err=0 nentries=9287 text= >> conn=1 op=5 UNBIND >> conn=1 fd=12 closed >> conn=3 fd=12 ACCEPT from IP=171.64.11.53:34815 (IP=0.0.0.0:389) >> conn=3 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" >> conn=3 op=0 SRCH attr=supportedSASLMechanisms >> conn=3 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= >> conn=3 op=1 BIND dn="" method=163 >> conn=3 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: >> conn=3 op=2 BIND dn="" method=163 >> conn=3 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: >> conn=3 op=3 BIND dn="" method=163 >> conn=3 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" >> conn=3 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 >> conn=3 op=3 RESULT tag=97 err=0 text= >> conn=3 op=4 SRCH base="cn=~tomhurl:cs106bgraders,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" >> conn=3 op=4 SRCH attr=member >> conn=3 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= >> conn=3 op=5 UNBIND >> conn=3 fd=12 closed >> conn=4 fd=19 ACCEPT from IP=171.64.11.53:34816 (IP=0.0.0.0:389) >> conn=4 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" >> conn=4 op=0 SRCH attr=supportedSASLMechanisms >> conn=4 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= >> conn=4 op=1 BIND dn="" method=163 >> conn=4 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: >> conn=4 op=2 BIND dn="" method=163 >> conn=4 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: >> conn=4 op=3 BIND dn="" method=163 >> conn=4 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" >> conn=4 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 >> conn=4 op=3 RESULT tag=97 err=0 text= >> conn=4 op=4 SRCH base="cn=postgrads:pgsample/administrator,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" >> conn=4 op=4 SRCH attr=member >> conn=4 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= >> conn=4 op=5 UNBIND >> conn=4 fd=19 closed >> conn=5 fd=12 ACCEPT from IP=171.64.11.53:34817 (IP=0.0.0.0:389) >> conn=5 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" >> conn=5 op=0 SRCH attr=supportedSASLMechanisms >> conn=5 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= >> conn=5 op=1 BIND dn="" method=163 >> conn=5 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: >> conn=5 op=2 BIND dn="" method=163 >> conn=5 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: >> conn=5 op=3 BIND dn="" method=163 >> conn=5 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" >> conn=5 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 >> conn=5 op=3 RESULT tag=97 err=0 text= >> conn=5 op=4 SRCH base="cn=med-emed:va,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" >> conn=5 op=4 SRCH attr=member >> conn=5 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= >> conn=5 op=5 UNBIND >> conn=5 fd=12 closed >> >> ... lots of ldap stats output ... >> >> conn=238 op=4 SRCH base="cn=maps:contracts/administrator,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" >> conn=238 op=4 SRCH attr=member >> conn=238 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= >> conn=238 op=5 UNBIND >> conn=238 fd=12 closed >> conn=239 fd=12 ACCEPT from IP=171.64.11.53:35040 (IP=0.0.0.0:389) >> conn=239 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" >> conn=239 op=0 SRCH attr=supportedSASLMechanisms >> conn=239 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= >> conn=239 op=1 BIND dn="" method=163 >> conn=239 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: >> conn=239 op=2 BIND dn="" method=163 >> conn=239 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: >> conn=239 op=3 BIND dn="" method=163 >> conn=239 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" >> conn=239 fd=12 closed (connection lost) >> ^Cdaemon: shutdown requested and initiated. >> slapd shutdown: waiting for 0 operations/tasks to finish >> ==25500== Warning: set address range perms: large range 5368709120 (noaccess) >> ==25500== Warning: set address range perms: large range 135020544 (noaccess) >> ==25500== Warning: set address range perms: large range 160000040 (noaccess) >> slapd stopped. >> ==25500== >> ==25500== ERROR SUMMARY: 4 errors from 2 contexts (suppressed: 233 from 4) >> ==25500== malloc/free: in use at exit: 6,055,651 bytes in 217,392 blocks. >> ==25500== malloc/free: 1,612,487 allocs, 1,395,095 frees, 499,560,609 bytes allocated. >> ==25500== For counts of detected errors, rerun with: -v >> ==25500== searching for pointers to 217,392 not-freed blocks. >> ==25500== checked 1,035,848 bytes. >> ==25500== >> ==25500== Thread 1: >> ==25500== >> ==25500== 20 bytes in 1 blocks are possibly lost in loss record 13 of 81 >> ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) >> ==25500== by 0x6DE6D91: strdup (in /lib/libc-2.7.so) >> ==25500== by 0x8EC70D4: ??? >> ==25500== by 0x8EC6F7B: ??? >> ==25500== by 0x8EC717D: ??? >> ==25500== by 0x8EC72E4: ??? >> ==25500== by 0x8EC73F9: ??? >> ==25500== by 0x8EC835C: ??? >> ==25500== by 0x8EC89EC: ??? >> ==25500== by 0x8C8D009: ??? >> ==25500== by 0x8C8ACBC: ??? >> ==25500== by 0x8C850CB: ??? >> ==25500== >> ==25500== >> ==25500== 31 bytes in 1 blocks are definitely lost in loss record 14 of 81 >> ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) >> ==25500== by 0x4A7997: slap_sasl_getconfpath (sasl.c:1110) >> ==25500== by 0x5AFFF71: sasl_server_init (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x4A7B9D: slap_sasl_init (sasl.c:1176) >> ==25500== by 0x477F99: slap_init (init.c:151) >> ==25500== by 0x41A9C0: main (main.c:750) >> ==25500== >> ==25500== >> ==25500== 32 bytes in 1 blocks are possibly lost in loss record 15 of 81 >> ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) >> ==25500== by 0x8EC6D40: ??? >> ==25500== by 0x8EC715F: ??? >> ==25500== by 0x8EC72E4: ??? >> ==25500== by 0x8EC73F9: ??? >> ==25500== by 0x8EC835C: ??? >> ==25500== by 0x8EC89EC: ??? >> ==25500== by 0x8C8D009: ??? >> ==25500== by 0x8C8ACBC: ??? >> ==25500== by 0x8C850CB: ??? >> ==25500== by 0x8C903F0: ??? >> ==25500== by 0x8C850CB: ??? >> ==25500== >> ==25500== >> ==25500== 64 (16 direct, 48 indirect) bytes in 1 blocks are definitely lost in loss record 19 of 81 >> ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) >> ==25500== by 0x8C85B9A: ??? >> ==25500== by 0x8C88D1A: ??? >> ==25500== by 0x8C89B8D: ??? >> ==25500== by 0x8C86DE0: ??? >> ==25500== by 0x8A681E6: ??? >> ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) >> ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) >> ==25500== by 0x4336B3: slap_client_connect (config.c:1803) >> ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) >> ==25500== >> ==25500== >> ==25500== 128 bytes in 4 blocks are definitely lost in loss record 26 of 81 >> ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) >> ==25500== by 0x8ECF6E2: ??? >> ==25500== by 0x8ECF76E: ??? >> ==25500== by 0x8ED7E66: ??? >> ==25500== by 0x8ED4CFF: ??? >> ==25500== by 0x8ED4FBE: ??? >> ==25500== by 0x8ED55EE: ??? >> ==25500== by 0x8ED5B5E: ??? >> ==25500== by 0x8ED6053: ??? >> ==25500== by 0x8C7F194: ??? >> ==25500== by 0x8C7FAB1: ??? >> ==25500== by 0x8C86D56: ??? >> ==25500== >> ==25500== >> ==25500== 1,008 (336 direct, 672 indirect) bytes in 1 blocks are definitely lost in loss record 35 of 81 >> ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) >> ==25500== by 0x8C88C49: ??? >> ==25500== by 0x8C88D4A: ??? >> ==25500== by 0x8C89B8D: ??? >> ==25500== by 0x8C86DE0: ??? >> ==25500== by 0x8A681E6: ??? >> ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) >> ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) >> ==25500== by 0x4336B3: slap_client_connect (config.c:1803) >> ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) >> ==25500== >> ==25500== >> ==25500== 636 (256 direct, 380 indirect) bytes in 8 blocks are definitely lost in loss record 36 of 81 >> ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) >> ==25500== by 0x8EED07A: ??? >> ==25500== by 0x8ED4B96: ??? >> ==25500== by 0x8ED4FBE: ??? >> ==25500== by 0x8ED55EE: ??? >> ==25500== by 0x8ED5B5E: ??? >> ==25500== by 0x8ED6053: ??? >> ==25500== by 0x8C7F194: ??? >> ==25500== by 0x8C7FAB1: ??? >> ==25500== by 0x8C86D56: ??? >> ==25500== by 0x8A681E6: ??? >> ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== >> ==25500== >> ==25500== 632 bytes in 1 blocks are possibly lost in loss record 37 of 81 >> ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) >> ==25500== by 0x8C8A6C2: ??? >> ==25500== by 0x8C8ACBC: ??? >> ==25500== by 0x8C850CB: ??? >> ==25500== by 0x8C903F0: ??? >> ==25500== by 0x8C850CB: ??? >> ==25500== by 0x8A697EE: ??? >> ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) >> ==25500== by 0x46442D: fe_op_bind (bind.c:280) >> ==25500== by 0x464032: do_bind (bind.c:205) >> ==25500== >> ==25500== >> ==25500== 920 bytes in 1 blocks are possibly lost in loss record 38 of 81 >> ==25500== at 0x4C22741: realloc (vg_replace_malloc.c:429) >> ==25500== by 0x8EC474D: ??? >> ==25500== by 0x8EC8A77: ??? >> ==25500== by 0x8C8D009: ??? >> ==25500== by 0x8C8ACBC: ??? >> ==25500== by 0x8C850CB: ??? >> ==25500== by 0x8C903F0: ??? >> ==25500== by 0x8C850CB: ??? >> ==25500== by 0x8A697EE: ??? >> ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) >> ==25500== >> ==25500== >> ==25500== 40,584 (14,592 direct, 25,992 indirect) bytes in 456 blocks are definitely lost in loss record 68 of 81 >> ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) >> ==25500== by 0x8EED11F: ??? >> ==25500== by 0x8EED564: ??? >> ==25500== by 0x8EED65C: ??? >> ==25500== by 0x8C8D175: ??? >> ==25500== by 0x8C8ACBC: ??? >> ==25500== by 0x8C850CB: ??? >> ==25500== by 0x8C903F0: ??? >> ==25500== by 0x8C850CB: ??? >> ==25500== by 0x8A697EE: ??? >> ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== >> ==25500== >> ==25500== 84,628 (34,656 direct, 49,972 indirect) bytes in 228 blocks are definitely lost in loss record 73 of 81 >> ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) >> ==25500== by 0x8EF028B: ??? >> ==25500== by 0x8EF0B2F: ??? >> ==25500== by 0x8C78439: ??? >> ==25500== by 0x8C84A7F: ??? >> ==25500== by 0x8A699F9: ??? >> ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) >> ==25500== by 0x46442D: fe_op_bind (bind.c:280) >> ==25500== by 0x464032: do_bind (bind.c:205) >> ==25500== by 0x43CEDD: connection_operation (connection.c:1123) >> ==25500== >> ==25500== >> ==25500== 5,871,600 (287,560 direct, 5,584,040 indirect) bytes in 455 blocks are definitely lost in loss record 81 of 81 >> ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) >> ==25500== by 0x8C8A6C2: ??? >> ==25500== by 0x8C8ACBC: ??? >> ==25500== by 0x8C850CB: ??? >> ==25500== by 0x8C903F0: ??? >> ==25500== by 0x8C850CB: ??? >> ==25500== by 0x8A697EE: ??? >> ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) >> ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) >> ==25500== by 0x46442D: fe_op_bind (bind.c:280) >> ==25500== by 0x464032: do_bind (bind.c:205) >> ==25500== >> ==25500== LEAK SUMMARY: >> ==25500== definitely lost: 337,575 bytes in 1,154 blocks. >> ==25500== indirectly lost: 5,661,104 bytes in 214,509 blocks. >> ==25500== possibly lost: 1,604 bytes in 4 blocks. >> ==25500== still reachable: 55,368 bytes in 1,725 blocks. >> ==25500== suppressed: 0 bytes in 0 blocks. >> ==25500== Reachable blocks (those to which a pointer was found) are not shown. >> ==25500== To see them, rerun with: --leak-check=full --show-reachable=yes -- Bill MacAllister, System Software Programmer Unix Systems Group, Stanford University

1 0

Re: (ITS#6330) slapd memory leak
by hyc＠symas.com 16 Oct '09

16 Oct '09

whm(a)stanford.edu wrote: > Here is the valgrind output. The complete log is at > > http://www.stanford.edu/~whm/files/slapd/valgrind-memcheck.txt All of this indicates memory leaks and errors in the SASL library, not any bug in OpenLDAP. > > Bill > > # valgrind --leak-check=yes /usr/sbin/slapd -f /e tc/ldap/slapd.conf -d 256 > ==25500== Memcheck, a memory error detector. > ==25500== Copyright (C) 2002-2007, and GNU GPL'd, by Julian Seward et al. > ==25500== Using LibVEX rev 1854, a library for dynamic binary translation. > ==25500== Copyright (C) 2004-2007, and GNU GPL'd, by OpenWorks LLP. > ==25500== Using valgrind-3.3.1-Debian, a dynamic binary instrumentation framework. > ==25500== Copyright (C) 2000-2007, and GNU GPL'd, by Julian Seward et al. > ==25500== For more details, rerun with: -v > ==25500== > @(#) $OpenLDAP: slapd 2.4.18 (Sep 29 2009 07:08:49) $ > root@leviticus.stanford.edu:/tmp/buildd/openldap-2.4.18/debian/build/servers/slapd > ==25500== Warning: set address range perms: large range 135020544 (defined) > ==25500== Warning: set address range perms: large range 5368709120 (defined) > ==25500== Warning: set address range perms: large range 160000008 (defined) > slapd starting > ==25500== Thread 3: > ==25500== Invalid read of size 1 > ==25500== at 0x4C22B72: strcat (mc_replace_strmem.c:186) > ==25500== by 0x8A67DDE: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) > ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) > ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) > ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) > ==25500== by 0x4336B3: slap_client_connect (config.c:1803) > ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) > ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) > ==25500== by 0x4E3800C: ldap_int_thread_pool_wrapper (tpool.c:685) > ==25500== by 0x6B56FC6: start_thread (in /lib/libpthread-2.7.so) > ==25500== Address 0xb2581c1 is 0 bytes after a block of size 33 alloc'd > ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) > ==25500== by 0x8C848AC: (within /usr/lib/libgssapi.so.2.0.0) > ==25500== by 0x8C85EA7: gss_display_status (in /usr/lib/libgssapi.so.2.0.0) > ==25500== by 0x8A67D8E: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) > ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) > ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) > ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) > ==25500== by 0x4336B3: slap_client_connect (config.c:1803) > ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) > ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) > ==25500== > ==25500== Invalid read of size 1 > ==25500== at 0x4C22B72: strcat (mc_replace_strmem.c:186) > ==25500== by 0x8A67EDA: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) > ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) > ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) > ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) > ==25500== by 0x4336B3: slap_client_connect (config.c:1803) > ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) > ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) > ==25500== by 0x4E3800C: ldap_int_thread_pool_wrapper (tpool.c:685) > ==25500== by 0x6B56FC6: start_thread (in /lib/libpthread-2.7.so) > ==25500== Address 0xb258227 is 0 bytes after a block of size 47 alloc'd > ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) > ==25500== by 0x8C848F4: (within /usr/lib/libgssapi.so.2.0.0) > ==25500== by 0x8C85EA7: gss_display_status (in /usr/lib/libgssapi.so.2.0.0) > ==25500== by 0x8A67E8A: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) > ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) > ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) > ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) > ==25500== by 0x4336B3: slap_client_connect (config.c:1803) > ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) > ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) > slap_client_connect: URI=ldap://ldap-uatmaster.stanford.edu:389 ldap_sasl_interactive_bind_s failed (-2) > ==25500== Warning: invalid file descriptor -1 in syscall close() > do_syncrepl: rid=000 rc -2 retrying > conn=0 fd=12 ACCEPT from IP=172.20.196.4:48599 (IP=0.0.0.0:389) > conn=0 op=0 BIND dn="" method=163 > conn=0 op=0 RESULT tag=97 err=14 text=SASL(0): successful result: > connection_input: conn=0 deferring operation: binding > conn=0 op=1 BIND dn="" method=163 > conn=0 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: > conn=0 op=2 BIND dn="" method=163 > conn=0 op=2 BIND authcid="service/course-regis-test(a)stanford.edu" authzid="service/course-regis-test(a)stanford.edu" > conn=0 op=2 BIND dn="cn=course-regis-test,cn=service,cn=applications,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 > conn=0 op=2 RESULT tag=97 err=0 text= > conn=0 op=3 UNBIND > conn=0 fd=12 closed > conn=1 fd=12 ACCEPT from IP=171.64.11.53:34814 (IP=0.0.0.0:389) > conn=1 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" > conn=1 op=0 SRCH attr=supportedSASLMechanisms > conn=1 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= > conn=1 op=1 BIND dn="" method=163 > conn=1 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: > conn=1 op=2 BIND dn="" method=163 > conn=1 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: > conn=1 op=3 BIND dn="" method=163 > conn=1 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" > conn=1 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 > conn=1 op=3 RESULT tag=97 err=0 text= > conn=1 op=4 SRCH base="cn=groups,dc=stanford,dc=edu" scope=1 deref=0 filter="(objectClass=suWorkgroup)" > conn=1 op=4 SRCH attr=cn > conn=2 fd=16 ACCEPT from IP=127.0.0.1:56960 (IP=0.0.0.0:389) > conn=2 op=0 BIND dn="" method=128 > conn=2 op=0 RESULT tag=97 err=0 text= > conn=2 op=1 SRCH base="dc=stanford,dc=edu" scope=2 deref=2 filter="(uid=johnjacobjingleheimerschmidt)" > conn=2 op=1 SRCH attr=suPtsUid > conn=2 op=1 SEARCH RESULT tag=101 err=0 nentries=0 text= > conn=2 op=2 UNBIND > conn=2 fd=16 closed > conn=1 op=4 SEARCH RESULT tag=101 err=0 nentries=9287 text= > conn=1 op=5 UNBIND > conn=1 fd=12 closed > conn=3 fd=12 ACCEPT from IP=171.64.11.53:34815 (IP=0.0.0.0:389) > conn=3 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" > conn=3 op=0 SRCH attr=supportedSASLMechanisms > conn=3 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= > conn=3 op=1 BIND dn="" method=163 > conn=3 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: > conn=3 op=2 BIND dn="" method=163 > conn=3 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: > conn=3 op=3 BIND dn="" method=163 > conn=3 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" > conn=3 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 > conn=3 op=3 RESULT tag=97 err=0 text= > conn=3 op=4 SRCH base="cn=~tomhurl:cs106bgraders,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" > conn=3 op=4 SRCH attr=member > conn=3 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= > conn=3 op=5 UNBIND > conn=3 fd=12 closed > conn=4 fd=19 ACCEPT from IP=171.64.11.53:34816 (IP=0.0.0.0:389) > conn=4 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" > conn=4 op=0 SRCH attr=supportedSASLMechanisms > conn=4 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= > conn=4 op=1 BIND dn="" method=163 > conn=4 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: > conn=4 op=2 BIND dn="" method=163 > conn=4 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: > conn=4 op=3 BIND dn="" method=163 > conn=4 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" > conn=4 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 > conn=4 op=3 RESULT tag=97 err=0 text= > conn=4 op=4 SRCH base="cn=postgrads:pgsample/administrator,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" > conn=4 op=4 SRCH attr=member > conn=4 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= > conn=4 op=5 UNBIND > conn=4 fd=19 closed > conn=5 fd=12 ACCEPT from IP=171.64.11.53:34817 (IP=0.0.0.0:389) > conn=5 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" > conn=5 op=0 SRCH attr=supportedSASLMechanisms > conn=5 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= > conn=5 op=1 BIND dn="" method=163 > conn=5 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: > conn=5 op=2 BIND dn="" method=163 > conn=5 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: > conn=5 op=3 BIND dn="" method=163 > conn=5 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" > conn=5 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 > conn=5 op=3 RESULT tag=97 err=0 text= > conn=5 op=4 SRCH base="cn=med-emed:va,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" > conn=5 op=4 SRCH attr=member > conn=5 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= > conn=5 op=5 UNBIND > conn=5 fd=12 closed > > ... lots of ldap stats output ... > > conn=238 op=4 SRCH base="cn=maps:contracts/administrator,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" > conn=238 op=4 SRCH attr=member > conn=238 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= > conn=238 op=5 UNBIND > conn=238 fd=12 closed > conn=239 fd=12 ACCEPT from IP=171.64.11.53:35040 (IP=0.0.0.0:389) > conn=239 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" > conn=239 op=0 SRCH attr=supportedSASLMechanisms > conn=239 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= > conn=239 op=1 BIND dn="" method=163 > conn=239 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: > conn=239 op=2 BIND dn="" method=163 > conn=239 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: > conn=239 op=3 BIND dn="" method=163 > conn=239 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" > conn=239 fd=12 closed (connection lost) > ^Cdaemon: shutdown requested and initiated. > slapd shutdown: waiting for 0 operations/tasks to finish > ==25500== Warning: set address range perms: large range 5368709120 (noaccess) > ==25500== Warning: set address range perms: large range 135020544 (noaccess) > ==25500== Warning: set address range perms: large range 160000040 (noaccess) > slapd stopped. > ==25500== > ==25500== ERROR SUMMARY: 4 errors from 2 contexts (suppressed: 233 from 4) > ==25500== malloc/free: in use at exit: 6,055,651 bytes in 217,392 blocks. > ==25500== malloc/free: 1,612,487 allocs, 1,395,095 frees, 499,560,609 bytes allocated. > ==25500== For counts of detected errors, rerun with: -v > ==25500== searching for pointers to 217,392 not-freed blocks. > ==25500== checked 1,035,848 bytes. > ==25500== > ==25500== Thread 1: > ==25500== > ==25500== 20 bytes in 1 blocks are possibly lost in loss record 13 of 81 > ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) > ==25500== by 0x6DE6D91: strdup (in /lib/libc-2.7.so) > ==25500== by 0x8EC70D4: ??? > ==25500== by 0x8EC6F7B: ??? > ==25500== by 0x8EC717D: ??? > ==25500== by 0x8EC72E4: ??? > ==25500== by 0x8EC73F9: ??? > ==25500== by 0x8EC835C: ??? > ==25500== by 0x8EC89EC: ??? > ==25500== by 0x8C8D009: ??? > ==25500== by 0x8C8ACBC: ??? > ==25500== by 0x8C850CB: ??? > ==25500== > ==25500== > ==25500== 31 bytes in 1 blocks are definitely lost in loss record 14 of 81 > ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) > ==25500== by 0x4A7997: slap_sasl_getconfpath (sasl.c:1110) > ==25500== by 0x5AFFF71: sasl_server_init (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x4A7B9D: slap_sasl_init (sasl.c:1176) > ==25500== by 0x477F99: slap_init (init.c:151) > ==25500== by 0x41A9C0: main (main.c:750) > ==25500== > ==25500== > ==25500== 32 bytes in 1 blocks are possibly lost in loss record 15 of 81 > ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) > ==25500== by 0x8EC6D40: ??? > ==25500== by 0x8EC715F: ??? > ==25500== by 0x8EC72E4: ??? > ==25500== by 0x8EC73F9: ??? > ==25500== by 0x8EC835C: ??? > ==25500== by 0x8EC89EC: ??? > ==25500== by 0x8C8D009: ??? > ==25500== by 0x8C8ACBC: ??? > ==25500== by 0x8C850CB: ??? > ==25500== by 0x8C903F0: ??? > ==25500== by 0x8C850CB: ??? > ==25500== > ==25500== > ==25500== 64 (16 direct, 48 indirect) bytes in 1 blocks are definitely lost in loss record 19 of 81 > ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) > ==25500== by 0x8C85B9A: ??? > ==25500== by 0x8C88D1A: ??? > ==25500== by 0x8C89B8D: ??? > ==25500== by 0x8C86DE0: ??? > ==25500== by 0x8A681E6: ??? > ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) > ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) > ==25500== by 0x4336B3: slap_client_connect (config.c:1803) > ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) > ==25500== > ==25500== > ==25500== 128 bytes in 4 blocks are definitely lost in loss record 26 of 81 > ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) > ==25500== by 0x8ECF6E2: ??? > ==25500== by 0x8ECF76E: ??? > ==25500== by 0x8ED7E66: ??? > ==25500== by 0x8ED4CFF: ??? > ==25500== by 0x8ED4FBE: ??? > ==25500== by 0x8ED55EE: ??? > ==25500== by 0x8ED5B5E: ??? > ==25500== by 0x8ED6053: ??? > ==25500== by 0x8C7F194: ??? > ==25500== by 0x8C7FAB1: ??? > ==25500== by 0x8C86D56: ??? > ==25500== > ==25500== > ==25500== 1,008 (336 direct, 672 indirect) bytes in 1 blocks are definitely lost in loss record 35 of 81 > ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) > ==25500== by 0x8C88C49: ??? > ==25500== by 0x8C88D4A: ??? > ==25500== by 0x8C89B8D: ??? > ==25500== by 0x8C86DE0: ??? > ==25500== by 0x8A681E6: ??? > ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) > ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) > ==25500== by 0x4336B3: slap_client_connect (config.c:1803) > ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) > ==25500== > ==25500== > ==25500== 636 (256 direct, 380 indirect) bytes in 8 blocks are definitely lost in loss record 36 of 81 > ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) > ==25500== by 0x8EED07A: ??? > ==25500== by 0x8ED4B96: ??? > ==25500== by 0x8ED4FBE: ??? > ==25500== by 0x8ED55EE: ??? > ==25500== by 0x8ED5B5E: ??? > ==25500== by 0x8ED6053: ??? > ==25500== by 0x8C7F194: ??? > ==25500== by 0x8C7FAB1: ??? > ==25500== by 0x8C86D56: ??? > ==25500== by 0x8A681E6: ??? > ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== > ==25500== > ==25500== 632 bytes in 1 blocks are possibly lost in loss record 37 of 81 > ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) > ==25500== by 0x8C8A6C2: ??? > ==25500== by 0x8C8ACBC: ??? > ==25500== by 0x8C850CB: ??? > ==25500== by 0x8C903F0: ??? > ==25500== by 0x8C850CB: ??? > ==25500== by 0x8A697EE: ??? > ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) > ==25500== by 0x46442D: fe_op_bind (bind.c:280) > ==25500== by 0x464032: do_bind (bind.c:205) > ==25500== > ==25500== > ==25500== 920 bytes in 1 blocks are possibly lost in loss record 38 of 81 > ==25500== at 0x4C22741: realloc (vg_replace_malloc.c:429) > ==25500== by 0x8EC474D: ??? > ==25500== by 0x8EC8A77: ??? > ==25500== by 0x8C8D009: ??? > ==25500== by 0x8C8ACBC: ??? > ==25500== by 0x8C850CB: ??? > ==25500== by 0x8C903F0: ??? > ==25500== by 0x8C850CB: ??? > ==25500== by 0x8A697EE: ??? > ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) > ==25500== > ==25500== > ==25500== 40,584 (14,592 direct, 25,992 indirect) bytes in 456 blocks are definitely lost in loss record 68 of 81 > ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) > ==25500== by 0x8EED11F: ??? > ==25500== by 0x8EED564: ??? > ==25500== by 0x8EED65C: ??? > ==25500== by 0x8C8D175: ??? > ==25500== by 0x8C8ACBC: ??? > ==25500== by 0x8C850CB: ??? > ==25500== by 0x8C903F0: ??? > ==25500== by 0x8C850CB: ??? > ==25500== by 0x8A697EE: ??? > ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) > ==25500== > ==25500== > ==25500== 84,628 (34,656 direct, 49,972 indirect) bytes in 228 blocks are definitely lost in loss record 73 of 81 > ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) > ==25500== by 0x8EF028B: ??? > ==25500== by 0x8EF0B2F: ??? > ==25500== by 0x8C78439: ??? > ==25500== by 0x8C84A7F: ??? > ==25500== by 0x8A699F9: ??? > ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) > ==25500== by 0x46442D: fe_op_bind (bind.c:280) > ==25500== by 0x464032: do_bind (bind.c:205) > ==25500== by 0x43CEDD: connection_operation (connection.c:1123) > ==25500== > ==25500== > ==25500== 5,871,600 (287,560 direct, 5,584,040 indirect) bytes in 455 blocks are definitely lost in loss record 81 of 81 > ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) > ==25500== by 0x8C8A6C2: ??? > ==25500== by 0x8C8ACBC: ??? > ==25500== by 0x8C850CB: ??? > ==25500== by 0x8C903F0: ??? > ==25500== by 0x8C850CB: ??? > ==25500== by 0x8A697EE: ??? > ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) > ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) > ==25500== by 0x46442D: fe_op_bind (bind.c:280) > ==25500== by 0x464032: do_bind (bind.c:205) > ==25500== > ==25500== LEAK SUMMARY: > ==25500== definitely lost: 337,575 bytes in 1,154 blocks. > ==25500== indirectly lost: 5,661,104 bytes in 214,509 blocks. > ==25500== possibly lost: 1,604 bytes in 4 blocks. > ==25500== still reachable: 55,368 bytes in 1,725 blocks. > ==25500== suppressed: 0 bytes in 0 blocks. > ==25500== Reachable blocks (those to which a pointer was found) are not shown. > ==25500== To see them, rerun with: --leak-check=full --show-reachable=yes > -- -- Howard Chu CTO, Symas Corp. http://www.symas.com Director, Highland Sun http://highlandsun.com/hyc/ Chief Architect, OpenLDAP http://www.openldap.org/project/

1 0

Re: (ITS#6330) slapd memory leak
by whm＠stanford.edu 15 Oct '09

15 Oct '09

Here is the valgrind output. The complete log is at http://www.stanford.edu/~whm/files/slapd/valgrind-memcheck.txt Bill # valgrind --leak-check=yes /usr/sbin/slapd -f /e tc/ldap/slapd.conf -d 256 ==25500== Memcheck, a memory error detector. ==25500== Copyright (C) 2002-2007, and GNU GPL'd, by Julian Seward et al. ==25500== Using LibVEX rev 1854, a library for dynamic binary translation. ==25500== Copyright (C) 2004-2007, and GNU GPL'd, by OpenWorks LLP. ==25500== Using valgrind-3.3.1-Debian, a dynamic binary instrumentation framework. ==25500== Copyright (C) 2000-2007, and GNU GPL'd, by Julian Seward et al. ==25500== For more details, rerun with: -v ==25500== @(#) $OpenLDAP: slapd 2.4.18 (Sep 29 2009 07:08:49) $ root@leviticus.stanford.edu:/tmp/buildd/openldap-2.4.18/debian/build/servers/slapd ==25500== Warning: set address range perms: large range 135020544 (defined) ==25500== Warning: set address range perms: large range 5368709120 (defined) ==25500== Warning: set address range perms: large range 160000008 (defined) slapd starting ==25500== Thread 3: ==25500== Invalid read of size 1 ==25500== at 0x4C22B72: strcat (mc_replace_strmem.c:186) ==25500== by 0x8A67DDE: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) ==25500== by 0x4336B3: slap_client_connect (config.c:1803) ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) ==25500== by 0x4E3800C: ldap_int_thread_pool_wrapper (tpool.c:685) ==25500== by 0x6B56FC6: start_thread (in /lib/libpthread-2.7.so) ==25500== Address 0xb2581c1 is 0 bytes after a block of size 33 alloc'd ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) ==25500== by 0x8C848AC: (within /usr/lib/libgssapi.so.2.0.0) ==25500== by 0x8C85EA7: gss_display_status (in /usr/lib/libgssapi.so.2.0.0) ==25500== by 0x8A67D8E: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) ==25500== by 0x4336B3: slap_client_connect (config.c:1803) ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) ==25500== ==25500== Invalid read of size 1 ==25500== at 0x4C22B72: strcat (mc_replace_strmem.c:186) ==25500== by 0x8A67EDA: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) ==25500== by 0x4336B3: slap_client_connect (config.c:1803) ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) ==25500== by 0x4E3800C: ldap_int_thread_pool_wrapper (tpool.c:685) ==25500== by 0x6B56FC6: start_thread (in /lib/libpthread-2.7.so) ==25500== Address 0xb258227 is 0 bytes after a block of size 47 alloc'd ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) ==25500== by 0x8C848F4: (within /usr/lib/libgssapi.so.2.0.0) ==25500== by 0x8C85EA7: gss_display_status (in /usr/lib/libgssapi.so.2.0.0) ==25500== by 0x8A67E8A: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) ==25500== by 0x8A688DB: (within /usr/lib/sasl2/libgssapiv2.so.2.0.22) ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) ==25500== by 0x4336B3: slap_client_connect (config.c:1803) ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) ==25500== by 0x4B63ED: do_syncrepl (syncrepl.c:1346) slap_client_connect: URI=ldap://ldap-uatmaster.stanford.edu:389 ldap_sasl_interactive_bind_s failed (-2) ==25500== Warning: invalid file descriptor -1 in syscall close() do_syncrepl: rid=000 rc -2 retrying conn=0 fd=12 ACCEPT from IP=172.20.196.4:48599 (IP=0.0.0.0:389) conn=0 op=0 BIND dn="" method=163 conn=0 op=0 RESULT tag=97 err=14 text=SASL(0): successful result: connection_input: conn=0 deferring operation: binding conn=0 op=1 BIND dn="" method=163 conn=0 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: conn=0 op=2 BIND dn="" method=163 conn=0 op=2 BIND authcid="service/course-regis-test(a)stanford.edu" authzid="service/course-regis-test(a)stanford.edu" conn=0 op=2 BIND dn="cn=course-regis-test,cn=service,cn=applications,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 conn=0 op=2 RESULT tag=97 err=0 text= conn=0 op=3 UNBIND conn=0 fd=12 closed conn=1 fd=12 ACCEPT from IP=171.64.11.53:34814 (IP=0.0.0.0:389) conn=1 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" conn=1 op=0 SRCH attr=supportedSASLMechanisms conn=1 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= conn=1 op=1 BIND dn="" method=163 conn=1 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: conn=1 op=2 BIND dn="" method=163 conn=1 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: conn=1 op=3 BIND dn="" method=163 conn=1 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" conn=1 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 conn=1 op=3 RESULT tag=97 err=0 text= conn=1 op=4 SRCH base="cn=groups,dc=stanford,dc=edu" scope=1 deref=0 filter="(objectClass=suWorkgroup)" conn=1 op=4 SRCH attr=cn conn=2 fd=16 ACCEPT from IP=127.0.0.1:56960 (IP=0.0.0.0:389) conn=2 op=0 BIND dn="" method=128 conn=2 op=0 RESULT tag=97 err=0 text= conn=2 op=1 SRCH base="dc=stanford,dc=edu" scope=2 deref=2 filter="(uid=johnjacobjingleheimerschmidt)" conn=2 op=1 SRCH attr=suPtsUid conn=2 op=1 SEARCH RESULT tag=101 err=0 nentries=0 text= conn=2 op=2 UNBIND conn=2 fd=16 closed conn=1 op=4 SEARCH RESULT tag=101 err=0 nentries=9287 text= conn=1 op=5 UNBIND conn=1 fd=12 closed conn=3 fd=12 ACCEPT from IP=171.64.11.53:34815 (IP=0.0.0.0:389) conn=3 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" conn=3 op=0 SRCH attr=supportedSASLMechanisms conn=3 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= conn=3 op=1 BIND dn="" method=163 conn=3 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: conn=3 op=2 BIND dn="" method=163 conn=3 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: conn=3 op=3 BIND dn="" method=163 conn=3 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" conn=3 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 conn=3 op=3 RESULT tag=97 err=0 text= conn=3 op=4 SRCH base="cn=~tomhurl:cs106bgraders,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" conn=3 op=4 SRCH attr=member conn=3 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= conn=3 op=5 UNBIND conn=3 fd=12 closed conn=4 fd=19 ACCEPT from IP=171.64.11.53:34816 (IP=0.0.0.0:389) conn=4 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" conn=4 op=0 SRCH attr=supportedSASLMechanisms conn=4 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= conn=4 op=1 BIND dn="" method=163 conn=4 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: conn=4 op=2 BIND dn="" method=163 conn=4 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: conn=4 op=3 BIND dn="" method=163 conn=4 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" conn=4 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 conn=4 op=3 RESULT tag=97 err=0 text= conn=4 op=4 SRCH base="cn=postgrads:pgsample/administrator,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" conn=4 op=4 SRCH attr=member conn=4 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= conn=4 op=5 UNBIND conn=4 fd=19 closed conn=5 fd=12 ACCEPT from IP=171.64.11.53:34817 (IP=0.0.0.0:389) conn=5 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" conn=5 op=0 SRCH attr=supportedSASLMechanisms conn=5 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= conn=5 op=1 BIND dn="" method=163 conn=5 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: conn=5 op=2 BIND dn="" method=163 conn=5 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: conn=5 op=3 BIND dn="" method=163 conn=5 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" conn=5 op=3 BIND dn="uid=whm,cn=accounts,dc=stanford,dc=edu" mech=GSSAPI sasl_ssf=56 ssf=56 conn=5 op=3 RESULT tag=97 err=0 text= conn=5 op=4 SRCH base="cn=med-emed:va,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" conn=5 op=4 SRCH attr=member conn=5 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= conn=5 op=5 UNBIND conn=5 fd=12 closed ... lots of ldap stats output ... conn=238 op=4 SRCH base="cn=maps:contracts/administrator,cn=groups,dc=stanford,dc=edu" scope=0 deref=0 filter="(objectClass=suWorkgroup)" conn=238 op=4 SRCH attr=member conn=238 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text= conn=238 op=5 UNBIND conn=238 fd=12 closed conn=239 fd=12 ACCEPT from IP=171.64.11.53:35040 (IP=0.0.0.0:389) conn=239 op=0 SRCH base="" scope=0 deref=0 filter="(objectClass=*)" conn=239 op=0 SRCH attr=supportedSASLMechanisms conn=239 op=0 SEARCH RESULT tag=101 err=0 nentries=1 text= conn=239 op=1 BIND dn="" method=163 conn=239 op=1 RESULT tag=97 err=14 text=SASL(0): successful result: conn=239 op=2 BIND dn="" method=163 conn=239 op=2 RESULT tag=97 err=14 text=SASL(0): successful result: conn=239 op=3 BIND dn="" method=163 conn=239 op=3 BIND authcid="whm(a)stanford.edu" authzid="whm(a)stanford.edu" conn=239 fd=12 closed (connection lost) ^Cdaemon: shutdown requested and initiated. slapd shutdown: waiting for 0 operations/tasks to finish ==25500== Warning: set address range perms: large range 5368709120 (noaccess) ==25500== Warning: set address range perms: large range 135020544 (noaccess) ==25500== Warning: set address range perms: large range 160000040 (noaccess) slapd stopped. ==25500== ==25500== ERROR SUMMARY: 4 errors from 2 contexts (suppressed: 233 from 4) ==25500== malloc/free: in use at exit: 6,055,651 bytes in 217,392 blocks. ==25500== malloc/free: 1,612,487 allocs, 1,395,095 frees, 499,560,609 bytes allocated. ==25500== For counts of detected errors, rerun with: -v ==25500== searching for pointers to 217,392 not-freed blocks. ==25500== checked 1,035,848 bytes. ==25500== ==25500== Thread 1: ==25500== ==25500== 20 bytes in 1 blocks are possibly lost in loss record 13 of 81 ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) ==25500== by 0x6DE6D91: strdup (in /lib/libc-2.7.so) ==25500== by 0x8EC70D4: ??? ==25500== by 0x8EC6F7B: ??? ==25500== by 0x8EC717D: ??? ==25500== by 0x8EC72E4: ??? ==25500== by 0x8EC73F9: ??? ==25500== by 0x8EC835C: ??? ==25500== by 0x8EC89EC: ??? ==25500== by 0x8C8D009: ??? ==25500== by 0x8C8ACBC: ??? ==25500== by 0x8C850CB: ??? ==25500== ==25500== ==25500== 31 bytes in 1 blocks are definitely lost in loss record 14 of 81 ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) ==25500== by 0x4A7997: slap_sasl_getconfpath (sasl.c:1110) ==25500== by 0x5AFFF71: sasl_server_init (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x4A7B9D: slap_sasl_init (sasl.c:1176) ==25500== by 0x477F99: slap_init (init.c:151) ==25500== by 0x41A9C0: main (main.c:750) ==25500== ==25500== ==25500== 32 bytes in 1 blocks are possibly lost in loss record 15 of 81 ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) ==25500== by 0x8EC6D40: ??? ==25500== by 0x8EC715F: ??? ==25500== by 0x8EC72E4: ??? ==25500== by 0x8EC73F9: ??? ==25500== by 0x8EC835C: ??? ==25500== by 0x8EC89EC: ??? ==25500== by 0x8C8D009: ??? ==25500== by 0x8C8ACBC: ??? ==25500== by 0x8C850CB: ??? ==25500== by 0x8C903F0: ??? ==25500== by 0x8C850CB: ??? ==25500== ==25500== ==25500== 64 (16 direct, 48 indirect) bytes in 1 blocks are definitely lost in loss record 19 of 81 ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) ==25500== by 0x8C85B9A: ??? ==25500== by 0x8C88D1A: ??? ==25500== by 0x8C89B8D: ??? ==25500== by 0x8C86DE0: ??? ==25500== by 0x8A681E6: ??? ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) ==25500== by 0x4336B3: slap_client_connect (config.c:1803) ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) ==25500== ==25500== ==25500== 128 bytes in 4 blocks are definitely lost in loss record 26 of 81 ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) ==25500== by 0x8ECF6E2: ??? ==25500== by 0x8ECF76E: ??? ==25500== by 0x8ED7E66: ??? ==25500== by 0x8ED4CFF: ??? ==25500== by 0x8ED4FBE: ??? ==25500== by 0x8ED55EE: ??? ==25500== by 0x8ED5B5E: ??? ==25500== by 0x8ED6053: ??? ==25500== by 0x8C7F194: ??? ==25500== by 0x8C7FAB1: ??? ==25500== by 0x8C86D56: ??? ==25500== ==25500== ==25500== 1,008 (336 direct, 672 indirect) bytes in 1 blocks are definitely lost in loss record 35 of 81 ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) ==25500== by 0x8C88C49: ??? ==25500== by 0x8C88D4A: ??? ==25500== by 0x8C89B8D: ??? ==25500== by 0x8C86DE0: ??? ==25500== by 0x8A681E6: ??? ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x5AF7262: sasl_client_start (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x4E41CC7: ldap_int_sasl_bind (cyrus.c:509) ==25500== by 0x4E45ED6: ldap_sasl_interactive_bind_s (sasl.c:464) ==25500== by 0x4336B3: slap_client_connect (config.c:1803) ==25500== by 0x4B387C: do_syncrep1 (syncrepl.c:561) ==25500== ==25500== ==25500== 636 (256 direct, 380 indirect) bytes in 8 blocks are definitely lost in loss record 36 of 81 ==25500== at 0x4C2260E: malloc (vg_replace_malloc.c:207) ==25500== by 0x8EED07A: ??? ==25500== by 0x8ED4B96: ??? ==25500== by 0x8ED4FBE: ??? ==25500== by 0x8ED55EE: ??? ==25500== by 0x8ED5B5E: ??? ==25500== by 0x8ED6053: ??? ==25500== by 0x8C7F194: ??? ==25500== by 0x8C7FAB1: ??? ==25500== by 0x8C86D56: ??? ==25500== by 0x8A681E6: ??? ==25500== by 0x5AF6D34: sasl_client_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== ==25500== ==25500== 632 bytes in 1 blocks are possibly lost in loss record 37 of 81 ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) ==25500== by 0x8C8A6C2: ??? ==25500== by 0x8C8ACBC: ??? ==25500== by 0x8C850CB: ??? ==25500== by 0x8C903F0: ??? ==25500== by 0x8C850CB: ??? ==25500== by 0x8A697EE: ??? ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) ==25500== by 0x46442D: fe_op_bind (bind.c:280) ==25500== by 0x464032: do_bind (bind.c:205) ==25500== ==25500== ==25500== 920 bytes in 1 blocks are possibly lost in loss record 38 of 81 ==25500== at 0x4C22741: realloc (vg_replace_malloc.c:429) ==25500== by 0x8EC474D: ??? ==25500== by 0x8EC8A77: ??? ==25500== by 0x8C8D009: ??? ==25500== by 0x8C8ACBC: ??? ==25500== by 0x8C850CB: ??? ==25500== by 0x8C903F0: ??? ==25500== by 0x8C850CB: ??? ==25500== by 0x8A697EE: ??? ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) ==25500== ==25500== ==25500== 40,584 (14,592 direct, 25,992 indirect) bytes in 456 blocks are definitely lost in loss record 68 of 81 ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) ==25500== by 0x8EED11F: ??? ==25500== by 0x8EED564: ??? ==25500== by 0x8EED65C: ??? ==25500== by 0x8C8D175: ??? ==25500== by 0x8C8ACBC: ??? ==25500== by 0x8C850CB: ??? ==25500== by 0x8C903F0: ??? ==25500== by 0x8C850CB: ??? ==25500== by 0x8A697EE: ??? ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) ==25500== ==25500== ==25500== 84,628 (34,656 direct, 49,972 indirect) bytes in 228 blocks are definitely lost in loss record 73 of 81 ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) ==25500== by 0x8EF028B: ??? ==25500== by 0x8EF0B2F: ??? ==25500== by 0x8C78439: ??? ==25500== by 0x8C84A7F: ??? ==25500== by 0x8A699F9: ??? ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) ==25500== by 0x46442D: fe_op_bind (bind.c:280) ==25500== by 0x464032: do_bind (bind.c:205) ==25500== by 0x43CEDD: connection_operation (connection.c:1123) ==25500== ==25500== ==25500== 5,871,600 (287,560 direct, 5,584,040 indirect) bytes in 455 blocks are definitely lost in loss record 81 of 81 ==25500== at 0x4C203E4: calloc (vg_replace_malloc.c:397) ==25500== by 0x8C8A6C2: ??? ==25500== by 0x8C8ACBC: ??? ==25500== by 0x8C850CB: ??? ==25500== by 0x8C903F0: ??? ==25500== by 0x8C850CB: ??? ==25500== by 0x8A697EE: ??? ==25500== by 0x5AFDDBE: sasl_server_step (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x5AFF10D: sasl_server_start (in /usr/lib/libsasl2.so.2.0.22) ==25500== by 0x4A88A0: slap_sasl_bind (sasl.c:1522) ==25500== by 0x46442D: fe_op_bind (bind.c:280) ==25500== by 0x464032: do_bind (bind.c:205) ==25500== ==25500== LEAK SUMMARY: ==25500== definitely lost: 337,575 bytes in 1,154 blocks. ==25500== indirectly lost: 5,661,104 bytes in 214,509 blocks. ==25500== possibly lost: 1,604 bytes in 4 blocks. ==25500== still reachable: 55,368 bytes in 1,725 blocks. ==25500== suppressed: 0 bytes in 0 blocks. ==25500== Reachable blocks (those to which a pointer was found) are not shown. ==25500== To see them, rerun with: --leak-check=full --show-reachable=yes -- Bill MacAllister, System Software Programmer Unix Systems Group, Stanford University

1 0

Re: (ITS#6331) slapd freezing, not accepting further 'write' operations while 'read' operations are unaffected
by j＠telepaths.org 15 Oct '09

15 Oct '09

That is exactly what I will do, thanks again. Jeff

1 0

Re: (ITS#6331) slapd freezing, not accepting further 'write' operations while 'read' operations are unaffected
by quanah＠zimbra.com 15 Oct '09

15 Oct '09

--On Thursday, October 15, 2009 6:48 PM +0000 j(a)telepaths.org wrote: > Quanah, > > I wasn't sure what you meant, but I figured out gdb (never used it > before): > > This is what I did (on both servers), so I'm putting it here so people > aren't left in the dark: > > dpkg -i slapd-dbg (whatever version applicable) > apt-get install gdb > gdb (enter gdb console) > gdb> file /usr/sbin/slapd > gdb> set args -d -1 -u openldap -g openldap -h ldap:/// ldaps:/// > ldapi:/// -f /etc/ldap/slapd.conf > gdb> run > > Running on both servers now .... Great! After one crashes, run "thr apply all bt" and send that output to the ITS. --Quanah -- Quanah Gibson-Mount Principal Software Engineer Zimbra, Inc -------------------- Zimbra :: the leader in open source messaging and collaboration

1 0

Re: (ITS#6331) slapd freezing, not accepting further 'write' operations while 'read' operations are unaffected
by j＠telepaths.org 15 Oct '09

15 Oct '09

Quanah, I wasn't sure what you meant, but I figured out gdb (never used it before): This is what I did (on both servers), so I'm putting it here so people aren't left in the dark: dpkg -i slapd-dbg (whatever version applicable) apt-get install gdb gdb (enter gdb console) gdb> file /usr/sbin/slapd gdb> set args -d -1 -u openldap -g openldap -h ldap:/// ldaps:/// ldapi:/// -f /etc/ldap/slapd.conf gdb> run Running on both servers now .... Jeff

1 0

Re: (ITS#6331) slapd freezing, not accepting further 'write' operations while 'read' operations are unaffected
by quanah＠zimbra.com 15 Oct '09

15 Oct '09

--On Thursday, October 15, 2009 6:06 PM +0000 j(a)telepaths.org wrote: > We are in luck. I started fresh with my two servers (deleted the data > and repopulated). > > During the INITIAL sync-up on "server1" (receiving data from server2): > > <= index_entry_add( 225, > "krb5PrincipalName=host/seven.relay.example.com(a)RELAY.EXAMPLE.COM > ,cn=RELAY.EXAMPLE.COM,cn=gssapi,cn=auth,dc=real,dc=example,dc=com" ) > success > => entry_encode(0x000000e1): > <= entry_encode(0x000000e1): > => acl_get: [2] matched > => acl_get: [2] attr userPassword > => match[dn0]: 0 60 > uid=plainproxy,cn=plain,cn=auth,dc=real,dc=example,dc=com > => match[dn1]: 0 3 uid > => match[dn2]: 4 14 plainproxy > => acl_mask: access to entry > "uid=plainproxy,cn=plain,cn=auth,dc=real,dc=example,dc=com", attr > "userPassword" requested > => acl_mask: to value by "", (=0) > <= check a_dn_pat: self > <= check a_dn_pat: > uid=plainchange,cn=plain,cn=auth,dc=real,dc=example,dc=com > <= check a_dn_pat: > uid=plainmodify,cn=plain,cn=auth,dc=real,dc=example,dc=com > <= check a_dn_pat: anonymous > <= acl_mask: [4] applying auth(=xd) (stop) > <= acl_mask: [4] mask: auth(=xd) > => slap_access_allowed: auth access granted by auth(=xd) > => access_allowed: auth access granted by auth(=xd) > conn=1 op=1 BIND > dn="uid=plainproxy,cn=plain,cn=auth,dc=real,dc=example,dc=com" > mech=SIMPLE ssf=0 > do_bind: v3 bind: > "uid=plainproxy,cn=plain,cn=auth,dc=real,dc=example,dc=com" to > "uid=plainproxy,cn=plain,cn=auth,dc=real,dc=example,dc=com" > send_ldap_result: conn=1 op=1 p=3 > send_ldap_result: err=0 matched="" text="" > send_ldap_response: msgid=2 tag=97 err=0 > ber_flush2: 22 bytes to sd 33 > 0000: 30 84 00 00 00 10 02 01 02 61 84 00 00 00 07 0a > 0........a...... > 0010: 01 00 04 00 04 00 ...... > tls_write: want=101, written=101 > 0000: 17 03 02 00 60 3e 98 2a 48 b2 d9 ae 12 70 ab > db ....`>.*H....p.. > 0010: 5e 46 c2 ef 7f c3 32 72 d4 41 ef 4d 58 07 d0 50 ^F.... > 2r.A.MX..P > 0020: 53 a2 da 54 69 d7 1c 61 ed a7 ce 53 14 16 46 73 > S..Ti..a...S..Fs > 0030: 91 74 c4 92 9e 35 24 84 ce 8c 6f 18 18 6a 68 0a .t... > 5$...o..jh. > 0040: b0 69 70 75 0d 6a 5d fa 02 38 89 e9 d7 99 c9 99 .ipu.j].. > 8...... > 0050: bb 7b be 62 5d 50 91 2f a9 a2 6e d5 88 47 f8 ed .{.b] > P./..n..G.. > 0060: 5e 3c a7 dd 17 ^<... > ldap_write: want=22, written=22 > 0000: 30 84 00 00 00 10 02 01 02 61 84 00 00 00 07 0a > 0........a...... > 0010: 01 00 04 00 04 00 ...... > daemon: activity on 1 descriptor > daemon: activity on: 33r > daemon: read active on 33 > daemon: epoll: listen=7 active_threads=0 tvp=zero > daemon: epoll: listen=8 active_threads=0 tvp=zero > daemon: epoll: listen=9 active_threads=0 tvp=zero > daemon: epoll: listen=10 active_threads=0 tvp=zero > daemon: epoll: listen=11 active_threads=0 tvp=zero > connection_get(33) > connection_get(33): got connid=1 > connection_read(33): checking for input on id=1 > ber_get_next > tls_read: want=5, got=5 > 0000: 17 03 02 00 c0 ..... > tls_read: want=192, got=192 > 0000: 60 a2 1b 5e 6f 13 18 52 f1 86 c7 b5 ff ae ec bf > `..^o..R........ > 0010: 7e 7f 65 19 30 c0 4a 3a 7d de 76 77 5b bf 0b dc ~.e. > 0.J:}.vw[... > 0020: 22 15 34 f9 5b dd 2d 8f f5 19 e3 25 0d 25 a8 b6 ".4. > [.-....%.%.. > 0030: 07 34 75 a5 08 c6 3e c2 8e 18 58 11 ee 5d 25 7c . > 4u...>...X..]%| > 0040: 00 9b fb 14 a4 9c 7d c1 37 bf 92 f7 ee ef 04 94 ......}. > 7....... > 0050: 81 a8 98 d8 eb 5b 80 0f ce 7d 21 3c 24 fa ba ca ..... > [...}!<$... > 0060: 3f 9a 94 ef dd 7f 47 17 e0 f2 cb 08 04 a5 25 > a3 ?.....G.......%. > 0070: f0 3e 92 a4 75 a2 6e d3 34 1a 82 29 7b 9f b0 07 .>..u.n. > 4..){... > 0080: fd 4e 5f 1e 8f f2 55 33 c5 eb 5f 34 a1 f6 3d > 0a .N_...U3.._4..=. > 0090: c3 e7 4f 4a 77 85 a5 1e 40 f8 d4 60 8e bd 08 > 8c ..OJw...@..`.... > 00a0: 8e 87 7d 93 50 11 da c1 ea b0 e1 74 60 34 ad > b8 ..}.P......t`4.. > 00b0: c0 9a f3 66 44 3c e5 bf 6e b1 4f 4f f8 51 18 > df ...fD<..n.OO.Q.. > ldap_read: want=8, got=8 > 0000: 30 53 02 01 03 63 4e 04 0S...cN. > ldap_read: want=77, got=77 > 0000: 2e 63 6e 3d 70 6c 61 69 6e 2c 63 6e 3d 61 75 > 74 .cn=plain,cn=aut > 0010: 68 2c 64 63 3d 76 65 72 69 6f 2c 64 63 3d 61 6e > h,dc=relay,dc=ex > 0020: 6f 6e 79 6d 69 7a 65 72 2c 64 63 3d 63 6f 6d 0a > ample ,dc=com. > 0030: 01 01 0a 01 00 02 01 01 02 01 00 01 01 00 a3 > 0b ................ > 0040: 04 03 75 69 64 04 04 72 6f 6f 74 30 > 00 ..uid..root0. > ber_get_next: tag 0x30 len 83 contents: > ber_dump: buf=0x2a0d1d0 ptr=0x2a0d1d0 end=0x2a0d223 len=83 > 0000: 02 01 03 63 4e 04 2e 63 6e 3d 70 6c 61 69 6e > 2c ...cN..cn=plain, > 0010: 63 6e 3d 61 75 74 68 2c 64 63 3d 76 65 72 69 6f > cn=auth,dc=relay > 0020: 2c 64 63 3d 61 6e 6f 6e 79 6d 69 7a 65 72 2c > 64 ,dc=example,dc=com > 0030: 63 3d 63 6f 6d 0a 01 01 0a 01 00 02 01 01 02 01 ........... > 0040: 00 01 01 00 a3 0b 04 03 75 69 64 04 04 72 6f > 6f ........uid..roo > 0050: 74 30 00 t0. > op tag 0x63, time 1255629604 > connection_input: conn=1 deferring operation: binding > ber_get_next > tls_read: want=5 error=Resource temporarily unavailable > ldap_read: want=8, got=0 > > daemon: activity on 1 descriptor > daemon: activity on: > daemon: epoll: listen=7 active_threads=0 tvp=zero > daemon: epoll: listen=8 active_threads=0 tvp=zero > daemon: epoll: listen=9 active_threads=0 tvp=zero > daemon: epoll: listen=10 active_threads=0 tvp=zero > daemon: epoll: listen=11 active_threads=0 tvp=zero > Segmentation fault <--------- HERE IT IS > > Again, this was just the initial sync-up. This is not a gdb backtrace from a core file, where slapd has debugging symbols. This information is not really useful. --Quanah -- Quanah Gibson-Mount Principal Software Engineer Zimbra, Inc -------------------- Zimbra :: the leader in open source messaging and collaboration

1 0

Jump to page:

2025

2024

2023

2022

2021

2020

2019

2018

2017

2016

2015

2014

2013

2012

2011

2010

2009

2008

2007

2006

openldap-bugs