Daily Usenet report

Sep 30 04:18:09 -- Oct 1 04:40:27

Unknown entries from news log file:

First 21 / 21 lines (100.0%)
Sep 30 19:56:55 elvis innfeed[3588]: CNFS-sm: No magic cookie found for cycbuff BUFNOC, initializing
Sep 30 19:56:55 elvis innfeed[3588]: CNFS-sm: CNFSflushhead: write failed (-1 bytes): Bad file descriptor
Sep 30 19:56:55 elvis innfeed[3588]: SM storage method 'cnfs' failed initialization
Sep 30 19:56:56 elvis innfeed[3588]: SM one or more storage methods failed initialization
Sep 30 19:56:56 elvis innfeed[3588]: Storage manager initialization failed
Sep 30 19:57:11 elvis innd: CNFS-sm: ERROR opening '/usr/local/news/cycbuffs/bufnoc' O_RDONLY : Permission denied
Sep 30 19:57:11 elvis innd: SM storage method 'cnfs' failed initialization
Sep 30 19:57:12 elvis innd: SM one or more storage methods failed initialization
Sep 30 19:58:42 elvis innfeed[6197]: CNFS-sm: No magic cookie found for cycbuff BUFNOC, initializing
Sep 30 19:58:42 elvis innfeed[6197]: CNFS-sm: CNFSflushhead: write failed (-1 bytes): Bad file descriptor
Sep 30 19:58:42 elvis innfeed[6197]: SM storage method 'cnfs' failed initialization
Sep 30 19:58:43 elvis innfeed[6197]: SM one or more storage methods failed initialization
Sep 30 19:58:43 elvis innfeed[6197]: Storage manager initialization failed
Sep 30 19:58:57 elvis innd: CNFS-sm: No magic cookie found for cycbuff BUFNOC, initializing
Sep 30 19:58:59 elvis innd: filter: Restored EMP database.
Sep 30 20:12:13 elvis innd: CNFS-sm: cnfs_retrieve: token @03064255463032390000001BE5540000000F@: bogus cycbuff name: BUF029:0x37caa800:15
Sep 30 23:57:25 elvis innd: too many connections from odn
Sep 30 23:57:25 elvis innd: too many connections from odn
Sep 30 23:58:26 elvis innd: too many connections from odn
Oct 1 01:56:10 elvis batcher[14877]: CNFS-sm: cnfs_retrieve: token @03084255463034310000000A86D600000003@: bogus cycbuff name: BUF041:0x150dac00:3
Oct 1 03:11:58 elvis innd: CNFS-sm: metacycbuff MALT cycbuff is moved to BUF045 remain calm

Log entries by program:

Program nameLines%LinesSize%Size
inn 162158 67.8%18.0 MB 66.1%
innd 65914 27.6%7.2 MB 26.7%
cnfsstat 7062 3.0%1.6 MB 5.7%
nnrpd 1855 0.8%182.6 KB 0.7%
innfeed 1295 0.5%154.4 KB 0.6%
batcher 821 0.3%85.5 KB 0.3%
controlchan 19 0.0%1.4 KB 0.0%
rnews 3 0.0%0.4 KB 0.0%
TOTAL: 8 239127 100.0%27.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 164680 45.2%
Do not exist 163372 44.8%
Positive hits 21267 5.8%
Cache misses 15358 4.2%
TOTAL: 4 364677 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:08.200 0.0%2056 0.000 3.988 144.000
article control00:00:07.214 0.0%1992 0.000 3.621 45.000
article link00:00:00.000 0.0%0 0.000 0.000 0.000
article write00:07:48.629 0.5%111465 0.000 4.204 515.200
history grep00:00:01.623 0.0%558 0.000 2.909 12.000
history lookup00:07:14.596 0.5%364607 0.000 1.192 10.453
history sync00:00:01.176 0.0%16391 0.000 0.072 6.000
history write00:15:05.978 1.0%161265 2.357 5.618 35.308
idle23:04:47.854 94.9%4014361 0.030 20.698131128.000
overview write00:10:40.393 0.7%111465 0.000 5.745 56.000
perl filter00:21:28.347 1.5%161234 2.000 7.991 121.125
site send00:00:29.516 0.0%236152 0.000 0.125 1.250
TOTAL: 24:18:45.07624:07:53.526 99.3%----

Control commands to INND:

