Daily Usenet report

Jun 15 15:00:01 -- Jun 16 15:00:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jun 15 15:01:27 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Jun 16 08:45:02 colo-sc-1 pgpverify[7505]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 12998 73.5%1.6 MB 70.7%
innd 2770 15.7%388.1 KB 17.2%
innfeed 1278 7.2%179.9 KB 8.0%
cnfsstat 576 3.3%86.0 KB 3.8%
nnrpd 50 0.3%5.1 KB 0.2%
controlchan 3 0.0%0.3 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 8 17677 100.0%2.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 38217 45.6%
Positive hits 33011 39.4%
Do not exist 12589 15.0%
Cache misses 22 0.0%
TOTAL: 4 83839 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.064 0.0%77 0.000 0.831 4.111
article cleanup00:00:00.079 0.0%12651 0.000 0.006 0.034
article logging00:00:00.378 0.0%12920 0.000 0.029 0.083
article parse00:00:00.236 0.0%24010 0.000 0.010 0.050
article write00:00:00.579 0.0%11240 0.000 0.052 0.452
artlog/artcncl00:00:00.002 0.0%77 0.000 0.026 0.333
data move00:00:00.048 0.0%93630 0.000 0.001 0.004
hisgrep/artcncl00:00:00.000 0.0%75 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%77 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.508 0.0%84186 0.000 0.042 0.811
history sync00:00:00.012 0.0%337 0.000 0.036 0.500
history write00:00:03.337 0.0%12651 0.000 0.264 13.037
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle24:00:16.445100.0%93506 544.285 924.181 3370.562
nntp read00:00:00.703 0.0%93383 0.000 0.008 0.024
overview write00:00:00.044 0.0%11240 0.000 0.004 0.034
perl filter00:00:14.498 0.0%12651 0.810 1.146 5.609
python filter00:00:00.371 0.0%12651 0.000 0.029 0.120
site send00:00:02.034 0.0%33721 0.024 0.060 0.096
TOTAL: 24:00:52.60324:00:42.338100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%11228 0.000 0.003 0.029
article prepare00:00:00.001 0.0%680 0.000 0.001 0.500
article read00:00:00.023 0.0%380 0.000 0.061 1.000
backlog stats00:00:00.052 0.0%58806 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.310 0.0%36525 0.000 0.008 0.025
data write00:00:00.682 0.0%25426 0.000 0.027 0.090
idle23:58:52.865100.0%58806 815.421 1468.096 3594.787
status file00:00:00.868 0.0%274 0.000 3.168 197.500
TOTAL: 23:58:56.90423:58:54.830100.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.5%10 0.000 0.100 1.000
TOTAL: 00:00:00.21800:00:00.001 0.5%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de000200
TOTAL000200

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 8 22020 7282 14451 287 33%48:24:07
2news-out.aioe.org 2 11796 3749 7894 153 31%24:48:50
3news.nntp4.net 1 10561 365 9155 1041 3%20:31:04
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 12 44377 11396 31500 1481 25%93:44:01
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net23.4 MB0.0 KB529.3 KB23.9 MB 97%3.2 KB
2news-out.aioe.org9.9 MB0.0 KB217.6 KB10.1 MB 97%2.7 KB
3news.nntp4.net1.2 MB0.0 KB4.1 MB5.4 MB 23%3.9 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 434.6 MB0.0 KB4.8 MB39.4 MB 87%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 15 15:00:01 - 15:59:59 677 6.0% 0.192.0 MB 5.9% 0.57
Jun 15 16:00:00 - 16:59:59 624 5.6% 0.172.0 MB 5.9% 0.57
Jun 15 17:00:00 - 17:59:59 598 5.3% 0.171.6 MB 4.6% 0.45
Jun 15 18:00:00 - 18:59:59 518 4.6% 0.141.6 MB 4.6% 0.45
Jun 15 19:00:00 - 19:59:59 585 5.2% 0.161.9 MB 5.6% 0.55
Jun 15 20:00:00 - 20:59:59 590 5.3% 0.161.5 MB 4.5% 0.44
Jun 15 21:00:00 - 21:59:59 475 4.2% 0.131.5 MB 4.3% 0.42
Jun 15 22:00:00 - 22:59:59 405 3.6% 0.111.4 MB 4.1% 0.39
Jun 15 23:00:00 - 23:59:59 316 2.8% 0.091.3 MB 3.7% 0.36
Jun 16 00:00:00 - 00:59:59 306 2.7% 0.09990.0 KB 2.8% 0.27
Jun 16 01:00:00 - 01:59:59 274 2.4% 0.081.5 MB 4.4% 0.43
Jun 16 02:00:00 - 02:59:59 199 1.8% 0.06591.7 KB 1.7% 0.16
Jun 16 03:00:00 - 03:59:59 196 1.7% 0.05582.0 KB 1.7% 0.16
Jun 16 04:00:00 - 04:59:59 248 2.2% 0.07703.2 KB 2.0% 0.20
Jun 16 05:00:00 - 05:59:59 312 2.8% 0.09945.8 KB 2.7% 0.26
Jun 16 06:00:00 - 06:59:59 386 3.4% 0.111.3 MB 3.7% 0.36
Jun 16 07:00:00 - 07:59:59 447 4.0% 0.121.5 MB 4.4% 0.42
Jun 16 08:00:00 - 08:59:59 474 4.2% 0.131.2 MB 3.6% 0.35
Jun 16 09:00:00 - 09:59:59 574 5.1% 0.161.6 MB 4.7% 0.45
Jun 16 10:00:00 - 10:59:59 577 5.1% 0.161.6 MB 4.6% 0.45
Jun 16 11:00:00 - 11:59:59 539 4.8% 0.151.5 MB 4.4% 0.42
Jun 16 12:00:00 - 12:59:59 661 5.9% 0.181.7 MB 4.9% 0.48
Jun 16 13:00:00 - 13:59:59 652 5.8% 0.182.1 MB 6.1% 0.59
Jun 16 14:00:00 - 14:59:59 603 5.4% 0.171.7 MB 5.1% 0.49
Jun 16 15:00:00 - 15:00:02 1 0.0% 0.503.9 KB 0.0% 1.95
TOTAL: 24:00:01 11237 100.0% 0.1334.1 MB 100.0% 0.40
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB410.1 MB 40.0% 7 0.17 72.53
ONEDEFAULT1024.0 MB585.4 MB 57.2% 9 0.17 70.91
THREEDEFAULT1024.0 MB421.7 MB 41.2% 7 0.17 71.87
TWODEFAULT1024.0 MB414.2 MB 40.4% 7 0.17 71.87
TOTAL: 4-4.0 GB1.8 GB 44.7% 30 0.17-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 993 12 0 0 1 0 0 0 980
2hasname-out.news.weretis.net 514 12 0 0 0 0 0 0 502
3news-out.aioe.org 177 0 0 0 0 0 0 0 177
TOTAL: 3 1684 24 0 0 1 0 0 0 1659

