Daily Usenet report

Jun 25 06:01:01 -- Jun 26 06:01:01

Unknown entries from news log file:

First 50 / 181 lines (27.6%)

Jun 25 06:02:16 kennel innd: message repeated 2 times: [ ctlinnd command s]
Jun 25 20:00:04 kennel pgpverify[469606]: pgpverify: verification failed
Jun 25 20:00:09 kennel pgpverify[469712]: pgpverify: verification failed
Jun 25 20:01:10 kennel pgpverify[470274]: pgpverify: verification failed
Jun 25 20:01:14 kennel pgpverify[470302]: pgpverify: verification failed
Jun 25 20:02:15 kennel pgpverify[470829]: pgpverify: verification failed
Jun 25 20:02:16 kennel pgpverify[470838]: pgpverify: verification failed
Jun 25 20:03:17 kennel pgpverify[471140]: pgpverify: verification failed
Jun 25 20:03:18 kennel pgpverify[471148]: pgpverify: verification failed
Jun 25 20:04:19 kennel pgpverify[471527]: pgpverify: verification failed
Jun 25 20:04:20 kennel pgpverify[471535]: pgpverify: verification failed
Jun 25 20:05:21 kennel pgpverify[471858]: pgpverify: verification failed
Jun 25 20:05:22 kennel pgpverify[471866]: pgpverify: verification failed
Jun 25 20:06:23 kennel pgpverify[472253]: pgpverify: verification failed
Jun 25 20:06:24 kennel pgpverify[472261]: pgpverify: verification failed
Jun 25 20:07:25 kennel pgpverify[472560]: pgpverify: verification failed
Jun 25 20:07:26 kennel pgpverify[472568]: pgpverify: verification failed
Jun 25 20:08:27 kennel pgpverify[472943]: pgpverify: verification failed
Jun 25 20:08:29 kennel pgpverify[472952]: pgpverify: verification failed
Jun 25 20:09:29 kennel pgpverify[473339]: pgpverify: verification failed
Jun 25 20:09:32 kennel pgpverify[473347]: pgpverify: verification failed
Jun 25 20:10:32 kennel pgpverify[473741]: pgpverify: verification failed
Jun 25 20:10:34 kennel pgpverify[473753]: pgpverify: verification failed
Jun 25 20:11:35 kennel pgpverify[474073]: pgpverify: verification failed
Jun 25 20:11:36 kennel pgpverify[474083]: pgpverify: verification failed
Jun 25 20:12:37 kennel pgpverify[474592]: pgpverify: verification failed
Jun 25 20:12:38 kennel pgpverify[474716]: pgpverify: verification failed
Jun 25 20:13:38 kennel pgpverify[475015]: pgpverify: verification failed
Jun 25 20:13:40 kennel pgpverify[475023]: pgpverify: verification failed
Jun 25 20:14:40 kennel pgpverify[475400]: pgpverify: verification failed
Jun 25 20:14:42 kennel pgpverify[475408]: pgpverify: verification failed
Jun 25 20:15:43 kennel pgpverify[475968]: pgpverify: verification failed
Jun 25 20:15:44 kennel pgpverify[475999]: pgpverify: verification failed
Jun 25 20:16:45 kennel pgpverify[476370]: pgpverify: verification failed
Jun 25 20:16:46 kennel pgpverify[476379]: pgpverify: verification failed
Jun 25 20:17:47 kennel pgpverify[476680]: pgpverify: verification failed
Jun 25 20:17:48 kennel pgpverify[476688]: pgpverify: verification failed
Jun 25 20:18:49 kennel pgpverify[477053]: pgpverify: verification failed
Jun 25 20:18:51 kennel pgpverify[477061]: pgpverify: verification failed
Jun 25 20:19:51 kennel pgpverify[477362]: pgpverify: verification failed
Jun 25 20:19:53 kennel pgpverify[477372]: pgpverify: verification failed
Jun 25 20:20:54 kennel pgpverify[477755]: pgpverify: verification failed
Jun 25 20:20:56 kennel pgpverify[477765]: pgpverify: verification failed
Jun 25 20:21:56 kennel pgpverify[478071]: pgpverify: verification failed
Jun 25 20:21:58 kennel pgpverify[478079]: pgpverify: verification failed
Jun 25 20:22:58 kennel pgpverify[478590]: pgpverify: verification failed
Jun 25 20:23:00 kennel pgpverify[478598]: pgpverify: verification failed
Jun 25 20:24:01 kennel pgpverify[478934]: pgpverify: verification failed
Jun 25 20:24:03 kennel pgpverify[479014]: pgpverify: verification failed
Jun 25 20:25:04 kennel pgpverify[479330]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 569236 98.1%70.1 MB 97.7%
innd 9008 1.6%1.4 MB 1.9%
innfeed 1460 0.3%209.7 KB 0.3%
controlchan 181 0.0%12.9 KB 0.0%
pgpverify 180 0.0%26.9 KB 0.0%
cnfsstat 144 0.0%31.2 KB 0.0%
nnrpd 23 0.0%2.5 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 8 580233 100.0%71.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 859376 43.4%
Do not exist 555117 28.0%
Positive hits 554335 28.0%
Cache misses 13134 0.7%
TOTAL: 4 1981962 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.004 0.0%53 0.000 0.075 1.000
article cleanup00:00:06.422 0.0%565016 0.004 0.011 0.017
article logging00:00:22.316 0.0%565125 0.017 0.039 0.054
article parse00:00:36.627 0.0%1719165 0.006 0.021 0.026
article write00:00:41.818 0.0%450616 0.070 0.093 0.125
artlog/artparse00:00:00.029 0.0%631 0.000 0.046 1.000
data move00:00:12.548 0.0%1855942 0.001 0.007 0.014
hisgrep/artcncl00:00:00.000 0.0%53 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:24.878 0.0%1984266 0.003 0.013 0.639
history sync00:00:00.027 0.0%305 0.000 0.089 0.500
history write00:00:33.611 0.0%554779 0.043 0.061 0.077
idle23:43:06.569 99.5%1382745 34.867 61.751 120.662
nntp read00:01:01.860 0.1%1384803 0.020 0.045 0.058
overview write00:00:02.382 0.0%450616 0.002 0.005 0.009
perl filter00:00:29.573 0.0%554154 0.019 0.053 0.066
python filter00:00:28.994 0.0%554154 0.023 0.052 0.073
site send00:00:17.251 0.0%1018178 0.013 0.017 0.157
TOTAL: 23:50:26.81423:48:24.909 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.376 0.0%117037 0.000 0.003 0.011
article prepare00:00:00.000 0.0%938 0.000 0.000 0.000
article read00:00:00.044 0.0%460 0.000 0.096 1.000
backlog stats00:00:00.338 0.0%345855 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.732 0.0%221708 0.009 0.026 0.047
data write00:00:04.624 0.0%132992 0.013 0.035 0.092
idle23:55:37.458100.0%345855 45.215 249.057 1586.013
status file00:00:00.172 0.0%283 0.000 0.608 1.000
TOTAL: 23:55:59.79923:55:48.744100.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.001 0.1%5 0.000 0.200 1.000
TOTAL: 00:00:01.06700:00:00.001 0.1%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org00018000
TOTAL00018000

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.feeder.erje.net 577 1099117 445450 538707 114960 40%49:38:18
2hasname-out.news.weretis.net 2 13132 5368 7679 85 40%48:43:04
3usenet.blueworldhosting.com 720 9035 2025 6603 407 22%23:42:14
4news.nntp4.net 1 9287 645 8290 352 6%23:59:56
5localhost 1 0 0 0 0 0%00:00:00
TOTAL: 5 1301 1130571 453488 561279 115804 40%146:03:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.feeder.erje.net4.7 GB123.3 MB1.1 GB5.9 GB 79%11.0 KB
2hasname-out.news.weretis.net14.7 MB15.0 KB152.0 KB14.8 MB 98%2.8 KB
3usenet.blueworldhosting.com4.2 MB0.0 KB2.4 MB6.6 MB 63%2.8 KB
4news.nntp4.net2.7 MB4.5 KB3.1 MB5.8 MB 46%5.9 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 54.7 GB123.3 MB1.1 GB5.9 GB 79%10.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 25 06:01:01 - 06:59:59 14857 3.3% 4.20169.5 MB 3.5% 49.05
Jun 25 07:00:00 - 07:59:59 17886 3.9% 4.97195.0 MB 4.0% 55.47
Jun 25 08:00:00 - 08:59:59 18021 4.0% 5.01203.1 MB 4.2% 57.76
Jun 25 09:00:00 - 09:59:59 20536 4.5% 5.70228.6 MB 4.7% 65.03
Jun 25 10:00:00 - 10:59:59 22313 4.9% 6.20264.6 MB 5.5% 75.27
Jun 25 11:00:00 - 11:59:59 21386 4.7% 5.94222.4 MB 4.6% 63.26
Jun 25 12:00:00 - 12:59:59 16521 3.6% 4.59189.1 MB 3.9% 53.80
Jun 25 13:00:00 - 13:59:59 19113 4.2% 5.31207.2 MB 4.3% 58.95
Jun 25 14:00:00 - 14:59:59 16695 3.7% 4.64189.1 MB 3.9% 53.80
Jun 25 15:00:00 - 15:59:59 24375 5.4% 6.77271.7 MB 5.6% 77.27
Jun 25 16:00:00 - 16:59:59 23589 5.2% 6.55243.6 MB 5.1% 69.30
Jun 25 17:00:00 - 17:59:59 22470 5.0% 6.24233.2 MB 4.8% 66.35
Jun 25 18:00:00 - 18:59:59 23112 5.1% 6.42221.4 MB 4.6% 62.97
Jun 25 19:00:00 - 19:59:59 22508 5.0% 6.25241.1 MB 5.0% 68.58
Jun 25 20:00:00 - 20:59:59 24422 5.4% 6.78253.0 MB 5.3% 71.95
Jun 25 21:00:00 - 21:59:59 17096 3.8% 4.75161.4 MB 3.4% 45.91
Jun 25 22:00:00 - 22:59:59 13013 2.9% 3.61135.2 MB 2.8% 38.44
Jun 25 23:00:00 - 23:59:59 21898 4.8% 6.08201.2 MB 4.2% 57.23
Jun 26 00:00:00 - 00:59:59 15366 3.4% 4.27147.9 MB 3.1% 42.08
Jun 26 01:00:00 - 01:59:59 14396 3.2% 4.00138.4 MB 2.9% 39.38
Jun 26 02:00:00 - 02:59:59 13688 3.0% 3.80140.7 MB 2.9% 40.02
Jun 26 03:00:00 - 03:59:59 13542 3.0% 3.76151.5 MB 3.1% 43.10
Jun 26 04:00:00 - 04:59:59 19177 4.2% 5.33221.8 MB 4.6% 63.10
Jun 26 05:00:00 - 05:59:59 17213 3.8% 4.78185.6 MB 3.9% 52.79
Jun 26 06:00:00 - 06:01:01 140 0.0% 2.301.2 MB 0.0% 20.91
TOTAL: 24:00:00 453333 100.0% 5.254.7 GB 100.0% 57.10
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
C1DEFAULT10.0 GB1.2 GB 12.2% 51 68.01 1.78
TOTAL: 1-10.0 GB1.2 GB 12.2% 51 68.01-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.feeder.erje.net115013103363 0 10962 2 0 0 0 686
2usenet.blueworldhosting.com 421 407 0 0 0 0 0 0 14
3news.nntp4.net 371 329 0 3 0 0 0 0 39
4hasname-out.news.weretis.net 98 81 0 5 0 0 0 0 12
TOTAL: 4115903104180 0 10970 2 0 0 0 751

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.friends 44430
alt.binaries.font 8025
alt.binaries.encrypted 2527
alt.binaries.fta 2397
alt.binaries.ath 1747
alt.binaries.pwp 1472
alt.binaries.hunters 1222
alt.binaries.cats 1210
alt.binaries.wtfnzb.alpha 1068
alt.binaries.wtfnzb.bravo 1058
alt.binaries.wtfnzb.beta 1056
alt.binaries.wtfnzb.golf 1046
alt.binaries.wtfnzb.novemeber 1040
alt.binaries.wtfnzb.echo 1038
alt.binaries.wtfnzb.mike 1029
alt.binaries.wtfnzb.delta 1022
alt.binaries.wtfnzb.india 1020
alt.binaries.wtfnzb.hotel 1015
alt.binaries.wtfnzb.lima 1005
alt.binaries.wtfnzb.charlie 1004
TOTAL: 372 104180

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

