[leafnode-list] Re: Fetchnews - glibc detected *** double free or corruption - aborted

Stroller linux.luser at myrealbox.com
Thu Jul 6 06:28:15 CEST 2006


On 4 Jul 2006, at 01:12, Stroller wrote:

>
> When recompiled the leafnode suite (using Gentoo's emerge command, of
> course) it was immediately fine, and so I am not able to reproduce
> the problem for you.
>

ARRRRRRRRGGGGGGG!

    ...
    uk.adverts.computer: considering 1489 articles 449145 - 450633,  
using XOVER
    uk.adverts.computer: XOVER: 1083 seen, 0 I have, 0 filtered, 1083  
to get
    uk.adverts.computer: will fetch 1083 articles
    uk.adverts.computer: 51 articles fetched (to 52), 0 killed
    free.teranews.com: cannot parse reply to "GROUP  
uk.comp.homebuilt": "220 449234
    <dwVgg.9060$lQ.5220 at newsfe3-gui.ntli.net> article"
    fetchnews: 9033 articles and 0 headers fetched, 0 killed, 0  
posted, in 4186 seco
    nds
    $ sudo fetchnews -vvv
    Password:
    fetchnews mode: get articles, get headers, get bodies, post articles
    *** glibc detected *** double free or corruption (!prev):  
0x08067d98 ***
    Aborted
    $


> 2. Install the most recent valgrind you can find and then run:
>
>    sudo valgrind --leak-check=yes --show-reachable=yes \
>                  --num-callers=16 --quiet fetchnews -vvv 2>&1 \
>    tee fetchnews.log

This doesn't seem to have created a "fetchnews.log" file as I  
expected, so below's a copy & paste from the terminal window. It's  
227 lines, so I figure that's within 15% of "fine for the list":

# valgrind --leak-check=yes --show-reachable=yes  --num-callers=16 -- 
quiet fetchnews -vvv 2>&1 tee fetchnews.log
fetchnews mode: get articles, get headers, get bodies, post articles
==22628== Invalid write of size 1
==22628==    at 0x805529C: getabufferedline (getaline.c:102)
==22628==    by 0x805079A: rereadactive (activutil.c:557)
==22628==    by 0x804E095: main (fetchnews.c:2141)
==22628==  Address 0x4249EBC is 0 bytes after a block of size 260  
alloc'd
==22628==    at 0x401A511: malloc (in /usr/lib/valgrind/x86-linux/ 
vgpreload_memcheck.so)
==22628==    by 0x8055274: getabufferedline (getaline.c:95)
==22628==    by 0x805079A: rereadactive (activutil.c:557)
==22628==    by 0x804E095: main (fetchnews.c:2141)
==22628==
==22628== Invalid read of size 1
==22628==    at 0x8050BF6: rereadactive (activutil.c:553)
==22628==    by 0x804E095: main (fetchnews.c:2141)
==22628==  Address 0x4249EBC is 0 bytes after a block of size 260  
alloc'd
==22628==    at 0x401A511: malloc (in /usr/lib/valgrind/x86-linux/ 
vgpreload_memcheck.so)
==22628==    by 0x8055274: getabufferedline (getaline.c:95)
==22628==    by 0x805079A: rereadactive (activutil.c:557)
==22628==    by 0x804E095: main (fetchnews.c:2141)
found 0 articles in in.coming.
news.eclipse.co.uk: connecting to port nntp
   trying:    address 216.196.109.145 port 119...
   connected: address 216.196.109.145 port 119.
