Daily Usenet report

Jun 2 15:00:08 -- Jun 3 15:00:11

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jun 2 15:05:12 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 30182 67.4%3.4 MB 68.8%
innd 12764 28.5%1.3 MB 26.4%
innfeed 1201 2.7%156.6 KB 3.1%
cnfsstat 576 1.3%79.8 KB 1.6%
nnrpd 24 0.1%2.5 KB 0.1%
overchan 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 44750 100.0%4.9 MB100.0%

History cache:

ReasonCount%Count
Negative hits 80330 47.9%
Positive hits 57516 34.3%
Do not exist 28620 17.1%
Cache misses 1332 0.8%
TOTAL: 4 167798 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:01:11.827 0.1%1299 0.000 55.294 569.250
article cleanup00:00:00.181 0.0%28702 0.000 0.006 0.023
article logging00:00:01.580 0.0%28960 0.000 0.055 4.981
article parse00:00:00.421 0.0%47693 0.000 0.009 0.021
article write00:00:09.899 0.0%17538 0.000 0.564 10.435
artlog/artcncl00:00:00.020 0.0%1234 0.000 0.016 0.111
data move00:00:00.085 0.0%175588 0.000 0.000 0.002
hisgrep/artcncl00:00:00.015 0.0%1295 0.000 0.012 0.250
hishave/artcncl00:00:02.371 0.0%1299 0.000 1.825 367.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:20:59.308 1.5%167153 0.002 7.534 50.251
history sync00:00:00.360 0.0%388 0.000 0.928 147.000
history write00:01:40.521 0.1%28702 0.006 3.502 68.213
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:35:20.489 98.2%170401 142.844 498.357 869.588
nntp read00:00:01.244 0.0%175013 0.001 0.007 0.015
overview write00:00:00.064 0.0%17538 0.000 0.004 0.059
perl filter00:00:43.745 0.1%28702 0.412 1.524 16.465
python filter00:00:00.789 0.0%28702 0.006 0.027 0.057
site send00:00:02.801 0.0%52614 0.028 0.053 0.103
TOTAL: 24:00:59.70524:00:15.720 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.032 0.0%17505 0.000 0.002 0.019
article prepare00:00:00.000 0.0%552 0.000 0.000 0.000
article read00:00:00.155 0.0%475 0.000 0.326 25.600
backlog stats00:00:00.051 0.0%78013 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.452 0.0%53116 0.000 0.009 0.026
data write00:00:00.987 0.0%36262 0.005 0.027 0.103
idle23:58:22.342100.0%78013 117.552 1106.256 3697.902
status file00:00:04.557 0.0%227 0.000 20.075 589.000
TOTAL: 23:58:31.99723:58:28.576100.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%6 0.000 0.000 0.000
TOTAL: 00:00:02.04300:00:00.000 0.0%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 146
name 2
pause 2
paused 2
reserve 2
TOTAL: 10 166

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 9 53188 11320 31773 10095 21%49:49:12
2news-out.aioe.org 2 12820 3912 8907 1 30%24:18:07
3news.nntp4.net 2 22039 2646 18249 1144 12%25:04:55
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 14 88047 17878 58929 11240 20%99:12:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net33.6 MB0.0 KB20.8 MB54.3 MB 61%2.6 KB
2news-out.aioe.org10.9 MB0.0 KB4.4 KB10.9 MB 99%2.9 KB
3news.nntp4.net6.3 MB0.0 KB3.6 MB9.9 MB 63%2.7 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 450.8 MB0.0 KB24.4 MB75.2 MB 67%2.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 2 15:00:08 - 15:59:59 2088 11.9% 0.584.3 MB 8.5% 1.21
Jun 2 16:00:00 - 16:59:59 984 5.6% 0.273.3 MB 6.6% 0.94
Jun 2 17:00:00 - 17:59:59 875 5.0% 0.242.4 MB 4.8% 0.68
Jun 2 18:00:00 - 18:59:59 926 5.3% 0.262.7 MB 5.4% 0.76
Jun 2 19:00:00 - 19:59:59 852 4.9% 0.242.2 MB 4.4% 0.62
Jun 2 20:00:00 - 20:59:59 885 5.0% 0.252.2 MB 4.4% 0.63
Jun 2 21:00:00 - 21:59:59 586 3.3% 0.161.6 MB 3.2% 0.45
Jun 2 22:00:00 - 22:59:59 456 2.6% 0.131.9 MB 3.8% 0.53
Jun 2 23:00:00 - 23:59:59 529 3.0% 0.151.6 MB 3.2% 0.46
Jun 3 00:00:00 - 00:59:59 607 3.5% 0.172.5 MB 5.1% 0.72
Jun 3 01:00:00 - 01:59:59 482 2.8% 0.132.2 MB 4.3% 0.62
Jun 3 02:00:00 - 02:59:59 453 2.6% 0.131.4 MB 2.8% 0.40
Jun 3 03:00:00 - 03:59:59 242 1.4% 0.07896.0 KB 1.8% 0.25
Jun 3 04:00:00 - 04:59:59 338 1.9% 0.091.1 MB 2.2% 0.31
Jun 3 05:00:00 - 05:59:59 367 2.1% 0.10978.8 KB 1.9% 0.27
Jun 3 06:00:00 - 06:59:59 499 2.8% 0.141.3 MB 2.6% 0.38
Jun 3 07:00:00 - 07:59:59 631 3.6% 0.181.7 MB 3.5% 0.49
Jun 3 08:00:00 - 08:59:59 626 3.6% 0.171.6 MB 3.2% 0.45
Jun 3 09:00:00 - 09:59:59 850 4.8% 0.242.2 MB 4.3% 0.61
Jun 3 10:00:00 - 10:59:59 735 4.2% 0.202.0 MB 4.0% 0.57
Jun 3 11:00:00 - 11:59:59 750 4.3% 0.212.1 MB 4.3% 0.61
Jun 3 12:00:00 - 12:59:59 848 4.8% 0.242.7 MB 5.5% 0.77
Jun 3 13:00:00 - 13:59:59 899 5.1% 0.252.3 MB 4.7% 0.66
Jun 3 14:00:00 - 14:59:59 1004 5.7% 0.282.8 MB 5.6% 0.79
Jun 3 15:00:00 - 15:00:11 14 0.1% 1.2754.0 KB 0.1% 4.91
TOTAL: 24:00:03 17526 100.0% 0.2049.9 MB 100.0% 0.59
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB250.7 MB 24.5% 1 0.26 47.17
ONEDEFAULT1024.0 MB410.4 MB 40.1% 3 0.26 46.58
THREEDEFAULT1024.0 MB254.5 MB 24.9% 1 0.26 47.14
TWODEFAULT1024.0 MB252.3 MB 24.6% 1 0.26 46.67
TOTAL: 4-4.0 GB1.1 GB 28.5% 6 0.26-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.news.weretis.net 10260 1 0 0 0 0 0 010259
2news.nntp4.net 1056 20 0 0 1 0 0 0 1035
3news-out.aioe.org 106 0 0 0 0 0 0 0 106
TOTAL: 3 11422 21 0 0 1 0 0 011400

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.blah 14
0.test 2
nb.test 1
bit.test 1
finet.test 1
alt.math 1
biz.misc 1
TOTAL: 7 21

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) 10565
EMP (md5) 458
EMP (phl) 36
EMP (phn nph) 35
Too many newsgroups 23
User-issued spam cancel 9
Scoring filter 8
HTML Multipart 5
HTML post 2
Binary: misplaced binary 1
TOTAL: 10 11142

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 147
news-out.aioe.org 105
news.nntp4.net 6
TOTAL: 3 258
TOTAL: 1 258

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 454 454 0 0 0 0100%20:55:55
2aioe 13729 9 13412 5 0 12 0%23:59:58
3weretis 6485 0 6239 11 0 0 0%23:59:58
4nntp4 15150 0 14975 0 0 0 0%23:59:55
TOTAL: 4 35818 463 34626 16 0 12 1%92:55:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.1 MB0.0 KB2.1 MB0.0 KB/s4.7 KB20:55:55
2aioe20.5 KB22.3 KB42.8 KB0.0 KB/s3.1 KB23:59:58
3weretis0.0 KB185.6 KB185.6 KB0.0 KB/s16.9 KB23:59:58
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 42.1 MB207.8 KB2.3 MB0.0 KB/s4.9 KB92:55:46
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.003 0.009 0.00000:00:01
scanner-09.ch1.censys-scanner.com 0.001 0.004 0.00000:00:00
scanner-06.ch1.censys-scanner.com 0.003 0.004 0.00000:00:00
TOTAL: 3 0.007 0.017 0.00000:00:02

NNRP no permission clients:

SystemConn
news.nntp4.net 3
scanner-06.ch1.censys-scanner.com 2
scanner-09.ch1.censys-scanner.com 1
TOTAL: 3 6