Daily Usenet report for paganini.linuxd.org

Jun 28 00:00:02 -- Jun 29 00:00:06

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Jun 28 05:28:42 paganini overchan[10879]: input line too long, skipping
Jun 28 05:40:31 paganini overchan[10879]: input line too long, skipping
Jun 28 05:47:42 paganini overchan[10879]: input line too long, skipping
Jun 28 06:01:25 paganini overchan[10879]: input line too long, skipping
Jun 28 09:22:03 paganini overchan[10879]: input line too long, skipping
Jun 28 21:11:13 paganini innd: filter: EMP database could not be dumped: File o directory non esistente
Jun 28 21:11:14 paganini innd: logging hist stats to /var/spool/news/www/inn.status
Jun 28 21:11:19 paganini overchan[10661]: overchan is running while innd is creating overview data (you can ignore this message if you are running makehistory -F)
Jun 28 21:11:43 paganini innd: Perl function filter_art died on article <anim8rfsk-06D114.12111428062017@news.easynews.com>: Illegal modulus zero at /etc/news/filter/filter_innd.pl line 569.

Log entries by program:

Program nameLines%LinesSize%Size
innfeed 91843 69.9%11.6 MB 55.3%
inn 28598 21.8%7.9 MB 37.5%
nnrpd 6648 5.1%786.0 KB 3.6%
innd 4322 3.3%758.8 KB 3.5%
nocem 58 0.0%11.6 KB 0.1%
overchan 7 0.0%1.4 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 7 131478 100.0%21.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 45876 46.7%
Do not exist 23151 23.6%
Negative hits 19795 20.2%
Cache misses 9339 9.5%
TOTAL: 4 98161 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.279 0.0%159 0.000 1.755 15.375
article cleanup00:00:00.151 0.0%23407 0.000 0.006 0.024
article logging00:00:00.187 0.0%23780 0.000 0.008 0.028
article parse00:00:00.433 0.0%32074 0.000 0.014 0.045
article write00:00:38.592 0.1%19405 0.110 1.989 18.843
artlog/artcncl00:00:00.003 0.0%130 0.000 0.023 0.250
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.051 0.0%95475 0.000 0.001 0.006
hisgrep/artcncl00:00:00.032 0.0%154 0.000 0.208 1.632
hishave/artcncl00:00:00.004 0.0%159 0.000 0.025 0.250
hissync/artwrite00: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:04.158 0.0%98762 0.013 0.042 0.194
history sync00:00:00.064 0.0%340 0.000 0.188 15.333
history write00:00:35.997 0.0%23264 0.013 1.547 74.824
hiswrite/artcncl00:00:00.001 0.0%5 0.000 0.200 0.500
idle21:08:14.168 99.8%94640 69.062 804.038 2281.449
nntp read00:00:00.865 0.0%95069 0.000 0.009 0.023
overview write00:00:18.561 0.0%19405 0.014 0.957 6.215
perl filter00:00:39.659 0.1%23264 1.029 1.705 5.838
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.082 0.0%58385 0.000 0.019 0.052
TOTAL: 21:10:57.51421:10:34.287100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.073 0.0%32703 0.000 0.002 0.018
article prepare00:00:00.005 0.0%17288 0.000 0.000 0.019
article read00:00:01.434 0.0%3744 0.000 0.383 8.561
backlog stats00:00:00.203 0.0%257534 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.197 0.0%139568 0.002 0.009 0.017
data write00:00:02.362 0.0%120640 0.006 0.020 0.035
idle20:52:54.032 99.2%257534 165.636 291.899 467.928
status file00:09:54.731 0.8%38219 8.330 15.561 80.395
TOTAL: 21:03:16.44321:02:54.037100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:06:26.587 99.3%6777 39.061 57.044 86.737
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.155 0.0%13860 0.005 0.011 0.017
TOTAL: 00:06:29.12300:06:26.742 99.4%----

Control commands to INND:

CommandNumber
L 1
go 2
logmode 1
mode 132
name 1
pause 1
paused 1
reload 2
reserve 2
throttle 2
xexec 1
TOTAL: 11 146

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 12 41808 18909 21424 1475 45%33:15:26
2newsfeed.neva.ru 23 11220 390 8729 2101 3%10:19:36
3nntp.pasdenom.info 4 35956 312 35292 352 0%36:18:23
4news.fcku.it 4 9788 137 9506 145 1%10:51:11
5localhost 23 0 0 0 0 0%00:00:01
TOTAL: 5 66 98772 19748 74951 4073 19%90:44:37
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net66.0 MB150.5 KB4.3 MB70.4 MB 93%3.5 KB
2newsfeed.neva.ru1.3 MB3.5 KB9.8 MB11.1 MB 11%4.6 KB
3nntp.pasdenom.info797.9 KB246.9 KB938.3 KB1.9 MB 40%3.0 KB
4news.fcku.it410.2 KB0.0 KB649.6 KB1.0 MB 38%3.8 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 568.4 MB401.0 KB15.6 MB84.5 MB 81%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 28 00:00:02 - 00:59:59 905 3.8% 0.253.2 MB 3.9% 0.91
Jun 28 01:00:00 - 01:59:59 752 3.2% 0.212.7 MB 3.3% 0.78
Jun 28 02:00:00 - 02:59:59 609 2.6% 0.172.3 MB 2.8% 0.65
Jun 28 03:00:00 - 03:59:59 544 2.3% 0.151.7 MB 2.1% 0.50
Jun 28 04:00:00 - 04:59:59 614 2.6% 0.172.1 MB 2.6% 0.61
Jun 28 05:00:00 - 05:59:59 428 1.8% 0.122.2 MB 2.7% 0.64
Jun 28 06:00:00 - 06:59:59 489 2.1% 0.142.2 MB 2.6% 0.61
Jun 28 07:00:00 - 07:59:59 521 2.2% 0.142.4 MB 2.9% 0.68
Jun 28 08:00:00 - 08:59:59 629 2.6% 0.172.4 MB 2.9% 0.67
Jun 28 09:00:00 - 09:59:59 806 3.4% 0.222.2 MB 2.7% 0.64
Jun 28 10:00:00 - 10:59:59 913 3.8% 0.252.8 MB 3.4% 0.78
Jun 28 11:00:00 - 11:59:59 1072 4.5% 0.303.0 MB 3.7% 0.86
Jun 28 12:00:00 - 12:59:59 1168 4.9% 0.323.4 MB 4.1% 0.96
Jun 28 13:00:00 - 13:59:59 1035 4.3% 0.293.4 MB 4.2% 0.98
Jun 28 14:00:00 - 14:59:59 1035 4.3% 0.292.8 MB 3.4% 0.80
Jun 28 15:00:00 - 15:59:59 1069 4.5% 0.304.2 MB 5.2% 1.20
Jun 28 16:00:00 - 16:59:59 1248 5.2% 0.355.6 MB 6.9% 1.60
Jun 28 17:00:00 - 17:59:59 1368 5.7% 0.385.4 MB 6.6% 1.55
Jun 28 18:00:00 - 18:59:59 1280 5.4% 0.363.2 MB 3.9% 0.90
Jun 28 19:00:00 - 19:59:59 1159 4.9% 0.323.1 MB 3.7% 0.87
Jun 28 20:00:00 - 20:59:59 1445 6.1% 0.405.5 MB 6.7% 1.56
Jun 28 21:00:00 - 21:59:59 1664 7.0% 0.465.3 MB 6.5% 1.51
Jun 28 22:00:00 - 22:59:59 1527 6.4% 0.425.8 MB 7.0% 1.64
Jun 28 23:00:00 - 23:59:59 1486 6.2% 0.414.9 MB 6.0% 1.40
Jun 29 00:00:00 - 00:00:06 35 0.1% 5.83138.4 KB 0.2% 23.07
TOTAL: 24:00:04 23801 100.0% 0.2882.1 MB 100.0% 0.97
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 2246 178 0 2 0 0 0 0 2066
2linuxd-out.news.weretis.net 1939 665 0 54 0 0 0 0 1220
3nntp.pasdenom.info 360 105 0 87 0 0 0 0 168
4news.fcku.it 111 4 0 0 0 0 0 0 107
TOTAL: 4 4656 952 0 143 0 0 0 0 3561

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 132
lada.talk 129
it-alt.sport.calcio.juventus 69
it.comp.os.win.windows10 59
lada.auto 44
gmane.linux.alsa.devel 43
mozilla.support.seamonkey 31
it.annunci.immobiliari 27
fido7.ru.android 25
it.annunci.commerciali 25
alt.sex.erotica.female 24
alt.sex.pictu 24
alt.computer.workshop 23
it.annunci.varie 23
uk.radio.amateur.moderated 21
gmane.comp.gis.openstreetmap.imports 18
cakewalk.audio 14
alt.politics.scorched-earth 13
alt.windows7.general 13
mozilla.support.thunderbird 13
TOTAL: 89 952

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2320
EMP (phn path) 597
EMP (phn nph) 68
Too many newsgroups 46
EMP (phl) 44
User-issued cancel 17
Binary Payload 5
Binary: non-binary distribution 3
User-issued spam cancel 2
Too many newsgroups (low_xpost) 2
Binary: misplaced 005 1
TOTAL: 11 3105

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 420
newsfeed.neva.ru 32
nntp.pasdenom.info 3
news.fcku.it 1
TOTAL: 4 456
TOTAL: 1 456

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 26999 1323 15763 2200 0 423 4%21:12:48
2nntp.pasdenom.info 7883 600 3348 83 0 16205 7%21:08:47
3neva.ru 25379 24 17882 109 0 247 0%21:10:54
4eternal-september 21106 23 16578 0 0 11 0%21:10:54
5weretis.net 185 2 175 0 0 550 1%21:05:30
6vc89.vc.panix.com 2514 0 0 0 0 21957 0%21:12:55
7news.killfile.org 2044 0 0 0 0 21487 0%21:12:55
8news.stack.nl 2524 0 0 0 0 21854 0%21:12:55
9news.netfront.net 2134 0 0 0 0 21537 0%21:12:59
10news.mixmin.net 0 0 0 0 0 0 0%00:10:00
11etla.org 0 0 0 0 0 19390 0%21:10:54
12news.albasani.net 2535 0 0 0 0 21008 0%21:12:55
TOTAL: 12 93303 1972 53746 2392 0 144669 2%233:14:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it4.2 MB7.9 MB12.1 MB0.2 KB/s3.5 KB21:12:48
2nntp.pasdenom.info1.8 MB252.6 KB2.1 MB0.0 KB/s3.1 KB21:08:47
3eternal-september232.2 KB0.0 KB232.2 KB0.0 KB/s10.1 KB21:10:54
4neva.ru226.2 KB706.2 KB932.4 KB0.0 KB/s7.0 KB21:10:54
5weretis.net3.6 KB0.0 KB3.6 KB0.0 KB/s1.8 KB21:05:30
6vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s021:12:55
7news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s021:12:55
8news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s021:12:55
9news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s021:12:59
10news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
11etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s021:10:54
12news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s021:12:55
TOTAL: 126.5 MB8.9 MB15.4 MB0.0 KB/s3.6 KB233:14:26
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-088-067-084-037.088.067.pools.vodafone-ip.de 12 00.0 KB 0 0 000:06:29
TOTAL: 1 12 00.0 KB 0 0 000:06:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.088.067.pools.vodafone-ip.de 12 00.0 KB 0 0 000:06:29
TOTAL: 1 12 00.0 KB 0 0 000:06:29

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 1.292 0.332 0.00000:06:29
TOTAL: 1 1.292 0.332 0.00000:06:29