GroupsCount
alt.binaries.whitburn 2
TOTAL: 1 2

INND no permission servers:

SystemConn
103.193.138.76 30
199.45.154.136 2
167.94.138.43 1
185.247.137.239 1
79.124.49.218 1
87.236.176.243 1
TOTAL: 6 36

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.feeder.erje.net 46
news.nntp4.net 39
usenet.blueworldhosting.com 14
hasname-out.news.weretis.net 12
TOTAL: 4 111
No colon-space in header field
hasname-out.feeder.erje.net 640
TOTAL: 1 640
TOTAL: 2 751

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 331 331 0 0 0 0100%20:29:01
2erje 7350 69 7248 8 0 32 0%23:59:54
3blueworldhosting 115160 27 114580 2 0 89 0%23:59:54
4nntp4 7526 11 7507 0 0 41 0%23:59:52
5weretis 2676 2 2635 33 0 0 0%23:59:54
TOTAL: 5 133043 440 131970 43 0 162 0%116:28:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.0 MB0.0 KB1.0 MB0.0 KB/s3.2 KB20:29:01
2blueworldhosting258.8 KB26.6 KB285.4 KB0.0 KB/s9.8 KB23:59:54
3erje108.7 KB153.7 KB262.4 KB0.0 KB/s3.4 KB23:59:54
4nntp418.7 KB0.0 KB18.7 KB0.0 KB/s1.7 KB23:59:52
5weretis2.6 KB555.5 KB558.1 KB0.0 KB/s15.9 KB23:59:54
TOTAL: 51.4 MB735.8 KB2.1 MB0.0 KB/s4.5 KB116:28:35
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
194.165.16.162 0.001 0.003 0.00000:00:00
194.165.16.167 0.003 0.001 0.00000:00:00
167.94.138.35 0.000 0.005 0.00000:00:00
azpdcgtqqxu4.stretchoid.com 0.000 0.004 0.00000:00:00
azpdssrvaql5.stretchoid.com 0.002 0.002 0.00000:00:00
TOTAL: 5 0.006 0.015 0.00000:00:01

NNRP no permission clients [Top 20]:

SystemConn
167.94.138.35 1
194.165.16.162 1
194.165.16.167 1
azpdcgtqqxu4.stretchoid.com 1
azpdssrvaql5.stretchoid.com 1
TOTAL: 5 5
innreport from INN 2.7.2 based on initial work (©) 1996-2001 by Fabien Tassin <fta@sofaraway.org> and enhanced by several contributors since then