Daily Usenet report for paganini.linuxd.org

Jan 17 00:00:01 -- Jan 18 00:00:02

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Jan 17 09:31:47 paganini overchan[32738]: input line too long, skipping
Jan 17 11:52:25 paganini overchan[32738]: input line too long, skipping
Jan 17 12:09:45 paganini overchan[32738]: input line too long, skipping
Jan 17 12:45:38 paganini overchan[32738]: input line too long, skipping
Jan 17 13:10:01 paganini pgpverify[21828]: pgpverify: verification failed
Jan 17 13:51:22 paganini overchan[32738]: input line too long, skipping
Jan 17 20:35:45 paganini overchan[32738]: input line too long, skipping
Jan 18 00:00:02 paganini overchan[23862]: 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
innfeed 101328 66.9%12.6 MB 54.7%
inn 36245 23.9%8.5 MB 36.7%
innd 12952 8.6%1.9 MB 8.1%
nnrpd 861 0.6%113.6 KB 0.5%
nocem 44 0.0%7.2 KB 0.0%
overchan 8 0.0%1.4 KB 0.0%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 8 151443 100.0%23.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 127117 55.7%
Negative hits 65844 28.8%
Do not exist 35386 15.5%
Cache misses 65 0.0%
TOTAL: 4 228412 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.312 0.0%131 0.000 2.382 28.667
article cleanup00:00:00.227 0.0%35488 0.000 0.006 0.020
article logging00:00:00.405 0.0%36107 0.000 0.011 0.239
article parse00:00:00.829 0.0%67719 0.000 0.012 0.031
article write00:01:00.889 0.1%23382 0.171 2.604 48.744
artlog/artcncl00:00:00.000 0.0%131 0.000 0.000 0.000
data move00:00:00.145 0.0%242330 0.000 0.001 0.003
hisgrep/artcncl00:00:00.000 0.0%131 0.000 0.000 0.000
hishave/artcncl00:00:00.004 0.0%131 0.000 0.031 0.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:13.241 0.0%228991 0.013 0.058 0.768
history sync00:00:00.204 0.0%309 0.000 0.660 69.500
history write00:00:37.419 0.0%35488 0.040 1.054 8.701
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:13.342 99.7%237854 223.366 362.295 851.602
nntp read00:00:01.818 0.0%246094 0.003 0.007 0.014
overview write00:00:23.632 0.0%23382 0.026 1.011 2.803
perl filter00:01:08.256 0.1%35488 1.125 1.923 3.583
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.579 0.0%70446 0.000 0.022 0.051
TOTAL: 24:00:21.99723:59:42.302100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.098 0.0%38582 0.000 0.003 0.013
article prepare00:00:00.001 0.0%23844 0.000 0.000 0.009
article read00:00:02.267 0.0%5052 0.000 0.449 20.955
backlog stats00:00:00.216 0.0%370516 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.506 0.0%202256 0.001 0.007 0.015
data write00:00:03.074 0.0%179114 0.007 0.017 0.034
idle23:42:22.437 99.2%370516 142.188 230.334 410.830
status file00:10:17.596 0.7%42346 7.904 14.585 38.032
TOTAL: 23:53:09.20623:52:47.195100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:39:05.413 99.6%1561 0.000 8421.149600480.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:22.374 0.2%142018 0.000 0.158 3.000
readart00:00:07.611 0.1%5792 0.033 1.314 10.041
TOTAL: 03:39:59.51703:39:35.398 99.8%----

Control commands to INND:

CommandNumber
L 1
flush 6
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 172

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newsmaster@carnet.hr000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 4 49498 20161 27648 1689 40%47:55:13
2newsfeed.neva.ru 144 80355 2782 67261 10312 3%71:41:04
3news.fcku.it 1 13332 276 12892 164 2%32:49:50
4nntp.pasdenom.info 3 20390 109 20272 9 0%19:51:41
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 177 163575 23328 128073 12174 14%172:17:48
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net60.1 MB0.0 KB10.6 MB70.8 MB 84%3.3 KB
2newsfeed.neva.ru7.2 MB0.0 KB78.7 MB85.8 MB 8%6.7 KB
3news.fcku.it684.6 KB0.0 KB397.0 KB1.1 MB 63%2.5 KB
4nntp.pasdenom.info265.8 KB0.0 KB25.3 KB291.2 KB 91%2.5 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 568.2 MB0.0 KB89.7 MB157.9 MB 43%4.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 17 00:00:01 - 00:59:59 828 3.5% 0.232.6 MB 3.7% 0.73
Jan 17 01:00:00 - 01:59:59 647 2.8% 0.181.9 MB 2.8% 0.55
Jan 17 02:00:00 - 02:59:59 618 2.6% 0.171.8 MB 2.7% 0.52
Jan 17 03:00:00 - 03:59:59 499 2.1% 0.141.7 MB 2.5% 0.48
Jan 17 04:00:00 - 04:59:59 469 2.0% 0.131.4 MB 2.1% 0.41
Jan 17 05:00:00 - 05:59:59 497 2.1% 0.141.6 MB 2.3% 0.45
Jan 17 06:00:00 - 06:59:59 534 2.3% 0.151.6 MB 2.3% 0.45
Jan 17 07:00:00 - 07:59:59 555 2.4% 0.152.0 MB 3.0% 0.58
Jan 17 08:00:00 - 08:59:59 647 2.8% 0.181.7 MB 2.5% 0.49
Jan 17 09:00:00 - 09:59:59 994 4.2% 0.283.3 MB 4.8% 0.94
Jan 17 10:00:00 - 10:59:59 1078 4.6% 0.303.0 MB 4.3% 0.84
Jan 17 11:00:00 - 11:59:59 1099 4.7% 0.312.8 MB 4.1% 0.81
Jan 17 12:00:00 - 12:59:59 885 3.8% 0.252.2 MB 3.2% 0.62
Jan 17 13:00:00 - 13:59:59 896 3.8% 0.252.5 MB 3.6% 0.71
Jan 17 14:00:00 - 14:59:59 1144 4.9% 0.323.5 MB 5.1% 0.98
Jan 17 15:00:00 - 15:59:59 1265 5.4% 0.353.7 MB 5.3% 1.04
Jan 17 16:00:00 - 16:59:59 1584 6.8% 0.445.0 MB 7.3% 1.42
Jan 17 17:00:00 - 17:59:59 1373 5.9% 0.383.7 MB 5.5% 1.06
Jan 17 18:00:00 - 18:59:59 1394 6.0% 0.393.7 MB 5.3% 1.04
Jan 17 19:00:00 - 19:59:59 1445 6.2% 0.404.3 MB 6.3% 1.22
Jan 17 20:00:00 - 20:59:59 1330 5.7% 0.373.8 MB 5.5% 1.08
Jan 17 21:00:00 - 21:59:59 1358 5.8% 0.384.3 MB 6.3% 1.23
Jan 17 22:00:00 - 22:59:59 1137 4.9% 0.323.2 MB 4.6% 0.90
Jan 17 23:00:00 - 00:00:02 1115 4.8% 0.313.3 MB 4.8% 0.93
TOTAL: 24:00:01 23391 100.0% 0.2768.5 MB 100.0% 0.81
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 10415 532 0 0 0 0 0 0 9883
2linuxd-out.news.weretis.net 2206 635 0 0 0 0 0 0 1571
3news.fcku.it 97 1 0 0 0 0 0 0 96
4nntp.pasdenom.info 5 1 0 0 0 0 0 0 4
TOTAL: 4 12723 1169 0 0 0 0 0 011554

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.auto 197
lada.talk 132
ut.test 123
it.annunci.varie 66
it.annunci.commerciali 63
it.annunci.immobiliari 63
it-alt.sport.calcio.juventus 45
alt.windows7.general 44
gmane.linux.alsa.devel 39
gmane.comp.gis.openstreetmap.tagging 23
alt.survival 23
mozilla.support.thunderbird 20
mpc.lists.nanog 19
mozilla.dev.platform 15
cakewalk.audio 13
gmane.linux.kernel 13
spline.eisfair 12
abg.test 11
gmane.linux.drivers.platform.x86.devel 10
spline.eisfair.dev 9
TOTAL: 112 1169

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 9139
EMP (phn path) 977
EMP (phl) 545
EMP (phn nph) 144
Too many newsgroups 91
Binary Payload 13
HTML post 11
User-issued cancel 11
Binary: non-binary distribution 4
HTML Multipart without Text/Plain. 1
Too many newsgroups (low_xpost) 1
TOTAL: 11 10937

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 523
newsfeed.neva.ru 89
news.fcku.it 4
nntp.pasdenom.info 1
TOTAL: 4 617
TOTAL: 1 617

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 32586 1814 18897 2313 0 299 5%23:50:01
2nntp.pasdenom.info 41669 1411 21621 263 0 701 3%23:57:25
3neva.ru 30773 55 20347 51 0 181 0%23:50:24
4eternal-september 25585 31 19948 1 0 15 0%23:53:12
5weretis.net 3232 25 3015 0 0 10 0%23:50:30
6news.killfile.org 2848 0 0 0 0 26238 0%23:59:48
7news.mixmin.net 0 0 0 0 0 0 0%00:10:00
8news.albasani.net 2863 0 0 0 0 25215 0%23:59:20
9news.netfront.net 2750 0 0 0 0 26023 0%23:59:27
10vc89.vc.panix.com 2840 0 0 0 0 26226 0%23:59:40
11news.stack.nl 2861 0 0 0 0 26236 0%23:59:45
12etla.org 0 0 0 0 0 23222 0%23:50:01
TOTAL: 12 148007 3336 83828 2628 0 154366 2%263:19:33
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info5.3 MB595.0 KB5.9 MB0.1 KB/s3.6 KB23:57:25
2news.fcku.it5.2 MB7.9 MB13.1 MB0.2 KB/s3.3 KB23:50:01
3neva.ru228.6 KB169.8 KB398.4 KB0.0 KB/s3.8 KB23:50:24
4eternal-september124.6 KB1.9 KB126.5 KB0.0 KB/s4.0 KB23:53:12
5weretis.net47.1 KB0.0 KB47.1 KB0.0 KB/s1.9 KB23:50:30
6news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
7news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
8news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:20
9news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:27
10vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:40
11news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
12etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
TOTAL: 1210.9 MB8.6 MB19.5 MB0.0 KB/s3.4 KB263:19:33
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1240.132.151.153.ap.dti.ne.jp 3 746877.1 KB 28 0 000:05:10
TOTAL: 1 3 746877.1 KB 28 0 003:39:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.132.151.153.ap.dti.ne.jp 3 746877.1 KB 28 0 000:05:10
2*.nielsenmedia.com 9 00.0 KB 0 0 001:00:41
3unresolved 1 00.0 KB 0 0 000:00:08
4*.094.216.pools.vodafone-ip.de 145 00.0 KB 0 0 000:00:29
5*.drr02.clwr.fl.frontiernet.net 14 00.0 KB 0 0 002:33:28
TOTAL: 5 172 746877.1 KB 28 0 003:39:59

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.816 0.036 0.00002:33:28
challenger.nielsenmedia.com 0.484 0.028 0.00001:00:41
240.132.151.153.ap.dti.ne.jp 0.376 0.208 0.00000:05:10
dslb-094-216-025-116.094.216.pools.vodafone-ip.de 7.716 0.548 0.00000:00:29
196.52.16.43 0.164 0.080 0.00000:00:08
TOTAL: 5 9.556 0.900 0.00003:39:59

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-094-216-025-116.094.216.pools.vodafone-ip.de 145
47-192-187-101.drr02.clwr.fl.frontiernet.net 14
challenger.nielsenmedia.com 9
196.52.16.43 1
TOTAL: 4 169