news.eclipse.co.uk: connected (200), banner: "200 news.eclipse.net.uk"
news.eclipse.co.uk: getting newsgroups list
Warning: skipping group "alt.", invalid name (NULL component).
Warning: skipping group "alt.binaries.", invalid name (NULL component).
Warning: skipping group "alt.binaries.celebrities.bikini.", invalid  
name (NULL component).
Warning: skipping group "alt.binaries.multimedia.erotica.", invalid  
name (NULL component).
Warning: skipping group "alt.binaries.pictures.", invalid name (NULL  
component).Warning: skipping group "alt.binaries.pictures.erotica.",  
invalid name (NULL component).
Warning: skipping group "alt.binaries.pictures.erotica.commercial- 
website.", invalid name (NULL component).
Warning: skipping group "alt.binaries.sounds..mp3.zappa", invalid  
name (NULL component).
Warning: skipping group "alt.chello.binaries.", invalid name (NULL  
component).
Warning: skipping group  
"alt.movies.one.flew.over.the.cuckoos.nest.famous.lines.mr.turkle.oh.shi 
t.the...", invalid name (NULL component).
Warning: skipping group "alt.sex.", invalid name (NULL component).
Warning: skipping group "alt.test.this-is-a-test-for-news-server- 
software-to-see-if-it-has-any-proble...", invalid name (NULL component).
Warning: skipping group  
"alt.there.is.only.one.newgrouper.in.this.town.and.his.name.sure.aint.je 
ffery...", invalid name (NULL component).
Warning: skipping group "req.", invalid name (NULL component).
Warning: skipping group "ural.", invalid name (NULL component).
Warning: skipping group "user..comp.lang.java.programmer", invalid  
name (NULL component).
news.eclipse.co.uk: read 105669 newsgroups
news.eclipse.co.uk: getting newsgroup descriptions
news.eclipse.co.uk: reading newsgroups descriptions failed: 501 no  
such list available
found 0 articles in out.going.
news.eclipse.co.uk: 0 articles posted
news.eclipse.co.uk: alt.autos.citroen: no new articles
news.eclipse.co.uk: alt.photography: no new articles
news.eclipse.co.uk: free.autos.citroen: no new articles
microsoft.public.windowsupdate: considering 2 articles 191653 -  
191654, using XOVER
microsoft.public.windowsupdate: XOVER: 2 seen, 0 I have, 0 filtered,  
2 to get
microsoft.public.windowsupdate: will fetch 2 articles
microsoft.public.windowsupdate: 2 articles fetched (to 2524), 0 killed
news.eclipse.co.uk: microsoft.public.windowsxp: no new articles
microsoft.public.windowsxp.general: considering 3 articles 1625592 -  
1625594, using XOVER
microsoft.public.windowsxp.general: XOVER: 3 seen, 2 I have, 0  
filtered, 1 to get
microsoft.public.windowsxp.general: will fetch 1 articles
microsoft.public.windowsxp.general: 1 articles fetched (to 2817), 0  
killed
news.eclipse.co.uk: uk.adverts.computer: no new articles
news.eclipse.co.uk: uk.comp.homebuilt: no new articles
uk.comp.vendors: considering 1 articles 99647 - 99647, using XOVER
uk.comp.vendors: XOVER: 1 seen, 0 I have, 0 filtered, 1 to get
uk.comp.vendors: will fetch 1 articles
uk.comp.vendors: 1 articles fetched (to 2501), 0 killed
uk.legal.moderated: considering 2 articles 55985 - 55986, using XOVER
uk.legal.moderated: XOVER: 2 seen, 1 I have, 0 filtered, 1 to get
uk.legal.moderated: will fetch 1 articles
uk.legal.moderated: 1 articles fetched (to 2544), 0 killed
news.eclipse.co.uk: uk.rec.cars.maintenance: no new articles
news.eclipse.co.uk: uk.telecom.broadband: no new articles
ERROR: FETCHNEWS MUST REFETCH THE WHOLE ACTIVE FILE NEXT RUN.
REASON: could not successfully talk to all servers.
free.teranews.com: connecting to port nntp
   trying:    address 66.150.105.47 port 119...
   connected: address 66.150.105.47 port 119.
