Daily Usenet report

Jul 13 15:00:03 -- Jul 14 15:00:10

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jul 13 15:07:49 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 16281 78.1%1.9 MB 75.5%
innd 2815 13.5%396.4 KB 15.0%
innfeed 1155 5.5%162.2 KB 6.1%
cnfsstat 576 2.8%84.8 KB 3.2%
nnrpd 22 0.1%2.0 KB 0.1%
overchan 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 20852 100.0%2.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 50090 47.1%
Positive hits 40456 38.1%
Do not exist 15718 14.8%
Cache misses 29 0.0%
TOTAL: 4 106293 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.305 0.0%46 0.000 93.587 780.000
article cleanup00:00:00.091 0.0%15938 0.000 0.006 0.050
article logging00:00:00.505 0.0%16246 0.000 0.031 0.130
article parse00:00:00.265 0.0%30935 0.000 0.009 0.028
article write00:00:07.312 0.0%14615 0.000 0.500 33.905
artlog/artcncl00:00:00.001 0.0%45 0.000 0.022 0.125
data move00:00:00.058 0.0%120439 0.000 0.000 0.003
hisgrep/artcncl00:00:00.002 0.0%46 0.000 0.043 0.500
hishave/artcncl00:00:00.878 0.0%46 0.000 19.087 677.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:39.932 0.2%107822 0.001 1.483 11.830
history sync00:00:00.193 0.0%368 0.000 0.524 89.500
history write00:00:09.602 0.0%15934 0.000 0.603 11.397
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:33.907 99.7%118888 408.911 725.001 1841.748
nntp read00:00:00.797 0.0%119736 0.000 0.007 0.016
overview write00:00:00.055 0.0%14615 0.000 0.004 0.043
perl filter00:00:34.167 0.0%15934 0.887 2.144 15.483
python filter00:00:00.468 0.0%15934 0.000 0.029 0.078
site send00:00:02.931 0.0%43845 0.029 0.067 0.110
TOTAL: 24:00:54.11824:00:15.469100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.032 0.0%14583 0.000 0.002 0.023
article prepare00:00:00.001 0.0%832 0.000 0.001 0.167
article read00:00:01.328 0.0%730 0.000 1.819 188.000
backlog stats00:00:00.055 0.0%68399 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.406 0.0%45795 0.000 0.009 0.030
data write00:00:00.831 0.0%31338 0.000 0.027 0.070
idle23:58:56.915100.0%68399 733.961 1262.254 2900.324
status file00:00:03.519 0.0%202 0.000 17.421 477.500
TOTAL: 23:59:05.20223:59:03.087100.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.0%5 0.000 0.200 1.000
TOTAL: 00:00:05.48200:00:00.001 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 3 29268 9019 20062 187 30%50:05:32
2news-out.aioe.org 3 13268 4417 8745 106 33%23:43:54
3news.nntp4.net 3 15770 1275 13455 1040 8%24:20:35
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 10 58306 14711 42262 1333 25%98:10:01
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net27.9 MB4.8 KB361.0 KB28.2 MB 98%3.1 KB
2news-out.aioe.org11.7 MB0.0 KB221.6 KB11.9 MB 98%2.7 KB
3news.nntp4.net3.3 MB2.5 KB6.6 MB9.9 MB 33%4.4 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 442.8 MB7.4 KB7.2 MB50.0 MB 85%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 13 15:00:03 - 15:59:59 848 5.8% 0.242.6 MB 6.1% 0.74
Jul 13 16:00:00 - 16:59:59 970 6.6% 0.272.8 MB 6.6% 0.79
Jul 13 17:00:00 - 17:59:59 847 5.8% 0.242.6 MB 6.1% 0.74
Jul 13 18:00:00 - 18:59:59 739 5.1% 0.212.1 MB 5.0% 0.61
Jul 13 19:00:00 - 19:59:59 752 5.1% 0.212.0 MB 4.7% 0.56
Jul 13 20:00:00 - 20:59:59 676 4.6% 0.191.9 MB 4.4% 0.53
Jul 13 21:00:00 - 21:59:59 648 4.4% 0.182.1 MB 5.0% 0.60
Jul 13 22:00:00 - 22:59:59 545 3.7% 0.151.6 MB 3.8% 0.46
Jul 13 23:00:00 - 23:59:59 366 2.5% 0.101.1 MB 2.5% 0.30
Jul 14 00:00:00 - 00:59:59 363 2.5% 0.101.2 MB 2.7% 0.33
Jul 14 01:00:00 - 01:59:59 320 2.2% 0.091.1 MB 2.7% 0.32
Jul 14 02:00:00 - 02:59:59 299 2.0% 0.081.2 MB 2.8% 0.34
Jul 14 03:00:00 - 03:59:59 286 2.0% 0.081003.3 KB 2.3% 0.28
Jul 14 04:00:00 - 04:59:59 366 2.5% 0.101.3 MB 3.1% 0.38
Jul 14 05:00:00 - 05:59:59 331 2.3% 0.091014.6 KB 2.3% 0.28
Jul 14 06:00:00 - 06:59:59 373 2.6% 0.101.0 MB 2.4% 0.28
Jul 14 07:00:00 - 07:59:59 555 3.8% 0.151.6 MB 3.7% 0.45
Jul 14 08:00:00 - 08:59:59 690 4.7% 0.191.9 MB 4.5% 0.54
Jul 14 09:00:00 - 09:59:59 784 5.4% 0.222.2 MB 5.2% 0.62
Jul 14 10:00:00 - 10:59:59 804 5.5% 0.222.0 MB 4.6% 0.56
Jul 14 11:00:00 - 11:59:59 722 4.9% 0.201.9 MB 4.4% 0.53
Jul 14 12:00:00 - 12:59:59 715 4.9% 0.202.0 MB 4.8% 0.58
Jul 14 13:00:00 - 13:59:59 760 5.2% 0.212.2 MB 5.1% 0.62
Jul 14 14:00:00 - 14:59:59 830 5.7% 0.232.1 MB 5.0% 0.61
Jul 14 15:00:00 - 15:00:10 16 0.1% 1.6048.6 KB 0.1% 4.86
TOTAL: 24:00:07 14605 100.0% 0.1742.4 MB 100.0% 0.50
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB953.4 MB 93.1% 1 0.22 56.24
ONEDEFAULT1024.0 MB91.3 MB 8.9% 4 0.21 56.78
THREEDEFAULT1024.0 MB957.6 MB 93.5% 1 0.21 57.19
TWODEFAULT1024.0 MB954.9 MB 93.2% 1 0.21 57.13
TOTAL: 4-4.0 GB2.9 GB 72.2% 7 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1036 4 0 1 1 0 0 0 1030
2hasname-out.news.weretis.net 377 2 0 3 0 0 0 0 372
3news-out.aioe.org 219 0 0 0 0 0 0 0 219
TOTAL: 3 1632 6 0 4 1 0 0 0 1621

