Daily Usenet report

Jul 31 15:00:02 -- Aug 1 15:00:23

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jul 31 15:01:26 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Aug 1 00:04:02 colo-sc-1 pgpverify[31806]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 13418 74.1%1.6 MB 71.4%
innd 2832 15.6%394.6 KB 17.0%
innfeed 1223 6.8%171.7 KB 7.4%
cnfsstat 576 3.2%88.4 KB 3.8%
nnrpd 27 0.1%2.9 KB 0.1%
controlchan 22 0.1%5.4 KB 0.2%
pgpverify 1 0.0%0.0 KB 0.0%
TOTAL: 7 18099 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 42092 47.2%
Positive hits 34073 38.2%
Do not exist 12996 14.6%
Cache misses 37 0.0%
TOTAL: 4 89198 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.094 0.0%91 0.000 44.989 464.000
article cleanup00:00:00.088 0.0%13096 0.000 0.007 0.043
article logging00:00:00.391 0.0%13321 0.000 0.029 0.100
article parse00:00:00.224 0.0%23375 0.000 0.010 0.042
article write00:00:02.609 0.0%11730 0.000 0.222 9.727
artlog/artcncl00:00:00.001 0.0%91 0.000 0.011 0.500
data move00:00:00.044 0.0%96668 0.000 0.000 0.008
hisgrep/artcncl00:00:00.000 0.0%87 0.000 0.000 0.000
hishave/artcncl00:00:00.971 0.0%91 0.000 10.670 124.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:42.489 0.3%89750 0.000 2.479 51.540
history sync00:00:00.019 0.0%375 0.000 0.051 0.500
history write00:00:08.145 0.0%13084 0.000 0.623 27.784
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:56:15.176 99.7%96133 520.973 896.416 3319.221
nntp read00:00:00.657 0.0%96856 0.000 0.007 0.017
overview write00:00:00.051 0.0%11730 0.000 0.004 0.054
perl filter00:00:16.560 0.0%13084 0.768 1.266 15.764
python filter00:00:00.352 0.0%13084 0.000 0.027 0.111
site send00:00:02.060 0.0%35192 0.013 0.059 0.114
TOTAL: 24:00:52.98724:00:33.931100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%11958 0.000 0.002 0.021
article prepare00:00:00.000 0.0%618 0.000 0.000 0.000
article read00:00:00.016 0.0%491 0.000 0.033 1.000
backlog stats00:00:00.039 0.0%55882 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.287 0.0%36472 0.000 0.008 0.032
data write00:00:00.636 0.0%24939 0.000 0.026 0.057
idle23:58:48.565100.0%55882 862.500 1544.837 4640.900
status file00:00:00.810 0.0%241 0.000 3.361 102.250
TOTAL: 23:58:52.13423:58:50.375100.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%6 0.000 0.167 1.000
TOTAL: 00:00:03.64600: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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
news@sfere.anjou.terraraq.org.uk001001
us-control@lists.killfile.org000100
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 5 23967 7319 16082 566 30%50:12:26
2news-out.aioe.org 3 11473 3794 7674 5 33%23:50:30
3news.nntp4.net 2 13329 616 11888 825 4%24:43:32
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 11 48769 11729 35644 1396 24%98:46:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net22.0 MB23.5 KB1.0 MB23.1 MB 95%3.0 KB
2news-out.aioe.org10.1 MB0.0 KB6.6 KB10.1 MB 99%2.7 KB
3news.nntp4.net2.1 MB11.9 KB2.7 MB4.8 MB 44%3.4 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 434.3 MB35.4 KB3.7 MB38.0 MB 90%3.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 31 15:00:02 - 15:59:59 650 5.5% 0.181.8 MB 5.4% 0.52
Jul 31 16:00:00 - 16:59:59 649 5.5% 0.181.7 MB 4.8% 0.47
Jul 31 17:00:00 - 17:59:59 598 5.1% 0.171.8 MB 5.3% 0.52
Jul 31 18:00:00 - 18:59:59 645 5.5% 0.182.0 MB 6.0% 0.58
Jul 31 19:00:00 - 19:59:59 606 5.2% 0.171.8 MB 5.2% 0.50
Jul 31 20:00:00 - 20:59:59 524 4.5% 0.151.6 MB 4.5% 0.44
Jul 31 21:00:00 - 21:59:59 549 4.7% 0.151.6 MB 4.8% 0.46
Jul 31 22:00:00 - 22:59:59 439 3.7% 0.121.2 MB 3.5% 0.34
Jul 31 23:00:00 - 23:59:59 370 3.2% 0.101.2 MB 3.4% 0.33
Aug 1 00:00:00 - 00:59:59 316 2.7% 0.091008.5 KB 2.9% 0.28
Aug 1 01:00:00 - 01:59:59 454 3.9% 0.131.4 MB 4.0% 0.39
Aug 1 02:00:00 - 02:59:59 237 2.0% 0.07758.2 KB 2.2% 0.21
Aug 1 03:00:00 - 03:59:59 239 2.0% 0.07829.6 KB 2.4% 0.23
Aug 1 04:00:00 - 04:59:59 202 1.7% 0.06662.3 KB 1.9% 0.18
Aug 1 05:00:00 - 05:59:59 263 2.2% 0.071.3 MB 3.8% 0.37
Aug 1 06:00:00 - 06:59:59 345 2.9% 0.101.1 MB 3.2% 0.32
Aug 1 07:00:00 - 07:59:59 508 4.3% 0.141.4 MB 4.1% 0.40
Aug 1 08:00:00 - 08:59:59 627 5.3% 0.171.4 MB 4.1% 0.40
Aug 1 09:00:00 - 09:59:59 546 4.7% 0.151.4 MB 4.0% 0.40
Aug 1 10:00:00 - 10:59:59 550 4.7% 0.151.5 MB 4.4% 0.43
Aug 1 11:00:00 - 11:59:59 600 5.1% 0.171.8 MB 5.2% 0.50
Aug 1 12:00:00 - 12:59:59 547 4.7% 0.151.5 MB 4.4% 0.43
Aug 1 13:00:00 - 13:59:59 667 5.7% 0.191.8 MB 5.3% 0.52
Aug 1 14:00:00 - 14:59:59 593 5.1% 0.161.8 MB 5.2% 0.50
Aug 1 15:00:00 - 15:00:23 6 0.1% 0.2623.4 KB 0.1% 1.02
TOTAL: 24:00:21 11730 100.0% 0.1434.3 MB 100.0% 0.41
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB222.8 MB 21.8% 2 0.17 70.37
ONEDEFAULT1024.0 MB385.2 MB 37.6% 4 0.17 71.41
THREEDEFAULT1024.0 MB227.9 MB 22.3% 2 0.18 69.32
TWODEFAULT1024.0 MB224.5 MB 21.9% 2 0.17 70.33
TOTAL: 4-4.0 GB1.0 GB 25.9% 10 0.17-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 800 2 0 3 1 0 0 0 794
2hasname-out.news.weretis.net 739 6 0 9 0 0 0 0 724
3news-out.aioe.org 58 0 0 0 0 0 0 0 58
TOTAL: 3 1597 8 0 12 1 0 0 0 1576

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.creative-cooking 4
wolfsburg.test 2
list.postfix.users 1
man.politics 1
TOTAL: 4 8

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 940
EMP (md5) 210
EMP (phn nph) 137
Scoring filter 21
Too many newsgroups 16
EMP (phl) 14
HTML Multipart 10
User-issued spam cancel 4
TOTAL: 8 1352

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 169
news-out.aioe.org 53
news.nntp4.net 2
TOTAL: 3 224
TOTAL: 1 224

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 450 450 0 0 0 0100%19:44:59
2aioe 8204 15 7798 0 0 112 0%24:00:13
3nntp4 11431 14 11121 0 0 136 0%23:59:53
4weretis 4583 0 4347 13 0 0 0%24:00:15
TOTAL: 4 24668 479 23266 13 0 248 1%91:45:20
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.4 MB0.0 KB1.4 MB0.0 KB/s3.2 KB19:44:59
2aioe70.9 KB0.0 KB70.9 KB0.0 KB/s4.7 KB24:00:13
3nntp436.9 KB0.0 KB36.9 KB0.0 KB/s2.6 KB23:59:53
4weretis0.0 KB50.4 KB50.4 KB0.0 KB/s3.9 KB24:00:15
TOTAL: 41.5 MB50.4 KB1.6 MB0.0 KB/s3.3 KB91:45:20
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
scanner-04.ch1.censys-scanner.com 0.001 0.003 0.00000:00:02
news.nntp4.net 0.001 0.006 0.00000:00:00
23.129.64.148 0.000 0.003 0.00000:00:00
23.129.64.162 0.000 0.002 0.00000:00:00
23.129.64.147 0.000 0.002 0.00000:00:00
TOTAL: 5 0.002 0.016 0.00000:00:03

NNRP no permission clients:

SystemConn
news.nntp4.net 2
23.129.64.148 1
23.129.64.147 1
23.129.64.162 1
scanner-04.ch1.censys-scanner.com 1
TOTAL: 5 6