Daily Usenet report for csiph.com: Jun 27 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	45341	39.6%	9.0 MB	57.0%
nnrpd	44001	38.4%	3.9 MB	24.6%
innd	21911	19.1%	2.4 MB	15.0%
innfeed	3190	2.8%	549.1 KB	3.4%
nocem	73	0.1%	7.5 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	114517	100.0%	15.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	548776	56.9%
Negative hits	370121	38.4%
Do not exist	44361	4.6%
Cache misses	693	0.1%
TOTAL: 4	963951	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.128	0.0%	202	0.000	0.634	21.000
article cleanup	00:00:00.316	0.0%	44154	0.000	0.007	0.024
article logging	00:00:00.699	0.0%	44680	0.000	0.016	0.497
article parse	00:00:02.134	0.0%	155885	0.003	0.014	0.220
article write	00:01:10.015	0.1%	26705	0.211	2.622	40.961
artlog/artcncl	00:00:00.001	0.0%	185	0.000	0.005	0.500
artlog/artparse	00:00:00.006	0.0%	324	0.000	0.019	1.000
data move	00:00:00.362	0.0%	914092	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.013	0.0%	201	0.000	0.065	4.000
hishave/artcncl	00:00:00.011	0.0%	202	0.000	0.054	11.000
hishave/artparse	00:00:00.001	0.0%	320	0.000	0.003	0.200
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:15.163	0.0%	965484	0.002	0.016	0.256
history sync	00:00:02.040	0.0%	337	0.000	6.053	96.500
history write	00:01:08.070	0.1%	44130	0.072	1.542	19.569
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.687	0.0%	320	0.000	2.147	20.062
idle	23:43:30.385	99.5%	935540	56.968	91.295	252.595
nntp read	00:00:03.184	0.0%	944226	0.002	0.003	0.006
overview write	00:01:47.740	0.1%	26705	0.426	4.034	113.679
perl filter	00:01:40.948	0.1%	44012	1.396	2.294	3.561
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.512	0.0%	53474	0.000	0.010	0.026
TOTAL: 23:50:45.207	23:49:42.415	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.073	0.0%	26995	0.000	0.003	0.012
article prepare	00:00:00.003	0.0%	22116	0.000	0.000	0.015
article read	00:00:00.871	0.0%	2379	0.000	0.366	20.846
backlog stats	00:00:00.297	0.0%	601825	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.319	0.0%	449285	0.002	0.005	0.011
data write	00:00:02.910	0.0%	431663	0.002	0.007	0.012
idle	23:53:39.421	100.0%	601825	84.520	142.931	390.038
status file	00:00:00.230	0.0%	284	0.000	0.810	4.167
TOTAL: 23:53:55.457	23:53:46.124	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.865	0.0%	7667	0.033	0.243	0.300
idle	41:11:24.645	99.1%	65365	79.408	2268.563	600108.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.760	0.0%	131801	0.000	0.006	0.500
readart	00:00:17.406	0.0%	11524	0.000	1.510	48.000
TOTAL: 41:34:45.354	41:11:44.676	99.1%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	288	31365	5456	23860	2049	17%	23:49:41
2	csiph-out.feeder.erje.net	1153	144617	4502	132040	8075	3%	94:58:04
3	feeder.eternal-september.org	2	37914	3822	32895	1197	10%	24:13:36
4	news-out.mixmin.net	3	30077	3636	25362	1079	12%	24:11:58
5	newsfeed.neva.ru	149	56191	2196	50068	3927	3%	72:06:46
6	csiph-out.news.weretis.net	4	71842	2021	69148	673	2%	59:16:15
7	news-out.aioe.org	3	25963	1977	23955	31	7%	24:09:52
8	newsfeed.fu-berlin.de	51	29305	1262	27441	602	4%	33:08:42
9	newsfeeds.xmission.com	1	27912	684	27184	44	2%	25:41:05
10	news.freedyn.net	3	29514	515	28939	60	1%	24:09:34
11	news.fcku.it	1	11874	435	11394	45	3%	29:33:55
12	au2pb.net	1	30158	198	29880	80	0%	25:37:06
13	news.redatomik.org	1	20722	185	20533	4	0%	22:26:07
14	news.swapon.de	2	2239	81	2155	3	3%	27:19:24
15	nntp.pasdenom.info	5	27824	26	27777	21	0%	25:06:06
16	xanadu-bbs.net	10	751	20	716	15	2%	23:33:46
17	localhost	44	9	9	0	0	100%	00:00:00
18	news.bbs.geek.nz	2	23466	5	23460	1	0%	23:59:39
TOTAL: 18		1723	601743	27030	556807	17906	4%	583:21:36

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	17.5 MB	69.9 KB	31.3 MB	48.9 MB	35%	4.0 KB
2	usenet.blueworldhosting.com	14.8 MB	0.0 KB	19.9 MB	34.7 MB	42%	4.7 KB
3	news-out.mixmin.net	12.7 MB	1.5 KB	2.1 MB	14.8 MB	85%	3.2 KB
4	feeder.eternal-september.org	9.6 MB	1.6 KB	20.0 MB	29.6 MB	32%	6.0 KB
5	newsfeed.neva.ru	6.2 MB	0.0 KB	29.2 MB	35.4 MB	17%	5.9 KB
6	csiph-out.news.weretis.net	5.8 MB	8.5 KB	11.8 MB	17.6 MB	32%	6.7 KB
7	news-out.aioe.org	4.5 MB	1.5 KB	54.0 KB	4.6 MB	98%	2.3 KB
8	newsfeed.fu-berlin.de	2.6 MB	1.5 KB	1.3 MB	3.9 MB	66%	2.1 KB
9	newsfeeds.xmission.com	2.0 MB	3.1 KB	935.5 KB	2.9 MB	68%	4.1 KB
10	news.freedyn.net	1.7 MB	1.5 KB	1.3 MB	3.0 MB	56%	5.4 KB
11	news.fcku.it	1.0 MB	0.0 KB	1.4 MB	2.4 MB	42%	5.1 KB
12	au2pb.net	514.4 KB	1.5 KB	266.4 KB	782.3 KB	65%	2.8 KB
13	news.redatomik.org	439.6 KB	1.5 KB	236.0 KB	677.1 KB	64%	3.6 KB
14	news.swapon.de	199.6 KB	0.0 KB	116.0 KB	315.6 KB	63%	3.8 KB
15	xanadu-bbs.net	56.4 KB	0.0 KB	28.5 KB	84.8 KB	66%	2.4 KB
16	nntp.pasdenom.info	44.9 KB	1.5 KB	48.2 KB	94.6 KB	47%	2.0 KB
17	localhost	12.5 KB	0.0 KB	0.0 KB	12.5 KB	100%	1.4 KB
18	news.bbs.geek.nz	7.6 KB	1.5 KB	1.5 KB	10.7 KB	71%	1.8 KB
TOTAL: 18		79.6 MB	95.2 KB	120.1 MB	199.8 MB	39%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 27 04:15:00 - 04:59:59	523	2.0%	0.19	2.2 MB	2.8%	0.82
Jun 27 05:00:00 - 05:59:59	668	2.5%	0.19	3.1 MB	4.0%	0.89
Jun 27 06:00:00 - 06:59:59	878	3.3%	0.24	2.8 MB	3.5%	0.78
Jun 27 07:00:00 - 07:59:59	984	3.7%	0.27	2.7 MB	3.5%	0.78
Jun 27 08:00:00 - 08:59:59	1195	4.5%	0.33	3.7 MB	4.7%	1.06
Jun 27 09:00:00 - 09:59:59	1220	4.6%	0.34	3.0 MB	3.8%	0.85
Jun 27 10:00:00 - 10:59:59	1338	5.0%	0.37	3.7 MB	4.7%	1.04
Jun 27 11:00:00 - 11:59:59	1400	5.2%	0.39	3.7 MB	4.8%	1.07
Jun 27 12:00:00 - 12:59:59	1602	6.0%	0.45	4.2 MB	5.3%	1.19
Jun 27 13:00:00 - 13:59:59	1600	6.0%	0.44	5.2 MB	6.6%	1.47
Jun 27 14:00:00 - 14:59:59	1468	5.5%	0.41	4.7 MB	6.0%	1.35
Jun 27 15:00:00 - 15:59:59	1363	5.1%	0.38	3.8 MB	4.8%	1.07
Jun 27 16:00:00 - 16:59:59	1449	5.4%	0.40	4.0 MB	5.1%	1.14
Jun 27 17:00:00 - 17:59:59	1440	5.4%	0.40	4.8 MB	6.1%	1.36
Jun 27 18:00:00 - 18:59:59	1518	5.7%	0.42	4.0 MB	5.1%	1.14
Jun 27 19:00:00 - 19:59:59	1350	5.0%	0.38	3.8 MB	4.9%	1.09
Jun 27 20:00:00 - 20:59:59	1344	5.0%	0.37	3.6 MB	4.6%	1.02
Jun 27 21:00:00 - 21:59:59	1366	5.1%	0.38	3.7 MB	4.7%	1.06
Jun 27 22:00:00 - 22:59:59	928	3.5%	0.26	2.8 MB	3.6%	0.80
Jun 27 23:00:00 - 23:59:59	853	3.2%	0.24	2.3 MB	3.0%	0.66
Jun 28 00:00:00 - 00:59:59	571	2.1%	0.16	1.8 MB	2.2%	0.50
Jun 28 01:00:00 - 01:59:59	546	2.0%	0.15	1.6 MB	2.0%	0.45
Jun 28 02:00:00 - 02:59:59	556	2.1%	0.15	1.7 MB	2.2%	0.49
Jun 28 03:00:00 - 03:59:59	504	1.9%	0.14	1.4 MB	1.8%	0.40
Jun 28 04:00:00 - 04:15:00	129	0.5%	0.14	352.5 KB	0.4%	0.39
TOTAL: 24:00:00	26793	100.0%	0.31	78.6 MB	100.0%	0.93

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	8119	655	11	0	7453
2	newsfeed.neva.ru	3943	1011	0	0	2932
3	usenet.blueworldhosting.com	2049	1024	0	2	1023
4	feeder.eternal-september.org	1210	100	2	0	1108
5	news-out.mixmin.net	1126	9	2	0	1115
6	newsfeed.fu-berlin.de	967	21	1	0	945
7	csiph-out.news.weretis.net	604	265	4	0	335
8	au2pb.net	85	83	1	0	1
9	news.freedyn.net	64	2	1	0	61
10	newsfeeds.xmission.com	44	29	2	0	13
11	news.fcku.it	43	0	0	0	43
12	news-out.aioe.org	37	28	1	0	8
13	nntp.pasdenom.info	21	14	1	0	6
14	news.swapon.de	19	0	0	0	19
15	xanadu-bbs.net	15	0	0	0	15
16	news.redatomik.org	5	0	1	0	4
17	news.bbs.geek.nz	1	0	1	0	0
TOTAL: 17		18352	3241	28	2	15081

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	730
mailing.freebsd.pkg-fallout	234
mailing.freebsd.ports-bugs	161
lada.talk	160
lada.auto	122
ut.test	113
it-alt.sport.calcio.juventus	113
mailing.openssl.cvs	67
mailing.freebsd.svn-ports-all	66
mailing.freebsd.svn-ports-head	66
fa.netbsd.bugs	45
mailing.openbsd.ports-changes	42
fa.openbsd.source-changes	36
mailing.openbsd.source-changes	36
alt.windows7.general	31
mozilla.support.thunderbird	31
gmane.linux.alsa.devel	28
mailing.freebsd.ports	27
mailing.openssl.dev	26
mailing.freebsd.bugs	26
TOTAL: 253	3241

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
nz.politics.announce	2
TOTAL: 1	2

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9874
EMP (phn path)	2388
PFM bot misc	672
EMP (phl)	649
EMP (phn nph)	209
Too many newsgroups	69
HTML Multipart	31
Binary Payload	28
User-issued cancel	22
Scoring filter (20)	14
Scoring filter (17)	11
Scoring filter (11)	11
Scoring filter (22)	11
Too many newsgroups (meow)	11
Scoring filter (21)	11
Scoring filter (15)	10
Scoring filter (8)	10
Scoring filter (10)	9
Binary: misplaced par2	8
Scoring filter (24)	8
TOTAL: 35	14111

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	65	0	70	70
TOTAL: 1	65	0	70	70

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	108
	usenet.blueworldhosting.com	3
	TOTAL: 2	111
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	usenet.blueworldhosting.com	1
	TOTAL: 2	5
