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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	48309	40.0%	9.3 MB	56.7%
nnrpd	44649	36.9%	3.9 MB	24.0%
innd	24567	20.3%	2.6 MB	16.0%
innfeed	3221	2.7%	557.5 KB	3.3%
nocem	95	0.1%	9.5 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	120842	100.0%	16.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	553794	57.6%
Negative hits	359365	37.4%
Do not exist	47029	4.9%
Cache misses	714	0.1%
TOTAL: 4	960902	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.003	0.0%	371	0.000	2.704	34.100
article cleanup	00:00:00.293	0.0%	46461	0.000	0.006	0.024
article logging	00:00:00.578	0.0%	46997	0.000	0.012	0.046
article parse	00:00:01.883	0.0%	168801	0.003	0.011	0.060
article write	00:04:56.811	0.3%	26502	0.214	11.200	54.840
artlog/artcncl	00:00:00.005	0.0%	344	0.000	0.015	0.250
artlog/artparse	00:00:00.028	0.0%	958	0.000	0.029	1.000
data move	00:00:00.317	0.0%	907056	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.052	0.0%	266	0.000	0.195	2.600
hishave/artcncl	00:00:00.008	0.0%	371	0.000	0.022	0.500
hishave/artparse	00:00:00.002	0.0%	376	0.000	0.005	0.143
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:05.553	0.0%	965715	0.002	0.006	0.130
history sync	00:00:02.371	0.0%	343	0.000	6.913	99.000
history write	00:00:38.688	0.0%	47010	0.103	0.823	9.769
hiswrite/artcncl	00:00:00.042	0.0%	105	0.000	0.400	0.800
hiswrite/artparse	00:00:00.242	0.0%	376	0.000	0.644	6.000
idle	23:50:35.257	99.3%	932073	56.242	92.091	251.766
nntp read	00:00:03.235	0.0%	946329	0.002	0.003	0.006
overview write	00:01:26.828	0.1%	26502	0.312	3.276	81.107
perl filter	00:01:49.467	0.1%	46310	1.449	2.364	3.508
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.450	0.0%	53093	0.000	0.008	0.027
TOTAL: 24:00:49.162	23:59:43.113	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.085	0.0%	26487	0.000	0.003	0.021
article prepare	00:00:00.004	0.0%	26380	0.000	0.000	0.013
article read	00:00:02.164	0.0%	3660	0.000	0.591	7.889
backlog stats	00:00:00.321	0.0%	619070	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.360	0.0%	453633	0.002	0.005	0.010
data write	00:00:02.897	0.0%	436254	0.002	0.007	0.011
idle	23:53:49.013	100.0%	619070	73.282	138.965	372.649
status file	00:00:00.380	0.0%	309	0.000	1.230	8.800
TOTAL: 23:54:06.314	23:53:57.224	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.404	0.0%	7452	0.048	0.188	0.524
idle	82:49:59.900	98.7%	1143192	82.841	260.848	600178.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:21.110	0.0%	3137798	0.000	0.007	0.167
readart	00:40:00.132	0.8%	1067701	0.000	2.248	49.000
TOTAL: 83:53:47.960	83:30:22.546	99.5%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	146978	6471	129616	10891	4%	94:57:39
2	usenet.blueworldhosting.com	288	30531	6237	22324	1970	20%	23:44:42
3	feeder.eternal-september.org	7	40345	4121	34921	1303	10%	25:03:45
4	csiph-out.news.weretis.net	3	58565	1957	55925	683	3%	46:34:50
5	news-out.aioe.org	1	25468	1792	23654	22	7%	23:59:58
6	newsfeed.neva.ru	152	62881	1731	56186	4964	2%	71:34:48
7	news-out.mixmin.net	3	29664	1179	28049	436	3%	24:08:55
8	newsfeed.fu-berlin.de	53	27510	1151	26001	358	4%	30:36:36
9	news.freedyn.net	4	29165	567	28506	92	1%	24:09:53
10	news.fcku.it	1	10999	413	10520	66	3%	23:48:39
11	newsfeeds.xmission.com	1	24335	283	24028	24	1%	20:03:02
12	au2pb.net	1	31264	250	30961	53	0%	25:49:11
13	news.redatomik.org	1	23467	119	23342	6	0%	22:26:07
14	news.swapon.de	2	2188	102	2086	0	4%	24:47:31
15	nntp.pasdenom.info	3	27504	47	27454	3	0%	24:08:22
16	news.bbs.geek.nz	1	27269	43	27226	0	0%	23:59:51
17	xanadu-bbs.net	11	852	11	834	7	1%	24:53:45
18	localhost	37	4	4	0	0	100%	00:00:00
TOTAL: 18		1721	598989	26478	551633	20878	4%	554:47:34

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	22.0 MB	112.1 KB	42.0 MB	64.1 MB	34%	3.8 KB
2	usenet.blueworldhosting.com	17.8 MB	0.0 KB	21.5 MB	39.3 MB	45%	4.9 KB
3	feeder.eternal-september.org	11.3 MB	4.7 KB	22.4 MB	33.7 MB	33%	6.4 KB
4	csiph-out.news.weretis.net	6.1 MB	0.0 KB	11.2 MB	17.3 MB	35%	6.7 KB
5	news-out.mixmin.net	5.0 MB	6.2 KB	1.2 MB	6.2 MB	80%	4.0 KB
6	newsfeed.neva.ru	4.6 MB	152.8 KB	39.5 MB	44.3 MB	10%	6.8 KB
7	news-out.aioe.org	4.2 MB	0.0 KB	35.2 KB	4.2 MB	99%	2.4 KB
8	newsfeed.fu-berlin.de	2.5 MB	0.0 KB	888.1 KB	3.3 MB	74%	2.3 KB
9	news.freedyn.net	2.0 MB	1.5 KB	666.3 KB	2.6 MB	75%	4.1 KB
10	newsfeeds.xmission.com	1.0 MB	0.0 KB	600.7 KB	1.6 MB	63%	5.3 KB
11	news.fcku.it	797.8 KB	393.4 KB	1.2 MB	2.4 MB	32%	5.1 KB
12	au2pb.net	609.1 KB	1.5 KB	350.8 KB	961.4 KB	63%	3.2 KB
13	news.redatomik.org	250.7 KB	0.0 KB	493.7 KB	744.4 KB	33%	6.0 KB
14	news.swapon.de	237.9 KB	0.0 KB	0.0 KB	237.9 KB	100%	2.3 KB
15	nntp.pasdenom.info	88.7 KB	0.0 KB	5.9 KB	94.6 KB	93%	1.9 KB
16	news.bbs.geek.nz	70.3 KB	0.0 KB	0.0 KB	70.3 KB	100%	1.6 KB
17	xanadu-bbs.net	24.0 KB	0.0 KB	14.1 KB	38.1 KB	63%	2.1 KB
18	localhost	6.0 KB	0.0 KB	0.0 KB	6.0 KB	100%	1.5 KB
TOTAL: 18		78.4 MB	672.2 KB	142.2 MB	221.2 MB	35%	4.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 16 04:15:00 - 04:59:59	537	2.0%	0.20	2.5 MB	3.2%	0.94
Jun 16 05:00:00 - 05:59:59	634	2.4%	0.18	2.1 MB	2.7%	0.61
Jun 16 06:00:00 - 06:59:59	855	3.2%	0.24	3.0 MB	3.9%	0.86
Jun 16 07:00:00 - 07:59:59	1214	4.6%	0.34	3.6 MB	4.6%	1.02
Jun 16 08:00:00 - 08:59:59	1195	4.5%	0.33	3.3 MB	4.2%	0.93
Jun 16 09:00:00 - 09:59:59	1395	5.3%	0.39	4.1 MB	5.3%	1.17
Jun 16 10:00:00 - 10:59:59	1215	4.6%	0.34	3.8 MB	4.8%	1.07
Jun 16 11:00:00 - 11:59:59	1241	4.7%	0.34	3.5 MB	4.5%	0.99
Jun 16 12:00:00 - 12:59:59	1365	5.2%	0.38	3.7 MB	4.7%	1.05
Jun 16 13:00:00 - 13:59:59	1362	5.1%	0.38	3.4 MB	4.3%	0.97
Jun 16 14:00:00 - 14:59:59	1539	5.8%	0.43	4.5 MB	5.7%	1.28
Jun 16 15:00:00 - 15:59:59	1718	6.5%	0.48	5.0 MB	6.4%	1.42
Jun 16 16:00:00 - 16:59:59	1667	6.3%	0.46	4.4 MB	5.7%	1.26
Jun 16 17:00:00 - 17:59:59	1321	5.0%	0.37	3.5 MB	4.5%	1.01
Jun 16 18:00:00 - 18:59:59	1293	4.9%	0.36	3.5 MB	4.5%	1.00
Jun 16 19:00:00 - 19:59:59	1231	4.6%	0.34	3.4 MB	4.3%	0.96
Jun 16 20:00:00 - 20:59:59	1256	4.7%	0.35	3.6 MB	4.6%	1.03
Jun 16 21:00:00 - 21:59:59	1186	4.5%	0.33	3.3 MB	4.2%	0.94
Jun 16 22:00:00 - 22:59:59	974	3.7%	0.27	3.2 MB	4.1%	0.92
Jun 16 23:00:00 - 23:59:59	778	2.9%	0.22	2.3 MB	2.9%	0.65
Jun 17 00:00:00 - 00:59:59	642	2.4%	0.18	2.2 MB	2.8%	0.63
Jun 17 01:00:00 - 01:59:59	551	2.1%	0.15	1.9 MB	2.4%	0.54
Jun 17 02:00:00 - 02:59:59	616	2.3%	0.17	2.0 MB	2.5%	0.56
Jun 17 03:00:00 - 03:59:59	566	2.1%	0.16	2.1 MB	2.6%	0.59
Jun 17 04:00:00 - 04:15:00	131	0.5%	0.15	452.4 KB	0.6%	0.50
TOTAL: 24:00:00	26482	100.0%	0.31	78.4 MB	100.0%	0.93

