Daily Usenet report

Dec 13 15:00:01 -- Dec 14 14:59:58

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 13 15:00:52 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 14185 74.3%1.7 MB 72.0%
innd 3014 15.8%416.9 KB 17.2%
innfeed 1236 6.5%174.4 KB 7.2%
cnfsstat 576 3.0%77.0 KB 3.2%
nnrpd 86 0.5%9.2 KB 0.4%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 19098 100.0%2.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 34581 41.9%
Positive hits 34172 41.4%
Do not exist 13400 16.2%
Cache misses 364 0.4%
TOTAL: 4 82517 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.513 0.0%409 0.000 3.699 79.625
article cleanup00:00:00.077 0.0%13481 0.000 0.006 0.052
article logging00:00:00.341 0.0%13788 0.000 0.025 0.091
article parse00:00:00.223 0.0%22994 0.000 0.010 0.046
article write00:00:00.660 0.0%12064 0.000 0.055 0.732
artlog/artcncl00:00:00.005 0.0%409 0.000 0.012 1.000
data move00:00:00.030 0.0%89050 0.000 0.000 0.005
hisgrep/artcncl00:00:00.004 0.0%404 0.000 0.010 0.083
hishave/artcncl00:00:00.001 0.0%409 0.000 0.002 0.024
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.393 0.0%82585 0.000 0.005 0.062
history sync00:00:00.011 0.0%409 0.000 0.027 0.333
history write00:00:01.802 0.0%13481 0.000 0.134 10.758
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle24:00:42.161100.0%89570 276.217 965.079 3803.304
nntp read00:00:00.662 0.0%89345 0.000 0.007 0.021
overview write00:00:00.040 0.0%12064 0.000 0.003 0.026
perl filter00:00:12.762 0.0%13481 0.487 0.947 1.387
python filter00:00:00.391 0.0%13481 0.000 0.029 0.069
site send00:00:02.480 0.0%36191 0.032 0.069 0.145
TOTAL: 24:01:11.46324:01:03.556100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%12065 0.000 0.002 0.034
article prepare00:00:00.001 0.0%764 0.000 0.001 0.111
article read00:00:00.018 0.0%443 0.000 0.041 0.500
backlog stats00:00:00.032 0.0%71084 0.000 0.000 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.304 0.0%42133 0.000 0.007 0.038
data write00:00:00.802 0.0%30132 0.000 0.027 0.075
idle23:58:51.905100.0%71084 318.663 1214.505 3399.712
status file00:00:00.068 0.0%257 0.000 0.265 1.000
TOTAL: 23:58:54.63123:58:53.158100.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.1%18 0.000 0.056 1.000
TOTAL: 00:00:01.70400:00:00.001 0.1%----

Control commands to INND:

CommandNumber
flush 1
go 2
logmode 1
lowmark 1
mode 146
name 1
pause 1
paused 1
reserve 2
TOTAL: 9 156

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 5 22534 6703 15513 318 29%48:13:41
2news-out.aioe.org 3 12323 4665 7645 13 37%24:34:21
3news.nntp4.net 2 12100 731 10328 1041 6%22:13:39
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 11 46957 12099 33486 1372 25%95:01:41
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net20.1 MB0.0 KB723.9 KB20.8 MB 96%3.0 KB
2news-out.aioe.org11.2 MB0.0 KB16.3 KB11.2 MB 99%2.5 KB
3news.nntp4.net2.4 MB0.0 KB2.8 MB5.2 MB 46%3.0 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 433.7 MB0.0 KB3.5 MB37.2 MB 90%2.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 13 15:00:01 - 15:59:59 710 5.9% 0.202.0 MB 5.9% 0.56
Dec 13 16:00:00 - 16:59:59 759 6.3% 0.212.1 MB 6.3% 0.60
Dec 13 17:00:00 - 17:59:59 725 6.0% 0.202.1 MB 6.1% 0.58
Dec 13 18:00:00 - 18:59:59 784 6.5% 0.222.1 MB 6.3% 0.60
Dec 13 19:00:00 - 19:59:59 625 5.2% 0.171.9 MB 5.6% 0.53
Dec 13 20:00:00 - 20:59:59 581 4.8% 0.161.5 MB 4.5% 0.43
Dec 13 21:00:00 - 21:59:59 937 7.8% 0.261.9 MB 5.7% 0.55
Dec 13 22:00:00 - 22:59:59 442 3.7% 0.121.1 MB 3.4% 0.32
Dec 13 23:00:00 - 23:59:59 355 2.9% 0.10926.2 KB 2.7% 0.26
Dec 14 00:00:00 - 00:59:59 262 2.2% 0.07702.5 KB 2.0% 0.20
Dec 14 01:00:00 - 01:59:59 209 1.7% 0.06617.0 KB 1.8% 0.17
Dec 14 02:00:00 - 02:59:59 194 1.6% 0.05820.4 KB 2.4% 0.23
Dec 14 03:00:00 - 03:59:59 202 1.7% 0.06685.6 KB 2.0% 0.19
Dec 14 04:00:00 - 04:59:59 235 1.9% 0.07731.9 KB 2.1% 0.20
Dec 14 05:00:00 - 05:59:59 241 2.0% 0.07755.4 KB 2.2% 0.21
Dec 14 06:00:00 - 06:59:59 252 2.1% 0.07855.1 KB 2.5% 0.24
Dec 14 07:00:00 - 07:59:59 374 3.1% 0.101.0 MB 3.0% 0.29
Dec 14 08:00:00 - 08:59:59 475 3.9% 0.131.6 MB 4.7% 0.45
Dec 14 09:00:00 - 09:59:59 578 4.8% 0.161.7 MB 5.2% 0.49
Dec 14 10:00:00 - 10:59:59 558 4.6% 0.151.6 MB 4.7% 0.45
Dec 14 11:00:00 - 11:59:59 644 5.3% 0.181.7 MB 5.0% 0.48
Dec 14 12:00:00 - 12:59:59 594 4.9% 0.171.8 MB 5.3% 0.51
Dec 14 13:00:00 - 13:59:59 580 4.8% 0.161.7 MB 5.0% 0.47
Dec 14 14:00:00 - 14:59:58 747 6.2% 0.211.9 MB 5.7% 0.55
TOTAL: 23:59:57 12063 100.0% 0.1433.6 MB 100.0% 0.40
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB967.1 MB 94.4% 9 0.18 69.08
ONEDEFAULT1024.0 MB120.0 MB 11.7% 12 0.17 69.70
THREEDEFAULT1024.0 MB978.9 MB 95.6% 9 0.18 68.62
TWODEFAULT1024.0 MB970.6 MB 94.8% 9 0.17 69.99
TOTAL: 4-4.0 GB3.0 GB 74.1% 39 0.18-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1083 3 0 0 0 0 0 0 1080
2hasname-out.news.weretis.net 505 10 0 0 0 0 0 0 495
3news-out.aioe.org 125 0 0 0 0 0 0 0 125
TOTAL: 3 1713 13 0 0 0 0 0 0 1700

