Daily Usenet report for paganini.linuxd.org

Jan 21 00:00:01 -- Jan 22 00:00:05

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jan 21 04:39:09 paganini pgpverify[10824]: pgpverify: verification failed
Jan 21 11:55:47 paganini overchan[1923]: input line too long, skipping
Jan 21 17:46:50 paganini overchan[29360]: overchan is running while innd is creating overview data (you can ignore this message if you are running makehistory -F)

Log entries by program:

Program nameLines%LinesSize%Size
inn 49982 71.8%10.2 MB 81.7%
innd 17611 25.3%2.0 MB 16.0%
innfeed 1905 2.7%281.5 KB 2.2%
nocem 102 0.1%12.3 KB 0.1%
nnrpd 35 0.1%3.1 KB 0.0%
controlchan 5 0.0%0.7 KB 0.0%
overchan 3 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 69644 100.0%12.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 289832 53.5%
Negative hits 202418 37.4%
Do not exist 49538 9.1%
Cache misses 106 0.0%
TOTAL: 4 541894 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.378 0.0%206 0.000 1.835 49.000
article cleanup00:00:00.281 0.0%49711 0.000 0.006 0.023
article logging00:00:00.407 0.0%49800 0.000 0.008 0.021
article parse00:00:01.287 0.0%132530 0.002 0.010 0.023
article write00:01:14.535 0.1%30415 0.092 2.451 11.349
artlog/artcncl00:00:00.001 0.0%205 0.000 0.005 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.214 0.0%577063 0.000 0.000 0.002
hisgrep/artcncl00:00:00.004 0.0%198 0.000 0.020 0.250
hishave/artcncl00:00:00.004 0.0%206 0.000 0.019 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:25.696 0.0%543605 0.015 0.047 0.381
history sync00:00:00.015 0.0%299 0.000 0.050 0.500
history write00:01:43.746 0.1%49703 0.058 2.087 11.103
hiswrite/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
idle23:52:29.376 99.5%567142 93.563 151.548 355.269
nntp read00:00:03.017 0.0%580922 0.002 0.005 0.010
overview write00:00:51.275 0.1%30415 0.016 1.686 7.026
perl filter00:02:12.457 0.2%49703 1.154 2.665 6.815
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:07.243 0.0%121882 0.007 0.059 0.119
TOTAL: 24:00:19.38223:59:09.936 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.059 0.0%32308 0.000 0.002 0.014
article prepare00:00:00.012 0.0%85782 0.000 0.000 0.001
article read00:00:21.438 0.0%20805 0.000 1.030 20.150
backlog stats00:00:00.172 0.0%499219 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.461 0.0%326405 0.002 0.008 0.013
data write00:00:03.775 0.0%300405 0.007 0.013 0.024
idle23:52:17.160 99.9%499219 101.578 172.143 482.818
status file00:00:06.480 0.0%192 0.000 33.750 286.000
TOTAL: 23:53:07.59423:52:51.557100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:20.597 99.9%78 2571.756 2571.756 2571.756
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.042 0.0%193 0.218 0.218 0.218
readart00:00:00.000 0.0%9 0.000 0.000 0.000
TOTAL: 00:03:20.74200:03:20.639 99.9%----

Control commands to INND:

CommandNumber
L 1
flush 1
flushlogs 2
go 2
logmode 2
mode 149
name 2
newgroup 1
pause 2
paused 2
reload 2
reserve 2
TOTAL: 12 168

Newsgroups created:

