Daily Usenet report for paganini.linuxd.org

Sep 28 00:00:02 -- Sep 29 00:00:03

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Sep 28 01:01:21 paganini overchan[4418]: input line too long, skipping
Sep 28 08:56:38 paganini overchan[4418]: input line too long, skipping
Sep 28 23:26:13 paganini overchan[4418]: input line too long, skipping
Sep 29 00:00:03 paganini overchan[27586]: 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 50665 62.5%10.9 MB 75.8%
innd 21624 26.7%2.4 MB 16.8%
nnrpd 6235 7.7%652.7 KB 4.4%
innfeed 2492 3.1%418.8 KB 2.8%
nocem 96 0.1%10.9 KB 0.1%
overchan 5 0.0%0.7 KB 0.0%
TOTAL: 6 81117 100.0%14.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 347970 59.5%
Negative hits 186682 31.9%
Do not exist 49849 8.5%
Cache misses 201 0.0%
TOTAL: 4 584702 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.221 0.0%158 0.000 1.399 28.000
article cleanup00:00:00.353 0.0%50313 0.000 0.007 0.022
article logging00:00:00.479 0.0%50675 0.000 0.009 0.090
article parse00:00:01.714 0.0%270732 0.000 0.006 0.023
article write00:00:54.368 0.1%27825 0.112 1.954 9.756
artlog/artcncl00:00:00.001 0.0%110 0.000 0.009 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.374 0.0%762578 0.000 0.000 0.002
hisgrep/artcncl00:00:00.069 0.0%155 0.000 0.445 3.750
hishave/artcncl00:00:00.001 0.0%158 0.000 0.006 0.077
hishave/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:33.776 0.0%589448 0.017 0.057 0.980
history sync00:00:00.019 0.0%353 0.000 0.054 0.500
history write00:00:47.975 0.1%50310 0.065 0.954 8.673
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:55:11.810 99.6%756891 9.487 113.770 479.059
nntp read00:00:05.032 0.0%770109 0.003 0.007 0.010
overview write00:00:26.318 0.0%27825 0.031 0.946 5.146
perl filter00:01:51.058 0.1%50310 1.128 2.207 12.418
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.497 0.0%83872 0.000 0.018 0.062
TOTAL: 24:00:51.64123:59:55.065 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.078 0.0%30193 0.000 0.003 0.014
article prepare00:00:00.017 0.0%159986 0.000 0.000 0.002
article read00:00:14.146 0.0%24112 0.018 0.587 7.039
backlog stats00:00:00.309 0.0%679177 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.680 0.0%434969 0.002 0.006 0.012
data write00:00:03.768 0.0%410991 0.005 0.009 0.017
idle23:52:43.525100.0%679177 69.126 126.570 325.370
status file00:00:05.531 0.0%200 0.000 27.655 294.000
TOTAL: 23:53:23.05523:53:10.054100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:38:32.387 99.1%15698 34.829 376.633601529.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.201 0.0%31678 0.000 0.006 0.070
readart00:00:22.527 0.4%8193 0.276 2.750 52.457
TOTAL: 01:39:25.34901:38:55.115 99.5%----

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 2 68680 6707 59018 2955 9%50:16:03
2feeder.eternal-september.org 3 45671 5380 36455 3836 11%23:48:45
3vc89.vc.panix.com 1 7176 3992 2152 1032 55%23:43:34
4news-out.mixmin.net 4 33827 3011 28712 2104 8%24:06:20
5newsfeed.neva.ru 144 106056 2718 92979 10359 2%72:13:21
6news.albasani.net 3 34334 2550 30106 1678 7%23:57:14
7news.fcku.it 2 7551 2318 5206 27 30%23:54:32
8etla.org 2 27944 946 26995 3 3%24:35:38
9nntp.pasdenom.info 3 23573 118 23449 6 0%24:08:09
10news.netfront.net 3 10631 30 9981 620 0%08:04:01
11news.stack.nl 1 0 0 0 0 0%00:10:00
12localhost 25 0 0 0 0 0%00:00:00
TOTAL: 12 193 365443 27770 315053 22620 7%298:57:37
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net23.1 MB0.0 KB32.5 MB55.6 MB 41%5.9 KB
2feeder.eternal-september.org15.6 MB0.0 KB30.5 MB46.1 MB 33%5.1 KB
3vc89.vc.panix.com13.4 MB0.0 KB6.2 MB19.7 MB 68%4.0 KB
4newsfeed.neva.ru8.7 MB93.3 KB80.4 MB89.2 MB 9%7.0 KB
5news.albasani.net7.9 MB0.0 KB9.9 MB17.8 MB 44%4.3 KB
6news-out.mixmin.net7.6 MB0.0 KB4.0 MB11.6 MB 65%2.3 KB
7news.fcku.it4.2 MB0.0 KB41.0 KB4.2 MB 99%1.8 KB
8etla.org2.9 MB0.0 KB20.4 KB2.9 MB 99%3.1 KB
9nntp.pasdenom.info260.8 KB0.0 KB109.1 KB369.9 KB 70%3.0 KB
10news.netfront.net95.0 KB0.0 KB234.7 MB234.8 MB 0%369.9 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: 1283.7 MB93.3 KB398.4 MB482.2 MB 17%9.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 28 00:00:02 - 00:59:59 1017 3.7% 0.283.1 MB 3.7% 0.88
Sep 28 01:00:00 - 01:59:59 764 2.7% 0.212.4 MB 2.9% 0.68
Sep 28 02:00:00 - 02:59:59 698 2.5% 0.193.7 MB 4.4% 1.05
Sep 28 03:00:00 - 03:59:59 540 1.9% 0.151.5 MB 1.8% 0.42
Sep 28 04:00:00 - 04:59:59 473 1.7% 0.131.8 MB 2.2% 0.52
Sep 28 05:00:00 - 05:59:59 490 1.8% 0.141.5 MB 1.8% 0.42
Sep 28 06:00:00 - 06:59:59 647 2.3% 0.182.2 MB 2.7% 0.63
Sep 28 07:00:00 - 07:59:59 632 2.3% 0.182.6 MB 3.1% 0.73
Sep 28 08:00:00 - 08:59:59 753 2.7% 0.212.4 MB 2.9% 0.69
Sep 28 09:00:00 - 09:59:59 1053 3.8% 0.293.1 MB 3.7% 0.88
Sep 28 10:00:00 - 10:59:59 1301 4.7% 0.363.6 MB 4.3% 1.02
Sep 28 11:00:00 - 11:59:59 1349 4.9% 0.373.9 MB 4.6% 1.10
Sep 28 12:00:00 - 12:59:59 1220 4.4% 0.343.5 MB 4.2% 1.00
Sep 28 13:00:00 - 13:59:59 1226 4.4% 0.343.4 MB 4.1% 0.97
Sep 28 14:00:00 - 14:59:59 1547 5.6% 0.433.8 MB 4.5% 1.07
Sep 28 15:00:00 - 15:59:59 1538 5.5% 0.434.4 MB 5.3% 1.27
Sep 28 16:00:00 - 16:59:59 1659 6.0% 0.465.0 MB 6.0% 1.42
Sep 28 17:00:00 - 17:59:59 1622 5.8% 0.454.0 MB 4.8% 1.15
Sep 28 18:00:00 - 18:59:59 1684 6.1% 0.475.9 MB 7.0% 1.67
Sep 28 19:00:00 - 19:59:59 1600 5.8% 0.444.8 MB 5.7% 1.36
Sep 28 20:00:00 - 20:59:59 1579 5.7% 0.444.4 MB 5.3% 1.24
Sep 28 21:00:00 - 21:59:59 1720 6.2% 0.484.9 MB 5.9% 1.40
Sep 28 22:00:00 - 22:59:59 1388 5.0% 0.393.6 MB 4.4% 1.03
Sep 28 23:00:00 - 23:59:59 1286 4.6% 0.363.9 MB 4.6% 1.10
Sep 29 00:00:00 - 00:00:03 3 0.0% 1.009.3 KB 0.0% 3.10
TOTAL: 24:00:01 27789 100.0% 0.3283.4 MB 100.0% 0.99
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 10285 2014 0 3 0 0 0 0 8268
2feeder.eternal-september.org 3880 246 0 0 0 0 0 0 3634
3linuxd-out.news.weretis.net 3030 1282 0 0 0 0 0 0 1748
4news-out.mixmin.net 2164 10 0 0 0 0 0 0 2154
5news.albasani.net 1788 210 0 0 1 0 0 0 1577
6vc89.vc.panix.com 1077 1 0 0 0 0 0 0 1076
7news.netfront.net 492 0 0 0 0 0 0 0 492
8news.fcku.it 38 24 0 0 0 0 0 0 14
9nntp.pasdenom.info 9 0 0 0 0 0 0 0 9
10etla.org 3 1 0 0 0 0 0 0 2
TOTAL: 10 22766 3788 0 3 1 0 0 018974

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 805
ut.test 174
lada.auto 170
lada.talk 159
it-alt.sport.calcio.juventus 114
alt.politics 111
pld.cvs.commit 102
mailing.freebsd.svn-ports-all 96
mailing.freebsd.svn-ports-head 94
mailing.freebsd.ports-bugs 85
alt.job 78
alabam.test 58
mozilla.dev.tree-alerts 50
alt.windows7.general 49
fa.openbsd.source-changes 48
mailing.openbsd.source-changes 48
mailing.gcc.gcc-cvs 45
it.comp.os.win.windows10 45
tin.it.sport.calcio 44
alt.survival 39
TOTAL: 267 3788

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

