Daily Usenet report for csiph.com: Mar 30 04:15:04

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	2030731	96.9%	217.1 MB	95.2%
inn	39788	1.9%	8.0 MB	3.5%
innd	21315	1.0%	2.4 MB	1.1%
innfeed	3224	0.2%	547.9 KB	0.2%
nocem	133	0.0%	14.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	2095192	100.0%	228.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	400454	57.9%
Negative hits	251491	36.4%
Do not exist	38763	5.6%
Cache misses	546	0.1%
TOTAL: 4	691254	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.831	0.0%	357	0.000	2.328	20.000
article cleanup	00:00:00.202	0.0%	33024	0.000	0.006	0.024
article logging	00:00:04.426	0.0%	33605	0.000	0.132	1.161
article parse	00:00:57.328	0.1%	712025	0.003	0.081	0.266
article write	00:02:07.591	0.1%	22749	0.206	5.609	18.871
artlog/artcncl	00:00:00.069	0.0%	271	0.000	0.255	4.800
artlog/artparse	00:00:01.926	0.0%	5725	0.000	0.336	17.000
data move	00:00:00.852	0.0%	1267174	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.105	0.0%	355	0.000	0.296	4.500
hishave/artcncl	00:00:00.028	0.0%	357	0.000	0.078	1.571
hishave/artparse	00:00:00.027	0.0%	5723	0.000	0.005	0.028
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:28.689	0.2%	687814	0.001	0.216	1.182
history sync	00:00:04.838	0.0%	327	0.000	14.795	89.000
history write	00:03:44.873	0.3%	32988	0.104	6.817	34.426
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
hiswrite/artparse	00:00:46.042	0.1%	5723	0.000	8.045	40.500
idle	23:42:28.900	98.7%	1231405	3.955	69.310	449.917
nntp read	00:00:05.618	0.0%	1262626	0.002	0.004	0.012
overview write	00:05:46.306	0.4%	22749	0.198	15.223	147.643
perl filter	00:01:03.140	0.1%	32891	1.442	1.920	3.307
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.379	0.0%	45624	0.000	0.008	0.028
TOTAL: 24:00:44.079	23:59:42.170	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.059	0.0%	22692	0.000	0.003	0.017
article prepare	00:00:00.003	0.0%	28516	0.000	0.000	0.005
article read	00:00:01.108	0.0%	4683	0.000	0.237	5.037
backlog stats	00:00:00.244	0.0%	427084	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.136	0.0%	325594	0.002	0.007	0.011
data write	00:00:01.771	0.0%	310213	0.002	0.006	0.011
idle	23:54:04.296	100.0%	427084	115.335	201.469	632.272
status file	00:00:00.382	0.0%	287	0.000	1.331	42.000
TOTAL: 23:54:16.877	23:54:09.999	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.929	0.0%	1448	0.037	0.642	3.484
idle	115:54:25.017	99.8%	2819302	83.931	148.003	600122.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:30.877	0.0%	5639215	0.000	0.005	0.500
readart	00:04:24.989	0.1%	22500	0.000	11.777	112.000
TOTAL: 116:05:24.203	115:59:21.812	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	111584	6761	96654	8169	6%	95:03:20
2	csiph-out.news.weretis.net	3	47289	5130	41512	647	10%	48:19:46
3	feeder.eternal-september.org	27	34443	2586	27176	4681	7%	30:13:16
4	news-out.aioe.org	6	23347	2143	21156	48	9%	24:12:41
5	news-out.mixmin.net	2	24717	1656	22526	535	6%	24:08:54
6	newsfeed.neva.ru	155	46111	1307	44076	728	2%	71:14:18
7	newsfeed.fu-berlin.de	55	25336	1149	23732	455	4%	36:22:46
8	newsfeeds.xmission.com	3	20049	806	19219	24	4%	20:42:10
9	news.redatomik.org	1	21043	782	20253	8	3%	23:04:36
10	xanadu-bbs.net	3	1061	216	832	13	20%	23:23:30
11	news.freedyn.net	2	25759	90	25612	57	0%	23:59:43
12	nntp.pasdenom.info	2	21872	71	21794	7	0%	23:58:53
13	news.swapon.de	2	2047	66	1978	3	3%	23:24:24
14	news.fcku.it	2	9977	62	9844	71	0%	23:58:03
15	news.bbs.geek.nz	1	20867	11	20854	2	0%	23:59:47
16	localhost	45	8	8	0	0	100%	00:00:00
TOTAL: 16		1461	435510	22844	397218	15448	5%	516:06:07

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	20.9 MB	31.4 KB	21.3 MB	42.2 MB	49%	2.9 KB
2	csiph-out.news.weretis.net	16.0 MB	5.7 KB	6.9 MB	23.0 MB	69%	4.1 KB
3	feeder.eternal-september.org	6.8 MB	8.1 KB	867.5 MB	874.3 MB	0%	123.2 KB
4	news-out.mixmin.net	6.7 MB	1.7 KB	1.2 MB	7.9 MB	84%	3.7 KB
5	news-out.aioe.org	5.6 MB	0.0 KB	72.8 KB	5.7 MB	98%	2.6 KB
6	newsfeed.neva.ru	3.1 MB	50.1 KB	1.6 MB	4.8 MB	64%	2.4 KB
7	newsfeed.fu-berlin.de	2.7 MB	0.0 KB	1.1 MB	3.8 MB	70%	2.4 KB
8	news.redatomik.org	2.5 MB	0.0 KB	170.5 KB	2.7 MB	93%	3.4 KB
9	newsfeeds.xmission.com	2.5 MB	0.0 KB	1.6 MB	4.1 MB	61%	5.0 KB
10	xanadu-bbs.net	772.7 KB	0.0 KB	326.0 KB	1.1 MB	70%	4.8 KB
11	news.freedyn.net	348.5 KB	4.1 KB	395.3 KB	747.9 KB	46%	5.1 KB
12	nntp.pasdenom.info	230.3 KB	0.0 KB	14.4 KB	244.7 KB	94%	3.1 KB
13	news.swapon.de	181.0 KB	0.0 KB	601.2 KB	782.2 KB	23%	11.3 KB
14	news.fcku.it	118.2 KB	36.0 KB	221.9 KB	376.1 KB	31%	2.8 KB
15	news.bbs.geek.nz	16.7 KB	2.4 KB	3.9 KB	22.9 KB	72%	1.8 KB
16	localhost	10.7 KB	0.0 KB	0.0 KB	10.7 KB	100%	1.3 KB
TOTAL: 16		68.3 MB	139.3 KB	903.1 MB	971.5 MB	7%	26.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 30 04:15:04 - 04:59:59	431	1.9%	0.16	1.4 MB	2.1%	0.55
Mar 30 05:00:00 - 05:59:59	611	2.7%	0.17	2.9 MB	4.2%	0.82
Mar 30 06:00:00 - 06:59:59	750	3.3%	0.21	2.5 MB	3.6%	0.70
Mar 30 07:00:00 - 07:59:59	1212	5.3%	0.34	4.0 MB	5.9%	1.15
Mar 30 08:00:00 - 08:59:59	986	4.3%	0.27	2.7 MB	4.0%	0.77
Mar 30 09:00:00 - 09:59:59	922	4.1%	0.26	2.4 MB	3.5%	0.68
Mar 30 10:00:00 - 10:59:59	1006	4.4%	0.28	2.8 MB	4.1%	0.79
Mar 30 11:00:00 - 11:59:59	1065	4.7%	0.30	2.8 MB	4.1%	0.80
Mar 30 12:00:00 - 12:59:59	1192	5.2%	0.33	3.1 MB	4.6%	0.89
Mar 30 13:00:00 - 13:59:59	1195	5.3%	0.33	3.7 MB	5.4%	1.04
Mar 30 14:00:00 - 14:59:59	1208	5.3%	0.34	3.4 MB	5.0%	0.96
Mar 30 15:00:00 - 15:59:59	1334	5.9%	0.37	3.8 MB	5.6%	1.08
Mar 30 16:00:00 - 16:59:59	1203	5.3%	0.33	3.4 MB	5.0%	0.97
Mar 30 17:00:00 - 17:59:59	1428	6.3%	0.40	4.1 MB	5.9%	1.15
Mar 30 18:00:00 - 18:59:59	1231	5.4%	0.34	3.6 MB	5.3%	1.04
Mar 30 19:00:00 - 19:59:59	1193	5.2%	0.33	3.5 MB	5.1%	1.00
Mar 30 20:00:00 - 20:59:59	1105	4.9%	0.31	3.3 MB	4.9%	0.95
Mar 30 21:00:00 - 21:59:59	964	4.2%	0.27	2.9 MB	4.2%	0.82
Mar 30 22:00:00 - 22:59:59	847	3.7%	0.24	2.8 MB	4.1%	0.79
Mar 30 23:00:00 - 23:59:59	689	3.0%	0.19	2.0 MB	2.9%	0.57
Mar 31 00:00:00 - 00:59:59	550	2.4%	0.15	1.6 MB	2.3%	0.45
Mar 31 01:00:00 - 01:59:59	526	2.3%	0.15	1.7 MB	2.5%	0.49
Mar 31 02:00:00 - 02:59:59	491	2.2%	0.14	1.6 MB	2.4%	0.46
Mar 31 03:00:00 - 03:59:59	403	1.8%	0.11	1.5 MB	2.2%	0.42
Mar 31 04:00:00 - 04:15:03	194	0.9%	0.21	689.4 KB	1.0%	0.76
TOTAL: 23:59:59	22736	100.0%	0.26	68.2 MB	100.0%	0.81

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	7393	425	9	6959
2	feeder.eternal-september.org	6284	59	6	6219
3	newsfeed.fu-berlin.de	836	41	0	795
4	newsfeed.neva.ru	746	386	13	347
5	csiph-out.news.weretis.net	671	254	2	415
6	news-out.mixmin.net	593	10	2	581
7	news.fcku.it	73	0	1	72
8	news-out.aioe.org	64	37	2	25
9	news.freedyn.net	55	5	0	50
10	newsfeeds.xmission.com	35	3	1	31
11	news.redatomik.org	14	0	2	12
12	xanadu-bbs.net	13	0	0	13
13	news.swapon.de	11	0	0	11
14	nntp.pasdenom.info	6	2	0	4
15	news.bbs.geek.nz	2	1	0	1
TOTAL: 15		16796	1223	38	15535

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	251
ut.test	189
it-alt.sport.calcio.juventus	84
it.annunci.commerciali	35
lada.auto	34
it.annunci.immobiliari	34
mpc.lists.freebsd.ports.bugs	31
it.annunci.varie	29
spline.eisfair	25
mozilla.support.seamonkey	23
mpc.lists.freebsd.x11	20
alt.politics.scorched-earth	20
alt.computer.workshop	20
gmane.comp.gis.openstreetmap.tagging	17
gmane.linux.alsa.devel	17
alt.windows7.general	17
cakewalk.audio	16
lada.kitchen	15
mozilla.dev.mdc	14
mozilla.dev.security.policy	14
TOTAL: 159	1223

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	7515
EMP (phn path)	839
EMP (phn nph)	225
Too many newsgroups	68
Binary Payload	32
HTML Multipart	27
Scoring filter (10)	25
Scoring filter (8)	24
Scoring filter (12)	22
User-issued cancel	21
EMP (phl)	17
Too many newsgroups (low_xpost)	17
Scoring filter (14)	12
Scoring filter (9)	10
Binary Image: misplaced jpg	9
Scoring filter (11)	8
Scoring filter (13)	7
Scoring filter (16)	7
HTML post	7
Scoring filter (19)	7
TOTAL: 27	8911

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	122	0	125	125
TOTAL: 1	122	0	125	125

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	94
	TOTAL: 1	94
