Daily Usenet report

Oct 27 15:00:01 -- Oct 28 15:00:01

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Oct 27 15:01:12 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Oct 28 06:11:40 colo-sc-1 pgpverify[14932]: pgpverify: verification failed
Oct 28 13:29:57 colo-sc-1 innd: message repeated 3 times: [ 223.111.175.15 rejected 502]
Oct 28 13:30:10 colo-sc-1 innd: message repeated 3 times: [ 223.111.175.15 rejected 502]
Oct 28 13:30:25 colo-sc-1 innd: message repeated 4 times: [ 223.111.175.15 rejected 502]
Oct 28 13:30:41 colo-sc-1 innd: message repeated 3 times: [ 223.111.175.15 rejected 502]
Oct 28 13:30:57 colo-sc-1 innd: message repeated 4 times: [ 223.111.175.15 rejected 502]
Oct 28 13:31:10 colo-sc-1 innd: message repeated 3 times: [ 223.111.175.15 rejected 502]
Oct 28 13:31:25 colo-sc-1 innd: message repeated 4 times: [ 223.111.175.15 rejected 502]
Oct 28 13:31:38 colo-sc-1 innd: message repeated 3 times: [ 223.111.175.15 rejected 502]
Oct 28 13:31:57 colo-sc-1 innd: message repeated 3 times: [ 223.111.175.15 rejected 502]
Oct 28 13:32:12 colo-sc-1 innd: message repeated 4 times: [ 223.111.175.15 rejected 502]
Oct 28 13:32:25 colo-sc-1 innd: message repeated 3 times: [ 223.111.175.15 rejected 502]

Log entries by program:

Program nameLines%LinesSize%Size
inn 13584 76.0%1.7 MB 73.8%
innd 2293 12.8%316.4 KB 13.8%
innfeed 1317 7.4%184.6 KB 8.1%
cnfsstat 580 3.2%87.3 KB 3.8%
nnrpd 73 0.4%8.0 KB 0.3%
controlchan 13 0.1%2.9 KB 0.1%
overchan 1 0.0%0.2 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 17862 100.0%2.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 33651 43.9%
Negative hits 29801 38.9%
Do not exist 13193 17.2%
Cache misses 34 0.0%
TOTAL: 4 76679 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.092 0.0%56 0.000 1.643 5.000
article cleanup00:00:00.086 0.0%13298 0.000 0.006 0.030
article logging00:00:00.335 0.0%13476 0.000 0.025 0.087
article parse00:00:00.202 0.0%21662 0.000 0.009 0.033
article write00:00:00.521 0.0%12658 0.000 0.041 0.160
artlog/artcncl00:00:00.000 0.0%56 0.000 0.000 0.000
data move00:00:00.036 0.0%83656 0.000 0.000 0.006
hisgrep/artcncl00:00:00.000 0.0%49 0.000 0.000 0.000
hishave/artcncl00:00:00.004 0.0%56 0.000 0.071 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:31.679 0.0%77283 0.000 0.410 14.002
history sync00:00:00.011 0.0%410 0.000 0.027 0.500
history write00:00:00.454 0.0%13298 0.000 0.034 0.698
hiswrite/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
idle23:50:10.988 99.9%84253 516.902 1018.492 4142.697
nntp read00:00:00.591 0.0%84077 0.000 0.007 0.019
overview write00:00:00.039 0.0%12658 0.000 0.003 0.047
perl filter00:00:13.441 0.0%13298 0.773 1.011 1.322
python filter00:00:00.360 0.0%13298 0.000 0.027 0.078
site send00:00:02.290 0.0%37975 0.011 0.060 0.121
TOTAL: 23:51:09.43323:51:01.129100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%12632 0.000 0.002 0.024
article prepare00:00:00.000 0.0%1059 0.000 0.000 0.000
article read00:00:00.020 0.0%461 0.000 0.043 1.000
backlog stats00:00:00.042 0.0%74929 0.000 0.001 0.012
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.346 0.0%44394 0.000 0.008 0.025
data write00:00:00.915 0.0%31794 0.000 0.029 0.090
idle23:47:47.441100.0%74929 677.217 1143.315 3730.441
status file00:00:00.416 0.0%287 0.000 1.449 70.600
TOTAL: 23:48:00.04623:47:49.209100.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%17 0.000 0.000 0.000
TOTAL: 00:00:00.75500: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
reserve 2
TOTAL: 10 167

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 7 22834 8580 14201 53 37%48:15:41
2news-out.aioe.org 3 10609 2617 7992 0 24%22:09:11
3news.nntp4.net 4 12898 1278 11042 578 9%23:25:01
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 15 46341 12475 33235 631 26%93:49:53
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net24.5 MB0.0 KB160.6 KB24.6 MB 99%2.9 KB
2news-out.aioe.org6.3 MB0.0 KB0.0 KB6.3 MB100%2.5 KB
3news.nntp4.net3.2 MB0.0 KB2.0 MB5.2 MB 61%2.9 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 434.0 MB0.0 KB2.1 MB36.1 MB 94%2.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 27 15:00:01 - 15:59:59 712 5.6% 0.202.0 MB 5.8% 0.57
Oct 27 16:00:00 - 16:59:59 690 5.4% 0.191.9 MB 5.6% 0.54
Oct 27 17:00:00 - 17:59:59 700 5.5% 0.191.8 MB 5.1% 0.50
Oct 27 18:00:00 - 18:59:59 576 4.5% 0.161.8 MB 5.4% 0.52
Oct 27 19:00:00 - 19:59:59 665 5.2% 0.181.6 MB 4.7% 0.46
Oct 27 20:00:00 - 20:59:59 509 4.0% 0.141.5 MB 4.4% 0.43
Oct 27 21:00:00 - 21:59:59 572 4.5% 0.161.5 MB 4.4% 0.43
Oct 27 22:00:00 - 22:59:59 498 3.9% 0.141.5 MB 4.4% 0.43
Oct 27 23:00:00 - 23:59:59 304 2.4% 0.08858.0 KB 2.4% 0.24
Oct 28 00:00:00 - 00:59:59 252 2.0% 0.07767.3 KB 2.2% 0.21
Oct 28 01:00:00 - 01:59:59 243 1.9% 0.07780.9 KB 2.2% 0.22
Oct 28 02:00:00 - 02:59:59 175 1.4% 0.05576.5 KB 1.6% 0.16
Oct 28 03:00:00 - 03:59:59 204 1.6% 0.06541.2 KB 1.5% 0.15
Oct 28 04:00:00 - 04:59:59 295 2.3% 0.08849.1 KB 2.4% 0.24
Oct 28 05:00:00 - 05:59:59 325 2.6% 0.09943.3 KB 2.7% 0.26
Oct 28 06:00:00 - 06:59:59 401 3.2% 0.111.0 MB 3.0% 0.30
Oct 28 07:00:00 - 07:59:59 583 4.6% 0.161.7 MB 4.8% 0.47
Oct 28 08:00:00 - 08:59:59 722 5.7% 0.201.8 MB 5.3% 0.52
Oct 28 09:00:00 - 09:59:59 753 5.9% 0.211.9 MB 5.4% 0.53
Oct 28 10:00:00 - 10:59:59 694 5.5% 0.191.7 MB 4.9% 0.48
Oct 28 11:00:00 - 11:59:59 628 4.9% 0.171.8 MB 5.2% 0.51
Oct 28 12:00:00 - 12:59:59 603 4.7% 0.171.6 MB 4.7% 0.46
Oct 28 13:00:00 - 13:59:59 759 6.0% 0.211.9 MB 5.5% 0.54
Oct 28 14:00:00 - 14:59:59 848 6.7% 0.242.2 MB 6.4% 0.63
Oct 28 15:00:00 - 15:00:01 2 0.0% 2.006.3 KB 0.0% 6.28
TOTAL: 24:00:00 12713 100.0% 0.1534.4 MB 100.0% 0.41
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB305.8 MB 29.9% 9 0.18 66.73
ONEDEFAULT1024.0 MB484.0 MB 47.3% 11 0.18 67.21
THREEDEFAULT1024.0 MB318.4 MB 31.1% 9 0.18 67.34
TWODEFAULT1024.0 MB312.4 MB 30.5% 9 0.18 66.99
TOTAL: 4-4.0 GB1.4 GB 34.7% 38 0.18-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 590 1 0 0 0 0 0 0 589
2hasname-out.news.weretis.net 217 12 0 0 0 0 0 0 205
3news-out.aioe.org 8 0 0 0 0 0 0 0 8
TOTAL: 3 815 13 0 0 0 0 0 0 802

