Daily Usenet report for csiph.com: Oct 3 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	107532	71.9%	11.5 MB	60.1%
inn	26267	17.6%	5.6 MB	29.0%
innd	12811	8.6%	1.6 MB	8.3%
innfeed	2852	1.9%	500.5 KB	2.6%
nocem	29	0.0%	3.3 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	149492	100.0%	19.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	325096	56.5%
Negative hits	224425	39.0%
Do not exist	25428	4.4%
Cache misses	309	0.1%
TOTAL: 4	575258	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.305	0.0%	60	0.000	5.083	38.000
article cleanup	00:00:00.210	0.0%	25326	0.000	0.008	0.030
article logging	00:00:00.424	0.0%	25869	0.000	0.016	0.042
article parse	00:00:00.912	0.0%	66278	0.000	0.014	0.040
article write	00:00:19.507	0.0%	19658	0.184	0.992	23.280
artlog/artcncl	00:00:00.001	0.0%	60	0.000	0.017	0.100
artlog/artparse	00:00:00.002	0.0%	337	0.000	0.006	0.250
data move	00:00:00.191	0.0%	542381	0.000	0.000	0.004
hisgrep/artcncl	00:00:00.006	0.0%	60	0.000	0.100	0.600
hishave/artcncl	00:00:00.006	0.0%	60	0.000	0.100	1.000
hishave/artparse	00:00:00.001	0.0%	337	0.000	0.003	0.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.933	0.0%	579937	0.003	0.009	0.035
history sync	00:00:00.462	0.0%	377	0.000	1.225	5.000
history write	00:00:10.178	0.0%	25319	0.160	0.402	2.357
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.110	0.0%	337	0.000	0.326	3.000
idle	23:58:19.941	99.8%	553102	77.000	156.029	641.664
nntp read	00:00:03.740	0.0%	551353	0.002	0.007	0.051
overview write	00:00:16.484	0.0%	19658	0.137	0.839	150.792
perl filter	00:00:47.783	0.1%	25319	1.402	1.887	9.298
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.317	0.0%	39345	0.000	0.008	0.032
TOTAL: 24:01:02.514	24:00:05.513	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.057	0.0%	19735	0.000	0.003	0.055
article prepare	00:00:00.000	0.0%	15784	0.000	0.000	0.000
article read	00:00:00.992	0.0%	1943	0.000	0.511	24.000
backlog stats	00:00:00.215	0.0%	376015	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.079	0.0%	283819	0.003	0.007	0.013
data write	00:00:01.747	0.0%	268828	0.003	0.006	0.012
idle	23:54:23.419	100.0%	376015	123.599	228.883	789.054
status file	00:00:00.191	0.0%	269	0.000	0.710	5.000
TOTAL: 23:54:36.675	23:54:28.700	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.774	0.0%	79450	0.000	0.035	0.333
idle	28:07:14.103	99.7%	202144	0.000	500.802	600142.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.135	0.0%	405524	0.000	0.005	1.900
readart	00:01:26.453	0.1%	14406	0.000	6.001	215.000
TOTAL: 28:12:50.634	28:08:45.465	99.8%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
mode	138
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	158

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	5	41004	4444	36175	385	10%	47:59:33
2	csiph-out.feeder.erje.net	1440	102569	4282	96017	2270	4%	118:42:10
3	feeder.eternal-september.org	5	23053	2725	19656	672	11%	25:17:53
4	news-out.aioe.org	4	19622	1954	17606	62	9%	24:09:26
5	newsfeed.neva.ru	151	25179	1327	21979	1873	5%	71:53:28
6	newsfeeds.xmission.com	3	19824	1307	18510	7	6%	26:39:30
7	newsfeed.fu-berlin.de	23	21471	1304	19853	314	6%	33:41:22
8	news-out.mixmin.net	2	20552	1010	19209	333	4%	23:59:36
9	news.redatomik.org	3	19593	979	18542	72	4%	24:08:48
10	news.fcku.it	1	3596	482	3100	14	13%	22:09:25
11	news.swapon.de	2	1582	72	1509	1	4%	20:45:02
12	news.freedyn.net	3	21228	24	21193	11	0%	24:08:03
13	nntp.pasdenom.info	2	18468	21	18426	21	0%	23:58:46
14	news.bbs.nz	2	18588	9	18579	0	0%	23:59:50
15	localhost	32	6	6	0	0	100%	00:00:01
16	xanadu-bbs.net	8	754	1	752	1	0%	20:13:15
TOTAL: 16		1686	357089	19947	331106	6036	5%	531:46:08

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	15.5 MB	27.3 KB	13.9 MB	29.4 MB	52%	4.6 KB
2	csiph-out.news.weretis.net	13.5 MB	0.0 KB	10.9 MB	24.4 MB	55%	5.2 KB
3	feeder.eternal-september.org	7.1 MB	0.0 KB	4.7 MB	11.9 MB	60%	3.6 KB
4	news-out.aioe.org	4.8 MB	2.7 KB	368.8 KB	5.1 MB	92%	2.6 KB
5	news-out.mixmin.net	3.7 MB	0.0 KB	1.0 MB	4.7 MB	77%	3.6 KB
6	newsfeeds.xmission.com	3.5 MB	0.0 KB	706.4 KB	4.2 MB	83%	3.3 KB
7	newsfeed.neva.ru	3.4 MB	1.2 KB	6.3 MB	9.7 MB	35%	3.1 KB
8	newsfeed.fu-berlin.de	3.1 MB	0.0 KB	752.9 KB	3.8 MB	80%	2.4 KB
9	news.redatomik.org	2.9 MB	7.8 KB	718.9 KB	3.6 MB	80%	3.5 KB
10	news.fcku.it	813.3 KB	0.0 KB	17.8 KB	831.1 KB	97%	1.7 KB
11	news.swapon.de	167.8 KB	0.0 KB	2.7 KB	170.6 KB	98%	2.3 KB
12	news.freedyn.net	86.6 KB	0.0 KB	244.4 KB	331.0 KB	26%	9.5 KB
13	nntp.pasdenom.info	40.8 KB	0.0 KB	40.4 KB	81.2 KB	50%	1.9 KB
14	news.bbs.nz	12.2 KB	0.0 KB	0.0 KB	12.2 KB	100%	1.4 KB
15	localhost	8.3 KB	0.0 KB	0.0 KB	8.3 KB	100%	1.4 KB
16	xanadu-bbs.net	4.0 KB	0.0 KB	2.8 KB	6.8 KB	58%	3.4 KB
TOTAL: 16		58.6 MB	39.0 KB	39.6 MB	98.2 MB	59%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 3 04:15:00 - 04:59:59	331	1.7%	0.12	1.5 MB	2.6%	0.58
Oct 3 05:00:00 - 05:59:59	522	2.7%	0.14	2.1 MB	3.6%	0.59
Oct 3 06:00:00 - 06:59:59	598	3.0%	0.17	2.4 MB	4.1%	0.68
Oct 3 07:00:00 - 07:59:59	703	3.6%	0.20	1.9 MB	3.3%	0.55
Oct 3 08:00:00 - 08:59:59	828	4.2%	0.23	2.1 MB	3.5%	0.58
Oct 3 09:00:00 - 09:59:59	849	4.3%	0.24	2.5 MB	4.2%	0.70
Oct 3 10:00:00 - 10:59:59	1115	5.7%	0.31	3.0 MB	5.2%	0.85
Oct 3 11:00:00 - 11:59:59	869	4.4%	0.24	2.2 MB	3.8%	0.62
Oct 3 12:00:00 - 12:59:59	891	4.5%	0.25	2.4 MB	4.2%	0.69
Oct 3 13:00:00 - 13:59:59	1140	5.8%	0.32	3.0 MB	5.2%	0.86
Oct 3 14:00:00 - 14:59:59	1155	5.9%	0.32	3.8 MB	6.5%	1.07
Oct 3 15:00:00 - 15:59:59	1289	6.6%	0.36	4.0 MB	6.9%	1.13
Oct 3 16:00:00 - 16:59:59	1166	5.9%	0.32	3.8 MB	6.6%	1.09
Oct 3 17:00:00 - 17:59:59	1115	5.7%	0.31	2.8 MB	4.9%	0.80
Oct 3 18:00:00 - 18:59:59	1094	5.6%	0.30	3.1 MB	5.3%	0.88
Oct 3 19:00:00 - 19:59:59	1115	5.7%	0.31	3.0 MB	5.2%	0.86
Oct 3 20:00:00 - 20:59:59	1017	5.2%	0.28	2.8 MB	4.8%	0.79
Oct 3 21:00:00 - 21:59:59	802	4.1%	0.22	2.2 MB	3.7%	0.61
Oct 3 22:00:00 - 22:59:59	777	4.0%	0.22	2.5 MB	4.3%	0.70
Oct 3 23:00:00 - 23:59:59	640	3.3%	0.18	1.9 MB	3.3%	0.55
Oct 4 00:00:00 - 00:59:59	467	2.4%	0.13	1.2 MB	2.2%	0.35
Oct 4 01:00:00 - 01:59:59	400	2.0%	0.11	1.2 MB	2.1%	0.34
Oct 4 02:00:00 - 02:59:59	378	1.9%	0.10	1.3 MB	2.3%	0.37
Oct 4 03:00:00 - 03:59:59	283	1.4%	0.08	966.2 KB	1.6%	0.27
Oct 4 04:00:00 - 04:15:00	98	0.5%	0.11	449.8 KB	0.8%	0.50
TOTAL: 24:00:00	19642	100.0%	0.23	58.0 MB	100.0%	0.69

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	2289	134	4	2151
2	newsfeed.neva.ru	1875	146	1	1728
3	newsfeed.fu-berlin.de	781	21	0	760
4	feeder.eternal-september.org	664	35	0	629
5	csiph-out.news.weretis.net	380	99	0	281
6	news-out.mixmin.net	354	0	0	354
7	news.redatomik.org	82	0	1	81
8	news-out.aioe.org	66	58	1	7
9	news.swapon.de	21	0	0	21
10	nntp.pasdenom.info	21	8	0	13
11	news.fcku.it	14	10	0	4
12	news.freedyn.net	11	0	0	11
13	newsfeeds.xmission.com	7	0	0	7
14	xanadu-bbs.net	1	0	0	1
TOTAL: 14		6566	511	7	6048

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.auto	67
lada.talk	55
it-alt.sport.calcio.juventus	40
mozilla.support.thunderbird	33
gmane.linux.alsa.devel	28
gmane.linux.kernel	21
alt.windows7.general	17
mozilla.support.firefox	17
alt.survival	16
gmane.comp.gis.openstreetmap.tagging	15
lada.commerce	11
mozilla.general	10
at.jobs	9
oesterreich.tratsch	9
alt.music.pink-floyd.publius	9
local.spam.fr	8
gmane.comp.gis.openstreetmap	7
mozilla.dev.platform	7
mozilla.dev.apps.thunderbird	6
alt.politics.usa	6
TOTAL: 89	511

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	4110
EMP (phn path)	706
Too many newsgroups	92
EMP (phl)	67
EMP (phn nph)	55
HTML Multipart	36
User-issued cancel	21
User-issued spam cancel	13
Binary Payload	12
Scoring filter (11)	9
Binary: misplaced par2	8
Scoring filter (8)	7
Scoring filter (10)	7
Scoring filter (16)	5
Binary Image: misplaced jpg	3
Scoring filter (12)	2
Binary: misplaced rar	2
Scoring filter (9)	2
Binary: misplaced 002	2
Binary: misplaced nfo	2
TOTAL: 23	5164

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.feeder.erje.net	159
	csiph-out.news.weretis.net	116
	feeder.eternal-september.org	34
	news.redatomik.org	9
	news-out.mixmin.net	9
	newsfeeds.xmission.com	7
	newsfeed.fu-berlin.de	2
	news.freedyn.net	2
	TOTAL: 8	338