Huge articles
	feeder.eternal-september.org	5856
	csiph-out.news.weretis.net	57
	newsfeeds.xmission.com	20
	news-out.mixmin.net	6
	news.fcku.it	3
	xanadu-bbs.net	3
	news.swapon.de	2
	news.redatomik.org	2
	news.freedyn.net	2
	newsfeed.fu-berlin.de	2
	TOTAL: 10	5953
Including strange strings
	newsfeed.fu-berlin.de	408
	csiph-out.feeder.erje.net	50
	csiph-out.news.weretis.net	43
	news-out.mixmin.net	30
	news-out.aioe.org	14
	newsfeeds.xmission.com	8
	newsfeed.neva.ru	8
	news.swapon.de	8
	feeder.eternal-september.org	6
	news.redatomik.org	4
	TOTAL: 11	580
No colon-space in header
	csiph-out.feeder.erje.net	2
	TOTAL: 1	2
TOTAL: 4		6629

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	40708	2816	19290	65	0	6%	23:59:53
2	xanadu-bbs	24877	688	21828	2	0	2%	23:59:54
3	news.freedyn.net	23756	682	21959	4	0	2%	23:59:53
4	fu-berlin.de	21320	542	20778	0	0	2%	23:59:53
5	usenet.pasdenom.info	25604	419	20639	1607	13	1%	23:59:53
6	xmission	24169	122	21072	10	0	0%	23:59:54
7	news.redatomik.org	22586	40	21323	12	0	0%	23:59:54
8	aioe	20244	39	18761	2	0	0%	23:59:47
9	weretis.net	16725	18	16258	1	18	0%	23:59:54
10	eternal-september	21383	11	19140	0	0	0%	23:59:44
11	news.mixmin.net	21419	10	20059	0	0	0%	23:59:51
12	news.swapon.de	2299	6	2214	2	0	0%	23:59:22
13	neva.ru	22269	6	20509	20	0	0%	23:59:39
14	erje	15984	1	15834	44	0	0%	23:59:48
15	news.fcku.it	3148	1	2908	0	0	0%	23:01:55
16	au2pb	0	0	0	0	22182	0%	23:58:39
17	bwh	0	0	0	0	22180	0%	23:58:39
TOTAL: 17		306491	5401	262572	1769	44393	1%	406:56:32

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	6.9 MB	186.8 KB	7.1 MB	0.1 KB/s	2.5 KB	23:59:53
2	news.freedyn.net	4.8 MB	9.0 KB	4.8 MB	0.1 KB/s	7.2 KB	23:59:53
3	xanadu-bbs	4.7 MB	6.5 KB	4.7 MB	0.1 KB/s	7.0 KB	23:59:54
4	fu-berlin.de	4.4 MB	0.0 KB	4.4 MB	0.1 KB/s	8.3 KB	23:59:53
5	usenet.pasdenom.info	1.5 MB	6.3 MB	7.8 MB	0.1 KB/s	3.9 KB	23:59:53
6	xmission	305.9 KB	22.3 KB	328.3 KB	0.0 KB/s	2.5 KB	23:59:54
7	news.redatomik.org	95.9 KB	30.5 KB	126.4 KB	0.0 KB/s	2.4 KB	23:59:54
8	aioe	68.1 KB	4.3 KB	72.3 KB	0.0 KB/s	1.8 KB	23:59:47
9	weretis.net	41.7 KB	4.6 KB	46.2 KB	0.0 KB/s	2.4 KB	23:59:54
10	eternal-september	20.4 KB	0.0 KB	20.4 KB	0.0 KB/s	1.9 KB	23:59:44
11	news.mixmin.net	15.7 KB	0.0 KB	15.7 KB	0.0 KB/s	1.6 KB	23:59:51
12	neva.ru	9.8 KB	37.7 KB	47.5 KB	0.0 KB/s	1.8 KB	23:59:39
13	news.swapon.de	9.6 KB	1.9 KB	11.4 KB	0.0 KB/s	1.4 KB	23:59:22
14	news.fcku.it	1.3 KB	0.0 KB	1.3 KB	0.0 KB/s	1.3 KB	23:01:55
15	erje	1.0 KB	349.4 KB	350.3 KB	0.0 KB/s	7.8 KB	23:59:48
16	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:39
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:39
TOTAL: 17		22.9 MB	6.9 MB	29.8 MB	0.0 KB/s	4.3 KB	406:56:32

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp130-04-70-54-157-241.dsl.bell.ca	2748	206	931.1 KB	133	0	0	89:09:19
2	204-73-239-109.cust.centrio.cz	20	32	98.5 KB	9	1	0	03:16:44
3	dhcp-089-099-203-254.chello.nl	33	15	26.9 KB	6	0	0	07:55:07
4	68-185-181-64.dhcp.mdsn.wi.charter.com	35	10	15.6 KB	10	7	6	10:26:24
TOTAL: 4		2836	263	1.0 MB	158	8	6	116:04:56

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	2748	206	931.1 KB	133	0	0	89:09:19
2	*.cust.centrio.cz	20	32	98.5 KB	9	1	0	03:16:44
3	*.chello.nl	33	15	26.9 KB	6	0	0	07:55:07
4	*.dhcp.mdsn.wi.charter.com	35	10	15.6 KB	10	7	6	10:26:24
5	*.bbox.io	8	0	0.0 KB	0	0	0	03:03:30
6	*.137.22.98.dynamic.ip.windstream.net	1	0	0.0 KB	0	0	0	02:13:50
TOTAL: 6		2845	263	1.0 MB	158	8	6	116:04:56

