[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]
[leafnode-list] Caught in the act! A hung fetchnews process...
I hope this is of use. Checking the logs, I've got a couple of days of fetchnews and texpire aborting, and it seems I've got a hung fetchnews process.
Here is the last thing it was doing:
Sep 29 19:07:26 pc69 fetchnews[11885]: msnews.microsoft.com: connecting to port nntp
Sep 29 19:07:42 pc69 fetchnews[11885]: trying: address 207.46.248.16 port 119...
Sep 29 19:07:42 pc69 fetchnews[11885]: connected: address 207.46.248.16 port 119.
Sep 29 19:07:46 pc69 fetchnews[11885]: msnews.microsoft.com: connected (200), banner: "200 NNTP Serv
ice 5.00.0984 Version: 5.0.2195.6702 Posting Allowed "
Sep 29 19:07:55 pc69 fetchnews[11885]: found 0 articles in out.going.
Sep 29 19:07:55 pc69 fetchnews[11885]: msnews.microsoft.com: 0 articles posted
Sep 29 19:07:55 pc69 fetchnews[11885]: msnews.microsoft.com: checking for new newsgroups
Sep 29 19:08:00 pc69 fetchnews[11885]: msnews.microsoft.com: found 0 new newsgroups
Sep 29 19:10:26 pc69 fetchnews[11885]: microsoft.public.vb.com: last seen article was 39389, server
now has 2 - 39386
Sep 29 19:10:26 pc69 fetchnews[11885]: microsoft.public.vb.com: rampant spam cancel? 39388 > 39386
Sep 29 19:10:26 pc69 fetchnews[11885]: microsoft.public.vb.com: considering 6 articles 39381 - 39386
, using XOVER
Sep 29 19:10:31 pc69 fetchnews[11885]: microsoft.public.vb.com: XOVER: 6 seen, 6 I have, 0 filtered,
0 to get
Sep 29 19:10:31 pc69 fetchnews[11885]: microsoft.public.vb.com: all articles already there
Sep 29 19:10:36 pc69 fetchnews[11885]: microsoft.public.vb.database: last seen article was 93856, se
rver now has 2 - 93854
Sep 29 19:10:36 pc69 fetchnews[11885]: microsoft.public.vb.database: rampant spam cancel? 93855 > 93
854
Sep 29 19:10:36 pc69 fetchnews[11885]: microsoft.public.vb.database: considering 6 articles 93849 -
93854, using XOVER
Sep 29 19:10:42 pc69 fetchnews[11885]: microsoft.public.vb.database: XOVER: 6 seen, 6 I have, 0 filt
ered, 0 to get
Sep 29 19:10:42 pc69 fetchnews[11885]: microsoft.public.vb.database: all articles already there
Sep 29 19:10:48 pc69 fetchnews[11885]: microsoft.public.vb.general.discussion: last seen article was
463995, server now has 3 - 463974
Sep 29 19:10:48 pc69 fetchnews[11885]: microsoft.public.vb.general.discussion: switched upstream ser
vers? 463995 > 463974
Sep 29 19:10:48 pc69 fetchnews[11885]: microsoft.public.vb.general.discussion: considering 463972 ar
ticles 3 - 463974, using XOVER
Here is the stack backtrace:
(gdb) backtrace full
#0 0x400e5414 in __libc_read () from /lib/libc.so.6
No locals.
#1 0x401317e0 in ?? () from /lib/libc.so.6
No symbol table info available.
#2 0x4009cd4b in _IO_new_file_underflow (fp=0x81ef100) at fileops.c:385
fp = (_IO_FILE *) 0x81ef100
count = -512
#3 0x4009eddb in _IO_default_uflow (fp=0x81ef100) at genops.c:371
fp = (_IO_FILE *) 0x81ef100
ch = -512
#4 0x4009e145 in __uflow (fp=0x81ef100) at genops.c:328
fp = (_IO_FILE *) 0x81ef100
#5 0x4009b181 in _IO_getc (fp=0x81ef100) at getc.c:39
_buffer = {__routine = 0x4012fee0 <main_arena>, __arg = 0x400a165a,
__canceltype = 1074993120, __prev = 0x81eff58}
_avail = 0
fp = (FILE *) 0x81ef100
result = 134647128
#6 0x80529f4 in _getline (
to=0x8068d58 "453333\tRe: set member variable\t\"martinique\" <bedbugs@xxxxxxxxxxxxxxxxx>\tWed,
6 Aug 2003 14:27:28 +1000\t<#01e5L9WDHA.2284@xxxxxxxxxxxxxxxxxxxx>\t<#NzbLF9WDHA.1268@xxxxxxxxxxxxxx
hx.gbl>\t1610\t36\tXref: TK2"..., size=1023, stream=0x81ef100) at getline.c:40
i = 0
c = -512
#7 0x8052aba in getline (pto=0x80655c8, size=0x80655cc, stream=0x81ef100) at getline.c:69
i = 0
cur = -512
off = 134647128
#8 0x80527ac in getaline (f=0xfffffe00) at getaline.c:45
len = 4096
#9 0x804b339 in fn_doxover (stufftoget=0xbffffc34, first=136249352, last=136249184, filtlst=0x0,
groupname=0x81949f0 "microsoft.public.vb.general.discussion") at fetchnews.c:890
l = 0x81f0008 "èþ\022@èþ\022@\217\001"
count = 0
dupes = 13791
seen = 13791
reply = 224
helpptr = (struct stringlist *) 0x0
delaybody_this_group = 0
#10 0x804ba1c in getgroup (g=0x4022359c, first=3) at fetchnews.c:1154
stufftoget = (struct stringlist *) 0x0
f = (struct filterlist *) 0x0
x = -512
outstanding = 0
last = 463974
delaybody_this_group = 0
tryxhdr = 0
#11 0x804cc27 in processupstream (server=0x4022359c "\aF\001", port=0, forceactive=0)
at fetchnews.c:1708
g = (struct newsgroup *) 0x4022359c
from = 463995
newserver = 1075983772
donethisgroup = 0x4022359c "\aF\001"
f = (struct _IO_FILE *) 0x81ef350
ng = 0x4022359c "\aF\001"
newfile = 0x8067cd0 "/var/spool/news/leaf.node/msnews.microsoft.com~"
oldfile = 0x81ef1b8 "/var/spool/news/leaf.node/msnews.microsoft.com"
r = (struct rblists *) 0x80684d8
upstream = (struct rbtree *) 0x81ef1f0
rc = 0
#12 0x804cf68 in do_server (forceactive=0) at fetchnews.c:1840
e = 0x8068d58 "453333\tRe: set member variable\t\"martinique\" <bedbugs@xxxxxxxxxxxxxxxxx>\t
Wed, 6 Aug 2003 14:27:28 +1000\t<#01e5L9WDHA.2284@xxxxxxxxxxxxxxxxxxxx>\t<#NzbLF9WDHA.1268@TK2MSFTNG
P11.phx.gbl>\t1610\t36\tXref: TK2"...
rc = -1
res = -512
reply = 200
flag = 3
#13 0x804d5ec in main (argc=2, argv=0xbffffd00) at fetchnews.c:2063
reply = -512
t = 0xfffffe00 <Address 0xfffffe00 out of bounds>
conffile = 0xc8 <Address 0xc8 out of bounds>
err = 1
rc = 0
postonly = 0
starttime = 1064862000
myname = "fetchnews"
sa = {__sigaction_handler = {sa_handler = 0x804a144 <sigcatch>,
sa_sigaction = 0x804a144 <sigcatch>}, sa_mask = {__val = {8192, 0 <repeats 31 times>}},
sa_flags = 268435457, sa_restorer = 0xbffffda8}
forceactive = 0
I am running leafnode-2.0.0.alpha20030716a. Apologies that it is not the latest version, but I do hope that this may help to track down this elusive problem.
Regards,
John Carlyle-Clarke
--
leafnode-list@xxxxxxxxxxxxxxxxxxxxxxxxxxxx -- mailing list for leafnode
To unsubscribe, send mail with "unsubscribe" in the subject to the list