Daily Usenet report

Aug 29 15:00:03 -- Aug 30 15:00:07

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 15588 76.7%1.9 MB 74.2%
innd 2996 14.7%416.9 KB 16.2%
innfeed 1139 5.6%165.9 KB 6.4%
cnfsstat 576 2.8%81.8 KB 3.2%
nnrpd 16 0.1%1.7 KB 0.1%
overchan 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 20318 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 47907 46.7%
Positive hits 39459 38.5%
Do not exist 15026 14.7%
Cache misses 147 0.1%
TOTAL: 4 102539 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.459 0.0%304 0.000 11.378 53.667
article cleanup00:00:00.090 0.0%14986 0.000 0.006 0.037
article logging00:00:00.541 0.0%15257 0.000 0.035 0.227
article parse00:00:00.223 0.0%26720 0.000 0.008 0.035
article write00:00:03.707 0.0%13418 0.000 0.276 15.284
artlog/artcncl00:00:00.005 0.0%304 0.000 0.016 0.167
data move00:00:00.065 0.0%111690 0.000 0.001 0.003
hisgrep/artcncl00:00:00.002 0.0%181 0.000 0.011 0.500
hishave/artcncl00:00:00.004 0.0%304 0.000 0.013 0.031
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:25.478 0.2%102798 0.000 1.999 63.368
history sync00:00:00.013 0.0%344 0.000 0.038 1.000
history write00:00:06.559 0.0%14986 0.000 0.438 40.792
hiswrite/artcncl00:00:00.002 0.0%123 0.016 0.016 0.016
idle23:56:24.927 99.7%110595 261.893 779.284 2490.295
nntp read00:00:00.804 0.0%111197 0.000 0.007 0.015
overview write00:00:00.046 0.0%13418 0.000 0.003 0.030
perl filter00:00:16.867 0.0%14986 0.560 1.126 5.599
python filter00:00:00.426 0.0%14986 0.000 0.028 0.072
site send00:00:02.538 0.0%40254 0.020 0.063 0.104
TOTAL: 24:00:45.72324:00:25.756100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.026 0.0%13412 0.000 0.002 0.034
article prepare00:00:00.001 0.0%789 0.000 0.001 0.067
article read00:00:00.053 0.0%591 0.000 0.090 1.038
backlog stats00:00:00.043 0.0%63963 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.399 0.0%42117 0.000 0.009 0.035
data write00:00:00.874 0.0%28928 0.000 0.030 0.065
idle23:59:49.065100.0%63963 474.892 1350.610 3896.013
status file00:00:02.786 0.0%205 0.000 13.590 682.500
TOTAL: 23:59:54.95923:59:53.247100.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.10600: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 6 27688 8758 18290 640 31%50:29:10
2news-out.aioe.org 4 13213 4101 9065 47 31%24:08:46
3news.nntp4.net 1 15664 552 14151 961 3%25:27:09
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 12 56565 13411 41506 1648 23%100:05:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net27.3 MB0.0 KB1.5 MB28.8 MB 94%3.1 KB
2news-out.aioe.org11.0 MB0.0 KB92.6 KB11.0 MB 99%2.7 KB
3news.nntp4.net2.2 MB0.0 KB3.6 MB5.9 MB 37%4.0 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 440.5 MB0.0 KB5.2 MB45.7 MB 88%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 29 15:00:03 - 15:59:59 699 5.2% 0.192.3 MB 5.7% 0.66
Aug 29 16:00:00 - 16:59:59 939 7.0% 0.262.0 MB 5.0% 0.58
Aug 29 17:00:00 - 17:59:59 684 5.1% 0.191.8 MB 4.4% 0.51
Aug 29 18:00:00 - 18:59:59 665 5.0% 0.181.9 MB 4.6% 0.53
Aug 29 19:00:00 - 19:59:59 706 5.3% 0.202.5 MB 6.3% 0.72
Aug 29 20:00:00 - 20:59:59 672 5.0% 0.192.0 MB 4.9% 0.56
Aug 29 21:00:00 - 21:59:59 562 4.2% 0.162.0 MB 5.0% 0.58
Aug 29 22:00:00 - 22:59:59 519 3.9% 0.141.9 MB 4.8% 0.55
Aug 29 23:00:00 - 23:59:59 392 2.9% 0.112.2 MB 5.5% 0.63
Aug 30 00:00:00 - 00:59:59 322 2.4% 0.09949.3 KB 2.3% 0.26
Aug 30 01:00:00 - 01:59:59 280 2.1% 0.08785.4 KB 1.9% 0.22
Aug 30 02:00:00 - 02:59:59 296 2.2% 0.08989.5 KB 2.4% 0.27
Aug 30 03:00:00 - 03:59:59 305 2.3% 0.081.1 MB 2.8% 0.32
Aug 30 04:00:00 - 04:59:59 282 2.1% 0.08902.0 KB 2.2% 0.25
Aug 30 05:00:00 - 05:59:59 367 2.7% 0.101.3 MB 3.3% 0.38
Aug 30 06:00:00 - 06:59:59 419 3.1% 0.121.1 MB 2.7% 0.31
Aug 30 07:00:00 - 07:59:59 541 4.0% 0.151.4 MB 3.4% 0.39
Aug 30 08:00:00 - 08:59:59 636 4.7% 0.182.0 MB 4.9% 0.56
Aug 30 09:00:00 - 09:59:59 654 4.9% 0.181.8 MB 4.4% 0.50
Aug 30 10:00:00 - 10:59:59 644 4.8% 0.181.6 MB 4.0% 0.46
Aug 30 11:00:00 - 11:59:59 638 4.8% 0.181.7 MB 4.2% 0.49
Aug 30 12:00:00 - 12:59:59 639 4.8% 0.182.0 MB 4.9% 0.56
Aug 30 13:00:00 - 13:59:59 793 5.9% 0.222.1 MB 5.3% 0.61
Aug 30 14:00:00 - 14:59:59 757 5.6% 0.212.0 MB 4.9% 0.57
Aug 30 15:00:00 - 15:00:07 6 0.0% 0.8618.4 KB 0.0% 2.63
TOTAL: 24:00:04 13417 100.0% 0.1640.5 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB720.6 MB 70.4% 2 0.20 59.64
ONEDEFAULT1024.0 MB881.9 MB 86.1% 4 0.20 60.64
THREEDEFAULT1024.0 MB724.3 MB 70.7% 2 0.20 59.57
TWODEFAULT1024.0 MB719.5 MB 70.3% 2 0.20 59.85
TOTAL: 4-4.0 GB3.0 GB 74.4% 10 0.20-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 919 9 0 0 1 0 0 0 909
2hasname-out.news.weretis.net 821 2 0 0 0 0 0 0 819
3news-out.aioe.org 127 0 0 0 0 0 0 0 127
TOTAL: 3 1867 11 0 0 1 0 0 0 1855

