Daily Usenet report

Jul 5 15:00:02 -- Jul 6 15:00:01

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

Jul 5 15:01:25 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Jul 5 18:48:36 colo-sc-1 pgpverify[3593]: pgpverify: verification failed
Jul 5 18:49:18 colo-sc-1 pgpverify[3618]: pgpverify: verification failed
Jul 5 18:50:00 colo-sc-1 pgpverify[3644]: pgpverify: verification failed
Jul 5 18:50:42 colo-sc-1 pgpverify[3814]: pgpverify: verification failed
Jul 5 18:51:24 colo-sc-1 pgpverify[3840]: pgpverify: verification failed
Jul 5 18:52:06 colo-sc-1 pgpverify[3863]: pgpverify: verification failed
Jul 5 18:52:48 colo-sc-1 pgpverify[3889]: pgpverify: verification failed
Jul 5 18:53:30 colo-sc-1 pgpverify[3914]: pgpverify: verification failed
Jul 5 18:54:12 colo-sc-1 pgpverify[3938]: pgpverify: verification failed
Jul 5 18:54:54 colo-sc-1 pgpverify[3964]: pgpverify: verification failed
Jul 5 18:55:36 colo-sc-1 pgpverify[3989]: pgpverify: verification failed
Jul 5 18:56:18 colo-sc-1 pgpverify[4013]: pgpverify: verification failed
Jul 5 18:57:00 colo-sc-1 pgpverify[4041]: pgpverify: verification failed
Jul 5 18:57:42 colo-sc-1 pgpverify[4065]: pgpverify: verification failed
Jul 5 18:58:24 colo-sc-1 pgpverify[4099]: pgpverify: verification failed
Jul 5 18:59:06 colo-sc-1 pgpverify[4133]: pgpverify: verification failed
Jul 5 18:59:49 colo-sc-1 pgpverify[4169]: pgpverify: verification failed
Jul 5 19:00:31 colo-sc-1 pgpverify[4231]: pgpverify: verification failed
Jul 5 19:12:03 colo-sc-1 pgpverify[4977]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 15659 60.8%2.1 MB 60.9%
innd 7494 29.1%995.9 KB 28.6%
innfeed 1396 5.4%189.7 KB 5.4%
cnfsstat 1152 4.5%171.5 KB 4.9%
controlchan 30 0.1%4.1 KB 0.1%
pgpverify 19 0.1%2.0 KB 0.1%
overchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 25751 100.0%3.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 37006 42.9%
Negative hits 34116 39.5%
Do not exist 15085 17.5%
Cache misses 63 0.1%
TOTAL: 4 86270 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.677 0.0%73 0.000 9.274 52.600
article cleanup00:00:00.096 0.0%15234 0.000 0.006 0.034
article logging00:00:01.730 0.0%15596 0.000 0.111 10.500
article parse00:00:00.236 0.0%27456 0.000 0.009 0.032
article write00:00:00.543 0.0%11989 0.000 0.045 0.128
artlog/artcncl00:00:00.001 0.0%68 0.000 0.015 0.250
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.044 0.0%90459 0.000 0.000 0.004
hisgrep/artcncl00:00:00.000 0.0%73 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%73 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.506 0.0%87018 0.000 0.006 0.098
history sync00:00:00.015 0.0%365 0.000 0.041 0.667
history write00:00:01.521 0.0%15234 0.000 0.100 6.366
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:22.284100.0%94084 426.546 918.565 2207.956
nntp read00:00:00.629 0.0%93093 0.000 0.007 0.018
overview write00:00:00.041 0.0%11989 0.000 0.003 0.032
perl filter00:00:14.884 0.0%15234 0.718 0.977 1.569
python filter00:00:00.409 0.0%15234 0.000 0.027 0.069
site send00:00:01.891 0.0%35986 0.018 0.053 0.120
TOTAL: 24:00:55.74524:00:45.507100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.031 0.0%11964 0.000 0.003 0.024
article prepare00:00:00.002 0.0%6008 0.000 0.000 0.013
article read00:00:00.069 0.0%1595 0.000 0.043 0.500
backlog stats00:00:00.056 0.0%74637 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.328 0.0%43134 0.000 0.008 0.029
data write00:00:00.886 0.0%31461 0.000 0.028 0.115
idle23:57:58.200100.0%74637 535.736 1155.971 2931.678
status file00:00:00.127 0.0%256 0.000 0.496 11.750
TOTAL: 23:58:01.82023:57:59.699100.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org0011901
TOTAL0011901

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 48 24285 7851 15269 1165 32%49:01:40
2usenet.blueworldhosting.com 720 14953 2904 10830 1219 19%23:47:25
3news.nntp4.net 1 13723 1227 11639 857 8%24:00:49
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 770 52961 11982 37738 3241 22%96:49:54
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net26.5 MB0.0 KB3.4 MB29.9 MB 88%3.4 KB
2usenet.blueworldhosting.com12.6 MB0.0 KB4.3 MB16.9 MB 74%4.2 KB
3news.nntp4.net3.1 MB0.0 KB2.0 MB5.1 MB 60%2.5 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 442.2 MB0.0 KB9.7 MB51.9 MB 81%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 5 15:00:02 - 15:59:59 775 6.5% 0.222.4 MB 5.8% 0.69
Jul 5 16:00:00 - 16:59:59 627 5.2% 0.171.7 MB 4.1% 0.49
Jul 5 17:00:00 - 17:59:59 566 4.7% 0.161.7 MB 4.0% 0.48
Jul 5 18:00:00 - 18:59:59 575 4.8% 0.161.9 MB 4.4% 0.53
Jul 5 19:00:00 - 19:59:59 553 4.6% 0.151.7 MB 4.1% 0.50
Jul 5 20:00:00 - 20:59:59 592 4.9% 0.162.6 MB 6.3% 0.75
Jul 5 21:00:00 - 21:59:59 504 4.2% 0.141.8 MB 4.4% 0.52
Jul 5 22:00:00 - 22:59:59 443 3.7% 0.121.7 MB 4.0% 0.48
Jul 5 23:00:00 - 23:59:59 396 3.3% 0.111.5 MB 3.6% 0.43
Jul 6 00:00:00 - 00:59:59 372 3.1% 0.101.6 MB 3.9% 0.46
Jul 6 01:00:00 - 01:59:59 287 2.4% 0.081.4 MB 3.3% 0.39
Jul 6 02:00:00 - 02:59:59 276 2.3% 0.081.3 MB 3.1% 0.38
Jul 6 03:00:00 - 03:59:59 248 2.1% 0.071.1 MB 2.6% 0.31
Jul 6 04:00:00 - 04:59:59 267 2.2% 0.071.0 MB 2.4% 0.29
Jul 6 05:00:00 - 05:59:59 339 2.8% 0.091.0 MB 2.4% 0.29
Jul 6 06:00:00 - 06:59:59 416 3.5% 0.121.8 MB 4.3% 0.52
Jul 6 07:00:00 - 07:59:59 561 4.7% 0.161.8 MB 4.2% 0.50
Jul 6 08:00:00 - 08:59:59 644 5.4% 0.182.0 MB 4.8% 0.58
Jul 6 09:00:00 - 09:59:59 573 4.8% 0.161.7 MB 4.0% 0.49
Jul 6 10:00:00 - 10:59:59 648 5.4% 0.182.0 MB 4.8% 0.58
Jul 6 11:00:00 - 11:59:59 492 4.1% 0.141.7 MB 4.1% 0.50
Jul 6 12:00:00 - 12:59:59 482 4.0% 0.131.9 MB 4.6% 0.55
Jul 6 13:00:00 - 13:59:59 595 5.0% 0.172.1 MB 4.9% 0.59
Jul 6 14:00:00 - 14:59:59 751 6.3% 0.212.4 MB 5.7% 0.69
Jul 6 15:00:00 - 15:00:01 1 0.0% 1.003.8 KB 0.0% 3.80
TOTAL: 23:59:59 11983 100.0% 0.1442.2 MB 100.0% 0.50
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
EIGHTBIG4.0 GB2.9 GB 72.6% 1 0.00 0.00
FIVEBIG4.0 GB2.9 GB 72.6% 1 0.00 0.00
FOURDEFAULT1024.0 MB65.2 MB 6.4% 22 0.20 61.41
ONEDEFAULT1024.0 MB225.4 MB 22.0% 24 0.19 63.08
SEVENBIG4.0 GB2.9 GB 72.6% 1 0.00 0.00
SIXBIG4.0 GB2.9 GB 72.8% 1 0.00 0.00
THREEDEFAULT1024.0 MB76.5 MB 7.5% 22 0.20 61.37
TWODEFAULT1024.0 MB61.2 MB 6.0% 22 0.20 62.20
TOTAL: 8-20.0 GB12.0 GB 60.2% 94 0.20-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.news.weretis.net 1520 4 0 0 0 0 0 0 1516
2usenet.blueworldhosting.com 1224 235 0 0 0 0 0 0 989
3news.nntp4.net 864 9 0 0 0 0 0 0 855
TOTAL: 3 3608 248 0 0 0 0 0 0 3360

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.git 58
perl.cpan 34
odessa.news 32
linux.kernel.netdev 25
alfanet.nocem 18
panix.questions 10
local.general 9
sybase.public.powerdesigner.general 8
alt.stupid 8
alt.energy 6
panix.chat.politics 6
alt.personals.sex 6
rocksolid.feeds.news 5
alt.fan.houston 5
linux.redhat.rhsa.announce 4
fido.ru.unix.ftn 2
alt.penthouse.sex.first-time 2
kraft.politics 1
alt.alien.vampire 1
adobe.illustrator.windows 1
TOTAL: 27 248

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 1584
EMP (md5) 1007
EMP (phn nph) 211
EMP (phl) 116
Too many newsgroups 57
Scoring filter 14
HTML Multipart 4
TOTAL: 7 2993

INND no permission servers:

SystemConn
162.142.125.217 1
TOTAL: 1 1

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 351
news.nntp4.net 11
usenet.blueworldhosting.com 5
TOTAL: 3 367
TOTAL: 1 367

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp4 12806 1008 9732 14 0 4 7%23:59:56
2bbsgslincom 445 445 0 0 0 0100%19:46:47
3weretis 6401 315 3708 55 0 0 4%23:59:56
4aioe 0 0 0 0 0 11901 0%23:59:54
5blueworldhosting 9933 0 8266 0 0 2 0%23:59:56
TOTAL: 5 29585 1768 21706 69 0 11907 5%115:46:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp44.2 MB52.2 KB4.2 MB0.0 KB/s4.2 KB23:59:56
2weretis1.5 MB211.0 KB1.7 MB0.0 KB/s4.7 KB23:59:56
3bbsgslincom1.4 MB0.0 KB1.4 MB0.0 KB/s3.1 KB19:46:47
4aioe0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
5blueworldhosting0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 57.0 MB263.3 KB7.3 MB0.0 KB/s4.0 KB115:46:29
Outgoing feeds (innfeed) by Volume