Huge articles
	feeder.eternal-september.org	119
	csiph-out.news.weretis.net	77
	usenet.blueworldhosting.com	77
	news.freedyn.net	15
	newsfeeds.xmission.com	11
	news.fcku.it	9
	news-out.mixmin.net	6
	news.redatomik.org	4
	news.swapon.de	2
	newsfeed.fu-berlin.de	1
	TOTAL: 10	321
Including strange strings
	newsfeed.fu-berlin.de	393
	csiph-out.feeder.erje.net	47
	news-out.mixmin.net	34
	feeder.eternal-september.org	18
	news.swapon.de	16
	news-out.aioe.org	7
	newsfeed.neva.ru	6
	csiph-out.news.weretis.net	5
	news.fcku.it	2
	newsfeeds.xmission.com	2
	TOTAL: 11	531
No colon-space in header
	usenet.blueworldhosting.com	4
	TOTAL: 1	4
TOTAL: 5		972

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	30408	1058	25108	8	0	3%	23:50:06
2	xanadu-bbs	29690	960	25732	24	53	3%	23:56:07
3	fu-berlin.de	25119	789	24330	0	0	3%	23:50:51
4	news.bbs.geek.nz	50095	673	25214	8	0	1%	23:50:04
5	usenet.pasdenom.info	34065	142	25468	1155	49	0%	23:59:55
6	weretis.net	24155	136	22694	21	0	0%	23:50:04
7	aioe	24548	115	22590	7	0	0%	23:50:04
8	au2pb	27635	98	25658	2	0	0%	23:53:10
9	news.redatomik.org	27166	68	25404	5	0	0%	23:50:20
10	xmission	31074	57	25185	0	0	0%	23:56:35
11	bwh	22911	21	20274	22	160	0%	23:51:45
12	news.mixmin.net	23540	18	22030	0	0	0%	23:58:35
13	eternal-september	24204	13	21672	0	0	0%	23:50:04
14	erje	24218	12	22063	32	0	0%	23:55:31
15	news.swapon.de	2172	7	2082	3	0	0%	23:51:46
16	neva.ru	24720	5	22976	18	0	0%	23:50:04
17	news.fcku.it	3991	0	3320	0	0	0%	22:56:02
TOTAL: 17		429711	4172	361800	1305	262	0%	405:01:03

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	8.8 MB	68.9 KB	8.9 MB	0.1 KB/s	8.5 KB	23:50:06
2	xanadu-bbs	8.4 MB	90.8 KB	8.5 MB	0.1 KB/s	8.8 KB	23:56:07
3	fu-berlin.de	8.0 MB	0.0 KB	8.0 MB	0.1 KB/s	10.3 KB	23:50:51
4	news.bbs.geek.nz	1.7 MB	34.8 KB	1.7 MB	0.0 KB/s	2.6 KB	23:50:04
5	usenet.pasdenom.info	381.2 KB	9.0 MB	9.3 MB	0.1 KB/s	7.4 KB	23:59:55
6	weretis.net	343.7 KB	200.0 KB	543.6 KB	0.0 KB/s	3.5 KB	23:50:04
7	aioe	253.6 KB	17.2 KB	270.8 KB	0.0 KB/s	2.2 KB	23:50:04
8	au2pb	233.3 KB	9.5 KB	242.8 KB	0.0 KB/s	2.4 KB	23:53:10
9	news.redatomik.org	168.3 KB	19.1 KB	187.4 KB	0.0 KB/s	2.6 KB	23:50:20
10	xmission	149.4 KB	0.0 KB	149.4 KB	0.0 KB/s	2.6 KB	23:56:35
11	bwh	52.5 KB	71.0 KB	123.5 KB	0.0 KB/s	2.9 KB	23:51:45
12	news.mixmin.net	35.0 KB	0.0 KB	35.0 KB	0.0 KB/s	1.9 KB	23:58:35
13	eternal-september	28.0 KB	0.0 KB	28.0 KB	0.0 KB/s	2.2 KB	23:50:04
14	erje	18.3 KB	153.9 KB	172.3 KB	0.0 KB/s	3.9 KB	23:55:31
15	news.swapon.de	9.9 KB	5.0 KB	14.9 KB	0.0 KB/s	1.5 KB	23:51:46
16	neva.ru	6.8 KB	52.4 KB	59.2 KB	0.0 KB/s	2.6 KB	23:50:04
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:56:02
TOTAL: 17		28.5 MB	9.7 MB	38.2 MB	0.0 KB/s	7.1 KB	405:01:03

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	65	201.9 KB	57	3	0	04:53:22
2	tempe0.bbox.io	26	19	28.9 KB	3	1	1	07:12:04
3	dhcp-089-099-203-254.chello.nl	41	14	23.0 KB	3	0	0	08:25:39
4	68-185-181-64.dhcp.mdsn.wi.charter.com	13	13	21.8 KB	7	5	5	02:10:43
5	mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	120	9	17.6 KB	8	0	0	00:37:12
6	challenger.nielsenmedia.com	9	1	1.4 KB	1	0	0	03:31:08
TOTAL: 6		497	121	294.7 KB	79	9	6	41:34:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	296	65	201.9 KB	57	3	0	19:37:16
2	*.bbox.io	26	19	28.9 KB	3	1	1	07:12:04
3	*.chello.nl	41	14	23.0 KB	3	0	0	08:25:39
4	*.dhcp.mdsn.wi.charter.com	13	13	21.8 KB	7	5	5	02:10:43
5	*.dsl.bell.ca	120	9	17.6 KB	8	0	0	00:37:12
6	*.nielsenmedia.com	9	1	1.4 KB	1	0	0	03:31:08
7	*.rev.numericable.fr	2	0	0.0 KB	0	0	0	00:00:35
TOTAL: 7		507	121	294.7 KB	79	9	6	41:34:40

