Daily Usenet report

Oct 5 15:00:02 -- Oct 6 15:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 5 15:01:22 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 16531 76.2%2.0 MB 73.9%
innd 3351 15.5%461.9 KB 16.8%
innfeed 1187 5.5%166.0 KB 6.0%
cnfsstat 576 2.7%85.2 KB 3.1%
nnrpd 40 0.2%4.0 KB 0.1%
overchan 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 21687 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 46085 44.5%
Positive hits 41325 39.9%
Do not exist 16071 15.5%
Cache misses 30 0.0%
TOTAL: 4 103511 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.048 0.0%74 0.000 0.649 3.000
article cleanup00:00:00.084 0.0%16240 0.000 0.005 0.027
article logging00:00:00.420 0.0%16533 0.000 0.025 0.082
article parse00:00:00.264 0.0%28811 0.000 0.009 0.025
article write00:00:02.161 0.0%14299 0.000 0.151 2.956
artlog/artcncl00:00:00.001 0.0%68 0.000 0.015 0.250
data move00:00:00.082 0.0%112823 0.000 0.001 0.006
hisgrep/artcncl00:00:00.002 0.0%72 0.000 0.028 1.000
hishave/artcncl00:00:00.007 0.0%74 0.000 0.095 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:34.718 0.1%104538 0.000 0.906 32.106
history sync00:00:00.007 0.0%361 0.000 0.019 0.500
history write00:00:02.890 0.0%16240 0.000 0.178 13.833
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:58:37.820 99.8%113113 402.584 763.111 2336.284
nntp read00:00:00.727 0.0%113382 0.000 0.006 0.013
overview write00:00:00.035 0.0%14299 0.000 0.002 0.028
perl filter00:00:17.329 0.0%16240 0.707 1.067 5.131
python filter00:00:00.404 0.0%16240 0.000 0.025 0.070
site send00:00:02.515 0.0%42897 0.020 0.059 0.131
TOTAL: 24:00:54.97224:00:39.514100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.033 0.0%14253 0.000 0.002 0.025
article prepare00:00:00.000 0.0%835 0.000 0.000 0.000
article read00:00:00.021 0.0%569 0.000 0.037 0.333
backlog stats00:00:00.049 0.0%77724 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.347 0.0%48082 0.000 0.007 0.023
data write00:00:00.971 0.0%34120 0.000 0.028 0.080
idle23:58:57.303100.0%77724 639.775 1110.819 3198.277
status file00:00:00.087 0.0%221 0.000 0.394 31.000
TOTAL: 23:59:00.81623:58:58.811100.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%10 0.000 0.100 1.000
TOTAL: 00:00:03.62600:00:00.001 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 27463 10099 16659 705 36%47:32:48
2news-out.aioe.org 2 13994 3556 10438 0 25%23:58:50
3news.nntp4.net 2 15337 481 13740 1116 3%23:16:24
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 11 56794 14136 40837 1821 24%94:48:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net32.2 MB0.0 KB1.3 MB33.6 MB 96%3.2 KB
2news-out.aioe.org9.4 MB0.0 KB0.0 KB9.4 MB100%2.7 KB
3news.nntp4.net1.5 MB0.0 KB3.7 MB5.2 MB 28%3.3 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 443.1 MB0.0 KB5.0 MB48.1 MB 89%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 5 15:00:02 - 15:59:59 843 5.9% 0.232.3 MB 5.3% 0.65
Oct 5 16:00:00 - 16:59:59 736 5.2% 0.202.0 MB 4.7% 0.58
Oct 5 17:00:00 - 17:59:59 804 5.6% 0.222.7 MB 6.2% 0.76
Oct 5 18:00:00 - 18:59:59 733 5.1% 0.202.6 MB 5.9% 0.73
Oct 5 19:00:00 - 19:59:59 769 5.4% 0.212.5 MB 5.9% 0.73
Oct 5 20:00:00 - 20:59:59 678 4.8% 0.192.1 MB 4.8% 0.59
Oct 5 21:00:00 - 21:59:59 776 5.4% 0.222.4 MB 5.5% 0.68
Oct 5 22:00:00 - 22:59:59 581 4.1% 0.162.2 MB 5.0% 0.62
Oct 5 23:00:00 - 23:59:59 415 2.9% 0.121.2 MB 2.8% 0.35
Oct 6 00:00:00 - 00:59:59 365 2.6% 0.101.2 MB 2.7% 0.34
Oct 6 01:00:00 - 01:59:59 316 2.2% 0.091.3 MB 3.1% 0.38
Oct 6 02:00:00 - 02:59:59 356 2.5% 0.101.2 MB 2.7% 0.34
Oct 6 03:00:00 - 03:59:59 325 2.3% 0.091012.9 KB 2.3% 0.28
Oct 6 04:00:00 - 04:59:59 278 1.9% 0.08931.6 KB 2.1% 0.26
Oct 6 05:00:00 - 05:59:59 330 2.3% 0.09893.6 KB 2.0% 0.25
Oct 6 06:00:00 - 06:59:59 418 2.9% 0.121.4 MB 3.2% 0.39
Oct 6 07:00:00 - 07:59:59 545 3.8% 0.151.7 MB 3.9% 0.48
Oct 6 08:00:00 - 08:59:59 616 4.3% 0.171.8 MB 4.2% 0.51
Oct 6 09:00:00 - 09:59:59 623 4.4% 0.171.7 MB 4.0% 0.49
Oct 6 10:00:00 - 10:59:59 650 4.6% 0.181.8 MB 4.2% 0.52
Oct 6 11:00:00 - 11:59:59 750 5.3% 0.211.9 MB 4.5% 0.55
Oct 6 12:00:00 - 12:59:59 786 5.5% 0.222.2 MB 5.1% 0.63
Oct 6 13:00:00 - 13:59:59 802 5.6% 0.222.2 MB 5.0% 0.62
Oct 6 14:00:00 - 14:59:59 761 5.3% 0.212.1 MB 4.8% 0.59
Oct 6 15:00:00 - 15:00:01 1 0.0% 1.001.3 KB 0.0% 1.25
TOTAL: 23:59:59 14257 100.0% 0.1743.3 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB341.8 MB 33.4% 3 0.21 57.57
ONEDEFAULT1024.0 MB504.5 MB 49.3% 5 0.21 56.83
THREEDEFAULT1024.0 MB345.5 MB 33.7% 3 0.22 56.35
TWODEFAULT1024.0 MB339.4 MB 33.1% 3 0.22 56.07
TOTAL: 4-4.0 GB1.5 GB 37.4% 14 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1241 14 0 0 1 0 0 0 1226
2hasname-out.news.weretis.net 927 10 0 0 0 0 0 0 917
3news-out.aioe.org 38 0 0 0 0 0 0 0 38
TOTAL: 3 2206 24 0 0 1 0 0 0 2181

