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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19052	47.2%	4.9 MB	63.4%
innd	17408	43.2%	2.2 MB	28.1%
innfeed	3363	8.3%	613.5 KB	7.8%
nnrpd	437	1.1%	48.0 KB	0.6%
nocem	68	0.2%	7.3 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40329	100.0%	7.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	271941	58.0%
Negative hits	178029	38.0%
Do not exist	18272	3.9%
Cache misses	258	0.1%
TOTAL: 4	468500	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.445	0.0%	128	0.000	3.477	28.000
article cleanup	00:00:00.109	0.0%	17523	0.000	0.006	0.048
article logging	00:00:00.470	0.0%	17989	0.000	0.026	2.182
article parse	00:00:02.342	0.0%	73782	0.000	0.032	0.273
article write	00:01:31.473	0.1%	14949	0.323	6.119	92.371
artlog/artcncl	00:00:00.003	0.0%	104	0.000	0.029	1.000
artlog/artparse	00:00:00.049	0.0%	913	0.000	0.054	2.100
data move	00:00:00.125	0.0%	464094	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.027	0.0%	124	0.000	0.218	10.000
hishave/artcncl	00:00:00.019	0.0%	128	0.000	0.148	4.000
hishave/artparse	00:00:00.002	0.0%	910	0.000	0.002	0.034
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:21.154	0.0%	471961	0.002	0.045	0.455
history sync	00:00:00.836	0.0%	361	0.000	2.316	14.000
history write	00:00:25.202	0.0%	17524	0.282	1.438	8.517
hiswrite/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hiswrite/artparse	00:00:01.556	0.0%	910	0.000	1.710	17.273
idle	23:54:38.867	99.6%	464383	103.125	185.362	981.291
nntp read	00:00:02.022	0.0%	471010	0.001	0.004	0.012
overview write	00:02:51.691	0.2%	14949	0.203	11.485	432.196
perl filter	00:00:30.828	0.0%	17520	1.262	1.760	9.805
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.304	0.0%	29960	0.000	0.010	0.040
TOTAL: 24:01:02.835	24:00:27.524	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.046	0.0%	15205	0.000	0.003	0.083
article prepare	00:00:00.001	0.0%	16856	0.000	0.000	0.006
article read	00:00:01.189	0.0%	1129	0.000	1.053	22.400
backlog stats	00:00:00.186	0.0%	314855	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.314	0.0%	244802	0.001	0.005	0.013
data write	00:00:01.529	0.0%	232354	0.000	0.007	0.012
idle	23:54:52.591	100.0%	314855	157.455	273.436	1189.646
status file	00:00:00.265	0.0%	272	0.000	0.974	23.000
TOTAL: 23:55:05.110	23:54:57.121	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	14:52:13.025	100.0%	332	59.000	161244.051	600077.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.710	0.0%	734	0.000	2.330	30.411
readart	00:00:00.287	0.0%	24	0.000	11.958	49.000
TOTAL: 14:52:37.853	14:52:15.022	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	30057	3351	26542	164	11%	49:56:09
2	csiph-out.news.xs4all.nl	864	16355	1847	13366	1142	11%	71:13:46
3	newsfeeds.xmission.com	3	14336	1807	12518	11	12%	24:39:14
4	feeder.eternal-september.org	5	17253	1726	15475	52	10%	26:57:36
5	csiph-out.feeder.erje.net	1440	72581	1516	70680	385	2%	118:42:27
6	news-out.aioe.org	2	14290	1438	12825	27	10%	24:09:02
7	news-out.mixmin.net	1	15680	912	14450	318	5%	23:59:51
8	news.freedyn.net	3	17420	811	15684	925	4%	24:08:50
9	newsfeed.fu-berlin.de	5	14090	776	13203	111	5%	24:09:08
10	newsfeed.neva.ru	143	17576	504	16843	229	2%	71:24:03
11	csiph-out.feed.uzoreto.com	864	21763	219	21419	125	1%	71:11:01
12	news.fcku.it	14	1705	126	1579	0	7%	22:05:37
13	nntp.pasdenom.info	1	9736	71	9658	7	0%	23:59:55
14	news.swapon.de	4	1431	28	1402	1	1%	20:42:39
15	news.samoylyk.net	1	14224	13	14211	0	0%	23:59:54
16	localhost	39	7	7	0	0	100%	00:00:06
17	news.bbs.nz	1	13982	6	13976	0	0%	23:59:54
18	xanadu-bbs.net	31	397	0	397	0	0%	21:36:24
TOTAL: 18		3425	292883	15158	274228	3497	5%	666:55:36

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	11.0 MB	2.8 KB	3.5 MB	14.5 MB	75%	4.2 KB
2	csiph-out.feeder.erje.net	9.8 MB	0.0 KB	12.9 MB	22.6 MB	43%	12.2 KB
3	newsfeeds.xmission.com	5.3 MB	0.0 KB	732.1 KB	6.1 MB	88%	3.4 KB
4	csiph-out.news.xs4all.nl	4.8 MB	0.0 KB	13.0 MB	17.8 MB	26%	6.1 KB
5	feeder.eternal-september.org	4.7 MB	0.0 KB	1.0 MB	5.7 MB	82%	3.3 KB
6	news-out.aioe.org	3.5 MB	2.8 KB	38.7 KB	3.6 MB	98%	2.5 KB
7	news-out.mixmin.net	2.6 MB	0.0 KB	653.9 KB	3.2 MB	80%	2.7 KB
8	news.freedyn.net	2.3 MB	0.0 KB	50.1 MB	52.5 MB	4%	30.9 KB
9	newsfeed.fu-berlin.de	1.8 MB	0.0 KB	232.8 KB	2.1 MB	88%	2.4 KB
10	newsfeed.neva.ru	1.5 MB	0.0 KB	781.8 KB	2.3 MB	66%	3.1 KB
11	csiph-out.feed.uzoreto.com	678.8 KB	0.0 KB	3.8 MB	4.5 MB	14%	13.3 KB
12	news.fcku.it	227.0 KB	0.0 KB	0.0 KB	227.0 KB	100%	1.8 KB
13	nntp.pasdenom.info	161.4 KB	0.0 KB	11.4 KB	172.8 KB	93%	2.2 KB
14	news.swapon.de	62.5 KB	0.0 KB	80.4 KB	142.9 KB	43%	4.9 KB
15	news.samoylyk.net	34.6 KB	0.0 KB	0.0 KB	34.6 KB	100%	2.7 KB
16	news.bbs.nz	24.2 KB	0.0 KB	0.0 KB	24.2 KB	100%	4.0 KB
17	localhost	15.4 KB	0.0 KB	0.0 KB	15.4 KB	100%	2.2 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		48.6 MB	5.6 KB	86.8 MB	135.3 MB	35%	7.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 1 04:15:00 - 04:59:59	154	1.0%	0.06	402.7 KB	0.8%	0.15
Sep 1 05:00:00 - 05:59:59	310	2.1%	0.09	992.6 KB	2.0%	0.28
Sep 1 06:00:00 - 06:59:59	475	3.2%	0.13	2.0 MB	4.2%	0.58
Sep 1 07:00:00 - 07:59:59	438	2.9%	0.12	1.8 MB	3.8%	0.51
Sep 1 08:00:00 - 08:59:59	531	3.5%	0.15	1.5 MB	3.1%	0.42
Sep 1 09:00:00 - 09:59:59	679	4.5%	0.19	2.4 MB	5.0%	0.68
Sep 1 10:00:00 - 10:59:59	697	4.7%	0.19	2.5 MB	5.3%	0.72
Sep 1 11:00:00 - 11:59:59	631	4.2%	0.18	1.7 MB	3.6%	0.49
Sep 1 12:00:00 - 12:59:59	702	4.7%	0.20	2.1 MB	4.3%	0.59
Sep 1 13:00:00 - 13:59:59	747	5.0%	0.21	2.2 MB	4.6%	0.63
Sep 1 14:00:00 - 14:59:59	834	5.6%	0.23	2.8 MB	5.8%	0.79
Sep 1 15:00:00 - 15:59:59	783	5.2%	0.22	2.1 MB	4.5%	0.61
Sep 1 16:00:00 - 16:59:59	897	6.0%	0.25	2.5 MB	5.2%	0.71
Sep 1 17:00:00 - 17:59:59	834	5.6%	0.23	2.8 MB	5.8%	0.80
Sep 1 18:00:00 - 18:59:59	872	5.8%	0.24	2.8 MB	5.9%	0.81
Sep 1 19:00:00 - 19:59:59	923	6.2%	0.26	2.9 MB	6.0%	0.82
Sep 1 20:00:00 - 20:59:59	870	5.8%	0.24	2.5 MB	5.1%	0.70
Sep 1 21:00:00 - 21:59:59	842	5.6%	0.23	2.2 MB	4.5%	0.62
Sep 1 22:00:00 - 22:59:59	599	4.0%	0.17	2.1 MB	4.4%	0.60
Sep 1 23:00:00 - 23:59:59	480	3.2%	0.13	1.6 MB	3.3%	0.46
Sep 2 00:00:00 - 00:59:59	408	2.7%	0.11	1.3 MB	2.7%	0.37
Sep 2 01:00:00 - 01:59:59	424	2.8%	0.12	1.4 MB	2.9%	0.40
Sep 2 02:00:00 - 02:59:59	351	2.3%	0.10	1.4 MB	3.0%	0.41
Sep 2 03:00:00 - 03:59:59	366	2.4%	0.10	1.3 MB	2.8%	0.38
Sep 2 04:00:00 - 04:15:00	121	0.8%	0.13	678.1 KB	1.4%	0.75
TOTAL: 24:00:00	14968	100.0%	0.17	48.0 MB	100.0%	0.57

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1200	57	0	1143
2	news.freedyn.net	932	13	0	919
3	newsfeed.fu-berlin.de	494	24	0	470
4	csiph-out.feeder.erje.net	390	36	0	354
5	news-out.mixmin.net	329	1	0	328
6	newsfeed.neva.ru	229	61	0	168
7	csiph-out.news.weretis.net	179	93	1	85
8	csiph-out.feed.uzoreto.com	127	1	0	126
9	feeder.eternal-september.org	41	18	0	23
10	news-out.aioe.org	33	25	1	7
11	newsfeeds.xmission.com	11	0	0	11
12	news.swapon.de	9	0	0	9
13	nntp.pasdenom.info	7	0	0	7
TOTAL: 13		3981	329	2	3650

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.bbs.synchronet	52
lada.talk	32
it-alt.sport.calcio.juventus	32
lada.auto	21
alt.computer.workshop	20
alt.windows7.general	19
alt.pl.nieruchomosci.gielda	11
oesterreich.tratsch	10
spline.eisfair	8
cakewalk.audio	8
mozilla.support.thunderbird	7
rocksolid.shared.offtopic	6
alt.survival	5
alt.binaries.pictures.purebeauty	5
mozilla.dev.ports.os2	5
eagle.support.eng	4
rocksolid.nodes	4
alt.philosophy	4
alt.binaries.audiobooks	4
alt.politics.usa	4
TOTAL: 69	329

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1761
EMP (phn path)	174
EMP (phl)	155
EMP (phn nph)	71
Too many newsgroups	25
User-issued cancel	19
Binary: misplaced rar	15
Too many newsgroups (low_xpost)	9
HTML Multipart	9
Binary Payload	9
Scoring filter (10)	8
Scoring filter (9)	3
User-issued spam cancel	2
Scoring filter (12)	2
Too many newsgroups (meow)	1
Scoring filter (14)	1
Scoring filter (11)	1
Scoring filter (16)	1
TOTAL: 18	2266

