Daily Usenet report

Sep 27 15:00:02 -- Sep 28 15:00:04

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 27 15:01:13 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 15509 75.0%1.9 MB 72.8%
innd 3400 16.4%465.4 KB 17.8%
innfeed 1193 5.8%161.7 KB 6.2%
cnfsstat 576 2.8%83.4 KB 3.2%
nnrpd 9 0.0%0.9 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
overchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 20689 100.0%2.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 41406 44.2%
Positive hits 37141 39.7%
Do not exist 15029 16.1%
Cache misses 18 0.0%
TOTAL: 4 93594 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.481 0.0%64 0.000 7.516 41.571
article cleanup00:00:00.095 0.0%15164 0.000 0.006 0.044
article logging00:00:00.423 0.0%15446 0.000 0.027 0.086
article parse00:00:00.305 0.0%29284 0.000 0.010 0.049
article write00:00:00.753 0.0%13286 0.000 0.057 0.667
artlog/artcncl00:00:00.000 0.0%54 0.000 0.000 0.000
data move00:00:00.066 0.0%106170 0.000 0.001 0.005
hisgrep/artcncl00:00:00.001 0.0%64 0.000 0.016 1.000
hishave/artcncl00:00:00.009 0.0%64 0.000 0.141 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:16.489 0.2%94462 0.001 1.445 41.961
history sync00:00:00.011 0.0%382 0.000 0.029 0.500
history write00:00:01.052 0.0%15164 0.000 0.069 1.993
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:06.942 99.8%105349 419.941 819.058 3972.159
nntp read00:00:00.790 0.0%105628 0.000 0.007 0.022
overview write00:00:00.048 0.0%13286 0.000 0.004 0.032
perl filter00:00:17.825 0.0%15164 0.885 1.175 4.661
python filter00:00:00.439 0.0%15164 0.000 0.029 0.103
site send00:00:02.291 0.0%39858 0.018 0.057 0.111
TOTAL: 24:01:01.19224:00:48.020100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.018 0.0%13241 0.000 0.001 0.029
article prepare00:00:00.000 0.0%838 0.000 0.000 0.000
article read00:00:00.021 0.0%652 0.000 0.032 1.000
backlog stats00:00:00.045 0.0%72223 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.332 0.0%43482 0.000 0.008 0.033
data write00:00:00.886 0.0%30359 0.000 0.029 0.078
idle23:57:28.431100.0%72223 703.039 1194.196 3657.977
status file00:00:00.441 0.0%212 0.000 2.080 47.125
TOTAL: 23:57:32.01223:57:30.174100.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:00.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 5 26132 9762 15609 761 37%47:44:29
2news-out.aioe.org 3 11411 2742 8668 1 24%21:55:07
3news.nntp4.net 1 15648 747 13693 1208 4%24:43:49
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 10 53191 13251 37970 1970 24%94:23:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net30.5 MB0.0 KB1.8 MB32.3 MB 94%3.1 KB
2news-out.aioe.org7.0 MB0.0 KB1.2 KB7.0 MB 99%2.6 KB
3news.nntp4.net2.3 MB0.0 KB10.7 MB12.9 MB 17%6.8 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 439.7 MB0.0 KB12.5 MB52.2 MB 76%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 27 15:00:02 - 15:59:59 793 6.0% 0.222.7 MB 6.8% 0.77
Sep 27 16:00:00 - 16:59:59 777 5.9% 0.222.1 MB 5.3% 0.60
Sep 27 17:00:00 - 17:59:59 750 5.7% 0.212.6 MB 6.5% 0.74
Sep 27 18:00:00 - 18:59:59 711 5.4% 0.202.3 MB 5.8% 0.66
Sep 27 19:00:00 - 19:59:59 731 5.5% 0.202.4 MB 6.0% 0.68
Sep 27 20:00:00 - 20:59:59 692 5.2% 0.192.1 MB 5.3% 0.60
Sep 27 21:00:00 - 21:59:59 636 4.8% 0.182.0 MB 5.0% 0.57
Sep 27 22:00:00 - 22:59:59 473 3.6% 0.131.2 MB 3.0% 0.35
Sep 27 23:00:00 - 23:59:59 392 3.0% 0.111.5 MB 3.7% 0.42
Sep 28 00:00:00 - 00:59:59 307 2.3% 0.091.0 MB 2.6% 0.30
Sep 28 01:00:00 - 01:59:59 273 2.1% 0.081.3 MB 3.1% 0.36
Sep 28 02:00:00 - 02:59:59 235 1.8% 0.07619.1 KB 1.5% 0.17
Sep 28 03:00:00 - 03:59:59 211 1.6% 0.06675.8 KB 1.7% 0.19
Sep 28 04:00:00 - 04:59:59 202 1.5% 0.06583.8 KB 1.4% 0.16
Sep 28 05:00:00 - 05:59:59 304 2.3% 0.08874.9 KB 2.1% 0.24
Sep 28 06:00:00 - 06:59:59 481 3.6% 0.131.5 MB 3.8% 0.43
Sep 28 07:00:00 - 07:59:59 602 4.5% 0.171.8 MB 4.6% 0.52
Sep 28 08:00:00 - 08:59:59 698 5.3% 0.191.8 MB 4.4% 0.50
Sep 28 09:00:00 - 09:59:59 618 4.7% 0.171.6 MB 4.1% 0.47
Sep 28 10:00:00 - 10:59:59 641 4.8% 0.181.6 MB 4.0% 0.45
Sep 28 11:00:00 - 11:59:59 619 4.7% 0.171.8 MB 4.6% 0.52
Sep 28 12:00:00 - 12:59:59 693 5.2% 0.191.9 MB 4.7% 0.53
Sep 28 13:00:00 - 13:59:59 717 5.4% 0.202.0 MB 5.0% 0.57
Sep 28 14:00:00 - 14:59:59 706 5.3% 0.201.9 MB 4.8% 0.54
Sep 28 15:00:00 - 15:00:04 8 0.1% 2.0032.2 KB 0.1% 8.05
TOTAL: 24:00:02 13270 100.0% 0.1539.9 MB 100.0% 0.47
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB199.1 MB 19.4% 3 0.20 61.78
ONEDEFAULT1024.0 MB361.2 MB 35.3% 5 0.20 60.86
THREEDEFAULT1024.0 MB202.4 MB 19.8% 3 0.20 61.52
TWODEFAULT1024.0 MB196.8 MB 19.2% 3 0.20 61.67
TOTAL: 4-4.0 GB959.5 MB 23.4% 14 0.20-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1134 11 0 0 2 0 0 0 1121
2hasname-out.news.weretis.net 1018 5 0 0 0 0 0 0 1013
3news-out.aioe.org 32 0 0 0 0 0 0 0 32
TOTAL: 3 2184 16 0 0 2 0 0 0 2166

