Daily Usenet report for paganini.linuxd.org

May 24 00:00:05 -- May 25 00:00:05

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

May 24 00:04:56 paganini overchan[20649]: input line too long, skipping
May 24 00:13:20 paganini overchan[20649]: input line too long, skipping
May 24 01:00:32 paganini overchan[20649]: input line too long, skipping
May 24 01:08:35 paganini overchan[20649]: input line too long, skipping
May 24 09:14:28 paganini overchan[20649]: input line too long, skipping
May 24 10:10:55 paganini overchan[20649]: input line too long, skipping
May 24 10:15:39 paganini overchan[20649]: input line too long, skipping
May 24 10:28:30 paganini overchan[20649]: input line too long, skipping
May 24 14:39:19 paganini overchan[20649]: input line too long, skipping
May 24 16:09:14 paganini overchan[20649]: input line too long, skipping
May 25 00:00:04 paganini overchan[3929]: 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 101109 47.1%12.6 MB 41.5%
nnrpd 74054 34.5%8.5 MB 28.1%
inn 30681 14.3%7.8 MB 25.7%
innd 8556 4.0%1.4 MB 4.6%
nocem 80 0.0%13.7 KB 0.0%
overchan 12 0.0%2.0 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 7 214494 100.0%30.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 120015 59.5%
Negative hits 51813 25.7%
Do not exist 29864 14.8%
Cache misses 94 0.0%
TOTAL: 4 201786 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.467 0.0%173 0.000 14.260 100.389
article cleanup00:00:00.213 0.0%30065 0.000 0.007 0.023
article logging00:00:00.230 0.0%30512 0.000 0.008 0.032
article parse00:00:00.594 0.0%45954 0.000 0.013 0.043
article write00:04:04.582 0.3%22565 0.200 10.839 32.247
artlog/artcncl00:00:00.001 0.0%173 0.000 0.006 1.000
data move00:00:00.126 0.0%210270 0.000 0.001 0.003
hisgrep/artcncl00:00:00.003 0.0%173 0.000 0.017 0.111
hishave/artcncl00:00:00.007 0.0%173 0.000 0.040 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.393 0.0%203157 0.017 0.051 0.759
history sync00:00:00.501 0.0%322 0.000 1.556 162.333
history write00:01:27.988 0.1%30064 0.013 2.927 13.587
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:52:23.606 99.4%199889 154.001 429.957 1156.572
nntp read00:00:01.538 0.0%210755 0.002 0.007 0.016
overview write00:00:49.951 0.1%22565 0.013 2.214 17.781
perl filter00:00:53.609 0.1%30063 1.201 1.783 3.367
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.376 0.0%67880 0.000 0.020 0.059
TOTAL: 24:00:32.16123:59:57.185100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.091 0.0%37366 0.000 0.002 0.017
article prepare00:00:00.004 0.0%25860 0.000 0.000 0.007
article read00:00:02.694 0.0%5143 0.000 0.524 14.575
backlog stats00:00:00.239 0.0%337235 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.532 0.0%186909 0.002 0.008 0.016
data write00:00:03.104 0.0%164571 0.010 0.019 0.035
idle23:42:46.208 99.2%337235 168.194 253.136 423.344
status file00:10:27.557 0.7%42278 8.259 14.844 85.678
TOTAL: 23:53:39.87623:53:21.429100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:39:14.852 99.8%74828 36.679 175.801600294.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.383 0.0%151778 0.000 0.009 0.167
readart00:00:00.001 0.0%11 0.000 0.091 0.250
TOTAL: 03:39:38.85303:39:16.236 99.8%----

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 5 49712 19502 28597 1613 39%48:33:16
2newsfeed.neva.ru 146 71205 2737 62745 5723 3%72:20:40
3news.fcku.it 1 7183 338 6699 146 4%21:17:58
4nntp.pasdenom.info 3 22660 44 22608 8 0%24:10:58
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 180 150760 22621 120649 7490 15%166:22:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net66.8 MB3.0 KB9.7 MB76.5 MB 87%3.7 KB
2newsfeed.neva.ru7.1 MB0.0 KB27.5 MB34.6 MB 20%4.2 KB
3news.fcku.it920.9 KB0.0 KB1.1 MB2.0 MB 44%4.3 KB
4nntp.pasdenom.info106.0 KB0.0 KB12.1 KB118.1 KB 89%2.3 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 574.9 MB3.0 KB38.3 MB113.3 MB 66%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 24 00:00:05 - 00:59:59 935 4.1% 0.263.8 MB 5.1% 1.09
May 24 01:00:00 - 01:59:59 761 3.4% 0.213.3 MB 4.5% 0.95
May 24 02:00:00 - 02:59:59 523 2.3% 0.151.6 MB 2.1% 0.45
May 24 03:00:00 - 03:59:59 464 2.1% 0.131.3 MB 1.8% 0.37
May 24 04:00:00 - 04:59:59 451 2.0% 0.131.5 MB 2.0% 0.43
May 24 05:00:00 - 05:59:59 463 2.1% 0.131.5 MB 2.0% 0.42
May 24 06:00:00 - 06:59:59 505 2.2% 0.141.8 MB 2.4% 0.52
May 24 07:00:00 - 07:59:59 608 2.7% 0.172.0 MB 2.7% 0.56
May 24 08:00:00 - 08:59:59 692 3.1% 0.192.9 MB 3.8% 0.81
May 24 09:00:00 - 09:59:59 982 4.4% 0.272.8 MB 3.7% 0.79
May 24 10:00:00 - 10:59:59 1031 4.6% 0.293.0 MB 4.0% 0.86
May 24 11:00:00 - 11:59:59 1121 5.0% 0.313.4 MB 4.6% 0.98
May 24 12:00:00 - 12:59:59 1000 4.4% 0.282.7 MB 3.6% 0.76
May 24 13:00:00 - 13:59:59 940 4.2% 0.263.5 MB 4.7% 0.99
May 24 14:00:00 - 14:59:59 1093 4.9% 0.303.0 MB 4.1% 0.86
May 24 15:00:00 - 15:59:59 1136 5.0% 0.323.6 MB 4.8% 1.03
May 24 16:00:00 - 16:59:59 1218 5.4% 0.343.6 MB 4.8% 1.02
May 24 17:00:00 - 17:59:59 1416 6.3% 0.393.9 MB 5.3% 1.12
May 24 18:00:00 - 18:59:59 1371 6.1% 0.383.7 MB 4.9% 1.05
May 24 19:00:00 - 19:59:59 1289 5.7% 0.363.9 MB 5.2% 1.11
May 24 20:00:00 - 20:59:59 1156 5.1% 0.324.5 MB 6.0% 1.28
May 24 21:00:00 - 21:59:59 1096 4.9% 0.303.1 MB 4.1% 0.88
May 24 22:00:00 - 22:59:59 1177 5.2% 0.335.7 MB 7.7% 1.63
May 24 23:00:00 - 23:59:59 1084 4.8% 0.304.4 MB 5.9% 1.25
May 25 00:00:00 - 00:00:05 20 0.1% 4.00115.8 KB 0.2% 23.16
TOTAL: 24:00:00 22532 100.0% 0.2674.6 MB 100.0% 0.88
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 5774 538 0 0 0 0 0 0 5236
2linuxd-out.news.weretis.net 2020 440 0 1 0 0 0 0 1579
3news.fcku.it 163 7 0 0 0 0 0 0 156
4nntp.pasdenom.info 19 0 1 0 0 1 0 0 17
TOTAL: 4 7976 985 1 1 0 1 0 0 6988

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 215
ut.test 151
lada.auto 68
it-alt.sport.calcio.juventus 54
gmane.linux.alsa.devel 51
mpc.lists.freebsd.ports.bugs 35
it.comp.os.win.windows10 28
it.annunci.commerciali 26
it.annunci.varie 26
spline.eisfair 23
mozilla.dev.platform 20
mpc.lists.nanog 18
alt.survival 15
gmane.comp.hardware.netbook.arm.sunxi 13
mozilla.dev.l10n 11
mozilla.general 9
uk.radio.amateur.moderated 9
mozilla.dev.mdc 9
mozilla.support.firefox 8
mozilla.support.thunderbird 8
TOTAL: 109 985