Unwanted newsgroups [Top 20]:

NewsgroupCount
sybase.public.powerdesigner.general 5
de.comm.geraete.mobil 3
alt.business.import.export 1
aol.neighborhood.ca.fresno.marketplace 1
alt.business.ads 1
panix.chat.politics 1
chico.forsale 1
TOTAL: 7 13

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 634
EMP (md5) 515
EMP (phl) 183
EMP (phn nph) 55
HTML Multipart 4
Scoring filter 3
TOTAL: 6 1394

INND no permission servers:

SystemConn
162.142.125.210 1
TOTAL: 1 1

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 188
news-out.aioe.org 114
news.nntp4.net 4
TOTAL: 3 306
TOTAL: 1 306

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 335 335 0 0 0 0100%19:01:28
2aioe 9480 91 7063 3 0 0 0%23:50:01
3nntp4 14304 1 11233 0 0 10 0%23:57:06
4weretis 5350 0 5221 10 0 0 0%23:50:01
TOTAL: 4 29469 427 23517 13 0 10 1%90:38:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.0 MB0.0 KB1.0 MB0.0 KB/s3.2 KB19:01:28
2aioe332.8 KB11.5 KB344.2 KB0.0 KB/s3.7 KB23:50:01
3nntp43.8 KB0.0 KB3.8 KB0.0 KB/s3.8 KB23:57:06
4weretis0.0 KB27.2 KB27.2 KB0.0 KB/s2.7 KB23:50:01
TOTAL: 41.4 MB38.6 KB1.4 MB0.0 KB/s3.3 KB90:38:36
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
23.225.163.215 0.002 0.004 0.00000:00:00
194.165.16.76 0.005 0.001 0.00000:00:00
147.182.247.10 0.003 0.008 0.00000:00:00
skilful.monitoring.internet-measurement.com 0.001 0.002 0.00000:00:00
164.92.106.15 0.001 0.003 0.00000:00:00
147.182.241.81 0.001 0.003 0.00000:00:00
192.241.199.206 0.000 0.002 0.00000:00:00
scanner-08.ch1.censys-scanner.com 0.000 0.003 0.00000:00:00
104.152.52.199 0.000 0.002 0.00000:00:00
104.152.52.225 0.002 0.000 0.00000:00:00
? 0.000 0.001 0.00000:00:00
TOTAL: 11 0.015 0.029 0.00000:00:01

NNRP no permission clients:

SystemConn
147.182.247.10 4
23.225.163.215 2
147.182.241.81 2
164.92.106.15 2
194.165.16.76 2
scanner-08.ch1.censys-scanner.com 1
skilful.monitoring.internet-measurement.com 1
104.152.52.199 1
192.241.199.206 1
104.152.52.225 1
TOTAL: 10 17

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1