Daily Usenet report

Apr 1 15:00:01 -- Apr 6 15:00:01

Unknown entries from news log file:

First 50 / 471 lines (10.6%)

Apr 1 15:01:17 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Apr 1 21:05:43 colo-sc-1 innfeed[1132]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 1 21:05:43 colo-sc-1 innfeed[1132]: SM: storage method 'cnfs' failed initialization
Apr 1 21:05:43 colo-sc-1 innfeed[1132]: SM: one or more storage methods failed initialization
Apr 1 21:05:43 colo-sc-1 innfeed[1132]: Storage manager initialization failed -- it is OK after a change in storage methods
Apr 1 21:05:43 colo-sc-1 innd: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 1 21:05:43 colo-sc-1 innd: SM: storage method 'cnfs' failed initialization
Apr 1 21:05:43 colo-sc-1 innd: SM: one or more storage methods failed initialization
Apr 1 21:25:47 colo-sc-1 nnrpd[8343]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 1 21:25:47 colo-sc-1 nnrpd[8343]: SM: storage method 'cnfs' failed initialization
Apr 1 21:25:47 colo-sc-1 nnrpd[8343]: SM: one or more storage methods failed initialization
Apr 1 21:25:47 colo-sc-1 nnrpd[8343]: can't initialize storage method, one or more storage methods failed initialization
Apr 1 21:25:47 colo-sc-1 nnrpd[8344]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 1 21:25:47 colo-sc-1 nnrpd[8344]: SM: storage method 'cnfs' failed initialization
Apr 1 21:25:47 colo-sc-1 nnrpd[8344]: SM: one or more storage methods failed initialization
Apr 1 21:25:47 colo-sc-1 nnrpd[8344]: can't initialize storage method, one or more storage methods failed initialization
Apr 1 22:02:50 colo-sc-1 nnrpd[21776]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 1 22:02:50 colo-sc-1 nnrpd[21776]: SM: storage method 'cnfs' failed initialization
Apr 1 22:02:50 colo-sc-1 nnrpd[21776]: SM: one or more storage methods failed initialization
Apr 1 22:02:50 colo-sc-1 nnrpd[21776]: can't initialize storage method, one or more storage methods failed initialization
Apr 1 22:02:50 colo-sc-1 nnrpd[21777]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 1 22:02:50 colo-sc-1 nnrpd[21777]: SM: storage method 'cnfs' failed initialization
Apr 1 22:02:50 colo-sc-1 nnrpd[21777]: SM: one or more storage methods failed initialization
Apr 1 22:02:50 colo-sc-1 nnrpd[21777]: can't initialize storage method, one or more storage methods failed initialization
Apr 1 22:02:50 colo-sc-1 nnrpd[21778]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 1 22:02:50 colo-sc-1 nnrpd[21778]: SM: storage method 'cnfs' failed initialization
Apr 1 22:02:50 colo-sc-1 nnrpd[21778]: SM: one or more storage methods failed initialization
Apr 1 22:02:50 colo-sc-1 nnrpd[21778]: can't initialize storage method, one or more storage methods failed initialization
Apr 1 22:46:38 colo-sc-1 nnrpd[6086]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 1 22:46:38 colo-sc-1 nnrpd[6086]: SM: storage method 'cnfs' failed initialization
Apr 1 22:46:38 colo-sc-1 nnrpd[6086]: SM: one or more storage methods failed initialization
Apr 1 22:46:38 colo-sc-1 nnrpd[6086]: can't initialize storage method, one or more storage methods failed initialization
Apr 1 22:46:38 colo-sc-1 nnrpd[6092]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 1 22:46:38 colo-sc-1 nnrpd[6092]: SM: storage method 'cnfs' failed initialization
Apr 1 22:46:38 colo-sc-1 nnrpd[6092]: SM: one or more storage methods failed initialization
Apr 1 22:46:38 colo-sc-1 nnrpd[6092]: can't initialize storage method, one or more storage methods failed initialization
Apr 1 23:53:51 colo-sc-1 nnrpd[30657]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 1 23:53:51 colo-sc-1 nnrpd[30657]: SM: storage method 'cnfs' failed initialization
Apr 1 23:53:51 colo-sc-1 nnrpd[30657]: SM: one or more storage methods failed initialization
Apr 1 23:53:51 colo-sc-1 nnrpd[30657]: can't initialize storage method, one or more storage methods failed initialization
Apr 1 23:53:52 colo-sc-1 nnrpd[30658]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 1 23:53:52 colo-sc-1 nnrpd[30658]: SM: storage method 'cnfs' failed initialization
Apr 1 23:53:52 colo-sc-1 nnrpd[30658]: SM: one or more storage methods failed initialization
Apr 1 23:53:52 colo-sc-1 nnrpd[30658]: can't initialize storage method, one or more storage methods failed initialization
Apr 2 02:23:07 colo-sc-1 nnrpd[22234]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 2 02:23:07 colo-sc-1 nnrpd[22234]: SM: storage method 'cnfs' failed initialization
Apr 2 02:23:07 colo-sc-1 nnrpd[22234]: SM: one or more storage methods failed initialization
Apr 2 02:23:07 colo-sc-1 nnrpd[22234]: can't initialize storage method, one or more storage methods failed initialization
Apr 2 02:32:34 colo-sc-1 nnrpd[25636]: CNFS: bogus cycbuff 'RIGHT' (metacycbuff 'BIG')
Apr 2 02:32:34 colo-sc-1 nnrpd[25636]: SM: storage method 'cnfs' failed initialization