CommandNumber
flush 2252
flushlogs 1
paused 2
TOTAL: 3 2255

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
news@news.belwue.de001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1nntp.noris.net 6 60130 37425 5003 17702 62%11:26:22
2newsfeed0.freenet.de 255 19115 12280 5983 852 64%06:34:08
3newsfeed1.freenet.de 249 17700 9381 7783 536 53%06:34:52
4news.nl.linux.org 6 7711 6152 1441 118 79%06:38:48
5news-out.odn.de 34 1123 621 384 118 55%21:33:51
6localhost 1 1 1 0 0 100%00:00:02
7finalfrontier.franken.de 105 0 0 0 0 0%00:00:04
TOTAL: 7 656 105780 65860 20594 19326 62%52:48:07

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 30 19:18:09 - 19:59:59 82 0.1% 0.03222.8 KB 0.0% 0.09
Sep 30 20:00:00 - 20:59:59 19815 17.8% 5.50302.7 MB 8.3% 86.09
Sep 30 21:00:00 - 21:59:59 15546 13.9% 4.32658.0 MB 18.0% 187.18
Sep 30 22:00:00 - 22:59:59 10417 9.3% 2.89486.1 MB 13.3% 138.26
Sep 30 23:00:00 - 23:59:59 14689 13.2% 4.08361.3 MB 9.9% 102.76
Oct 1 00:00:00 - 00:59:59 14434 12.9% 4.01498.2 MB 13.6% 141.70
Oct 1 01:00:00 - 01:59:59 13825 12.4% 3.84375.0 MB 10.2% 106.68
Oct 1 02:00:00 - 02:59:59 12229 11.0% 3.40368.9 MB 10.1% 104.94
Oct 1 03:00:00 - 03:59:59 6770 6.1% 1.88372.3 MB 10.2% 105.90
Oct 1 04:00:00 - 04:40:27 3679 3.3% 1.52239.8 MB 6.5% 101.19
TOTAL: 09:22:18 111486 100.0% 3.303.6 GB 100.0% 111.16

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUF001MDEU1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF002MDEU1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF003MDEU1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF004MDEU1.9 GB1.6 GB 85.7% 0 0.78 29.86
BUF005MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF006MSUP1.9 GB470.0 MB 24.1% 4 0.00 0.00
BUF009MSUP1.9 GB68.8 MB 3.5% 2 2.24 10.35
BUF010MSUP1.9 GB491.5 KB 0.0% 2 0.00 0.00
BUF015MBIN1.9 GB1.0 GB 53.4% 25 57.33 0.40
BUF018MBIN1.9 GB491.5 KB 0.0% 24 0.00 0.00
BUF020MBIN1.9 GB491.5 KB 0.0% 23 0.00 0.00
BUF021MBIN1.9 GB491.5 KB 0.0% 21 0.00 0.00
BUF024MBIN1.9 GB499.3 MB 25.6% 22 0.00 0.00
BUF025MBIN1.9 GB491.5 KB 0.0% 22 0.00 0.00
BUF029MALT1.9 GB900.1 MB 46.1% 14 0.00 0.00
BUF030MALT1.9 GB491.5 KB 0.0% 14 0.00 0.00
BUF032MALT1.9 GB491.5 KB 0.0% 13 0.00 0.00
BUF033MALT1.9 GB491.5 KB 0.0% 13 0.00 0.00
BUF041MALL1.9 GB799.9 MB 41.0% 2 0.00 0.00
BUF042MALT1.9 GB491.5 KB 0.0% 2 0.00 0.00
BUF043MALL1.9 GB108.8 MB 5.6% 2 3.62 6.40
BUF044MBIN1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF045MALT1.9 GB491.5 KB 0.0% 2 75.63 0.31
BUF046MALT1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF047MBIN1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF048MALT1.9 GB426.6 MB 21.8% 1 90.76 0.26
BUF049MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF050MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF051MBIN1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF052MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF053MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF054MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF055MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF056MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF057MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF058MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF062MALL1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF063MALL1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF064MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF065MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF067MALT1.9 GB491.5 KB 0.0% 3 0.00 0.00
BUF070MBIN1.9 GB491.5 KB 0.0% 2 0.00 0.00
BUF078MBIN1.9 GB491.5 KB 0.0% 2 0.00 0.00
BUF081MALT1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF082MALT1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF083MALT1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF084MALT1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF085MBIN1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF086MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF088MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF089MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUFCTLMCTL500.0 MB203.9 MB 40.8% 11 0.00 0.00
BUFNOCMNOC500.0 MB3.1 MB 0.6% 0 0.73 8.12
TOTAL: 53-98.2 GB6.1 GB 6.2% 244 25.83-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.noris.net 48797 1793 0 9 5 0 0 046990
2newsfeed0.freenet.de 1006 23 0 116 3 0 0 0 864
3newsfeed1.freenet.de 627 26 0 99 2 0 0 0 500
4news-out.odn.de 124 0 0 0 0 0 0 0 124
5news.nl.linux.org 118 0 0 105 0 0 0 0 13
TOTAL: 5 50672 1842 0 329 10 0 0 048491

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.sex.pictures.nospam 293
alt.sex.phone.ads 161
alt.sex.telephone.ads 148
alt.sex.erotica.market.place 130
alt.sex.erotica.marketplace 130
alt.sex.femdom 120
alt.sex.telephone 92
alt.binaries.nospam.breasts.natural 67
alt.binaries.pictures.erotica.blondesalt.binaries.pictures.erotica.male 55
alt.penthouse.sex.telephone 50
alt.sex.girls 33
alt.sex.fetish.feet 32
comp.lang.xharbour 27
alt.sex.masterbation 22
alt.sex.marketplace 20
gnu.hurd.bug 19
uk.net.providers.gradwell 19
novell.support.identity-manager.engine-drivers 19
alt.penthouse.sex.wanted 15
novell.support.identity-manager.userapp-workflow 15
TOTAL: 162 1842

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
alt.christnet.religion 4
sci.physics.strings 2
gnu.g++.bug 1
rec.arts.movies.erotica 1
at.anzeigen.arbeitsmarkt 1
rec.crafts.jewelry 1
TOTAL: 6 10

