Daily Usenet report

Jun 17 15:00:01 -- Jun 18 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jun 17 15:01:32 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 12273 72.9%1.5 MB 70.1%
innd 2766 16.4%388.6 KB 18.0%
innfeed 1209 7.2%169.2 KB 7.8%
cnfsstat 576 3.4%85.2 KB 4.0%
nnrpd 18 0.1%1.7 KB 0.1%
overchan 1 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 16844 100.0%2.1 MB100.0%

History cache:

ReasonCount%Count
Negative hits 35364 45.1%
Positive hits 31051 39.6%
Do not exist 12014 15.3%
Cache misses 22 0.0%
TOTAL: 4 78451 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.407 0.0%81 0.000 5.025 43.000
article cleanup00:00:00.097 0.0%12088 0.000 0.008 0.053
article logging00:00:00.418 0.0%12217 0.000 0.034 0.094
article parse00:00:00.241 0.0%26657 0.000 0.009 0.048
article write00:00:00.547 0.0%10768 0.000 0.051 0.125
artlog/artcncl00:00:00.001 0.0%78 0.000 0.013 0.500
data move00:00:00.063 0.0%90351 0.000 0.001 0.006
hisgrep/artcncl00:00:00.000 0.0%76 0.000 0.000 0.000
hishave/artcncl00:00:00.016 0.0%81 0.000 0.198 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:47.234 0.1%78874 0.000 0.599 7.057
history sync00:00:00.019 0.0%376 0.000 0.051 1.000
history write00:00:01.003 0.0%12088 0.000 0.083 5.468
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle23:59:32.767 99.9%91460 526.637 944.378 2819.620
nntp read00:00:00.703 0.0%91484 0.000 0.008 0.017
overview write00:00:00.040 0.0%10768 0.000 0.004 0.037
perl filter00:00:16.873 0.0%12088 0.958 1.396 13.049
python filter00:00:00.400 0.0%12088 0.000 0.033 0.094
site send00:00:02.199 0.0%32300 0.010 0.068 0.148
TOTAL: 24:00:53.30124:00:43.028100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.017 0.0%10735 0.000 0.002 0.024
article prepare00:00:00.000 0.0%674 0.000 0.000 0.000
article read00:00:00.205 0.0%442 0.000 0.464 13.846
backlog stats00:00:00.039 0.0%55279 0.000 0.001 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.265 0.0%34654 0.000 0.008 0.028
data write00:00:00.670 0.0%24089 0.000 0.028 0.065
idle23:58:42.536100.0%55279 919.733 1561.579 3822.732
status file00:00:00.098 0.0%240 0.000 0.408 22.000
TOTAL: 23:58:49.43623:58:43.830100.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:00.54900: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 20344 6620 13516 208 32%47:35:25
2news-out.aioe.org 3 10526 3831 6659 36 36%23:39:22
3news.nntp4.net 1 13308 120 12102 1086 0%25:48:43
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 10 44178 10571 32277 1330 23%97:03:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net22.0 MB0.0 KB452.5 KB22.5 MB 98%3.4 KB
2news-out.aioe.org10.4 MB0.0 KB45.6 KB10.4 MB 99%2.8 KB
3news.nntp4.net516.8 KB0.0 KB9.4 MB9.9 MB 5%8.4 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 432.9 MB0.0 KB9.9 MB42.8 MB 76%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 17 15:00:01 - 15:59:59 668 6.2% 0.192.0 MB 6.0% 0.57
Jun 17 16:00:00 - 16:59:59 667 6.2% 0.192.4 MB 7.1% 0.68
Jun 17 17:00:00 - 17:59:59 456 4.2% 0.131.3 MB 3.8% 0.37
Jun 17 18:00:00 - 18:59:59 604 5.6% 0.171.8 MB 5.3% 0.51
Jun 17 19:00:00 - 19:59:59 592 5.5% 0.162.0 MB 6.0% 0.58
Jun 17 20:00:00 - 20:59:59 579 5.4% 0.162.0 MB 6.0% 0.57
Jun 17 21:00:00 - 21:59:59 444 4.1% 0.121.5 MB 4.3% 0.41
Jun 17 22:00:00 - 22:59:59 332 3.1% 0.091012.9 KB 2.9% 0.28
Jun 17 23:00:00 - 23:59:59 263 2.4% 0.07954.4 KB 2.8% 0.27
Jun 18 00:00:00 - 00:59:59 256 2.4% 0.07802.6 KB 2.3% 0.22
Jun 18 01:00:00 - 01:59:59 229 2.1% 0.061.1 MB 3.3% 0.31
Jun 18 02:00:00 - 02:59:59 225 2.1% 0.06844.3 KB 2.4% 0.23
Jun 18 03:00:00 - 03:59:59 196 1.8% 0.05734.8 KB 2.1% 0.20
Jun 18 04:00:00 - 04:59:59 225 2.1% 0.06984.2 KB 2.9% 0.27
Jun 18 05:00:00 - 05:59:59 316 2.9% 0.09991.3 KB 2.9% 0.28
Jun 18 06:00:00 - 06:59:59 256 2.4% 0.07896.0 KB 2.6% 0.25
Jun 18 07:00:00 - 07:59:59 448 4.2% 0.121.4 MB 4.2% 0.40
Jun 18 08:00:00 - 08:59:59 584 5.4% 0.161.6 MB 4.7% 0.45
Jun 18 09:00:00 - 09:59:59 555 5.2% 0.151.4 MB 4.3% 0.41
Jun 18 10:00:00 - 10:59:59 571 5.3% 0.161.6 MB 4.7% 0.45
Jun 18 11:00:00 - 11:59:59 528 4.9% 0.151.5 MB 4.4% 0.42
Jun 18 12:00:00 - 12:59:59 603 5.6% 0.171.7 MB 5.2% 0.50
Jun 18 13:00:00 - 13:59:59 612 5.7% 0.171.7 MB 4.9% 0.47
Jun 18 14:00:00 - 14:59:59 539 5.0% 0.151.6 MB 4.8% 0.46
Jun 18 15:00:00 - 15:00:02 2 0.0% 1.007.0 KB 0.0% 3.50
TOTAL: 24:00:01 10750 100.0% 0.1233.7 MB 100.0% 0.40
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB438.5 MB 42.8% 7 0.16 74.28
ONEDEFAULT1024.0 MB614.5 MB 60.0% 9 0.17 71.26
THREEDEFAULT1024.0 MB450.0 MB 43.9% 7 0.16 74.66
TWODEFAULT1024.0 MB442.5 MB 43.2% 7 0.16 74.99
TOTAL: 4-4.0 GB1.9 GB 47.5% 30 0.16-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1066 26 0 0 1 0 0 0 1039
2hasname-out.news.weretis.net 311 6 0 0 0 0 0 0 305
3news-out.aioe.org 68 0 0 0 0 0 0 0 68
TOTAL: 3 1445 32 0 0 1 0 0 0 1412

