Daily Usenet report

May 7 15:00:01 -- May 8 15:00:01

Unknown entries from news log file:

First 50 / 723 lines (6.9%)

May 7 15:00:55 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
May 7 15:01:28 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:03:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:05:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:07:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:09:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:11:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:13:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:15:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:17:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:19:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:21:32 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:23:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:25:33 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:27:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:29:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:31:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:33:31 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:35:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:37:32 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:39:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:41:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:43:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:45:32 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:47:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:49:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:51:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:53:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:55:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:57:32 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 15:59:28 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:01:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:03:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:05:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:07:28 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:09:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:11:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:13:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:15:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:17:32 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:19:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:21:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:23:27 colo-sc-1 innd: message repeated 8 times: [ 199.102.165.10 rejected 502]
May 7 16:25:28 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:27:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:29:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:31:29 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:33:27 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:35:28 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]
May 7 16:37:28 colo-sc-1 innd: message repeated 9 times: [ 199.102.165.10 rejected 502]

Log entries by program:

Program nameLines%LinesSize%Size
inn 12675 62.5%1.7 MB 65.0%
innd 4883 24.1%579.5 KB 21.5%
innfeed 1500 7.4%183.9 KB 6.8%
cnfsstat 1152 5.7%174.3 KB 6.5%
nnrpd 59 0.3%6.0 KB 0.2%
controlchan 1 0.0%0.1 KB 0.0%
overchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 20271 100.0%2.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 28517 45.9%
Positive hits 21156 34.1%
Do not exist 12409 20.0%
Cache misses 7 0.0%
TOTAL: 4 62089 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.008 0.0%42 0.000 0.190 2.000
article cleanup00:00:00.086 0.0%12427 0.000 0.007 0.049
article logging00:00:00.333 0.0%12644 0.000 0.026 0.091
article parse00:00:00.191 0.0%22955 0.000 0.008 0.040
article write00:00:00.476 0.0%10507 0.000 0.045 0.130
artlog/artcncl00:00:00.000 0.0%38 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.039 0.0%72960 0.000 0.001 0.005
hisgrep/artcncl00:00:00.000 0.0%27 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%42 0.000 0.024 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.375 0.0%62226 0.000 0.006 0.063
history sync00:00:00.012 0.0%417 0.000 0.029 0.500
history write00:00:00.558 0.0%12427 0.000 0.045 1.404
hiswrite/artcncl00:00:00.000 0.0%15 0.000 0.000 0.000
idle24:00:48.260100.0%84977 600.399 1017.314 2622.450
nntp read00:00:00.516 0.0%72020 0.000 0.007 0.022
overview write00:00:00.048 0.0%10507 0.000 0.005 0.048
perl filter00:00:12.966 0.0%12427 0.760 1.043 1.893
python filter00:00:00.286 0.0%12427 0.000 0.023 0.082
site send00:00:01.620 0.0%31521 0.010 0.051 0.095
TOTAL: 24:01:12.41124:01:05.775100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%10474 0.000 0.002 0.021
article prepare00:00:00.000 0.0%364 0.000 0.000 0.000
article read00:00:00.007 0.0%337 0.000 0.021 0.500
backlog stats00:00:00.056 0.0%58131 0.000 0.001 0.018
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.257 0.0%34532 0.000 0.007 0.029
data write00:00:00.659 0.0%24105 0.000 0.027 0.074
idle23:56:46.024100.0%58131 840.274 1482.961 3907.714
status file00:00:00.074 0.0%309 0.000 0.239 1.000
TOTAL: 23:56:50.73323:56:47.102100.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%12 0.000 0.083 1.000
TOTAL: 00:00:00.96300:00:00.001 0.1%----

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 5 21139 9222 10885 1032 43%47:54:58
2news.nntp4.net 2 11153 1136 9166 851 10%22:16:19
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 8 32292 10358 20051 1883 32%70:11:17
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net32.1 MB0.0 KB5.1 MB37.1 MB 86%3.7 KB
2news.nntp4.net2.5 MB0.0 KB2.6 MB5.1 MB 49%2.6 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 334.6 MB0.0 KB7.7 MB42.2 MB 81%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 7 15:00:01 - 15:59:59 604 5.7% 0.171.9 MB 5.5% 0.55
May 7 16:00:00 - 16:59:59 586 5.6% 0.161.6 MB 4.7% 0.47
May 7 17:00:00 - 17:59:59 546 5.2% 0.151.6 MB 4.6% 0.46
May 7 18:00:00 - 18:59:59 577 5.5% 0.161.6 MB 4.7% 0.47
May 7 19:00:00 - 19:59:59 448 4.3% 0.121.4 MB 3.9% 0.39
May 7 20:00:00 - 20:59:59 401 3.8% 0.111.3 MB 3.8% 0.38
May 7 21:00:00 - 21:59:59 381 3.6% 0.111.2 MB 3.5% 0.34
May 7 22:00:00 - 22:59:59 388 3.7% 0.111.6 MB 4.7% 0.47
May 7 23:00:00 - 23:59:59 282 2.7% 0.08952.9 KB 2.7% 0.26
May 8 00:00:00 - 00:59:59 259 2.5% 0.07918.2 KB 2.6% 0.26
May 8 01:00:00 - 01:59:59 220 2.1% 0.06795.4 KB 2.2% 0.22
May 8 02:00:00 - 02:59:59 272 2.6% 0.081.3 MB 3.6% 0.36
May 8 03:00:00 - 03:59:59 170 1.6% 0.05967.6 KB 2.7% 0.27
May 8 04:00:00 - 04:59:59 236 2.2% 0.07808.2 KB 2.3% 0.22
May 8 05:00:00 - 05:59:59 375 3.6% 0.101.6 MB 4.5% 0.45
May 8 06:00:00 - 06:59:59 319 3.0% 0.09938.1 KB 2.6% 0.26
May 8 07:00:00 - 07:59:59 402 3.8% 0.111.1 MB 3.3% 0.32
May 8 08:00:00 - 08:59:59 560 5.3% 0.161.6 MB 4.6% 0.46
May 8 09:00:00 - 09:59:59 647 6.2% 0.182.1 MB 5.9% 0.59
May 8 10:00:00 - 10:59:59 565 5.4% 0.161.5 MB 4.4% 0.44
May 8 11:00:00 - 11:59:59 571 5.4% 0.162.2 MB 6.3% 0.63
May 8 12:00:00 - 12:59:59 526 5.0% 0.151.9 MB 5.5% 0.54
May 8 13:00:00 - 13:59:59 559 5.3% 0.162.2 MB 6.4% 0.63
May 8 14:00:00 - 15:00:01 611 5.8% 0.171.8 MB 5.2% 0.52
TOTAL: 24:00:00 10505 100.0% 0.1235.0 MB 100.0% 0.42
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 MB226.4 MB 22.1% 21 0.16 75.10
ONEDEFAULT1024.0 MB389.2 MB 38.0% 23 0.17 72.95
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 MB233.8 MB 22.8% 21 0.17 72.90
TWODEFAULT1024.0 MB220.5 MB 21.5% 21 0.16 73.58
TOTAL: 8-20.0 GB12.7 GB 63.3% 90 0.16-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.news.weretis.net 1232 1 0 0 0 0 0 0 1231
2news.nntp4.net 900 1 0 0 0 0 0 0 899
TOTAL: 2 2132 2 0 0 0 0 0 0 2130

