Daily Usenet report for csiph.com: Apr 10 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	25320	42.3%	5.6 MB	58.3%
nnrpd	21293	35.6%	2.2 MB	23.1%
innd	10221	17.1%	1.3 MB	13.3%
innfeed	2920	4.9%	509.8 KB	5.2%
nocem	49	0.1%	5.5 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	59804	100.0%	9.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	312562	58.4%
Negative hits	197990	37.0%
Do not exist	24494	4.6%
Cache misses	252	0.0%
TOTAL: 4	535298	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.449	0.0%	155	0.000	2.897	28.000
article cleanup	00:00:00.163	0.0%	24469	0.000	0.007	0.030
article logging	00:00:00.393	0.0%	24993	0.000	0.016	0.051
article parse	00:00:01.319	0.0%	63611	0.000	0.021	0.209
article write	00:00:11.438	0.0%	19789	0.214	0.578	5.595
artlog/artcncl	00:00:00.001	0.0%	126	0.000	0.008	0.056
artlog/artparse	00:00:00.006	0.0%	295	0.000	0.020	0.250
data move	00:00:00.146	0.0%	517075	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.091	0.0%	153	0.000	0.595	24.000
hishave/artcncl	00:00:00.031	0.0%	155	0.000	0.200	4.000
hishave/artparse	00:00:00.001	0.0%	294	0.000	0.003	0.050
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:34.577	0.0%	540644	0.003	0.064	0.518
history sync	00:00:01.179	0.0%	372	0.000	3.169	22.000
history write	00:00:47.411	0.1%	24455	0.251	1.939	9.817
hiswrite/artcncl	00:00:00.007	0.0%	2	3.500	3.500	3.500
hiswrite/artparse	00:00:00.574	0.0%	294	0.000	1.952	44.000
idle	23:51:09.614	99.3%	521479	89.283	164.666	609.093
nntp read	00:00:02.575	0.0%	523394	0.001	0.005	0.010
overview write	00:06:30.459	0.5%	19789	0.364	19.731	1681.610
perl filter	00:00:48.112	0.1%	24453	1.445	1.968	3.029
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.351	0.0%	39621	0.000	0.009	0.024
TOTAL: 24:00:56.119	24:00:08.897	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.043	0.0%	19780	0.000	0.002	0.020
article prepare	00:00:00.003	0.0%	15852	0.000	0.000	0.021
article read	00:00:00.363	0.0%	2106	0.000	0.172	1.935
backlog stats	00:00:00.213	0.0%	372671	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.775	0.0%	282459	0.002	0.006	0.011
data write	00:00:01.552	0.0%	268124	0.001	0.006	0.012
idle	23:53:58.805	100.0%	372671	117.182	230.871	683.043
status file	00:00:00.211	0.0%	277	0.000	0.762	2.000
TOTAL: 23:54:12.775	23:54:02.965	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	26:57:16.058	99.9%	61067	88.250	1589.010	600198.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.682	0.0%	123183	0.000	0.006	0.167
readart	00:00:41.642	0.0%	8787	0.000	4.739	58.000
TOTAL: 26:59:37.366	26:57:58.382	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	7	41567	6375	34692	500	15%	48:35:35
2	csiph-out.feeder.erje.net	1152	81093	2730	76906	1457	3%	95:02:40
3	feeder.eternal-september.org	6	21253	2435	18377	441	11%	22:41:37
4	news-out.aioe.org	2	20155	1895	18191	69	9%	23:59:50
5	newsfeeds.xmission.com	4	18984	1745	17235	4	9%	23:06:58
6	newsfeed.neva.ru	147	28706	1350	25687	1669	4%	71:20:00
7	news-out.mixmin.net	2	20956	1073	19489	394	5%	24:08:55
8	newsfeed.fu-berlin.de	24	19648	985	18453	210	5%	28:16:31
9	news.fcku.it	1	8853	734	7959	160	8%	23:59:54
10	news.redatomik.org	1	18878	341	18532	5	1%	24:24:22
11	news.swapon.de	7	1473	76	1394	3	5%	23:15:29
12	nntp.pasdenom.info	2	18899	27	18855	17	0%	23:59:03
13	news.freedyn.net	4	37050	23	36996	31	0%	36:38:25
14	news.bbs.geek.nz	2	27188	13	27174	1	0%	30:22:55
15	localhost	34	2	2	0	0	100%	00:00:00
16	xanadu-bbs.net	22	516	1	511	4	0%	22:08:12
TOTAL: 16		1417	365221	19805	340451	4965	5%	522:00:26

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	20.6 MB	0.0 KB	5.6 MB	26.2 MB	78%	3.9 KB
2	csiph-out.feeder.erje.net	12.7 MB	34.2 KB	11.9 MB	24.6 MB	51%	6.0 KB
3	feeder.eternal-september.org	6.3 MB	0.0 KB	3.3 MB	9.6 MB	65%	3.4 KB
4	newsfeeds.xmission.com	4.9 MB	0.0 KB	49.4 KB	5.0 MB	99%	2.9 KB
5	news-out.aioe.org	4.8 MB	0.0 KB	283.5 KB	5.1 MB	94%	2.6 KB
6	news-out.mixmin.net	3.6 MB	0.0 KB	789.6 KB	4.4 MB	82%	3.0 KB
7	newsfeed.neva.ru	3.4 MB	0.0 KB	4.0 MB	7.4 MB	45%	2.5 KB
8	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	334.6 KB	2.6 MB	87%	2.2 KB
9	news.fcku.it	1.6 MB	0.0 KB	711.8 KB	2.3 MB	69%	2.6 KB
10	news.redatomik.org	1.0 MB	0.0 KB	8.4 KB	1.0 MB	99%	3.0 KB
11	news.swapon.de	199.0 KB	0.0 KB	1.8 MB	2.0 MB	9%	25.5 KB
12	nntp.pasdenom.info	68.4 KB	0.0 KB	33.5 KB	101.9 KB	67%	2.3 KB
13	news.freedyn.net	49.1 KB	0.0 KB	251.0 KB	300.1 KB	16%	5.6 KB
14	news.bbs.geek.nz	30.5 KB	0.0 KB	1.7 KB	32.2 KB	94%	2.3 KB
15	localhost	4.5 KB	0.0 KB	0.0 KB	4.5 KB	100%	2.3 KB
16	xanadu-bbs.net	2.1 KB	0.0 KB	6.2 KB	8.3 KB	24%	1.7 KB
TOTAL: 16		61.5 MB	34.2 KB	29.0 MB	90.5 MB	67%	3.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 10 04:15:00 - 04:59:59	751	3.8%	0.28	3.5 MB	5.8%	1.33
Apr 10 05:00:00 - 05:59:59	766	3.9%	0.21	2.7 MB	4.5%	0.78
Apr 10 06:00:00 - 06:59:59	670	3.4%	0.19	2.2 MB	3.7%	0.64
Apr 10 07:00:00 - 07:59:59	797	4.0%	0.22	2.3 MB	3.8%	0.66
Apr 10 08:00:00 - 08:59:59	893	4.5%	0.25	3.4 MB	5.7%	0.98
Apr 10 09:00:00 - 09:59:59	851	4.3%	0.24	2.1 MB	3.4%	0.59
Apr 10 10:00:00 - 10:59:59	877	4.5%	0.24	2.5 MB	4.1%	0.71
Apr 10 11:00:00 - 11:59:59	859	4.4%	0.24	2.6 MB	4.3%	0.74
Apr 10 12:00:00 - 12:59:59	921	4.7%	0.26	2.7 MB	4.4%	0.77
Apr 10 13:00:00 - 13:59:59	888	4.5%	0.25	2.7 MB	4.4%	0.77
Apr 10 14:00:00 - 14:59:59	1036	5.3%	0.29	2.6 MB	4.3%	0.75
Apr 10 15:00:00 - 15:59:59	1429	7.3%	0.40	5.0 MB	8.2%	1.41
Apr 10 16:00:00 - 16:59:59	1188	6.0%	0.33	3.3 MB	5.4%	0.93
Apr 10 17:00:00 - 17:59:59	1026	5.2%	0.28	2.6 MB	4.3%	0.74
Apr 10 18:00:00 - 18:59:59	996	5.1%	0.28	2.6 MB	4.4%	0.75
Apr 10 19:00:00 - 19:59:59	947	4.8%	0.26	2.9 MB	4.8%	0.83
Apr 10 20:00:00 - 20:59:59	974	4.9%	0.27	3.1 MB	5.0%	0.87
Apr 10 21:00:00 - 21:59:59	862	4.4%	0.24	2.7 MB	4.4%	0.77
Apr 10 22:00:00 - 22:59:59	677	3.4%	0.19	2.1 MB	3.4%	0.59
Apr 10 23:00:00 - 23:59:59	530	2.7%	0.15	1.7 MB	2.8%	0.48
Apr 11 00:00:00 - 00:59:59	425	2.2%	0.12	1.3 MB	2.2%	0.37
Apr 11 01:00:00 - 01:59:59	420	2.1%	0.12	1.1 MB	1.9%	0.33
Apr 11 02:00:00 - 02:59:59	416	2.1%	0.12	1.4 MB	2.2%	0.39
Apr 11 03:00:00 - 03:59:59	366	1.9%	0.10	1.2 MB	2.0%	0.34
Apr 11 04:00:00 - 04:15:00	125	0.6%	0.14	339.2 KB	0.5%	0.38
TOTAL: 24:00:00	19690	100.0%	0.23	60.7 MB	100.0%	0.72

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	1670	271	0	1399
2	csiph-out.feeder.erje.net	1478	200	15	1263
3	newsfeed.fu-berlin.de	622	51	0	571
4	csiph-out.news.weretis.net	553	319	0	234
5	feeder.eternal-september.org	464	50	0	414
6	news-out.mixmin.net	393	6	0	387
7	news.fcku.it	158	2	0	156
8	news-out.aioe.org	73	57	0	16
9	news.swapon.de	27	0	0	27
10	news.freedyn.net	18	0	0	18
11	nntp.pasdenom.info	17	17	0	0
12	newsfeeds.xmission.com	17	0	0	17
13	news.redatomik.org	7	0	0	7
14	xanadu-bbs.net	4	0	0	4
15	news.bbs.geek.nz	3	3	0	0
TOTAL: 15		5504	976	15	4513

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	211
it-alt.sport.calcio.juventus	64
mozilla.dev.platform	47
alt.windows7.general	46
it.annunci.commerciali	41
it.annunci.immobiliari	41
it.annunci.varie	40
spline.eisfair	36
mpc.lists.freebsd.ports.bugs	31
lada.auto	31
gmane.comp.gis.openstreetmap.tagging	31
alt.survival	31
alt.bbs.synchronet	16
free.it.religioni.scientology	16
alt.computer.workshop	16
gmane.linux.alsa.devel	13
mpc.lists.freebsd.gnome	10
mozilla.support.seamonkey	10
eagle.support.eng	9
alt.politics.usa	9
TOTAL: 118	976

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3076
EMP (phn path)	204
EMP (phn nph)	123
EMP (phl)	97
Too many newsgroups	56
User-issued cancel	40
HTML Multipart	38
Binary Payload	14
Scoring filter (9)	13
Binary: misplaced par2	8
Scoring filter (10)	5
Scoring filter (13)	5
Scoring filter (8)	4
Binary: misplaced pdf	2
Too many newsgroups (meow)	1
Binary: misplaced 003	1
Scoring filter (12)	1
Scoring filter (11)	1
HTML post	1
Binary: misplaced rar	1
TOTAL: 21	3692

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	35	0	36	36
TOTAL: 1	35	8	36	36

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
Huge articles
	csiph-out.feeder.erje.net	172
	csiph-out.news.weretis.net	76
	feeder.eternal-september.org	36
	news.fcku.it	3
	news.swapon.de	3
	news-out.mixmin.net	2
	newsfeeds.xmission.com	1
	news.redatomik.org	1
	TOTAL: 8	294
