Daily Usenet report for paganini.linuxd.org

Mar 12 00:00:02 -- Mar 13 00:00:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Mar 12 08:48:44 paganini overchan[31994]: input line too long, skipping
Mar 13 00:00:02 paganini overchan[11358]: 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 117918 73.9%14.8 MB 62.0%
inn 30596 19.2%7.4 MB 30.9%
innd 10705 6.7%1.6 MB 6.9%
nnrpd 348 0.2%51.6 KB 0.2%
nocem 88 0.1%16.4 KB 0.1%
overchan 3 0.0%0.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 159659 100.0%23.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 108043 56.5%
Negative hits 53280 27.8%
Do not exist 29885 15.6%
Cache misses 105 0.1%
TOTAL: 4 191313 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.546 0.0%220 0.000 2.482 25.182
article cleanup00:00:00.204 0.0%29906 0.000 0.007 0.028
article logging00:00:00.271 0.0%30241 0.000 0.009 0.032
article parse00:00:00.693 0.0%58457 0.000 0.012 0.034
article write00:00:48.586 0.1%20384 0.120 2.384 14.859
artlog/artcncl00:00:00.000 0.0%188 0.000 0.000 0.000
data move00:00:00.118 0.0%209376 0.000 0.001 0.004
hisgrep/artcncl00:00:00.006 0.0%220 0.000 0.027 0.500
hishave/artcncl00:00:00.002 0.0%220 0.000 0.009 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:11.411 0.0%191365 0.015 0.060 0.534
history sync00:00:00.023 0.0%397 0.000 0.058 0.667
history write00:00:33.965 0.0%29906 0.023 1.136 6.761
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:47:41.407 99.8%201277 114.485 425.590 1904.390
nntp read00:00:01.395 0.0%207990 0.001 0.007 0.015
overview write00:00:19.249 0.0%20384 0.000 0.944 2.970
perl filter00:00:59.414 0.1%29906 1.016 1.987 6.098
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.990 0.0%61337 0.000 0.016 0.053
TOTAL: 23:51:02.04723:50:38.280100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.117 0.0%54979 0.000 0.002 0.012
article prepare00:00:00.002 0.0%26648 0.000 0.000 0.007
article read00:00:02.705 0.0%6375 0.000 0.424 10.875
backlog stats00:00:00.198 0.0%313129 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.300 0.0%166299 0.001 0.008 0.017
data write00:00:02.809 0.0%146081 0.011 0.019 0.035
idle23:41:31.943 99.2%313129 28.647 272.386 524.576
status file00:11:25.380 0.8%49417 8.487 13.869 35.096
TOTAL: 23:53:16.30923:53:04.454100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:15:21.760 99.9%326 27.333 24913.374414911.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.006 0.0%869 0.000 0.007 0.125
readart00:00:00.001 0.0%8 0.000 0.125 0.250
TOTAL: 02:15:32.37702:15:21.767 99.9%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 5 44451 17828 24820 1803 40%48:05:28
2newsfeed.neva.ru 148 69177 2496 58984 7697 3%71:57:55
3news.fcku.it 1 6031 144 5773 114 2%23:59:55
4nntp.pasdenom.info 3 18404 78 18322 4 0%24:10:23
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 182 138063 20546 107899 9618 14%168:13:41
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net60.7 MB0.0 KB15.8 MB76.5 MB 79%4.0 KB
2newsfeed.neva.ru8.1 MB0.0 KB57.4 MB65.5 MB 12%6.6 KB
3news.fcku.it645.8 KB0.0 KB3.0 MB3.7 MB 17%14.6 KB
4nntp.pasdenom.info155.4 KB0.0 KB5.4 KB160.8 KB 96%2.0 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 569.6 MB0.0 KB76.2 MB145.8 MB 47%5.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 12 00:00:02 - 00:59:59 791 3.9% 0.222.1 MB 3.0% 0.59
Mar 12 01:00:00 - 01:59:59 1081 5.3% 0.3010.7 MB 15.2% 3.04
Mar 12 02:00:00 - 02:59:59 532 2.6% 0.151.9 MB 2.6% 0.53
Mar 12 03:00:00 - 03:59:59 445 2.2% 0.121.5 MB 2.1% 0.43
Mar 12 04:00:00 - 04:59:59 420 2.0% 0.122.2 MB 3.2% 0.64
Mar 12 05:00:00 - 05:59:59 291 1.4% 0.08887.4 KB 1.2% 0.25
Mar 12 06:00:00 - 06:59:59 309 1.5% 0.09860.1 KB 1.2% 0.24
Mar 12 07:00:00 - 07:59:59 404 2.0% 0.111.5 MB 2.1% 0.42
Mar 12 08:00:00 - 08:59:59 576 2.8% 0.161.8 MB 2.5% 0.51
Mar 12 09:00:00 - 09:59:59 768 3.7% 0.212.6 MB 3.7% 0.73
Mar 12 10:00:00 - 10:59:59 782 3.8% 0.222.1 MB 3.1% 0.61
Mar 12 11:00:00 - 11:59:59 895 4.4% 0.252.6 MB 3.7% 0.74
Mar 12 12:00:00 - 12:59:59 906 4.4% 0.252.4 MB 3.3% 0.67
Mar 12 13:00:00 - 13:59:59 953 4.6% 0.263.0 MB 4.3% 0.85
Mar 12 14:00:00 - 14:59:59 1003 4.9% 0.284.4 MB 6.3% 1.25
Mar 12 15:00:00 - 15:59:59 1070 5.2% 0.303.1 MB 4.4% 0.88
Mar 12 16:00:00 - 16:59:59 1097 5.3% 0.303.1 MB 4.4% 0.88
Mar 12 17:00:00 - 17:59:59 1214 5.9% 0.343.2 MB 4.5% 0.90
Mar 12 18:00:00 - 18:59:59 1146 5.6% 0.323.4 MB 4.8% 0.96
Mar 12 19:00:00 - 19:59:59 1347 6.6% 0.374.0 MB 5.7% 1.14
Mar 12 20:00:00 - 20:59:59 1277 6.2% 0.354.4 MB 6.3% 1.26
Mar 12 21:00:00 - 21:59:59 1107 5.4% 0.313.1 MB 4.5% 0.89
Mar 12 22:00:00 - 22:59:59 1112 5.4% 0.313.2 MB 4.5% 0.90
Mar 12 23:00:00 - 23:59:59 974 4.7% 0.272.5 MB 3.5% 0.71
Mar 13 00:00:00 - 00:00:02 6 0.0% 3.0033.6 KB 0.0% 16.81
TOTAL: 24:00:00 20506 100.0% 0.2470.4 MB 100.0% 0.83
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 7679 407 0 0 0 0 0 0 7272
2linuxd-out.news.weretis.net 2103 458 0 0 0 0 0 0 1645
3news.fcku.it 112 0 0 0 0 0 0 0 112
4nntp.pasdenom.info 8 0 0 0 0 0 0 0 8
TOTAL: 4 9902 865 0 0 0 0 0 0 9037

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 184
lada.talk 79
it-alt.sport.calcio.juventus 57
mpc.lists.freebsd.ports.bugs 48
lada.auto 33
mpc.lists.nanog 28
cakewalk.audio 28
alt.windows7.general 25
gmane.comp.gis.openstreetmap.tagging 22
mozilla.support.firefox 22
lada.commerce 22
us 19
gmane.comp.bacula.user 18
alt.survival 17
mozilla.general 15
alt.2600 15
spline.eisfair.dev 13
mozilla.support.thunderbird 13
spline.eisfair 13
mozilla.support.seamonkey 10
TOTAL: 101 865

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7064
EMP (phn path) 1454
Too many newsgroups 50
EMP (phl) 49
Binary Payload 26
Binary: misplaced pdf 15
User-issued cancel 11
EMP (phn nph) 5
Binary: non-binary distribution 5
HTML post 5
Too many newsgroups (meow) 4
User-issued spam cancel 3
Binary Image: misplaced jpg 3
Binary Image: misplaced png 1
Too many newsgroups (low_xpost) 1
EMP (phr path) 1
TOTAL: 16 8697

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 311
newsfeed.neva.ru 29
TOTAL: 2 340
TOTAL: 1 340

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 26460 2696 14081 3592 0 28 10%23:59:54
2nntp.pasdenom.info 22719 155 19140 57 0 21364 0%23:57:48
3neva.ru 26628 49 17843 79 0 40 0%23:59:55
4eternal-september 23199 47 17465 1 0 81 0%23:59:54
5weretis.net 2892 24 2716 0 0 5 0%23:59:25
6news.killfile.org 2850 0 0 0 0 23355 0%23:59:55
7etla.org 0 0 0 0 0 20506 0%23:59:55
8news.stack.nl 2857 0 0 0 0 23332 0%23:59:55
9news.mixmin.net 0 0 0 0 0 0 0%00:10:00
10news.netfront.net 2754 0 0 0 0 23205 0%23:59:54
11news.albasani.net 2867 0 0 0 0 22628 0%23:59:55
12vc89.vc.panix.com 2840 0 0 0 0 23345 0%23:59:55
TOTAL: 12 116066 2971 71245 3729 0 157889 2%264:06:25
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it7.7 MB13.0 MB20.7 MB0.2 KB/s3.4 KB23:59:54
2nntp.pasdenom.info453.4 KB706.5 KB1.1 MB0.0 KB/s5.5 KB23:57:48
3neva.ru423.8 KB817.0 KB1.2 MB0.0 KB/s9.7 KB23:59:55
4eternal-september248.3 KB2.7 KB251.0 KB0.0 KB/s5.2 KB23:59:54
5weretis.net55.6 KB0.0 KB55.6 KB0.0 KB/s2.3 KB23:59:25
6news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
7etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
8news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
9news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
10news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
11news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
12vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 128.9 MB14.5 MB23.4 MB0.0 KB/s3.6 KB264:06:25
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147-192-187-101.drr02.clwr.fl.frontiernet.net 9 47.5 KB 1 0 001:45:02
2challenger.nielsenmedia.com 2 47.5 KB 1 0 000:30:14
TOTAL: 2 11 815.1 KB 2 0 002:15:32

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.drr02.clwr.fl.frontiernet.net 9 47.5 KB 1 0 001:45:02
2*.nielsenmedia.com 2 47.5 KB 1 0 000:30:14
3*.188.104.pools.vodafone-ip.de 97 00.0 KB 0 0 000:00:14
TOTAL: 3 108 815.1 KB 2 0 002:15:32

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.612 0.036 0.00001:45:02
challenger.nielsenmedia.com 0.184 0.008 0.00000:30:14
dslb-188-104-034-195.188.104.pools.vodafone-ip.de 5.044 0.312 0.00000:00:14
TOTAL: 3 5.840 0.356 0.00002:15:32

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-188-104-034-195.188.104.pools.vodafone-ip.de 97
TOTAL: 1 97

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1comp 8100.0%
TOTAL: 1 8100.0%

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

NewsgroupCount
1comp.lang.awk 8
TOTAL: 1 8