Daily Usenet report

Nov 3 15:00:02 -- Nov 4 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 3 15:01:07 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 16676 76.1%2.0 MB 73.7%
innd 3399 15.5%468.9 KB 16.9%
innfeed 1248 5.7%169.9 KB 6.1%
cnfsstat 576 2.6%88.6 KB 3.2%
nnrpd 17 0.1%1.9 KB 0.1%
overchan 1 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 21918 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 42753 42.7%
Positive hits 41119 41.1%
Do not exist 16219 16.2%
Cache misses 46 0.0%
TOTAL: 4 100137 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.999 0.0%49 0.000 40.796 216.000
article cleanup00:00:00.107 0.0%16304 0.000 0.007 0.050
article logging00:00:00.470 0.0%16622 0.000 0.028 0.107
article parse00:00:00.242 0.0%29214 0.000 0.008 0.045
article write00:00:02.044 0.0%14321 0.000 0.143 3.991
artlog/artcncl00:00:00.004 0.0%49 0.000 0.082 1.000
data move00:00:00.057 0.0%109066 0.000 0.001 0.005
hisgrep/artcncl00:00:00.001 0.0%47 0.000 0.021 1.000
hishave/artcncl00:00:00.008 0.0%49 0.000 0.163 3.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:21.968 0.0%100646 0.000 0.218 5.941
history sync00:00:00.016 0.0%344 0.000 0.047 1.500
history write00:00:02.609 0.0%16304 0.000 0.160 15.892
hiswrite/artcncl00:00:00.001 0.0%2 0.000 0.500 1.000
idle23:59:29.395 99.9%109921 203.022 785.741 3660.780
nntp read00:00:00.852 0.0%109925 0.000 0.008 0.024
overview write00:00:00.057 0.0%14321 0.000 0.004 0.030
perl filter00:00:19.165 0.0%16304 0.721 1.175 16.739
python filter00:00:00.401 0.0%16304 0.000 0.025 0.071
site send00:00:02.590 0.0%42963 0.031 0.060 0.111
TOTAL: 24:00:41.31724:00:21.986100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.040 0.0%14286 0.000 0.003 0.024
article prepare00:00:00.000 0.0%1054 0.000 0.000 0.000
article read00:00:00.018 0.0%567 0.000 0.032 1.000
backlog stats00:00:00.049 0.0%78210 0.000 0.001 0.013
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.378 0.0%48340 0.000 0.008 0.022
data write00:00:01.026 0.0%34257 0.000 0.030 0.078
idle23:56:45.899100.0%78210 383.941 1102.236 4804.832
status file00:00:04.730 0.0%249 0.000 18.996 932.600
TOTAL: 23:56:54.19723:56:52.140100.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%4 0.000 0.250 1.000
TOTAL: 00:00:01.41500: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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 7 27742 9874 17327 541 35%48:44:55
2news-out.aioe.org 3 14576 4202 10370 4 28%24:57:03
3news.nntp4.net 2 16950 526 14912 1512 3%24:58:04
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 13 59268 14602 42609 2057 24%98:40:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net30.9 MB0.0 KB925.2 KB31.8 MB 97%3.1 KB
2news-out.aioe.org10.7 MB0.0 KB5.1 KB10.7 MB 99%2.6 KB
3news.nntp4.net1.8 MB0.0 KB5.0 MB6.8 MB 26%3.4 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 443.4 MB0.0 KB5.9 MB49.2 MB 88%3.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 3 15:00:02 - 15:59:59 655 4.6% 0.182.1 MB 4.8% 0.59
Nov 3 16:00:00 - 16:59:59 804 5.6% 0.222.2 MB 5.2% 0.64
Nov 3 17:00:00 - 17:59:59 1083 7.6% 0.303.2 MB 7.5% 0.91
Nov 3 18:00:00 - 18:59:59 799 5.6% 0.222.2 MB 5.2% 0.63
Nov 3 19:00:00 - 19:59:59 724 5.1% 0.202.0 MB 4.6% 0.56
Nov 3 20:00:00 - 20:59:59 708 4.9% 0.201.9 MB 4.5% 0.55
Nov 3 21:00:00 - 21:59:59 788 5.5% 0.222.1 MB 4.8% 0.59
Nov 3 22:00:00 - 22:59:59 651 4.5% 0.182.0 MB 4.7% 0.57
Nov 3 23:00:00 - 23:59:59 517 3.6% 0.142.3 MB 5.3% 0.64
Nov 4 00:00:00 - 00:59:59 335 2.3% 0.091.2 MB 2.7% 0.33
Nov 4 01:00:00 - 01:59:59 303 2.1% 0.08950.4 KB 2.2% 0.26
Nov 4 02:00:00 - 02:59:59 274 1.9% 0.081.1 MB 2.7% 0.32
Nov 4 03:00:00 - 03:59:59 191 1.3% 0.05667.6 KB 1.5% 0.19
Nov 4 04:00:00 - 04:59:59 199 1.4% 0.06643.6 KB 1.5% 0.18
Nov 4 05:00:00 - 05:59:59 314 2.2% 0.091.1 MB 2.5% 0.30
Nov 4 06:00:00 - 06:59:59 407 2.8% 0.111.2 MB 2.8% 0.34
Nov 4 07:00:00 - 07:59:59 551 3.8% 0.151.5 MB 3.6% 0.44
Nov 4 08:00:00 - 08:59:59 591 4.1% 0.161.7 MB 4.0% 0.48
Nov 4 09:00:00 - 09:59:59 697 4.9% 0.191.9 MB 4.5% 0.55
Nov 4 10:00:00 - 10:59:59 733 5.1% 0.202.1 MB 4.9% 0.60
Nov 4 11:00:00 - 11:59:59 762 5.3% 0.212.1 MB 5.0% 0.60
Nov 4 12:00:00 - 12:59:59 724 5.1% 0.202.1 MB 5.0% 0.61
Nov 4 13:00:00 - 13:59:59 707 4.9% 0.201.9 MB 4.4% 0.54
Nov 4 14:00:00 - 14:59:59 803 5.6% 0.222.5 MB 6.0% 0.72
Nov 4 15:00:00 - 15:00:02 1 0.0% 0.501.3 KB 0.0% 0.63
TOTAL: 24:00:00 14321 100.0% 0.1742.7 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB831.7 MB 81.2% 3 0.21 57.42
ONEDEFAULT1024.0 MB993.7 MB 97.0% 5 0.21 56.75
THREEDEFAULT1024.0 MB835.0 MB 81.5% 3 0.21 57.55
TWODEFAULT1024.0 MB828.7 MB 80.9% 3 0.22 55.69
TOTAL: 4-4.0 GB3.4 GB 85.2% 14 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1451 7 0 0 1 0 0 0 1443
2hasname-out.news.weretis.net 798 4 0 0 0 0 0 0 794
3news-out.aioe.org 57 2 0 0 0 0 0 0 55
TOTAL: 3 2306 13 0 0 1 0 0 0 2292