Including strange strings
	newsfeed.fu-berlin.de	414
	csiph-out.news.weretis.net	37
	news.swapon.de	24
	csiph-out.feeder.erje.net	21
	newsfeeds.xmission.com	13
	news-out.mixmin.net	6
	news-out.aioe.org	5
	feeder.eternal-september.org	2
	newsfeed.neva.ru	1
	news.fcku.it	1
	TOTAL: 11	525
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 4		821

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	36928	757	18439	19	0	2%	23:59:53
2	news.freedyn.net	21474	689	18985	2	0	3%	23:59:53
3	xanadu-bbs	22222	569	19120	0	0	2%	23:59:53
4	fu-berlin.de	18543	474	18048	0	47	2%	23:59:53
5	usenet.pasdenom.info	21702	213	18435	1015	11	0%	23:59:53
6	aioe	16974	46	16209	0	0	0%	23:59:52
7	news.mixmin.net	18345	16	17972	0	0	0%	23:59:53
8	weretis.net	13563	12	12199	6	0	0%	23:59:25
9	neva.ru	18715	11	17637	73	0	0%	23:59:53
10	news.redatomik.org	19930	10	18872	25	0	0%	23:59:50
11	eternal-september	17513	9	16502	0	34	0%	23:59:53
12	erje	18224	6	16897	1	44	0%	23:59:53
13	news.swapon.de	1492	6	1478	0	0	0%	23:50:29
14	xmission	19486	5	17358	0	0	0%	23:59:53
15	news.fcku.it	1764	0	1732	0	0	0%	21:43:48
TOTAL: 15		266875	2823	229883	1141	136	1%	357:32:14

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	6.9 MB	45.7 KB	7.0 MB	0.1 KB/s	10.3 KB	23:59:53
2	xanadu-bbs	6.5 MB	0.0 KB	6.5 MB	0.1 KB/s	11.7 KB	23:59:53
3	fu-berlin.de	6.2 MB	0.0 KB	6.2 MB	0.1 KB/s	13.5 KB	23:59:53
4	news.bbs.geek.nz	2.4 MB	187.8 KB	2.6 MB	0.0 KB/s	3.4 KB	23:59:53
5	usenet.pasdenom.info	645.7 KB	7.2 MB	7.8 MB	0.1 KB/s	6.5 KB	23:59:53
6	aioe	148.6 KB	0.0 KB	148.6 KB	0.0 KB/s	3.2 KB	23:59:52
7	news.redatomik.org	69.8 KB	85.6 KB	155.4 KB	0.0 KB/s	4.4 KB	23:59:50
8	news.mixmin.net	54.1 KB	0.0 KB	54.1 KB	0.0 KB/s	3.4 KB	23:59:53
9	erje	31.0 KB	1.3 KB	32.3 KB	0.0 KB/s	4.6 KB	23:59:53
10	weretis.net	30.9 KB	27.6 KB	58.5 KB	0.0 KB/s	3.3 KB	23:59:25
11	eternal-september	27.7 KB	0.0 KB	27.7 KB	0.0 KB/s	3.1 KB	23:59:53
12	neva.ru	18.7 KB	187.2 KB	205.9 KB	0.0 KB/s	2.5 KB	23:59:53
13	xmission	18.2 KB	0.0 KB	18.2 KB	0.0 KB/s	3.6 KB	23:59:53
14	news.swapon.de	11.5 KB	0.0 KB	11.5 KB	0.0 KB/s	1.9 KB	23:50:29
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:43:48
TOTAL: 15		23.2 MB	7.7 MB	30.9 MB	0.0 KB/s	8.0 KB	357:32:14

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp130-05-70-55-70-56.dsl.bell.ca	950	364	1.3 MB	52	0	0	01:59:12
2	141.168.117.108	41	4	10.8 KB	4	0	0	00:32:36
3	194-73-239-109.cust.centrio.cz	5	4	7.5 KB	2	0	0	01:09:23
4	96-42-18-226.dhcp.mdsn.wi.charter.com	24	3	7.8 KB	3	2	2	05:14:21
5	a131033.upc-a.chello.nl	44	2	6.6 KB	2	0	0	13:07:52
TOTAL: 5		1064	377	1.4 MB	63	2	2	26:59:29

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	950	364	1.3 MB	52	0	0	01:59:12
2	unresolved	45	4	10.8 KB	4	0	0	00:32:53
3	*.cust.centrio.cz	5	4	7.5 KB	2	0	0	01:09:23
4	*.dhcp.mdsn.wi.charter.com	24	3	7.8 KB	3	2	2	05:14:21
5	*.upc-a.chello.nl	44	2	6.6 KB	2	0	0	13:07:52
6	*.ph.ph.cox.net	13	0	0.0 KB	0	0	0	04:25:39
7	*.nielsenmedia.com	1	0	0.0 KB	0	0	0	00:30:06
TOTAL: 7		1082	377	1.4 MB	63	2	2	26:59:29