NoCeM on Spool:

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

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	400
	csiph-out.feeder.erje.net	241
	csiph-out.news.xs4all.nl	153
	csiph-out.feed.uzoreto.com	52
	csiph-out.news.weretis.net	47
	newsfeeds.xmission.com	11
	feeder.eternal-september.org	4
	news-out.mixmin.net	2
	news.swapon.de	1
	TOTAL: 9	911
Including strange strings
	newsfeed.fu-berlin.de	394
	csiph-out.news.xs4all.nl	35
	csiph-out.news.weretis.net	13
	news-out.mixmin.net	10
	news.swapon.de	8
	news-out.aioe.org	6
	csiph-out.feeder.erje.net	2
	feeder.eternal-september.org	1
	TOTAL: 8	469
No colon-space in header
	csiph-out.news.xs4all.nl	2
	csiph-out.feeder.erje.net	1
	TOTAL: 2	3
TOTAL: 4		1428

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17602	950	14018	0	217	5%	23:59:54
2	fu-berlin.de	13965	622	13343	0	0	4%	23:59:54
3	news.freedyn.net	14390	622	13429	46	0	4%	23:59:54
4	news.samoylyk.net	15519	606	14292	59	0	3%	23:59:54
5	news.bbs.nz	27643	239	14053	4	2	0%	23:59:53
6	usenet.pasdenom.info	15302	95	14141	660	0	0%	23:59:40
7	newsfeed.xs4all.nl	13333	28	12485	6	63	0%	23:59:53
8	aioe	12590	18	12152	0	0	0%	23:59:54
9	news.uzoreto.com	14329	16	14113	72	0	0%	23:59:17
10	neva.ru	13881	11	13555	129	0	0%	23:59:54
11	news.mixmin.net	13587	10	13244	0	0	0%	23:59:54
12	xmission	15707	9	12553	1	0	0%	23:59:49
13	weretis.net	11110	8	10986	0	0	0%	23:59:53
14	eternal-september	13013	7	12593	0	0	0%	23:59:54
15	news.swapon.de	1612	7	1586	0	0	0%	23:55:15
16	erje	13590	7	13309	38	0	0%	23:59:53
17	news.redatomik.org	0	0	0	0	14311	0%	23:59:54
18	news.fcku.it	1387	0	1385	0	0	0%	21:33:36
TOTAL: 18		228560	3255	201237	1015	14593	1%	429:26:15

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	8.2 MB	0.0 KB	8.2 MB	0.1 KB/s	8.8 KB	23:59:54
2	news.freedyn.net	7.5 MB	78.7 KB	7.6 MB	0.1 KB/s	11.6 KB	23:59:54
3	fu-berlin.de	7.5 MB	0.0 KB	7.5 MB	0.1 KB/s	12.3 KB	23:59:54
4	news.samoylyk.net	6.0 MB	1.6 MB	7.5 MB	0.1 KB/s	11.6 KB	23:59:54
5	news.bbs.nz	510.3 KB	8.3 KB	518.6 KB	0.0 KB/s	2.1 KB	23:59:53
6	usenet.pasdenom.info	257.4 KB	7.5 MB	7.8 MB	0.1 KB/s	10.6 KB	23:59:40
7	newsfeed.xs4all.nl	120.3 KB	37.7 KB	158.1 KB	0.0 KB/s	4.6 KB	23:59:53
8	news.uzoreto.com	52.2 KB	283.3 KB	335.5 KB	0.0 KB/s	3.8 KB	23:59:17
9	aioe	40.5 KB	0.0 KB	40.5 KB	0.0 KB/s	2.2 KB	23:59:54
10	neva.ru	39.9 KB	238.2 KB	278.0 KB	0.0 KB/s	2.0 KB	23:59:54
11	xmission	21.3 KB	1.3 KB	22.7 KB	0.0 KB/s	2.3 KB	23:59:49
12	news.mixmin.net	21.0 KB	0.0 KB	21.0 KB	0.0 KB/s	2.1 KB	23:59:54
13	weretis.net	17.6 KB	0.0 KB	17.6 KB	0.0 KB/s	2.2 KB	23:59:53
14	eternal-september	15.4 KB	0.0 KB	15.4 KB	0.0 KB/s	2.2 KB	23:59:54
15	news.swapon.de	15.4 KB	0.0 KB	15.4 KB	0.0 KB/s	2.2 KB	23:55:15
16	erje	10.0 KB	185.4 KB	195.4 KB	0.0 KB/s	4.3 KB	23:59:53
17	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:54
18	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:33:36
TOTAL: 18		30.2 MB	9.9 MB	40.1 MB	0.0 KB/s	9.6 KB	429:26:15

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-190-164-204.dhcp.eucl.wi.charter.com	20	10	21.6 KB	9	7	7	05:10:52
2	a131033.upc-a.chello.nl	26	8	15.9 KB	5	0	0	07:13:08
3	p3ee23683.dip0.t-ipconnect.de	1	6	14.9 KB	1	0	0	00:00:11
TOTAL: 3		47	24	52.3 KB	15	7	7	14:52:37

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.eucl.wi.charter.com	20	10	21.6 KB	9	7	7	05:10:52
2	*.upc-a.chello.nl	26	8	15.9 KB	5	0	0	07:13:08
3	*.dip0.t-ipconnect.de	1	6	14.9 KB	1	0	0	00:00:11
4	*.ph.ph.cox.net	5	0	0.0 KB	0	0	0	02:20:15
5	*.ip.moscow.rt.ru	1	0	0.0 KB	0	0	0	00:00:12
6	*.res.spectrum.com	1	0	0.0 KB	0	0	0	00:00:00
7	unresolved	6	0	0.0 KB	0	0	0	00:00:16
8	*.19-1.cable.virginm.net	1	0	0.0 KB	0	0	0	00:07:38
9	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
TOTAL: 9		62	24	52.3 KB	15	7	7	14:52:37

