Daily Usenet report for paganini.linuxd.org

Apr 3 00:00:02 -- Apr 4 00:00:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Apr 3 19:14:38 paganini overchan[651]: input line too long, skipping
Apr 3 19:15:34 paganini overchan[651]: input line too long, skipping
Apr 4 00:00:01 paganini overchan[29253]: 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 101129 63.5%12.2 MB 52.7%
inn 34617 21.8%7.9 MB 33.9%
innd 13318 8.4%2.0 MB 8.7%
nnrpd 10002 6.3%1.1 MB 4.6%
nocem 79 0.0%13.8 KB 0.1%
overchan 4 0.0%0.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 159150 100.0%23.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 95760 47.9%
Negative hits 70253 35.1%
Do not exist 33889 16.9%
Cache misses 78 0.0%
TOTAL: 4 199980 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.420 0.0%183 0.000 2.295 73.000
article cleanup00:00:00.247 0.0%34081 0.000 0.007 0.040
article logging00:00:00.428 0.0%34403 0.000 0.012 0.216
article parse00:00:00.886 0.0%75750 0.000 0.012 0.025
article write00:00:54.449 0.1%20704 0.156 2.630 16.458
artlog/artcncl00:00:00.001 0.0%183 0.000 0.005 0.040
data move00:00:00.168 0.0%240356 0.000 0.001 0.003
hisgrep/artcncl00:00:00.001 0.0%180 0.000 0.006 0.200
hishave/artcncl00:00:00.003 0.0%183 0.000 0.016 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.349 0.0%201082 0.016 0.051 0.539
history sync00:00:00.201 0.0%396 0.000 0.508 22.000
history write00:00:29.873 0.0%34081 0.017 0.877 4.458
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:57:30.855 99.7%232886 223.234 370.357 1017.197
nntp read00:00:01.823 0.0%238011 0.004 0.008 0.017
overview write00:00:24.557 0.0%20704 0.027 1.186 4.383
perl filter00:01:08.862 0.1%34081 1.038 2.021 5.063
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.987 0.0%62263 0.000 0.016 0.032
TOTAL: 24:01:17.13724:00:44.110100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.091 0.0%34778 0.000 0.003 0.013
article prepare00:00:00.004 0.0%23284 0.000 0.000 0.007
article read00:00:01.400 0.0%5627 0.000 0.249 7.853
backlog stats00:00:00.176 0.0%236257 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.914 0.0%123234 0.002 0.007 0.020
data write00:00:01.841 0.0%102619 0.006 0.018 0.032
idle23:40:27.815 99.1%236257 240.651 360.742 609.391
status file00:12:48.262 0.9%42327 11.873 18.151 41.274
TOTAL: 23:53:41.11023:53:20.503100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:34:59.775 99.3%20512 94.794 102.368 139.513
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.354 0.0%41108 0.002 0.009 0.017
readart00:00:03.291 0.2%8117 0.155 0.405 3.846
TOTAL: 00:35:15.56900:35:03.420 99.4%----

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 8 53297 17074 32414 3809 32%48:45:00
2newsfeed.neva.ru 152 70876 2756 58563 9557 3%72:06:27
3news.fcku.it 1 5479 841 4628 10 15%22:11:31
4localhost 25 0 0 0 0 0%00:00:00
TOTAL: 4 186 129652 20671 95605 13376 15%143:02:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net58.3 MB0.0 KB29.0 MB87.3 MB 66%4.3 KB
2newsfeed.neva.ru9.3 MB0.0 KB70.7 MB80.0 MB 11%6.7 KB
3news.fcku.it1.8 MB0.0 KB20.1 KB1.8 MB 98%2.2 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 469.5 MB0.0 KB99.7 MB169.2 MB 41%5.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 3 00:00:02 - 00:59:59 808 3.9% 0.223.0 MB 4.3% 0.85
Apr 3 01:00:00 - 01:59:59 651 3.1% 0.182.4 MB 3.4% 0.67
Apr 3 02:00:00 - 02:59:59 546 2.6% 0.151.6 MB 2.4% 0.47
Apr 3 03:00:00 - 03:59:59 666 3.2% 0.182.3 MB 3.3% 0.65
Apr 3 04:00:00 - 04:59:59 390 1.9% 0.111.4 MB 2.0% 0.39
Apr 3 05:00:00 - 05:59:59 498 2.4% 0.143.3 MB 4.7% 0.94
Apr 3 06:00:00 - 06:59:59 415 2.0% 0.121.5 MB 2.1% 0.42
Apr 3 07:00:00 - 07:59:59 447 2.2% 0.122.1 MB 3.0% 0.59
Apr 3 08:00:00 - 08:59:59 559 2.7% 0.161.9 MB 2.7% 0.54
Apr 3 09:00:00 - 09:59:59 713 3.4% 0.202.0 MB 2.9% 0.57
Apr 3 10:00:00 - 10:59:59 781 3.8% 0.222.2 MB 3.1% 0.61
Apr 3 11:00:00 - 11:59:59 878 4.2% 0.243.1 MB 4.5% 0.89
Apr 3 12:00:00 - 12:59:59 932 4.5% 0.263.5 MB 5.0% 0.98
Apr 3 13:00:00 - 13:59:59 882 4.3% 0.243.6 MB 5.2% 1.02
Apr 3 14:00:00 - 14:59:59 996 4.8% 0.283.0 MB 4.3% 0.85
Apr 3 15:00:00 - 15:59:59 916 4.4% 0.253.0 MB 4.3% 0.85
Apr 3 16:00:00 - 16:59:59 1046 5.1% 0.293.7 MB 5.3% 1.05
Apr 3 17:00:00 - 17:59:59 1126 5.4% 0.313.8 MB 5.5% 1.09
Apr 3 18:00:00 - 18:59:59 1205 5.8% 0.333.3 MB 4.8% 0.94
Apr 3 19:00:00 - 19:59:59 1332 6.4% 0.373.8 MB 5.4% 1.07
Apr 3 20:00:00 - 20:59:59 1374 6.6% 0.385.5 MB 7.9% 1.56
Apr 3 21:00:00 - 21:59:59 1305 6.3% 0.363.7 MB 5.3% 1.04
Apr 3 22:00:00 - 22:59:59 1184 5.7% 0.333.3 MB 4.7% 0.93
Apr 3 23:00:00 - 23:59:59 1044 5.0% 0.292.8 MB 4.0% 0.80
Apr 4 00:00:00 - 00:00:02 17 0.1% 8.5047.7 KB 0.1% 23.84
TOTAL: 24:00:00 20711 100.0% 0.2469.6 MB 100.0% 0.82
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 9617 890 0 0 1 0 0 0 8726
2linuxd-out.news.weretis.net 4079 1069 0 0 0 0 0 0 3010
3news.fcku.it 15 7 0 0 0 0 0 0 8
TOTAL: 3 13711 1966 0 0 1 0 0 011744

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 224
lada.talk 167
mailing.freebsd.pkg-fallout 138
lada.auto 136
it-alt.sport.calcio.juventus 78
ut.test 72
mailing.freebsd.ports-bugs 68
mailing.freebsd.svn-ports-all 62
mailing.freebsd.svn-ports-head 54
alt.survival 53
mailing.openbsd.tech 42
fa.openbsd.tech 42
mpc.lists.freebsd.ports.bugs 31
alt.windows7.general 31
it.comp.os.win.windows10 28
mailing.unix.dovecot 28
mailing.openssl.cvs 25
mailing.openbsd.misc 21
mailing.openbsd.source-changes 20
fa.openbsd.source-changes 20
TOTAL: 187 1966

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