NNRP auth users [Top 20]:

User	Conn
moussa	41
ctomczyk	5
ohlandl	2
TOTAL: 3	48

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	3.231	0.665	0.000	13:07:52
96-42-18-226.dhcp.mdsn.wi.charter.com	2.033	0.427	0.007	05:14:21
ip72-222-200-59.ph.ph.cox.net	1.170	0.294	0.000	04:25:39
mtrlpq2314w-lp130-05-70-55-70-56.dsl.bell.ca	87.428	14.733	0.000	01:59:12
194-73-239-109.cust.centrio.cz	0.355	0.092	0.017	01:09:23
141.168.117.108	4.551	0.966	0.156	00:32:36
challenger.nielsenmedia.com	0.086	0.016	0.000	00:30:06
192.241.199.17	0.056	0.008	0.000	00:00:09
94.166.87.9	0.154	0.049	0.000	00:00:06
TOTAL: 9	99.064	17.250	0.180	26:59:29

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-59.ph.ph.cox.net	13
94.166.87.9	3
challenger.nielsenmedia.com	1
192.241.199.17	1
TOTAL: 4	18

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-59.ph.ph.cox.net	7	0
96-42-18-226.dhcp.mdsn.wi.charter.com	5	0
194-73-239-109.cust.centrio.cz	2	0
challenger.nielsenmedia.com	1	0
TOTAL: 4	15	0