NNRP auth users [Top 20]:

User	Conn
ohlandl	7
TOTAL: 1	7

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	1.982	0.424	0.000	07:13:08
68-190-164-204.dhcp.eucl.wi.charter.com	1.865	0.271	0.016	05:10:52
ip72-222-200-117.ph.ph.cox.net	0.466	0.090	0.000	02:20:15
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	0.119	0.009	0.000	00:07:38
broadband-178-140-57-105.ip.moscow.rt.ru	0.063	0.016	0.000	00:00:12
p3ee23683.dip0.t-ipconnect.de	0.109	0.094	0.000	00:00:11
138.68.212.244	0.048	0.032	0.000	00:00:09
78.128.113.38	0.141	0.022	0.000	00:00:02
94.161.248.101	0.128	0.033	0.000	00:00:02
94.164.139.255	0.064	0.016	0.000	00:00:01
scan-141.security.ipip.net	0.060	0.022	0.000	00:00:00
098-127-144-236.res.spectrum.com	0.062	0.016	0.000	00:00:00
TOTAL: 12	5.107	1.045	0.016	14:52:37

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	5
94.161.248.101	2
78.128.113.38	2
scan-141.security.ipip.net	1
138.68.212.244	1
94.164.139.255	1
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1
098-127-144-236.res.spectrum.com	1
broadband-178-140-57-105.ip.moscow.rt.ru	1
TOTAL: 9	15

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
78.128.113.38	2
TOTAL: 2	6

NNRP unrecognized commands (by command):

Command	Count
^C	2
User-Agent: HTTP Banner Detection (https...	1
GET / HTTP/1.1	1
Host: 69.160.37.58:119	1
Connection: close	1
TOTAL: 5	6

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-204.dhcp.eucl.wi.charter.com	6	0
ip72-222-200-117.ph.ph.cox.net	4	0
78.128.113.38	2	2
TOTAL: 3	12	2

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	18	75.0%
2	de	6	25.0%
TOTAL: 2		24	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	18
2	de.sci.electronics	6
TOTAL: 2		24

Daily Usenet report for csiph.com

Sep 1 04:15:00 -- Sep 2 04:15:00