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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17967	47.7%	4.6 MB	62.7%
innd	15403	40.9%	2.0 MB	27.7%
innfeed	3491	9.3%	634.9 KB	8.4%
nnrpd	785	2.1%	84.4 KB	1.1%
nocem	26	0.1%	2.9 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	37673	100.0%	7.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	295999	54.6%
Negative hits	228172	42.1%
Do not exist	17289	3.2%
Cache misses	234	0.0%
TOTAL: 4	541694	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.021	0.0%	7	0.000	3.000	17.000
article cleanup	00:00:00.117	0.0%	16990	0.000	0.007	0.029
article logging	00:00:00.243	0.0%	17533	0.000	0.014	0.203
article parse	00:00:00.738	0.0%	50658	0.000	0.015	0.115
article write	00:00:07.308	0.0%	14454	0.178	0.506	22.580
artlog/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
artlog/artparse	00:00:00.008	0.0%	364	0.000	0.022	1.000
data move	00:00:00.166	0.0%	510719	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.000	0.0%	6	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hishave/artparse	00:00:00.000	0.0%	359	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:05.795	0.0%	543199	0.001	0.011	0.319
history sync	00:00:00.825	0.0%	362	0.000	2.279	19.500
history write	00:00:09.836	0.0%	16992	0.037	0.579	8.314
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.288	0.0%	351	0.000	0.821	14.000
idle	23:48:53.141	99.8%	516149	100.851	166.102	486.767
nntp read	00:00:02.012	0.0%	518247	0.002	0.004	0.008
overview write	00:00:45.325	0.1%	14454	0.087	3.136	339.980
perl filter	00:00:23.400	0.0%	16987	1.108	1.378	2.038
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.258	0.0%	28933	0.000	0.009	0.028
TOTAL: 23:51:03.051	23:50:29.481	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.034	0.0%	14559	0.000	0.002	0.028
article prepare	00:00:00.001	0.0%	8316	0.000	0.000	0.023
article read	00:00:00.178	0.0%	885	0.000	0.201	22.500
backlog stats	00:00:00.183	0.0%	335032	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.243	0.0%	263936	0.001	0.005	0.009
data write	00:00:01.456	0.0%	250922	0.002	0.006	0.012
idle	23:53:42.734	100.0%	335032	148.060	256.760	837.194
status file	00:00:00.196	0.0%	260	0.000	0.754	3.125
TOTAL: 23:53:51.659	23:53:46.025	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	36:03:46.387	99.8%	468	413.000	277406.810	600086.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.003	0.0%	1127	0.000	0.003	0.167
readart	00:00:00.336	0.0%	41	0.000	8.195	42.000
TOTAL: 36:08:28.837	36:03:46.726	99.8%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
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	newsfeeds.xmission.com	2	14319	3162	11120	37	22%	25:29:56
2	news-out.mixmin.net	3	15332	2359	12739	234	15%	24:12:38
3	csiph-out.news.xs4all.nl	497	16754	2307	13169	1278	13%	68:30:05
4	feeder.eternal-september.org	4	16156	1942	14151	63	12%	24:09:35
5	news-out.aioe.org	3	13687	1170	12456	61	8%	24:09:00
6	newsfeed.fu-berlin.de	10	14262	919	13253	90	6%	25:14:39
7	csiph-out.news.weretis.net	3	31538	746	30398	394	2%	52:47:35
8	csiph-out.feeder.erje.net	1438	72595	684	71738	173	0%	119:27:43
9	newsfeed.neva.ru	140	13096	452	12404	240	3%	71:32:46
10	csiph-out.feed.uzoreto.com	864	22329	292	21768	269	1%	71:11:53
11	news.fcku.it	9	1191	198	984	9	16%	21:16:02
12	news-out.neodome.net	2	15633	167	15445	21	1%	23:59:52
13	nntp.pasdenom.info	2	8718	129	8570	19	1%	23:58:49
14	news.swapon.de	8	1501	56	1444	1	3%	23:14:39
15	news.freedyn.net	2	17315	22	17271	22	0%	23:59:52
16	csiph-out.news.tnetconsulting.net	1	6324	15	6298	11	0%	13:16:19
17	news.bbs.nz	2	14612	10	14601	1	0%	23:59:35
18	news.samoylyk.net	1	13982	4	13975	3	0%	23:59:53
19	localhost	27	1	1	0	0	100%	00:00:04
20	xanadu-bbs.net	27	483	0	483	0	0%	20:35:16
TOTAL: 20		3045	309828	14635	292267	2926	4%	705:06:11

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	9.8 MB	1.8 KB	2.1 MB	11.9 MB	82%	3.8 KB
2	csiph-out.news.xs4all.nl	6.1 MB	0.0 KB	11.5 MB	17.6 MB	34%	5.0 KB
3	feeder.eternal-september.org	5.5 MB	0.0 KB	1015.4 KB	6.5 MB	84%	3.3 KB
4	news-out.mixmin.net	4.7 MB	1.8 KB	410.3 KB	5.1 MB	92%	2.0 KB
5	news-out.aioe.org	4.1 MB	0.0 KB	204.6 KB	4.3 MB	95%	3.5 KB
6	csiph-out.feeder.erje.net	3.5 MB	0.0 KB	3.4 MB	6.9 MB	50%	8.2 KB
7	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	361.1 KB	2.7 MB	86%	2.7 KB
8	csiph-out.news.weretis.net	2.0 MB	0.0 KB	2.2 MB	4.2 MB	46%	3.8 KB
9	newsfeed.neva.ru	1.3 MB	0.0 KB	576.0 KB	1.9 MB	69%	2.8 KB
10	csiph-out.feed.uzoreto.com	1.1 MB	0.0 KB	8.3 MB	9.5 MB	12%	17.3 KB
11	news-out.neodome.net	480.8 KB	0.0 KB	108.0 KB	588.9 KB	81%	3.1 KB
12	nntp.pasdenom.info	311.9 KB	0.0 KB	24.4 KB	336.3 KB	92%	2.3 KB
13	news.fcku.it	264.2 KB	0.0 KB	7.2 KB	271.4 KB	97%	1.3 KB
14	news.freedyn.net	150.8 KB	0.0 KB	451.8 KB	602.6 KB	25%	13.7 KB
15	news.swapon.de	132.6 KB	0.0 KB	80.3 KB	212.9 KB	62%	3.7 KB
16	csiph-out.news.tnetconsulting.net	44.7 KB	0.0 KB	82.7 KB	127.3 KB	35%	4.9 KB
17	news.samoylyk.net	12.7 KB	1.9 KB	123.6 KB	138.1 KB	9%	19.7 KB
18	news.bbs.nz	11.3 KB	1.5 KB	1.5 KB	14.3 KB	79%	1.3 KB
19	localhost	1.8 KB	0.0 KB	0.0 KB	1.8 KB	100%	1.8 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		41.8 MB	7.0 KB	30.9 MB	72.7 MB	57%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 26 04:15:00 - 04:59:59	237	1.6%	0.09	630.3 KB	1.5%	0.23
Sep 26 05:00:00 - 05:59:59	290	2.0%	0.08	854.4 KB	2.0%	0.24
Sep 26 06:00:00 - 06:59:59	497	3.4%	0.14	1.5 MB	3.5%	0.41
Sep 26 07:00:00 - 07:59:59	457	3.2%	0.13	1.3 MB	3.0%	0.36
Sep 26 08:00:00 - 08:59:59	601	4.1%	0.17	1.9 MB	4.7%	0.55
Sep 26 09:00:00 - 09:59:59	707	4.9%	0.20	2.0 MB	4.9%	0.58
Sep 26 10:00:00 - 10:59:59	823	5.7%	0.23	2.9 MB	7.0%	0.83
Sep 26 11:00:00 - 11:59:59	692	4.8%	0.19	1.8 MB	4.4%	0.51
Sep 26 12:00:00 - 12:59:59	720	5.0%	0.20	1.9 MB	4.5%	0.53
Sep 26 13:00:00 - 13:59:59	810	5.6%	0.23	2.5 MB	6.1%	0.72
Sep 26 14:00:00 - 14:59:59	701	4.8%	0.19	1.8 MB	4.4%	0.52
Sep 26 15:00:00 - 15:59:59	709	4.9%	0.20	1.7 MB	4.2%	0.49
Sep 26 16:00:00 - 16:59:59	864	6.0%	0.24	2.2 MB	5.2%	0.61
Sep 26 17:00:00 - 17:59:59	863	6.0%	0.24	2.2 MB	5.3%	0.63
Sep 26 18:00:00 - 18:59:59	786	5.4%	0.22	2.2 MB	5.2%	0.61
Sep 26 19:00:00 - 19:59:59	730	5.0%	0.20	1.9 MB	4.6%	0.54
Sep 26 20:00:00 - 20:59:59	727	5.0%	0.20	1.8 MB	4.3%	0.51
Sep 26 21:00:00 - 21:59:59	733	5.1%	0.20	2.2 MB	5.4%	0.63
Sep 26 22:00:00 - 22:59:59	534	3.7%	0.15	1.8 MB	4.3%	0.51
Sep 26 23:00:00 - 23:59:59	431	3.0%	0.12	1.3 MB	3.2%	0.37
Sep 27 00:00:00 - 00:59:59	362	2.5%	0.10	1.1 MB	2.7%	0.32
Sep 27 01:00:00 - 01:59:59	413	2.8%	0.11	1.4 MB	3.3%	0.39
Sep 27 02:00:00 - 02:59:59	375	2.6%	0.10	1.1 MB	2.6%	0.31
Sep 27 03:00:00 - 03:59:59	355	2.4%	0.10	1.3 MB	3.2%	0.37
Sep 27 04:00:00 - 04:15:00	81	0.6%	0.09	203.6 KB	0.5%	0.23
TOTAL: 24:00:00	14498	100.0%	0.17	41.4 MB	100.0%	0.49

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1313	54	0	1259
2	newsfeed.fu-berlin.de	481	9	0	472
3	csiph-out.news.weretis.net	374	31	0	343
4	news-out.mixmin.net	312	1	1	310
5	csiph-out.feed.uzoreto.com	270	10	0	260
6	newsfeed.neva.ru	244	23	0	221
7	csiph-out.feeder.erje.net	173	37	0	136
8	news-out.aioe.org	79	58	0	21
9	feeder.eternal-september.org	65	24	0	41
10	newsfeeds.xmission.com	31	1	1	29
11	news-out.neodome.net	23	1	0	22
12	news.freedyn.net	20	0	0	20
13	nntp.pasdenom.info	19	0	0	19
14	news.swapon.de	19	0	0	19
15	csiph-out.news.tnetconsulting.net	18	15	0	3
16	news.fcku.it	9	0	0	9
17	news.samoylyk.net	3	0	1	2
TOTAL: 17		3453	264	3	3186

