Daily Usenet report

Jan 20 15:00:01 -- Jan 21 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 17874 73.4%2.1 MB 71.5%
innd 4581 18.8%607.1 KB 20.0%
innfeed 1193 4.9%163.3 KB 5.4%
cnfsstat 576 2.4%80.2 KB 2.6%
nnrpd 120 0.5%11.9 KB 0.4%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 24345 100.0%3.0 MB100.0%

History cache:

ReasonCount%Count
Negative hits 47852 43.8%
Positive hits 44182 40.4%
Do not exist 17282 15.8%
Cache misses 55 0.1%
TOTAL: 4 109371 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:05.520 0.0%120 0.000 46.000 948.000
article cleanup00:00:00.098 0.0%17485 0.000 0.006 0.036
article logging00:00:00.455 0.0%17787 0.000 0.026 0.080
article parse00:00:00.277 0.0%32113 0.000 0.009 0.039
article write00:00:01.305 0.0%14542 0.000 0.090 6.513
artlog/artcncl00:00:00.000 0.0%117 0.000 0.000 0.000
data move00:00:00.056 0.0%120573 0.000 0.000 0.005
hisgrep/artcncl00:00:01.210 0.0%117 0.000 10.342 601.500
hishave/artcncl00:00:00.025 0.0%120 0.000 0.208 4.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:17.309 0.0%110598 0.000 0.157 5.307
history sync00:00:00.015 0.0%410 0.000 0.037 0.667
history write00:00:01.475 0.0%17485 0.000 0.084 3.303
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:59:55.557 99.9%122417 333.913 705.748 2503.338
nntp read00:00:00.895 0.0%122286 0.000 0.007 0.025
overview write00:00:00.068 0.0%14542 0.000 0.005 0.040
perl filter00:00:21.379 0.0%17485 0.828 1.223 18.227
python filter00:00:00.478 0.0%17485 0.000 0.027 0.073
site send00:00:02.522 0.0%43624 0.010 0.058 0.098
TOTAL: 24:01:03.22624:00:48.644100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%14503 0.000 0.002 0.025
article prepare00:00:00.002 0.0%825 0.000 0.002 0.333
article read00:00:00.020 0.0%501 0.000 0.040 1.000
backlog stats00:00:00.039 0.0%80802 0.000 0.000 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.391 0.0%49439 0.000 0.008 0.026
data write00:00:01.044 0.0%35205 0.007 0.030 0.093
idle23:58:41.161100.0%80802 554.502 1068.305 2529.882
status file00:00:01.007 0.0%233 0.000 4.322 586.000
TOTAL: 23:58:45.81223:58:43.688100.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%30 0.000 0.000 0.000
TOTAL: 00:00:00.79800: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 10 28373 8029 19201 1143 28%46:52:16
2news-out.aioe.org 3 14755 6053 8441 261 41%24:05:38
3news.nntp4.net 1 16323 276 14608 1439 1%22:58:44
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 15 59451 14358 42250 2843 24%93:56:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net24.9 MB0.0 KB2.0 MB26.8 MB 92%3.0 KB
2news-out.aioe.org14.9 MB0.0 KB480.6 KB15.4 MB 96%2.5 KB
3news.nntp4.net856.6 KB0.0 KB5.2 MB6.1 MB 13%3.6 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 440.7 MB0.0 KB7.6 MB48.3 MB 84%2.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 20 15:00:01 - 15:59:59 808 5.6% 0.222.2 MB 5.4% 0.63
Jan 20 16:00:00 - 16:59:59 800 5.5% 0.222.2 MB 5.4% 0.63
Jan 20 17:00:00 - 17:59:59 935 6.4% 0.262.7 MB 6.5% 0.76
Jan 20 18:00:00 - 18:59:59 797 5.5% 0.222.2 MB 5.5% 0.64
Jan 20 19:00:00 - 19:59:59 657 4.5% 0.181.8 MB 4.5% 0.52
Jan 20 20:00:00 - 20:59:59 691 4.8% 0.192.2 MB 5.2% 0.61
Jan 20 21:00:00 - 21:59:59 675 4.7% 0.192.0 MB 5.0% 0.58
Jan 20 22:00:00 - 22:59:59 583 4.0% 0.161.7 MB 4.2% 0.49
Jan 20 23:00:00 - 23:59:59 547 3.8% 0.151.9 MB 4.6% 0.54
Jan 21 00:00:00 - 00:59:59 398 2.7% 0.111.3 MB 3.1% 0.36
Jan 21 01:00:00 - 01:59:59 420 2.9% 0.121.3 MB 3.1% 0.36
Jan 21 02:00:00 - 02:59:59 263 1.8% 0.07889.6 KB 2.1% 0.25
Jan 21 03:00:00 - 03:59:59 276 1.9% 0.08956.8 KB 2.3% 0.27
Jan 21 04:00:00 - 04:59:59 276 1.9% 0.08991.9 KB 2.4% 0.28
Jan 21 05:00:00 - 05:59:59 378 2.6% 0.101.4 MB 3.3% 0.39
Jan 21 06:00:00 - 06:59:59 461 3.2% 0.131.2 MB 2.8% 0.33
Jan 21 07:00:00 - 07:59:59 435 3.0% 0.121.2 MB 2.9% 0.34
Jan 21 08:00:00 - 08:59:59 590 4.1% 0.161.5 MB 3.6% 0.42
Jan 21 09:00:00 - 09:59:59 721 5.0% 0.201.9 MB 4.7% 0.55
Jan 21 10:00:00 - 10:59:59 735 5.1% 0.201.8 MB 4.3% 0.50
Jan 21 11:00:00 - 11:59:59 783 5.4% 0.222.0 MB 4.8% 0.56
Jan 21 12:00:00 - 12:59:59 635 4.4% 0.181.5 MB 3.8% 0.44
Jan 21 13:00:00 - 13:59:59 770 5.3% 0.212.1 MB 5.1% 0.60
Jan 21 14:00:00 - 14:59:59 863 6.0% 0.242.2 MB 5.5% 0.64
Jan 21 15:00:00 - 15:00:02 1 0.0% 0.501.5 KB 0.0% 0.75
TOTAL: 24:00:01 14498 100.0% 0.1741.1 MB 100.0% 0.49
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB98.3 MB 9.6% 5 0.21 57.98
ONEDEFAULT1024.0 MB264.0 MB 25.8% 7 0.21 57.16
THREEDEFAULT1024.0 MB107.3 MB 10.5% 5 0.21 58.11
TWODEFAULT1024.0 MB99.4 MB 9.7% 5 0.21 58.75
TOTAL: 4-4.0 GB569.1 MB 13.9% 22 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1524 27 0 0 1 0 0 0 1496
2hasname-out.news.weretis.net 1414 11 0 0 0 0 0 0 1403
3news-out.aioe.org 321 0 0 0 0 0 0 0 321
TOTAL: 3 3259 38 0 0 1 0 0 0 3220

