Daily Usenet report for paganini.linuxd.org

Apr 21 00:00:07 -- Apr 22 00:00:04

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Apr 21 13:14:21 paganini overchan[21908]: input line too long, skipping
Apr 21 16:57:25 paganini overchan[21908]: input line too long, skipping
Apr 21 20:53:47 paganini overchan[21908]: input line too long, skipping
Apr 21 21:15:50 paganini overchan[21908]: input line too long, skipping
Apr 21 21:27:50 paganini overchan[21908]: input line too long, skipping
Apr 22 00:00:04 paganini overchan[9858]: 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 104006 42.7%12.9 MB 39.0%
nnrpd 80386 33.0%9.3 MB 28.0%
inn 40149 16.5%8.4 MB 25.5%
innd 18750 7.7%2.5 MB 7.5%
nocem 96 0.0%15.7 KB 0.0%
overchan 7 0.0%1.2 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 243395 100.0%33.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 116091 49.2%
Negative hits 80915 34.3%
Do not exist 38844 16.5%
Cache misses 57 0.0%
TOTAL: 4 235907 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.023 0.0%194 0.000 5.273 40.846
article cleanup00:00:00.234 0.0%39192 0.000 0.006 0.021
article logging00:00:00.394 0.0%39772 0.000 0.010 0.045
article parse00:00:01.098 0.0%89606 0.000 0.012 0.034
article write00:01:29.120 0.1%21422 0.133 4.160 32.777
artlog/artcncl00:00:00.003 0.0%193 0.000 0.016 0.333
data move00:00:00.179 0.0%249392 0.000 0.001 0.005
hisgrep/artcncl00:00:00.048 0.0%194 0.000 0.247 3.615
hishave/artcncl00:00:00.041 0.0%194 0.000 0.211 3.077
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:18.484 0.1%237867 0.016 0.330 4.549
history sync00:00:00.112 0.0%306 0.000 0.366 47.500
history write00:01:42.188 0.1%39192 0.058 2.607 24.223
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:42:26.789 99.4%247635 179.492 344.648 1005.829
nntp read00:00:01.985 0.0%259306 0.002 0.008 0.119
overview write00:01:04.346 0.1%21422 0.013 3.004 31.236
perl filter00:01:30.137 0.1%39192 1.120 2.300 4.702
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.194 0.0%64463 0.002 0.019 0.050
TOTAL: 23:50:20.11023:49:37.375100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.103 0.0%57077 0.000 0.002 0.012
article prepare00:00:00.005 0.0%34604 0.000 0.000 0.004
article read00:00:02.034 0.0%6564 0.000 0.310 14.930
backlog stats00:00:00.211 0.0%343183 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.485 0.0%190411 0.001 0.008 0.018
data write00:00:02.961 0.0%169053 0.009 0.018 0.032
idle23:38:21.401 98.9%343183 27.165 247.977 423.798
status file00:14:37.950 1.0%43470 9.401 20.197 142.605
TOTAL: 23:53:25.88823:53:06.150100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:58:56.106 99.8%81310 37.390 220.589600107.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.568 0.0%165098 0.000 0.009 0.017
readart00:00:00.001 0.0%6 0.000 0.167 0.333
TOTAL: 04:59:28.73604:58:57.675 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 3 46935 17918 26916 2101 38%48:17:10
2newsfeed.neva.ru 146 81282 2362 63476 15444 2%71:44:37
3news.fcku.it 2 7955 1384 6221 350 17%23:59:56
4nntp.pasdenom.info 2 21793 52 21733 8 0%23:56:47
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 178 157965 21716 118346 17903 13%167:58:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net55.7 MB0.0 KB14.7 MB70.4 MB 79%3.6 KB
2newsfeed.neva.ru6.0 MB0.0 KB134.8 MB140.8 MB 4%8.1 KB
3news.fcku.it4.3 MB0.0 KB2.1 MB6.4 MB 67%3.8 KB
4nntp.pasdenom.info142.6 KB0.0 KB216.2 KB358.8 KB 39%6.0 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 566.2 MB0.0 KB151.8 MB218.0 MB 30%5.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 21 00:00:07 - 00:59:59 880 4.1% 0.242.6 MB 4.1% 0.75
Apr 21 01:00:00 - 01:59:59 692 3.2% 0.192.3 MB 3.6% 0.66
Apr 21 02:00:00 - 02:59:59 550 2.6% 0.151.7 MB 2.6% 0.49
Apr 21 03:00:00 - 03:59:59 448 2.1% 0.122.3 MB 3.5% 0.64
Apr 21 04:00:00 - 04:59:59 465 2.2% 0.131.5 MB 2.3% 0.43
Apr 21 05:00:00 - 05:59:59 508 2.4% 0.142.1 MB 3.2% 0.59
Apr 21 06:00:00 - 06:59:59 528 2.4% 0.152.1 MB 3.2% 0.60
Apr 21 07:00:00 - 07:59:59 517 2.4% 0.141.5 MB 2.2% 0.41
Apr 21 08:00:00 - 08:59:59 578 2.7% 0.161.6 MB 2.5% 0.46
Apr 21 09:00:00 - 09:59:59 981 4.6% 0.273.0 MB 4.6% 0.86
Apr 21 10:00:00 - 10:59:59 1047 4.9% 0.293.2 MB 4.9% 0.91
Apr 21 11:00:00 - 11:59:59 1006 4.7% 0.283.1 MB 4.8% 0.88
Apr 21 12:00:00 - 12:59:59 1063 4.9% 0.303.2 MB 4.9% 0.91
Apr 21 13:00:00 - 13:59:59 1018 4.7% 0.283.1 MB 4.8% 0.89
Apr 21 14:00:00 - 14:59:59 1060 4.9% 0.292.9 MB 4.5% 0.83
Apr 21 15:00:00 - 15:59:59 1161 5.4% 0.322.9 MB 4.5% 0.84
Apr 21 16:00:00 - 16:59:59 1331 6.2% 0.374.2 MB 6.4% 1.18
Apr 21 17:00:00 - 17:59:59 1184 5.5% 0.333.0 MB 4.6% 0.86
Apr 21 18:00:00 - 18:59:59 1088 5.0% 0.302.7 MB 4.1% 0.75
Apr 21 19:00:00 - 19:59:59 1280 5.9% 0.363.9 MB 6.0% 1.12
Apr 21 20:00:00 - 20:59:59 1138 5.3% 0.323.3 MB 5.1% 0.94
Apr 21 21:00:00 - 21:59:59 996 4.6% 0.283.0 MB 4.6% 0.85
Apr 21 22:00:00 - 22:59:59 1011 4.7% 0.282.9 MB 4.5% 0.84
Apr 21 23:00:00 - 23:59:59 999 4.6% 0.282.8 MB 4.4% 0.81
Apr 22 00:00:00 - 00:00:04 27 0.1% 6.75122.9 KB 0.2% 30.72
TOTAL: 23:59:57 21556 100.0% 0.2565.2 MB 100.0% 0.77
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 15411 406 0 0 0 0 0 015005
2linuxd-out.news.weretis.net 2651 637 0 0 0 0 0 0 2014
3news.fcku.it 316 31 0 0 0 0 0 0 285
4nntp.pasdenom.info 7 1 0 0 0 0 0 0 6
TOTAL: 4 18385 1075 0 0 0 0 0 017310

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 134
lada.talk 118
it-alt.sport.calcio.juventus 105
gmane.linux.alsa.devel 57
lada.auto 53
mpc.lists.freebsd.ports.bugs 46
alt.windows7.general 31
mozilla.support.firefox 30
it.annunci.varie 28
cakewalk.audio 26
alt.politics.scorched-earth 25
mozilla.dev.security.policy 23
it.annunci.commerciali 20
mozilla.support.thunderbird 19
it.annunci.immobiliari 18
gmane.comp.gis.openstreetmap.tagging 16
spline.eisfair.dev 15
mozilla.dev.security 15
alt.tv.star-trek 14
lada.commerce 12
TOTAL: 127 1075

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 15049
EMP (phn path) 1526
Too many newsgroups 53
User-issued cancel 31
EMP (phn nph) 23
Binary Payload 18
EMP (phl) 15
Binary: non-binary distribution 5
Binary Image: misplaced jpg 3
User-issued spam cancel 3
HTML post 3
Too many newsgroups (low_xpost) 1
TOTAL: 12 16730

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 547
newsfeed.neva.ru 29
news.fcku.it 4
TOTAL: 3 580
TOTAL: 1 580

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 52840 3311 35728 910 0 2881 6%23:57:49
2news.fcku.it 23792 1509 16533 2284 0 26 6%24:06:19
3weretis.net 4019 271 3514 0 0 35 6%24:09:28
4neva.ru 26883 120 18985 239 0 111 0%24:09:34
5eternal-september 22758 44 18738 3 0 31 0%24:09:36
6news.stack.nl 2857 0 0 0 0 24414 0%24:00:20
7etla.org 0 0 0 0 0 21740 0%24:09:36
8news.killfile.org 2850 0 0 0 0 24433 0%24:00:22
9vc89.vc.panix.com 2840 0 0 0 0 24420 0%24:00:03
10news.netfront.net 2770 0 0 0 0 24312 0%24:00:19
11news.albasani.net 2865 0 0 0 0 23613 0%24:00:05
12news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 12 144474 5255 93498 3436 0 146016 3%264:53:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info10.5 MB1.9 MB12.3 MB0.1 KB/s3.0 KB23:57:49
2news.fcku.it4.6 MB7.3 MB12.0 MB0.1 KB/s3.2 KB24:06:19
3weretis.net451.9 KB0.0 KB451.9 KB0.0 KB/s1.7 KB24:09:28
4neva.ru284.9 KB701.2 KB986.2 KB0.0 KB/s2.7 KB24:09:34
5eternal-september143.6 KB6.4 KB150.0 KB0.0 KB/s3.2 KB24:09:36
6news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:20
7etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:09:36
8news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:22
9vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:03
10news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:19
11news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:05
12news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 1215.9 MB9.9 MB25.8 MB0.0 KB/s3.0 KB264:53:31
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-094-217-142-075.094.217.pools.vodafone-ip.de 145 618.5 KB 4 0 001:05:55
TOTAL: 1 145 618.5 KB 4 0 004:59:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.094.217.pools.vodafone-ip.de 145 618.5 KB 4 0 001:05:55
2unresolved 1 00.0 KB 0 0 000:00:10
3*.drr02.clwr.fl.frontiernet.net 1 00.0 KB 0 0 000:24:34
4*.nielsenmedia.com 7 00.0 KB 0 0 003:28:47
TOTAL: 4 154 618.5 KB 4 0 004:59:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.340 0.028 0.00003:28:47
dslb-094-217-142-075.094.217.pools.vodafone-ip.de 15.724 3.924 0.00001:05:55
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.056 0.000 0.00000:24:34
94.102.48.193 0.052 0.004 0.00000:00:10
TOTAL: 4 16.172 3.956 0.00004:59:28

Curious NNRP server explorers [Top 20]:

SystemConn
challenger.nielsenmedia.com 7
47-192-187-101.drr02.clwr.fl.frontiernet.net 1
94.102.48.193 1
TOTAL: 3 9

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 6 0
TOTAL: 1 6 0

Newsgroup request counts (by category):

CategoryCountPct
1de 6100.0%
TOTAL: 1 6100.0%

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

NewsgroupCount
1de.talk.tagesgeschehen 3
2de.rec.heimwerken 1
3de.soc.umwelt 1
4de.comp.software.graphik 1
TOTAL: 4 6