Daily Usenet report

Dec 7 15:00:01 -- Dec 8 15:00:03

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 7 15:01:19 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 12875 75.4%1.6 MB 72.6%
innd 2303 13.5%331.1 KB 15.1%
innfeed 1217 7.1%170.9 KB 7.8%
cnfsstat 576 3.4%88.7 KB 4.0%
nnrpd 93 0.5%9.5 KB 0.4%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 17065 100.0%2.1 MB100.0%

History cache:

ReasonCount%Count
Negative hits 33398 42.4%
Positive hits 32793 41.7%
Do not exist 12490 15.9%
Cache misses 35 0.0%
TOTAL: 4 78716 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.660 0.0%71 0.000 9.296 43.875
article cleanup00:00:00.075 0.0%12542 0.000 0.006 0.067
article logging00:00:00.893 0.0%12787 0.000 0.070 7.297
article parse00:00:00.228 0.0%22280 0.000 0.010 0.035
article write00:00:00.702 0.0%11660 0.000 0.060 2.143
artlog/artcncl00:00:00.001 0.0%71 0.000 0.014 0.333
data move00:00:00.035 0.0%86699 0.000 0.000 0.007
hisgrep/artcncl00:00:00.000 0.0%70 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%71 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.420 0.0%78995 0.000 0.005 0.118
history sync00:00:00.023 0.0%361 0.000 0.064 0.667
history write00:00:00.458 0.0%12542 0.000 0.037 0.781
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle24:00:17.189100.0%86594 528.858 997.958 3798.057
nntp read00:00:00.569 0.0%86408 0.000 0.007 0.020
overview write00:00:00.043 0.0%11660 0.000 0.004 0.056
perl filter00:00:12.430 0.0%12542 0.759 0.991 1.354
python filter00:00:00.377 0.0%12542 0.000 0.030 0.109
site send00:00:02.390 0.0%34978 0.032 0.068 0.110
TOTAL: 24:00:49.30324:00:36.493100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.026 0.0%11637 0.000 0.002 0.034
article prepare00:00:00.000 0.0%999 0.000 0.000 0.000
article read00:00:00.202 0.0%482 0.000 0.419 17.000
backlog stats00:00:00.030 0.0%69636 0.000 0.000 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.318 0.0%40900 0.000 0.008 0.027
data write00:00:00.824 0.0%29348 0.000 0.028 0.073
idle23:58:09.154100.0%69636 650.075 1239.146 3273.359
status file00:00:00.071 0.0%252 0.000 0.282 1.000
TOTAL: 23:58:16.33023:58:10.625100.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%19 0.000 0.000 0.000
TOTAL: 00:00:00.62800: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 5 22163 7948 14009 206 35%49:16:29
2news-out.aioe.org 2 11909 3235 8674 0 27%24:51:54
3news.nntp4.net 1 12365 772 10915 678 6%24:25:52
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 9 46437 11955 33598 884 25%98:34:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net25.4 MB0.0 KB505.0 KB25.9 MB 98%3.2 KB
2news-out.aioe.org8.1 MB0.0 KB0.0 KB8.1 MB100%2.6 KB
3news.nntp4.net2.9 MB0.0 KB2.6 MB5.5 MB 53%3.9 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 436.4 MB0.0 KB3.1 MB39.4 MB 92%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 7 15:00:01 - 15:59:59 775 6.6% 0.222.0 MB 5.6% 0.57
Dec 7 16:00:00 - 16:59:59 787 6.7% 0.222.3 MB 6.4% 0.64
Dec 7 17:00:00 - 17:59:59 699 6.0% 0.192.0 MB 5.7% 0.57
Dec 7 18:00:00 - 18:59:59 620 5.3% 0.171.9 MB 5.2% 0.53
Dec 7 19:00:00 - 19:59:59 603 5.2% 0.171.8 MB 5.1% 0.52
Dec 7 20:00:00 - 20:59:59 549 4.7% 0.151.5 MB 4.3% 0.44
Dec 7 21:00:00 - 21:59:59 446 3.8% 0.121.5 MB 4.2% 0.42
Dec 7 22:00:00 - 22:59:59 542 4.6% 0.151.8 MB 5.1% 0.51
Dec 7 23:00:00 - 23:59:59 479 4.1% 0.131.7 MB 4.9% 0.49
Dec 8 00:00:00 - 00:59:59 379 3.2% 0.111.7 MB 4.8% 0.49
Dec 8 01:00:00 - 01:59:59 357 3.1% 0.101.9 MB 5.3% 0.54
Dec 8 02:00:00 - 02:59:59 260 2.2% 0.071013.7 KB 2.8% 0.28
Dec 8 03:00:00 - 03:59:59 198 1.7% 0.06776.7 KB 2.1% 0.22
Dec 8 04:00:00 - 04:59:59 211 1.8% 0.06781.4 KB 2.1% 0.22
Dec 8 05:00:00 - 05:59:59 240 2.1% 0.07798.2 KB 2.2% 0.22
Dec 8 06:00:00 - 06:59:59 245 2.1% 0.07636.1 KB 1.7% 0.18
Dec 8 07:00:00 - 07:59:59 330 2.8% 0.091011.1 KB 2.8% 0.28
Dec 8 08:00:00 - 08:59:59 449 3.8% 0.121.3 MB 3.6% 0.36
Dec 8 09:00:00 - 09:59:59 569 4.9% 0.161.5 MB 4.1% 0.42
Dec 8 10:00:00 - 10:59:59 550 4.7% 0.151.3 MB 3.8% 0.38
Dec 8 11:00:00 - 11:59:59 517 4.4% 0.141.4 MB 4.1% 0.41
Dec 8 12:00:00 - 12:59:59 574 4.9% 0.161.6 MB 4.4% 0.44
Dec 8 13:00:00 - 13:59:59 664 5.7% 0.181.8 MB 5.0% 0.50
Dec 8 14:00:00 - 14:59:59 631 5.4% 0.181.7 MB 4.8% 0.49
Dec 8 15:00:00 - 15:00:03 3 0.0% 1.0010.8 KB 0.0% 3.61
TOTAL: 24:00:02 11677 100.0% 0.1435.6 MB 100.0% 0.42
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB881.9 MB 86.1% 9 0.18 69.18
ONEDEFAULT1024.0 MB35.0 MB 3.4% 12 0.18 68.48
THREEDEFAULT1024.0 MB894.8 MB 87.4% 9 0.18 68.57
TWODEFAULT1024.0 MB885.9 MB 86.5% 9 0.17 69.41
TOTAL: 4-4.0 GB2.6 GB 65.9% 39 0.18-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 662 4 0 0 1 0 0 0 657
2hasname-out.news.weretis.net 427 11 0 0 0 0 0 0 416
3news-out.aioe.org 38 0 0 0 0 0 0 0 38
TOTAL: 3 1127 15 0 0 1 0 0 0 1111