Unwanted newsgroups [Top 20]:

NewsgroupCount
panix.chat.politics 12
intel.motherboards.pentium_ii 7
alt.religion.biblestudy 5
bofh.transport.public 4
aol.neighborhood.pa.jobs 1
aol.neighborhood.in.jobs 1
alt.test.1 1
wolfsburg.test 1
TOTAL: 8 32

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 633
EMP (phn path) 434
EMP (phn nph) 111
EMP (phl) 86
Scoring filter 11
HTML Multipart 8
TOTAL: 6 1283

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 97
news-out.aioe.org 32
TOTAL: 2 129
TOTAL: 1 129

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 366 366 0 0 0 0100%18:45:43
2aioe 7533 65 6596 3 0 0 0%23:59:54
3nntp4 11550 0 10637 0 0 0 0%23:59:54
4weretis 4158 0 3962 9 0 0 0%23:59:54
TOTAL: 4 23607 431 21195 12 0 0 1%90:45:25
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.0 MB0.0 KB2.0 MB0.0 KB/s5.6 KB18:45:43
2aioe205.4 KB9.6 KB215.0 KB0.0 KB/s3.2 KB23:59:54
3nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
4weretis0.0 KB51.2 KB51.2 KB0.0 KB/s5.7 KB23:59:54
TOTAL: 42.2 MB60.8 KB2.3 MB0.0 KB/s5.2 KB90:45:25
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
45.227.254.54 0.003 0.003 0.00000:00:00
192.241.202.81 0.000 0.003 0.00000:00:00
? 0.000 0.001 0.00000:00:00
TOTAL: 3 0.003 0.007 0.00000:00:00

NNRP no permission clients:

SystemConn
45.227.254.54 2
192.241.202.81 1
TOTAL: 2 3

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1