Including strange strings
	newsfeed.fu-berlin.de	476
	news.swapon.de	20
	csiph-out.feeder.erje.net	20
	news.redatomik.org	12
	csiph-out.news.weretis.net	7
	news-out.mixmin.net	6
	news-out.aioe.org	2
	feeder.eternal-september.org	2
	newsfeed.neva.ru	1
	TOTAL: 9	546
TOTAL: 3		929

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	20749	664	18949	2	123	3%	23:59:55
2	xanadu-bbs	22065	605	19033	0	1	2%	23:59:32
3	fu-berlin.de	18280	501	17779	0	0	2%	23:59:55
4	news.bbs.nz	37172	324	18780	5	3	0%	23:59:15
5	erje	19586	160	14770	383	0	0%	23:59:43
6	usenet.pasdenom.info	21406	94	18523	1004	21	0%	23:59:55
7	aioe	17139	14	16284	0	0	0%	23:59:38
8	weretis.net	14820	12	14050	2	0	0%	23:59:52
9	xmission	20256	11	17782	0	3	0%	23:59:41
10	news.redatomik.org	18931	10	18112	0	8	0%	23:59:55
11	neva.ru	17574	9	17283	205	0	0%	23:59:49
12	news.mixmin.net	18313	8	17755	1	0	0%	23:59:25
13	eternal-september	17083	8	16242	0	0	0%	23:57:58
14	news.swapon.de	1770	6	1701	0	0	0%	23:54:20
15	news.fcku.it	2103	0	2082	0	0	0%	21:52:53
TOTAL: 15		267247	2426	229125	1602	159	0%	357:41:46

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	5.9 MB	2.6 KB	5.9 MB	0.1 KB/s	9.1 KB	23:59:55
2	xanadu-bbs	5.7 MB	0.0 KB	5.7 MB	0.1 KB/s	9.6 KB	23:59:32
3	fu-berlin.de	5.4 MB	0.0 KB	5.4 MB	0.1 KB/s	11.1 KB	23:59:55
4	news.bbs.nz	876.9 KB	14.4 KB	891.3 KB	0.0 KB/s	2.7 KB	23:59:15
5	erje	396.5 KB	1.1 MB	1.5 MB	0.0 KB/s	2.9 KB	23:59:43
6	usenet.pasdenom.info	290.3 KB	6.2 MB	6.5 MB	0.1 KB/s	6.0 KB	23:59:55
7	aioe	21.6 KB	0.0 KB	21.6 KB	0.0 KB/s	1.5 KB	23:59:38
8	xmission	21.2 KB	0.0 KB	21.2 KB	0.0 KB/s	1.9 KB	23:59:41
9	weretis.net	20.7 KB	3.9 KB	24.6 KB	0.0 KB/s	1.8 KB	23:59:52
10	neva.ru	16.9 KB	508.4 KB	525.2 KB	0.0 KB/s	2.5 KB	23:59:49
11	news.redatomik.org	16.7 KB	0.0 KB	16.7 KB	0.0 KB/s	1.7 KB	23:59:55
12	news.mixmin.net	12.9 KB	1.6 KB	14.5 KB	0.0 KB/s	1.6 KB	23:59:25
13	eternal-september	12.9 KB	0.0 KB	12.9 KB	0.0 KB/s	1.6 KB	23:57:58
14	news.swapon.de	8.4 KB	0.0 KB	8.4 KB	0.0 KB/s	1.4 KB	23:54:20
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:52:53
TOTAL: 15		18.6 MB	7.8 MB	26.5 MB	0.0 KB/s	6.7 KB	357:41:46

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp130-01-70-49-68-37.dsl.bell.ca	2800	374	1.2 MB	122	0	0	08:54:48
2	167-179-154-5.a7b39a.mel.nbn.aussiebb.net	48	77	257.7 KB	55	0	0	00:43:02
3	challenger.nielsenmedia.com	13	25	67.6 KB	11	0	0	02:10:02
4	71-82-167-111.dhcp.mdsn.wi.charter.com	29	8	11.7 KB	8	6	6	07:33:08
5	a131033.upc-a.chello.nl	22	5	5.6 KB	3	0	0	03:45:36
TOTAL: 5		2912	489	1.6 MB	199	6	6	28:12:18

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	2800	374	1.2 MB	122	0	0	08:54:48
2	*.a7b39a.mel.nbn.aussiebb.net	48	77	257.7 KB	55	0	0	00:43:02
3	*.nielsenmedia.com	13	25	67.6 KB	11	0	0	02:10:02
4	*.dhcp.mdsn.wi.charter.com	29	8	11.7 KB	8	6	6	07:33:08
5	*.upc-a.chello.nl	22	5	5.6 KB	3	0	0	03:45:36
6	*.us-west-1.compute.amazonaws.com	1	0	0.0 KB	0	0	0	00:00:00
7	*.143.22.98.dynamic.ip.windstream.net	1	0	0.0 KB	0	0	0	01:42:20
8	*.dhcp.chtrptr.net	8	0	0.0 KB	0	0	0	00:23:10
9	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:00
10	*.ph.ph.cox.net	5	0	0.0 KB	0	0	0	02:30:09
TOTAL: 10		2928	489	1.6 MB	199	6	6	28:12:18

