Daily Usenet report

Aug 6 15:00:01 -- Aug 7 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 13957 77.2%1.7 MB 74.5%
innd 2317 12.8%328.0 KB 14.2%
innfeed 1201 6.6%172.3 KB 7.4%
cnfsstat 576 3.2%86.8 KB 3.7%
nnrpd 33 0.2%3.2 KB 0.1%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 18085 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 44247 47.4%
Positive hits 35597 38.1%
Do not exist 13497 14.5%
Cache misses 43 0.0%
TOTAL: 4 93384 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.826 0.0%79 0.000 23.114 241.500
article cleanup00:00:00.071 0.0%13577 0.000 0.005 0.030
article logging00:00:00.426 0.0%13909 0.000 0.031 0.143
article parse00:00:00.220 0.0%27094 0.000 0.008 0.039
article write00:00:06.528 0.0%12750 0.000 0.512 55.938
artlog/artcncl00:00:00.002 0.0%64 0.000 0.031 0.500
data move00:00:00.055 0.0%103845 0.000 0.001 0.005
hisgrep/artcncl00:00:00.007 0.0%76 0.000 0.092 1.000
hishave/artcncl00:00:00.161 0.0%79 0.000 2.038 62.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:04:52.597 0.3%93823 0.001 3.119 53.202
history sync00:00:00.015 0.0%378 0.000 0.040 0.500
history write00:00:09.840 0.0%13563 0.000 0.726 69.713
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:53:46.452 99.5%103813 432.609 828.667 2554.200
nntp read00:00:00.693 0.0%104609 0.000 0.007 0.018
overview write00:00:00.043 0.0%12750 0.000 0.003 0.033
perl filter00:00:18.028 0.0%13563 0.832 1.329 19.027
python filter00:00:00.366 0.0%13563 0.000 0.027 0.080
site send00:00:02.143 0.0%38250 0.031 0.056 0.095
TOTAL: 24:00:52.56523:59:19.473 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%12716 0.000 0.002 0.024
article prepare00:00:00.000 0.0%651 0.000 0.000 0.000
article read00:00:00.352 0.0%494 0.000 0.713 81.667
backlog stats00:00:00.029 0.0%59893 0.000 0.000 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.320 0.0%39586 0.000 0.008 0.028
data write00:00:00.744 0.0%27021 0.005 0.028 0.078
idle23:57:54.319100.0%59893 715.111 1440.474 4550.326
status file00:00:00.116 0.0%239 0.000 0.485 51.000
TOTAL: 23:57:57.44023:57:55.903100.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%7 0.000 0.000 0.000
TOTAL: 00:00:01.98300: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 3 24124 7728 16284 112 32%48:42:19
2news-out.aioe.org 3 12415 4679 7736 0 37%24:10:04
3news.nntp4.net 2 12282 413 11245 624 3%22:31:07
4localhost 1 0 0 0 0 0%00:00:01
TOTAL: 4 9 48821 12820 35265 736 26%95:23:31
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net23.5 MB16.0 KB238.0 KB23.7 MB 98%3.1 KB
2news-out.aioe.org13.0 MB0.0 KB0.0 KB13.0 MB100%2.8 KB
3news.nntp4.net1.2 MB48.2 KB3.5 MB4.8 MB 24%4.7 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 437.6 MB64.2 KB3.8 MB41.5 MB 90%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 6 15:00:01 - 15:59:59 831 6.5% 0.232.4 MB 6.3% 0.68
Aug 6 16:00:00 - 16:59:59 736 5.8% 0.202.1 MB 5.5% 0.59
Aug 6 17:00:00 - 17:59:59 738 5.8% 0.202.0 MB 5.4% 0.58
Aug 6 18:00:00 - 18:59:59 744 5.8% 0.212.0 MB 5.3% 0.57
Aug 6 19:00:00 - 19:59:59 792 6.2% 0.222.6 MB 7.0% 0.74
Aug 6 20:00:00 - 20:59:59 622 4.9% 0.171.7 MB 4.5% 0.48
Aug 6 21:00:00 - 21:59:59 555 4.4% 0.151.6 MB 4.4% 0.47
Aug 6 22:00:00 - 22:59:59 487 3.8% 0.141.4 MB 3.7% 0.40
Aug 6 23:00:00 - 23:59:59 433 3.4% 0.121.4 MB 3.6% 0.39
Aug 7 00:00:00 - 00:59:59 386 3.0% 0.111.2 MB 3.3% 0.35
Aug 7 01:00:00 - 01:59:59 292 2.3% 0.08964.3 KB 2.5% 0.27
Aug 7 02:00:00 - 02:59:59 258 2.0% 0.07995.1 KB 2.6% 0.28
Aug 7 03:00:00 - 03:59:59 264 2.1% 0.071.4 MB 3.6% 0.39
Aug 7 04:00:00 - 04:59:59 224 1.8% 0.06993.8 KB 2.6% 0.28
Aug 7 05:00:00 - 05:59:59 301 2.4% 0.08792.1 KB 2.1% 0.22
Aug 7 06:00:00 - 06:59:59 338 2.7% 0.091.2 MB 3.3% 0.35
Aug 7 07:00:00 - 07:59:59 580 4.6% 0.161.6 MB 4.3% 0.46
Aug 7 08:00:00 - 08:59:59 519 4.1% 0.141.4 MB 3.7% 0.39
Aug 7 09:00:00 - 09:59:59 514 4.0% 0.141.3 MB 3.4% 0.36
Aug 7 10:00:00 - 10:59:59 539 4.2% 0.151.5 MB 3.9% 0.41
Aug 7 11:00:00 - 11:59:59 586 4.6% 0.161.7 MB 4.6% 0.49
Aug 7 12:00:00 - 12:59:59 604 4.7% 0.171.7 MB 4.5% 0.48
Aug 7 13:00:00 - 13:59:59 593 4.7% 0.161.5 MB 4.0% 0.43
Aug 7 14:00:00 - 14:59:59 794 6.2% 0.222.2 MB 5.9% 0.63
Aug 7 15:00:00 - 15:00:02 4 0.0% 2.0013.5 KB 0.0% 6.75
TOTAL: 24:00:01 12734 100.0% 0.1537.5 MB 100.0% 0.44
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB326.4 MB 31.9% 2 0.19 64.04
ONEDEFAULT1024.0 MB488.3 MB 47.7% 4 0.19 64.63
THREEDEFAULT1024.0 MB330.7 MB 32.3% 2 0.19 63.92
TWODEFAULT1024.0 MB327.5 MB 32.0% 2 0.19 63.88
TOTAL: 4-4.0 GB1.4 GB 36.0% 10 0.19-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 730 1 0 10 1 0 0 0 718
2hasname-out.news.weretis.net 337 3 0 4 0 0 0 0 330
3news-out.aioe.org 92 0 0 0 0 0 0 0 92
TOTAL: 3 1159 4 0 14 1 0 0 0 1140

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.postfix.users 1
adobe.illustrator.windows 1
alt.ads.forsale 1
panix.questions 1
TOTAL: 4 4

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 419
EMP (phn nph) 175
EMP (phn path) 168
EMP (phl) 14
HTML Multipart 10
Too many newsgroups 7
HTML post 6
User-issued spam cancel 6
Binary: misplaced binary 3
TOTAL: 9 808

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 230
news-out.aioe.org 92
news.nntp4.net 10
TOTAL: 3 332
TOTAL: 1 332

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 443 443 0 0 0 0100%19:48:49
2aioe 8295 10 7963 1 0 0 0%23:59:57
3weretis 5233 1 5001 40 0 0 0%23:59:50
4nntp4 12524 0 12293 0 0 0 0%23:59:47
TOTAL: 4 26495 454 25257 41 0 0 1%91:48:23
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.6 MB0.0 KB1.6 MB0.0 KB/s3.8 KB19:48:49
2aioe27.8 KB3.5 KB31.3 KB0.0 KB/s2.8 KB23:59:57
3weretis0.6 KB160.3 KB160.9 KB0.0 KB/s3.9 KB23:59:50
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
TOTAL: 41.7 MB163.7 KB1.8 MB0.0 KB/s3.8 KB91:48:23
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
117.50.7.159 0.002 0.009 0.00000:00:01
news.nntp4.net 0.000 0.003 0.00000:00:00
scanner-09.ch1.censys-scanner.com 0.001 0.002 0.00000:00:00
TOTAL: 3 0.003 0.014 0.00000:00:01

NNRP no permission clients:

SystemConn
117.50.7.159 5
news.nntp4.net 1
scanner-09.ch1.censys-scanner.com 1
TOTAL: 3 7