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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18079	45.5%	4.6 MB	61.6%
innd	17746	44.7%	2.2 MB	30.0%
innfeed	3392	8.5%	585.1 KB	7.7%
nnrpd	484	1.2%	54.7 KB	0.7%
nocem	18	0.0%	2.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39720	100.0%	7.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	256713	55.8%
Negative hits	185602	40.3%
Do not exist	17619	3.8%
Cache misses	300	0.1%
TOTAL: 4	460234	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.155	0.0%	50	0.000	3.100	40.000
article cleanup	00:00:00.095	0.0%	16891	0.000	0.006	0.031
article logging	00:00:00.381	0.0%	17237	0.000	0.022	0.687
article parse	00:00:01.407	0.0%	69343	0.000	0.020	0.098
article write	00:00:06.601	0.0%	13921	0.149	0.474	7.609
artlog/artcncl	00:00:00.001	0.0%	48	0.000	0.021	0.167
artlog/artparse	00:00:00.013	0.0%	745	0.000	0.017	1.000
data move	00:00:00.117	0.0%	448275	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.004	0.0%	48	0.000	0.083	1.000
hishave/artcncl	00:00:00.000	0.0%	50	0.000	0.000	0.000
hishave/artparse	00:00:00.002	0.0%	745	0.000	0.003	0.125
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:12.659	0.0%	459976	0.002	0.028	0.200
history sync	00:00:00.724	0.0%	381	0.000	1.900	5.500
history write	00:00:20.487	0.0%	16889	0.061	1.213	7.464
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
hiswrite/artparse	00:00:00.809	0.0%	745	0.000	1.086	18.500
idle	23:48:44.182	99.8%	456444	113.157	187.809	605.536
nntp read	00:00:01.789	0.0%	456046	0.001	0.004	0.011
overview write	00:00:36.967	0.0%	13921	0.103	2.655	156.050
perl filter	00:00:27.711	0.0%	16889	1.180	1.641	2.877
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.246	0.0%	27858	0.000	0.009	0.031
TOTAL: 23:51:03.607	23:50:34.350	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.041	0.0%	14214	0.000	0.003	0.038
article prepare	00:00:00.001	0.0%	13504	0.000	0.000	0.012
article read	00:00:00.218	0.0%	1199	0.000	0.182	16.000
backlog stats	00:00:00.146	0.0%	302383	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.045	0.0%	229370	0.000	0.005	0.011
data write	00:00:01.371	0.0%	217249	0.002	0.006	0.013
idle	23:54:36.021	100.0%	302383	161.156	284.659	890.208
status file	00:00:00.220	0.0%	283	0.000	0.777	2.000
TOTAL: 23:54:45.511	23:54:39.063	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	17:48:38.142	100.0%	358	329.333	179100.955	600114.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.009	0.0%	814	0.000	0.011	0.143
readart	00:00:00.471	0.0%	26	0.000	18.115	47.000
TOTAL: 17:48:50.856	17:48:38.622	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
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	13645	2233	11400	12	16%	25:17:09
2	news.freedyn.net	3	16835	2054	13852	929	12%	24:08:48
3	feeder.eternal-september.org	3	15214	1810	13304	100	11%	23:04:56
4	csiph-out.news.weretis.net	3	27918	1639	26154	125	5%	50:18:15
5	csiph-out.news.xs4all.nl	861	15890	1342	13537	1011	8%	71:27:21
6	news-out.aioe.org	1	13315	1316	11989	10	9%	23:59:58
7	csiph-out.feeder.erje.net	1440	67168	1126	65716	326	1%	118:42:51
8	newsfeed.fu-berlin.de	4	13357	792	12516	49	5%	24:29:43
9	news-out.mixmin.net	2	14502	727	13538	237	5%	23:59:51
10	newsfeed.neva.ru	146	15734	588	14573	573	3%	72:13:23
11	csiph-out.feed.uzoreto.com	864	22968	228	22439	301	0%	71:11:44
12	news.fcku.it	16	1400	117	1282	1	8%	22:45:24
13	nntp.pasdenom.info	4	8983	64	8914	5	0%	24:38:46
14	news.swapon.de	8	1248	20	1228	0	1%	22:49:23
15	localhost	37	8	8	0	0	100%	00:00:00
16	news.bbs.nz	1	14328	7	14321	0	0%	23:59:50
17	news.samoylyk.net	2	13353	5	13348	0	0%	23:59:35
18	xanadu-bbs.net	29	244	0	243	1	0%	15:07:55
TOTAL: 18		3427	276110	14076	258354	3680	5%	662:14:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	7.0 MB	0.0 KB	586.8 KB	7.5 MB	92%	3.4 KB
2	csiph-out.feeder.erje.net	6.7 MB	0.0 KB	9.5 MB	16.2 MB	41%	11.4 KB
3	news.freedyn.net	5.2 MB	3.9 KB	40.5 MB	45.8 MB	11%	15.7 KB
4	feeder.eternal-september.org	4.8 MB	0.0 KB	538.2 KB	5.4 MB	90%	2.9 KB
5	csiph-out.news.weretis.net	4.8 MB	9.0 KB	3.0 MB	7.8 MB	61%	4.5 KB
6	csiph-out.news.xs4all.nl	4.0 MB	0.0 KB	8.5 MB	12.5 MB	31%	5.5 KB
7	news-out.aioe.org	3.0 MB	0.0 KB	20.3 KB	3.1 MB	99%	2.4 KB
8	news-out.mixmin.net	2.3 MB	0.0 KB	432.7 KB	2.7 MB	84%	2.9 KB
9	newsfeed.fu-berlin.de	1.8 MB	0.0 KB	167.1 KB	2.0 MB	91%	2.4 KB
10	newsfeed.neva.ru	1.6 MB	0.0 KB	1.9 MB	3.6 MB	45%	3.1 KB
11	csiph-out.feed.uzoreto.com	1.1 MB	0.0 KB	6.1 MB	7.1 MB	14%	13.8 KB
12	news.fcku.it	247.0 KB	0.0 KB	0.8 KB	247.8 KB	99%	2.1 KB
13	nntp.pasdenom.info	135.3 KB	0.0 KB	7.4 KB	142.7 KB	94%	2.1 KB
14	news.swapon.de	49.4 KB	0.0 KB	0.0 KB	49.4 KB	100%	2.5 KB
15	news.samoylyk.net	15.9 KB	0.0 KB	0.0 KB	15.9 KB	100%	3.2 KB
16	news.bbs.nz	12.9 KB	0.0 KB	0.0 KB	12.9 KB	100%	1.8 KB
17	localhost	10.7 KB	0.0 KB	0.0 KB	10.7 KB	100%	1.3 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	36.0 KB	36.0 KB	0%	36.0 KB
TOTAL: 18		42.9 MB	12.9 KB	71.2 MB	114.1 MB	37%	6.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 28 04:15:00 - 04:59:59	191	1.4%	0.07	636.6 KB	1.5%	0.24
Sep 28 05:00:00 - 05:59:59	336	2.4%	0.09	1.3 MB	3.0%	0.37
Sep 28 06:00:00 - 06:59:59	443	3.2%	0.12	1.8 MB	4.2%	0.51
Sep 28 07:00:00 - 07:59:59	523	3.7%	0.15	1.5 MB	3.6%	0.44
Sep 28 08:00:00 - 08:59:59	603	4.3%	0.17	1.8 MB	4.2%	0.51
Sep 28 09:00:00 - 09:59:59	615	4.4%	0.17	1.7 MB	4.0%	0.49
Sep 28 10:00:00 - 10:59:59	669	4.8%	0.19	2.1 MB	5.0%	0.60
Sep 28 11:00:00 - 11:59:59	662	4.7%	0.18	2.0 MB	4.6%	0.56
Sep 28 12:00:00 - 12:59:59	688	4.9%	0.19	1.9 MB	4.4%	0.54
Sep 28 13:00:00 - 13:59:59	785	5.6%	0.22	2.2 MB	5.1%	0.62
Sep 28 14:00:00 - 14:59:59	795	5.7%	0.22	2.4 MB	5.7%	0.69
Sep 28 15:00:00 - 15:59:59	718	5.1%	0.20	2.3 MB	5.3%	0.65
Sep 28 16:00:00 - 16:59:59	787	5.6%	0.22	2.2 MB	5.3%	0.64
Sep 28 17:00:00 - 17:59:59	766	5.5%	0.21	2.1 MB	5.0%	0.60
Sep 28 18:00:00 - 18:59:59	839	6.0%	0.23	2.5 MB	6.0%	0.72
Sep 28 19:00:00 - 19:59:59	801	5.7%	0.22	2.5 MB	5.8%	0.70
Sep 28 20:00:00 - 20:59:59	734	5.3%	0.20	2.3 MB	5.5%	0.66
Sep 28 21:00:00 - 21:59:59	674	4.8%	0.19	1.8 MB	4.2%	0.51
Sep 28 22:00:00 - 22:59:59	470	3.4%	0.13	1.6 MB	3.8%	0.46
Sep 28 23:00:00 - 23:59:59	492	3.5%	0.14	1.5 MB	3.6%	0.44
Sep 29 00:00:00 - 00:59:59	350	2.5%	0.10	1007.5 KB	2.3%	0.28
Sep 29 01:00:00 - 01:59:59	359	2.6%	0.10	1.1 MB	2.6%	0.31
Sep 29 02:00:00 - 02:59:59	306	2.2%	0.09	1.3 MB	3.0%	0.37
Sep 29 03:00:00 - 03:59:59	292	2.1%	0.08	825.8 KB	1.9%	0.23
Sep 29 04:00:00 - 04:15:00	58	0.4%	0.06	184.6 KB	0.4%	0.21
TOTAL: 24:00:00	13956	100.0%	0.16	42.6 MB	100.0%	0.51

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1022	30	0	992
2	news.freedyn.net	995	11	1	983
3	newsfeed.neva.ru	566	32	0	534
4	newsfeed.fu-berlin.de	346	28	0	318
5	csiph-out.feeder.erje.net	330	59	0	271
6	csiph-out.feed.uzoreto.com	303	10	0	293
7	news-out.mixmin.net	242	0	0	242
8	csiph-out.news.weretis.net	119	43	1	75
9	feeder.eternal-september.org	103	19	0	84
10	newsfeeds.xmission.com	11	3	0	8
11	news-out.aioe.org	10	9	0	1
12	news.samoylyk.net	10	0	0	10
13	nntp.pasdenom.info	5	0	0	5
14	news.swapon.de	2	0	0	2
15	xanadu-bbs.net	1	0	0	1
16	news.fcku.it	1	1	0	0
TOTAL: 16		4066	245	2	3819

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.pictures.purebeauty	17
mozilla.support.seamonkey	15
lada.talk	15
alt.survival	13
alt.windows7.general	13
spline.fli4l	11
it-alt.sport.calcio.juventus	11
alt.music.pink-floyd.publius	10
mozilla.general	10
oesterreich.tratsch	9
fido7.ru.android	7
mozilla.dev.platform	7
alt.math.undergrad	7
alt.christian.bible	6
alt.binaries.ebooks	6
alt.politics	6
spline.eisfair	5
alt.politics.usa	4
al.christnet.bible	4
alt.binaries.ebook	4
TOTAL: 67	245

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2460
EMP (phl)	77
EMP (phn nph)	70
EMP (phn path)	33
Too many newsgroups	27
HTML Multipart	14
Binary: misplaced rar	9
Binary Payload	7
User-issued cancel	7
Scoring filter (8)	5
Scoring filter (10)	5
Scoring filter (12)	5
Too many newsgroups (low_xpost)	2
Scoring filter (9)	1
Binary Image: misplaced jpg	1
HTML Image Tags	1
User-issued spam cancel	1
TOTAL: 17	2725

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	10	0	10	10
TOTAL: 1	10	6	10	10

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	news.freedyn.net	388
	csiph-out.feeder.erje.net	170
	csiph-out.news.xs4all.nl	77
	csiph-out.feed.uzoreto.com	63
	csiph-out.news.weretis.net	28
	news.samoylyk.net	10
	newsfeeds.xmission.com	8
	feeder.eternal-september.org	3
	news-out.mixmin.net	1
	TOTAL: 9	748
