Daily Usenet report for paganini.linuxd.org

May 28 00:00:01 -- May 29 00:00:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

May 28 00:00:19 paganini nnrpd[7612]: 2001:ba8:1f1:f1ef::2 noperm ihave without permission
May 28 00:00:50 paganini nnrpd[7660]: 2001:ba8:1f1:f1ef::2 noperm ihave without permission
May 28 20:52:42 paganini overchan[25530]: input line too long, skipping
May 28 20:58:13 paganini overchan[25530]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 46092 63.1%10.4 MB 76.8%
innd 17914 24.5%2.1 MB 15.8%
nnrpd 6503 8.9%669.6 KB 4.8%
innfeed 2367 3.2%334.1 KB 2.4%
nocem 117 0.2%14.9 KB 0.1%
overchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 72995 100.0%13.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 327495 57.1%
Negative hits 177904 31.0%
Do not exist 45528 7.9%
Cache misses 22770 4.0%
TOTAL: 4 573697 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.962 0.0%211 0.000 14.038 226.455
article cleanup00:00:00.279 0.0%45820 0.000 0.006 0.028
article logging00:00:00.813 0.0%45929 0.000 0.018 1.463
article parse00:00:01.492 0.0%203926 0.001 0.007 0.022
article write00:00:42.473 0.0%26874 0.100 1.580 11.945
artlog/artcncl00:00:00.002 0.0%197 0.000 0.010 0.143
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.265 0.0%681018 0.000 0.000 0.002
hisgrep/artcncl00:00:00.004 0.0%206 0.000 0.019 0.333
hishave/artcncl00:00:00.000 0.0%211 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:25.728 0.0%577794 0.013 0.045 0.309
history sync00:00:00.140 0.0%297 0.000 0.471 48.000
history write00:01:12.288 0.1%45788 0.246 1.579 5.914
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle23:54:15.420 99.6%671238 32.646 128.204 447.115
nntp read00:00:03.671 0.0%684156 0.003 0.005 0.009
overview write00:00:32.328 0.0%26874 0.013 1.203 3.615
perl filter00:01:58.033 0.1%45788 1.048 2.578 7.768
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.761 0.0%80802 0.005 0.022 0.051
TOTAL: 24:00:19.28423:59:17.659 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.063 0.0%29187 0.000 0.002 0.026
article prepare00:00:00.015 0.0%152136 0.000 0.000 0.001
article read00:00:12.430 0.0%23385 0.000 0.532 6.532
backlog stats00:00:00.272 0.0%619653 0.000 0.000 0.001
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.909 0.0%408925 0.003 0.007 0.012
data write00:00:04.720 0.0%387129 0.006 0.012 0.021
idle24:01:44.192 99.9%619653 69.997 139.601 377.441
status file00:00:06.574 0.0%185 0.000 35.535 359.000
TOTAL: 24:02:29.68024:02:11.175100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:27:13.870 97.2%13290 34.971 122.940 434.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.211 0.3%28327 0.000 0.149 11.170
readart00:00:08.912 0.5%6131 0.305 1.454 35.000
TOTAL: 00:28:01.32400:27:26.993 98.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 5 64994 6698 55818 2478 10%49:39:10
2feeder.eternal-september.org 6 41989 6090 32269 3630 14%24:31:39
3vc89.vc.panix.com 25 7418 4219 2423 776 56%24:17:17
4news.albasani.net 4 33191 2792 28941 1458 8%23:58:39
5newsfeed.neva.ru 146 96089 2411 84957 8721 2%74:02:52
6news-out.mixmin.net 7 32029 1873 28962 1194 5%23:39:56
7news.fcku.it 10 4452 1624 2799 29 36%26:18:07
8etla.org 4 46546 922 45618 6 1%21:24:16
9news.netfront.net 1 39663 80 39034 549 0%22:02:36
10nntp.pasdenom.info 2 26007 18 25987 2 0%23:59:31
11localhost 25 0 0 0 0 0%00:00:00
12news.stack.nl 1 0 0 0 0 0%00:10:00
TOTAL: 12 236 392378 26727 346808 18843 6%314:04:03
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1vc89.vc.panix.com24.2 MB187.3 KB4.7 MB29.1 MB 83%6.0 KB
2linuxd-out.news.weretis.net22.7 MB7.0 KB17.4 MB40.1 MB 56%4.5 KB
3feeder.eternal-september.org17.7 MB1.6 KB33.5 MB51.2 MB 34%5.4 KB
4news.albasani.net10.6 MB1.8 KB14.2 MB24.9 MB 42%6.0 KB
5newsfeed.neva.ru6.4 MB143.7 KB66.5 MB73.1 MB 8%6.7 KB
6news-out.mixmin.net5.2 MB0.0 KB2.2 MB7.4 MB 69%2.5 KB
7etla.org3.4 MB1.5 KB11.8 KB3.5 MB 99%3.8 KB
8news.fcku.it2.8 MB0.0 KB40.4 KB2.9 MB 98%1.8 KB
9news.netfront.net621.0 KB39.8 KB127.2 MB127.9 MB 0%208.1 KB
10nntp.pasdenom.info47.8 KB1.1 KB2.0 KB51.0 KB 93%2.5 KB
11localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1293.8 MB383.9 KB265.9 MB360.0 MB 26%8.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 28 00:00:01 - 00:59:59 852 3.2% 0.243.8 MB 4.0% 1.08
May 28 01:00:00 - 01:59:59 719 2.7% 0.202.1 MB 2.2% 0.60
May 28 02:00:00 - 02:59:59 681 2.5% 0.192.3 MB 2.4% 0.65
May 28 03:00:00 - 03:59:59 622 2.3% 0.172.2 MB 2.3% 0.61
May 28 04:00:00 - 04:59:59 484 1.8% 0.132.0 MB 2.1% 0.56
May 28 05:00:00 - 05:59:59 476 1.8% 0.131.5 MB 1.6% 0.44
May 28 06:00:00 - 06:59:59 605 2.3% 0.172.0 MB 2.2% 0.58
May 28 07:00:00 - 07:59:59 663 2.5% 0.184.6 MB 4.8% 1.30
May 28 08:00:00 - 08:59:59 938 3.5% 0.263.3 MB 3.6% 0.95
May 28 09:00:00 - 09:59:59 1163 4.3% 0.323.0 MB 3.1% 0.84
May 28 10:00:00 - 10:59:59 1290 4.8% 0.363.4 MB 3.7% 0.98
May 28 11:00:00 - 11:59:59 1381 5.1% 0.383.8 MB 4.1% 1.09
May 28 12:00:00 - 12:59:59 1339 5.0% 0.374.4 MB 4.6% 1.24
May 28 13:00:00 - 13:59:59 1246 4.6% 0.355.1 MB 5.4% 1.44
May 28 14:00:00 - 14:59:59 1389 5.2% 0.394.2 MB 4.5% 1.20
May 28 15:00:00 - 15:59:59 1443 5.4% 0.404.3 MB 4.6% 1.23
May 28 16:00:00 - 16:59:59 1491 5.5% 0.418.0 MB 8.5% 2.27
May 28 17:00:00 - 17:59:59 1528 5.7% 0.425.6 MB 5.9% 1.59
May 28 18:00:00 - 18:59:59 1481 5.5% 0.415.2 MB 5.5% 1.48
May 28 19:00:00 - 19:59:59 1499 5.6% 0.425.4 MB 5.7% 1.53
May 28 20:00:00 - 20:59:59 1644 6.1% 0.465.7 MB 6.0% 1.61
May 28 21:00:00 - 21:59:59 1400 5.2% 0.394.3 MB 4.6% 1.22
May 28 22:00:00 - 22:59:59 1326 4.9% 0.374.7 MB 4.9% 1.32
May 28 23:00:00 - 23:59:59 1204 4.5% 0.333.4 MB 3.6% 0.97
May 29 00:00:00 - 00:00:01 2 0.0% 2.008.7 KB 0.0% 8.73
TOTAL: 24:00:00 26866 100.0% 0.3194.2 MB 100.0% 1.12
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 8757 2038 0 20 0 0 0 0 6699
2feeder.eternal-september.org 3663 431 0 1 0 0 0 0 3231
3linuxd-out.news.weretis.net 2524 1459 0 4 0 0 0 0 1061
4news.albasani.net 1424 165 0 1 0 0 0 0 1258
5news-out.mixmin.net 1226 18 0 0 0 0 0 0 1208
6vc89.vc.panix.com 805 4 0 4 0 0 0 0 797
7news.netfront.net 583 4 0 0 0 0 0 0 579
8news.fcku.it 32 0 0 0 0 0 0 0 32
9etla.org 9 0 0 1 0 0 0 0 8
10nntp.pasdenom.info 6 5 0 1 0 0 0 0 0
TOTAL: 10 19029 4124 0 32 0 0 0 014873

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 836
lada.talk 315
ut.test 150
it-alt.sport.calcio.juventus 124
alt.politics 113
lada.auto 111
alt.politics.scorched-earth 110
mailing.freebsd.svn-ports-all 104
mailing.freebsd.svn-ports-head 101
mailing.freebsd.pkg-fallout 101
gmane.comp.gis.openstreetmap 80
mailing.gcc.gcc-cvs 71
alt.windows7.general 71
mailing.openbsd.misc 54
24hoursupport.helpdesk 51
lada.commerce 49
mailing.database.pgsql-general 47
gmane.linux.alsa.devel 45
mpc.lists.nanog 40
lada.photo 37
TOTAL: 276 4124

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 10346
EMP (phn path) 2593
EMP (phl) 757
Binary: misplaced flac 517
PFM bot misc 132
EMP (phn nph) 118
Too many newsgroups 112
Binary Image: misplaced jpg 52
Binary Payload 41
Binary: non-binary distribution 33
User-issued cancel 24
HTML post 14
Binary: misplaced zip 10
Binary: misplaced rar 6
Binary: misplaced sfv 3
Binary: misplaced nzb 3
Too many newsgroups (low_xpost) 2
Too many newsgroups (meow) 1
TOTAL: 18 14764

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1vc89.vc.panix.com 30532 1999 10287 14504 3 169 6%23:55:36
2news.netfront.net 48062 1992 24745 119 1 466 4%24:03:24
3etla.org 33759 674 26106 87 1 672 1%23:59:20
4weretis.net 21357 521 19382 1 0 14 2%23:57:25
5neva.ru 29046 292 23121 815 0 26 1%24:04:39
6news.killfile.org 44292 175 23982 2762 3 178 0%24:03:14
7news.albasani.net 28140 138 21975 1841 0 64 0%23:54:08
8nntp.pasdenom.info 35066 118 25812 806 0 62 0%23:59:53
9news.fcku.it 27201 101 14441 10886 0 0 0%23:59:49
10news.stack.nl 35451 41 26637 57 0 603 0%23:59:58
11eternal-september 22119 7 20550 15 0 32 0%23:55:42
TOTAL: 11 355025 6058 237038 31893 8 2286 1%263:53:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org20.3 MB400.8 KB20.7 MB0.2 KB/s27.9 KB23:59:20
2vc89.vc.panix.com8.4 MB39.6 MB48.0 MB0.6 KB/s3.0 KB23:55:36
3news.netfront.net7.9 MB12.1 MB20.0 MB0.2 KB/s9.7 KB24:03:24
4weretis.net858.0 KB195.7 KB1.0 MB0.0 KB/s2.0 KB23:57:25
5neva.ru589.9 KB1.5 MB2.1 MB0.0 KB/s2.0 KB24:04:39
6news.killfile.org564.3 KB8.7 MB9.3 MB0.1 KB/s3.2 KB24:03:14
7nntp.pasdenom.info333.7 KB1.3 MB1.6 MB0.0 KB/s1.8 KB23:59:53
8news.albasani.net301.5 KB6.6 MB6.9 MB0.1 KB/s3.5 KB23:54:08
9news.fcku.it276.6 KB54.2 MB54.5 MB0.6 KB/s5.1 KB23:59:49
10news.stack.nl115.7 KB105.7 KB221.4 KB0.0 KB/s2.3 KB23:59:58
11eternal-september23.5 KB30.2 KB53.7 KB0.0 KB/s2.4 KB23:55:42
TOTAL: 1139.6 MB124.8 MB164.4 MB0.2 KB/s4.4 KB263:53:08
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1bas2-montrealak-1177634274.dsl.bell.ca 276 8193.0 MB 204 0 000:26:54
2x55b3a1ad.dyn.telefonica.de 6 10317.9 KB 1 0 000:00:08
3f055151175.adsl.alicedsl.de 41 514.4 KB 4 0 000:00:56
TOTAL: 3 323 8343.3 MB 209 0 000:28:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 276 8193.0 MB 204 0 000:26:54
2*.dyn.telefonica.de 6 10317.9 KB 1 0 000:00:08
3*.adsl.alicedsl.de 41 514.4 KB 4 0 000:00:56
4? 2 00.0 KB 0 0 000:00:00
TOTAL: 4 325 8343.3 MB 209 0 000:28:00

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
bas2-montrealak-1177634274.dsl.bell.ca 20.140 1.408 0.00000:26:54
f055151175.adsl.alicedsl.de 2.176 0.248 0.00000:00:56
x55b3a1ad.dyn.telefonica.de 0.348 0.020 0.00000:00:08
2001:ba8:1f1:f1ef::2 0.068 0.004 0.00000:00:00
TOTAL: 4 22.732 1.680 0.00000:28:00