Sites sending bad articles:

Server		Total	Group	Duplic	TooOld	Other
1	csiph-out.feeder.erje.net	10943	498	9	0	10436
2	newsfeed.neva.ru	5035	1260	6	0	3769
3	usenet.blueworldhosting.com	1959	862	0	0	1097
4	feeder.eternal-september.org	1354	145	2	0	1207
5	newsfeed.fu-berlin.de	753	28	0	0	725
6	csiph-out.news.weretis.net	704	225	1	0	478
7	news-out.mixmin.net	436	2	3	0	431
8	news.freedyn.net	89	1	1	0	87
9	news.fcku.it	58	0	11	0	47
10	au2pb.net	52	37	0	0	15
11	news-out.aioe.org	31	21	0	0	10
12	news.swapon.de	26	0	0	0	26
13	newsfeeds.xmission.com	25	17	0	0	8
14	news.redatomik.org	8	0	0	0	8
15	xanadu-bbs.net	7	0	0	0	7
16	nntp.pasdenom.info	3	0	0	1	2
TOTAL: 16		21483	3096	33	1	18353

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	938
lada.talk	197
mailing.freebsd.pkg-fallout	117
mailing.freebsd.ports-bugs	78
ut.test	77
lada.auto	76
mailing.freebsd.svn-ports-all	52
mailing.freebsd.svn-ports-head	51
mpc.lists.nanog	48
mailing.openssl.cvs	48
mailing.gcc.gcc-cvs	44
alt.politics.scorched-earth	44
it-alt.sport.calcio.juventus	40
mailing.database.pgsql-general	38
fa.freebsd.cvs-all	36
mailing.freebsd.svn-src-all	36
24hoursupport.helpdesk	31
lada.photo	29
mailing.freebsd.kde	28
mozilla.dev.l10n	28
TOTAL: 252	3096

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12826
EMP (phn path)	1983
PFM bot misc	763
EMP (phl)	706
EMP (phn nph)	139
HTML Multipart	52
Too many newsgroups	35
Scoring filter (18)	25
Scoring filter (19)	22
User-issued cancel	20
Scoring filter (8)	18
Binary Payload	17
Scoring filter (10)	16
Scoring filter (17)	14
Scoring filter (16)	13
Scoring filter (14)	12
Scoring filter (15)	11
Scoring filter (12)	10
Scoring filter (11)	10
Scoring filter (21)	8
TOTAL: 37	16751

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	89	0	90	90
TOTAL: 1	89	0	90	90

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	114
	usenet.blueworldhosting.com	3
	TOTAL: 2	117
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	usenet.blueworldhosting.com	1
	TOTAL: 2	5