INND perl filter [Top 20]:

ReasonCount
EMP (md5) 25803
EMP (phl) 9663
Binary in non-binary group 5319
Poison newsgroup 3298
EMP (fsl) 2087
Scoring filter (8) 366
Excessively crossposted test article 355
Scoring filter (9) 250
Scoring filter (10) 200
Bad X-Cancelled-By 127
Scoring filter (11) 107
Scoring filter (12) 75
Cancel for rejected article 50
Scoring filter (13) 49
Adult group ECP 49
HTML post 40
Scoring filter (15) 35
Scoring filter (14) 33
Scoring filter (16) 11
Scoring filter (17) 5
TOTAL: 21 47926

INND too many connects per minute:

SystemConn
news-out.odn.de 1354
newsfeed0.freenet.de 59
newsfeed1.freenet.de 56
TOTAL: 3 1469

INND misc events:

EventsCount
gethostbyname error 14
TOTAL: 1 14

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed0.freenet.de 1
newsfeed1.freenet.de 1
TOTAL: 2 2
Huge articles
nntp.noris.net 4
TOTAL: 1 4
Including strange strings
nntp.noris.net 174
newsfeed0.freenet.de 46
newsfeed1.freenet.de 22
news.nl.linux.org 1
TOTAL: 4 243
TOTAL: 3 249

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1newsserver.news.garr.it 276466 321 257788 117 1 6015 0%160:30:39
2news-in.odn.de 4286 182 4104 0 0 0 4%158:50:27
3nntp.noris.net 8091 13 8037 0 0 1009 0%160:53:18
4fu-berlin.de 0 0 0 0 0 0 0%152:56:58
5hammer.uoregon.edu 0 0 0 0 0 404 0%173:34:03
6mail2news 0 0 0 0 0 35017 0%173:33:56
7news.hometree.net 0 0 0 0 0 0 0%173:33:56
8news.nl.linux.org 0 0 0 0 0 0 0%152:56:58
9newsfeed.freenet.de 3444 0 3401 17 0 673 0%157:56:52
TOTAL: 9 292287 516 273330 134 1 43118 0%1464:47:07

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1newsserver.news.garr.it27.5 MB335.7 KB27.8 MB0.0 KB/s65.0 KB160:30:39
2news-in.odn.de498.9 KB0.0 KB498.9 KB0.0 KB/s2.7 KB158:50:27
3nntp.noris.net22.1 KB0.0 KB22.1 KB0.0 KB/s1.7 KB160:53:18
4fu-berlin.de0.0 KB0.0 KB0.0 KB0.0 KB/s0152:56:58
5hammer.uoregon.edu0.0 KB0.0 KB0.0 KB0.0 KB/s0173:34:03
6mail2news0.0 KB0.0 KB0.0 KB0.0 KB/s0173:33:56
7news.hometree.net0.0 KB0.0 KB0.0 KB0.0 KB/s0173:33:56
8news.nl.linux.org0.0 KB0.0 KB0.0 KB0.0 KB/s0152:56:58
9newsfeed.freenet.de0.0 KB35.3 KB35.3 KB0.0 KB/s2.1 KB157:56:52
TOTAL: 928.0 MB371.0 KB28.4 MB0.0 KB/s44.7 KB1464:47:07

UUCP batches created:

ServerOfferedArticlesSizeElapsed
aquanews 36 9692.0 MB00:00:44
billix 6 5601.3 MB00:00:07
chi 9 9922.0 MB00:00:10
classic 2 82197.6 KB00:00:02
crei 38 157307.7 KB00:00:41
deco 1 12.6 KB00:00:00
gjbsd 1 13.6 KB00:00:00
hektor 1 44194.1 KB00:00:01
karnickel 130 1369941.1 MB00:02:02
kaschber 36 2981.1 MB00:00:32
knilch 3 195621.5 KB00:00:03
mbsks 69 231541.6 KB00:00:59
memotech 2 3263.1 KB00:00:01
moldy 2 3790.8 KB00:00:02
polaris 2 2755.7 KB00:00:01
sammy 13 361710.1 MB00:00:31
seefeld 1 121485.8 KB00:00:01
silesia 53 212411.4 MB00:00:53
swzcomm 3 408894.2 KB00:00:03
teebox 26 38059.1 MB00:00:21
tmb 2 2987.1 KB00:00:01
tychen 44 4691.1 MB00:00:47
unicorn 12 190380.4 KB00:00:09
watari 3 305693.3 KB00:00:04
TOTAL: 24 495 2839383.7 MB00:08:27

Rnews articles offered from:

SystemOffered
aquanews 1
TOTAL: 1 1

Rnews connections rejected:

ReasonConn
400 Input/output error writing SMstore file -- throttling 2
TOTAL: 1 2

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1213.185.132.10 57 199408.4 KB 252 0 000:01:52
2dslb-088-065-209-051.pools.arcor-ip.net 3 117312.8 KB 242 0 000:41:06
3r0aee.r.pppool.de 4 85156.0 KB 11 0 000:22:19
4shell.franken.de 1 77142.5 KB 4 0 000:00:09
5finalfrontier.franken.de 105 1323.8 KB 10 0 000:00:26
TOTAL: 5 170 4911.0 MB 519 0 0348428:53:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 57 199408.4 KB 252 0 000:01:52
2*.pools.arcor-ip.net 3 117312.8 KB 242 0 000:41:06
3*.franken.de 106 90166.3 KB 14 0 000:00:35
4*.r.pppool.de 36 85156.0 KB 11 0 000:22:20
5*.83.171.180.48.ip-pool.nefkom.net 4 00.0 KB 0 0 001:54:47
6*.dynamic.mnet-online.de 1 00.0 KB 0 0 000:00:33
7*.cpur.de 2 00.0 KB 0 0 000:00:00
8*.dip0.t-ipconnect.de 1 00.0 KB 0 0 000:00:00
9*.212.114.236.162.ip-pool.nefkom.net 1 00.0 KB 0 0 000:03:41
10*.dip.t-dialin.net 2 00.0 KB 0 0 000:00:51
11*.customers.d1-online.com 4 00.0 KB 0 0 000:00:00
12*.83.171.146.25.ip-pool.nefkom.net 2 00.0 KB 0 0 000:00:00
13*.212.114.231.144.ip-pool.nefkom.net 3 00.0 KB 0 0 000:01:11
TOTAL: 13 222 4911.0 MB 519 0 0348428:53:38

Curious NNRP server explorers [Top 20]:

SystemConn
r2d40.r.pppool.de 7
r2fee.r.pppool.de 7
r2971.r.pppool.de 6
r2074.r.pppool.de 6
r28a6.r.pppool.de 6
dsl01.83.171.180.48.ip-pool.nefkom.net 4
dsl01.212.114.231.144.ip-pool.nefkom.net 3
stargate.cpur.de 2
dsl01.83.171.146.25.ip-pool.nefkom.net 2
p5081d860.dip.t-dialin.net 2
tmo-104-100.customers.d1-online.com 2
tmo-109-93.customers.d1-online.com 1
tmo-104-208.customers.d1-online.com 1
dsl01.212.114.236.162.ip-pool.nefkom.net 1
p54a39553.dip0.t-ipconnect.de 1
ppp-88-217-100-6.dynamic.mnet-online.de 1
TOTAL: 16 52

NNRP gethostbyaddr failures [Top 20]:

SystemConn
213.185.132.10 57
TOTAL: 1 57

Newsgroup request counts (by category):

CategoryCountPct
1de 390 79.4%
2ger 58 11.8%
3rec 43 8.8%
TOTAL: 3 491100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1de.soc.recht.misc 134
2de.etc.sprache.deutsch 66
3ger.ct 58
4de.comm.funk.amateur 50
5rec.games.bridge 23
6rec.sport.soccer 20
7de.rec.motorrad 20
8de.comm.funk.cb 20
9de.alt.netdigest 15
10de.sci.medizin.diabetes 12
11de.admin.net-abuse.mail 12
12de.soc.recht.strafrecht 10
13de.test 9
14de.alt.fan.tabak 8
15de.rec.tv.lindenstrasse 7
16de.comm.provider.misc 4
17de.comm.funk.misc 4
18de.comm.funk.vereine 3
19de.soc.recht.strassenverkehr 3
20de.rec.sport.fussball 3
21de.alt.mud 3
22de.rec.buecher 3
23de.rec.film.misc 2
24de.rec.tiere.aquaristik 2
TOTAL: 24 491

innreport 3.0.2 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>.