Daily Usenet report

Oct 21 15:00:01 -- Oct 22 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 16323 75.3%2.0 MB 73.0%
innd 3572 16.5%491.3 KB 17.9%
innfeed 1188 5.5%159.7 KB 5.8%
cnfsstat 576 2.7%89.1 KB 3.2%
nnrpd 12 0.1%1.2 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 21673 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 45148 44.5%
Positive hits 40387 39.8%
Do not exist 15797 15.6%
Cache misses 53 0.1%
TOTAL: 4 101385 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:05.404 0.0%65 0.000 83.138 2438.000
article cleanup00:00:00.104 0.0%15836 0.000 0.007 0.032
article logging00:00:00.454 0.0%16144 0.000 0.028 0.075
article parse00:00:00.266 0.0%29637 0.000 0.009 0.045
article write00:00:03.820 0.0%13679 0.000 0.279 15.353
artlog/artcncl00:00:00.003 0.0%61 0.000 0.049 1.000
data move00:00:00.070 0.0%112734 0.000 0.001 0.004
hisgrep/artcncl00:00:00.001 0.0%64 0.000 0.016 0.500
hishave/artcncl00:00:01.621 0.0%65 0.000 24.938 1486.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:46.575 0.1%101622 0.001 0.458 8.983
history sync00:00:00.015 0.0%350 0.000 0.043 0.667
history write00:00:07.845 0.0%15836 0.000 0.495 15.757
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:49:05.108 99.9%112468 454.133 762.396 2401.140
nntp read00:00:00.875 0.0%112489 0.000 0.008 0.020
overview write00:00:00.040 0.0%13679 0.000 0.003 0.037
perl filter00:00:19.533 0.0%15836 0.787 1.233 12.000
python filter00:00:00.445 0.0%15836 0.000 0.028 0.076
site send00:00:02.378 0.0%41037 0.018 0.058 0.093
TOTAL: 23:50:52.76123:50:34.557100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.033 0.0%13760 0.000 0.002 0.023
article prepare00:00:00.000 0.0%716 0.000 0.000 0.000
article read00:00:00.032 0.0%540 0.000 0.059 1.000
backlog stats00:00:00.055 0.0%76465 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.384 0.0%46981 0.000 0.008 0.036
data write00:00:01.004 0.0%33324 0.000 0.030 0.103
idle23:59:42.698100.0%76465 599.697 1129.702 3463.783
status file00:00:00.067 0.0%222 0.000 0.302 1.000
TOTAL: 23:59:46.38523:59:44.273100.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%3 0.000 0.000 0.000
TOTAL: 00:00:00.92500: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 3 27383 9477 16997 909 34%48:22:09
2news-out.aioe.org 3 13363 3741 9612 10 27%23:43:47
3news.nntp4.net 1 15651 513 13889 1249 3%23:48:09
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 8 56397 13731 40498 2168 24%95:54:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net31.4 MB0.0 KB1.8 MB33.2 MB 94%3.3 KB
2news-out.aioe.org10.6 MB0.0 KB20.5 KB10.6 MB 99%2.9 KB
3news.nntp4.net1.8 MB0.0 KB4.1 MB5.9 MB 30%3.4 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 443.8 MB0.0 KB5.9 MB49.7 MB 88%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 21 15:00:01 - 15:59:59 745 5.4% 0.212.6 MB 6.0% 0.75
Oct 21 16:00:00 - 16:59:59 850 6.2% 0.242.6 MB 6.0% 0.75
Oct 21 17:00:00 - 17:59:59 709 5.2% 0.202.7 MB 6.2% 0.77
Oct 21 18:00:00 - 18:59:59 770 5.6% 0.212.2 MB 5.1% 0.64
Oct 21 19:00:00 - 19:59:59 666 4.8% 0.182.0 MB 4.6% 0.58
Oct 21 20:00:00 - 20:59:59 683 5.0% 0.192.0 MB 4.5% 0.57
Oct 21 21:00:00 - 21:59:59 686 5.0% 0.192.4 MB 5.4% 0.68
Oct 21 22:00:00 - 22:59:59 501 3.6% 0.141.9 MB 4.2% 0.53
Oct 21 23:00:00 - 23:59:59 437 3.2% 0.121.6 MB 3.6% 0.45
Oct 22 00:00:00 - 00:59:59 359 2.6% 0.101.5 MB 3.5% 0.43
Oct 22 01:00:00 - 01:59:59 267 1.9% 0.071.1 MB 2.6% 0.32
Oct 22 02:00:00 - 02:59:59 258 1.9% 0.07893.5 KB 2.0% 0.25
Oct 22 03:00:00 - 03:59:59 256 1.9% 0.07836.9 KB 1.9% 0.23
Oct 22 04:00:00 - 04:59:59 283 2.1% 0.08917.0 KB 2.0% 0.25
Oct 22 05:00:00 - 05:59:59 298 2.2% 0.08853.3 KB 1.9% 0.24
Oct 22 06:00:00 - 06:59:59 414 3.0% 0.121.2 MB 2.7% 0.34
Oct 22 07:00:00 - 07:59:59 593 4.3% 0.161.7 MB 3.9% 0.48
Oct 22 08:00:00 - 08:59:59 641 4.7% 0.181.9 MB 4.4% 0.55
Oct 22 09:00:00 - 09:59:59 743 5.4% 0.212.1 MB 4.7% 0.59
Oct 22 10:00:00 - 10:59:59 728 5.3% 0.202.2 MB 5.1% 0.64
Oct 22 11:00:00 - 11:59:59 751 5.5% 0.212.0 MB 4.6% 0.58
Oct 22 12:00:00 - 12:59:59 743 5.4% 0.212.3 MB 5.2% 0.66
Oct 22 13:00:00 - 13:59:59 689 5.0% 0.192.0 MB 4.5% 0.56
Oct 22 14:00:00 - 14:59:59 688 5.0% 0.192.3 MB 5.3% 0.67
Oct 22 15:00:00 - 15:00:02 1 0.0% 0.504.0 KB 0.0% 1.99
TOTAL: 24:00:01 13759 100.0% 0.1644.0 MB 100.0% 0.52
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB608.2 MB 59.4% 3 0.21 56.62
ONEDEFAULT1024.0 MB770.6 MB 75.3% 5 0.21 57.19
THREEDEFAULT1024.0 MB612.1 MB 59.8% 3 0.22 56.21
TWODEFAULT1024.0 MB604.7 MB 59.1% 3 0.21 56.84
TOTAL: 4-4.0 GB2.5 GB 63.4% 14 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1294 9 0 0 1 0 0 0 1284
2hasname-out.news.weretis.net 1149 4 0 0 0 0 0 0 1145
3news-out.aioe.org 60 0 0 0 0 0 0 0 60
TOTAL: 3 2503 13 0 0 1 0 0 0 2489