Unwanted newsgroups [Top 20]:

NewsgroupCount
panix.chat.politics 4
alt.math 2
alt.elvis 2
alt.alt.sex.spanking 1
alt.sex.bestiality.hamster 1
fa.haskell 1
TOTAL: 6 11

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) 957
EMP (md5) 378
EMP (phn nph) 185
User-issued spam cancel 26
Binary Image: misplaced jpg 22
EMP (phl) 6
HTML Multipart 5
Too many newsgroups 3
Binary Image: misplaced jpeg 1
HTML post 1
Binary: misplaced binary 1
Scoring filter 1
TOTAL: 12 1586

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 186
news-out.aioe.org 81
news.nntp4.net 2
TOTAL: 3 269
TOTAL: 1 269

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 525 525 0 0 0 0100%22:30:43
2aioe 9583 9 9135 0 0 0 0%23:59:53
3nntp4 13095 3 12878 0 0 0 0%24:00:00
4weretis 5099 0 4569 54 0 0 0%24:00:00
TOTAL: 4 28302 537 26582 54 0 0 1%94:30:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.9 MB0.0 KB1.9 MB0.0 KB/s3.8 KB22:30:43
2aioe28.4 KB0.0 KB28.4 KB0.0 KB/s3.2 KB23:59:53
3nntp412.3 KB0.0 KB12.3 KB0.0 KB/s4.1 KB24:00:00
4weretis0.0 KB259.4 KB259.4 KB0.0 KB/s4.8 KB24:00:00
TOTAL: 42.0 MB259.4 KB2.2 MB0.0 KB/s3.9 KB94:30:36
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
scanner-09.ch1.censys-scanner.com 0.002 0.004 0.00000:00:00
sky.census.shodan.io 0.003 0.002 0.00000:00:00
TOTAL: 2 0.005 0.006 0.00000:00:00

NNRP no permission clients:

SystemConn
scanner-09.ch1.censys-scanner.com 2
sky.census.shodan.io 2
TOTAL: 2 4