Daily Usenet report for paganini.linuxd.org

Nov 23 00:00:06 -- Nov 24 00:00:05

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Nov 23 19:55:49 paganini overchan[22514]: input line too long, skipping
Nov 24 00:00:05 paganini overchan[28800]: 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
nnrpd 474188 76.9%52.6 MB 70.2%
innfeed 102410 16.6%12.7 MB 17.0%
inn 31501 5.1%8.2 MB 11.0%
innd 8094 1.3%1.4 MB 1.8%
nocem 51 0.0%8.5 KB 0.0%
overchan 3 0.0%0.3 KB 0.0%
controlchan 2 0.0%0.3 KB 0.0%
TOTAL: 7 616249 100.0%74.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 129206 59.4%
Negative hits 57451 26.4%
Do not exist 30856 14.2%
Cache misses 80 0.0%
TOTAL: 4 217593 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.007 0.0%142 0.000 7.092 120.500
article cleanup00:00:00.209 0.0%30880 0.000 0.007 0.048
article logging00:00:00.278 0.0%31360 0.000 0.009 0.256
article parse00:00:00.627 0.0%41801 0.000 0.015 0.033
article write00:00:53.720 0.1%24011 0.143 2.237 18.986
artlog/artcncl00:00:00.001 0.0%141 0.000 0.007 0.067
data move00:00:00.098 0.0%219947 0.000 0.000 0.002
hisgrep/artcncl00:00:00.042 0.0%141 0.000 0.298 39.000
hishave/artcncl00:00:00.001 0.0%142 0.000 0.007 0.056
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:13.617 0.0%218467 0.015 0.062 0.557
history sync00:00:00.038 0.0%302 0.000 0.126 11.500
history write00:00:32.563 0.0%30880 0.039 1.055 4.722
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:56:32.427 99.7%214978 162.345 400.936 1121.380
nntp read00:00:01.592 0.0%220968 0.003 0.007 0.019
overview write00:00:22.352 0.0%24011 0.013 0.931 5.062
perl filter00:00:53.892 0.1%30880 0.955 1.745 9.304
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.910 0.0%72530 0.000 0.026 0.262
TOTAL: 24:00:22.29123:59:34.374 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.085 0.0%40440 0.000 0.002 0.019
article prepare00:00:00.004 0.0%12212 0.000 0.000 0.010
article read00:00:02.324 0.0%2605 0.000 0.892 33.353
backlog stats00:00:00.228 0.0%357769 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.461 0.0%196354 0.001 0.007 0.018
data write00:00:02.536 0.0%172835 0.007 0.015 0.029
idle23:42:44.932 99.3%357769 104.453 238.603 457.921
status file00:09:43.344 0.7%42768 7.229 13.640 27.660
TOTAL: 23:52:58.69223:52:34.914100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle35:46:08.091 99.9%589738 27.333 218.348600153.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:11.146 0.0%1180005 0.000 0.009 2.078
readart00:00:15.928 0.0%30100 0.000 0.529 35.000
TOTAL: 35:47:48.29335:46:35.165 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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
tskirvin@killfile.org010001
TOTAL010001

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 7 50125 20084 28665 1376 40%48:13:29
2newsfeed.neva.ru 143 71751 3028 63657 5066 4%71:34:31
3news.fcku.it 2 13636 764 12587 285 5%31:01:33
4nntp.pasdenom.info 2 36001 143 35715 143 0%29:03:56
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 179 171513 24019 140624 6870 14%179:53:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net61.6 MB0.0 KB5.2 MB66.8 MB 92%3.2 KB
2newsfeed.neva.ru9.3 MB0.0 KB15.5 MB24.8 MB 37%3.1 KB
3news.fcku.it2.3 MB0.0 KB895.8 KB3.1 MB 72%3.1 KB
4nntp.pasdenom.info327.0 KB0.0 KB769.8 KB1.1 MB 29%3.8 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 573.5 MB0.0 KB22.3 MB95.8 MB 76%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 23 00:00:06 - 00:59:59 886 3.7% 0.252.6 MB 3.5% 0.74
Nov 23 01:00:00 - 01:59:59 730 3.0% 0.202.5 MB 3.4% 0.70
Nov 23 02:00:00 - 02:59:59 613 2.6% 0.172.6 MB 3.5% 0.73
Nov 23 03:00:00 - 03:59:59 536 2.2% 0.151.6 MB 2.2% 0.46
Nov 23 04:00:00 - 04:59:59 510 2.1% 0.142.6 MB 3.5% 0.73
Nov 23 05:00:00 - 05:59:59 542 2.3% 0.152.2 MB 3.0% 0.62
Nov 23 06:00:00 - 06:59:59 458 1.9% 0.131.5 MB 2.0% 0.42
Nov 23 07:00:00 - 07:59:59 466 1.9% 0.131.6 MB 2.1% 0.44
Nov 23 08:00:00 - 08:59:59 726 3.0% 0.202.1 MB 2.9% 0.60
Nov 23 09:00:00 - 09:59:59 929 3.9% 0.262.9 MB 3.9% 0.81
Nov 23 10:00:00 - 10:59:59 1126 4.7% 0.313.2 MB 4.3% 0.91
Nov 23 11:00:00 - 11:59:59 1228 5.1% 0.343.5 MB 4.7% 0.99
Nov 23 12:00:00 - 12:59:59 1132 4.7% 0.313.1 MB 4.3% 0.89
Nov 23 13:00:00 - 13:59:59 1251 5.2% 0.353.1 MB 4.3% 0.89
Nov 23 14:00:00 - 14:59:59 1130 4.7% 0.313.3 MB 4.5% 0.93
Nov 23 15:00:00 - 15:59:59 1016 4.2% 0.282.6 MB 3.6% 0.75
Nov 23 16:00:00 - 16:59:59 1173 4.9% 0.333.7 MB 5.0% 1.05
Nov 23 17:00:00 - 17:59:59 1207 5.0% 0.343.8 MB 5.2% 1.08
Nov 23 18:00:00 - 18:59:59 1729 7.2% 0.484.6 MB 6.2% 1.30
Nov 23 19:00:00 - 19:59:59 1484 6.2% 0.414.1 MB 5.6% 1.17
Nov 23 20:00:00 - 20:59:59 1333 5.6% 0.373.9 MB 5.3% 1.11
Nov 23 21:00:00 - 21:59:59 1290 5.4% 0.364.4 MB 6.0% 1.25
Nov 23 22:00:00 - 22:59:59 1240 5.2% 0.343.5 MB 4.8% 1.00
Nov 23 23:00:00 - 23:59:59 1259 5.2% 0.354.6 MB 6.3% 1.32
Nov 24 00:00:00 - 00:00:05 20 0.1% 4.0076.9 KB 0.1% 15.38
TOTAL: 23:59:59 24014 100.0% 0.2873.6 MB 100.0% 0.87
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 5131 340 0 0 0 0 0 0 4791
2linuxd-out.news.weretis.net 1826 450 0 0 0 0 0 0 1376
3news.fcku.it 273 0 0 0 0 0 0 0 273
4nntp.pasdenom.info 117 1 0 0 0 0 0 0 116
TOTAL: 4 7347 791 0 0 0 0 0 0 6556

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 121
lada.talk 88
it-alt.sport.calcio.juventus 78
lada.auto 66
gmane.comp.gis.openstreetmap.tagging 27
mozilla.support.firefox 23
alt.survival 21
alt.windows7.general 20
gmane.linux.alsa.devel 17
mpc.lists.freebsd.office 17
lada.commerce 15
mozilla.dev.security.policy 15
mozilla.general 11
test.post 10
cakewalk.audio 10
mozilla.tools.taskcluster 10
alt.social-security-disability 9
mozilla.test 9
spline.eisfair 9
hk.politics 8
TOTAL: 116 791

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4471
EMP (phn path) 784
EMP (phl) 472
EMP (phn nph) 174
Too many newsgroups 112
Binary Payload 23
User-issued cancel 13
HTML post 10
Binary: non-binary distribution 6
Too many newsgroups (low_xpost) 5
Too many newsgroups (meow) 4
Binary Image: misplaced jpg 2
Binary: misplaced par2 1
TOTAL: 13 6077

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 451
newsfeed.neva.ru 20
news.fcku.it 6
nntp.pasdenom.info 2
TOTAL: 4 479
TOTAL: 1 479

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 37938 1404 20160 35 0 3590 3%23:57:33
2news.fcku.it 30613 421 21969 844 0 647 1%23:59:43
3weretis.net 4238 154 3759 1 0 278 3%23:59:43
4neva.ru 30835 46 20787 140 0 135 0%23:59:43
5eternal-september 27806 22 20739 0 0 152 0%23:59:43
6news.mixmin.net 0 0 0 0 0 0 0%00:10:01
7etla.org 0 0 0 0 0 24014 0%23:59:43
8news.albasani.net 2861 0 0 0 0 26134 0%23:59:43
9vc89.vc.panix.com 2841 0 0 0 0 26854 0%23:59:43
10news.stack.nl 2860 0 0 0 0 26822 0%23:59:43
11news.netfront.net 2691 0 0 0 0 26647 0%23:59:43
12news.killfile.org 2849 0 0 0 0 26862 0%23:59:43
TOTAL: 12 145532 2047 87414 1020 0 162135 1%264:04:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info3.2 MB48.4 KB3.3 MB0.0 KB/s2.3 KB23:57:33
2news.fcku.it1.2 MB3.5 MB4.8 MB0.1 KB/s3.9 KB23:59:43
3weretis.net279.9 KB1.9 KB281.8 KB0.0 KB/s1.8 KB23:59:43
4neva.ru89.9 KB507.3 KB597.2 KB0.0 KB/s3.2 KB23:59:43
5eternal-september41.9 KB0.0 KB41.9 KB0.0 KB/s1.9 KB23:59:43
6news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:01
7etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
8news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
9vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
10news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
11news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
12news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:43
TOTAL: 124.9 MB4.1 MB9.0 MB0.0 KB/s3.0 KB264:04:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca 242 106637.2 KB 60 0 026:31:08
2challenger.nielsenmedia.com 31 815.9 KB 4 0 006:36:49
347-192-187-101.drr02.clwr.fl.frontiernet.net 7 48.6 KB 1 0 001:08:25
TOTAL: 3 280 118661.7 KB 65 0 035:47:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 242 106637.2 KB 60 0 026:31:08
2*.nielsenmedia.com 31 815.9 KB 4 0 006:36:49
3*.drr02.clwr.fl.frontiernet.net 7 48.6 KB 1 0 001:08:25
4unresolved 6 00.0 KB 0 0 001:31:05
5*.188.110.pools.vodafone-ip.de 88 00.0 KB 0 0 000:00:17
TOTAL: 5 374 118661.7 KB 65 0 035:47:46

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca 38.940 26.368 0.00026:31:08
challenger.nielsenmedia.com 2.376 0.196 0.00006:36:49
47.192.187.101 0.376 0.016 0.00001:30:46
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.524 0.036 0.00001:08:25
196.52.16.45 0.172 0.080 0.00000:00:18
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 4.696 0.304 0.00000:00:17
TOTAL: 6 47.084 27.000 0.00035:47:46

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 88
47.192.187.101 5
196.52.16.45 1
TOTAL: 3 94

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 12 1
47.192.187.101 3 0
mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca 2 2
47-192-187-101.drr02.clwr.fl.frontiernet.net 2 0
TOTAL: 4 19 3