NNRP auth users [Top 20]:

User	Conn
moussa	288
ohlandl	5
kev009	1
TOTAL: 3	294

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
216.239.174.119	0.410	0.547	0.000	13:40:46
dhcp-089-099-203-254.chello.nl	3.756	0.801	0.000	08:25:39
tempe0.bbox.io	2.266	0.484	0.003	07:12:04
202.89.176.220	30.565	7.767	0.789	04:53:22
challenger.nielsenmedia.com	0.829	0.189	0.000	03:31:08
68-185-181-64.dhcp.mdsn.wi.charter.com	1.468	0.245	0.011	02:10:43
71.98.160.36	0.253	0.024	0.000	01:03:05
mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	15.120	4.246	0.000	00:37:12
81-67-242-59.rev.numericable.fr	0.164	0.055	0.000	00:00:35
94.167.49.201	0.104	0.008	0.000	00:00:01
TOTAL: 10	54.935	14.366	0.803	41:34:40

Curious NNRP server explorers [Top 20]:

System	Conn
216.246.166.30	4
71.98.160.36	3
81-67-242-59.rev.numericable.fr	2
94.167.49.201	1
TOTAL: 4	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	13	0
challenger.nielsenmedia.com	6	0
71.98.160.36	2	0
68-185-181-64.dhcp.mdsn.wi.charter.com	1	0
TOTAL: 4	22	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	112	92.6%
2	alt	4	3.3%
3	uk	3	2.5%
4	rec	1	0.8%
5	soc	1	0.8%
TOTAL: 5		121	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	59
2	comp.os.vms	26
3	comp.ai.neural-nets	8
4	comp.sys.ibm.pc.games.action	7
5	comp.arch.embedded	5
6	alt.home.repair	2
7	comp.os.os2.networking.misc	2
8	comp.ai.philosophy	2
9	comp.sys.hp.hardware	1
10	soc.genealogy.britain	1
11	comp.sys.ibm.pc.hardware.storage	1
12	alt.os.linux	1
13	uk.legal	1
14	uk.sci.weather	1
15	uk.media.radio.archers	1
16	alt.happy.valley	1
17	rec.arts.tv.uk.coronation-st	1
18	comp.lang.awk	1
TOTAL: 18		121

Daily Usenet report for csiph.com

Jun 27 04:15:00 -- Jun 28 04:15:00