Daily Usenet report

Jul 16 15:00:10 -- Jul 17 15:00:11

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jul 16 15:12:37 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 14577 77.3%1.8 MB 75.1%
innd 2518 13.3%352.2 KB 14.7%
innfeed 1182 6.3%165.3 KB 6.9%
cnfsstat 576 3.1%78.7 KB 3.3%
nnrpd 9 0.0%1.0 KB 0.0%
controlchan 3 0.0%0.2 KB 0.0%
TOTAL: 6 18865 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 45955 48.0%
Positive hits 35701 37.3%
Do not exist 14077 14.7%
Cache misses 23 0.0%
TOTAL: 4 95756 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:06.807 0.0%41 0.000 166.024 623.000
article cleanup00:00:00.081 0.0%14231 0.000 0.006 0.038
article logging00:00:00.495 0.0%14447 0.000 0.034 1.052
article parse00:00:00.251 0.0%26749 0.000 0.009 0.037
article write00:00:11.986 0.0%13334 0.000 0.899 35.145
artlog/artcncl00:00:00.001 0.0%40 0.000 0.025 0.333
data move00:00:00.059 0.0%104881 0.000 0.001 0.005
hisgrep/artcncl00:00:00.000 0.0%38 0.000 0.000 0.000
hishave/artcncl00:00:02.076 0.0%41 0.000 50.634 381.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:19:05.880 1.3%96746 0.000 11.844 56.845
history sync00:00:00.016 0.0%396 0.000 0.040 0.500
history write00:00:16.887 0.0%14226 0.000 1.187 16.490
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:19:42.786 98.5%100929 397.553 832.098 2126.176
nntp read00:00:00.666 0.0%105796 0.000 0.006 0.017
overview write00:00:00.047 0.0%13334 0.000 0.004 0.031
perl filter00:00:26.979 0.0%14226 0.842 1.896 20.366
python filter00:00:00.367 0.0%14226 0.000 0.026 0.085
site send00:00:02.374 0.0%40002 0.020 0.059 0.107
TOTAL: 23:41:03.50123:39:57.758 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%13385 0.000 0.002 0.022
article prepare00:00:00.001 0.0%845 0.000 0.001 0.062
article read00:00:00.108 0.0%692 0.000 0.156 6.571
backlog stats00:00:00.038 0.0%62067 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.323 0.0%41628 0.000 0.008 0.038
data write00:00:00.734 0.0%28448 0.000 0.026 0.099
idle23:48:30.801100.0%62067 751.029 1380.940 3131.923
status file00:00:04.950 0.0%227 0.000 21.806 594.000
TOTAL: 23:48:40.97823:48:36.979100.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%2 0.000 0.000 0.000
TOTAL: 00:00:01.62700:00:00.000 0.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 9 22328 8491 13701 136 38%43:22:16
2news-out.aioe.org 3 11429 3110 8242 77 27%22:43:39
3news.nntp4.net 4 13828 1160 11995 673 8%23:12:10
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 17 47585 12761 33938 886 26%89:18:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net26.2 MB0.0 KB270.5 KB26.5 MB 99%3.1 KB
2news-out.aioe.org8.8 MB8.8 KB174.3 KB9.0 MB 98%2.9 KB
3news.nntp4.net3.9 MB0.0 KB4.7 MB8.6 MB 45%4.8 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 438.9 MB8.8 KB5.2 MB44.1 MB 88%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 16 15:00:10 - 15:59:59 720 5.4% 0.202.4 MB 5.9% 0.69
Jul 16 16:00:00 - 16:59:59 831 6.2% 0.232.3 MB 5.6% 0.66
Jul 16 17:00:00 - 17:59:59 733 5.5% 0.202.3 MB 5.7% 0.67
Jul 16 18:00:00 - 18:59:59 678 5.1% 0.191.9 MB 4.8% 0.55
Jul 16 19:00:00 - 19:59:59 743 5.5% 0.212.6 MB 6.3% 0.74
Jul 16 20:00:00 - 20:59:59 625 4.7% 0.171.9 MB 4.7% 0.54
Jul 16 21:00:00 - 21:59:59 563 4.2% 0.161.9 MB 4.6% 0.54
Jul 16 22:00:00 - 22:59:59 603 4.5% 0.171.9 MB 4.7% 0.55
Jul 16 23:00:00 - 23:59:59 389 2.9% 0.111.4 MB 3.4% 0.40
Jul 17 00:00:00 - 00:59:59 434 3.2% 0.121.9 MB 4.6% 0.54
Jul 17 01:00:00 - 01:59:59 352 2.6% 0.101.6 MB 3.9% 0.45
Jul 17 02:00:00 - 02:59:59 258 1.9% 0.071.1 MB 2.6% 0.30
Jul 17 03:00:00 - 03:59:59 288 2.1% 0.081012.6 KB 2.4% 0.28
Jul 17 04:00:00 - 04:59:59 339 2.5% 0.091.1 MB 2.6% 0.30
Jul 17 05:00:00 - 05:59:59 327 2.4% 0.09988.7 KB 2.4% 0.27
Jul 17 06:00:00 - 06:59:59 414 3.1% 0.121.4 MB 3.4% 0.39
Jul 17 07:00:00 - 07:59:59 466 3.5% 0.131.2 MB 3.0% 0.35
Jul 17 08:00:00 - 08:59:59 572 4.3% 0.161.4 MB 3.5% 0.41
Jul 17 09:00:00 - 09:59:59 690 5.1% 0.191.6 MB 4.0% 0.47
Jul 17 10:00:00 - 10:59:59 660 4.9% 0.181.7 MB 4.1% 0.48
Jul 17 11:00:00 - 11:59:59 502 3.7% 0.141.3 MB 3.3% 0.38
Jul 17 12:00:00 - 12:59:59 733 5.5% 0.201.9 MB 4.6% 0.53
Jul 17 13:00:00 - 13:59:59 681 5.1% 0.191.7 MB 4.1% 0.48
Jul 17 14:00:00 - 14:59:59 814 6.1% 0.232.3 MB 5.6% 0.65
Jul 17 15:00:00 - 15:00:11 10 0.1% 0.9131.5 KB 0.1% 2.86
TOTAL: 24:00:01 13425 100.0% 0.1640.9 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB1004.5 MB 98.1% 1 0.21 58.99
ONEDEFAULT1024.0 MB142.8 MB 13.9% 4 0.21 59.00
THREEDEFAULT1024.0 MB1008.9 MB 98.5% 1 0.20 60.67
TWODEFAULT1024.0 MB1006.5 MB 98.3% 1 0.20 59.48
TOTAL: 4-4.0 GB3.1 GB 77.2% 7 0.20-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 723 7 0 0 1 0 0 0 715
2hasname-out.news.weretis.net 262 3 0 0 0 0 0 0 259
3news-out.aioe.org 127 0 0 5 0 0 0 0 122
TOTAL: 3 1112 10 0 5 1 0 0 0 1096

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.health.policy.drug-approval 3
panix.chat.politics 1
tw.k-12.primary.chinese 1
wolfsburg.party 1
mailing.postfix.users 1
alt.christian.word-of-faith 1
nanaimo.general 1
alt.cable-tv 1
TOTAL: 8 10

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 537
EMP (phn path) 268
EMP (phl) 40
HTML Multipart 13
Too many newsgroups 8
User-issued spam cancel 6
EMP (phn nph) 5
Binary: misplaced binary 2
Scoring filter 1
TOTAL: 9 880

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 114
news-out.aioe.org 57
news.nntp4.net 45
TOTAL: 3 216
TOTAL: 1 216

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 638 638 0 0 0 0100%19:58:06
2aioe 10329 11 10109 0 0 1 0%23:49:05
3weretis 4436 0 4313 40 0 1 0%23:49:05
4nntp4 12320 0 12150 0 0 1 0%23:49:05
TOTAL: 4 27723 649 26572 40 0 3 2%91:25:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.9 MB0.0 KB2.9 MB0.0 KB/s4.7 KB19:58:06
2aioe42.0 KB0.0 KB42.0 KB0.0 KB/s3.8 KB23:49:05
3weretis0.0 KB348.6 KB348.6 KB0.0 KB/s8.7 KB23:49:05
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:49:05
TOTAL: 42.9 MB348.6 KB3.3 MB0.0 KB/s4.9 KB91:25:21
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.003 0.001 0.00000:00:01
188.166.46.115 0.000 0.003 0.00000:00:00
TOTAL: 2 0.003 0.004 0.00000:00:01

NNRP no permission clients:

SystemConn
news.nntp4.net 1
188.166.46.115 1
TOTAL: 2 2