Log entries by program:

Program nameLines%LinesSize%Size
inn 176700 88.1%23.1 MB 88.3%
innd 19278 9.6%2.4 MB 9.3%
cnfsstat 3236 1.6%479.4 KB 1.8%
innfeed 686 0.3%90.1 KB 0.3%
nnrpd 670 0.3%63.6 KB 0.2%
controlchan 15 0.0%2.8 KB 0.0%
rnews 4 0.0%0.6 KB 0.0%
overchan 2 0.0%0.2 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 9 200592 100.0%26.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 4650716 94.2%
Negative hits 142342 2.9%
Cache misses 123786 2.5%
Positive hits 18284 0.4%
TOTAL: 4 4935128 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.026 0.0%304 0.000 6.664 7.052
article cleanup00:00:00.782 0.0%173749 0.000 0.005 0.016
article logging00:00:03.246 0.0%175130 0.006 0.019 0.042
article parse00:00:08.143 0.0%6228507 0.000 0.001 0.004
article write00:00:07.022 0.0%129189 0.013 0.054 0.472
artlog/artcncl00:00:00.001 0.0%250 0.000 0.004 0.004
artlog/artparse00:00:00.003 0.0%116 0.000 0.026 0.333
data move00:00:08.539 0.0%4551824 0.000 0.002 0.012
hisgrep/artcncl00:00:00.002 0.0%75 0.000 0.027 0.032
hishave/artcncl00:00:02.016 0.0%304 0.000 6.632 7.024
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:50.556 0.1%4935164 0.001 0.010 0.073
history sync00:00:00.007 0.0%157 0.000 0.045 0.500
history write00:00:05.908 0.0%173853 0.008 0.034 0.247
hiswrite/artcncl00:00:00.003 0.0%229 0.000 0.013 1.000
idle10:42:07.547 98.7%4011499 1.225 9.604 48.220
nntp read00:00:41.922 0.1%4250884 0.007 0.010 0.012
overview write00:00:00.303 0.0%129189 0.000 0.002 0.017
perl filter00:03:27.669 0.5%173726 0.723 1.195 2.988
python filter00:00:02.944 0.0%173726 0.011 0.017 0.108
site send00:00:07.977 0.0%311955 0.013 0.026 0.068
TOTAL: 10:50:22.34210:47:56.616 99.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.076 0.0%109589 0.000 0.001 0.020
article prepare00:00:00.001 0.0%4956 0.000 0.000 0.015
article read00:00:02.887 0.0%2334 0.000 1.237 281.200
backlog stats00:00:00.050 0.0%166892 0.000 0.000 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.461 0.0%110373 0.000 0.004 0.017
data write00:00:00.804 0.0%71258 0.000 0.011 0.074
idle10:53:22.247100.0%166892 5.075 234.896 8237.260
status file00:00:00.036 0.0%130 0.000 0.277 1.000
TOTAL: 10:53:34.78610:53:26.562100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.000 0.0%0 0.000 0.000 0.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%112 0.000 0.000 0.000
TOTAL: 00:00:00.19000:00:00.000 0.0%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 71
name 2
pause 2
paused 2
reserve 2
TOTAL: 10 91

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feed1.usenet.blueworldhosting.com 1825 4629612 77168 385774513867 1%13:36:02
2hasname-out.news.weretis.net 6 102086 48547 51559 1980 47%18:19:05
3news.nntp4.net 4 59387 3752 50198 5437 6%10:38:35
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 1836 4791085 129467 1403344521284 2%42:33:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed1.usenet.blueworldhosting.com2.0 GB0.0 KB830.3 MB2.8 GB 71%0.6 KB
2hasname-out.news.weretis.net158.5 MB13.8 KB9.3 MB167.8 MB 94%3.4 KB
3news.nntp4.net10.4 MB0.0 KB23.3 MB33.7 MB 30%3.8 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 42.2 GB13.8 KB862.9 MB3.0 GB 72%0.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 1 15:00:01 - 15:59:59 8056 6.2% 2.24224.5 MB 0.0% 63.87
Apr 1 16:00:00 - 16:59:59 6977 5.4% 1.94213.8 MB 0.0% 60.81
Apr 1 17:00:00 - 17:59:59 9379 7.2% 2.61222.9 MB 0.0% 63.40
Apr 1 18:00:00 - 18:59:59 8052 6.2% 2.24202.8 MB 0.0% 57.69
Apr 1 19:00:00 - 19:59:59 4699 3.6% 1.31114.6 MB 0.0% 32.61
Apr 1 20:00:00 - 20:59:59 7146 5.5% 1.99145.8 MB 0.0% 41.48
Apr 1 21:00:00 - 21:59:59 288 0.2% 0.086.5 MB 0.0% 1.85
Apr 1 22:00:00 - 22:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 1 23:00:00 - 23:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 6 00:00:00 - 00:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 6 01:00:00 - 01:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 6 02:00:00 - 02:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 6 03:00:00 - 03:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 6 04:00:00 - 04:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 6 05:00:00 - 05:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 6 06:00:00 - 06:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 6 07:00:00 - 07:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 6 08:00:00 - 08:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 6 09:00:00 - 09:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Apr 6 10:00:00 - 10:59:59 48166 37.1% 13.38156.6 MB 0.0% 44.54
Apr 6 11:00:00 - 11:59:59 492 0.4% 0.141.8 MB 0.0% 0.52
Apr 6 12:00:00 - 12:59:59 21299 16.4% 5.92554.4 MB 0.0% 157.71
Apr 6 13:00:00 - 13:59:59 8122 6.3% 2.26209.3 MB 0.0% 59.52
Apr 6 14:00:00 - 15:00:01 7222 5.6% 2.01182.1 MB 0.0% 51.78
TOTAL: 24:00:00 129898 100.0% 1.500.0 KB 100.0% 0.00
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
EIGHTBIG4.0 GB143.4 KB 0.0% 0 0.00 0.00
FIVEBIG4.0 GB143.4 KB 0.0% 0 0.00 0.00
FOURDEFAULT1024.0 MB196.6 MB 19.2% 14 17.70 0.69
ONEDEFAULT1024.0 MB362.2 MB 35.4% 16 17.75 0.68
SEVENBIG4.0 GB143.4 KB 0.0% 0 0.00 0.00
SIXBIG4.0 GB143.4 KB 0.0% 0 0.00 0.00
THREEDEFAULT1024.0 MB204.1 MB 19.9% 14 17.72 0.68
TWODEFAULT1024.0 MB192.9 MB 18.8% 14 18.01 0.67
TOTAL: 8-20.0 GB956.4 MB 4.7% 58 17.80-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feed1.usenet.blueworldhosting.com 37702 34499 0 0 0 0 0 0 3203
2news.nntp4.net 5496 7 0 0 2 0 0 0 5487
3hasname-out.news.weretis.net 3354 33 0 12 0 11 0 0 3298
TOTAL: 3 46552 34539 0 12 2 11 0 011988

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.encrypted 3637
alt.binaries.ath 968
alt.binaries.newznzb.charlie 922
alt.binaries.newznzb.delta 899
alt.binaries.wtfnzb.echo 879
alt.binaries.font 878
alt.binaries.wtfnzb.charlie 871
alt.binaries.wtfnzb.mike 871
alt.binaries.wtfnzb.delta 866
alt.binaries.wtfnzb.alpha 864
alt.binaries.wtfnzb.juliet 860
alt.binaries.wtfnzb.kilo 858
alt.binaries.u-4all 854
alt.binaries.wtfnzb.hotel 853
alt.binaries.wtfnzb.foxtrot 849
alt.binaries.wtfnzb.golf 845
alt.binaries.wtfnzb.beta 826
alt.binaries.wtfnzb.bravo 823
alt.binaries.wtfnzb.novemeber 821
alt.binaries.flowed 815
TOTAL: 187 34539

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

