Daily Usenet report

Nov 30 06:01:01 -- Dec 1 06:01:01

Unknown entries from news log file:

First 35 / 35 lines (100.0%)

Nov 30 06:01:57 kennel innd: message repeated 2 times: [ ctlinnd command s]
Nov 30 15:28:00 kennel innd: message repeated 2 times: [ 24.182.239.66 rejected 502]
Nov 30 15:29:00 kennel innd: message repeated 2 times: [ 24.182.239.66 rejected 502]
Nov 30 15:30:00 kennel innd: message repeated 3 times: [ 24.182.239.66 rejected 502]
Nov 30 15:31:00 kennel innd: message repeated 4 times: [ 24.182.239.66 rejected 502]
Nov 30 15:32:00 kennel innd: message repeated 5 times: [ 24.182.239.66 rejected 502]
Nov 30 15:33:00 kennel innd: message repeated 6 times: [ 24.182.239.66 rejected 502]
Nov 30 15:34:00 kennel innd: message repeated 7 times: [ 24.182.239.66 rejected 502]
Nov 30 15:35:00 kennel innd: message repeated 8 times: [ 24.182.239.66 rejected 502]
Nov 30 15:36:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:37:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:38:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:39:00 kennel innd: message repeated 2 times: [ 24.182.239.66 rejected 502]
Nov 30 15:39:00 kennel innd: message repeated 6 times: [ 24.182.239.66 rejected 502]
Nov 30 15:40:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:41:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:42:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:43:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:44:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:45:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:46:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:47:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:48:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:49:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:50:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:51:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:52:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:56:05 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:57:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:58:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 15:59:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 16:00:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 16:01:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Nov 30 16:02:00 kennel innd: message repeated 9 times: [ 24.182.239.66 rejected 502]
Dec 1 00:04:02 kennel pgpverify[596634]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 565164 94.8%72.5 MB 94.8%
innfeed 20532 3.4%2.3 MB 3.0%
innd 10158 1.7%1.6 MB 2.1%
cnfsstat 144 0.0%24.4 KB 0.0%
nnrpd 66 0.0%7.5 KB 0.0%
controlchan 32 0.0%7.7 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 7 596097 100.0%76.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 788542 41.7%
Do not exist 551569 29.2%
Positive hits 516893 27.3%
Cache misses 33539 1.8%
TOTAL: 4 1890543 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.009 0.0%78 0.000 0.115 1.000
article cleanup00:00:05.634 0.0%564234 0.006 0.010 0.015
article logging00:00:21.503 0.0%564358 0.017 0.038 0.058
article parse00:00:31.244 0.0%1495604 0.013 0.021 0.028
article write00:00:20.250 0.0%225871 0.045 0.090 0.125
artlog/artparse00:00:00.069 0.0%1054 0.000 0.065 0.500
data move00:00:02.541 0.0%1439200 0.001 0.002 0.004
hisgrep/artcncl00:00:00.002 0.0%78 0.000 0.026 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:20.361 0.0%1914575 0.002 0.011 0.327
history sync00:00:00.031 0.0%312 0.000 0.099 0.667
history write00:00:34.121 0.0%557030 0.029 0.061 0.084
idle23:50:45.906 99.3%1200654 24.395 71.499 187.214
nntp read00:00:45.742 0.1%1202383 0.028 0.038 0.055
overview write00:00:01.247 0.0%225871 0.000 0.006 0.013
perl filter00:00:25.934 0.0%555999 0.032 0.047 0.071
python filter00:00:26.723 0.0%555999 0.028 0.048 0.069
site send00:00:08.169 0.0%508583 0.010 0.016 0.099
TOTAL: 24:00:28.62823:54:49.486 99.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.219 0.0%72589 0.000 0.003 0.016
article prepare00:00:00.001 0.0%4497 0.000 0.000 0.001
article read00:00:00.096 0.0%1172 0.000 0.082 1.000
backlog stats00:00:00.214 0.0%185126 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.039 0.0%119817 0.004 0.025 0.051
data write00:00:03.004 0.0%70168 0.016 0.043 0.104
idle23:53:49.247100.0%185126 131.260 464.706 1167.352
status file00:00:06.006 0.0%8335 0.544 0.721 1.705
TOTAL: 23:54:12.40223:54:01.826100.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.0%14 0.000 0.071 1.000
TOTAL: 00:00:02.07800:00:00.001 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
control@eternal-september.org001001
us-control@lists.killfile.org000100
TOTAL002102

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.feeder.erje.net 578 1083293 215471 528324 339498 19%58:27:20
2hasname-out.news.weretis.net 4 16452 4651 11741 60 28%48:05:56
3news.nntp4.net 2 7991 3542 4297 152 44%24:09:02
4usenet.blueworldhosting.com 970 9527 1270 8182 75 13%23:20:56
5localhost 1 0 0 0 0 0%00:00:00
TOTAL: 5 1555 1117263 224934 552544 339785 20%154:03:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.feeder.erje.net1.9 GB83.0 MB3.0 GB5.0 GB 38%9.5 KB
2news.nntp4.net40.8 MB25.2 KB884.9 KB41.6 MB 97%11.5 KB
3hasname-out.news.weretis.net9.2 MB13.8 KB100.9 KB9.3 MB 98%2.0 KB
4usenet.blueworldhosting.com2.6 MB0.0 KB305.6 KB2.9 MB 89%2.2 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 52.0 GB83.0 MB3.0 GB5.1 GB 39%9.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 30 06:01:01 - 06:59:59 6629 2.9% 1.8763.3 MB 3.1% 18.32
Nov 30 07:00:00 - 07:59:59 9143 4.1% 2.5477.0 MB 3.8% 21.89
Nov 30 08:00:00 - 08:59:59 9725 4.3% 2.7080.9 MB 4.0% 23.01
Nov 30 09:00:00 - 09:59:59 7948 3.5% 2.2172.2 MB 3.5% 20.53
Nov 30 10:00:00 - 10:59:59 7914 3.5% 2.2071.2 MB 3.5% 20.25
Nov 30 11:00:00 - 11:59:59 7687 3.4% 2.1477.1 MB 3.8% 21.93
Nov 30 12:00:00 - 12:59:59 7774 3.5% 2.1672.5 MB 3.5% 20.62
Nov 30 13:00:00 - 13:59:59 8671 3.9% 2.4188.8 MB 4.3% 25.24
Nov 30 14:00:00 - 14:59:59 8199 3.6% 2.2871.0 MB 3.5% 20.19
Nov 30 15:00:00 - 15:59:59 12693 5.6% 3.53118.7 MB 5.8% 33.76
Nov 30 16:00:00 - 16:59:59 8302 3.7% 2.3175.0 MB 3.7% 21.34
Nov 30 17:00:00 - 17:59:59 9436 4.2% 2.6274.9 MB 3.7% 21.32
Nov 30 18:00:00 - 18:59:59 16076 7.1% 4.47120.3 MB 5.9% 34.23
Nov 30 19:00:00 - 19:59:59 17060 7.6% 4.74134.8 MB 6.6% 38.34
Nov 30 20:00:00 - 20:59:59 13491 6.0% 3.75116.8 MB 5.7% 33.22
Nov 30 21:00:00 - 21:59:59 11495 5.1% 3.19122.3 MB 6.0% 34.80
Nov 30 22:00:00 - 22:59:59 9294 4.1% 2.5884.6 MB 4.1% 24.06
Nov 30 23:00:00 - 23:59:59 9700 4.3% 2.6986.0 MB 4.2% 24.47
Dec 1 00:00:00 - 00:59:59 7559 3.4% 2.1080.9 MB 4.0% 23.00
Dec 1 01:00:00 - 01:59:59 8865 3.9% 2.4686.1 MB 4.2% 24.49
Dec 1 02:00:00 - 02:59:59 8125 3.6% 2.2685.6 MB 4.2% 24.34
Dec 1 03:00:00 - 03:59:59 6834 3.0% 1.9068.0 MB 3.3% 19.33
Dec 1 04:00:00 - 04:59:59 5516 2.5% 1.5354.6 MB 2.7% 15.54
Dec 1 05:00:00 - 05:59:59 6744 3.0% 1.8761.7 MB 3.0% 17.56
Dec 1 06:00:00 - 06:01:01 93 0.0% 1.52958.3 KB 0.0% 15.71
TOTAL: 24:00:00 224973 100.0% 2.602.0 GB 100.0% 24.24
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
C1DEFAULT10.0 GB6.8 GB 68.3% 101 29.73 4.08
TOTAL: 1-10.0 GB6.8 GB 68.3% 101 29.73-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.feeder.erje.net339829330800 0 8118 0 0 0 0 911
2news.nntp4.net 191 143 0 9 0 1 0 0 38
3usenet.blueworldhosting.com 97 76 0 0 0 0 0 0 21
4hasname-out.news.weretis.net 74 50 0 13 0 0 0 0 11
TOTAL: 4340191331069 0 8140 0 1 0 0 981

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.friends 278488
alt.binaries.encrypted 3734
alt.binaries.pwp 3293
alt.binaries.wtfnzb.beta 1331
alt.binaries.wtfnzb.hotel 1329
alt.binaries.wtfnzb.india 1329
alt.binaries.wtfnzb.juliet 1328
alt.binaries.wtfnzb.alpha 1323
alt.binaries.wtfnzb.charlie 1320
alt.binaries.wtfnzb.lima 1320
alt.binaries.wtfnzb.kilo 1312
alt.binaries.wtfnzb.echo 1302
alt.binaries.wtfnzb.golf 1291
alt.binaries.wtfnzb.novemeber 1290
alt.binaries.wtfnzb.delta 1287
alt.binaries.wtfnzb.foxtrot 1284
alt.binaries.wtfnzb.mike 1270
alt.binaries.wtfnzb.bravo 1253
alt.binaries.ninja.axe 1097
alt.binaries.font 1064
TOTAL: 214 331069