Unwanted newsgroups [Top 20]:

NewsgroupCount
wolfsburg.test 4
yu.forum 2
alt.dvd.video 1
alt.math 1
tw.k-12.kindergarten 1
tw.k-12.information 1
tw.k-12.students 1
fa.haskell 1
alt.lang.teco 1
alt.bestjobsusa.jobs.offered 1
tw.k-12.class 1
list.postfix.users 1
alt.bestjobsusa.philly.jobs 1
adobe.acrobat.reader 1
mozilla.dev.tech.js-engine 1
mozilla.dev.apps.seamonkey 1
tw.talk 1
tw.test 1
tw.wanted 1
tw.k-12.teachers 1
TOTAL: 20 24

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) 1082
EMP (md5) 532
EMP (phn nph) 194
User-issued spam cancel 40
EMP (phl) 19
Too many newsgroups 12
HTML Multipart 5
Scoring filter 4
TOTAL: 8 1888

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 253
news-out.aioe.org 38
news.nntp4.net 2
TOTAL: 3 293
TOTAL: 1 293

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 484 484 0 0 0 0100%20:55:05
2aioe 12829 33 10542 5 0 2 0%23:59:56
3weretis 4213 0 3961 50 0 0 0%23:59:54
4nntp4 16005 0 13767 0 0 0 0%23:59:56
TOTAL: 4 33531 517 28270 55 0 2 1%92:54:51
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.9 MB0.0 KB1.9 MB0.0 KB/s4.0 KB20:55:05
2aioe215.8 KB40.3 KB256.1 KB0.0 KB/s6.7 KB23:59:56
3weretis0.0 KB186.2 KB186.2 KB0.0 KB/s3.7 KB23:59:54
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 42.1 MB226.4 KB2.3 MB0.0 KB/s4.1 KB92:54:51
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.006 0.015 0.00000:00:03
battery.census.shodan.io 0.000 0.004 0.00000:00:00
ec2-18-144-3-143.us-west-1.compute.amazonaws.com 0.001 0.002 0.00000:00:00
TOTAL: 3 0.007 0.021 0.00000:00:03

NNRP no permission clients:

SystemConn
news.nntp4.net 7
battery.census.shodan.io 2
ec2-18-144-3-143.us-west-1.compute.amazonaws.com 1
TOTAL: 3 10