Daily Usenet report for paganini.linuxd.org

Apr 14 00:00:03 -- Apr 15 00:00:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Apr 14 09:28:36 paganini overchan[14024]: input line too long, skipping
Apr 14 10:37:17 paganini overchan[14024]: input line too long, skipping
Apr 15 00:00:02 paganini overchan[27186]: 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 116440 47.6%14.5 MB 43.6%
nnrpd 67112 27.4%7.7 MB 23.3%
inn 40692 16.6%8.3 MB 25.0%
innd 20241 8.3%2.6 MB 7.9%
nocem 66 0.0%11.6 KB 0.0%
overchan 4 0.0%0.8 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 244556 100.0%33.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 116512 49.5%
Negative hits 79045 33.6%
Do not exist 39860 16.9%
Cache misses 65 0.0%
TOTAL: 4 235482 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.781 0.0%158 0.000 4.943 119.000
article cleanup00:00:00.286 0.0%40054 0.000 0.007 0.029
article logging00:00:00.450 0.0%40535 0.000 0.011 0.222
article parse00:00:01.163 0.0%88177 0.000 0.013 0.055
article write00:00:49.766 0.1%20583 0.106 2.418 17.891
artlog/artcncl00:00:00.001 0.0%147 0.000 0.007 1.000
data move00:00:00.167 0.0%237299 0.000 0.001 0.005
hisgrep/artcncl00:00:00.087 0.0%156 0.000 0.558 86.000
hishave/artcncl00:00:00.003 0.0%158 0.000 0.019 0.154
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:11.946 0.0%236765 0.011 0.050 0.954
history sync00:00:00.026 0.0%400 0.000 0.065 0.667
history write00:00:36.505 0.0%40054 0.055 0.911 3.905
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:56:59.546 99.7%241467 159.810 357.066 1272.746
nntp read00:00:01.886 0.0%249976 0.002 0.008 0.024
overview write00:00:20.644 0.0%20583 0.019 1.003 5.871
perl filter00:01:27.694 0.1%40054 0.857 2.189 4.591
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.067 0.0%61926 0.000 0.017 0.064
TOTAL: 24:01:01.35724:00:32.018100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.107 0.0%56750 0.000 0.002 0.012
article prepare00:00:00.002 0.0%21332 0.000 0.000 0.007
article read00:00:03.607 0.0%4943 0.000 0.730 29.290
backlog stats00:00:00.231 0.0%308196 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.305 0.0%165286 0.001 0.008 0.020
data write00:00:02.850 0.0%144901 0.008 0.020 0.034
idle23:41:31.873 99.2%308196 28.007 276.746 482.303
status file00:11:03.896 0.8%48766 7.913 13.614 22.939
TOTAL: 23:52:56.25923:52:43.871100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:01:34.055 99.9%67778 36.503 266.961600100.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.350 0.0%137443 0.000 0.010 0.111
readart00:00:00.001 0.0%7 0.000 0.143 1.000
TOTAL: 05:01:53.23005:01:35.406 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 3 46012 18184 25592 2236 39%48:06:49
2newsfeed.neva.ru 145 83633 2213 64403 17017 2%71:58:52
3news.fcku.it 3 9320 196 8831 293 2%27:39:33
4nntp.pasdenom.info 3 22169 21 22144 4 0%25:49:12
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 179 161134 20614 120970 19550 12%173:34:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net59.4 MB0.0 KB13.7 MB73.1 MB 81%3.7 KB
2newsfeed.neva.ru5.8 MB0.0 KB143.3 MB149.1 MB 3%7.9 KB
3news.fcku.it568.9 KB0.0 KB2.0 MB2.6 MB 21%5.4 KB
4nntp.pasdenom.info45.5 KB0.0 KB129.3 KB174.8 KB 26%7.0 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 565.8 MB0.0 KB159.1 MB224.9 MB 29%5.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 14 00:00:03 - 00:59:59 768 3.7% 0.212.8 MB 4.2% 0.79
Apr 14 01:00:00 - 01:59:59 688 3.3% 0.192.1 MB 3.2% 0.60
Apr 14 02:00:00 - 02:59:59 588 2.9% 0.161.9 MB 2.8% 0.53
Apr 14 03:00:00 - 03:59:59 552 2.7% 0.151.5 MB 2.3% 0.43
Apr 14 04:00:00 - 04:59:59 425 2.1% 0.121.3 MB 2.0% 0.37
Apr 14 05:00:00 - 05:59:59 362 1.8% 0.101.0 MB 1.6% 0.30
Apr 14 06:00:00 - 06:59:59 418 2.0% 0.121.3 MB 2.0% 0.38
Apr 14 07:00:00 - 07:59:59 452 2.2% 0.131.6 MB 2.4% 0.44
Apr 14 08:00:00 - 08:59:59 683 3.3% 0.191.9 MB 2.9% 0.55
Apr 14 09:00:00 - 09:59:59 863 4.2% 0.242.3 MB 3.4% 0.64
Apr 14 10:00:00 - 10:59:59 948 4.6% 0.262.5 MB 3.9% 0.72
Apr 14 11:00:00 - 11:59:59 1095 5.3% 0.303.0 MB 4.6% 0.85
Apr 14 12:00:00 - 12:59:59 935 4.5% 0.262.4 MB 3.7% 0.69
Apr 14 13:00:00 - 13:59:59 842 4.1% 0.232.1 MB 3.3% 0.61
Apr 14 14:00:00 - 14:59:59 975 4.7% 0.273.3 MB 5.0% 0.93
Apr 14 15:00:00 - 15:59:59 1181 5.7% 0.335.9 MB 8.9% 1.67
Apr 14 16:00:00 - 16:59:59 1207 5.9% 0.346.4 MB 9.7% 1.82
Apr 14 17:00:00 - 17:59:59 1244 6.0% 0.353.6 MB 5.5% 1.03
Apr 14 18:00:00 - 18:59:59 1154 5.6% 0.323.2 MB 4.8% 0.91
Apr 14 19:00:00 - 19:59:59 1153 5.6% 0.323.4 MB 5.1% 0.96
Apr 14 20:00:00 - 20:59:59 1174 5.7% 0.333.8 MB 5.8% 1.08
Apr 14 21:00:00 - 21:59:59 1045 5.1% 0.292.9 MB 4.3% 0.81
Apr 14 22:00:00 - 22:59:59 924 4.5% 0.263.0 MB 4.6% 0.87
Apr 14 23:00:00 - 23:59:59 897 4.4% 0.252.4 MB 3.7% 0.69
Apr 15 00:00:00 - 00:00:02 25 0.1% 12.50119.6 KB 0.2% 59.80
TOTAL: 23:59:59 20598 100.0% 0.2465.8 MB 100.0% 0.78
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 17010 600 0 0 2 0 0 016408
2linuxd-out.news.weretis.net 2687 639 0 0 0 0 0 0 2048
3news.fcku.it 226 3 0 0 0 0 0 0 223
4nntp.pasdenom.info 6 0 0 0 0 0 0 0 6
TOTAL: 4 19929 1242 0 0 2 0 0 018685

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 269
lada.auto 144
ut.test 111
mozilla.support.thunderbird 52
it-alt.sport.calcio.juventus 47
it.annunci.commerciali 38
it.annunci.varie 37
it.annunci.immobiliari 36
alt.windows7.general 33
gmane.linux.alsa.devel 31
mpc.lists.nanog 25
mpc.lists.freebsd.ports.bugs 23
mozilla.support.firefox 21
cakewalk.audio 20
alt.survival 16
alt.computer.workshop 15
mozilla.general 15
spline.eisfair 14
mozilla.dev.l10n 13
mozilla.support.seamonkey 13
TOTAL: 121 1242

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
it.scienza.astronomia 1
uk.legal.moderated 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 16279
EMP (phn path) 1337
User-issued cancel 324
EMP (phn nph) 142
Too many newsgroups 64
EMP (phl) 11
Binary: non-binary distribution 11
Binary Payload 11
HTML post 9
Binary Image: misplaced jpg 6
User-issued spam cancel 5
Too many newsgroups (low_xpost) 5
Too many newsgroups (meow) 1
TOTAL: 13 18205

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 462
newsfeed.neva.ru 18
TOTAL: 2 480
TOTAL: 1 480

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 27505 1798 15792 2836 0 54 6%23:59:54
2nntp.pasdenom.info 26505 459 22032 87 0 20047 1%23:57:47
3weretis.net 2450 54 2326 0 0 11 2%23:57:45
4eternal-september 21811 40 17838 1 0 21 0%23:59:54
5neva.ru 26074 17 18254 77 0 41 0%23:59:54
6vc89.vc.panix.com 2843 0 0 0 0 23440 0%23:59:54
7news.stack.nl 2851 0 0 0 0 23411 0%23:59:54
8news.netfront.net 2775 0 0 0 0 23328 0%23:59:53
9etla.org 0 0 0 0 0 20598 0%23:59:54
10news.killfile.org 2848 0 0 0 0 23445 0%23:59:54
11news.albasani.net 2865 0 0 0 0 22591 0%23:59:54
12news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 12 118527 2368 76242 3001 0 156987 1%264:04:37
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it5.3 MB9.1 MB14.4 MB0.2 KB/s3.2 KB23:59:54
2nntp.pasdenom.info1.7 MB186.6 KB1.9 MB0.0 KB/s3.6 KB23:57:47
3eternal-september172.1 KB4.4 KB176.4 KB0.0 KB/s4.3 KB23:59:54
4weretis.net64.9 KB0.0 KB64.9 KB0.0 KB/s1.2 KB23:57:45
5neva.ru44.8 KB463.1 KB507.8 KB0.0 KB/s5.4 KB23:59:54
6vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
7news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
8news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
9etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
10news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
11news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
12news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 127.3 MB9.7 MB17.0 MB0.0 KB/s3.2 KB264:04:37
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-094-217-142-075.094.217.pools.vodafone-ip.de 121 512.5 KB 4 0 000:55:39
2challenger.nielsenmedia.com 9 22.8 KB 2 0 002:53:16
TOTAL: 2 130 715.3 KB 6 0 005:01:52

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.094.217.pools.vodafone-ip.de 121 512.5 KB 4 0 000:55:39
2*.nielsenmedia.com 9 22.8 KB 2 0 002:53:16
3*.drr02.clwr.fl.frontiernet.net 4 00.0 KB 0 0 001:12:57
TOTAL: 3 134 715.3 KB 6 0 005:01:52

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.500 0.020 0.00002:53:16
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.212 0.020 0.00001:12:57
dslb-094-217-142-075.094.217.pools.vodafone-ip.de 13.060 3.212 0.00000:55:39
TOTAL: 3 13.772 3.252 0.00005:01:52

Curious NNRP server explorers [Top 20]:

SystemConn
47-192-187-101.drr02.clwr.fl.frontiernet.net 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1de 4 57.1%
2comp 2 28.6%
3alt 1 14.3%
TOTAL: 3 7100.0%

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

NewsgroupCount
1comp.lang.awk 2
2de.soc.politik.misc 2
3de.etc.sprache.deutsch 1
4alt.test 1
5de.rec.mampf 1
TOTAL: 5 7