Unwanted newsgroups [Top 20]:

NewsgroupCount
bit.listserv.os2-l 1
3dfx.products.voodoo3 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 1030
EMP (md5) 726
EMP (phn nph) 109
EMP (phl) 39
HTML Multipart 8
Scoring filter 1
TOTAL: 6 1913

INND no permission servers:

SystemConn
199.102.165.10 766
TOTAL: 1 766

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 210
news.nntp4.net 7
TOTAL: 2 217
TOTAL: 1 217

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 328 328 0 0 0 0100%19:06:52
2blueworldhosting 11436 2 9369 0 0 0 0%23:59:46
3aioe 0 0 0 0 0 10467 0%23:59:56
4weretis 1190 0 1167 7 0 0 0%23:08:12
5nntp4 10722 0 9293 0 0 0 0%23:59:53
TOTAL: 5 23676 330 19829 7 0 10467 1%114:14:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.4 MB0.0 KB1.4 MB0.0 KB/s4.4 KB19:06:52
2blueworldhosting6.3 KB0.0 KB6.3 KB0.0 KB/s3.2 KB23:59:46
3aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
4weretis0.0 KB19.5 KB19.5 KB0.0 KB/s2.8 KB23:08:12
5nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 51.4 MB19.5 KB1.4 MB0.0 KB/s4.4 KB114:14:39
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
cute.monitoring.internet-measurement.com 0.000 0.003 0.00000:00:00
178.128.32.203 0.000 0.005 0.00000:00:00
137.184.13.100 0.001 0.003 0.00000:00:00
147.182.202.179 0.003 0.003 0.00000:00:00
165.227.172.206 0.000 0.004 0.00000:00:00
64.226.86.7 0.001 0.003 0.00000:00:00
162.243.143.21 0.000 0.002 0.00000:00:00
TOTAL: 7 0.005 0.023 0.00000:00:00

NNRP no permission clients:

SystemConn
165.227.172.206 2
64.226.86.7 2
147.182.202.179 2
178.128.32.203 2
137.184.13.100 2
cute.monitoring.internet-measurement.com 1
162.243.143.21 1
TOTAL: 7 12
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>