Hi, I'm running Nntpcache 3.0.1 on Solaris 2.6. We have about 30 to 50 clients connecting to the nntpcache. It seems that there is a locking problem when multiple clients try to access the same newsgroup. As shown in lsof output 6 processes have opened 2 files named 49152_xover and 48640_xover. I am unable to retreive headers from the newsgroup from a news client. $ lsof | grep media.satelli nntpcache 5515 nntpcach 4uW VREG 32,8 126283 394499 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet/49152_xover nntpcache 5808 nntpcach cwd VDIR 32,8 3072 394497 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet nntpcache 5808 nntpcach 4u VREG 32,8 126283 394499 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet/49152_xover nntpcache 5835 nntpcach cwd VDIR 32,8 3072 394497 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet nntpcache 5835 nntpcach 4uW VREG 32,8 132733 394668 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet/48640_xover nntpcache 5835 nntpcach 6u VREG 32,8 126283 394499 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet/49152_xover nntpcache 5838 nntpcach cwd VDIR 32,8 3072 394497 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet nntpcache 5838 nntpcach 4u VREG 32,8 132733 394668 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet/48640_xover nntpcache 5852 nntpcach cwd VDIR 32,8 3072 394497 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet nntpcache 5852 nntpcach 6u VREG 32,8 132733 394668 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet/48640_xover nntpcache 5854 nntpcach cwd VDIR 32,8 3072 394497 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet nntpcache 5854 nntpcach 4u VREG 32,8 132733 394668 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet/48640_xover nntpcache 5856 nntpcach cwd VDIR 32,8 3072 394497 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet nntpcache 5856 nntpcach 4u VREG 32,8 132733 394668 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet/48640_xover nntpcache 5857 nntpcach cwd VDIR 32,8 3072 394497 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet nntpcache 5857 nntpcach 4u VREG 32,8 132733 394668 /opt/nntpcache/var/nntpcache/ oce.news.eu.uu.net/nl/media/satelliet/48640_xover Is this normal behaviour or is this the sign that nntpcache hangs on this particular newsgroup? This client fails to retreive headers but with nntpcache logging errors. Apr 18 13:49:01 news-ext nntpcache-client[5857]: client task awakening Apr 18 13:49:01 news-ext nntpcache-client[5857]: testsystem.oce.nl connect from unknown@testsystem .oce.nl (134.188.148.90) Apr 18 13:49:01 news-ext nntpcache-client[5857]: testsystem.oce.nl connect Apr 18 13:49:01 news-ext nntpcache-client[5857]: sockets.c:455: <- MODE READER Apr 18 13:49:05 news-ext nntpcache-client[5857]: sockets.c:455: <- GROUP nl.media.satelliet Apr 18 13:49:05 news-ext nntpcache-client[5857]: sockets.c:455: <- ARTICLE 49005 Apr 18 13:49:18 news-ext nntpcache-client[5857]: sockets.c:455: <- GROUP nl.media.satelliet Apr 18 13:49:18 news-ext nntpcache-client[5857]: testsystem.oce.nl group nl.media.satelliet 1 Apr 18 13:49:18 news-ext nntpcache-client[5857]: sockets.c:455: <- XOVER 48660-49659 In other occasions I have seen the following errors; # grep "lient\[217\]" messages Apr 16 18:05:26 news-ext nntpcache-client[217]: client task awakening Apr 16 18:05:26 news-ext nntpcache-client[217]: testsystem.oce.nl connect from unknown@testsystem. oce.nl (134.188.148.90) Apr 16 18:05:26 news-ext nntpcache-client[217]: testsystem.oce.nl connect Apr 16 18:05:26 news-ext nntpcache-client[217]: sockets.c:455: <- MODE READER Apr 16 18:05:26 news-ext nntpcache-client[217]: sockets.c:455: <- GROUP comp.mail.sendmail Apr 16 18:05:27 news-ext nntpcache-client[217]: group.c:130: cwd now oce.news.eu.uu.net/comp/m ail/sendmail Apr 16 18:05:27 news-ext nntpcache-client[217]: sockets.c:173: connected to NNTP server oce.ne ws.eu.uu.net as DEFAULT Apr 16 18:05:27 news-ext nntpcache-client[217]: group.c:229: current newsgroup on server 'oce. news.eu.uu.net' now 'comp.mail.sendmail' Apr 16 18:05:27 news-ext nntpcache-client[217]: sockets.c:455: <- XOVER 160457-161456 Apr 16 18:05:27 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] xover 1 60457-161456 Apr 16 18:07:12 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161454 Apr 16 18:07:12 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161454 Apr 16 18:07:13 news-ext nntpcache-client[217]: article.c:239: adding <a9hh7l$387gv$1@id-99293 .news.dfncis.de>:oce.news.eu.uu.net/comp/mail/sendmail/161454 to cache.history (suceeded) Apr 16 18:07:16 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 160481 Apr 16 18:07:16 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 160481 Apr 16 18:07:16 news-ext nntpcache-client[217]: article.c:239: adding <uamlb8p9f1b0b7@corp.sup ernews.com>:oce.news.eu.uu.net/comp/mail/sendmail/160481 to cache.history (suceeded) Apr 16 18:07:23 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161451 Apr 16 18:07:23 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161451 Apr 16 18:07:24 news-ext nntpcache-client[217]: article.c:239: adding <7qXu8.16805$f5.1129625@ news>:oce.news.eu.uu.net/comp/mail/sendmail/161451 to cache.history (suceeded) Apr 16 18:07:41 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161456 Apr 16 18:07:41 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161456 Apr 16 18:07:42 news-ext nntpcache-client[217]: article.c:239: adding <a9a9bf68.0204160759.6e2 fb713@posting.google.com>:oce.news.eu.uu.net/comp/mail/sendmail/161456 to cache.history (sucee ded) Apr 16 18:07:47 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161438 Apr 16 18:07:47 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161438 Apr 16 18:07:47 news-ext nntpcache-client[217]: article.c:239: adding <3cbc226a.0@news1.mweb.c o.za>:oce.news.eu.uu.net/comp/mail/sendmail/161438 to cache.history (suceeded) Apr 16 18:08:25 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161442 Apr 16 18:08:25 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161442 Apr 16 18:08:25 news-ext nntpcache-client[217]: article.c:239: adding <0204161419001.1274andre as.amann@epost.de>:oce.news.eu.uu.net/comp/mail/sendmail/161442 to cache.history (suceeded) Apr 16 18:08:28 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 160458 Apr 16 18:08:28 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 160458 Apr 16 18:08:28 news-ext nntpcache-client[217]: article.c:239: adding <a8f3ar$1mb$1@husk.cso.n iu.edu>:oce.news.eu.uu.net/comp/mail/sendmail/160458 to cache.history (suceeded) Apr 16 18:08:36 news-ext nntpcache-client[217]: sockets.c:455: <- GROUP comp.mail.sendmail Apr 16 18:08:36 news-ext nntpcache-client[217]: testsystem.oce.nl group comp.mail.sendmail 7 Apr 16 18:08:36 news-ext nntpcache-client[217]: sockets.c:455: <- XOVER 159457-160456 Apr 16 18:08:36 news-ext nntpcache-client[217]: xover.c:711:Deadlock situation detected/avoide d: unable to lockex 'oce.news.eu.uu.net/comp/mail/sendmail/159232_xover' (...unlinking) Apr 16 18:08:36 news-ext nntpcache-client[217]: xover.c:711:Deadlock situation detected/avoide d: unable to lockex 'oce.news.eu.uu.net/comp/mail/sendmail/159232_xover' (...unlinking) Apr 16 18:08:36 news-ext nntpcache-client[217]: xover.c:711:Deadlock situation detected/avoide d: unable to lockex 'oce.news.eu.uu.net/comp/mail/sendmail/159744_xover' (...unlinking) Apr 16 18:08:36 news-ext nntpcache-client[217]: xover.c:711:Deadlock situation detected/avoide d: unable to lockex 'oce.news.eu.uu.net/comp/mail/sendmail/159744_xover' (...unlinking) Apr 16 18:08:36 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] xover 1 59457-160456 Apr 16 18:09:03 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161368 Apr 16 18:09:03 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161368 Apr 16 18:09:03 news-ext nntpcache-client[217]: article.c:239: adding <w4Eu8.1953$ws6.43353@ne ws2.nokia.com>:oce.news.eu.uu.net/comp/mail/sendmail/161368 to cache.history (suceeded) Apr 16 18:09:29 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161395 Apr 16 18:09:29 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161395 Apr 16 18:09:30 news-ext nntpcache-client[217]: article.c:239: adding <3CBB5423.A2F6C7FD@webha rt.net>:oce.news.eu.uu.net/comp/mail/sendmail/161395 to cache.history (suceeded) Apr 16 18:09:45 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161025 Apr 16 18:09:45 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161025 Apr 16 18:09:45 news-ext nntpcache-client[217]: article.c:239: adding <69a0d408.0204101406.100 2a00d@posting.google.com>:oce.news.eu.uu.net/comp/mail/sendmail/161025 to cache.history (sucee ded) Apr 16 18:09:48 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161014 Apr 16 18:09:48 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161014 Apr 16 18:09:48 news-ext nntpcache-client[217]: article.c:239: adding <a9253p$33p$1@news.tpi.p l>:oce.news.eu.uu.net/comp/mail/sendmail/161014 to cache.history (suceeded) Apr 16 18:10:10 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161018 Apr 16 18:10:10 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161018 Apr 16 18:10:10 news-ext nntpcache-client[217]: article.c:239: adding <m3lmbvl26f.fsf@pinky.lo cal>:oce.news.eu.uu.net/comp/mail/sendmail/161018 to cache.history (suceeded) Apr 16 18:11:23 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161046 Apr 16 18:11:23 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161046 Apr 16 18:11:23 news-ext nntpcache-client[217]: article.c:239: adding <z6et8.6$L85.1031@nsw.nn rp.telstra.net>:oce.news.eu.uu.net/comp/mail/sendmail/161046 to cache.history (suceeded) Apr 16 18:11:25 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161044 Apr 16 18:11:25 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161044 Apr 16 18:11:25 news-ext nntpcache-client[217]: article.c:239: adding <vpl39a.994.ln@hubert-a. 2y.net>:oce.news.eu.uu.net/comp/mail/sendmail/161044 to cache.history (suceeded) Apr 16 18:11:26 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161045 Apr 16 18:11:26 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161045 Apr 16 18:11:26 news-ext nntpcache-client[217]: article.c:239: adding <a93njc$he0$1@mserv2.dl. ac.uk>:oce.news.eu.uu.net/comp/mail/sendmail/161045 to cache.history (suceeded) Apr 16 18:11:27 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 161200 Apr 16 18:11:27 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 161200 Apr 16 18:11:27 news-ext nntpcache-client[217]: article.c:239: adding <a98t5o$6r0$1@hedeland.o rg>:oce.news.eu.uu.net/comp/mail/sendmail/161200 to cache.history (suceeded) Apr 16 18:11:30 news-ext nntpcache-client[217]: sockets.c:455: <- GROUP alt.test Apr 16 18:11:30 news-ext nntpcache-client[217]: testsystem.oce.nl group comp.mail.sendmail 9 Apr 16 18:11:30 news-ext nntpcache-client[217]: group.c:130: cwd now oce.news.eu.uu.net/alt/te st Apr 16 18:11:30 news-ext nntpcache-client[217]: group.c:229: current newsgroup on server 'oce. news.eu.uu.net' now 'alt.test' Apr 16 18:11:30 news-ext nntpcache-client[217]: sockets.c:455: <- XOVER 1715461-1715816 Apr 16 18:11:30 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] xover 1 715461-1715816 Apr 16 18:11:35 news-ext nntpcache-client[217]: sockets.c:455: <- GROUP alt.hack.nl Apr 16 18:11:44 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 120055 Apr 16 18:11:44 news-ext nntpcache-client[217]: group.c:229: current newsgroup on server 'oce. news.eu.uu.net' now 'alt.hack.nl' Apr 16 18:11:44 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 120055 Apr 16 18:11:45 news-ext nntpcache-client[217]: article.c:239: adding <a9fknn$67j$1@news1.xs4a ll.nl>:oce.news.eu.uu.net/alt/hack/nl/120055 to cache.history (suceeded) Apr 16 18:11:52 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 120035 Apr 16 18:11:52 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 120035 Apr 16 18:11:52 news-ext nntpcache-client[217]: article.c:239: adding <a9d65b$lei$1@news1.xs4a ll.nl>:oce.news.eu.uu.net/alt/hack/nl/120035 to cache.history (suceeded) Apr 16 18:11:54 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 120038 Apr 16 18:11:54 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 120038 Apr 16 18:11:54 news-ext nntpcache-client[217]: article.c:239: adding <4Nvu8.14849$58.920101@z woll1.home.nl>:oce.news.eu.uu.net/alt/hack/nl/120038 to cache.history (suceeded) Apr 16 18:11:55 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 120054 Apr 16 18:11:55 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 120054 Apr 16 18:11:56 news-ext nntpcache-client[217]: article.c:239: adding <ggIu8.16934$58.1197414@ zwoll1.home.nl>:oce.news.eu.uu.net/alt/hack/nl/120054 to cache.history (suceeded) Apr 16 18:12:05 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 120050 Apr 16 18:12:05 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 120050 Apr 16 18:12:05 news-ext nntpcache-client[217]: article.c:239: adding <a9fcf4$2v8v$1@news.kabe lfoon.nl>:oce.news.eu.uu.net/alt/hack/nl/120050 to cache.history (suceeded) Apr 16 18:12:06 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 120051 Apr 16 18:12:06 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 120051 Apr 16 18:12:07 news-ext nntpcache-client[217]: article.c:239: adding <1018902734.520796@seven .kulnet.kuleuven.ac.be>:oce.news.eu.uu.net/alt/hack/nl/120051 to cache.history (suceeded) Apr 16 18:12:14 news-ext nntpcache-client[217]: sockets.c:455: <- GROUP nl.media.dvd Apr 16 18:12:14 news-ext nntpcache-client[217]: testsystem.oce.nl group alt.hack.nl 6 Apr 16 18:12:14 news-ext nntpcache-client[217]: group.c:130: cwd now oce.news.eu.uu.net/nl/med ia/dvd Apr 16 18:12:14 news-ext nntpcache-client[217]: group.c:229: current newsgroup on server 'oce. news.eu.uu.net' now 'nl.media.dvd' Apr 16 18:12:14 news-ext nntpcache-client[217]: sockets.c:455: <- XOVER 48463-48479 Apr 16 18:12:15 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] xover 4 8463-48479 Apr 16 18:12:20 news-ext nntpcache-client[217]: sockets.c:455: <- GROUP nl.media.dvd Apr 16 18:12:29 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 48476 Apr 16 18:12:29 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 48476 Apr 16 18:12:29 news-ext nntpcache-client[217]: article.c:239: adding <a9hbc4$1v93$1@nl-news.e uro.net>:oce.news.eu.uu.net/nl/media/dvd/48476 to cache.history (suceeded) Apr 16 18:12:30 news-ext nntpcache-client[217]: sockets.c:455: <- ARTICLE 48479 Apr 16 18:12:30 news-ext nntpcache-client[217]: sockets.c:491: => [oce.news.eu.uu.net] ARTICLE 48479 Apr 16 18:12:31 news-ext nntpcache-client[217]: article.c:239: adding <zuXu8.181$E57.5938@cast or.casema.net>:oce.news.eu.uu.net/nl/media/dvd/48479 to cache.history (suceeded) Apr 16 18:35:20 news-ext nntpcache-client[217]: nntpcache.c:1132: client 'unknown@testsystem.oce .nl' diconnected before QUIT Apr 16 18:35:20 news-ext nntpcache-client[217]: testsystem.oce.nl cant read Error 0 Apr 16 18:35:20 news-ext nntpcache-client[217]: client task retiring Apr 16 18:35:20 news-ext nntpcache-client[217]: testsystem.oce.nl group nl.media.dvd 2 Apr 16 18:35:20 news-ext nntpcache-client[217]: testsystem.oce.nl exit articles 24 groups 6 byte s 691461 Apr 16 18:35:20 news-ext nntpcache-client[217]: testsystem.oce.nl times user 0.27 system 0.28 el apsed 1794.00 Apr 16 18:35:20 news-ext nntpcache-client[217]: clean shutdown Two errors can be found here; xover.c:711:Deadlock situation detected/avoided: unable to lockex 'oce.news.eu.uu.net/comp/mail/sendmail/159744_xover' (...unlinking) and testsystem.oce.nl cant read Error 0 Are these warnings related to a locking problem? Should I be worried? Thanks in advance. -- With regards, Marcel Janssen _______________________________________________ NNTPCache-users mailing list NNTPCache-users@nntpcache.org http://www.nntpcache.org/cgi-bin/mailman/listinfo/nntpcache-users