NNRP auth users [Top 20]:

User	Conn
moussa	48
ohlandl	6
TOTAL: 2	54

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mtrlpq2314w-lp130-01-70-49-68-37.dsl.bell.ca	240.551	37.198	0.000	08:54:48
71-82-167-111.dhcp.mdsn.wi.charter.com	2.741	0.395	0.021	07:33:08
a131033.upc-a.chello.nl	1.770	0.250	0.000	03:45:36
ip72-222-200-117.ph.ph.cox.net	0.527	0.107	0.000	02:30:09
challenger.nielsenmedia.com	1.436	0.177	0.000	02:10:02
h128.143.22.98.dynamic.ip.windstream.net	1.662	4.653	0.000	01:42:20
167-179-154-5.a7b39a.mel.nbn.aussiebb.net	5.368	1.100	0.154	00:43:02
c-67-160-62-214.hsd1.wa.comcast.net	0.055	0.039	0.000	00:30:00
172-221-041-102.dhcp.chtrptr.net	0.637	0.524	0.000	00:23:10
ec2-54-153-67-15.us-west-1.compute.amazonaws.com	0.095	0.008	0.000	00:00:00
TOTAL: 10	254.842	44.451	0.175	28:12:18

Curious NNRP server explorers [Top 20]:

System	Conn
172-221-041-102.dhcp.chtrptr.net	8
ip72-222-200-117.ph.ph.cox.net	5
c-67-160-62-214.hsd1.wa.comcast.net	1
ec2-54-153-67-15.us-west-1.compute.amazonaws.com	1
h128.143.22.98.dynamic.ip.windstream.net	1
TOTAL: 5	16

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-82-167-111.dhcp.mdsn.wi.charter.com	6	0
ip72-222-200-117.ph.ph.cox.net	5	0
challenger.nielsenmedia.com	3	0
c-67-160-62-214.hsd1.wa.comcast.net	1	0
TOTAL: 4	15	0

