Daily Usenet report for paganini.linuxd.org

Jan 3 00:00:03 -- Jan 4 00:00:01

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Jan 3 01:09:05 paganini overchan[15755]: input line too long, skipping
Jan 3 01:42:11 paganini overchan[15755]: input line too long, skipping
Jan 3 02:00:55 paganini overchan[15755]: input line too long, skipping
Jan 3 02:13:36 paganini overchan[15755]: input line too long, skipping
Jan 3 02:44:18 paganini overchan[15755]: input line too long, skipping
Jan 3 03:22:55 paganini overchan[15755]: input line too long, skipping
Jan 3 10:54:02 paganini overchan[15755]: input line too long, skipping
Jan 3 15:27:44 paganini overchan[15755]: input line too long, skipping
Jan 3 16:40:31 paganini overchan[15755]: input line too long, skipping
Jan 3 16:42:56 paganini overchan[15755]: input line too long, skipping
Jan 3 20:44:38 paganini overchan[15755]: input line too long, skipping
Jan 3 21:03:39 paganini overchan[15755]: input line too long, skipping
Jan 3 21:13:10 paganini overchan[15755]: input line too long, skipping
Jan 3 21:35:55 paganini overchan[15755]: input line too long, skipping
Jan 3 23:43:25 paganini overchan[15755]: input line too long, skipping
Jan 4 00:00:01 paganini overchan[5047]: 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 101327 62.7%12.7 MB 53.2%
inn 36789 22.8%8.2 MB 34.4%
innd 15340 9.5%2.0 MB 8.6%
nnrpd 8154 5.0%922.1 KB 3.8%
nocem 50 0.0%8.3 KB 0.0%
overchan 17 0.0%3.0 KB 0.0%
TOTAL: 6 161677 100.0%23.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 133840 56.4%
Negative hits 67306 28.3%
Do not exist 36161 15.2%
Cache misses 114 0.0%
TOTAL: 4 237421 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.450 0.0%170 0.000 2.647 23.000
article cleanup00:00:00.227 0.0%36214 0.000 0.006 0.026
article logging00:00:00.570 0.0%36677 0.000 0.016 0.844
article parse00:00:01.017 0.0%77641 0.000 0.013 0.036
article write00:00:48.254 0.1%21932 0.113 2.200 9.685
artlog/artcncl00:00:00.001 0.0%165 0.000 0.006 0.250
data move00:00:00.136 0.0%236979 0.000 0.001 0.003
hisgrep/artcncl00:00:00.006 0.0%169 0.000 0.036 1.000
hishave/artcncl00:00:00.001 0.0%170 0.000 0.006 0.056
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.557 0.0%238692 0.009 0.053 0.483
history sync00:00:00.025 0.0%402 0.000 0.062 0.667
history write00:00:28.719 0.0%36214 0.000 0.793 9.359
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:11.660 99.7%236749 157.348 364.232 1470.397
nntp read00:00:01.834 0.0%244729 0.003 0.007 0.016
overview write00:00:23.898 0.0%21932 0.021 1.090 5.967
perl filter00:01:16.100 0.1%36214 1.112 2.101 4.625
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.344 0.0%66007 0.000 0.020 0.067
TOTAL: 24:01:07.61724:00:26.799100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.091 0.0%36737 0.000 0.002 0.017
article prepare00:00:00.003 0.0%16620 0.000 0.000 0.010
article read00:00:03.173 0.0%3699 0.000 0.858 52.500
backlog stats00:00:00.206 0.0%350867 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.439 0.0%190493 0.002 0.008 0.017
data write00:00:02.914 0.0%168930 0.010 0.017 0.031
idle23:43:44.050 99.3%350867 163.118 243.466 461.721
status file00:09:23.164 0.7%42349 7.346 13.298 33.474
TOTAL: 23:53:29.75023:53:15.040100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:44:18.773 99.4%15780 29.000 624.764470288.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.315 0.0%32237 0.000 0.010 0.125
readart00:00:06.381 0.1%6180 0.000 1.033 10.667
TOTAL: 02:45:15.52202:44:25.469 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 5 47811 19599 25845 2367 40%48:06:38
2newsfeed.neva.ru 141 80724 1811 67608 11305 2%71:12:45
3news.fcku.it 1 4371 182 4058 131 4%14:54:30
4nntp.pasdenom.info 2 19167 36 18915 216 0%17:02:30
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 174 152073 21628 116426 14019 14%151:16:23
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net63.1 MB0.0 KB17.2 MB80.3 MB 78%3.7 KB
2newsfeed.neva.ru5.9 MB0.0 KB98.4 MB104.3 MB 5%8.1 KB
3news.fcku.it1.4 MB0.0 KB3.9 MB5.3 MB 26%17.4 KB
4nntp.pasdenom.info59.4 KB0.0 KB935.9 KB995.3 KB 5%3.9 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 570.5 MB0.0 KB120.4 MB190.9 MB 36%5.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 3 00:00:03 - 00:59:59 778 3.6% 0.222.3 MB 3.2% 0.65
Jan 3 01:00:00 - 01:59:59 622 2.8% 0.171.8 MB 2.5% 0.52
Jan 3 02:00:00 - 02:59:59 582 2.7% 0.162.0 MB 2.8% 0.57
Jan 3 03:00:00 - 03:59:59 436 2.0% 0.121.2 MB 1.7% 0.34
Jan 3 04:00:00 - 04:59:59 488 2.2% 0.142.2 MB 3.1% 0.62
Jan 3 05:00:00 - 05:59:59 468 2.1% 0.131.9 MB 2.6% 0.53
Jan 3 06:00:00 - 06:59:59 376 1.7% 0.101.8 MB 2.5% 0.52
Jan 3 07:00:00 - 07:59:59 460 2.1% 0.132.4 MB 3.4% 0.69
Jan 3 08:00:00 - 08:59:59 532 2.4% 0.151.9 MB 2.6% 0.53
Jan 3 09:00:00 - 09:59:59 774 3.5% 0.212.5 MB 3.5% 0.71
Jan 3 10:00:00 - 10:59:59 1102 5.0% 0.313.3 MB 4.6% 0.94
Jan 3 11:00:00 - 11:59:59 1060 4.8% 0.293.4 MB 4.7% 0.96
Jan 3 12:00:00 - 12:59:59 1010 4.6% 0.282.9 MB 4.1% 0.83
Jan 3 13:00:00 - 13:59:59 950 4.3% 0.262.5 MB 3.5% 0.72
Jan 3 14:00:00 - 14:59:59 1048 4.8% 0.293.0 MB 4.2% 0.86
Jan 3 15:00:00 - 15:59:59 1047 4.8% 0.292.9 MB 4.1% 0.83
Jan 3 16:00:00 - 16:59:59 1254 5.7% 0.354.1 MB 5.7% 1.16
Jan 3 17:00:00 - 17:59:59 1349 6.2% 0.374.1 MB 5.7% 1.17
Jan 3 18:00:00 - 18:59:59 1287 5.9% 0.364.2 MB 5.9% 1.20
Jan 3 19:00:00 - 19:59:59 1402 6.4% 0.395.5 MB 7.7% 1.56
Jan 3 20:00:00 - 20:59:59 1329 6.1% 0.374.4 MB 6.1% 1.24
Jan 3 21:00:00 - 21:59:59 1260 5.8% 0.353.8 MB 5.3% 1.08
Jan 3 22:00:00 - 22:59:59 1224 5.6% 0.344.3 MB 6.1% 1.23
Jan 3 23:00:00 - 00:00:01 1056 4.8% 0.293.1 MB 4.3% 0.87
TOTAL: 23:59:58 21894 100.0% 0.2571.5 MB 100.0% 0.85
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 11390 335 0 0 0 0 0 011055
2linuxd-out.news.weretis.net 2813 601 0 0 0 0 0 0 2212
3nntp.pasdenom.info 377 2 0 0 0 0 0 0 375
4news.fcku.it 150 1 0 0 0 0 0 0 149
TOTAL: 4 14730 939 0 0 0 0 0 013791

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 88
lada.auto 73
mpc.lists.freebsd.ports.bugs 67
it.annunci.immobiliari 59
lada.talk 58
it.annunci.commerciali 57
it.annunci.varie 57
gmane.linux.alsa.devel 48
alt.survival 41
it-alt.sport.calcio.juventus 36
it.comp.os.win.windows10 23
mozilla.test 15
it-alt.comp.software.openoffice 14
alt.windows7.general 14
mpc.lists.freebsd.x11 12
mozilla.dev.platform 10
lada.soft 10
alt.2600 9
alt.politics.scorched-earth 9
uk.radio.amateur.moderated 9
TOTAL: 120 939

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 11621
EMP (phn path) 1110
EMP (phl) 485
Too many newsgroups 31
Binary Payload 28
EMP (phn nph) 24
User-issued cancel 15
Binary Image: misplaced jpg 8
Binary: non-binary distribution 7
HTML post 1
TOTAL: 10 13330

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 445
newsfeed.neva.ru 15
news.fcku.it 1
TOTAL: 3 461
TOTAL: 1 461

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 39677 1032 19683 1120 0 558 2%23:57:43
2news.fcku.it 30201 681 19782 1116 0 113 2%23:59:51
3weretis.net 2285 102 2107 0 0 4 4%23:57:33
4neva.ru 28346 36 19941 74 0 88 0%23:59:51
5eternal-september 24588 20 18707 0 0 55 0%23:59:51
6news.albasani.net 2866 0 0 0 0 23769 0%23:59:51
7vc89.vc.panix.com 2837 0 0 0 0 24730 0%23:59:51
8news.netfront.net 2754 0 0 0 0 24577 0%23:59:51
9news.mixmin.net 0 0 0 0 0 0 0%00:10:00
10etla.org 0 0 0 0 0 21894 0%23:59:51
11news.stack.nl 2859 0 0 0 0 24718 0%23:59:51
12news.killfile.org 2843 0 0 0 0 24736 0%23:59:51
TOTAL: 12 139256 1871 80220 2310 0 145242 1%264:03:55
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info5.2 MB1.9 MB7.2 MB0.1 KB/s3.4 KB23:57:43
2news.fcku.it2.2 MB4.7 MB6.9 MB0.1 KB/s3.9 KB23:59:51
3weretis.net151.0 KB0.0 KB151.0 KB0.0 KB/s1.5 KB23:57:33
4neva.ru135.8 KB234.2 KB369.9 KB0.0 KB/s3.4 KB23:59:51
5eternal-september91.9 KB0.0 KB91.9 KB0.0 KB/s4.6 KB23:59:51
6news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
7vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
8news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
9news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
10etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
11news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
12news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
TOTAL: 127.8 MB6.9 MB14.7 MB0.0 KB/s3.6 KB264:03:55
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-05-70-55-56-27.dsl.bell.ca 170 201631.2 KB 118 0 000:32:27
2challenger.nielsenmedia.com 12 612.8 KB 2 0 001:42:06
TOTAL: 2 182 207644.0 KB 120 0 002:45:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 170 201631.2 KB 118 0 000:32:27
2*.nielsenmedia.com 12 612.8 KB 2 0 001:42:06
3*.drr02.clwr.fl.frontiernet.net 3 00.0 KB 0 0 000:30:13
4*.094.216.pools.vodafone-ip.de 128 00.0 KB 0 0 000:00:26
TOTAL: 4 313 207644.0 KB 120 0 002:45:14

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.868 0.084 0.00001:42:06
mtrlpq2314w-lp140-05-70-55-56-27.dsl.bell.ca 14.540 1.672 0.00000:32:27
47-192-187-101.drr02.clwr.fl.frontiernet.net 0.204 0.016 0.00000:30:13
dslb-094-216-025-116.094.216.pools.vodafone-ip.de 6.712 0.608 0.00000:00:26
TOTAL: 4 22.324 2.380 0.00002:45:14

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-094-216-025-116.094.216.pools.vodafone-ip.de 128
47-192-187-101.drr02.clwr.fl.frontiernet.net 3
TOTAL: 2 131

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 3 0
47-192-187-101.drr02.clwr.fl.frontiernet.net 1 0
TOTAL: 2 4 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 73 35.3%
2uk 36 17.4%
3talk 35 16.9%
4comp 23 11.1%
5rec 15 7.2%
6soc 9 4.3%
7linux 5 2.4%
8fr 5 2.4%
9misc 3 1.4%
10sci 3 1.4%
TOTAL: 10 207100.0%

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

