Daily Usenet report

May 9 15:00:02 -- May 10 15:00:01

Unknown entries from news log file:

First 50 / 735 lines (6.8%)

May 9 15:00:48 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
May 9 15:02:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:04:00 colo-sc-1 innd: message repeated 4 times: [ 199.102.165.10 rejected 502]
May 9 15:04:00 colo-sc-1 innd: message repeated 4 times: [ 199.102.165.10 rejected 502]
May 9 15:06:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:08:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:10:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:12:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:14:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:16:04 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:18:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:20:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:22:00 colo-sc-1 innd: message repeated 8 times: [ 199.102.165.10 rejected 502]
May 9 15:24:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:26:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:28:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:30:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:32:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:34:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:36:02 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:38:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:40:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:42:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:44:05 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:46:02 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:48:03 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:50:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:52:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:54:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:56:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 15:58:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:00:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:02:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:04:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:06:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:08:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:10:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:12:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:14:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:16:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:18:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:20:00 colo-sc-1 innd: message repeated 8 times: [ 199.102.165.10 rejected 502]
May 9 16:22:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:24:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:26:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:28:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:30:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:32:00 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:34:03 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 9 16:36:01 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]

Log entries by program:

Program nameLines%LinesSize%Size
inn 13447 64.5%1.8 MB 66.8%
innd 4709 22.6%558.7 KB 20.2%
innfeed 1414 6.8%173.7 KB 6.3%
cnfsstat 1152 5.5%172.6 KB 6.2%
nnrpd 131 0.6%13.1 KB 0.5%
overchan 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 20856 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 29363 45.8%
Positive hits 21697 33.8%
Do not exist 13064 20.4%
Cache misses 46 0.1%
TOTAL: 4 64170 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.062 0.0%136 0.000 0.456 2.000
article cleanup00:00:00.071 0.0%13134 0.000 0.005 0.045
article logging00:00:00.308 0.0%13370 0.000 0.023 0.077
article parse00:00:00.232 0.0%25353 0.000 0.009 0.028
article write00:00:00.931 0.0%11350 0.000 0.082 3.245
artlog/artcncl00:00:00.001 0.0%136 0.000 0.007 0.010
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.033 0.0%77015 0.000 0.000 0.006
hisgrep/artcncl00:00:00.000 0.0%50 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%136 0.000 0.007 0.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.316 0.0%64773 0.000 0.005 0.021
history sync00:00:00.015 0.0%403 0.000 0.037 0.500
history write00:00:00.889 0.0%13134 0.000 0.068 2.500
hiswrite/artcncl00:00:00.000 0.0%86 0.000 0.000 0.000
idle24:00:40.689100.0%88722 513.403 974.287 2459.549
nntp read00:00:00.551 0.0%75503 0.000 0.007 0.026
overview write00:00:00.048 0.0%11350 0.000 0.004 0.032
perl filter00:00:14.231 0.0%13134 0.470 1.084 1.554
python filter00:00:00.339 0.0%13134 0.000 0.026 0.082
site send00:00:01.760 0.0%34050 0.011 0.052 0.119
TOTAL: 24:01:07.42224:01:00.477100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%11343 0.000 0.002 0.027
article prepare00:00:00.001 0.0%461 0.000 0.002 0.200
article read00:00:00.017 0.0%419 0.000 0.041 0.500
backlog stats00:00:00.048 0.0%62660 0.000 0.001 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.270 0.0%37139 0.000 0.007 0.028
data write00:00:00.721 0.0%25955 0.005 0.028 0.078
idle23:58:15.246100.0%62660 833.036 1377.198 3371.899
status file00:00:00.070 0.0%266 0.000 0.263 1.000
TOTAL: 23:58:20.24623:58:16.395100.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%27 0.000 0.037 1.000
TOTAL: 00:00:27.22600: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
reserve 2
TOTAL: 10 167

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 4 22948 9985 12256 707 43%49:23:42
2news.nntp4.net 2 12872 1372 10403 1097 10%24:17:27
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 7 35820 11357 22659 1804 31%73:41:09
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net34.7 MB0.0 KB3.6 MB38.3 MB 90%3.7 KB
2news.nntp4.net3.5 MB0.0 KB4.3 MB7.8 MB 44%3.3 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 338.2 MB0.0 KB7.9 MB46.1 MB 82%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 9 15:00:02 - 15:59:59 599 5.3% 0.172.0 MB 5.2% 0.57
May 9 16:00:00 - 16:59:59 620 5.5% 0.171.8 MB 4.8% 0.52
May 9 17:00:00 - 17:59:59 659 5.8% 0.181.9 MB 5.1% 0.55
May 9 18:00:00 - 18:59:59 544 4.8% 0.152.0 MB 5.3% 0.58
May 9 19:00:00 - 19:59:59 505 4.5% 0.141.9 MB 5.0% 0.55
May 9 20:00:00 - 20:59:59 508 4.5% 0.141.9 MB 5.1% 0.55
May 9 21:00:00 - 21:59:59 435 3.9% 0.121.5 MB 3.9% 0.42
May 9 22:00:00 - 22:59:59 478 4.2% 0.131.6 MB 4.3% 0.46
May 9 23:00:00 - 23:59:59 313 2.8% 0.091.1 MB 2.8% 0.30
May 10 00:00:00 - 00:59:59 272 2.4% 0.081.2 MB 3.3% 0.36
May 10 01:00:00 - 01:59:59 203 1.8% 0.06804.7 KB 2.1% 0.22
May 10 02:00:00 - 02:59:59 232 2.1% 0.06922.3 KB 2.4% 0.26
May 10 03:00:00 - 03:59:59 232 2.1% 0.06801.9 KB 2.1% 0.22
May 10 04:00:00 - 04:59:59 289 2.6% 0.081.3 MB 3.4% 0.37
May 10 05:00:00 - 05:59:59 290 2.6% 0.08807.4 KB 2.1% 0.22
May 10 06:00:00 - 06:59:59 457 4.0% 0.131.1 MB 2.8% 0.30
May 10 07:00:00 - 07:59:59 576 5.1% 0.161.7 MB 4.6% 0.50
May 10 08:00:00 - 08:59:59 631 5.6% 0.182.1 MB 5.4% 0.59
May 10 09:00:00 - 09:59:59 609 5.4% 0.172.0 MB 5.3% 0.58
May 10 10:00:00 - 10:59:59 543 4.8% 0.151.9 MB 5.1% 0.55
May 10 11:00:00 - 11:59:59 574 5.1% 0.162.0 MB 5.3% 0.58
May 10 12:00:00 - 12:59:59 560 5.0% 0.161.8 MB 4.6% 0.50
May 10 13:00:00 - 13:59:59 590 5.2% 0.162.0 MB 5.2% 0.57
May 10 14:00:00 - 15:00:01 578 5.1% 0.161.9 MB 4.9% 0.53
TOTAL: 23:59:59 11297 100.0% 0.1338.2 MB 100.0% 0.45
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 MB255.3 MB 24.9% 21 0.18 68.94
ONEDEFAULT1024.0 MB418.2 MB 40.8% 23 0.18 66.68
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 MB263.3 MB 25.7% 21 0.18 67.03
TWODEFAULT1024.0 MB249.8 MB 24.4% 21 0.18 67.75
TOTAL: 8-20.0 GB12.8 GB 63.9% 90 0.18-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1077 7 0 0 0 0 0 0 1070
2hasname-out.news.weretis.net 937 3 0 0 0 0 0 0 934
TOTAL: 2 2014 10 0 0 0 0 0 0 2004