NNRP auth users [Top 20]:

User	Conn
ctomczyk	8
ohlandl	6
TOTAL: 2	14

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mtrlpq2314w-lp130-04-70-54-157-241.dsl.bell.ca	358.162	137.088	0.000	89:09:19
68-185-181-64.dhcp.mdsn.wi.charter.com	3.238	0.728	0.024	10:26:24
dhcp-089-099-203-254.chello.nl	3.112	0.657	0.000	07:55:07
204-73-239-109.cust.centrio.cz	1.639	0.391	0.029	03:16:44
tempe0.bbox.io	0.769	0.156	0.000	03:03:30
h96.137.22.98.dynamic.ip.windstream.net	0.171	0.145	0.000	02:13:50
TOTAL: 6	367.091	139.165	0.053	116:04:56

Curious NNRP server explorers [Top 20]:

System	Conn
tempe0.bbox.io	8
h96.137.22.98.dynamic.ip.windstream.net	1
TOTAL: 2	9

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-185-181-64.dhcp.mdsn.wi.charter.com	10	0
tempe0.bbox.io	6	0
204-73-239-109.cust.centrio.cz	5	0
h96.137.22.98.dynamic.ip.windstream.net	2	0
TOTAL: 4	23	0

Newsgroup request counts (by category):

Category		Count	Pct
1	free	69	26.2%
2	alt	60	22.8%
3	comp	53	20.2%
4	rec	10	3.8%
5	fr	10	3.8%
6	talk	10	3.8%
7	uk	9	3.4%
8	francom	6	2.3%
9	soc	5	1.9%
10	aus	5	1.9%
11	can	5	1.9%
12	muc	5	1.9%
13	pl	4	1.5%
14	misc	4	1.5%
15	de	2	0.8%
16	linux	2	0.8%
17	sac	2	0.8%
18	relcom	1	0.4%
19	it	1	0.4%
TOTAL: 19		263	100.0%

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