GroupsCount
alt.culture.china 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 14419
EMP (phn path) 2180
EMP (phl) 800
EMP (phn nph) 533
Binary: misplaced rar 426
Too many newsgroups 73
Binary: misplaced par2 58
User-issued cancel 33
Binary Image: misplaced jpg 31
Binary: non-binary distribution 31
Binary Payload 13
User-issued spam cancel 6
Too many newsgroups (low_xpost) 5
HTML post 5
TOTAL: 14 18613

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 173
news.albasani.net 103
news-out.mixmin.net 50
feeder.eternal-september.org 14
news.fcku.it 11
vc89.vc.panix.com 7
newsfeed.neva.ru 2
etla.org 1
TOTAL: 8 361
TOTAL: 1 361

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1vc89.vc.panix.com 30035 2777 8555 16455 1 142 9%23:59:55
2news.netfront.net 49693 2576 25070 37 0 398 5%23:59:55
3news.fcku.it 27199 2509 15529 7413 0 3 9%23:59:55
4weretis.net 22361 960 19849 0 0 0 4%23:59:55
5etla.org 35592 591 27166 32 0 433 1%23:59:53
6neva.ru 30602 461 23449 1063 0 38 1%23:59:54
7news.albasani.net 29329 253 22877 2079 0 78 0%23:59:55
8news.stack.nl 46002 155 27320 267 0 940 0%23:59:55
9nntp.pasdenom.info 37976 139 26865 657 0 117 0%23:59:55
10news.killfile.org 47311 124 26029 1635 0 362 0%23:59:55
11eternal-september 24486 2 22226 0 0 27 0%23:59:55
12news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 12 380586 10547 244935 29638 1 2538 2%264:09:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net9.9 MB373.0 KB10.3 MB0.1 KB/s4.0 KB23:59:55
2news.fcku.it9.0 MB28.8 MB37.8 MB0.4 KB/s3.9 KB23:59:55
3vc89.vc.panix.com8.5 MB44.1 MB52.6 MB0.6 KB/s2.8 KB23:59:55
4etla.org7.6 MB122.1 KB7.7 MB0.1 KB/s12.6 KB23:59:53
5weretis.net1.7 MB0.0 KB1.7 MB0.0 KB/s1.8 KB23:59:55
6neva.ru1.3 MB1.7 MB3.0 MB0.0 KB/s2.0 KB23:59:54
7news.albasani.net767.4 KB8.1 MB8.9 MB0.1 KB/s3.9 KB23:59:55
8news.stack.nl642.6 KB748.9 KB1.4 MB0.0 KB/s3.3 KB23:59:55
9nntp.pasdenom.info572.0 KB1.2 MB1.8 MB0.0 KB/s2.3 KB23:59:55
10news.killfile.org406.7 KB6.6 MB7.0 MB0.1 KB/s4.1 KB23:59:55
11eternal-september12.3 KB0.0 KB12.3 KB0.0 KB/s6.2 KB23:59:55
12news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 1240.3 MB91.7 MB132.0 MB0.1 KB/s3.4 KB264:09:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1x4db4b0c7.dyn.telefonica.de 48 55138.8 KB 40 0 000:01:09
2mtrlpq2314w-lp130-04-1177984284.dsl.bell.ca 129 52153.8 KB 14 0 001:38:15
TOTAL: 2 177 107292.7 KB 54 0 001:39:24

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dyn.telefonica.de 48 55138.8 KB 40 0 000:01:09
2*.dsl.bell.ca 129 52153.8 KB 14 0 001:38:15
TOTAL: 2 177 107292.7 KB 54 0 001:39:24

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp130-04-1177984284.dsl.bell.ca 11.792 1.312 0.00001:38:15
x4db4b0c7.dyn.telefonica.de 3.520 0.336 0.00000:01:09
TOTAL: 2 15.312 1.648 0.00001:39:24