INND no permission servers:

SystemConn
24.182.239.66 35
103.193.138.76 27
35.203.210.30 3
147.185.133.184 2
185.247.137.154 1
185.247.137.180 1
66.132.153.138 1
85.208.84.68 1
TOTAL: 8 71

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.feeder.erje.net 54
news.nntp4.net 38
usenet.blueworldhosting.com 21
hasname-out.news.weretis.net 11
TOTAL: 4 124
No colon-space in header field
hasname-out.feeder.erje.net 857
TOTAL: 1 857
TOTAL: 2 981

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1blueworldhosting 55571 472 54444 4 0 13281 0%23:59:53
2bbsgslincom 306 306 0 0 0 0100%19:13:53
3erje 9106 0 8465 378 0 0 0%23:59:53
4weretis 5751 0 5370 194 0 1 0%23:59:37
5nntp4 2722 0 0 0 0 9698 0%23:59:53
TOTAL: 5 73456 778 68279 576 0 22980 1%115:13:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1blueworldhosting5.4 MB44.4 KB5.5 MB0.1 KB/s11.8 KB23:59:53
2bbsgslincom1.0 MB0.0 KB1.0 MB0.0 KB/s3.4 KB19:13:53
3erje0.0 KB10.5 MB10.5 MB0.1 KB/s28.3 KB23:59:53
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
5weretis0.0 KB5.2 MB5.2 MB0.1 KB/s27.3 KB23:59:37
TOTAL: 56.5 MB15.7 MB22.1 MB0.1 KB/s16.7 KB115:13:09
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
prepared.monitoring.internet-measurement.com 0.000 0.005 0.00000:00:00
o05.scanner.modat.io 0.002 0.002 0.00000:00:00
193.34.213.150 0.001 0.003 0.00000:00:00
88.214.25.121 0.003 0.001 0.00000:00:00
199.45.154.117 0.004 0.010 0.00000:00:00
162.142.125.121 0.006 0.005 0.00000:00:00
205.210.31.230 0.004 0.000 0.00000:00:00
azpdsgrr8x7j.stretchoid.com 0.001 0.002 0.00000:00:00
205.210.31.202 0.001 0.002 0.00000:00:00
TOTAL: 9 0.022 0.030 0.00000:00:02

NNRP no permission clients [Top 20]:

SystemConn
162.142.125.121 3
199.45.154.117 3
azpdsgrr8x7j.stretchoid.com 2
193.34.213.150 1
205.210.31.202 1
205.210.31.230 1
88.214.25.121 1
o05.scanner.modat.io 1
prepared.monitoring.internet-measurement.com 1
TOTAL: 9 14