Newsgroup		Count
1	free.at	67
2	comp.lang.javascript	28
3	comp.sys.ibm.ps2.hardware	25
4	alt.drugs	9
5	talk.politics.misc	9
6	francom.esoterisme	6
7	alt.drugs.hard	6
8	can.politics	5
9	pl.comp.lang.javascript	4
10	rec.arts.tv	4
11	uk.rec.drugs.cannabis	4
12	alt.usenet.kooks	4
13	fr.soc.politique	4
14	fr.usenet.forums.evolution	3
15	alt.christnet.christianlife	3
16	alt.fan.jai-maharaj	3
17	muc.lists.freebsd.current	3
18	rec.arts.drwho	3
19	aus.politics	3
20	alt.jobs.overseas	3
21	alt.atheism	2
22	misc.jobs.misc	2
23	uk.politics.misc	2
24	alt.politics.democrats.d	2
25	uk.radio.amateur	2
26	soc.culture.usa	2
27	free.willey	2
28	alt.religion.christian.adventist	2
29	alt.privacy	2
30	alt.checkmate	2
31	alt.drugs.chemistry	2
32	alt.comp.virus	2
33	soc.men	2
34	alt.law-enforcement	2
35	rec.music.artists.springsteen	2
36	alt.my.job.sucks	2
37	sac.politics	2
38	alt.society.liberalism	2
39	muc.lists.freebsd.bugs	2
40	uk.rec.cycling	1
41	alt.jobs.jobsearch	1
42	alt.politics.trump	1
43	alt.politics.republicans	1
44	alt.sports.basketball.nba.denver-nuggets	1
45	de.sci.informatik.misc	1
46	fr.comp.os.mac-os.x	1
47	alt.politics.british	1
48	fr.lettres.langue.francaise	1
49	aus.ads.jobs.resumes	1
50	rec.drugs.cannabis	1
51	alt.society.conservatism	1
52	linux.kernel	1
53	misc.immigration.usa	1
54	alt.politics.obama	1
55	linux.debian.devel.release	1
56	alt.history.british	1
57	de.alt.comp.sap-r3	1
58	talk.politics.guns	1
59	soc.culture.thai	1
60	misc.jobs.contract	1
61	fr.rec.loisirs-creatifs	1
62	relcom.talk	1
63	alt.politics.homosexuality	1
64	alt.music.misc	1
65	aus.sport.golf	1
66	alt.sex.stories	1
67	it.comp.hardware	1
68	alt.sex.masturbation.techniques	1
TOTAL: 68		263

Daily Usenet report for csiph.com

Mar 30 04:15:04 -- Mar 31 04:15:03