Daily Usenet report

Nov 30 15:00:05 -- Dec 1 15:00:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Dec 1 00:04:03 colo-sc-1 pgpverify[28846]: pgpverify: verification failed
Dec 1 07:30:02 colo-sc-1 pgpverify[21659]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 16102 74.1%1.9 MB 71.5%
innd 3778 17.4%515.6 KB 18.8%
innfeed 1238 5.7%176.9 KB 6.5%
cnfsstat 576 2.6%77.4 KB 2.8%
controlchan 33 0.2%7.6 KB 0.3%
nnrpd 9 0.0%1.1 KB 0.0%
pgpverify 2 0.0%0.3 KB 0.0%
TOTAL: 7 21738 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 50453 47.5%
Positive hits 40095 37.7%
Do not exist 15678 14.8%
Cache misses 36 0.0%
TOTAL: 4 106262 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:06.041 0.0%75 0.000 80.547 1169.000
article cleanup00:00:00.102 0.0%15856 0.000 0.006 0.044
article logging00:00:00.483 0.0%16052 0.000 0.030 0.105
article parse00:00:00.310 0.0%32100 0.000 0.010 0.053
article write00:00:02.284 0.0%13602 0.000 0.168 6.757
artlog/artcncl00:00:00.001 0.0%74 0.000 0.014 0.333
data move00:00:00.071 0.0%121763 0.000 0.001 0.006
hisgrep/artcncl00:00:00.000 0.0%69 0.000 0.000 0.000
hishave/artcncl00:00:01.894 0.0%75 0.000 25.253 353.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:05:09.022 0.4%107388 0.002 2.878 76.264
history sync00:00:00.011 0.0%384 0.000 0.029 0.667
history write00:00:04.294 0.0%15856 0.000 0.271 26.516
hiswrite/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
idle23:54:44.751 99.6%119693 352.194 719.213 2379.849
nntp read00:00:00.981 0.0%120830 0.000 0.008 0.015
overview write00:00:00.049 0.0%13602 0.000 0.004 0.028
perl filter00:00:24.216 0.0%15856 0.827 1.527 30.561
python filter00:00:00.478 0.0%15856 0.000 0.030 0.078
site send00:00:02.619 0.0%40809 0.032 0.064 0.103
TOTAL: 24:00:53.90724:00:37.607100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.035 0.0%13545 0.000 0.003 0.027
article prepare00:00:00.000 0.0%680 0.000 0.000 0.000
article read00:00:00.029 0.0%489 0.000 0.059 1.000
backlog stats00:00:00.062 0.0%65293 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.357 0.0%42853 0.000 0.008 0.027
data write00:00:00.893 0.0%29560 0.000 0.030 0.091
idle23:58:18.558100.0%65293 745.975 1321.712 3587.155
status file00:00:00.558 0.0%252 0.000 2.214 115.000
TOTAL: 23:58:22.44823:58:20.492100.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 1.4%2 0.000 0.500 1.000
TOTAL: 00:00:00.07300:00:00.001 1.4%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 148
name 2
pause 2
paused 2
reserve 2
TOTAL: 10 168

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001101
news@sfere.anjou.terraraq.org.uk001001
us-control@lists.killfile.org000100
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 4 25611 7490 17225 896 29%45:52:56
2news-out.aioe.org 3 13655 5605 8039 11 41%24:21:47
3news.nntp4.net 1 16059 510 14141 1408 3%24:21:15
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 9 55325 13605 39405 2315 24%94:35:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net26.9 MB0.0 KB1.5 MB28.5 MB 94%3.5 KB
2news-out.aioe.org15.1 MB0.0 KB18.6 KB15.2 MB 99%2.8 KB
3news.nntp4.net1.6 MB0.0 KB10.7 MB12.3 MB 12%6.6 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 443.6 MB0.0 KB12.3 MB55.9 MB 78%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 30 15:00:05 - 15:59:59 802 5.9% 0.222.2 MB 5.1% 0.63
Nov 30 16:00:00 - 16:59:59 753 5.6% 0.212.3 MB 5.4% 0.66
Nov 30 17:00:00 - 17:59:59 761 5.6% 0.212.7 MB 6.3% 0.77
Nov 30 18:00:00 - 18:59:59 736 5.4% 0.202.7 MB 6.2% 0.77
Nov 30 19:00:00 - 19:59:59 739 5.4% 0.212.6 MB 6.0% 0.73
Nov 30 20:00:00 - 20:59:59 653 4.8% 0.182.3 MB 5.2% 0.64
Nov 30 21:00:00 - 21:59:59 687 5.1% 0.192.3 MB 5.3% 0.66
Nov 30 22:00:00 - 22:59:59 619 4.6% 0.172.1 MB 4.9% 0.60
Nov 30 23:00:00 - 23:59:59 495 3.6% 0.141.6 MB 3.8% 0.46
Dec 1 00:00:00 - 00:59:59 365 2.7% 0.101.3 MB 3.0% 0.37
Dec 1 01:00:00 - 01:59:59 337 2.5% 0.091.4 MB 3.1% 0.39
Dec 1 02:00:00 - 02:59:59 274 2.0% 0.081.1 MB 2.6% 0.32
Dec 1 03:00:00 - 03:59:59 266 2.0% 0.07837.7 KB 1.9% 0.23
Dec 1 04:00:00 - 04:59:59 383 2.8% 0.11918.2 KB 2.1% 0.26
Dec 1 05:00:00 - 05:59:59 309 2.3% 0.091.0 MB 2.4% 0.29
Dec 1 06:00:00 - 06:59:59 375 2.8% 0.101.2 MB 2.8% 0.34
Dec 1 07:00:00 - 07:59:59 485 3.6% 0.131.6 MB 3.8% 0.47
Dec 1 08:00:00 - 08:59:59 568 4.2% 0.161.8 MB 4.0% 0.50
Dec 1 09:00:00 - 09:59:59 679 5.0% 0.191.8 MB 4.1% 0.51
Dec 1 10:00:00 - 10:59:59 610 4.5% 0.171.5 MB 3.4% 0.41
Dec 1 11:00:00 - 11:59:59 698 5.1% 0.192.1 MB 4.9% 0.60
Dec 1 12:00:00 - 12:59:59 632 4.7% 0.181.7 MB 4.0% 0.49
Dec 1 13:00:00 - 13:59:59 620 4.6% 0.172.2 MB 5.1% 0.63
Dec 1 14:00:00 - 15:00:02 716 5.3% 0.202.0 MB 4.7% 0.58
TOTAL: 23:59:57 13562 100.0% 0.1643.4 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB259.0 MB 25.3% 4 0.21 58.24
ONEDEFAULT1024.0 MB422.1 MB 41.2% 6 0.21 57.62
THREEDEFAULT1024.0 MB260.6 MB 25.4% 4 0.21 58.51
TWODEFAULT1024.0 MB256.1 MB 25.0% 4 0.21 57.32
TOTAL: 4-4.0 GB1.2 GB 29.2% 18 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1341 9 0 0 1 0 0 0 1331
2hasname-out.news.weretis.net 1073 3 0 0 0 0 0 0 1070
3news-out.aioe.org 53 4 0 0 0 0 0 0 49
TOTAL: 3 2467 16 0 0 1 0 0 0 2450

