Daily Usenet report

Dec 16 15:00:02 -- Dec 17 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 16 15:01:28 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 16332 73.8%1.9 MB 71.5%
innd 4054 18.3%545.9 KB 19.6%
innfeed 1145 5.2%157.1 KB 5.7%
cnfsstat 576 2.6%87.4 KB 3.1%
nnrpd 17 0.1%1.8 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 22125 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 44899 44.6%
Positive hits 39915 39.7%
Do not exist 15783 15.7%
Cache misses 36 0.0%
TOTAL: 4 100633 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.130 0.0%66 0.000 62.576 315.250
article cleanup00:00:00.092 0.0%15852 0.000 0.006 0.062
article logging00:00:00.462 0.0%16284 0.000 0.028 0.154
article parse00:00:00.265 0.0%31297 0.000 0.008 0.048
article write00:00:04.295 0.0%13369 0.000 0.321 29.869
artlog/artcncl00:00:00.001 0.0%64 0.000 0.016 0.083
data move00:00:00.051 0.0%114324 0.000 0.000 0.003
hisgrep/artcncl00:00:00.002 0.0%63 0.000 0.032 2.000
hishave/artcncl00:00:00.786 0.0%66 0.000 11.909 64.833
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:11.782 0.0%100891 0.000 0.117 4.835
history sync00:00:00.010 0.0%363 0.000 0.028 0.500
history write00:00:03.876 0.0%15852 0.000 0.245 21.076
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:59:53.570 99.9%114487 429.532 754.615 2831.547
nntp read00:00:01.004 0.0%114462 0.000 0.009 0.024
overview write00:00:00.041 0.0%13369 0.000 0.003 0.023
perl filter00:00:16.797 0.0%15852 0.810 1.060 3.825
python filter00:00:00.416 0.0%15852 0.000 0.026 0.111
site send00:00:02.304 0.0%40107 0.024 0.057 0.098
TOTAL: 24:00:56.83324:00:39.884100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%13350 0.000 0.002 0.024
article prepare00:00:00.000 0.0%1045 0.000 0.000 0.000
article read00:00:00.026 0.0%643 0.000 0.040 0.500
backlog stats00:00:00.047 0.0%77557 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.370 0.0%46695 0.000 0.008 0.028
data write00:00:01.007 0.0%33539 0.000 0.030 0.116
idle23:58:24.754100.0%77557 631.250 1112.791 3239.629
status file00:00:00.806 0.0%210 0.000 3.838 757.000
TOTAL: 23:58:28.91823:58:27.033100.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%4 0.000 0.000 0.000
TOTAL: 00:00:01.55400: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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 6 26723 7613 18156 954 28%47:57:14
2news-out.aioe.org 3 12908 4787 8114 7 37%23:43:16
3news.nntp4.net 30 15450 784 13154 1512 5%23:45:58
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 40 55081 13184 39424 2473 23%95:26:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net23.7 MB0.0 KB1.7 MB25.4 MB 93%3.0 KB
2news-out.aioe.org12.6 MB0.0 KB13.0 KB12.6 MB 99%2.7 KB
3news.nntp4.net2.6 MB0.0 KB8.2 MB10.9 MB 24%4.8 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 438.9 MB0.0 KB10.0 MB48.8 MB 79%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 16 15:00:02 - 15:59:59 747 5.6% 0.212.2 MB 5.7% 0.64
Dec 16 16:00:00 - 16:59:59 862 6.4% 0.242.5 MB 6.2% 0.70
Dec 16 17:00:00 - 17:59:59 770 5.8% 0.212.5 MB 6.4% 0.71
Dec 16 18:00:00 - 18:59:59 659 4.9% 0.182.0 MB 5.0% 0.56
Dec 16 19:00:00 - 19:59:59 718 5.4% 0.201.8 MB 4.5% 0.51
Dec 16 20:00:00 - 20:59:59 600 4.5% 0.171.8 MB 4.7% 0.52
Dec 16 21:00:00 - 21:59:59 741 5.5% 0.212.2 MB 5.7% 0.63
Dec 16 22:00:00 - 22:59:59 541 4.0% 0.151.5 MB 3.8% 0.43
Dec 16 23:00:00 - 23:59:59 510 3.8% 0.142.4 MB 6.0% 0.67
Dec 17 00:00:00 - 00:59:59 487 3.6% 0.141.6 MB 4.2% 0.47
Dec 17 01:00:00 - 01:59:59 362 2.7% 0.101.2 MB 2.9% 0.33
Dec 17 02:00:00 - 02:59:59 242 1.8% 0.07951.8 KB 2.4% 0.26
Dec 17 03:00:00 - 03:59:59 209 1.6% 0.06639.8 KB 1.6% 0.18
Dec 17 04:00:00 - 04:59:59 301 2.3% 0.081.2 MB 3.0% 0.33
Dec 17 05:00:00 - 05:59:59 301 2.3% 0.08884.2 KB 2.2% 0.25
Dec 17 06:00:00 - 06:59:59 272 2.0% 0.08832.9 KB 2.1% 0.23
Dec 17 07:00:00 - 07:59:59 402 3.0% 0.111.1 MB 2.7% 0.30
Dec 17 08:00:00 - 08:59:59 639 4.8% 0.181.6 MB 4.1% 0.46
Dec 17 09:00:00 - 09:59:59 706 5.3% 0.201.8 MB 4.6% 0.52
Dec 17 10:00:00 - 10:59:59 754 5.6% 0.211.8 MB 4.4% 0.50
Dec 17 11:00:00 - 11:59:59 637 4.8% 0.181.7 MB 4.2% 0.48
Dec 17 12:00:00 - 12:59:59 520 3.9% 0.141.6 MB 3.9% 0.44
Dec 17 13:00:00 - 13:59:59 631 4.7% 0.181.9 MB 4.8% 0.54
Dec 17 14:00:00 - 14:59:59 754 5.6% 0.212.0 MB 5.0% 0.56
Dec 17 15:00:00 - 15:00:02 2 0.0% 1.007.0 KB 0.0% 3.50
TOTAL: 24:00:00 13367 100.0% 0.1539.4 MB 100.0% 0.47
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB538.1 MB 52.6% 4 0.19 62.50
ONEDEFAULT1024.0 MB701.5 MB 68.5% 6 0.20 60.42
THREEDEFAULT1024.0 MB544.2 MB 53.1% 4 0.20 61.22
TWODEFAULT1024.0 MB537.4 MB 52.5% 4 0.20 62.24
TOTAL: 4-4.0 GB2.3 GB 56.7% 18 0.20-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1516 6 0 0 1 0 0 0 1509
2hasname-out.news.weretis.net 1289 1 0 0 0 0 0 0 1288
3news-out.aioe.org 96 0 0 0 0 0 0 0 96
TOTAL: 3 2901 7 0 0 1 0 0 0 2893

