Daily Usenet report for paganini.linuxd.org

Mar 30 00:00:02 -- Mar 31 00:00:02

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Mar 30 08:43:33 paganini overchan[26393]: input line too long, skipping
Mar 30 08:44:36 paganini overchan[26393]: input line too long, skipping
Mar 30 08:46:26 paganini overchan[26393]: input line too long, skipping
Mar 30 08:49:03 paganini overchan[26393]: input line too long, skipping
Mar 30 17:16:23 paganini overchan[26393]: input line too long, skipping
Mar 30 17:24:53 paganini overchan[26393]: input line too long, skipping
Mar 30 18:22:52 paganini overchan[26393]: input line too long, skipping
Mar 30 20:51:44 paganini overchan[26393]: input line too long, skipping
Mar 30 20:52:23 paganini overchan[26393]: input line too long, skipping
Mar 31 00:00:02 paganini overchan[5551]: 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 115576 74.0%14.4 MB 60.3%
inn 31058 19.9%7.8 MB 32.7%
innd 9037 5.8%1.6 MB 6.6%
nnrpd 471 0.3%68.0 KB 0.3%
nocem 104 0.1%18.5 KB 0.1%
overchan 12 0.0%1.9 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 156259 100.0%23.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 118889 59.0%
Negative hits 52062 25.9%
Do not exist 30377 15.1%
Cache misses 63 0.0%
TOTAL: 4 201391 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.660 0.0%205 0.000 3.220 14.182
article cleanup00:00:00.216 0.0%30498 0.000 0.007 0.031
article logging00:00:00.391 0.0%30940 0.000 0.013 0.693
article parse00:00:00.618 0.0%41221 0.000 0.015 0.033
article write00:01:00.330 0.1%22185 0.089 2.719 45.610
artlog/artcncl00:00:00.000 0.0%204 0.000 0.000 0.000
data move00:00:00.093 0.0%208482 0.000 0.000 0.003
hisgrep/artcncl00:00:00.066 0.0%200 0.000 0.330 2.818
hishave/artcncl00:00:00.003 0.0%205 0.000 0.015 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.058 0.0%202068 0.014 0.050 0.560
history sync00:00:00.031 0.0%399 0.000 0.078 1.000
history write00:00:41.209 0.0%30498 0.011 1.351 4.085
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle23:57:29.495 99.7%203476 251.498 423.880 1123.657
nntp read00:00:01.433 0.0%209196 0.002 0.007 0.024
overview write00:00:24.692 0.0%22185 0.011 1.113 15.471
perl filter00:00:50.175 0.1%30493 1.011 1.645 4.531
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.943 0.0%66738 0.002 0.014 0.047
TOTAL: 24:01:07.20324:00:40.413100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.090 0.0%38648 0.000 0.002 0.022
article prepare00:00:00.001 0.0%20296 0.000 0.000 0.004
article read00:00:02.159 0.0%4692 0.000 0.460 21.333
backlog stats00:00:00.223 0.0%315102 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.365 0.0%168844 0.003 0.008 0.017
data write00:00:02.862 0.0%146994 0.009 0.019 0.030
idle23:42:09.387 99.2%315102 188.945 270.799 454.240
status file00:10:56.382 0.8%48416 6.501 13.557 33.659
TOTAL: 23:53:24.70023:53:12.469100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:40:04.541 99.9%420 27.333 40010.812600175.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.009 0.0%1094 0.000 0.008 0.125
TOTAL: 04:40:16.26004:40:04.550 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 4 47240 19314 26403 1523 40%48:17:17
2newsfeed.neva.ru 146 72362 2703 63101 6558 3%72:05:34
3news.fcku.it 2 8915 169 8523 223 1%24:44:36
4nntp.pasdenom.info 2 22791 38 22735 18 0%24:00:49
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 179 151308 22224 120762 8322 14%169:08:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net59.7 MB0.0 KB6.9 MB66.6 MB 89%3.3 KB
2newsfeed.neva.ru7.1 MB0.0 KB20.1 MB27.3 MB 26%3.0 KB
3news.fcku.it1.9 MB0.0 KB875.2 KB2.7 MB 68%7.1 KB
4nntp.pasdenom.info121.6 KB2.1 KB133.7 KB257.4 KB 47%4.6 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 568.8 MB2.1 KB28.0 MB96.8 MB 71%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 30 00:00:02 - 00:59:59 970 4.4% 0.273.8 MB 5.6% 1.08
Mar 30 01:00:00 - 01:59:59 664 3.0% 0.182.3 MB 3.4% 0.66
Mar 30 02:00:00 - 02:59:59 609 2.8% 0.172.0 MB 3.0% 0.57
Mar 30 03:00:00 - 03:59:59 378 1.7% 0.101.3 MB 1.8% 0.36
Mar 30 04:00:00 - 04:59:59 435 2.0% 0.121.3 MB 1.9% 0.38
Mar 30 05:00:00 - 05:59:59 540 2.4% 0.152.0 MB 2.9% 0.56
Mar 30 06:00:00 - 06:59:59 551 2.5% 0.152.6 MB 3.8% 0.74
Mar 30 07:00:00 - 07:59:59 526 2.4% 0.151.8 MB 2.6% 0.51
Mar 30 08:00:00 - 08:59:59 716 3.2% 0.202.2 MB 3.3% 0.63
Mar 30 09:00:00 - 09:59:59 1126 5.1% 0.313.7 MB 5.4% 1.05
Mar 30 10:00:00 - 10:59:59 952 4.3% 0.262.7 MB 3.9% 0.76
Mar 30 11:00:00 - 11:59:59 912 4.1% 0.253.0 MB 4.4% 0.85
Mar 30 12:00:00 - 12:59:59 986 4.5% 0.272.7 MB 4.0% 0.78
Mar 30 13:00:00 - 13:59:59 1044 4.7% 0.292.9 MB 4.2% 0.81
Mar 30 14:00:00 - 14:59:59 1159 5.2% 0.323.1 MB 4.5% 0.87
Mar 30 15:00:00 - 15:59:59 1148 5.2% 0.323.6 MB 5.2% 1.01
Mar 30 16:00:00 - 16:59:59 1171 5.3% 0.333.2 MB 4.7% 0.91
Mar 30 17:00:00 - 17:59:59 1302 5.9% 0.363.7 MB 5.4% 1.06
Mar 30 18:00:00 - 18:59:59 1177 5.3% 0.333.4 MB 5.0% 0.97
Mar 30 19:00:00 - 19:59:59 1374 6.2% 0.383.8 MB 5.6% 1.08
Mar 30 20:00:00 - 20:59:59 1191 5.4% 0.333.7 MB 5.4% 1.05
Mar 30 21:00:00 - 21:59:59 1158 5.2% 0.323.4 MB 5.0% 0.96
Mar 30 22:00:00 - 22:59:59 1103 5.0% 0.313.2 MB 4.7% 0.92
Mar 30 23:00:00 - 23:59:59 946 4.3% 0.262.8 MB 4.2% 0.81
Mar 31 00:00:00 - 00:00:02 4 0.0% 2.0020.9 KB 0.0% 10.46
TOTAL: 24:00:00 22142 100.0% 0.2668.1 MB 100.0% 0.81
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 6541 573 0 0 0 0 0 0 5968
2linuxd-out.news.weretis.net 1937 680 0 0 0 0 0 0 1257
3news.fcku.it 234 1 0 0 0 0 0 0 233
4nntp.pasdenom.info 18 1 0 0 0 5 0 0 12
TOTAL: 4 8730 1255 0 0 0 5 0 0 7470

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 245
ut.test 178
it-alt.sport.calcio.juventus 86
mpc.lists.freebsd.ports.bugs 40
it.comp.os.win.windows10 39
it.annunci.commerciali 35
lada.auto 34
it.annunci.immobiliari 34
it.annunci.varie 29
mpc.lists.freebsd.x11 26
spline.eisfair 25
alt.2600 25
gmane.comp.gis.openstreetmap.tagging 20
alt.computer.workshop 20
mozilla.support.seamonkey 19
gmane.linux.alsa.devel 17
lada.kitchen 16
alt.windows7.general 15
alt.politics.scorched-earth 15
mozilla.dev.mdc 15
TOTAL: 142 1255

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5849
EMP (phn path) 793
EMP (phn nph) 194
Too many newsgroups 58
Binary Payload 52
Too many newsgroups (low_xpost) 37
User-issued cancel 17
Binary: non-binary distribution 10
EMP (phl) 9
HTML post 7
EMP (fsl) 2
Binary: misplaced rar 1
Binary: misplaced zip 1
Too many newsgroups (meow) 1
TOTAL: 14 7031

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 415
newsfeed.neva.ru 22
nntp.pasdenom.info 1
news.fcku.it 1
TOTAL: 4 439
TOTAL: 1 439

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 31050 1817 17621 2466 0 203 5%23:52:21
2nntp.pasdenom.info 9088 469 3465 149 0 20228 5%24:03:12
3eternal-september 24558 66 19207 2 0 34 0%23:52:32
4weretis.net 3127 40 2828 0 0 7 1%23:34:02
5neva.ru 29424 10 19368 69 0 137 0%23:59:54
6vc89.vc.panix.com 2841 0 0 0 0 25005 0%23:59:53
7news.netfront.net 2761 0 0 0 0 24849 0%23:59:57
8etla.org 0 0 0 0 0 22157 0%23:59:54
9news.albasani.net 2864 0 0 0 0 24029 0%23:59:49
10news.stack.nl 2859 0 0 0 0 24985 0%24:00:02
11news.killfile.org 2847 0 0 0 0 25005 0%23:59:48
12news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 12 111419 2402 62489 2686 0 166639 2%263:31:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it5.6 MB7.4 MB13.0 MB0.2 KB/s3.1 KB23:52:21
2nntp.pasdenom.info1.6 MB415.7 KB2.0 MB0.0 KB/s3.2 KB24:03:12
3eternal-september226.0 KB4.0 KB230.0 KB0.0 KB/s3.4 KB23:52:32
4weretis.net60.5 KB0.0 KB60.5 KB0.0 KB/s1.5 KB23:34:02
5neva.ru26.5 KB350.1 KB376.6 KB0.0 KB/s4.8 KB23:59:54
6vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
7news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
8etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
9news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
10news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:02
11news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
12news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 127.4 MB8.2 MB15.6 MB0.0 KB/s3.1 KB263:31:24
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-092-073-008-096.092.073.pools.vodafone-ip.de 124 00.0 KB 0 0 000:00:18
2challenger.nielsenmedia.com 3 00.0 KB 0 0 001:00:21
347-192-187-101.drr02.clwr.fl.frontiernet.net 19 00.0 KB 0 0 003:39:35
TOTAL: 3 146 00.0 KB 0 0 004:40:15

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.092.073.pools.vodafone-ip.de 124 00.0 KB 0 0 000:00:18
2*.drr02.clwr.fl.frontiernet.net 19 00.0 KB 0 0 003:39:35
3*.nielsenmedia.com 3 00.0 KB 0 0 001:00:21
TOTAL: 3 146 00.0 KB 0 0 004:40:15

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47-192-187-101.drr02.clwr.fl.frontiernet.net 1.180 0.048 0.00003:39:35
challenger.nielsenmedia.com 0.260 0.032 0.00001:00:21
dslb-092-073-008-096.092.073.pools.vodafone-ip.de 6.548 0.308 0.00000:00:18
TOTAL: 3 7.988 0.388 0.00004:40:15

NNRP client timeouts [Top 20]:

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