Newsgroup request counts (by category):

Category		Count	Pct
1	perl	147	30.1%
2	comp	130	26.6%
3	linux	111	22.7%
4	alt	55	11.2%
5	uk	21	4.3%
6	misc	13	2.7%
7	free	8	1.6%
8	fr	4	0.8%
TOTAL: 8		489	100.0%

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

Newsgroup		Count
1	perl.cpan.uploads	140
2	linux.debian.bugs.dist	70
3	linux.debian.bugs.rc	28
4	comp.lang.awk	25
5	comp.mobile.android	24
6	comp.os.vms	23
7	alt.comp.os.windows-10	21
8	comp.sys.ibm.ps2.hardware	20
9	comp.arch	18
10	uk.legal.moderated	17
11	alt.comp.freeware	16
12	misc.phone.mobile.iphone	13
13	alt.os.linux.ubuntu	9
14	comp.sys.ibm.pc.games.action	9
15	free.virginmedia.discussion.general	8
16	alt.privacy.anon-server.stats	7
17	linux.gentoo.dev	6
18	perl.modules	4
19	comp.mobile.ipad	4
20	linux.gentoo.user	4
21	fr.rec.loisirs-creatifs	4
22	comp.sys.raspberry-pi	3
23	linux.debian.kernel	3
24	uk.rec.cycling.moderated	3
25	perl.perl5.porters	2
26	uk.radio.amateur.moderated	1
27	perl.perl5.changes	1
28	comp.os.cpm	1
29	comp.ai.neural-nets	1
30	alt.os.linux.mageia	1
31	comp.ai.philosophy	1
32	alt.satellite.gps.garmin	1
33	comp.sys.ibm.as400.misc	1
TOTAL: 33		489

Daily Usenet report for csiph.com

Oct 3 04:15:00 -- Oct 4 04:15:00