NewsgroupCount
1talk.politics.misc 25
2alt.christnet.christianlife 25
3alt.atheism 12
4uk.legal 12
5alt.fan.rush-limbaugh 11
6talk.politics.guns 9
7comp.lang.python 9
8uk.politics.misc 6
9alt.sports.football.pro.sd-chargers 6
10comp.lang.awk 6
11rec.arts.tv 6
12soc.culture.usa 5
13linux.kernel 5
14fr.soc.politique 5
15comp.lang.c 5
16uk.games.video.misc 4
17uk.d-i-y 4
18alt.happy.valley 4
19rec.boats 3
20soc.genealogy.britain 3
21misc.survivalism 3
22alt.home.repair 3
23sci.physics.relativity 3
24uk.tech.digital-tv 2
25alt.global-warming 2
26alt.usage.english 2
27alt.support.diabetes 2
28rec.sport.tennis 2
29uk.sci.weather 2
30rec.arts.tv.uk.coronation-st 2
31alt.comp.os.windows-10 2
32uk.media.radio.archers 2
33alt.os.linux 2
34alt.california 1
35alt.russian.z1 1
36uk.media.tv.misc 1
37talk.origins 1
38uk.people.silversurfers 1
39comp.lang.java.programmer 1
40rec.food.cooking 1
41uk.radio.amateur 1
42uk.rec.motorcycles 1
43comp.sys.raspberry-pi 1
44comp.lang.javascript 1
45soc.culture.quebec 1
46rec.arts.sf.written 1
TOTAL: 46 207