Unwanted newsgroups [Top 20]:

NewsgroupCount
wolfsburg.test 7
gun.general 4
alt.buttered.scones 3
houston.swingers 2
houston.jobs 2
panix.test 1
3dfx.game.support 1
panix.chat.politics 1
alt.ads 1
alt.sex.gay 1
intel.motherboards.pentium_ii 1
TOTAL: 11 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) 598
EMP (md5) 560
EMP (phn nph) 112
EMP (phl) 105
HTML Multipart 9
Binary: misplaced binary 4
Scoring filter 3
HTML post 1
TOTAL: 8 1392

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 231
news-out.aioe.org 36
TOTAL: 2 267
TOTAL: 1 267

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 285 285 0 0 0 1100%17:08:10
2aioe 8467 75 7208 12 0 0 0%23:59:57
3nntp4 12132 3 10862 2 0 0 0%23:59:53
4weretis 4058 0 3935 7 0 0 0%23:59:26
TOTAL: 4 24942 363 22005 21 0 1 1%89:07:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.1 MB0.0 KB1.1 MB0.0 KB/s4.0 KB17:08:10
2aioe258.8 KB46.5 KB305.3 KB0.0 KB/s3.5 KB23:59:57
3nntp410.2 KB5.1 KB15.3 KB0.0 KB/s3.1 KB23:59:53
4weretis0.0 KB37.1 KB37.1 KB0.0 KB/s5.3 KB23:59:26
TOTAL: 41.4 MB88.7 KB1.5 MB0.0 KB/s3.9 KB89:07:26
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.241.219.100 0.002 0.001 0.00000:00:00
46.101.130.147 0.005 0.014 0.00000:00:00
192.241.221.74 0.003 0.000 0.00000:00:00
TOTAL: 3 0.010 0.015 0.00000:00:00

NNRP no permission clients:

SystemConn
46.101.130.147 8
192.241.221.74 1
192.241.219.100 1
TOTAL: 3 10