Unwanted newsgroups [Top 20]:

NewsgroupCount
panix.chat.politics 6
alt.pl.nauka.angielskiego 2
alt.radio.free 1
lada.music 1
TOTAL: 4 10

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 802
EMP (phn path) 785
EMP (phn nph) 103
EMP (phl) 54
Too many newsgroups (meow) 17
Scoring filter 5
HTML Multipart 3
TOTAL: 7 1769

INND no permission servers:

SystemConn
199.102.165.10 755
94.102.61.27 1
TOTAL: 2 756

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 227
news.nntp4.net 8
TOTAL: 2 235
TOTAL: 1 235

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 405 405 0 0 0 0100%18:49:55
2blueworldhosting 12410 3 9711 0 0 51 0%23:59:54
3nntp4 11362 1 9929 0 0 0 0%23:59:32
4weretis 1340 0 1310 10 0 0 0%23:28:32
5aioe 0 0 0 0 0 11235 0%23:59:54
TOTAL: 5 25517 409 20950 10 0 11286 1%114:17:47
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.7 MB0.0 KB1.7 MB0.0 KB/s4.2 KB18:49:55
2blueworldhosting11.5 KB0.0 KB11.5 KB0.0 KB/s3.8 KB23:59:54
3nntp41.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:32
4weretis0.0 KB35.1 KB35.1 KB0.0 KB/s3.5 KB23:28:32
5aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
TOTAL: 51.7 MB35.1 KB1.7 MB0.0 KB/s4.2 KB114:17:47
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
221.212.178.114 0.000 0.002 0.00000:00:11
221.212.178.187 0.000 0.003 0.00000:00:11
14.204.44.97 0.000 0.002 0.00000:00:02
tor-exit-3.zbau.f3netze.de 0.001 0.003 0.00000:00:00
71.6.134.233 0.004 0.004 0.00000:00:00
123.160.173.41 0.001 0.001 0.00000:00:00
59.48.211.7 0.002 0.001 0.00000:00:00
159.89.124.112 0.002 0.004 0.00000:00:00
164.92.114.247 0.000 0.006 0.00000:00:00
tor-exit-12.zbau.f3netze.de 0.001 0.001 0.00000:00:00
134.209.95.237 0.000 0.005 0.00000:00:00
64.225.74.178 0.002 0.002 0.00000:00:00
185.220.101.133 0.002 0.000 0.00000:00:00
147.182.225.86 0.002 0.003 0.00000:00:00
192.241.202.239 0.000 0.003 0.00000:00:00
tor-exit-32.for-privacy.net 0.000 0.002 0.00000:00:00
104.152.52.216 0.001 0.001 0.00000:00:00
104.152.52.231 0.001 0.001 0.00000:00:00
104.152.52.228 0.002 0.001 0.00000:00:00
TOTAL: 19 0.021 0.045 0.00000:00:27

NNRP no permission clients:

SystemConn
71.6.134.233 3
134.209.95.237 2
164.92.114.247 2
tor-exit-3.zbau.f3netze.de 2
159.89.124.112 2
64.225.74.178 2
147.182.225.86 2
59.48.211.7 1
221.212.178.114 1
tor-exit-12.zbau.f3netze.de 1
104.152.52.216 1
104.152.52.231 1
104.152.52.228 1
tor-exit-32.for-privacy.net 1
221.212.178.187 1
123.160.173.41 1
14.204.44.97 1
185.220.101.133 1
192.241.202.239 1
TOTAL: 19 27