Daily Usenet report

Sep 13 15:00:01 -- Sep 14 15:00:01

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Sep 13 15:01:43 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Sep 13 21:34:00 colo-sc-1 innd: message repeated 4 times: [ 199.102.165.10 rejected 502]
Sep 13 21:40:01 colo-sc-1 innd: message repeated 11 times: [ 199.102.165.10 rejected 502]
Sep 13 21:42:00 colo-sc-1 innd: message repeated 5 times: [ 199.102.165.10 rejected 502]
Sep 13 21:44:00 colo-sc-1 innd: message repeated 6 times: [ 199.102.165.10 rejected 502]
Sep 13 21:48:00 colo-sc-1 innd: message repeated 16 times: [ 199.102.165.10 rejected 502]
Sep 13 21:50:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
Sep 13 21:54:00 colo-sc-1 innd: message repeated 19 times: [ 199.102.165.10 rejected 502]
Sep 13 21:58:00 colo-sc-1 innd: message repeated 19 times: [ 199.102.165.10 rejected 502]
Sep 13 22:00:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
Sep 13 22:04:00 colo-sc-1 innd: message repeated 19 times: [ 199.102.165.10 rejected 502]
Sep 13 22:06:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
Sep 13 22:10:00 colo-sc-1 innd: message repeated 19 times: [ 199.102.165.10 rejected 502]
Sep 13 22:14:00 colo-sc-1 innd: message repeated 19 times: [ 199.102.165.10 rejected 502]
Sep 13 22:18:01 colo-sc-1 innd: message repeated 19 times: [ 199.102.165.10 rejected 502]
Sep 13 22:20:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
Sep 13 22:24:00 colo-sc-1 innd: message repeated 19 times: [ 199.102.165.10 rejected 502]
Sep 13 22:28:01 colo-sc-1 innd: message repeated 19 times: [ 199.102.165.10 rejected 502]
Sep 13 22:30:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]

Log entries by program:

Program nameLines%LinesSize%Size
inn 8539 49.4%1.2 MB 51.2%
innd 5447 31.5%674.7 KB 28.7%
innfeed 1992 11.5%277.1 KB 11.8%
cnfsstat 1160 6.7%180.5 KB 7.7%
nnrpd 92 0.5%9.2 KB 0.4%
controlchan 26 0.2%1.6 KB 0.1%
overchan 26 0.2%4.1 KB 0.2%
TOTAL: 7 17282 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 16470 43.6%
Negative hits 13684 36.2%
Do not exist 7116 18.8%
Cache misses 512 1.4%
TOTAL: 4 37782 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.171 0.0%42 0.000 27.881 810.000
article cleanup00:00:00.046 0.0%7226 0.000 0.006 0.048
article logging00:00:00.215 0.0%7331 0.000 0.029 0.100
article parse00:00:00.115 0.0%11381 0.000 0.010 0.057
article write00:00:02.109 0.0%6789 0.000 0.311 17.196
artlog/artcncl00:00:00.000 0.0%41 0.000 0.000 0.000
data move00:00:00.036 0.0%36465 0.000 0.001 0.006
hisgrep/artcncl00:00:00.000 0.0%42 0.000 0.000 0.000
hishave/artcncl00:00:00.976 0.0%42 0.000 23.238 810.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:38.159 0.1%38251 0.003 2.566 37.236
history sync00:00:00.043 0.0%283 0.000 0.152 16.000
history write00:00:01.842 0.0%7226 0.000 0.255 15.310
idle19:58:46.689 99.8%40497 1041.918 1776.099 6131.184
nntp read00:00:00.283 0.0%39523 0.000 0.007 0.020
overview write00:00:00.017 0.0%6789 0.000 0.003 0.053
perl filter00:00:07.140 0.0%7226 0.654 0.988 1.522
python filter00:00:00.164 0.0%7226 0.000 0.023 0.081
site send00:00:01.051 0.0%20367 0.000 0.052 0.087
TOTAL: 20:00:46.46920:00:40.056100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.013 0.0%6739 0.000 0.002 0.025
article prepare00:00:00.002 0.0%5476 0.000 0.000 0.022
article read00:00:00.077 0.0%2091 0.000 0.037 0.333
backlog stats00:00:00.027 0.0%44843 0.000 0.001 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.190 0.0%25776 0.000 0.007 0.028
data write00:00:00.508 0.0%19190 0.000 0.026 0.068
idle19:55:53.002100.0%44843 909.126 1600.094 5264.868
status file00:00:04.495 0.0%335 0.000 13.418 1021.000
TOTAL: 19:56:26.25919:55:58.314100.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.2%19 0.000 0.053 1.000
TOTAL: 00:00:00.55200:00:00.001 0.2%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 171
name 2
pause 2
paused 2
reserve 2
shutdown 72
TOTAL: 11 263

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 51 13240 5300 7923 17 40%46:23:17
2usenet.blueworldhosting.com 735 8204 1759 6058 387 21%22:37:00
3news.nntp4.net 26 6276 754 5441 81 12%22:48:28
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 813 27720 7813 19422 485 28%91:48:45
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net16.2 MB0.0 KB191.9 KB16.4 MB 98%3.2 KB
2usenet.blueworldhosting.com4.0 MB0.0 KB2.6 MB6.5 MB 60%3.1 KB
3news.nntp4.net2.0 MB0.0 KB225.5 KB2.2 MB 90%2.7 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 422.1 MB0.0 KB3.0 MB25.1 MB 88%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 13 15:00:01 - 15:59:59 472 6.0% 0.131.2 MB 5.4% 0.34
Sep 13 16:00:00 - 16:59:59 413 5.2% 0.111.1 MB 5.0% 0.32
Sep 13 17:00:00 - 17:59:59 436 5.5% 0.121.4 MB 6.3% 0.40
Sep 13 18:00:00 - 18:59:59 409 5.2% 0.111.2 MB 5.6% 0.35
Sep 13 19:00:00 - 19:59:59 411 5.2% 0.111.3 MB 5.7% 0.36
Sep 13 20:00:00 - 20:59:59 381 4.8% 0.111.3 MB 5.6% 0.36
Sep 13 21:00:00 - 21:59:59 357 4.5% 0.101.1 MB 5.1% 0.33
Sep 13 22:00:00 - 22:59:59 384 4.9% 0.111.2 MB 5.4% 0.35
Sep 13 23:00:00 - 23:59:59 229 2.9% 0.06935.9 KB 4.1% 0.26
Sep 14 00:00:00 - 00:59:59 199 2.5% 0.06714.5 KB 3.1% 0.20
Sep 14 01:00:00 - 01:59:59 145 1.8% 0.04402.6 KB 1.8% 0.11
Sep 14 02:00:00 - 02:59:59 138 1.8% 0.04412.7 KB 1.8% 0.11
Sep 14 03:00:00 - 03:59:59 149 1.9% 0.04519.2 KB 2.3% 0.14
Sep 14 04:00:00 - 04:59:59 128 1.6% 0.04352.5 KB 1.5% 0.10
Sep 14 05:00:00 - 05:59:59 193 2.5% 0.05482.5 KB 2.1% 0.13
Sep 14 06:00:00 - 06:59:59 304 3.9% 0.08804.1 KB 3.5% 0.22
Sep 14 07:00:00 - 07:59:59 371 4.7% 0.101.0 MB 4.6% 0.29
Sep 14 08:00:00 - 08:59:59 458 5.8% 0.131.3 MB 5.8% 0.37
Sep 14 09:00:00 - 09:59:59 452 5.7% 0.131.1 MB 4.8% 0.30
Sep 14 10:00:00 - 10:59:59 327 4.2% 0.09848.3 KB 3.7% 0.24
Sep 14 11:00:00 - 11:59:59 335 4.3% 0.09824.6 KB 3.6% 0.23
Sep 14 12:00:00 - 12:59:59 406 5.2% 0.111.0 MB 4.6% 0.29
Sep 14 13:00:00 - 13:59:59 368 4.7% 0.10930.9 KB 4.1% 0.26
Sep 14 14:00:00 - 15:00:01 402 5.1% 0.11994.5 KB 4.4% 0.28
TOTAL: 24:00:00 7867 100.0% 0.0922.3 MB 100.0% 0.26
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
EIGHTBIG4.0 GB2.9 GB 72.6% 1 0.00 0.00
FIVEBIG4.0 GB2.9 GB 72.6% 1 0.00 0.00
FOURDEFAULT1024.0 MB940.5 MB 91.8% 29 0.11 106.58
ONEDEFAULT1024.0 MB129.9 MB 12.7% 32 0.12 103.99
SEVENBIG4.0 GB2.9 GB 72.6% 1 0.00 0.00
SIXBIG4.0 GB2.9 GB 72.8% 1 0.00 0.00
THREEDEFAULT1024.0 MB960.8 MB 93.8% 29 0.12 103.78
TWODEFAULT1024.0 MB963.5 MB 94.1% 29 0.12 102.56
TOTAL: 8-20.0 GB14.5 GB 72.7% 123 0.12-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 447 347 0 0 0 0 0 0 100
2news.nntp4.net 94 4 0 0 0 0 0 0 90
3hasname-out.news.weretis.net 83 3 0 0 0 0 0 0 80
TOTAL: 3 624 354 0 0 0 0 0 0 270

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 161
linux.kernel.git 34
fido7.pushkin.local 25
perl.cpan 22
fido7.fidonet.online 15
alt.religion.biblestudy 14
fido7.lorapvt.horo 12
fido7.ukrnews 11
rocksolid.feeds.news 9
fido7.f715.techinfo 6
local.general 5
fido7.crimea.robots 5
fido7.altyn.local 4
fido7.starper.limited 4
hispagatos.hacking.ctf 4
hispagatos.hacking.news 3
alt.wesley.crusher.die.die 3
kraft.politics 2
panix.chat.politics 2
alt.mac 2
TOTAL: 31 354

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 67
EMP (md5) 52
Too many newsgroups (meow) 10
HTML Multipart 5
hierarchy violation - crosspost outside sdnet 2
Scoring filter 2
Binary: misplaced binary 2
TOTAL: 7 140

