Daily Usenet report for paganini.linuxd.org

Jul 2 00:00:01 -- Jul 3 00:00:03

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Jul 2 03:06:32 paganini overchan[24584]: input line too long, skipping
Jul 2 10:40:36 paganini overchan[24584]: input line too long, skipping
Jul 2 10:54:15 paganini overchan[24584]: input line too long, skipping
Jul 2 12:25:20 paganini overchan[24584]: input line too long, skipping
Jul 2 14:46:25 paganini overchan[24584]: input line too long, skipping
Jul 3 00:00:03 paganini overchan[11769]: 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 101378 62.5%12.5 MB 52.5%
inn 35380 21.8%8.0 MB 33.6%
innd 14106 8.7%2.1 MB 8.8%
nnrpd 11183 6.9%1.2 MB 5.1%
nocem 39 0.0%6.2 KB 0.0%
overchan 7 0.0%1.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 162094 100.0%23.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 101110 51.0%
Negative hits 62301 31.4%
Do not exist 34452 17.4%
Cache misses 369 0.2%
TOTAL: 4 198232 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.893 0.0%440 0.000 4.302 34.000
article cleanup00:00:00.221 0.0%34597 0.000 0.006 0.026
article logging00:00:00.834 0.0%34927 0.000 0.024 1.585
article parse00:00:00.823 0.0%64089 0.000 0.013 0.034
article write00:00:53.644 0.1%20833 0.151 2.575 9.872
artlog/artcncl00:00:00.003 0.0%436 0.000 0.007 0.250
data move00:00:00.131 0.0%228978 0.000 0.001 0.004
hisgrep/artcncl00:00:00.039 0.0%440 0.000 0.089 0.167
hishave/artcncl00:00:00.010 0.0%440 0.000 0.023 0.167
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:17.038 0.0%198456 0.012 0.086 4.649
history sync00:00:00.023 0.0%309 0.000 0.074 1.000
history write00:00:46.176 0.1%34594 0.033 1.335 4.903
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:55:58.438 99.7%216800 215.613 397.410 1129.015
nntp read00:00:01.591 0.0%221359 0.001 0.007 0.015
overview write00:00:22.542 0.0%20833 0.035 1.082 4.728
perl filter00:01:23.675 0.1%34594 1.243 2.419 6.629
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.273 0.0%62644 0.000 0.020 0.053
TOTAL: 24:00:23.03923:59:48.354100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.085 0.0%35647 0.000 0.002 0.015
article prepare00:00:00.004 0.0%22808 0.000 0.000 0.010
article read00:00:01.325 0.0%4656 0.000 0.285 8.500
backlog stats00:00:00.191 0.0%308423 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.241 0.0%161573 0.001 0.008 0.024
data write00:00:02.234 0.0%140801 0.004 0.016 0.027
idle23:43:23.387 99.3%308423 193.920 276.903 650.771
status file00:09:14.949 0.6%42384 7.104 13.093 22.760
TOTAL: 23:53:06.45923:52:43.416100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:17:43.180 98.3%25011 28.333 330.382600148.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:39.292 1.2%50544 0.000 1.964 414.450
readart00:00:06.803 0.1%20737 0.118 0.328 3.017
TOTAL: 02:20:08.40202:19:29.275 99.5%----

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 51065 17478 28638 4949 34%47:39:41
2newsfeed.neva.ru 149 77639 2030 66799 8810 2%71:00:11
3news.fcku.it 1 7290 1082 5954 254 14%24:11:09
4localhost 25 0 0 0 0 0%00:00:00
5nntp.pasdenom.info 2 0 0 0 0 0%00:20:02
TOTAL: 5 181 135994 20590 101391 14013 15%143:11:03
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net59.7 MB0.0 KB42.3 MB102.1 MB 58%4.7 KB
2newsfeed.neva.ru6.7 MB0.0 KB43.2 MB49.9 MB 13%4.7 KB
3news.fcku.it2.9 MB20.8 KB2.7 MB5.6 MB 52%4.3 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
5nntp.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 569.4 MB20.8 KB88.2 MB157.6 MB 44%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 2 00:00:01 - 00:59:59 858 4.1% 0.243.4 MB 4.9% 0.98
Jul 2 01:00:00 - 01:59:59 728 3.5% 0.202.3 MB 3.2% 0.64
Jul 2 02:00:00 - 02:59:59 656 3.1% 0.182.7 MB 3.9% 0.77
Jul 2 03:00:00 - 03:59:59 588 2.8% 0.162.3 MB 3.3% 0.65
Jul 2 04:00:00 - 04:59:59 506 2.4% 0.143.0 MB 4.3% 0.85
Jul 2 05:00:00 - 05:59:59 447 2.1% 0.121.6 MB 2.3% 0.45
Jul 2 06:00:00 - 06:59:59 687 3.3% 0.192.9 MB 4.1% 0.81
Jul 2 07:00:00 - 07:59:59 551 2.6% 0.152.7 MB 3.9% 0.76
Jul 2 08:00:00 - 08:59:59 614 2.9% 0.172.2 MB 3.2% 0.63
Jul 2 09:00:00 - 09:59:59 726 3.5% 0.202.4 MB 3.4% 0.67
Jul 2 10:00:00 - 10:59:59 885 4.2% 0.252.7 MB 3.9% 0.76
Jul 2 11:00:00 - 11:59:59 942 4.5% 0.263.0 MB 4.2% 0.84
Jul 2 12:00:00 - 12:59:59 985 4.7% 0.272.6 MB 3.7% 0.73
Jul 2 13:00:00 - 13:59:59 1032 5.0% 0.293.1 MB 4.4% 0.87
Jul 2 14:00:00 - 14:59:59 1027 4.9% 0.292.9 MB 4.2% 0.84
Jul 2 15:00:00 - 15:59:59 938 4.5% 0.262.7 MB 3.9% 0.77
Jul 2 16:00:00 - 16:59:59 1056 5.1% 0.293.2 MB 4.6% 0.92
Jul 2 17:00:00 - 17:59:59 1199 5.8% 0.333.7 MB 5.3% 1.04
Jul 2 18:00:00 - 18:59:59 1227 5.9% 0.345.4 MB 7.7% 1.52
Jul 2 19:00:00 - 19:59:59 1116 5.4% 0.313.3 MB 4.7% 0.93
Jul 2 20:00:00 - 20:59:59 1057 5.1% 0.293.5 MB 5.0% 0.99
Jul 2 21:00:00 - 21:59:59 916 4.4% 0.252.9 MB 4.2% 0.83
Jul 2 22:00:00 - 22:59:59 1000 4.8% 0.282.6 MB 3.7% 0.74
Jul 2 23:00:00 - 23:59:59 1082 5.2% 0.302.8 MB 4.0% 0.79
Jul 3 00:00:00 - 00:00:03 22 0.1% 7.3390.0 KB 0.1% 30.01
TOTAL: 24:00:02 20845 100.0% 0.2469.7 MB 100.0% 0.83
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 8578 542 0 0 0 0 0 0 8036
2linuxd-out.news.weretis.net 5252 985 0 0 0 0 0 0 4267
3news.fcku.it 256 2 0 3 0 0 0 0 251
TOTAL: 3 14086 1529 0 3 0 0 0 012554

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 210
mailing.freebsd.pkg-fallout 145
ut.test 94
lada.talk 50
mailing.freebsd.ports-bugs 48
it-alt.sport.calcio.juventus 47
mailing.freebsd.svn-ports-all 43
mailing.freebsd.svn-ports-head 42
alt.windows7.general 34
gmane.comp.gis.openstreetmap.tagging 34
fa.freebsd.bugs 30
mailing.freebsd.bugs 30
lada.photo 23
it.comp.os.win.windows10 23
lada.auto 22
mozilla.support.thunderbird 22
mailing.openssl.cvs 18
spline.eisfair 16
mozilla.general 16
mailing.gcc.gcc-cvs 16
TOTAL: 189 1529

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 9177
EMP (phn path) 1792
EMP (phl) 657
User-issued cancel 303
EMP (phn nph) 201
Too many newsgroups 52
Binary Payload 20
Binary: non-binary distribution 4
Binary: misplaced par2 4
HTML post 3
User-issued spam cancel 2
Too many newsgroups (meow) 1
Binary: misplaced cmd 1
Binary: misplaced srr 1
Binary: misplaced nfo 1
Binary: misplaced sfv 1
Binary Image: misplaced jpg 1
MI5 Filter 1
U2 violation - invalid distribution 1
TOTAL: 19 12223

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 300
newsfeed.neva.ru 24
news.fcku.it 7
TOTAL: 3 331
TOTAL: 1 331

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 25366 1213 16518 1929 0 96 4%23:59:48
2nntp.pasdenom.info 37150 1071 18990 699 0 580 2%23:57:41
3weretis.net 3522 312 2881 0 0 24 8%23:59:14
4neva.ru 28814 146 18302 361 0 154 0%23:59:47
5news.stack.nl 2858 0 0 0 0 23612 0%23:59:48
6etla.org 0 0 0 0 0 20845 0%23:59:48
7eternal-september 0 0 0 0 0 17630 0%23:59:48
8news.netfront.net 2760 0 0 0 0 23523 0%23:59:48
9news.mixmin.net 0 0 0 0 0 0 0%00:10:00
10vc89.vc.panix.com 2838 0 0 0 0 23682 0%23:59:48
11news.killfile.org 2849 0 0 0 0 23693 0%23:59:48
12news.albasani.net 2860 0 0 0 0 22880 0%23:59:48
TOTAL: 12 109017 2742 56691 2989 0 156719 2%264:05:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info4.3 MB1.7 MB6.0 MB0.1 KB/s3.5 KB23:57:41
2news.fcku.it3.5 MB7.4 MB10.9 MB0.1 KB/s3.6 KB23:59:48
3neva.ru1003.1 KB1.2 MB2.2 MB0.0 KB/s4.4 KB23:59:47
4weretis.net592.4 KB0.0 KB592.4 KB0.0 KB/s1.9 KB23:59:14
5news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
6etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
7eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
8news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
9news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
10vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
11news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
12news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
TOTAL: 129.4 MB10.4 MB19.7 MB0.0 KB/s3.5 KB264:05:06
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca 125 16136.1 KB 14 0 000:46:41
TOTAL: 1 125 16136.1 KB 14 0 002:20:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 125 16136.1 KB 14 0 000:46:41
2unresolved 2 00.0 KB 0 0 000:18:01
3*.nielsenmedia.com 7 00.0 KB 0 0 001:14:56
4*.188.099.pools.vodafone-ip.de 137 00.0 KB 0 0 000:00:28
TOTAL: 4 271 16136.1 KB 14 0 002:20:07

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.404 0.040 0.00001:14:56
mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca 8.104 1.516 0.00000:46:41
71.98.160.36 0.052 0.008 0.00000:15:57
196.52.16.50 0.268 0.136 0.00000:02:04
dslb-188-099-106-132.188.099.pools.vodafone-ip.de 7.244 0.404 0.00000:00:28
TOTAL: 5 16.072 2.104 0.00002:20:07

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-188-099-106-132.188.099.pools.vodafone-ip.de 137
challenger.nielsenmedia.com 7
196.52.16.50 1
71.98.160.36 1
TOTAL: 4 146

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 2 1
TOTAL: 1 2 1

Newsgroup request counts (by category):

CategoryCountPct
1rec 8 50.0%
2alt 5 31.2%
3sci 2 12.5%
4uk 1 6.2%
TOTAL: 4 16100.0%

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

NewsgroupCount
1rec.arts.tv 5
2sci.physics 2
3rec.outdoors.rv-travel 1
4rec.boats 1
5rec.arts.tv.uk.coronation-st 1
6alt.obituaries 1
7alt.support.depression 1
8alt.conspiracy 1
9uk.legal 1
10alt.russian.z1 1
11alt.os.linux.ubuntu 1
TOTAL: 11 16