Unwanted newsgroups [Top 20]:

NewsgroupCount
sybase.public.powerdesigner.general 9
panix.chat.politics 4
alt.biz 1
wolfsburg.test 1
TOTAL: 4 15

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 411
EMP (phn path) 283
EMP (phl) 134
EMP (phn nph) 21
Binary: misplaced binary 8
HTML Multipart 5
Scoring filter 4
TOTAL: 7 866

INND no permission servers:

SystemConn
167.248.133.63 1
TOTAL: 1 1

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 206
news-out.aioe.org 38
news.nntp4.net 1
TOTAL: 3 245
TOTAL: 1 245

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 311 311 0 0 0 0100%18:34:13
2aioe 10626 136 7956 26 0 0 1%23:50:01
3nntp4 13889 0 10900 0 0 0 0%23:58:24
4weretis 3893 0 3797 7 0 0 0%23:50:01
TOTAL: 4 28719 447 22653 33 0 0 1%90:12:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.2 MB0.0 KB1.2 MB0.0 KB/s3.9 KB18:34:13
2aioe482.8 KB60.6 KB543.4 KB0.0 KB/s3.4 KB23:50:01
3nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:58:24
4weretis0.0 KB48.0 KB48.0 KB0.0 KB/s6.9 KB23:50:01
TOTAL: 41.7 MB108.6 KB1.8 MB0.0 KB/s3.8 KB90:12:39
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
164.92.106.15 0.002 0.002 0.00000:00:00
147.182.247.10 0.001 0.005 0.00000:00:00
143.110.240.247 0.006 0.012 0.00000:00:00
147.182.225.86 0.001 0.003 0.00000:00:00
ec2-35-87-93-3.us-west-2.compute.amazonaws.com 0.001 0.001 0.00000:00:00
192.241.192.20 0.000 0.003 0.00000:00:00
192.241.205.84 0.000 0.002 0.00000:00:00
scanner-27.ch1.censys-scanner.com 0.000 0.002 0.00000:00:00
104.152.52.111 0.000 0.002 0.00000:00:00
TOTAL: 9 0.011 0.032 0.00000:00:00

NNRP no permission clients:

SystemConn
143.110.240.247 8
147.182.247.10 2
164.92.106.15 2
147.182.225.86 2
104.152.52.111 1
ec2-35-87-93-3.us-west-2.compute.amazonaws.com 1
scanner-27.ch1.censys-scanner.com 1
192.241.192.20 1
192.241.205.84 1
TOTAL: 9 19