Huge articles
	feeder.eternal-september.org	129
	usenet.blueworldhosting.com	106
	csiph-out.news.weretis.net	83
	news.fcku.it	13
	news.freedyn.net	8
	news.redatomik.org	8
	newsfeeds.xmission.com	8
	news-out.mixmin.net	6
	au2pb.net	3
	newsfeed.fu-berlin.de	2
	TOTAL: 10	366
Including strange strings
	newsfeed.fu-berlin.de	383
	feeder.eternal-september.org	42
	csiph-out.feeder.erje.net	37
	news.swapon.de	26
	csiph-out.news.weretis.net	24
	news-out.aioe.org	8
	news-out.mixmin.net	6
	newsfeed.neva.ru	4
	news.fcku.it	4
	au2pb.net	2
	TOTAL: 11	537
No colon-space in header
	csiph-out.feeder.erje.net	581
	TOTAL: 1	581
TOTAL: 5		1606

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	49275	1224	24414	30	1	2%	23:59:55
2	news.freedyn.net	29394	1071	24845	17	1	3%	23:59:51
3	erje	24650	970	18822	17	0	3%	23:59:55
4	xanadu-bbs	29491	877	25586	1	0	2%	23:59:56
5	fu-berlin.de	24998	652	24346	0	0	2%	23:59:51
6	usenet.pasdenom.info	34107	255	25117	1065	2	0%	23:59:56
7	news.redatomik.org	28123	77	25409	6	0	0%	23:59:50
8	weretis.net	24518	71	23078	25	0	0%	23:59:56
9	au2pb	27298	60	25408	1	1	0%	23:59:56
10	aioe	25529	55	22510	14	0	0%	23:59:54
11	xmission	30078	37	25270	5	0	0%	23:59:56
12	news.mixmin.net	26689	10	23941	0	0	0%	23:59:56
13	bwh	21679	8	19191	0	49	0%	23:59:56
14	eternal-september	25060	8	21124	0	0	0%	23:59:56
15	news.fcku.it	3607	1	3261	0	0	0%	22:25:18
16	neva.ru	27612	1	23573	45	0	0%	23:59:56
17	news.swapon.de	2342	0	2090	7	0	0%	23:58:08
TOTAL: 17		434450	5377	357985	1233	54	1%	406:22:06

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	7.4 MB	106.2 KB	7.5 MB	0.1 KB/s	7.1 KB	23:59:51
2	xanadu-bbs	6.9 MB	8.4 KB	6.9 MB	0.1 KB/s	8.0 KB	23:59:56
3	fu-berlin.de	6.4 MB	0.0 KB	6.4 MB	0.1 KB/s	10.0 KB	23:59:51
4	erje	3.1 MB	249.0 KB	3.4 MB	0.0 KB/s	3.5 KB	23:59:55
5	news.bbs.geek.nz	2.8 MB	123.9 KB	2.9 MB	0.0 KB/s	2.4 KB	23:59:55
6	usenet.pasdenom.info	730.4 KB	7.3 MB	8.0 MB	0.1 KB/s	6.2 KB	23:59:56
7	weretis.net	167.4 KB	156.6 KB	324.0 KB	0.0 KB/s	3.4 KB	23:59:56
8	news.redatomik.org	166.3 KB	86.6 KB	252.9 KB	0.0 KB/s	3.0 KB	23:59:50
9	aioe	111.6 KB	47.3 KB	158.8 KB	0.0 KB/s	2.3 KB	23:59:54
10	au2pb	108.5 KB	37.3 KB	145.7 KB	0.0 KB/s	2.4 KB	23:59:56
11	xmission	86.1 KB	10.4 KB	96.4 KB	0.0 KB/s	2.3 KB	23:59:56
12	news.mixmin.net	59.3 KB	0.0 KB	59.3 KB	0.0 KB/s	5.9 KB	23:59:56
13	eternal-september	21.2 KB	0.0 KB	21.2 KB	0.0 KB/s	2.6 KB	23:59:56
14	bwh	19.0 KB	0.0 KB	19.0 KB	0.0 KB/s	2.4 KB	23:59:56
15	neva.ru	3.5 KB	125.5 KB	128.9 KB	0.0 KB/s	2.8 KB	23:59:56
16	news.fcku.it	2.3 KB	0.0 KB	2.3 KB	0.0 KB/s	2.3 KB	22:25:18
17	news.swapon.de	0.0 KB	46.0 KB	46.0 KB	0.0 KB/s	6.6 KB	23:58:08
TOTAL: 17		28.1 MB	8.2 MB	36.3 MB	0.0 KB/s	5.6 KB	406:22:06

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	98	425181	1.4 GB	542	0	0	30:42:18
2	202.89.176.220	288	69	176.6 KB	60	1	0	05:10:42
3	challenger.nielsenmedia.com	10	19	39.4 KB	3	0	0	02:53:12
4	dhcp-089-099-203-254.chello.nl	36	12	18.1 KB	4	0	0	10:25:30
5	68-185-181-64.dhcp.mdsn.wi.charter.com	24	5	7.9 KB	5	3	3	06:29:50
6	92-108-162-83.dynamic.upc.nl	2	3	4.3 KB	1	0	0	00:03:02
7	tempe0.bbox.io	43	3	4.0 KB	3	0	0	09:27:40
8	71.98.160.36	3	1	2.4 KB	1	0	0	00:51:31
TOTAL: 8		504	425293	1.4 GB	619	4	3	83:53:42

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	98	425181	1.4 GB	542	0	0	30:42:18
2	unresolved	295	70	179.0 KB	61	1	0	23:52:07
3	*.nielsenmedia.com	10	19	39.4 KB	3	0	0	02:53:12
4	*.chello.nl	36	12	18.1 KB	4	0	0	10:25:30
5	*.dhcp.mdsn.wi.charter.com	24	5	7.9 KB	5	3	3	06:29:50
6	*.dynamic.upc.nl	2	3	4.3 KB	1	0	0	00:03:02
7	*.bbox.io	43	3	4.0 KB	3	0	0	09:27:40
TOTAL: 7		508	425293	1.4 GB	619	4	3	83:53:42