Unwanted newsgroups [Top 20]:

NewsgroupCount
panix.chat.politics 4
panix.questions 4
alt.bestjobsusa.jobs.offered 3
sybase.public.powerdesigner.general 3
alt.fetish 2
alt.makemoney 2
ibm.software.japan.test 1
0.test 1
rhein.test 1
creative.test 1
nb.test 1
alt.israel.test 1
alt.penthouse.sex.first-time 1
ntl.test 1
freedyn.test 1
lucky.freebsd.jobs 1
kl.test 1
kassel.test 1
bit.listserv.test 1
manse.test 1
TOTAL: 26 38

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 1893
EMP (md5) 746
EMP (phn nph) 145
Binary: misplaced binary 64
User-issued spam cancel 32
EMP (phl) 15
HTML Multipart 9
Too many newsgroups 8
Scoring filter 8
TOTAL: 9 2920

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 238
news-out.aioe.org 60
news.nntp4.net 2
TOTAL: 3 300
TOTAL: 1 300

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 397 397 0 0 0 0100%19:42:35
2aioe 10924 56 8273 9 0 0 0%23:59:00
3nntp4 16716 3 14049 0 0 0 0%23:50:00
4weretis 6463 0 6192 38 0 27 0%23:51:05
TOTAL: 4 34500 456 28514 47 0 27 1%91:22:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.3 MB0.0 KB1.3 MB0.0 KB/s3.5 KB19:42:35
2aioe211.7 KB36.3 KB248.0 KB0.0 KB/s3.8 KB23:59:00
3nntp46.1 KB0.0 KB6.1 KB0.0 KB/s2.0 KB23:50:00
4weretis0.0 KB155.1 KB155.1 KB0.0 KB/s4.1 KB23:51:05
TOTAL: 41.6 MB191.4 KB1.7 MB0.0 KB/s3.5 KB91:22:40
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
li151-123.members.linode.com 0.023 0.055 0.00000:00:00
tor-exit-50.for-privacy.net 0.002 0.002 0.00000:00:00
TOTAL: 2 0.025 0.057 0.00000:00:00

NNRP no permission clients:

SystemConn
li151-123.members.linode.com 29
tor-exit-50.for-privacy.net 1
TOTAL: 2 30