Including strange strings
	newsfeed.fu-berlin.de	292
	csiph-out.news.xs4all.nl	21
	csiph-out.news.weretis.net	17
	news-out.mixmin.net	7
	csiph-out.feeder.erje.net	4
	csiph-out.feed.uzoreto.com	2
	news.swapon.de	2
	newsfeed.neva.ru	1
	TOTAL: 8	346
TOTAL: 3		1139

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	12894	745	10141	0	3070	5%	23:59:55
2	news.samoylyk.net	14546	454	13493	4	0	3%	23:59:28
3	news.freedyn.net	12260	445	11400	34	0	3%	23:59:55
4	fu-berlin.de	13116	429	12687	0	0	3%	23:59:55
5	news.bbs.nz	26164	239	13262	3	0	0%	23:59:53
6	usenet.pasdenom.info	14429	151	13271	469	221	1%	23:59:55
7	aioe	12092	85	11510	0	0	0%	23:59:54
8	newsfeed.xs4all.nl	12903	69	12189	8	59	0%	23:59:54
9	neva.ru	13105	30	12651	116	0	0%	23:59:52
10	erje	14083	20	12692	4	0	0%	23:59:55
11	news.mixmin.net	13152	15	12631	0	0	0%	23:59:42
12	weretis.net	12043	9	11883	3	0	0%	23:59:55
13	xmission	15183	9	11258	1	0	0%	23:59:55
14	news.swapon.de	1350	8	1324	0	0	0%	23:49:51
15	eternal-september	12085	8	11548	0	0	0%	23:59:55
16	news.uzoreto.com	13598	7	13225	14	1	0%	23:59:43
17	news.fcku.it	1242	0	1240	0	0	0%	22:01:22
18	news.redatomik.org	0	0	0	0	13508	0%	23:59:55
TOTAL: 18		214245	2723	186405	656	16859	1%	429:48:54

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.1 MB	0.0 KB	5.1 MB	0.1 KB/s	7.0 KB	23:59:55
2	news.freedyn.net	4.7 MB	53.9 KB	4.8 MB	0.1 KB/s	10.2 KB	23:59:55
3	news.samoylyk.net	4.6 MB	21.6 KB	4.6 MB	0.1 KB/s	10.4 KB	23:59:28
4	fu-berlin.de	4.6 MB	0.0 KB	4.6 MB	0.1 KB/s	11.0 KB	23:59:55
5	news.bbs.nz	671.4 KB	4.8 KB	676.3 KB	0.0 KB/s	2.8 KB	23:59:53
6	usenet.pasdenom.info	408.8 KB	4.7 MB	5.1 MB	0.1 KB/s	8.4 KB	23:59:55
7	newsfeed.xs4all.nl	269.0 KB	28.9 KB	297.9 KB	0.0 KB/s	3.9 KB	23:59:54
8	aioe	159.5 KB	0.0 KB	159.5 KB	0.0 KB/s	1.9 KB	23:59:54
9	neva.ru	62.5 KB	309.6 KB	372.1 KB	0.0 KB/s	2.5 KB	23:59:52
10	erje	46.7 KB	67.9 KB	114.6 KB	0.0 KB/s	4.8 KB	23:59:55
11	news.mixmin.net	22.4 KB	0.0 KB	22.4 KB	0.0 KB/s	1.5 KB	23:59:42
12	weretis.net	12.9 KB	5.6 KB	18.5 KB	0.0 KB/s	1.5 KB	23:59:55
13	xmission	12.9 KB	1.1 KB	14.0 KB	0.0 KB/s	1.4 KB	23:59:55
14	news.swapon.de	10.7 KB	0.0 KB	10.7 KB	0.0 KB/s	1.3 KB	23:49:51
15	eternal-september	10.7 KB	0.0 KB	10.7 KB	0.0 KB/s	1.3 KB	23:59:55
16	news.uzoreto.com	10.1 KB	45.4 KB	55.5 KB	0.0 KB/s	2.6 KB	23:59:43
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:01:22
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:55
TOTAL: 18		20.7 MB	5.2 MB	25.9 MB	0.0 KB/s	7.9 KB	429:48:54

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	25	16	24.2 KB	8	0	0	05:41:49
2	66-188-82-154.dhcp.mdsn.wi.charter.com	29	10	13.4 KB	10	8	8	09:11:23
TOTAL: 2		54	26	37.6 KB	18	8	8	17:48:50

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	25	16	24.2 KB	8	0	0	05:41:49
2	*.dhcp.mdsn.wi.charter.com	29	10	13.4 KB	10	8	8	09:11:23
3	unresolved	6	0	0.0 KB	0	0	0	00:00:16
4	*.ph.ph.cox.net	7	0	0.0 KB	0	0	0	02:55:20
TOTAL: 4		67	26	37.6 KB	18	8	8	17:48:50

NNRP auth users [Top 20]:

User	Conn
ohlandl	8
TOTAL: 1	8

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
66-188-82-154.dhcp.mdsn.wi.charter.com	2.535	0.445	0.018	09:11:23
a131033.upc-a.chello.nl	2.338	0.307	0.000	05:41:49
ip72-222-200-117.ph.ph.cox.net	0.646	0.108	0.000	02:55:20
159.203.197.30	0.064	0.014	0.000	00:00:09
94.165.138.235	0.143	0.016	0.000	00:00:02
5.87.218.175	0.074	0.008	0.000	00:00:01
94.164.219.104	0.072	0.008	0.000	00:00:01
94.165.234.151	0.073	0.007	0.000	00:00:01
TOTAL: 8	5.945	0.913	0.018	17:48:50

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	7
94.165.138.235	2
159.203.197.30	1
94.164.219.104	1
5.87.218.175	1
94.165.234.151	1
TOTAL: 6	13

NNRP client timeouts [Top 20]:

System	Conn	Peer
66-188-82-154.dhcp.mdsn.wi.charter.com	12	0
ip72-222-200-117.ph.ph.cox.net	4	0
TOTAL: 2	16	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Sep 28 04:15:00 -- Sep 29 04:15:00