Unwanted newsgroups [Top 20]:

NewsgroupCount
0.test 4
alt.bestjobsusa.jobs.offered 3
alt.bestjobsusa.philly.jobs 2
intel.motherboards.pentium_ii 2
alt.atheist 1
wolfsburg.test 1
TOTAL: 6 13

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) 1464
EMP (md5) 350
EMP (phn nph) 231
EMP (phl) 83
User-issued spam cancel 43
HTML Multipart 7
Binary: misplaced binary 2
Scoring filter 1
TOTAL: 8 2181

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 258
news-out.aioe.org 50
TOTAL: 2 308
TOTAL: 1 308

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 484 484 0 0 0 0100%21:19:59
2aioe 12223 30 9833 0 0 3 0%23:59:57
3nntp4 15520 2 13236 0 0 0 0%23:59:52
4weretis 4513 0 4255 26 0 0 0%23:59:58
TOTAL: 4 32740 516 27324 26 0 3 1%93:19:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.9 MB0.0 KB1.9 MB0.0 KB/s4.1 KB21:19:59
2aioe145.3 KB0.0 KB145.3 KB0.0 KB/s4.8 KB23:59:57
3nntp43.2 KB0.0 KB3.2 KB0.0 KB/s1.6 KB23:59:52
4weretis0.0 KB106.8 KB106.8 KB0.0 KB/s4.1 KB23:59:58
TOTAL: 42.1 MB106.8 KB2.2 MB0.0 KB/s4.1 KB93:19:46
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.002 0.006 0.00000:00:00
scanner-07.ch1.censys-scanner.com 0.001 0.003 0.00000:00:00
TOTAL: 2 0.003 0.009 0.00000:00:00

NNRP no permission clients:

SystemConn
news.nntp4.net 2
scanner-07.ch1.censys-scanner.com 1
TOTAL: 2 3