Curious NNRP server explorers [Top 20]:

SystemConn
2001:ba8:1f1:f1ef::2 2
TOTAL: 1 2

Newsgroup request counts (by category):

CategoryCountPct
1alt 451 54.1%
2linux 142 17.0%
3rec 128 15.3%
4fr 62 7.4%
5de 15 1.8%
6uk 12 1.4%
7aus 7 0.8%
8sci 7 0.8%
9can 6 0.7%
10talk 3 0.4%
11comp 1 0.1%
TOTAL: 11 834100.0%

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

NewsgroupCount
1linux.kernel 142
2alt.fan.rush-limbaugh 105
3alt.usage.english 71
4fr.soc.politique 62
5rec.arts.tv 39
6alt.usenet.kooks 38
7alt.atheism 36
8rec.sport.pro-wrestling 34
9rec.food.cooking 29
10alt.comp.freeware 28
11alt.society.liberalism 26
12alt.gossip.celebrities 21
13alt.happy.valley 19
14alt.conspiracy 18
15alt.home.repair 18
16alt.california 14
17alt.support.depression 11
18de.admin.infos 10
19rec.crafts.metalworking 9
20alt.books.louis-lamour 8
21alt.life.sucks 8
22rec.outdoors.rv-travel 7
23uk.d-i-y 7
24can.politics 6
25alt.humor.puns 6
26sci.physics 6
27uk.railway 5
28alt.obituaries 5
29rec.gambling.poker 4
30aus.tv 4
31alt.appalachian 4
32alt.assassination.jfk 4
33de.talk.jokes 4
34alt.support.diabetes 3
35aus.politics 3
36alt.arts.poetry.comments 2
37alt.astronomy 2
38talk.origins 2
39rec.sport.football.college 2
40rec.sport.tennis 2
41comp.sys.apple2 1
42alt.autos.toyota 1
43rec.boats 1
44sci.electronics.design 1
45alt.bible.prophecy 1
46talk.politics.misc 1
47rec.photo.digital 1
48de.etc.finanz.boerse 1
49alt.autos.ford 1
50alt.christnet.christianlife 1
TOTAL: 50 834