Unwanted distributions [Top 20]:

DistributionCount
local 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4813
EMP (phn path) 1414
EMP (phl) 107
EMP (phn nph) 72
Too many newsgroups 67
Binary: non-binary distribution 23
User-issued cancel 19
Binary Payload 18
HTML post 6
Binary: misplaced par2 2
User-issued spam cancel 1
Binary: misplaced nfo 1
Binary: misplaced sfv 1
TOTAL: 13 6544

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 414
newsfeed.neva.ru 26
news.fcku.it 4
TOTAL: 3 444
TOTAL: 1 444

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 38128 2176 19619 653 0 592 5%23:57:41
2news.fcku.it 28210 1383 18632 2144 0 135 4%23:59:45
3eternal-september 25134 35 19352 0 0 3 0%23:59:42
4neva.ru 27081 15 19692 102 0 154 0%23:59:48
5weretis.net 151 2 144 0 0 3007 1%23:57:22
6news.albasani.net 2864 0 0 0 0 24747 0%23:59:48
7news.mixmin.net 0 0 0 0 0 0 0%00:10:00
8etla.org 0 0 0 0 0 22532 0%23:59:48
9vc89.vc.panix.com 2841 0 0 0 0 25372 0%23:59:48
10news.netfront.net 2753 0 0 0 0 25245 0%23:59:47
11news.stack.nl 2858 0 0 0 0 25293 0%23:59:48
12news.killfile.org 2806 0 0 0 0 25337 0%23:59:48
TOTAL: 12 132826 3611 77439 2899 0 152417 2%264:03:05
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info8.2 MB1.5 MB9.8 MB0.1 KB/s3.5 KB23:57:41
2news.fcku.it4.2 MB7.1 MB11.3 MB0.1 KB/s3.3 KB23:59:45
3eternal-september99.1 KB0.0 KB99.1 KB0.0 KB/s2.8 KB23:59:42
4neva.ru33.2 KB337.6 KB370.8 KB0.0 KB/s3.2 KB23:59:48
5weretis.net2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:57:22
6news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
7news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
8etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
9vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
10news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
11news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
12news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
TOTAL: 1212.5 MB9.0 MB21.6 MB0.0 KB/s3.4 KB264:03:05
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 5 814.7 KB 2 0 002:33:59
2dslb-088-067-084-037.088.067.pools.vodafone-ip.de 134 36.0 KB 3 0 001:05:38
TOTAL: 2 139 1120.7 KB 5 0 003:39:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 5 814.7 KB 2 0 002:33:59
2*.088.067.pools.vodafone-ip.de 134 36.0 KB 3 0 001:05:38
TOTAL: 2 139 1120.7 KB 5 0 003:39:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.328 0.028 0.00002:33:59
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 14.484 3.500 0.00001:05:38
TOTAL: 2 14.812 3.528 0.00003:39:38

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 5 0
TOTAL: 1 5 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 8 72.7%
2de 3 27.3%
TOTAL: 2 11100.0%

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

NewsgroupCount
1comp.lang.awk 8
2de.comm.software.mozilla.browser 1
3de.comp.office-pakete.ms-office.word 1
4de.soc.gleichberechtigung 1
TOTAL: 4 11