Daily Usenet Report

Nov 30 00:01:01 -- Dec 1 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Nov 30 00:01:55 wibble innd: message repeated 2 times: [ ctlinnd command s]
Nov 30 18:04:03 wibble pgpverify[3694480]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 14386 85.1%2.0 MB 85.0%
innd 1580 9.3%242.6 KB 10.2%
innfeed 743 4.4%95.0 KB 4.0%
nnrpd 171 1.0%13.1 KB 0.6%
controlchan 22 0.1%5.7 KB 0.2%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 6 16903 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 26922 40.7%
Negative hits 25335 38.3%
Do not exist 13949 21.1%
Cache misses 5 0.0%
TOTAL: 4 66211 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.027 0.0%49 0.000 0.551 7.500
article cleanup00:00:00.055 0.0%14144 0.000 0.004 0.025
article logging00:00:00.149 0.0%14339 0.000 0.010 0.036
article parse00:00:00.163 0.0%39396 0.000 0.004 0.029
article write00:00:01.657 0.0%13473 0.020 0.123 0.883
artlog/artcncl00:00:00.000 0.0%49 0.000 0.000 0.000
data move00:00:00.017 0.0%92246 0.000 0.000 0.003
hisgrep/artcncl00:00:00.000 0.0%36 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%49 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.154 0.0%66294 0.000 0.002 0.014
history sync00:00:00.009 0.0%298 0.000 0.030 0.500
history write00:00:00.305 0.0%13962 0.000 0.022 0.111
hiswrite/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
idle23:59:42.954100.0%90396 327.914 955.606 3726.665
nntp read00:00:00.439 0.0%90306 0.000 0.005 0.016
overview write00:00:15.677 0.0%13473 0.000 1.164 5.731
perl filter00:00:09.285 0.0%13962 0.419 0.665 1.286
python filter00:00:00.239 0.0%13963 0.000 0.017 0.075
site send00:00:00.257 0.0%26948 0.000 0.010 0.045
TOTAL: 24:00:16.00324:00:11.387100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.020 0.0%13637 0.000 0.001 0.026
article prepare00:00:00.000 0.0%528 0.000 0.000 0.000
article read00:00:00.024 0.0%132 0.000 0.182 23.000
backlog stats00:00:00.020 0.0%95017 0.000 0.000 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.247 0.0%52643 0.000 0.005 0.022
data write00:00:00.616 0.0%39383 0.000 0.016 0.088
idle23:56:47.793100.0%95017 518.378 907.288 2419.706
status file00:00:00.165 0.0%150 0.000 1.100 130.000
TOTAL: 23:56:50.11523:56:48.885100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle70:19:44.176100.0%4588 1627.067 55183.997 59584.276
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.109 0.0%9255 0.008 0.012 0.018
readart00:00:00.022 0.0%100 0.000 0.220 11.000
TOTAL: 70:19:44.57970:19:44.307100.0%----

Control commands to INND:

CommandNumber
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 168

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
news@sfere.anjou.terraraq.org.uk001001
us-control@lists.killfile.org000100
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 7 27724 13359 13699 666 48%48:59:36
2news.bbs.nz 1 13552 182 13369 1 1%23:59:40
3localhost 26 1 1 0 0 100%00:00:00
TOTAL: 3 34 41277 13542 27068 667 32%72:59:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net55.3 MB403.9 KB1.8 MB57.5 MB 96%4.2 KB
2news.bbs.nz644.3 KB0.0 KB2.3 KB646.6 KB 99%3.5 KB
3localhost1.0 KB0.0 KB0.0 KB1.0 KB100%1.0 KB
TOTAL: 355.9 MB403.9 KB1.8 MB58.1 MB 96%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 30 00:01:01 - 00:59:59 270 2.0% 0.08849.2 KB 1.5% 0.24
Nov 30 01:00:00 - 01:59:59 397 2.9% 0.111.4 MB 2.5% 0.41
Nov 30 02:00:00 - 02:59:59 514 3.8% 0.142.4 MB 4.2% 0.68
Nov 30 03:00:00 - 03:59:59 634 4.7% 0.182.4 MB 4.2% 0.67
Nov 30 04:00:00 - 04:59:59 641 4.8% 0.181.6 MB 2.9% 0.47
Nov 30 05:00:00 - 05:59:59 674 5.0% 0.191.7 MB 3.1% 0.49
Nov 30 06:00:00 - 06:59:59 655 4.9% 0.183.7 MB 6.5% 1.04
Nov 30 07:00:00 - 07:59:59 709 5.3% 0.202.7 MB 4.9% 0.78
Nov 30 08:00:00 - 08:59:59 770 5.7% 0.213.0 MB 5.4% 0.86
Nov 30 09:00:00 - 09:59:59 807 6.0% 0.224.2 MB 7.5% 1.20
Nov 30 10:00:00 - 10:59:59 772 5.7% 0.213.8 MB 6.8% 1.08
Nov 30 11:00:00 - 11:59:59 778 5.8% 0.223.4 MB 6.1% 0.97
Nov 30 12:00:00 - 12:59:59 755 5.6% 0.213.7 MB 6.6% 1.06
Nov 30 13:00:00 - 13:59:59 740 5.5% 0.213.1 MB 5.5% 0.88
Nov 30 14:00:00 - 14:59:59 667 5.0% 0.192.2 MB 3.9% 0.63
Nov 30 15:00:00 - 15:59:59 675 5.0% 0.192.7 MB 4.8% 0.77
Nov 30 16:00:00 - 16:59:59 600 4.5% 0.172.3 MB 4.1% 0.66
Nov 30 17:00:00 - 17:59:59 504 3.7% 0.142.6 MB 4.7% 0.75
Nov 30 18:00:00 - 18:59:59 372 2.8% 0.101.4 MB 2.4% 0.39
Nov 30 19:00:00 - 19:59:59 339 2.5% 0.091.3 MB 2.4% 0.38
Nov 30 20:00:00 - 20:59:59 270 2.0% 0.071.1 MB 2.0% 0.32
Nov 30 21:00:00 - 21:59:59 272 2.0% 0.081.8 MB 3.2% 0.52
Nov 30 22:00:00 - 22:59:59 338 2.5% 0.091.4 MB 2.5% 0.40
Nov 30 23:00:00 - 23:59:59 312 2.3% 0.091.3 MB 2.4% 0.38
Dec 1 00:00:00 - 00:01:01 5 0.0% 0.0810.9 KB 0.0% 0.18
TOTAL: 24:00:00 13470 100.0% 0.1656.3 MB 100.0% 0.67
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 865 0 0 182 0 0 0 0 683
2news.bbs.nz 2 1 0 0 0 0 0 0 1
TOTAL: 2 867 1 0 182 0 0 0 0 684

Unwanted newsgroups [Top 20]:

NewsgroupCount
at.jobs 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 247
EMP (md5) 165
User-issued spam cancel 46
Too many newsgroups 16
User-issued cancel 11
HTML Multipart 4
TOTAL: 6 489

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 194
news.bbs.nz 1
TOTAL: 2 195
TOTAL: 1 195

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.nz 26227 108 13158 19 0 169 0%23:59:49
2news.weretis.net 13524 5 13465 0 0 6 0%23:59:57
TOTAL: 2 39751 113 26623 19 0 175 0%47:59:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.bbs.nz365.4 KB251.0 KB616.5 KB0.0 KB/s4.9 KB23:59:49
2news.weretis.net8.7 KB0.0 KB8.7 KB0.0 KB/s1.7 KB23:59:57
TOTAL: 2374.1 KB251.0 KB625.1 KB0.0 KB/s4.7 KB47:59:46
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1wibble 3 713.6 KB 3 0 070:19:44
TOTAL: 1 3 713.6 KB 3 0 070:19:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 3 713.6 KB 3 0 070:19:44
TOTAL: 1 3 713.6 KB 3 0 070:19:44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
wibble 0.319 0.162 0.00070:19:44
TOTAL: 1 0.319 0.162 0.00070:19:44

Newsgroup request counts (by category):

CategoryCountPct
1news 2 50.0%
2comp 1 25.0%
3alt 1 25.0%
TOTAL: 3 4100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1news.software.nntp 2
2comp.sys.acorn.apps 1
3alt.visa.us 1
TOTAL: 3 4