Unwanted newsgroups [Top 20]:

NewsgroupCount
sybase.public.powerdesigner.general 10
rwth.general 1
alt.penthouse.sex.femdom 1
alt.sports.baseball.az-diamondbacks 1
TOTAL: 4 13

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 430
EMP (phl) 105
EMP (phn path) 85
Too many newsgroups 1
HTML post 1
TOTAL: 5 622

INND no permission servers:

SystemConn
223.111.175.15 14
TOTAL: 1 14

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 170
news-out.aioe.org 8
news.nntp4.net 2
TOTAL: 3 180
TOTAL: 1 180

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 271 271 0 0 0 0100%17:25:36
2aioe 11577 164 9439 0 0 0 1%23:53:09
3nntp4 14017 2 11366 0 0 0 0%23:53:09
4weretis 5517 0 4062 31 0 3 0%23:54:18
TOTAL: 4 31382 437 24867 31 0 3 1%89:06:12
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.0 MB0.0 KB1.0 MB0.0 KB/s3.9 KB17:25:36
2aioe568.2 KB0.0 KB568.2 KB0.0 KB/s3.5 KB23:53:09
3nntp418.0 KB0.0 KB18.0 KB0.0 KB/s9.0 KB23:53:09
4weretis0.0 KB127.3 KB127.3 KB0.0 KB/s4.1 KB23:54:18
TOTAL: 41.6 MB127.3 KB1.7 MB0.0 KB/s3.8 KB89:06:12
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
sh-ams-nl-gp1-wk112.internet-census.org 0.001 0.015 0.00000:00:00
phenomenal.monitoring.internet-measurement.com 0.001 0.001 0.00000:00:00
192.241.212.94 0.001 0.001 0.00000:00:00
147.182.225.86 0.003 0.003 0.00000:00:00
147.182.202.179 0.002 0.002 0.00000:00:00
4addf5cd.tidalcoinage.internet-measurement.com 0.000 0.002 0.00000:00:00
scanner-08.ch1.censys-scanner.com 0.000 0.002 0.00000:00:00
sh-ams-nl-gp1-wk112d.internet-census.org 0.001 0.001 0.00000:00:00
TOTAL: 8 0.009 0.027 0.00000:00:00

NNRP no permission clients:

SystemConn
sh-ams-nl-gp1-wk112.internet-census.org 8
147.182.225.86 2
147.182.202.179 2
192.241.212.94 1
4addf5cd.tidalcoinage.internet-measurement.com 1
phenomenal.monitoring.internet-measurement.com 1
sh-ams-nl-gp1-wk112d.internet-census.org 1
scanner-08.ch1.censys-scanner.com 1
TOTAL: 8 17
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>