Unwanted newsgroups [Top 20]:

NewsgroupCount
comp.infosystems.gemini 6
alt.religion.animism-global 2
alt.business.ads 1
alt.biz 1
biz.misc 1
alt.tv.twilight.zone 1
alt.test.1 1
alt.support.chronic.pain 1
de.alt.fan.konsumterror 1
alt.math 1
TOTAL: 10 16

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) 1587
EMP (md5) 483
EMP (phn nph) 96
User-issued spam cancel 40
EMP (phl) 29
Binary: misplaced binary 9
Scoring filter 1
HTML Multipart 1
Too many newsgroups 1
TOTAL: 9 2247

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 159
news-out.aioe.org 42
news.nntp4.net 2
TOTAL: 3 203
TOTAL: 1 203

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 429 429 0 0 0 0100%20:15:29
2aioe 8690 13 7898 1 0 1 0%23:59:54
3weretis 6069 1 5961 47 0 0 0%23:59:44
4nntp4 13836 0 13058 1 0 0 0%23:59:54
TOTAL: 4 29024 443 26917 49 0 1 1%92:15:01
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.0 MB0.0 KB2.0 MB0.0 KB/s4.8 KB20:15:29
2aioe53.8 KB2.8 KB56.6 KB0.0 KB/s4.0 KB23:59:54
3weretis6.6 KB340.3 KB346.9 KB0.0 KB/s7.2 KB23:59:44
4nntp40.0 KB6.1 KB6.1 KB0.0 KB/s6.1 KB23:59:54
TOTAL: 42.1 MB349.2 KB2.4 MB0.0 KB/s5.0 KB92:15:01
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ec2-44-233-220-49.us-west-2.compute.amazonaws.com 0.002 0.001 0.00000:00:00
104.152.52.140 0.002 0.002 0.00000:00:00
TOTAL: 2 0.004 0.003 0.00000:00:00

NNRP no permission clients:

SystemConn
104.152.52.140 1
ec2-44-233-220-49.us-west-2.compute.amazonaws.com 1
TOTAL: 2 2