Daily Usenet report for csiph.com: Sep 2 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	71754	49.2%	13.5 MB	61.6%
innd	69593	47.7%	7.7 MB	35.0%
innfeed	3576	2.4%	635.1 KB	2.8%
nnrpd	1017	0.7%	112.9 KB	0.5%
nocem	39	0.0%	4.6 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	145980	100.0%	22.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	385407	49.0%
Negative hits	268744	34.1%
Do not exist	93942	11.9%
Cache misses	39115	5.0%
TOTAL: 4	787208	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:07.941	0.0%	317	0.000	25.050	56.800
article cleanup	00:00:00.110	0.0%	17934	0.000	0.006	0.032
article logging	00:00:00.362	0.0%	18304	0.000	0.020	0.314
article parse	00:01:15.560	0.1%	1259158	0.000	0.060	1.084
article write	00:00:25.730	0.0%	14956	0.129	1.720	27.367
artlog/artcncl	00:00:00.008	0.0%	317	0.000	0.025	0.027
artlog/artparse	00:00:00.593	0.0%	53162	0.000	0.011	1.000
data move	00:00:01.276	0.0%	1463801	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.473	0.0%	317	0.000	1.492	9.000
hishave/artcncl	00:00:00.211	0.0%	317	0.000	0.666	0.750
hishave/artparse	00:00:00.122	0.0%	53155	0.000	0.002	0.003
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:40.595	0.0%	736868	0.002	0.055	0.408
history sync	00:00:01.980	0.0%	343	0.000	5.773	21.667
history write	00:01:00.458	0.1%	17909	0.226	3.376	12.454
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:01:02.827	0.1%	52900	0.000	1.188	218.000
idle	23:54:30.067	99.6%	1648285	1.764	52.218	452.241
nntp read	00:00:06.408	0.0%	1676644	0.001	0.004	0.010
overview write	00:00:59.188	0.1%	14956	0.158	3.957	57.419
perl filter	00:00:25.392	0.0%	17901	1.007	1.418	2.265
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.274	0.0%	29951	0.000	0.009	0.032
TOTAL: 24:00:39.481	24:00:39.575	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.039	0.0%	15512	0.000	0.003	0.030
article prepare	00:00:00.004	0.0%	13920	0.000	0.000	0.250
article read	00:00:01.915	0.0%	1913	0.000	1.001	32.190
backlog stats	00:00:00.206	0.0%	358559	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.317	0.0%	277135	0.002	0.005	0.009
data write	00:00:01.460	0.0%	265727	0.001	0.005	0.015
idle	23:54:20.645	100.0%	358559	107.645	240.018	683.491
status file	00:00:00.484	0.0%	309	0.000	1.566	12.000
TOTAL: 23:54:33.688	23:54:26.070	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	49:09:09.431	99.8%	665	0.000	266089.370	600194.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.006	0.0%	1510	0.000	0.004	0.143
readart	00:00:00.314	0.0%	19	0.000	16.526	62.000
TOTAL: 49:14:00.162	49:09:09.751	99.8%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	136
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	156

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	14519	4000	10476	43	27%	24:08:03
2	news-out.mixmin.net	2	15760	2795	12622	343	17%	24:08:54
3	feeder.eternal-september.org	5	16688	2079	14505	104	12%	24:13:26
4	news-out.aioe.org	2	14658	1117	13473	68	7%	24:09:02
5	newsfeed.neva.ru	147	16748	1004	15290	454	5%	72:21:31
6	csiph-out.news.weretis.net	2	19543	826	18465	252	4%	32:50:50
7	csiph-out.news.xs4all.nl	861	16772	762	14864	1146	4%	71:25:56
8	newsfeed.fu-berlin.de	11	12493	737	11675	81	5%	21:50:16
9	csiph-out.feeder.erje.net	1325	166741	617	99132	66992	0%	111:09:03
10	news.fcku.it	9	1825	341	1478	6	18%	22:44:33
11	csiph-out.feed.uzoreto.com	864	23682	193	23115	374	0%	71:07:29
12	news-out.neodome.net	1	15956	108	15803	45	0%	23:59:52
13	news.freedyn.net	7	70632	78	52657	17897	0%	26:36:31
14	nntp.pasdenom.info	5	10244	47	10155	42	0%	23:55:52
15	news.swapon.de	9	1326	41	1284	1	3%	23:05:45
16	csiph-out.news.tnetconsulting.net	1	14946	36	14876	34	0%	23:59:55
17	news.bbs.nz	2	14580	15	14563	2	0%	23:59:31
18	news.samoylyk.net	2	14661	11	14649	1	0%	23:59:47
19	localhost	27	1	1	0	0	100%	00:00:04
20	xanadu-bbs.net	41	393	0	393	0	0%	20:29:09
TOTAL: 20		3326	462168	14808	359475	87885	3%	690:15:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.9 MB	0.0 KB	2.9 MB	14.7 MB	80%	3.7 KB
2	feeder.eternal-september.org	5.7 MB	5.2 KB	490.1 KB	6.2 MB	92%	2.9 KB
3	news-out.mixmin.net	5.7 MB	7.0 KB	714.7 KB	6.4 MB	88%	2.1 KB
4	news-out.aioe.org	3.8 MB	1.3 KB	262.5 KB	4.0 MB	93%	3.5 KB
5	csiph-out.feeder.erje.net	3.7 MB	84.5 KB	2.0 GB	2.0 GB	0%	31.3 KB
6	newsfeed.neva.ru	2.9 MB	3.5 KB	1.1 MB	4.0 MB	72%	2.8 KB
7	csiph-out.news.weretis.net	2.4 MB	15.6 KB	4.2 MB	6.6 MB	35%	6.3 KB
8	csiph-out.news.xs4all.nl	2.4 MB	4.2 KB	11.1 MB	13.4 MB	17%	7.2 KB
9	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	338.2 KB	2.3 MB	85%	2.9 KB
10	csiph-out.feed.uzoreto.com	795.5 KB	5.8 KB	9.4 MB	10.2 MB	7%	18.3 KB
11	news.fcku.it	538.2 KB	0.0 KB	99.7 KB	637.9 KB	84%	1.8 KB
12	news.freedyn.net	451.8 KB	3.8 KB	1.0 GB	1.0 GB	0%	59.8 KB
13	news-out.neodome.net	338.8 KB	6.2 KB	86.8 KB	431.8 KB	78%	2.8 KB
14	csiph-out.news.tnetconsulting.net	155.7 KB	2.8 KB	291.3 KB	449.8 KB	34%	6.4 KB
15	nntp.pasdenom.info	97.9 KB	0.0 KB	89.3 KB	187.1 KB	52%	2.1 KB
16	news.swapon.de	90.7 KB	1.4 KB	1.4 KB	93.6 KB	96%	2.2 KB
17	news.samoylyk.net	43.4 KB	4.1 KB	4.1 KB	51.5 KB	84%	4.3 KB
18	news.bbs.nz	33.8 KB	0.0 KB	3.5 KB	37.3 KB	90%	2.2 KB
19	localhost	1.3 KB	0.0 KB	0.0 KB	1.3 KB	100%	1.3 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		42.8 MB	145.5 KB	3.1 GB	3.1 GB	1%	31.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 2 04:15:00 - 04:59:59	512	3.4%	0.19	2.6 MB	6.0%	0.99
Sep 2 05:00:00 - 05:59:59	368	2.5%	0.10	1.3 MB	2.9%	0.36
Sep 2 06:00:00 - 06:59:59	482	3.2%	0.13	1.3 MB	2.9%	0.36
Sep 2 07:00:00 - 07:59:59	522	3.5%	0.14	1.4 MB	3.3%	0.41
Sep 2 08:00:00 - 08:59:59	587	3.9%	0.16	1.6 MB	3.7%	0.45
Sep 2 09:00:00 - 09:59:59	610	4.1%	0.17	1.4 MB	3.2%	0.40
Sep 2 10:00:00 - 10:59:59	733	4.9%	0.20	1.8 MB	4.0%	0.50
Sep 2 11:00:00 - 11:59:59	690	4.6%	0.19	1.9 MB	4.3%	0.53
Sep 2 12:00:00 - 12:59:59	665	4.4%	0.18	1.8 MB	4.0%	0.50
Sep 2 13:00:00 - 13:59:59	780	5.2%	0.22	2.0 MB	4.5%	0.56
Sep 2 14:00:00 - 14:59:59	885	5.9%	0.25	2.5 MB	5.7%	0.71
Sep 2 15:00:00 - 15:59:59	875	5.9%	0.24	2.7 MB	6.1%	0.76
Sep 2 16:00:00 - 16:59:59	923	6.2%	0.26	2.3 MB	5.2%	0.65
Sep 2 17:00:00 - 17:59:59	885	5.9%	0.25	2.5 MB	5.7%	0.70
Sep 2 18:00:00 - 18:59:59	734	4.9%	0.20	1.9 MB	4.4%	0.54
Sep 2 19:00:00 - 19:59:59	751	5.0%	0.21	2.2 MB	5.1%	0.63
Sep 2 20:00:00 - 20:59:59	725	4.9%	0.20	2.3 MB	5.3%	0.65
Sep 2 21:00:00 - 21:59:59	516	3.5%	0.14	1.5 MB	3.5%	0.43
Sep 2 22:00:00 - 22:59:59	581	3.9%	0.16	1.7 MB	3.9%	0.49
Sep 2 23:00:00 - 23:59:59	460	3.1%	0.13	1.4 MB	3.2%	0.39
Sep 3 00:00:00 - 00:59:59	428	2.9%	0.12	1.4 MB	3.2%	0.39
Sep 3 01:00:00 - 01:59:59	417	2.8%	0.12	1.2 MB	2.9%	0.35
Sep 3 02:00:00 - 02:59:59	414	2.8%	0.12	1.6 MB	3.7%	0.46
Sep 3 03:00:00 - 03:59:59	334	2.2%	0.09	1.0 MB	2.3%	0.29
Sep 3 04:00:00 - 04:15:00	68	0.5%	0.08	286.9 KB	0.6%	0.32
TOTAL: 24:00:00	14945	100.0%	0.17	43.3 MB	100.0%	0.51

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Other
1	csiph-out.feeder.erje.net	35209	61	1	12	35135
2	news.freedyn.net	17890	1	0	1	17888
3	csiph-out.news.xs4all.nl	1139	39	0	1	1099
4	newsfeed.neva.ru	455	44	0	1	410
5	newsfeed.fu-berlin.de	390	42	0	0	348
6	news-out.mixmin.net	379	6	0	4	369
7	csiph-out.feed.uzoreto.com	374	14	0	1	359
8	csiph-out.news.weretis.net	294	69	0	4	221
9	feeder.eternal-september.org	104	35	0	1	68
10	news-out.aioe.org	84	50	0	1	33
11	newsfeeds.xmission.com	47	6	0	0	41
12	news-out.neodome.net	43	1	0	4	38
13	nntp.pasdenom.info	42	0	0	0	42
14	csiph-out.news.tnetconsulting.net	32	25	0	0	7
15	news.fcku.it	6	0	0	0	6
16	news.swapon.de	2	0	0	1	1
17	news.bbs.nz	2	0	0	0	2
18	news.samoylyk.net	1	0	0	1	0
TOTAL: 18		56493	393	1	32	56067

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	42
scinet.stats	27
mozilla.support.thunderbird	20
alt.politics.usa	20
lada.auto	19
lada.talk	18
alt.job	16
at.jobs	13
alt.windows7.general	13
spline.eisfair	13
alt.binaries.pictures.purebeauty	12
spline.eisfair.dev	11
alt.politics	10
it-alt.sport.calcio.juventus	10
mozilla.support.seamonkey	9
alt.bbs.synchronet	9
oesterreich.tratsch	8
alt.philosophy	7
alt.survival	7
alt.binaries.ebooks	6
TOTAL: 78	393