GroupsCount
uk.legal.moderated 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7098
EMP (phn path) 2450
EMP (phl) 705
Binary: misplaced rar 691
EMP (phn nph) 298
Too many newsgroups 89
User-issued cancel 26
Binary Payload 18
Binary: non-binary distribution 16
Binary Image: misplaced jpg 9
Binary: misplaced par2 7
Too many newsgroups (meow) 5
HTML post 3
Binary: misplaced sfv 2
Binary: misplaced nfo 2
Binary: misplaced srr 2
Binary: misplaced r14 1
TOTAL: 17 11422

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 286
newsfeed.neva.ru 31
news.fcku.it 5
TOTAL: 3 322
TOTAL: 1 322

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 24725 1933 14444 3297 0 27 7%23:52:11
2neva.ru 26022 186 17469 260 0 27 0%23:59:49
3weretis.net 4302 140 3519 0 0 57 3%23:59:49
4nntp.pasdenom.info 0 0 0 0 0 20553 0%23:50:00
5news.killfile.org 2831 0 0 0 0 23521 0%23:59:43
6vc89.vc.panix.com 2837 0 0 0 0 23526 0%23:59:36
7eternal-september 0 0 0 0 0 17683 0%23:59:49
8etla.org 0 0 0 0 0 20711 0%23:59:49
9news.mixmin.net 0 0 0 0 0 0 0%00:10:00
10news.albasani.net 2859 0 0 0 0 22824 0%23:59:41
11news.stack.nl 2857 0 0 0 0 23456 0%23:59:49
12news.netfront.net 2752 0 0 0 0 23363 0%23:59:34
TOTAL: 12 69185 2259 35432 3557 0 175748 3%263:49:50
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it8.3 MB16.1 MB24.4 MB0.3 KB/s4.8 KB23:52:11
2neva.ru526.0 KB852.7 KB1.3 MB0.0 KB/s3.1 KB23:59:49
3weretis.net246.2 KB0.0 KB246.2 KB0.0 KB/s1.8 KB23:59:49
4nntp.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:00
5news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
6vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:36
7eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
8etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
9news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
10news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:41
11news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
12news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:34
TOTAL: 129.1 MB16.9 MB26.0 MB0.0 KB/s4.6 KB263:49:50
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-01-845526598.dsl.bell.ca 48 4249.1 KB 10 0 000:35:15
TOTAL: 1 48 4249.1 KB 10 0 000:35:15

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 48 4249.1 KB 10 0 000:35:15
TOTAL: 1 48 4249.1 KB 10 0 000:35:15

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp140-01-845526598.dsl.bell.ca 5.088 1.316 0.00000:35:15
TOTAL: 1 5.088 1.316 0.00000:35:15

Newsgroup request counts (by category):

CategoryCountPct
1sci 22 52.4%
2alt 20 47.6%
TOTAL: 2 42100.0%

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

NewsgroupCount
1sci.physics 22
2alt.drugs.heroin 18
3alt.happy.valley 1
4alt.support.depression 1
TOTAL: 4 42