Unwanted newsgroups [Top 20]:

NewsgroupCount
newsreader.test 3
alt.bestjobsusa.jobs.offered 2
panix.test 2
alt.bestjobsusa.philly.jobs 2
mozilla.dev.apps.seamonkey 1
alt.entrepreneurs 1
alt.biz.misc 1
sybase.public.powerbuilder.general 1
0.test 1
alt.fun 1
alt.blah 1
TOTAL: 11 16

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

GroupsCount
bit.listserv.catholic 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 1093
EMP (md5) 615
EMP (phn nph) 149
User-issued spam cancel 13
EMP (phl) 7
Binary: misplaced binary 5
HTML post 2
HTML Multipart 1
Scoring filter 1
TOTAL: 9 1886

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 245
news-out.aioe.org 31
news.nntp4.net 4
TOTAL: 3 280
TOTAL: 1 280

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 590 590 0 0 0 0100%22:03:24
2aioe 10707 39 8576 0 0 1990 0%24:09:55
3nntp4 15074 0 12573 0 0 0 0%24:00:50
4weretis 3476 0 3301 24 0 0 0%24:03:58
TOTAL: 4 29847 629 24450 24 0 1990 2%94:18:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.4 MB0.0 KB2.4 MB0.0 KB/s4.2 KB22:03:24
2aioe218.5 KB0.0 KB218.5 KB0.0 KB/s5.6 KB24:09:55
3nntp40.0 KB0.0 KB0.0 KB0.0 KB/s024:00:50
4weretis0.0 KB104.7 KB104.7 KB0.0 KB/s4.4 KB24:03:58
TOTAL: 42.6 MB104.7 KB2.7 MB0.0 KB/s4.2 KB94:18:07
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.001 0.002 0.00000:00:00
167.94.138.114 0.001 0.002 0.00000:00:00
TOTAL: 2 0.002 0.004 0.00000:00:00

NNRP no permission clients:

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