Daily Usenet report

Aug 25 15:00:03 -- Aug 26 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 15513 77.4%1.9 MB 74.6%
innd 2706 13.5%394.1 KB 15.4%
innfeed 1215 6.1%165.6 KB 6.5%
cnfsstat 576 2.9%84.9 KB 3.3%
nnrpd 25 0.1%2.5 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 20036 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 48710 46.8%
Positive hits 40218 38.6%
Do not exist 15155 14.6%
Cache misses 39 0.0%
TOTAL: 4 104122 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.707 0.0%79 0.000 8.949 50.000
article cleanup00:00:00.098 0.0%15262 0.000 0.006 0.042
article logging00:00:00.507 0.0%15431 0.000 0.033 0.098
article parse00:00:00.298 0.0%32206 0.000 0.009 0.060
article write00:00:01.812 0.0%13905 0.000 0.130 4.228
artlog/artcncl00:00:00.001 0.0%79 0.000 0.013 0.111
data move00:00:00.072 0.0%118783 0.000 0.001 0.004
hisgrep/artcncl00:00:00.004 0.0%79 0.000 0.051 1.000
hishave/artcncl00:00:00.143 0.0%79 0.000 1.810 21.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:41.845 0.2%104742 0.001 1.545 26.534
history sync00:00:00.014 0.0%343 0.000 0.041 0.500
history write00:00:04.483 0.0%15261 0.000 0.294 10.255
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:03.967 99.7%117471 303.485 734.002 3093.876
nntp read00:00:00.913 0.0%118121 0.000 0.008 0.019
overview write00:00:00.053 0.0%13905 0.000 0.004 0.032
perl filter00:00:20.666 0.0%15261 0.878 1.354 16.093
python filter00:00:00.462 0.0%15261 0.000 0.030 0.082
site send00:00:02.640 0.0%41714 0.027 0.063 0.096
TOTAL: 24:00:41.47824:00:18.685100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.042 0.0%13906 0.000 0.003 0.023
article prepare00:00:00.002 0.0%953 0.000 0.002 0.200
article read00:00:00.024 0.0%551 0.000 0.044 1.000
backlog stats00:00:00.054 0.0%66757 0.000 0.001 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.393 0.0%43820 0.000 0.009 0.028
data write00:00:00.932 0.0%30067 0.000 0.031 0.080
idle23:58:53.178100.0%66757 499.829 1293.245 4228.803
status file00:00:01.600 0.0%235 0.000 6.809 241.000
TOTAL: 23:58:58.80023:58:56.225100.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%6 0.000 0.167 1.000
TOTAL: 00:00:02.39900: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 5 27066 8140 18512 414 30%48:32:35
2news-out.aioe.org 3 13641 4965 8555 121 36%23:51:59
3news.nntp4.net 2 15065 685 13528 852 4%24:00:31
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 11 55772 13790 40595 1387 24%96:25:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net27.6 MB6.0 KB1000.6 KB28.6 MB 96%3.4 KB
2news-out.aioe.org13.8 MB0.0 KB195.3 KB14.0 MB 98%2.8 KB
3news.nntp4.net2.8 MB0.0 KB7.6 MB10.5 MB 27%7.0 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 444.3 MB6.0 KB8.8 MB53.0 MB 83%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 25 15:00:03 - 15:59:59 712 5.1% 0.202.2 MB 5.0% 0.64
Aug 25 16:00:00 - 16:59:59 846 6.1% 0.232.8 MB 6.2% 0.79
Aug 25 17:00:00 - 17:59:59 653 4.7% 0.182.1 MB 4.6% 0.59
Aug 25 18:00:00 - 18:59:59 800 5.7% 0.222.6 MB 5.8% 0.74
Aug 25 19:00:00 - 19:59:59 813 5.8% 0.232.5 MB 5.6% 0.71
Aug 25 20:00:00 - 20:59:59 591 4.2% 0.161.9 MB 4.2% 0.54
Aug 25 21:00:00 - 21:59:59 504 3.6% 0.141.5 MB 3.4% 0.43
Aug 25 22:00:00 - 22:59:59 501 3.6% 0.141.6 MB 3.5% 0.44
Aug 25 23:00:00 - 23:59:59 449 3.2% 0.121.4 MB 3.1% 0.39
Aug 26 00:00:00 - 00:59:59 372 2.7% 0.101.2 MB 2.7% 0.35
Aug 26 01:00:00 - 01:59:59 321 2.3% 0.091.4 MB 3.0% 0.39
Aug 26 02:00:00 - 02:59:59 351 2.5% 0.101.1 MB 2.5% 0.32
Aug 26 03:00:00 - 03:59:59 238 1.7% 0.07781.6 KB 1.7% 0.22
Aug 26 04:00:00 - 04:59:59 295 2.1% 0.08899.9 KB 2.0% 0.25
Aug 26 05:00:00 - 05:59:59 309 2.2% 0.091.2 MB 2.6% 0.33
Aug 26 06:00:00 - 06:59:59 470 3.4% 0.131.6 MB 3.7% 0.47
Aug 26 07:00:00 - 07:59:59 586 4.2% 0.162.1 MB 4.8% 0.61
Aug 26 08:00:00 - 08:59:59 574 4.1% 0.161.9 MB 4.2% 0.53
Aug 26 09:00:00 - 09:59:59 744 5.3% 0.211.9 MB 4.3% 0.54
Aug 26 10:00:00 - 10:59:59 632 4.5% 0.182.1 MB 4.7% 0.60
Aug 26 11:00:00 - 11:59:59 697 5.0% 0.192.2 MB 4.9% 0.62
Aug 26 12:00:00 - 12:59:59 754 5.4% 0.212.2 MB 4.9% 0.62
Aug 26 13:00:00 - 13:59:59 823 5.9% 0.232.9 MB 6.4% 0.82
Aug 26 14:00:00 - 14:59:59 880 6.3% 0.242.7 MB 6.1% 0.78
Aug 26 15:00:00 - 15:00:02 3 0.0% 1.506.5 KB 0.0% 3.26
TOTAL: 23:59:59 13918 100.0% 0.1644.7 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB654.9 MB 64.0% 2 0.21 56.53
ONEDEFAULT1024.0 MB816.6 MB 79.7% 4 0.21 56.94
THREEDEFAULT1024.0 MB658.4 MB 64.3% 2 0.22 55.27
TWODEFAULT1024.0 MB654.4 MB 63.9% 2 0.22 55.84
TOTAL: 4-4.0 GB2.7 GB 68.0% 10 0.22-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 811 6 0 0 1 0 0 0 804
2hasname-out.news.weretis.net 533 14 0 1 0 0 0 0 518
3news-out.aioe.org 171 0 0 0 0 0 0 0 171
TOTAL: 3 1515 20 0 1 1 0 0 0 1493