Unwanted newsgroups [Top 20]:

NewsgroupCount
comp.infosystems.gemini 4
list.postfix.users 1
alt.penthouse.sex.first-time 1
panix.chat.politics 1
0.test 1
alt.bestjobsusa.philly.jobs 1
panix.test 1
alt.biz 1
alt.bestjobsusa.jobs.offered 1
alt.math 1
TOTAL: 10 13

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 896
EMP (phn path) 826
EMP (phn nph) 133
User-issued spam cancel 59
Too many newsgroups 30
EMP (phl) 20
Scoring filter 5
Too many newsgroups (meow) 4
HTML Multipart 1
TOTAL: 9 1974

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 408 408 0 0 0 0100%20:11:59
2aioe 12336 76 10129 1 0 0 0%23:59:50
3weretis 4969 3 4413 79 0 0 0%23:59:15
4nntp4 16008 3 13807 0 0 0 0%23:59:50
TOTAL: 4 33721 490 28349 80 0 0 1%92:10:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.5 MB0.0 KB1.5 MB0.0 KB/s3.7 KB20:11:59
2aioe409.3 KB4.6 KB413.9 KB0.0 KB/s5.4 KB23:59:50
3nntp412.7 KB0.0 KB12.7 KB0.0 KB/s4.2 KB23:59:50
4weretis6.1 KB314.7 KB320.8 KB0.0 KB/s3.9 KB23:59:15
TOTAL: 41.9 MB319.3 KB2.2 MB0.0 KB/s3.9 KB92:10:54
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.003 0.005 0.00000:00:01
23.129.64.174 0.000 0.002 0.00000:00:00
TOTAL: 2 0.003 0.007 0.00000:00:01

NNRP no permission clients:

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