Daily Usenet report

Aug 31 06:01:01 -- Sep 1 06:01:01

Unknown entries from news log file:

First 50 / 105 lines (47.6%)

Aug 31 06:01:58 kennel innd: message repeated 2 times: [ ctlinnd command s]
Aug 31 21:16:10 kennel innd: message repeated 3 times: [ 24.182.239.66 rejected 502]
Aug 31 21:17:03 kennel innd: message repeated 4 times: [ 24.182.239.66 rejected 502]
Aug 31 21:18:17 kennel innd: message repeated 5 times: [ 24.182.239.66 rejected 502]
Aug 31 21:19:13 kennel innd: message repeated 6 times: [ 24.182.239.66 rejected 502]
Aug 31 21:21:05 kennel innd: message repeated 8 times: [ 24.182.239.66 rejected 502]
Aug 31 21:22:09 kennel innd: message repeated 7 times: [ 24.182.239.66 rejected 502]
Aug 31 21:23:09 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:24:02 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:25:02 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:27:12 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:28:14 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:29:07 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:30:05 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:31:02 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:32:08 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:33:03 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:34:08 kennel innd: message repeated 4 times: [ 24.182.239.66 rejected 502]
Aug 31 21:34:16 kennel innd: message repeated 4 times: [ 24.182.239.66 rejected 502]
Aug 31 21:35:18 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:36:07 kennel innd: message repeated 8 times: [ 24.182.239.66 rejected 502]
Aug 31 21:37:09 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:38:07 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:39:03 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:40:02 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:41:10 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:42:06 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:43:06 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:45:07 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:46:02 kennel innd: message repeated 8 times: [ 24.182.239.66 rejected 502]
Aug 31 21:47:02 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:48:02 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:49:27 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:52:04 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:53:07 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:54:09 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:55:10 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:58:09 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 21:59:09 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 22:00:09 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 22:01:11 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 22:04:08 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 22:05:04 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 22:06:03 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 22:07:03 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 22:08:09 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 22:09:10 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Aug 31 22:10:09 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Sep 1 00:04:02 kennel pgpverify[2977125]: pgpverify: verification failed
Sep 1 00:15:10 kennel innd: message repeated 2 times: [ 24.182.239.66 rejected 502]

Log entries by program:

Program nameLines%LinesSize%Size
inn 374367 96.8%47.1 MB 96.4%
innd 10786 2.8%1.5 MB 3.1%
innfeed 1449 0.4%198.0 KB 0.4%
cnfsstat 144 0.0%17.2 KB 0.0%
nnrpd 108 0.0%10.7 KB 0.0%
controlchan 33 0.0%7.6 KB 0.0%
overchan 2 0.0%0.1 KB 0.0%
pgpverify 2 0.0%0.3 KB 0.0%
TOTAL: 8 386891 100.0%48.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 611669 45.0%
Positive hits 376029 27.7%
Do not exist 364689 26.8%
Cache misses 6781 0.5%
TOTAL: 4 1359168 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.004 0.0%43 0.000 0.093 1.000
article cleanup00:00:04.437 0.0%373032 0.005 0.012 0.021
article logging00:00:16.065 0.0%373200 0.022 0.043 0.058
article parse00:00:24.895 0.0%1173230 0.009 0.021 0.026
article write00:00:24.064 0.0%255521 0.031 0.094 0.131
artlog/artparse00:00:00.076 0.0%1648 0.000 0.046 1.000
data move00:00:10.892 0.0%1298448 0.001 0.008 0.016
hisgrep/artcncl00:00:00.000 0.0%43 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:29.304 0.0%1366190 0.002 0.021 0.480
history sync00:00:00.017 0.0%315 0.000 0.054 0.500
history write00:00:23.147 0.0%366000 0.036 0.063 0.103
idle23:49:38.218 99.2%1012286 26.191 84.737 226.789
nntp read00:00:44.962 0.1%1011350 0.022 0.044 0.063
overview write00:00:01.507 0.0%255521 0.001 0.006 0.011
perl filter00:00:20.424 0.0%364392 0.034 0.056 0.080
python filter00:00:20.088 0.0%364392 0.023 0.055 0.074
site send00:00:10.327 0.0%605729 0.011 0.017 0.119
TOTAL: 24:00:26.96123:53:28.427 99.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.334 0.0%108701 0.000 0.003 0.020
article prepare00:00:00.003 0.0%4013 0.000 0.001 0.500
article read00:00:00.143 0.0%1240 0.000 0.115 1.000
backlog stats00:00:00.269 0.0%256531 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:04.264 0.0%168007 0.005 0.025 0.085
data write00:00:03.298 0.0%98903 0.012 0.033 0.085
idle23:57:03.727100.0%256531 46.763 336.114 2031.098
status file00:00:00.304 0.0%284 0.000 1.070 33.000
TOTAL: 23:57:22.58923:57:12.342100.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%22 0.000 0.000 0.000
TOTAL: 00:01:32.26800:00:00.000 0.0%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reload 48
reserve 2
TOTAL: 11 215

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
moderator@dana.de001101
us-control@lists.killfile.org000100
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.feeder.erje.net 576 720712 247777 354183 118752 34%48:20:05
2hasname-out.news.weretis.net 6 13183 5282 7837 64 40%47:06:08
3news.nntp4.net 2 8184 1548 6568 68 18%24:09:01
4usenet.blueworldhosting.com 1331 7550 534 6960 56 7%21:46:34
524.182.239.66 0 5 0 5 0 0%00:01:40
6localhost 1 0 0 0 0 0%00:00:00
TOTAL: 6 1916 749634 255141 375553 118940 34%141:23:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.feeder.erje.net2.8 GB98.5 MB1.1 GB4.0 GB 69%11.4 KB
2news.nntp4.net26.3 MB15.6 KB380.2 KB26.7 MB 98%16.9 KB
3hasname-out.news.weretis.net20.5 MB0.0 KB127.0 KB20.6 MB 99%3.9 KB
4usenet.blueworldhosting.com1.4 MB34.9 KB227.6 KB1.7 MB 84%2.9 KB
524.182.239.660.0 KB0.0 KB0.0 KB0.0 KB 0%0
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 62.8 GB98.6 MB1.1 GB4.0 GB 69%11.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 31 06:01:01 - 06:59:59 10456 4.1% 2.95126.5 MB 4.4% 36.61
Aug 31 07:00:00 - 07:59:59 10553 4.1% 2.93124.9 MB 4.3% 35.54
Aug 31 08:00:00 - 08:59:59 7713 3.0% 2.14115.6 MB 4.0% 32.87
Aug 31 09:00:00 - 09:59:59 12693 5.0% 3.53175.4 MB 6.1% 49.89
Aug 31 10:00:00 - 10:59:59 11769 4.6% 3.27135.4 MB 4.7% 38.50
Aug 31 11:00:00 - 11:59:59 11917 4.7% 3.31124.9 MB 4.3% 35.52
Aug 31 12:00:00 - 12:59:59 12949 5.1% 3.60158.8 MB 5.5% 45.16
Aug 31 13:00:00 - 13:59:59 32329 12.7% 8.98235.4 MB 8.1% 66.97
Aug 31 14:00:00 - 14:59:59 9098 3.6% 2.53102.7 MB 3.6% 29.22
Aug 31 15:00:00 - 15:59:59 12114 4.7% 3.37125.2 MB 4.3% 35.61
Aug 31 16:00:00 - 16:59:59 10155 4.0% 2.82114.3 MB 4.0% 32.51
Aug 31 17:00:00 - 17:59:59 10968 4.3% 3.05127.4 MB 4.4% 36.25
Aug 31 18:00:00 - 18:59:59 11854 4.6% 3.29144.2 MB 5.0% 41.01
Aug 31 19:00:00 - 19:59:59 12370 4.8% 3.44145.3 MB 5.0% 41.32
Aug 31 20:00:00 - 20:59:59 9410 3.7% 2.61100.9 MB 3.5% 28.69
Aug 31 21:00:00 - 21:59:59 10158 4.0% 2.82103.0 MB 3.6% 29.30
Aug 31 22:00:00 - 22:59:59 8760 3.4% 2.43113.6 MB 3.9% 32.31
Aug 31 23:00:00 - 23:59:59 9354 3.7% 2.60129.7 MB 4.5% 36.88
Sep 1 00:00:00 - 00:59:59 6845 2.7% 1.9083.4 MB 2.9% 23.72
Sep 1 01:00:00 - 01:59:59 8768 3.4% 2.44120.8 MB 4.2% 34.36
Sep 1 02:00:00 - 02:59:59 6128 2.4% 1.7073.3 MB 2.5% 20.85
Sep 1 03:00:00 - 03:59:59 5750 2.3% 1.6063.6 MB 2.2% 18.09
Sep 1 04:00:00 - 04:59:59 6180 2.4% 1.7274.1 MB 2.6% 21.09
Sep 1 05:00:00 - 05:59:59 6761 2.6% 1.8871.3 MB 2.5% 20.29
Sep 1 06:00:00 - 06:01:01 142 0.1% 2.332.1 MB 0.1% 35.07
TOTAL: 24:00:00 255194 100.0% 2.952.8 GB 100.0% 34.27
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
C1DEFAULT10.0 GB2.7 GB 27.1% 76 40.20 3.02
TOTAL: 1-10.0 GB2.7 GB 27.1% 76 40.20-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.feeder.erje.net118910108385 0 8629 148 0 0 0 1748
2news.nntp4.net 122 68 0 1 0 0 0 0 53
3hasname-out.news.weretis.net 82 70 0 0 0 0 0 0 12
4usenet.blueworldhosting.com 59 53 0 3 0 0 0 0 3
TOTAL: 4119173108576 0 8633 148 0 0 0 1816

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.friends 48990
alt.binaries.encrypted 4405
alt.binaries.pwp 3753
alt.binaries.pictures.purebeauty 2274
alt.binaries.fta 2220
alt.binaries.encryptnzb.charlie 1268
alt.binaries.encryptnzb.india 1222
alt.binaries.encryptnzb.hotel 1216
alt.binaries.encryptnzb.bravo 1207
alt.binaries.encryptnzb.novemeber 1204
alt.binaries.encryptnzb.echo 1203
alt.binaries.encryptnzb.juliet 1203
alt.binaries.encryptnzb.alpha 1195
alt.binaries.encryptnzb.lima 1180
alt.binaries.encryptnzb.delta 1168
alt.binaries.encryptnzb.mike 1166
alt.binaries.encryptnzb.beta 1155
alt.binaries.encryptnzb.kilo 1151
alt.binaries.erotica.sheep 1141
alt.binaries.encryptnzb.foxtrot 1139
TOTAL: 204 108576

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