GroupMode
free.speechy
TOTAL1

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
nl-admin@nic.surfnet.nl000100
sealteam6@osama-is-dead.net100011
TOTAL100111

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 2 68973 11222 53858 3893 16%47:05:41
2feeder.eternal-september.org 10 45826 5445 37638 2743 11%25:24:09
3news-out.mixmin.net 8 37546 4331 32045 1170 11%24:59:38
4vc89.vc.panix.com 2 8881 4295 4130 456 48%23:40:24
5newsfeed.neva.ru 145 99738 3328 85666 10744 3%71:38:51
6etla.org 4 31015 1608 29407 0 5%24:45:23
7news.netfront.net 3 61993 157 61674 162 0%29:41:39
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 199 353972 30386 304418 19168 8%247:15:45
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net44.3 MB0.0 KB23.3 MB67.6 MB 65%4.6 KB
2vc89.vc.panix.com16.6 MB166.8 KB3.4 MB20.2 MB 82%4.4 KB
3feeder.eternal-september.org15.5 MB0.0 KB32.0 MB47.5 MB 32%5.9 KB
4news-out.mixmin.net11.4 MB0.0 KB2.4 MB13.8 MB 82%2.6 KB
5newsfeed.neva.ru9.0 MB67.9 KB80.3 MB89.4 MB 10%6.5 KB
6etla.org5.5 MB0.0 KB0.0 KB5.5 MB100%3.5 KB
7news.netfront.net2.5 MB0.0 KB11.9 MB14.4 MB 17%46.2 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 8104.7 MB234.8 KB153.5 MB258.3 MB 40%5.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 21 00:00:01 - 00:59:59 1068 3.5% 0.303.0 MB 2.9% 0.84
Jan 21 01:00:00 - 01:59:59 793 2.6% 0.224.7 MB 4.5% 1.33
Jan 21 02:00:00 - 02:59:59 663 2.2% 0.183.2 MB 3.1% 0.92
Jan 21 03:00:00 - 03:59:59 591 1.9% 0.162.0 MB 2.0% 0.58
Jan 21 04:00:00 - 04:59:59 615 2.0% 0.172.1 MB 2.0% 0.58
Jan 21 05:00:00 - 05:59:59 727 2.4% 0.202.7 MB 2.6% 0.75
Jan 21 06:00:00 - 06:59:59 661 2.2% 0.182.1 MB 2.0% 0.60
Jan 21 07:00:00 - 07:59:59 871 2.9% 0.243.2 MB 3.1% 0.90
Jan 21 08:00:00 - 08:59:59 900 3.0% 0.253.0 MB 2.9% 0.86
Jan 21 09:00:00 - 09:59:59 1123 3.7% 0.313.1 MB 3.0% 0.87
Jan 21 10:00:00 - 10:59:59 1562 5.1% 0.434.7 MB 4.6% 1.34
Jan 21 11:00:00 - 11:59:59 1540 5.1% 0.434.3 MB 4.2% 1.22
Jan 21 12:00:00 - 12:59:59 1453 4.8% 0.404.1 MB 4.0% 1.17
Jan 21 13:00:00 - 13:59:59 1410 4.6% 0.394.0 MB 3.9% 1.13
Jan 21 14:00:00 - 14:59:59 1602 5.3% 0.454.7 MB 4.6% 1.35
Jan 21 15:00:00 - 15:59:59 1663 5.5% 0.466.1 MB 6.0% 1.75
Jan 21 16:00:00 - 16:59:59 1790 5.9% 0.505.4 MB 5.2% 1.54
Jan 21 17:00:00 - 17:59:59 1789 5.9% 0.508.3 MB 8.0% 2.35
Jan 21 18:00:00 - 18:59:59 1899 6.2% 0.535.5 MB 5.4% 1.57
Jan 21 19:00:00 - 19:59:59 1599 5.3% 0.444.4 MB 4.3% 1.26
Jan 21 20:00:00 - 20:59:59 1657 5.4% 0.464.7 MB 4.6% 1.35
Jan 21 21:00:00 - 21:59:59 1645 5.4% 0.467.1 MB 6.9% 2.02
Jan 21 22:00:00 - 22:59:59 1499 4.9% 0.426.7 MB 6.5% 1.89
Jan 21 23:00:00 - 23:59:59 1274 4.2% 0.353.7 MB 3.6% 1.05
Jan 22 00:00:00 - 00:00:05 17 0.1% 3.40265.9 KB 0.3% 53.17
TOTAL: 24:00:04 30411 100.0% 0.35103.0 MB 100.0% 1.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 10777 2099 0 3 0 0 0 0 8675
2linuxd-out.news.weretis.net 3987 1902 0 0 0 0 0 0 2085
3feeder.eternal-september.org 2805 224 0 0 0 0 0 0 2581
4news-out.mixmin.net 1157 16 0 0 0 0 0 0 1141
5vc89.vc.panix.com 474 7 0 5 0 0 0 0 462
6news.netfront.net 165 2 0 0 0 0 0 0 163
7etla.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 19366 4250 0 8 0 0 0 015108

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 893
mailing.freebsd.pkg-fallout 216
lada.talk 154
lada.auto 149
alt.politics 119
mailing.freebsd.svn-src-all 116
fa.freebsd.cvs-all 116
mailing.freebsd.svn-src-head 112
mailing.freebsd.ports-bugs 107
ut.test 95
alt.survival 91
it-alt.sport.calcio.juventus 89
mailing.freebsd.svn-ports-all 85
mailing.freebsd.svn-ports-head 77
alt.windows7.general 71
mailing.gcc.gcc-cvs 57
gmane.comp.gis.openstreetmap.tagging 57
pld.cvs.commit 50
mozilla.general 40
tin.it.sport.calcio 38
TOTAL: 286 4250

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 10657
EMP (phn path) 2883
EMP (phl) 821
EMP (phn nph) 207
Binary Image: misplaced jpg 173
Too many newsgroups 149
User-issued cancel 36
Binary: misplaced JPG 30
Binary: non-binary distribution 23
Binary Payload 18
Too many newsgroups (meow) 12
HTML post 6
MI5 Filter 3
Binary: misplaced pdf 1
TOTAL: 14 15019

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1vc89.vc.panix.com 36777 718 13630 16159 6 194 1%24:05:11
2etla.org 36054 337 30033 18 0 735 0%23:59:12
3news.netfront.net 54854 280 29891 51 0 457 0%23:56:50
4news.killfile.org 49516 135 26469 3823 5 205 0%24:01:06
5news.stack.nl 32368 38 30188 54 0 495 0%24:06:30
6neva.ru 30860 16 26877 14 0 31 0%24:03:37
7eternal-september 26428 7 24898 6 0 0 0%23:59:11
8weretis.net 19816 2 19035 0 0 6 0%24:04:09
9news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 9 286673 1533 201021 20125 11 2123 0%192:25:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org16.4 MB884.3 KB17.3 MB0.2 KB/s49.9 KB23:59:12
2news.netfront.net11.3 MB2.4 MB13.7 MB0.2 KB/s42.4 KB23:56:50
3vc89.vc.panix.com2.3 MB49.3 MB51.7 MB0.6 KB/s3.1 KB24:05:11
4news.killfile.org579.6 KB14.3 MB14.9 MB0.2 KB/s3.8 KB24:01:06
5news.stack.nl108.6 KB178.2 KB286.9 KB0.0 KB/s3.1 KB24:06:30
6neva.ru71.5 KB356.1 KB427.6 KB0.0 KB/s14.3 KB24:03:37
7eternal-september32.3 KB8.0 KB40.3 KB0.0 KB/s3.1 KB23:59:11
8weretis.net5.2 KB0.0 KB5.2 KB0.0 KB/s2.6 KB24:04:09
9news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 930.8 MB67.5 MB98.2 MB0.1 KB/s4.6 KB192:25:46
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.168.200.4 1 918.9 KB 4 0 000:03:20
TOTAL: 1 1 918.9 KB 4 0 000:03:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 1 918.9 KB 4 0 000:03:20
TOTAL: 1 1 918.9 KB 4 0 000:03:20

NNRP auth users [Top 20]:

UserConn
ivo@paganini.linuxd.org 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.168.200.4 0.092 0.004 0.00200:03:20
TOTAL: 1 0.092 0.004 0.00200:03:20

Newsgroup request counts (by category):

CategoryCountPct
1it 8 88.9%
2news 1 11.1%
TOTAL: 2 9100.0%

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

NewsgroupCount
1it.comp.os.win.windows7 5
2it.news.net-abuse 2
3news.lists.filters 1
4it.comp.os.linux.sys 1
TOTAL: 4 9