NNRP client timeouts [Top 20]:

SystemConnPeer
mtrlpq2314w-lp130-04-1177984284.dsl.bell.ca 6 4
TOTAL: 1 6 4

Newsgroup request counts (by category):

CategoryCountPct
1de 55 51.4%
2sci 14 13.1%
3rec 14 13.1%
4talk 12 11.2%
5soc 6 5.6%
6uk 4 3.7%
7alt 2 1.9%
TOTAL: 7 107100.0%

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

NewsgroupCount
1de.talk.jokes 16
2de.etc.finanz.boerse 16
3sci.electronics.design 10
4talk.politics.guns 9
5de.comm.provider.status 7
6de.alt.rec.digitalfotografie 6
7soc.retirement 6
8rec.gambling.poker 6
9de.comm.technik.dsl 4
10rec.sport.soccer 4
11uk.d-i-y 4
12sci.physics 3
13rec.sport.pro-wrestling 3
14talk.origins 3
15de.alt.sysadmin.recovery 2
16de.comm.provider.usenet 1
17de.comp.os.unix.networking.misc 1
18de.markt.comp.hardware.misc 1
19alt.life.sucks 1
20de.comm.software.mailserver 1
21sci.military.naval 1
22alt.atheism 1
23rec.photo.digital 1
TOTAL: 23 107