Unwanted newsgroups [Top 20]:

NewsgroupCount
panix.chat.politics 2
zippo.test 1
can.forsale 1
alt.religion.christian.reformed 1
list.postfix.users 1
clari.web.local.missouri 1
TOTAL: 6 7

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) 1574
EMP (md5) 677
EMP (phn nph) 155
EMP (phl) 33
HTML Multipart 10
User-issued spam cancel 10
Too many newsgroups 1
HTML post 1
TOTAL: 8 2461

INND no permission servers:

SystemConn
5.188.206.2 1
80.66.76.21 1
TOTAL: 2 2

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 338
news-out.aioe.org 89
news.nntp4.net 5
TOTAL: 3 432
TOTAL: 1 432

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 518 518 0 0 0 0100%21:48:22
2aioe 11172 75 8253 8 0 0 0%23:50:00
3nntp4 15346 8 12523 1 0 0 0%23:55:19
4weretis 5643 0 5573 39 0 0 0%23:50:00
TOTAL: 4 32679 601 26349 48 0 0 1%93:23:41
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.8 MB0.0 KB1.8 MB0.0 KB/s3.6 KB21:48:22
2aioe350.8 KB59.2 KB410.0 KB0.0 KB/s4.9 KB23:50:00
3nntp418.2 KB7.3 KB25.5 KB0.0 KB/s2.8 KB23:55:19
4weretis0.0 KB119.7 KB119.7 KB0.0 KB/s3.1 KB23:50:00
TOTAL: 42.2 MB186.2 KB2.4 MB0.0 KB/s3.8 KB93:23:41
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.002 0.006 0.00000:00:01
80.66.76.21 0.000 0.003 0.00000:00:00
TOTAL: 2 0.002 0.009 0.00000:00:01

NNRP no permission clients:

SystemConn
news.nntp4.net 3
80.66.76.21 1
TOTAL: 2 4