free.teranews.com: connected (200), banner: "200 welcome to  
free.teranews.com NNRP email to  (posting ok)"
check_date: free.teranews.com: clocks of upstream and this computer  
are more than 10 minutes apart. Check your system clock.
free.teranews.com: getting newsgroups list
Warning: skipping group "alt.any-new-2nd-level-group.", invalid name  
(NULL component).
Warning: skipping group "alt..config.tgos.long-winded.stupid.k00k",  
invalid name (NULL component).
Warning: skipping group "alt..config.tgos.long- 
winded.stupid.k00k.ugly.control.freak", invalid name (NULL component).
Warning: skipping group "alt..config.tgos.long- 
winded.stupid.k00k.ugly.control.freak.nazi.and", invalid name (NULL  
component).
Warning: skipping group  
"alt.binaries.meglomaniaci.own.all..binaries.ibm- 
pc.akoolas.own.abwi", invalid name (NULL component).
Warning: skipping group "alt..config.tgos.long-winded.stupid",  
invalid name (NULL component).
Warning: skipping group "alt.binaries.multimedia.erotica.", invalid  
name (NULL component).
Warning: skipping group "alt..config", invalid name (NULL component).
free.teranews.com: read 83949 newsgroups
Newsgroup name conflict: 2a.TEISprint-News vs. 2a.teisprint-news
Newsgroup name conflict, chose 2a.teisprint-news
Newsgroup name conflict: abbotsford.forsale vs. Abbotsford.forsale
Newsgroup name conflict, chose abbotsford.forsale
Newsgroup name conflict: AIDS vs. aids
Newsgroup name conflict, chose aids
Newsgroup name conflict: ALT.BINARIES.MP3.FRENCH vs.  
alt.binaries.mp3.french
Newsgroup name conflict, chose alt.binaries.mp3.french
Newsgroup name conflict: alt.binaries.Oday.games vs.  
alt.binaries.oday.games
Newsgroup name conflict, chose alt.binaries.oday.games
Newsgroup name conflict: alt.binaries.pictures.erotica.teen.female  
vs. Alt.binaries.pictures.erotica.teen.female
Newsgroup name conflict, chose alt.binaries.pictures.erotica.teen.female
Newsgroup name conflict: alt.dumbass.david_rickets vs.  
alt.dumbass.David_RicketsNewsgroup name conflict, chose  
alt.dumbass.david_rickets
Newsgroup name conflict: alt.dumbass.david_rickets vs.  
alt.dumbass.DaviD_RicketsNewsgroup name conflict, chose  
alt.dumbass.david_rickets
Newsgroup name conflict: alt.fan.Flipper-Mike vs. alt.fan.flipper-mike
Newsgroup name conflict, chose alt.fan.flipper-mike
Newsgroup name conflict: alt.men.with.no.sperm-count.steven.l vs.  
alt.men.with.no.sperm-count.Steven.L
Newsgroup name conflict, chose alt.men.with.no.sperm-count.steven.l
Newsgroup name conflict: christian vs. Christian
Newsgroup name conflict, chose christian
Newsgroup name conflict: control.cancel: vs. control.Cancel:
Newsgroup name conflict, chose control.cancel:
Newsgroup name conflict: control.No vs. control.no
Newsgroup name conflict, chose control.no
Newsgroup name conflict: do vs. Do
Newsgroup name conflict, chose do
Newsgroup name conflict: i vs. I
Newsgroup name conflict, chose i
Newsgroup name conflict: l vs. L
Newsgroup name conflict, chose l
Newsgroup name conflict: ping vs. Ping
Newsgroup name conflict, chose ping
Newsgroup name conflict: religion vs. Religion
Newsgroup name conflict, chose religion
Newsgroup name conflict: soc.es.catalan vs. SOC.ES.CATALAN
Newsgroup name conflict, chose soc.es.catalan
Newsgroup name conflict: social.culture.israel vs. Social.culture.Israel
Newsgroup name conflict, chose social.culture.israel
Newsgroup name conflict: yes vs. Yes
Newsgroup name conflict, chose yes
found 0 articles in out.going.
free.teranews.com: 0 articles posted
free.teranews.com: alt.autos.citroen: no new articles
free.teranews.com: alt.photography: no new articles
microsoft.public.windowsupdate: considering 2 articles 99218 - 99219,  
using XOVER
microsoft.public.windowsupdate: XOVER: 2 seen, 2 I have, 0 filtered,  
0 to get
microsoft.public.windowsupdate: all articles already there
microsoft.public.windowsxp.general: considering 1 articles 2001069 -  
2001069, using XOVER
microsoft.public.windowsxp.general: XOVER: 1 seen, 1 I have, 0  
filtered, 0 to get
microsoft.public.windowsxp.general: all articles already there
free.teranews.com: uk.adverts.computer: no new articles
uk.comp.homebuilt: considering 1 articles 209473 - 209473, using XOVER
uk.comp.homebuilt: XOVER: 1 seen, 0 I have, 0 filtered, 1 to get
uk.comp.homebuilt: will fetch 1 articles
uk.comp.homebuilt: 1 articles fetched (to 2707), 0 killed
uk.comp.vendors: considering 1 articles 105160 - 105160, using XOVER
uk.comp.vendors: XOVER: 1 seen, 1 I have, 0 filtered, 0 to get
uk.comp.vendors: all articles already there
uk.legal.moderated: considering 2 articles 62633 - 62634, using XOVER
uk.legal.moderated: XOVER: 2 seen, 1 I have, 0 filtered, 1 to get
uk.legal.moderated: will fetch 1 articles
uk.legal.moderated: 1 articles fetched (to 2545), 0 killed
free.teranews.com: uk.rec.cars.maintenance: no new articles
free.teranews.com: uk.telecom.broadband: no new articles
fetchnews: 7 articles and 0 headers fetched, 0 killed, 0 posted, in  
629 seconds
==22628==
==22628==
==22628== 12 bytes in 1 blocks are still reachable in loss record 1 of 6
==22628==    at 0x401A511: malloc (in /usr/lib/valgrind/x86-linux/ 
vgpreload_memcheck.so)
==22628==    by 0x805A4E1: rbinit (redblack.c:142)
==22628==    by 0x80582D9: initgrouplistdir (miscutil.c:334)
==22628==    by 0x805869C: init_dormant (miscutil.c:462)
==22628==    by 0x805872A: is_dormant (miscutil.c:504)
==22628==    by 0x805B7E9: store_stream (store.c:356)
==22628==    by 0x804A4B4: getarticle (fetchnews.c:419)
==22628==    by 0x804BD94: getgroup (fetchnews.c:1101)
==22628==    by 0x804D8DB: do_server (fetchnews.c:1681)
==22628==    by 0x804E17E: main (fetchnews.c:2181)
==22628==
==22628==
==22628== 156 (36 direct, 120 indirect) bytes in 1 blocks are  
definitely lost in loss record 2 of 6
==22628==    at 0x401A511: malloc (in /usr/lib/valgrind/x86-linux/ 
vgpreload_memcheck.so)
==22628==    by 0x415A296: (within /lib/libc-2.3.6.so)
==22628==    by 0x4159B73: __nss_database_lookup (in /lib/libc-2.3.6.so)
==22628==    by 0x42B91EB: ???
==22628==    by 0x42BA75C: ???
==22628==    by 0x411A19B: getpwnam_r (in /lib/libc-2.3.6.so)
==22628==    by 0x4119C4E: getpwnam (in /lib/libc-2.3.6.so)
==22628==    by 0x805CB50: uid_getbyuname (ugid_ugetbyuname.c:13)
==22628==    by 0x8057D0F: init_post (miscutil.c:162)
==22628==    by 0x804DEF0: main (fetchnews.c:2070)
==22628==
==22628==
==22628== 40 bytes in 5 blocks are indirectly lost in loss record 3 of 6
==22628==    at 0x401A511: malloc (in /usr/lib/valgrind/x86-linux/ 
vgpreload_memcheck.so)
==22628==    by 0x4159EBD: __nss_lookup_function (in /lib/libc-2.3.6.so)
==22628==    by 0x42B920B: ???
==22628==    by 0x42BA75C: ???
==22628==    by 0x411A19B: getpwnam_r (in /lib/libc-2.3.6.so)
==22628==    by 0x4119C4E: getpwnam (in /lib/libc-2.3.6.so)
==22628==    by 0x805CB50: uid_getbyuname (ugid_ugetbyuname.c:13)
==22628==    by 0x8057D0F: init_post (miscutil.c:162)
==22628==    by 0x804DEF0: main (fetchnews.c:2070)
==22628==
==22628==
==22628== 80 bytes in 5 blocks are indirectly lost in loss record 4 of 6
==22628==    at 0x401A511: malloc (in /usr/lib/valgrind/x86-linux/ 
vgpreload_memcheck.so)
==22628==    by 0x4148C10: tsearch (in /lib/libc-2.3.6.so)
==22628==    by 0x4159E7C: __nss_lookup_function (in /lib/libc-2.3.6.so)
==22628==    by 0x42B920B: ???
==22628==    by 0x42BA75C: ???
==22628==    by 0x411A19B: getpwnam_r (in /lib/libc-2.3.6.so)
==22628==    by 0x4119C4E: getpwnam (in /lib/libc-2.3.6.so)
==22628==    by 0x805CB50: uid_getbyuname (ugid_ugetbyuname.c:13)
==22628==    by 0x8057D0F: init_post (miscutil.c:162)
==22628==    by 0x804DEF0: main (fetchnews.c:2070)
==22628==
==22628==
==22628== 530 bytes in 1 blocks are still reachable in loss record 5  
of 6
==22628==    at 0x401BC8F: realloc (in /usr/lib/valgrind/x86-linux/ 
vgpreload_memcheck.so)
==22628==    by 0x805359D: mycritrealloc (critmem_realloc.c:25)
==22628==    by 0x8055560: getline (getline.c:67)
==22628==    by 0x8055161: getaline (getaline.c:45)
==22628==    by 0x805C974: timeout_getaline (timeout_getaline.c:39)
==22628==    by 0x805C9D9: mgetaline (timeout_getaline.c:47)
==22628==    by 0x804B47B: getgroup (fetchnews.c:986)
==22628==    by 0x804D8DB: do_server (fetchnews.c:1681)
==22628==    by 0x804E17E: main (fetchnews.c:2181)
==22628==
==22628==
==22628== 6,310,927 bytes in 124,358 blocks are still reachable in  
loss record 6 of 6
==22628==    at 0x401A511: malloc (in /usr/lib/valgrind/x86-linux/ 
vgpreload_memcheck.so)
==22628==    by 0x8053511: mycritmalloc (critmem_malloc.c:25)
==22628==    by 0x8057901: lookup (midutil.c:31)
==22628==    by 0x8057954: ihave (midutil.c:60)
==22628==    by 0x804B7A2: getgroup (fetchnews.c:963)
==22628==    by 0x804D8DB: do_server (fetchnews.c:1681)
==22628==    by 0x804E17E: main (fetchnews.c:2181)
# updatedb
# locate fetchnews.log
#

I've been getting the "Warning: skipping group "alt.", invalid name  
(NULL component)" and "ERROR: FETCHNEWS MUST REFETCH THE WHOLE ACTIVE  
FILE NEXT RUN." messages for some time, both on this machine & it's  
predecessor and I always figured it was something to do with my ISP's  
server. Is this anything to worry about? I repeated the run using  
three or four servers I found listed at <http://freenews.maxbaud.net/ 
 > and excluding to Eclispe server and didn't see this message, so  
that tends to support this theory. These messages have never bothered  
me because I am happy to be able to read & post news. The second run  
is at <http://linux.stroller.uk.eu.org/fetchnews2.txt.gz>

Thanks for all advices,

Stroller.







More information about the leafnode-list mailing list