INND no permission servers:

SystemConn
199.102.165.10 19
91.238.181.33 1
80.66.76.134 1
TOTAL: 3 21

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 66
usenet.blueworldhosting.com 62
news.nntp4.net 2
TOTAL: 3 130
TOTAL: 1 130

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 1448 1448 0 0 0 3100%23:39:15
2nntp4 8327 1010 6028 19 0 5 12%23:48:36
3weretis 3562 124 2279 88 0 9 3%23:43:49
4aioe 0 0 0 0 0 7829 0%23:49:50
5blueworldhosting 6344 0 5687 0 0 5 0%23:48:37
TOTAL: 5 19681 2582 13994 107 0 7851 13%118:50:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom4.5 MB0.0 KB4.5 MB0.1 KB/s3.2 KB23:39:15
2nntp42.1 MB55.2 KB2.1 MB0.0 KB/s2.1 KB23:48:36
3weretis343.7 KB174.6 KB518.3 KB0.0 KB/s2.4 KB23:43:49
4aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:49:50
5blueworldhosting0.0 KB0.0 KB0.0 KB0.0 KB/s023:48:37
TOTAL: 56.9 MB229.8 KB7.1 MB0.0 KB/s2.7 KB118:50:07
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
147.182.241.81 0.002 0.006 0.00000:00:00
159.89.124.112 0.000 0.004 0.00000:00:00
157.245.222.108 0.001 0.003 0.00000:00:00
azpdegc29.stretchoid.com 0.002 0.000 0.00000:00:00
167.94.145.96 0.000 0.004 0.00000:00:00
server-0-3.survey.inspici.com 0.000 0.002 0.00000:00:00
104.152.52.124 0.000 0.002 0.00000:00:00
198.235.24.174 0.000 0.002 0.00000:00:00
suave.monitoring.internet-measurement.com 0.000 0.002 0.00000:00:00
147.185.132.213 0.001 0.001 0.00000:00:00
104.152.52.199 0.001 0.001 0.00000:00:00
198.235.24.82 0.000 0.002 0.00000:00:00
TOTAL: 12 0.007 0.029 0.00000:00:00

NNRP no permission clients:

SystemConn
147.182.241.81 4
167.94.145.96 3
157.245.222.108 2
159.89.124.112 2
104.152.52.199 1
147.185.132.213 1
suave.monitoring.internet-measurement.com 1
198.235.24.82 1
104.152.52.124 1
azpdegc29.stretchoid.com 1
198.235.24.174 1
server-0-3.survey.inspici.com 1
TOTAL: 12 19
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>