Newsgroup request counts (by category):

CategoryCountPct
1free 31 26.3%
2uk 25 21.2%
3comp 16 13.6%
4rec 16 13.6%
5alt 10 8.5%
6de 7 5.9%
7it 5 4.2%
8nl 3 2.5%
9hr 3 2.5%
10us 1 0.8%
11bit 1 0.8%
TOTAL: 11 118100.0%

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

NewsgroupCount
1free.at 31
2comp.lang.awk 12
3uk.legal 7
4rec.boats 6
5rec.arts.tv 5
6uk.d-i-y 4
7uk.politics.misc 4
8de.comp.os.ms-windows.misc 3
9hr.rec.sport.padobranstvo 3
10comp.lang.python 3
11nl.politiek 3
12alt.california 2
13alt.support.diabetes 2
14uk.tech.digital-tv 2
15rec.aviation.soaring 2
16uk.rec.sheds 2
17it.politica 2
18it.discussioni.auto 2
19rec.autos.sport.f1 2
20alt.life.sucks 2
21uk.media.radio.archers 2
22alt.usage.english 2
23comp.os.vms 1
24bit.listserv.vse-l 1
25de.alt.fan.pluesch 1
26uk.rec.motorcycles 1
27rec.crafts.metalworking 1
28uk.radio.amateur 1
29us.politics 1
30uk.railway 1
31de.etc.bahn.misc 1
32de.sci.electronics 1
33de.comp.office-pakete.staroffice.misc 1
34alt.atheism 1
35alt.drugs 1
36uk.rec.cycling 1
37it.hobby.fai-da-te 1
TOTAL: 37 118