NNRP auth users [Top 20]:

User	Conn
moussa	288
ohlandl	3
TOTAL: 2	291

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	69.738	107.789	0.000	30:42:18
216.239.174.71	0.750	0.604	0.000	17:49:53
dhcp-089-099-203-254.chello.nl	3.044	0.715	0.000	10:25:30
tempe0.bbox.io	3.515	0.891	0.000	09:27:40
68-185-181-64.dhcp.mdsn.wi.charter.com	2.333	0.569	0.006	06:29:50
202.89.176.220	28.940	7.605	0.743	05:10:42
challenger.nielsenmedia.com	1.037	0.216	0.000	02:53:12
71.98.160.36	0.250	0.040	0.000	00:51:31
92-108-162-83.dynamic.upc.nl	0.187	0.031	0.000	00:03:02
TOTAL: 9	109.794	118.460	0.749	83:53:42

Curious NNRP server explorers [Top 20]:

System	Conn
216.239.174.71	4
TOTAL: 1	4

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	368410	100.0%
2	comp	113	0.0%
3	rec	5	0.0%
TOTAL: 3		368528	100.0%

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

Newsgroup		Count
1	alt.fan.rush-limbaugh	260462
2	alt.usenet.kooks	107947
3	comp.os.vms	31
4	comp.sys.ibm.ps2.hardware	27
5	comp.lang.awk	20
6	comp.arch	12
7	comp.os.os2.misc	4
8	comp.os.os2.apps	4
9	comp.arch.embedded	4
10	comp.sys.ibm.as400.misc	2
11	comp.arch.fpga	2
12	rec.arts.tv	2
13	rec.outdoors.rv-travel	1
14	comp.os.os2.announce	1
15	comp.sys.mac.system	1
16	comp.sys.ibm.pc.games.rpg	1
17	comp.windows.x.kde	1
18	comp.ai.philosophy	1
19	rec.arts.drwho	1
20	comp.os.msdos.djgpp	1
21	comp.unix.aix	1
22	alt.home.repair	1
23	rec.sport.golf	1
TOTAL: 23		368528

Daily Usenet report for csiph.com

Jun 16 04:15:00 -- Jun 17 04:15:00