GroupsCount
alt.binaries.whitburn 148
TOTAL: 1 148

INND no permission servers:

SystemConn
24.182.239.66 124
103.193.138.76 30
162.142.125.196 1
TOTAL: 3 155

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
usenet.blueworldhosting.com 4
hasname-out.feeder.erje.net 4
TOTAL: 2 8
Including strange strings
hasname-out.feeder.erje.net 100
news.nntp4.net 53
hasname-out.news.weretis.net 12
usenet.blueworldhosting.com 3
TOTAL: 4 168
No colon-space in header field
hasname-out.feeder.erje.net 1644
TOTAL: 1 1644
TOTAL: 3 1820

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 318 318 0 0 0 0100%19:45:04
2blueworldhosting 96074 190 93590 2 0 14092 0%23:59:54
3erje 6836 1 6728 10 0 41 0%23:59:34
4nntp4 6638 1 6636 0 0 7 0%23:59:30
5weretis 2705 0 1978 720 0 0 0%23:48:00
TOTAL: 5 112571 510 108932 732 0 14140 0%115:32:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1blueworldhosting1.8 MB27.7 KB1.8 MB0.0 KB/s9.5 KB23:59:54
2bbsgslincom1.1 MB0.0 KB1.1 MB0.0 KB/s3.4 KB19:45:04
3erje1.4 KB135.8 KB137.2 KB0.0 KB/s12.5 KB23:59:34
4nntp41.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:59:30
5weretis0.0 KB19.9 MB19.9 MB0.2 KB/s28.3 KB23:48:00
TOTAL: 52.8 MB20.1 MB22.9 MB0.1 KB/s18.9 KB115:32:02
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
164.52.24.190 0.008 0.018 0.00000:01:23
91.238.181.96 0.002 0.002 0.00000:00:06
165.154.253.251 0.001 0.004 0.00000:00:01
199.45.155.88 0.002 0.010 0.00000:00:00
167.94.145.111 0.007 0.003 0.00000:00:00
167.94.146.63 0.002 0.006 0.00000:00:00
162.142.125.215 0.002 0.003 0.00000:00:00
azpdes8idctp.stretchoid.com 0.002 0.006 0.00000:00:00
205.210.31.227 0.001 0.002 0.00000:00:00
205.210.31.70 0.001 0.003 0.00000:00:00
TOTAL: 10 0.028 0.057 0.00000:01:32

NNRP no permission clients [Top 20]:

SystemConn
164.52.24.190 6
167.94.145.111 3
167.94.146.63 3
199.45.155.88 3
azpdes8idctp.stretchoid.com 2
162.142.125.215 1
165.154.253.251 1
205.210.31.227 1
205.210.31.70 1
91.238.181.96 1
TOTAL: 10 22
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