Unwanted distributions [Top 20]:

Distribution	Count
local	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1784
EMP (phl)	251
EMP (phn path)	240
0	119
Too many newsgroups	58
EMP (phn nph)	39
HTML Multipart	35
Scoring filter	7
Binary: misplaced binary	6
TOTAL: 9	2539

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	67
	csiph-out.feed.uzoreto.com	7
	csiph-out.news.xs4all.nl	6
	TOTAL: 3	80
Huge articles
	csiph-out.feeder.erje.net	35054
	news.freedyn.net	17781
	csiph-out.news.xs4all.nl	116
	csiph-out.feed.uzoreto.com	114
	csiph-out.news.weretis.net	41
	newsfeeds.xmission.com	37
	news-out.mixmin.net	5
	feeder.eternal-september.org	4
	newsfeed.fu-berlin.de	3
	csiph-out.news.tnetconsulting.net	2
	TOTAL: 11	53158
Including strange strings
	newsfeed.fu-berlin.de	303
	news-out.mixmin.net	33
	news-out.aioe.org	17
	csiph-out.news.weretis.net	7
	newsfeeds.xmission.com	4
	csiph-out.news.xs4all.nl	2
	csiph-out.feeder.erje.net	1
	csiph-out.feed.uzoreto.com	1
	newsfeed.neva.ru	1
	news.swapon.de	1
	TOTAL: 10	370
