Daily Usenet report

Apr 14 15:00:01 -- Apr 15 15:00:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Apr 14 15:01:26 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Apr 14 20:45:02 colo-sc-1 pgpverify[24625]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 14910 74.0%1.8 MB 71.5%
innd 3473 17.2%477.1 KB 18.7%
innfeed 1126 5.6%156.6 KB 6.1%
cnfsstat 576 2.9%86.3 KB 3.4%
nnrpd 54 0.3%5.8 KB 0.2%
controlchan 2 0.0%0.2 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
overchan 1 0.0%0.0 KB 0.0%
TOTAL: 8 20143 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 38058 42.7%
Positive hits 36633 41.1%
Do not exist 14411 16.2%
Cache misses 39 0.0%
TOTAL: 4 89141 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.709 0.0%45 0.000 60.200 604.500
article cleanup00:00:00.111 0.0%14557 0.000 0.008 0.043
article logging00:00:00.475 0.0%14866 0.000 0.032 0.100
article parse00:00:00.239 0.0%26004 0.000 0.009 0.038
article write00:00:02.249 0.0%12508 0.000 0.180 6.785
artlog/artcncl00:00:00.000 0.0%44 0.000 0.000 0.000
data move00:00:00.053 0.0%98757 0.000 0.001 0.009
hisgrep/artcncl00:00:00.000 0.0%43 0.000 0.000 0.000
hishave/artcncl00:00:01.214 0.0%45 0.000 26.978 604.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:50.655 0.1%90024 0.000 1.229 65.076
history sync00:00:00.008 0.0%354 0.000 0.023 0.500
history write00:00:03.052 0.0%14553 0.000 0.210 7.458
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:58:11.063 99.8%98897 509.353 872.535 4512.564
nntp read00:00:00.787 0.0%99190 0.000 0.008 0.022
overview write00:00:00.055 0.0%12508 0.000 0.004 0.056
perl filter00:00:18.851 0.0%14553 0.957 1.295 8.192
python filter00:00:00.460 0.0%14553 0.000 0.032 0.107
site send00:00:02.416 0.0%37523 0.029 0.064 0.131
TOTAL: 24:00:51.85724:00:34.397100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.018 0.0%12485 0.000 0.001 0.027
article prepare00:00:00.000 0.0%918 0.000 0.000 0.000
article read00:00:00.030 0.0%735 0.000 0.041 1.000
backlog stats00:00:00.049 0.0%71629 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.345 0.0%43395 0.000 0.008 0.036
data write00:00:00.860 0.0%31107 0.000 0.028 0.107
idle23:58:32.873100.0%71629 675.916 1204.999 3972.237
status file00:00:01.054 0.0%203 0.000 5.192 989.000
TOTAL: 23:58:41.71823:58:35.229100.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%13 0.000 0.077 1.000
TOTAL: 00:00:00.70700: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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 6 25519 7570 17217 732 29%49:49:02
2news-out.aioe.org 2 12137 4784 7297 56 39%23:40:40
3news.nntp4.net 2 15684 141 14205 1338 0%25:41:53
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 11 53340 12495 38719 2126 23%99:11:35
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net24.4 MB0.0 KB1.2 MB25.6 MB 95%3.2 KB
2news-out.aioe.org12.6 MB10.7 KB102.4 KB12.7 MB 99%2.7 KB
3news.nntp4.net506.5 KB10.8 KB3.2 MB3.7 MB 13%2.6 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 437.4 MB21.6 KB4.5 MB42.0 MB 89%2.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 14 15:00:01 - 15:59:59 715 5.7% 0.202.0 MB 5.4% 0.58
Apr 14 16:00:00 - 16:59:59 728 5.8% 0.202.2 MB 5.9% 0.63
Apr 14 17:00:00 - 17:59:59 734 5.9% 0.202.1 MB 5.5% 0.59
Apr 14 18:00:00 - 18:59:59 663 5.3% 0.181.7 MB 4.6% 0.49
Apr 14 19:00:00 - 19:59:59 700 5.6% 0.192.1 MB 5.7% 0.60
Apr 14 20:00:00 - 20:59:59 632 5.1% 0.182.0 MB 5.2% 0.56
Apr 14 21:00:00 - 21:59:59 491 3.9% 0.141.7 MB 4.4% 0.47
Apr 14 22:00:00 - 22:59:59 506 4.0% 0.141.7 MB 4.7% 0.50
Apr 14 23:00:00 - 23:59:59 388 3.1% 0.111.3 MB 3.5% 0.37
Apr 15 00:00:00 - 00:59:59 303 2.4% 0.081.3 MB 3.4% 0.36
Apr 15 01:00:00 - 01:59:59 243 1.9% 0.071.1 MB 3.0% 0.31
Apr 15 02:00:00 - 02:59:59 249 2.0% 0.07968.4 KB 2.5% 0.27
Apr 15 03:00:00 - 03:59:59 234 1.9% 0.07909.8 KB 2.4% 0.25
Apr 15 04:00:00 - 04:59:59 265 2.1% 0.07874.6 KB 2.3% 0.24
Apr 15 05:00:00 - 05:59:59 288 2.3% 0.08939.0 KB 2.5% 0.26
Apr 15 06:00:00 - 06:59:59 319 2.6% 0.09873.6 KB 2.3% 0.24
Apr 15 07:00:00 - 07:59:59 514 4.1% 0.141.5 MB 3.9% 0.42
Apr 15 08:00:00 - 08:59:59 646 5.2% 0.181.5 MB 3.9% 0.42
Apr 15 09:00:00 - 09:59:59 621 5.0% 0.171.6 MB 4.4% 0.47
Apr 15 10:00:00 - 10:59:59 592 4.7% 0.161.6 MB 4.3% 0.45
Apr 15 11:00:00 - 11:59:59 657 5.3% 0.181.8 MB 4.9% 0.52
Apr 15 12:00:00 - 12:59:59 622 5.0% 0.171.7 MB 4.6% 0.49
Apr 15 13:00:00 - 13:59:59 669 5.4% 0.192.0 MB 5.4% 0.58
Apr 15 14:00:00 - 14:59:59 720 5.8% 0.202.1 MB 5.6% 0.59
Apr 15 15:00:00 - 15:00:01 1 0.0% 1.003.7 KB 0.0% 3.67
TOTAL: 24:00:00 12500 100.0% 0.1437.4 MB 100.0% 0.44
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB519.1 MB 50.7% 6 0.18 66.20
ONEDEFAULT1024.0 MB690.5 MB 67.4% 8 0.19 64.77
THREEDEFAULT1024.0 MB527.5 MB 51.5% 6 0.19 64.69
TWODEFAULT1024.0 MB519.2 MB 50.7% 6 0.19 64.77
TOTAL: 4-4.0 GB2.2 GB 55.1% 26 0.19-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1285 5 0 2 1 0 0 0 1277
2hasname-out.news.weretis.net 973 1 0 0 0 0 0 0 972
3news-out.aioe.org 108 0 0 2 0 0 0 0 106
TOTAL: 3 2366 6 0 4 1 0 0 0 2355

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.misc 3
clari.local.chicago 1
netscape.public.mozilla.test 1
ga.jobs 1
TOTAL: 4 6

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) 1401
EMP (md5) 412
EMP (phn nph) 150
EMP (phl) 50
User-issued spam cancel 15
Scoring filter 6
Too many newsgroups 4
HTML Multipart 2
Too many test groups in crosspost 1
U2 violation - invalid distribution 1
TOTAL: 10 2042

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 258
news-out.aioe.org 52
news.nntp4.net 3
TOTAL: 3 313
TOTAL: 1 313

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 684 684 0 0 0 0100%19:18:35
2aioe 9855 34 7509 1 0 1 0%23:59:53
3weretis 5098 0 4915 24 0 0 0%23:59:53
4nntp4 14748 0 12382 0 0 2 0%23:59:47
TOTAL: 4 30385 718 24806 25 0 3 2%91:18:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.6 MB0.0 KB2.6 MB0.0 KB/s3.9 KB19:18:35
2aioe216.5 KB19.6 KB236.1 KB0.0 KB/s6.7 KB23:59:53
3weretis0.0 KB102.2 KB102.2 KB0.0 KB/s4.3 KB23:59:53
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
TOTAL: 42.8 MB121.8 KB2.9 MB0.0 KB/s4.0 KB91:18:08
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.003 0.013 0.00000:00:00
147.78.47.5 0.000 0.004 0.00000:00:00
35.213.214.237 0.002 0.002 0.00000:00:00
ninja.census.shodan.io 0.000 0.005 0.00000:00:00
sh-ams-nl-gp1-wk112c.internet-census.org 0.002 0.001 0.00000:00:00
scanner-05.ch1.censys-scanner.com 0.002 0.001 0.00000:00:00
TOTAL: 6 0.009 0.026 0.00000:00:00

NNRP no permission clients:

SystemConn
sh-ams-nl-gp1-wk112.internet-census.org 7
ninja.census.shodan.io 2
sh-ams-nl-gp1-wk112c.internet-census.org 1
scanner-05.ch1.censys-scanner.com 1
35.213.214.237 1
147.78.47.5 1
TOTAL: 6 13