Unwanted newsgroups [Top 20]:

Newsgroup	Count
scinet.stats	27
alt.bbs.synchronet	22
mozilla.support.thunderbird	20
lada.talk	16
it-alt.sport.calcio.juventus	13
alt.philosophy	11
cakewalk.audio	9
alt.job	8
alt.windows7.general	7
alt.politics.usa	6
oesterreich.tratsch	6
alt.binaries.multimedia.vintage.tv	5
argonet.cfc	5
alt.binaries.ebook	5
alt.binaries.documentaries	5
mozilla.general	4
mozilla.test	4
spline.eisfair	4
at.jobs	4
alt.math.undergrad	4
TOTAL: 72	264

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1398
EMP (phn path)	463
EMP (phl)	168
EMP (phn nph)	96
Too many newsgroups	85
0	47
Scoring filter	12
Binary: misplaced binary	6
Binary Payload	1
HTML Multipart	1
Too many newsgroups (meow)	1
TOTAL: 11	2278

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	65
	csiph-out.feed.uzoreto.com	5
	csiph-out.news.xs4all.nl	4
	TOTAL: 3	74
Huge articles
	csiph-out.news.xs4all.nl	135
	csiph-out.feed.uzoreto.com	105
	csiph-out.feeder.erje.net	59
	newsfeeds.xmission.com	29
	csiph-out.news.weretis.net	9
	news.freedyn.net	6
	feeder.eternal-september.org	5
	csiph-out.news.tnetconsulting.net	3
	newsfeed.fu-berlin.de	3
	news.samoylyk.net	2
	TOTAL: 13	359