Unwanted newsgroups [Top 20]:

NewsgroupCount
aol.neighborhood.wa.seattle.jobs 1
alt.business.career-opportunities.executives 1
alt.math 1
alt.atheism.holysmoke 1
biz.misc 1
0.test 1
TOTAL: 6 6

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 802
EMP (phn path) 362
EMP (phn nph) 84
EMP (phl) 43
User-issued spam cancel 13
HTML Multipart 5
Binary: misplaced binary 4
Too many newsgroups 1
TOTAL: 8 1314

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 192
news-out.aioe.org 109
news.nntp4.net 6
TOTAL: 3 307
TOTAL: 1 307

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 696 696 0 0 0 0100%22:41:05
2aioe 10312 12 9976 1 0 0 0%24:00:00
3nntp4 13618 0 13336 0 0 0 0%23:59:50
4weretis 5982 0 5723 21 0 0 0%24:00:03
TOTAL: 4 30608 708 29035 22 0 0 2%94:40:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.4 MB0.0 KB2.4 MB0.0 KB/s3.6 KB22:41:05
2aioe50.2 KB7.6 KB57.8 KB0.0 KB/s4.4 KB24:00:00
3nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
4weretis0.0 KB110.5 KB110.5 KB0.0 KB/s5.3 KB24:00:03
TOTAL: 42.5 MB118.1 KB2.6 MB0.0 KB/s3.7 KB94:40:58
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
23.129.64.147 0.001 0.004 0.00000:00:04
news.nntp4.net 0.000 0.006 0.00000:00:01
tor-exit-6.zbau.f3netze.de 0.000 0.003 0.00000:00:00
23.129.64.138 0.000 0.002 0.00000:00:00
TOTAL: 4 0.001 0.015 0.00000:00:05

NNRP no permission clients:

SystemConn
news.nntp4.net 2
23.129.64.147 1
tor-exit-6.zbau.f3netze.de 1
23.129.64.138 1
TOTAL: 4 5