No colon-space in header
	csiph-out.news.xs4all.nl	2
	csiph-out.feeder.erje.net	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	4
TOTAL: 4		53612

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18482	1326	13610	8	36	7%	23:59:54
2	news.bbs.nz	28419	481	14096	19	0	1%	23:59:54
3	fu-berlin.de	14012	340	13672	0	0	2%	23:59:31
4	news.samoylyk.net	15437	333	14598	3	0	2%	23:59:38
5	tnet	15970	216	14394	1	0	1%	23:59:54
6	eternal-september	13065	89	12278	12	0	0%	23:59:54
7	news.freedyn.net	15087	71	14662	1	0	0%	23:59:54
8	newsfeed.xs4all.nl	14583	37	14065	7	186	0%	23:59:54
9	xmission	12903	31	10509	5	0	0%	23:59:54
10	usenet.pasdenom.info	15270	25	14524	10	373	0%	23:59:54
11	neva.ru	13450	20	13190	157	0	0%	23:59:47
12	news.uzoreto.com	14674	15	14367	77	0	0%	23:59:54
13	erje	18211	14	14051	144	0	0%	23:59:54
14	neodome.net	15272	10	14775	0	0	0%	23:59:54
15	news.mixmin.net	11853	6	11529	0	0	0%	23:59:35
16	aioe	11394	4	10871	2	0	0%	23:59:54
17	weretis.net	13649	1	13519	0	0	0%	23:59:54
18	news.swapon.de	1298	1	1294	0	0	0%	23:38:14
19	news.fcku.it	1341	0	1339	0	0	0%	21:55:04
TOTAL: 19		264370	3020	231343	446	595	1%	453:30:31

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.2 MB	35.5 KB	5.3 MB	0.1 KB/s	4.1 KB	23:59:54
2	fu-berlin.de	2.7 MB	0.0 KB	2.7 MB	0.0 KB/s	8.2 KB	23:59:31
3	news.samoylyk.net	2.7 MB	4.4 KB	2.7 MB	0.0 KB/s	8.3 KB	23:59:38
4	news.bbs.nz	1.1 MB	91.8 KB	1.2 MB	0.0 KB/s	2.5 KB	23:59:54
5	news.freedyn.net	472.3 KB	39.8 KB	512.1 KB	0.0 KB/s	7.1 KB	23:59:54
6	tnet	449.0 KB	1.2 KB	450.2 KB	0.0 KB/s	2.1 KB	23:59:54
7	eternal-september	341.8 KB	95.7 KB	437.5 KB	0.0 KB/s	4.3 KB	23:59:54
8	newsfeed.xs4all.nl	109.3 KB	26.4 KB	135.7 KB	0.0 KB/s	3.1 KB	23:59:54
9	usenet.pasdenom.info	87.3 KB	74.2 KB	161.6 KB	0.0 KB/s	4.6 KB	23:59:54
10	xmission	63.8 KB	10.4 KB	74.2 KB	0.0 KB/s	2.1 KB	23:59:54
11	news.mixmin.net	47.8 KB	0.0 KB	47.8 KB	0.0 KB/s	8.0 KB	23:59:35
12	neva.ru	29.6 KB	380.8 KB	410.4 KB	0.0 KB/s	2.3 KB	23:59:47
13	erje	28.5 KB	564.4 KB	592.9 KB	0.0 KB/s	3.8 KB	23:59:54
14	news.uzoreto.com	22.7 KB	213.9 KB	236.6 KB	0.0 KB/s	2.6 KB	23:59:54
15	aioe	15.1 KB	3.4 KB	18.5 KB	0.0 KB/s	3.1 KB	23:59:54
16	neodome.net	15.0 KB	0.0 KB	15.0 KB	0.0 KB/s	1.5 KB	23:59:54
17	weretis.net	1.3 KB	0.0 KB	1.3 KB	0.0 KB/s	1.3 KB	23:59:54
18	news.swapon.de	1.3 KB	0.0 KB	1.3 KB	0.0 KB/s	1.3 KB	23:38:14
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:55:04
TOTAL: 19		13.4 MB	1.5 MB	15.0 MB	0.0 KB/s	4.4 KB	453:30:31

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	69	7	26.0 KB	6	0	0	16:17:46
2	096-042-018-019.res.spectrum.com	14	7	26.0 KB	5	1	1	04:21:09
3	8.44.58.66	3	5	14.0 KB	1	0	0	00:00:12
TOTAL: 3		86	19	66.0 KB	12	1	1	49:13:58

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	69	7	26.0 KB	6	0	0	16:17:46
2	*.res.spectrum.com	14	7	26.0 KB	5	1	1	04:21:09
3	unresolved	76	5	14.0 KB	1	0	0	24:00:37
4	*.ph.ph.cox.net	8	0	0.0 KB	0	0	0	04:34:24
5	*.us-west-2.compute.amazonaws.com	1	0	0.0 KB	0	0	0	00:00:00
TOTAL: 5		168	19	66.0 KB	12	1	1	49:13:58

NNRP auth users [Top 20]:

User	Conn
ohlandl	1
TOTAL: 1	1

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.761	1.471	0.000	24:00:14
a131033.upc-a.chello.nl	4.785	1.037	0.000	16:17:46
ip72-222-200-117.ph.ph.cox.net	0.806	0.195	0.000	04:34:24
096-042-018-019.res.spectrum.com	1.001	0.354	0.003	04:21:09
8.44.58.66	0.246	0.023	0.000	00:00:12
138.99.216.171	0.068	0.023	0.000	00:00:10
ec2-34-221-53-62.us-west-2.compute.amazonaws.com	0.058	0.016	0.000	00:00:00
TOTAL: 7	11.725	3.119	0.003	49:13:58

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
ip72-222-200-117.ph.ph.cox.net	8
138.99.216.171	1
ec2-34-221-53-62.us-west-2.compute.amazonaws.com	1
TOTAL: 4	82

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	6	0
096-042-018-019.res.spectrum.com	6	0
TOTAL: 2	12	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	19	100.0%
TOTAL: 1		19	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	19
TOTAL: 1		19

Daily Usenet report for csiph.com

Sep 2 04:15:00 -- Sep 3 04:15:00