Newsgroup request counts (by category):

Category		Count	Pct
1	talk	324	85.9%
2	alt	17	4.5%
3	comp	10	2.7%
4	uk	9	2.4%
5	rec	6	1.6%
6	pl	4	1.1%
7	sci	3	0.8%
8	fr	2	0.5%
9	soc	2	0.5%
TOTAL: 9		377	100.0%

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

Newsgroup		Count
1	talk.politics.guns	324
2	comp.sys.ibm.ps2.hardware	9
3	alt.usage.english	6
4	pl.comp.www	4
5	alt.comp.os.windows-10	4
6	rec.boats	3
7	uk.legal.moderated	3
8	fr.rec.photo	2
9	alt.jobs.offered	2
10	sci.physics	2
11	uk.d-i-y	2
12	uk.rec.cycling.moderated	1
13	rec.arts.movies.current-films	1
14	alt.jobs.jobsearch	1
15	rec.arts.tv	1
16	alt.os.linux.mint	1
17	alt.home.repair	1
18	comp.mobile.android	1
19	rec.skiing.alpine	1
20	alt.atheism	1
21	sci.electronics.design	1
22	uk.legal	1
23	alt.jobs.overseas	1
24	uk.media.radio.archers	1
25	soc.genealogy.britain	1
26	soc.genealogy.jewish	1
27	uk.sci.weather	1
TOTAL: 27		377

Daily Usenet report for csiph.com

Apr 10 04:15:00 -- Apr 11 04:15:00