Unwanted newsgroups [Top 20]:

NewsgroupCount
wolfsburg.test 3
alt.bestjobsusa.newjersey.jobs 3
newsreader.test 3
alt.biz 1
pbinfo.test 1
adobe.acrobat.windows 1
alt.ads 1
alt.math 1
tnn.test 1
alt.calculator 1
fa.haskell 1
panix.chat.politics 1
owl.test 1
il.general 1
TOTAL: 14 20

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) 745
EMP (md5) 406
EMP (phn nph) 114
EMP (phl) 24
Too many newsgroups 15
HTML Multipart 13
User-issued spam cancel 5
Binary: misplaced binary 2
TOTAL: 8 1324

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 118
news-out.aioe.org 49
news.nntp4.net 2
TOTAL: 3 169
TOTAL: 1 169

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 419 419 0 0 0 0100%20:37:50
2aioe 9118 8 8694 1 0 1 0%23:59:56
3weretis 6460 1 5547 124 0 1 0%23:59:56
4nntp4 13480 0 13216 0 0 1 0%23:59:52
TOTAL: 4 29477 428 27457 125 0 3 1%92:37:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.7 MB0.0 KB1.7 MB0.0 KB/s4.1 KB20:37:50
2aioe29.2 KB6.2 KB35.4 KB0.0 KB/s3.9 KB23:59:56
3weretis1.6 KB627.2 KB628.7 KB0.0 KB/s5.0 KB23:59:56
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
TOTAL: 41.7 MB633.4 KB2.3 MB0.0 KB/s4.3 KB92:37:34
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.003 0.007 0.00000:00:01
tor-exit-10.zbau.f3netze.de 0.000 0.003 0.00000:00:00
scanner-26.ch1.censys-scanner.com 0.001 0.002 0.00000:00:00
23.129.64.165 0.000 0.002 0.00000:00:00
TOTAL: 4 0.004 0.014 0.00000:00:02

NNRP no permission clients:

SystemConn
news.nntp4.net 3
23.129.64.165 1
scanner-26.ch1.censys-scanner.com 1
tor-exit-10.zbau.f3netze.de 1
TOTAL: 4 6
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>