GroupsCount
bit.listserv.catholic 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 3495
EMP (md5) 2816
Binary: misplaced binary 1907
EMP (phl) 867
Too many newsgroups (low_xpost) 446
Too many newsgroups 327
Scoring filter 185
EMP (phn nph) 176
EMP (fsl) 128
Excessively crossposted test article 45
Too many newsgroups (meow) 45
HTML Multipart 14
Adult group ECP 10
MID-Bot 9
User-issued spam cancel 5
Angle-bracket bot 1
TOTAL: 16 10476

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
feed1.usenet.blueworldhosting.com 1
TOTAL: 1 1
Bad command received
feed1.usenet.blueworldhosting.com 2
TOTAL: 1 2
Including strange strings
hasname-out.news.weretis.net 1355
news.nntp4.net 28
TOTAL: 2 1383
No colon-space in header
feed1.usenet.blueworldhosting.com 128
TOTAL: 1 128
TOTAL: 4 1514

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 1585 1585 0 0 0 978100%09:53:04
2nntp4 59852 712 58654 33 0 37063 1%10:54:20
3weretis 5597 70 4678 12 0 0 1%10:47:28
4blueworldhosting 45028 0 42392 21 0 8241 0%10:54:19
5aioe 0 0 0 0 0 53320 0%10:56:00
TOTAL: 5 112062 2367 105724 66 0 99602 2%53:25:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom8.3 MB0.0 KB8.3 MB0.2 KB/s5.4 KB09:53:04
2nntp42.7 MB68.9 KB2.8 MB0.1 KB/s3.8 KB10:54:20
3weretis292.8 KB37.1 KB329.9 KB0.0 KB/s4.0 KB10:47:28
4blueworldhosting0.0 KB26.6 KB26.6 KB0.0 KB/s1.3 KB10:54:19
5aioe0.0 KB0.0 KB0.0 KB0.0 KB/s010:56:00
TOTAL: 511.3 MB132.6 KB11.5 MB0.1 KB/s4.8 KB53:25:11
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
147.182.202.179 0.003 0.002 0.00000:00:00
? 0.052 0.041 0.00000:00:00
TOTAL: 2 0.055 0.043 0.00000:00:00

NNRP no permission clients:

SystemConn
147.182.202.179 2
TOTAL: 1 2