Including strange strings
	newsfeed.fu-berlin.de	385
	news-out.mixmin.net	78
	csiph-out.news.xs4all.nl	35
	news.swapon.de	18
	news-out.aioe.org	14
	csiph-out.news.weretis.net	7
	csiph-out.feeder.erje.net	4
	feeder.eternal-september.org	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 9	544
No colon-space in header
	csiph-out.news.xs4all.nl	3
	TOTAL: 1	3
TOTAL: 4		980

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17354	564	13935	0	81	3%	23:59:56
2	fu-berlin.de	13326	480	12846	0	0	3%	23:59:56
3	news.samoylyk.net	14950	454	14032	8	0	3%	23:59:45
4	news.bbs.nz	27510	166	13814	21	0	0%	23:59:55
5	xmission	13586	44	10798	1	0	0%	23:59:56
6	neva.ru	13642	38	13294	59	0	0%	23:59:56
7	news.freedyn.net	14204	35	13839	0	0	0%	23:59:51
8	newsfeed.xs4all.nl	12741	27	12130	0	0	0%	23:59:51
9	usenet.pasdenom.info	14359	17	13874	0	7	0%	23:59:56
10	news.mixmin.net	11756	17	11421	0	0	0%	23:59:55
11	neodome.net	14700	15	14278	0	0	0%	23:59:56
12	eternal-september	12472	14	11956	8	0	0%	23:59:56
13	erje	13761	9	13642	44	0	0%	23:59:54
14	news.uzoreto.com	13835	5	13496	45	0	0%	23:59:10
15	tnet	15273	5	14016	1	0	0%	23:59:37
16	weretis.net	13416	4	13191	1	0	0%	23:59:56
17	aioe	10602	3	10135	1	0	0%	23:59:30
18	news.swapon.de	1646	1	1594	0	0	0%	23:34:54
19	news.fcku.it	918	0	918	0	0	0%	20:53:41
TOTAL: 19		250051	1898	223209	189	88	0%	452:25:31

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	xanadu-bbs	3.2 MB	0.0 KB	3.2 MB	5.8 KB	23:59:56
2	fu-berlin.de	3.0 MB	0.0 KB	3.0 MB	6.4 KB	23:59:56
3	news.samoylyk.net	3.0 MB	8.4 KB	3.0 MB	6.6 KB	23:59:45
4	news.bbs.nz	438.6 KB	82.6 KB	521.2 KB	2.8 KB	23:59:55
5	news.freedyn.net	351.6 KB	0.0 KB	351.6 KB	10.0 KB	23:59:51
6	xmission	88.6 KB	5.0 KB	93.6 KB	2.1 KB	23:59:56
7	neva.ru	86.8 KB	183.7 KB	270.5 KB	2.8 KB	23:59:56
8	newsfeed.xs4all.nl	48.5 KB	0.0 KB	48.5 KB	1.8 KB	23:59:51
9	eternal-september	37.4 KB	40.2 KB	77.6 KB	3.5 KB	23:59:56
10	usenet.pasdenom.info	30.5 KB	0.0 KB	30.5 KB	1.8 KB	23:59:56
11	news.mixmin.net	24.3 KB	0.0 KB	24.3 KB	1.4 KB	23:59:55
12	neodome.net	20.4 KB	0.0 KB	20.4 KB	1.4 KB	23:59:56
13	erje	16.7 KB	117.3 KB	134.0 KB	2.5 KB	23:59:54
14	tnet	9.3 KB	1.1 KB	10.5 KB	1.7 KB	23:59:37
15	news.uzoreto.com	8.0 KB	104.3 KB	112.3 KB	2.2 KB	23:59:10
16	weretis.net	7.1 KB	1.7 KB	8.9 KB	1.8 KB	23:59:56
17	aioe	6.2 KB	0.6 KB	6.7 KB	1.7 KB	23:59:30
18	news.swapon.de	1.8 KB	0.0 KB	1.8 KB	1.8 KB	23:34:54
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0	20:53:41
TOTAL: 19		10.3 MB	544.9 KB	10.9 MB	5.3 KB	452:25:31

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	34	14	33.5 KB	4	0	0	09:22:21
2	8.44.58.66	2	14	30.4 KB	1	0	0	00:00:24
3	096-042-018-108.res.spectrum.com	7	11	27.3 KB	5	1	1	01:34:45
4	ip72-222-200-117.ph.ph.cox.net	5	2	6.0 KB	2	0	0	01:30:40
TOTAL: 4		48	41	97.3 KB	12	1	1	36:08:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	34	14	33.5 KB	4	0	0	09:22:21
2	unresolved	73	14	30.4 KB	1	0	0	23:40:40
3	*.res.spectrum.com	7	11	27.3 KB	5	1	1	01:34:45
4	*.ph.ph.cox.net	5	2	6.0 KB	2	0	0	01:30:40
TOTAL: 4		119	41	97.3 KB	12	1	1	36:08:28

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.796	1.117	0.000	23:40:15
a131033.upc-a.chello.nl	2.462	0.432	0.000	09:22:21
096-042-018-108.res.spectrum.com	0.669	0.093	0.003	01:34:45
ip72-222-200-117.ph.ph.cox.net	0.315	0.049	0.000	01:30:40
8.44.58.66	0.183	0.016	0.000	00:00:24
TOTAL: 5	8.425	1.707	0.003	36:08:28

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	71
TOTAL: 1	71

NNRP client timeouts [Top 20]:

System	Conn	Peer
096-042-018-108.res.spectrum.com	4	1
ip72-222-200-117.ph.ph.cox.net	3	0
TOTAL: 2	7	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Sep 26 04:15:00 -- Sep 27 04:15:00