NNRP client timeouts [Top 20]:

SystemConnPeer
47-192-187-101.drr02.clwr.fl.frontiernet.net 5 0
challenger.nielsenmedia.com 2 0
TOTAL: 2 7 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 746100.0%
TOTAL: 1 746100.0%

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

NewsgroupCount
1alt.books.louis-lamour 314
2alt.books.reviews 161
3alt.bread.recipes 90
4alt.books.m-lackey 73
5alt.books.arthur-clarke 21
6alt.boomerang 17
7alt.books.tom-holt 16
8alt.bonehead.jai-maharaj 9
9alt.japanese.neojapan.fetish.lolita 7
10alt.books.stephen-king 6
11alt.japanese.neojapan.lolita 6
12alt.books.inklings 3
13alt.brain.teasers 3
14alt.books.pratchett 2
15alt.books.dean-koontz 2
16alt.bonsai 2
17alt.books 2
18alt.boston.unmoderated 2
19alt.books.isaac-asimov 1
20alt.books.moorcock 1
21alt.bonehead.klaas.suck.checkmates.dick 1
22alt.books.iain-banks 1
23alt.books.roger-zelazny 1
24alt.books.raymond-feist 1
25alt.books.cait-r-kiernan 1
26alt.books.tom-clancy 1
27alt.books.h-g-wells 1
28alt.books.george-orwell 1
TOTAL: 28 746