Daily Usenet report for paganini.linuxd.org

Jul 18 00:00:02 -- Jul 19 00:00:03

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Jul 18 00:00:22 paganini nnrpd[24286]: 2001:ba8:1f1:f1ef::2 noperm ihave without permission
Jul 18 00:00:53 paganini nnrpd[24318]: 2001:ba8:1f1:f1ef::2 noperm ihave without permission
Jul 18 14:50:42 paganini overchan[23999]: input line too long, skipping
Jul 18 14:59:50 paganini overchan[23999]: input line too long, skipping
Jul 19 00:00:03 paganini overchan[13550]: 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
inn 47577 57.6%9.7 MB 71.4%
innd 24550 29.7%2.7 MB 19.5%
nnrpd 7891 9.6%835.6 KB 6.0%
innfeed 2376 2.9%402.9 KB 2.9%
nocem 177 0.2%21.1 KB 0.2%
overchan 4 0.0%0.5 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 82576 100.0%13.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 304706 56.2%
Negative hits 169007 31.2%
Do not exist 47039 8.7%
Cache misses 21358 3.9%
TOTAL: 4 542110 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.298 0.0%172 0.000 1.733 21.600
article cleanup00:00:00.320 0.0%47299 0.000 0.007 0.044
article logging00:00:00.450 0.0%47426 0.000 0.009 0.025
article parse00:00:01.447 0.0%162083 0.003 0.009 0.024
article write00:00:51.159 0.1%23497 0.096 2.177 46.371
artlog/artcncl00:00:00.003 0.0%146 0.000 0.021 0.111
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.346 0.0%585702 0.000 0.001 0.002
hisgrep/artcncl00:00:00.054 0.0%170 0.000 0.318 5.100
hishave/artcncl00:00:00.002 0.0%172 0.000 0.012 0.067
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:29.366 0.0%545259 0.017 0.054 0.390
history sync00:00:00.024 0.0%354 0.000 0.068 0.667
history write00:00:45.332 0.1%47206 0.045 0.960 5.009
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:55:24.837 99.6%578767 43.829 148.807 498.062
nntp read00:00:03.988 0.0%589396 0.003 0.007 0.011
overview write00:00:21.444 0.0%23497 0.031 0.913 4.926
perl filter00:01:57.894 0.1%47206 0.996 2.497 7.703
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.142 0.0%70984 0.004 0.016 0.033
TOTAL: 24:00:52.12223:59:58.106 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.065 0.0%24132 0.000 0.003 0.018
article prepare00:00:00.019 0.0%140632 0.000 0.000 0.002
article read00:00:10.722 0.0%19781 0.024 0.542 6.929
backlog stats00:00:00.265 0.0%572466 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.243 0.0%365763 0.003 0.006 0.013
data write00:00:03.886 0.0%344938 0.007 0.011 0.018
idle23:52:02.146100.0%572466 91.696 150.091 369.543
status file00:00:05.308 0.0%185 0.000 28.692 135.000
TOTAL: 23:52:40.68123:52:24.654100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:31:43.243 97.2%14332 34.286 132.797 653.200
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.920 0.0%29202 0.000 0.032 4.097
readart00:00:09.343 0.5%5349 0.370 1.747 52.000
TOTAL: 00:32:37.59400:31:53.506 97.7%----

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 53349 7857 42027 3465 14%47:54:05
2feeder.eternal-september.org 9 43552 5241 32620 5691 12%25:15:21
3vc89.vc.panix.com 1 7026 3402 2491 1133 48%23:55:17
4news.albasani.net 3 29733 2525 25717 1491 8%24:10:47
5newsfeed.neva.ru 173 99724 2043 86300 11381 2%96:47:22
6news.fcku.it 1 5050 1195 3854 1 23%24:43:38
7news-out.mixmin.net 3 30648 736 29245 667 2%25:11:32
8etla.org 4 34472 304 34167 1 0%15:19:01
9nntp.pasdenom.info 2 25781 49 25719 13 0%23:59:35
10news.netfront.net 1 17338 15 17243 80 0%11:04:11
11news.stack.nl 1 0 0 0 0 0%00:10:00
12localhost 25 0 0 0 0 0%00:00:00
TOTAL: 12 226 346673 23367 299383 23923 6%318:30:49
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net32.3 MB84.8 KB36.4 MB68.8 MB 46%6.2 KB
2vc89.vc.panix.com19.7 MB13.0 KB10.9 MB30.6 MB 64%6.9 KB
3feeder.eternal-september.org15.0 MB26.8 KB57.0 MB72.0 MB 20%6.7 KB
4news.albasani.net7.7 MB6.5 KB7.3 MB15.1 MB 51%3.8 KB
5newsfeed.neva.ru6.6 MB423.3 KB100.1 MB107.1 MB 6%8.2 KB
6news-out.mixmin.net2.5 MB15.4 KB1.7 MB4.2 MB 59%3.1 KB
7news.fcku.it2.0 MB0.0 KB0.8 KB2.0 MB 99%1.7 KB
8etla.org965.2 KB0.0 KB13.2 KB978.4 KB 98%3.2 KB
9nntp.pasdenom.info98.5 KB83.5 KB94.1 KB276.0 KB 35%4.5 KB
10news.netfront.net35.2 KB25.0 KB24.0 MB24.0 MB 0%259.2 KB
11news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1286.9 MB678.1 KB237.5 MB325.0 MB 26%7.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 18 00:00:02 - 00:59:59 974 4.1% 0.272.8 MB 3.2% 0.81
Jul 18 01:00:00 - 01:59:59 831 3.5% 0.233.1 MB 3.5% 0.88
Jul 18 02:00:00 - 02:59:59 621 2.6% 0.171.9 MB 2.2% 0.54
Jul 18 03:00:00 - 03:59:59 591 2.5% 0.164.2 MB 4.8% 1.21
Jul 18 04:00:00 - 04:59:59 472 2.0% 0.131.4 MB 1.6% 0.41
Jul 18 05:00:00 - 05:59:59 561 2.4% 0.163.3 MB 3.8% 0.95
Jul 18 06:00:00 - 06:59:59 597 2.5% 0.174.9 MB 5.6% 1.39
Jul 18 07:00:00 - 07:59:59 494 2.1% 0.142.6 MB 3.0% 0.74
Jul 18 08:00:00 - 08:59:59 713 3.0% 0.203.0 MB 3.4% 0.86
Jul 18 09:00:00 - 09:59:59 884 3.8% 0.253.4 MB 3.9% 0.98
Jul 18 10:00:00 - 10:59:59 1126 4.8% 0.314.3 MB 4.9% 1.23
Jul 18 11:00:00 - 11:59:59 1199 5.1% 0.333.4 MB 3.9% 0.96
Jul 18 12:00:00 - 12:59:59 1124 4.8% 0.313.0 MB 3.4% 0.85
Jul 18 13:00:00 - 13:59:59 1022 4.3% 0.282.8 MB 3.2% 0.79
Jul 18 14:00:00 - 14:59:59 1101 4.7% 0.313.5 MB 4.0% 0.99
Jul 18 15:00:00 - 15:59:59 1247 5.3% 0.354.4 MB 5.0% 1.25
Jul 18 16:00:00 - 16:59:59 1344 5.7% 0.374.2 MB 4.8% 1.20
Jul 18 17:00:00 - 17:59:59 1373 5.8% 0.384.9 MB 5.6% 1.40
Jul 18 18:00:00 - 18:59:59 1374 5.8% 0.384.2 MB 4.8% 1.19
Jul 18 19:00:00 - 19:59:59 1309 5.6% 0.366.6 MB 7.5% 1.88
Jul 18 20:00:00 - 20:59:59 1214 5.2% 0.345.6 MB 6.3% 1.58
Jul 18 21:00:00 - 21:59:59 1069 4.5% 0.303.1 MB 3.5% 0.87
Jul 18 22:00:00 - 22:59:59 1152 4.9% 0.323.1 MB 3.5% 0.88
Jul 18 23:00:00 - 23:59:59 1100 4.7% 0.314.0 MB 4.6% 1.15
Jul 19 00:00:00 - 00:00:03 6 0.0% 2.0021.7 KB 0.0% 7.24
TOTAL: 24:00:01 23498 100.0% 0.2787.9 MB 100.0% 1.04
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 11341 884 0 47 0 0 0 010410
2feeder.eternal-september.org 5708 265 0 9 0 0 0 0 5434
3linuxd-out.news.weretis.net 3500 1186 0 8 0 0 0 0 2306
4news.albasani.net 1499 162 0 3 0 0 0 0 1334
5vc89.vc.panix.com 1133 1 0 5 0 0 0 0 1127
6news-out.mixmin.net 619 6 0 6 0 0 0 0 607
7news.netfront.net 90 1 0 4 0 0 0 0 85
8news.fcku.it 23 0 0 0 0 0 0 0 23
9nntp.pasdenom.info 18 7 0 11 0 0 0 0 0
10etla.org 2 0 0 0 0 0 0 0 2
TOTAL: 10 23933 2512 0 93 0 0 0 021328

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 281
mailing.freebsd.pkg-fallout 222
alt.politics 119
mailing.openbsd.ports-changes 115
lada.talk 115
ut.test 102
mailing.openbsd.source-changes 94
alt.job 92
alt.windows7.general 86
fa.openbsd.source-changes 73
mailing.freebsd.svn-ports-all 72
it-alt.sport.calcio.juventus 65
alt.politics.scorched-earth 64
mailing.freebsd.svn-ports-head 64
mailing.freebsd.ports-bugs 43
mailing.freebsd.svn-src-all 32
mailing.openbsd.tech 32
fa.freebsd.cvs-all 31
pld.cvs.commit 31
fa.openbsd.tech 30
TOTAL: 213 2512

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 15983
EMP (phn path) 3570
EMP (phl) 811
EMP (phn nph) 425
PFM bot misc 239
Too many newsgroups 47
User-issued cancel 42
Binary Image: misplaced jpg 39
Binary Payload 20
Binary: non-binary distribution 16
HTML post 4
Binary: misplaced JPG 1
TOTAL: 12 21197

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 52
news.albasani.net 25
news.fcku.it 22
feeder.eternal-september.org 17
vc89.vc.panix.com 5
news-out.mixmin.net 3
newsfeed.neva.ru 1
etla.org 1
news.netfront.net 1
TOTAL: 9 127
TOTAL: 1 127

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 40764 4646 18771 33 0 124 11%23:59:49
2vc89.vc.panix.com 25929 2545 8245 12707 0 35 9%23:59:50
3news.fcku.it 23961 2107 13223 7026 0 0 8%23:59:50
4weretis.net 16612 528 14916 0 0 2 3%23:59:50
5etla.org 29000 493 22983 20 0 170 1%23:59:49
6neva.ru 25798 255 20348 625 0 2 0%23:59:50
7news.albasani.net 25241 235 19234 1494 0 52 0%23:59:50
8news.killfile.org 39436 161 21880 1456 0 46 0%23:59:50
9nntp.pasdenom.info 31043 110 22466 785 0 27 0%23:59:50
10news.stack.nl 37796 34 23277 51 0 306 0%23:59:50
11eternal-september 19475 4 18126 4 0 2 0%23:59:43
12news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 12 315055 11118 203469 24201 0 766 3%264:08:01
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net27.9 MB180.5 KB28.1 MB0.3 KB/s6.2 KB23:59:49
2etla.org20.4 MB56.1 KB20.4 MB0.2 KB/s40.8 KB23:59:49
3news.fcku.it9.1 MB41.3 MB50.4 MB0.6 KB/s5.6 KB23:59:50
4vc89.vc.panix.com8.5 MB38.9 MB47.5 MB0.6 KB/s3.2 KB23:59:50
5weretis.net1.1 MB0.0 KB1.1 MB0.0 KB/s2.1 KB23:59:50
6neva.ru962.1 KB1.4 MB2.3 MB0.0 KB/s2.7 KB23:59:50
7news.albasani.net800.7 KB7.3 MB8.1 MB0.1 KB/s4.8 KB23:59:50
8nntp.pasdenom.info589.1 KB1.3 MB1.9 MB0.0 KB/s2.2 KB23:59:50
9news.killfile.org529.3 KB6.5 MB7.0 MB0.1 KB/s4.4 KB23:59:50
10news.stack.nl201.9 KB107.3 KB309.2 KB0.0 KB/s3.6 KB23:59:50
11eternal-september183.5 KB5.6 KB189.1 KB0.0 KB/s23.6 KB23:59:43
12news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 1270.1 MB97.1 MB167.2 MB0.2 KB/s4.8 KB264:08:01
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1x5ce3e81b.dyn.telefonica.de 41 101249.9 KB 53 0 000:01:01
2mtrlpq2314w-lp140-07-1178043451.dsl.bell.ca 250 99421.8 KB 46 0 000:31:24
3x55b5fda6.dyn.telefonica.de 7 416.3 KB 2 0 000:00:09
TOTAL: 3 298 204688.0 KB 101 0 000:32:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dyn.telefonica.de 48 105266.2 KB 55 0 000:01:11
2*.dsl.bell.ca 250 99421.8 KB 46 0 000:31:24
3? 2 00.0 KB 0 0 000:00:00
TOTAL: 3 300 204688.0 KB 101 0 000:32:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp140-07-1178043451.dsl.bell.ca 19.832 1.688 0.00000:31:24
x5ce3e81b.dyn.telefonica.de 3.368 0.196 0.00000:01:01
x55b5fda6.dyn.telefonica.de 0.420 0.060 0.00000:00:09
2001:ba8:1f1:f1ef::2 0.128 0.004 0.00000:00:00
TOTAL: 4 23.748 1.948 0.00000:32:36

Curious NNRP server explorers [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1de 105 51.5%
2alt 47 23.0%
3fr 13 6.4%
4talk 12 5.9%
5rec 9 4.4%
6uk 6 2.9%
7linux 6 2.9%
8can 3 1.5%
9aus 2 1.0%
10sci 1 0.5%
TOTAL: 10 204100.0%

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

NewsgroupCount
1de.comp.security.misc 59
2de.comp.os.unix.networking.misc 26
3de.talk.jokes 17
4fr.soc.politique 13
5talk.origins 12
6alt.humor.puns 12
7alt.atheism 8
8alt.usage.english 7
9linux.kernel 6
10uk.d-i-y 6
11rec.games.pinball 6
12alt.happy.valley 4
13alt.tasteless.jokes 4
14alt.home.repair 4
15alt.comp.freeware 3
16can.politics 3
17de.comm.technik.dsl 3
18alt.slack 2
19aus.politics 2
20rec.woodworking 2
21sci.physics.relativity 1
22alt.support.depression 1
23alt.revisionism 1
24rec.martial-arts 1
25alt.baldspot 1
TOTAL: 25 204