Daily Usenet report for csiph.com: Mar 23 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	43708	42.6%	8.6 MB	60.0%
nnrpd	33825	33.0%	2.8 MB	19.9%
innd	21731	21.2%	2.4 MB	16.5%
innfeed	3285	3.2%	525.9 KB	3.6%
nocem	83	0.1%	8.2 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	102633	100.0%	14.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	507516	58.0%
Negative hits	307905	35.2%
Do not exist	43340	5.0%
Cache misses	16512	1.9%
TOTAL: 4	875273	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.392	0.0%	260	0.000	1.508	62.500
article cleanup	00:00:00.247	0.0%	42268	0.000	0.006	0.019
article logging	00:00:00.560	0.0%	42827	0.000	0.013	0.088
article parse	00:00:01.732	0.0%	174162	0.003	0.010	0.040
article write	00:00:58.674	0.1%	25547	0.181	2.297	18.657
artlog/artcncl	00:00:00.002	0.0%	181	0.000	0.011	0.500
artlog/artparse	00:00:00.009	0.0%	703	0.000	0.013	0.125
data move	00:00:00.312	0.0%	842827	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.006	0.0%	257	0.000	0.023	1.000
hishave/artcncl	00:00:00.001	0.0%	260	0.000	0.004	0.100
hishave/artparse	00:00:00.002	0.0%	474	0.000	0.004	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.599	0.0%	882690	0.001	0.004	0.101
history sync	00:00:00.866	0.0%	335	0.000	2.585	12.000
history write	00:00:27.247	0.0%	42378	0.083	0.643	6.519
hiswrite/artcncl	00:00:00.013	0.0%	3	4.333	4.333	4.333
hiswrite/artparse	00:00:00.237	0.0%	474	0.000	0.500	9.000
idle	23:55:27.399	99.6%	857956	45.252	100.387	260.679
nntp read	00:00:02.865	0.0%	864954	0.001	0.003	0.005
overview write	00:01:05.497	0.1%	25547	0.309	2.564	22.602
perl filter	00:01:39.093	0.1%	42138	1.545	2.352	3.903
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.439	0.0%	51169	0.000	0.009	0.026
TOTAL: 24:00:43.940	23:59:49.192	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.081	0.0%	42138	0.000	0.002	0.016
article prepare	00:00:00.005	0.0%	36420	0.000	0.000	0.005
article read	00:00:02.979	0.0%	4921	0.000	0.605	7.663
backlog stats	00:00:00.276	0.0%	584627	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.024	0.0%	417028	0.001	0.005	0.009
data write	00:00:02.761	0.0%	406674	0.003	0.007	0.013
idle	23:53:26.365	100.0%	584627	42.109	147.113	402.330
status file	00:00:00.230	0.0%	334	0.000	0.689	1.600
TOTAL: 23:53:47.455	23:53:34.721	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.853	0.0%	16152	0.004	0.053	0.109
idle	79:37:16.036	99.4%	49199	45.000	5826.054	600169.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.560	0.0%	99322	0.000	0.006	0.071
readart	00:00:00.514	0.0%	78	0.000	6.590	74.000
TOTAL: 80:04:01.813	79:37:17.963	99.4%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	288	29832	6031	21348	2453	20%	23:44:51
2	csiph-out.feeder.erje.net	1152	96711	4600	88597	3514	4%	95:07:35
3	csiph-out.news.weretis.net	3	56119	3091	52013	1015	5%	49:11:52
4	feeder.eternal-september.org	8	30604	2249	27808	547	7%	11:36:08
5	news-out.aioe.org	4	23994	2222	21744	28	9%	24:09:45
6	newsfeed.neva.ru	144	58707	2009	51820	4878	3%	72:02:46
7	news-out.mixmin.net	2	29823	1723	26094	2006	5%	24:38:22
8	newsfeed.fu-berlin.de	54	29255	1202	27655	398	4%	33:05:47
9	news.fcku.it	1	11172	603	10562	7	5%	26:19:53
10	news.freedyn.net	3	29389	562	28484	343	1%	24:09:56
11	newsfeeds.xmission.com	1	22616	494	22108	14	2%	22:05:49
12	au2pb.net	1	36068	351	35642	75	0%	31:29:42
13	xanadu-bbs.net	3	37343	166	33155	4022	0%	22:06:02
14	news.redatomik.org	1	24840	96	24742	2	0%	22:40:04
15	nntp.pasdenom.info	6	24952	81	24856	15	0%	26:32:17
16	news.swapon.de	2	1596	59	1537	0	3%	23:17:05
17	news.bbs.geek.nz	2	22725	22	22702	1	0%	20:34:13
18	localhost	45	10	10	0	0	100%	00:00:00
TOTAL: 18		1720	565756	25571	520867	19318	4%	552:52:07

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	17.9 MB	109.7 KB	4.7 MB	22.7 MB	78%	2.9 KB
2	usenet.blueworldhosting.com	17.5 MB	40.8 KB	23.3 MB	40.8 MB	42%	4.9 KB
3	csiph-out.news.weretis.net	8.8 MB	0.0 KB	21.4 MB	30.2 MB	29%	7.5 KB
4	news-out.mixmin.net	6.3 MB	1.1 KB	3.5 MB	9.8 MB	64%	2.7 KB
5	newsfeed.neva.ru	5.5 MB	3.4 KB	40.9 MB	46.5 MB	11%	6.9 KB
6	feeder.eternal-september.org	5.3 MB	67.6 KB	5.3 MB	10.7 MB	49%	3.9 KB
7	news-out.aioe.org	5.3 MB	0.0 KB	49.6 KB	5.3 MB	99%	2.4 KB
8	newsfeed.fu-berlin.de	2.8 MB	0.0 KB	967.0 KB	3.7 MB	74%	2.4 KB
9	news.freedyn.net	1.6 MB	5.1 KB	2.2 MB	3.8 MB	42%	4.3 KB
10	newsfeeds.xmission.com	1.2 MB	0.0 KB	229.6 KB	1.4 MB	84%	2.9 KB
11	news.fcku.it	1.2 MB	1.4 KB	46.1 KB	1.2 MB	96%	2.0 KB
12	au2pb.net	998.1 KB	0.0 KB	348.9 KB	1.3 MB	74%	3.2 KB
13	xanadu-bbs.net	415.3 KB	5.4 KB	37.9 MB	38.4 MB	1%	9.4 KB
14	news.redatomik.org	357.6 KB	0.0 KB	148.9 KB	506.5 KB	70%	5.2 KB
15	nntp.pasdenom.info	289.5 KB	1.2 KB	36.1 KB	326.8 KB	88%	3.4 KB
16	news.swapon.de	141.3 KB	0.0 KB	0.0 KB	141.3 KB	100%	2.4 KB
17	news.bbs.geek.nz	33.0 KB	0.0 KB	1.6 KB	34.6 KB	95%	1.5 KB
18	localhost	14.1 KB	0.0 KB	0.0 KB	14.1 KB	100%	1.4 KB
TOTAL: 18		75.5 MB	235.7 KB	141.1 MB	216.9 MB	34%	4.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 23 04:15:00 - 04:59:59	464	1.8%	0.17	1.4 MB	1.9%	0.55
Mar 23 05:00:00 - 05:59:59	596	2.3%	0.17	1.9 MB	2.6%	0.55
Mar 23 06:00:00 - 06:59:59	590	2.3%	0.16	1.9 MB	2.5%	0.54
Mar 23 07:00:00 - 07:59:59	897	3.5%	0.25	3.0 MB	4.0%	0.85
Mar 23 08:00:00 - 08:59:59	1140	4.5%	0.32	3.3 MB	4.3%	0.93
Mar 23 09:00:00 - 09:59:59	1423	5.6%	0.40	4.8 MB	6.4%	1.37
Mar 23 10:00:00 - 10:59:59	1282	5.0%	0.36	3.3 MB	4.3%	0.93
Mar 23 11:00:00 - 11:59:59	1294	5.1%	0.36	3.4 MB	4.5%	0.96
Mar 23 12:00:00 - 12:59:59	1294	5.1%	0.36	3.5 MB	4.7%	1.00
Mar 23 13:00:00 - 13:59:59	1252	4.9%	0.35	3.4 MB	4.6%	0.97
Mar 23 14:00:00 - 14:59:59	1172	4.6%	0.33	3.2 MB	4.2%	0.90
Mar 23 15:00:00 - 15:59:59	1168	4.6%	0.32	3.1 MB	4.1%	0.87
Mar 23 16:00:00 - 16:59:59	1285	5.0%	0.36	4.1 MB	5.4%	1.16
Mar 23 17:00:00 - 17:59:59	1255	4.9%	0.35	3.9 MB	5.2%	1.12
Mar 23 18:00:00 - 18:59:59	1247	4.9%	0.35	3.8 MB	5.1%	1.09
Mar 23 19:00:00 - 19:59:59	1315	5.1%	0.37	3.9 MB	5.2%	1.12
Mar 23 20:00:00 - 20:59:59	1285	5.0%	0.36	4.0 MB	5.3%	1.14
Mar 23 21:00:00 - 21:59:59	1110	4.3%	0.31	3.5 MB	4.6%	0.99
Mar 23 22:00:00 - 22:59:59	992	3.9%	0.28	3.2 MB	4.2%	0.91
Mar 23 23:00:00 - 23:59:59	831	3.3%	0.23	2.6 MB	3.5%	0.74
Mar 24 00:00:00 - 00:59:59	596	2.3%	0.17	2.0 MB	2.7%	0.57
Mar 24 01:00:00 - 01:59:59	463	1.8%	0.13	1.5 MB	2.0%	0.42
Mar 24 02:00:00 - 02:59:59	463	1.8%	0.13	1.2 MB	1.6%	0.35
Mar 24 03:00:00 - 03:59:59	1996	7.8%	0.55	4.8 MB	6.3%	1.35
Mar 24 04:00:00 - 04:15:00	136	0.5%	0.15	569.3 KB	0.7%	0.63
TOTAL: 24:00:00	25546	100.0%	0.30	75.2 MB	100.0%	0.89

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.neva.ru	4878	1041	2	0	3835
2	xanadu-bbs.net	4188	25	4	0	4159
3	usenet.blueworldhosting.com	2450	1026	21	5	1398
4	news-out.mixmin.net	2013	5	1	0	2007
5	csiph-out.feeder.erje.net	1461	269	43	0	1149
6	csiph-out.news.weretis.net	1061	254	0	0	807
7	newsfeed.fu-berlin.de	808	31	0	0	777
8	feeder.eternal-september.org	595	80	38	0	477
9	news.freedyn.net	346	3	2	0	341
10	au2pb.net	61	53	0	0	8
11	news-out.aioe.org	39	26	0	0	13
12	newsfeeds.xmission.com	23	15	4	0	4
13	news.swapon.de	23	0	2	0	21
14	nntp.pasdenom.info	17	8	1	0	8
15	news.fcku.it	11	0	1	0	10
16	news.bbs.geek.nz	4	2	0	0	2
17	news.redatomik.org	3	0	0	0	3
TOTAL: 17		17981	2838	119	5	15019

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	680
mailing.freebsd.pkg-fallout	154
lada.talk	146
lada.auto	80
ut.test	68
mailing.freebsd.svn-ports-all	68
mailing.freebsd.svn-ports-head	66
mailing.freebsd.ports-bugs	59
it-alt.sport.calcio.juventus	55
alt.philosophy	38
gmane.linux.alsa.devel	37
alt.windows7.general	36
mailing.gcc.gcc-cvs	33
mailing.database.pgsql-bugs	31
fa.linux.680x0	30
mailing.freebsd.svn-src-all	30
fa.freebsd.cvs-all	29
mailing.freebsd.svn-src-head	28
mailing.openbsd.ports-changes	26
cakewalk.audio	25
TOTAL: 236	2838

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

Groups	Count
alt.culture.china	3
it.scienza.astronomia	2
TOTAL: 2	5

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9790
EMP (phn path)	1909
EMP (phl)	800
PFM bot misc	244
EMP (phn nph)	225
Binary: misplaced rar	210
Scoring filter (8)	46
HTML Multipart	40
Too many newsgroups	40
Scoring filter (25)	40
Scoring filter (18)	36
Scoring filter (23)	25
Scoring filter (21)	24
Scoring filter (19)	23
Scoring filter (14)	23
Scoring filter (10)	22
User-issued cancel	22
Scoring filter (12)	21
Scoring filter (20)	21
Binary Payload	20
TOTAL: 41	13747

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	74	0	75	75
TOTAL: 1	74	0	75	75

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	8
	usenet.blueworldhosting.com	3
	TOTAL: 2	11
Huge articles
	csiph-out.news.weretis.net	224
	xanadu-bbs.net	98
	usenet.blueworldhosting.com	98
	feeder.eternal-september.org	27
	news.freedyn.net	16
	news-out.mixmin.net	4
	news.redatomik.org	3
	newsfeed.fu-berlin.de	2
	newsfeeds.xmission.com	2
	TOTAL: 9	474
Including strange strings
	newsfeed.fu-berlin.de	422
	csiph-out.news.weretis.net	36
	csiph-out.feeder.erje.net	23
	news.swapon.de	20
	news-out.mixmin.net	17
	feeder.eternal-september.org	11
	news-out.aioe.org	10
	news.fcku.it	4
	newsfeed.neva.ru	4
	au2pb.net	2
	TOTAL: 15	558
No colon-space in header
	csiph-out.feeder.erje.net	228
	usenet.blueworldhosting.com	1
	TOTAL: 2	229
TOTAL: 4		1272

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	45508	1804	22655	23	4	3%	23:59:51
2	xanadu-bbs	27984	1511	23848	3	110	5%	23:59:52
3	news.freedyn.net	29542	1284	23675	8	4	4%	23:59:51
4	fu-berlin.de	24091	911	23178	0	2	3%	23:59:47
5	aioe	25621	670	20280	15	3	2%	23:59:51
6	usenet.pasdenom.info	32775	384	23642	1482	492	1%	23:58:43
7	news.redatomik.org	30437	238	23915	22	1256	0%	23:59:51
8	xmission	30295	233	23873	17	1	0%	23:59:43
9	au2pb	24959	102	24166	17	1	0%	23:59:52
10	weretis.net	21482	35	20967	4	124	0%	23:59:51
11	erje	21204	30	20695	12	14	0%	23:59:52
12	news.fcku.it	4139	30	3203	6	0	0%	22:20:15
13	neva.ru	27963	26	21967	204	2	0%	23:59:17
14	news.mixmin.net	27409	24	22249	0	52	0%	23:59:51
15	eternal-september	24256	20	22317	0	13523	0%	23:59:52
16	bwh	19469	11	18398	0	0	0%	23:59:51
17	news.swapon.de	2114	8	1732	5	0	0%	23:58:32
TOTAL: 17		419248	7321	340760	1818	15588	1%	406:14:42

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	9.8 MB	10.0 KB	9.8 MB	0.1 KB/s	6.6 KB	23:59:52
2	news.freedyn.net	9.5 MB	72.6 KB	9.5 MB	0.1 KB/s	7.6 KB	23:59:51
3	fu-berlin.de	8.5 MB	0.0 KB	8.5 MB	0.1 KB/s	9.6 KB	23:59:47
4	news.bbs.geek.nz	4.4 MB	53.8 KB	4.5 MB	0.1 KB/s	2.5 KB	23:59:51
5	aioe	1.7 MB	78.1 KB	1.8 MB	0.0 KB/s	2.7 KB	23:59:51
6	usenet.pasdenom.info	1.3 MB	9.5 MB	10.8 MB	0.1 KB/s	5.9 KB	23:58:43
7	news.redatomik.org	656.5 KB	54.9 KB	711.4 KB	0.0 KB/s	2.7 KB	23:59:51
8	xmission	501.4 KB	46.1 KB	547.6 KB	0.0 KB/s	2.2 KB	23:59:43
9	au2pb	273.5 KB	56.7 KB	330.3 KB	0.0 KB/s	2.8 KB	23:59:52
10	erje	130.1 KB	48.3 KB	178.4 KB	0.0 KB/s	4.2 KB	23:59:52
11	neva.ru	84.2 KB	773.1 KB	857.4 KB	0.0 KB/s	3.7 KB	23:59:17
12	weretis.net	74.3 KB	50.0 KB	124.3 KB	0.0 KB/s	3.2 KB	23:59:51
13	news.fcku.it	73.8 KB	8.7 KB	82.5 KB	0.0 KB/s	2.3 KB	22:20:15
14	eternal-september	70.4 KB	0.0 KB	70.4 KB	0.0 KB/s	3.5 KB	23:59:52
15	news.mixmin.net	57.8 KB	0.0 KB	57.8 KB	0.0 KB/s	2.4 KB	23:59:51
16	bwh	16.2 KB	0.0 KB	16.2 KB	0.0 KB/s	1.5 KB	23:59:51
17	news.swapon.de	12.7 KB	8.6 KB	21.3 KB	0.0 KB/s	1.6 KB	23:58:32
TOTAL: 17		37.1 MB	10.7 MB	47.8 MB	0.0 KB/s	5.4 KB	406:14:42

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	287	34	68.5 KB	33	2	0	04:50:43
2	68-185-181-64.dhcp.mdsn.wi.charter.com	32	28	41.5 KB	11	7	6	07:56:15
3	tempe0.bbox.io	57	12	17.3 KB	6	1	1	09:07:00
4	dhcp-089-099-203-254.chello.nl	16	4	5.2 KB	1	0	0	05:53:05
TOTAL: 4		392	78	132.5 KB	51	10	7	80:03:57

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	352	34	68.5 KB	33	2	0	54:46:17
2	*.dhcp.mdsn.wi.charter.com	32	28	41.5 KB	11	7	6	07:56:15
3	*.bbox.io	57	12	17.3 KB	6	1	1	09:07:00
4	*.chello.nl	16	4	5.2 KB	1	0	0	05:53:05
5	*.nielsenmedia.com	4	0	0.0 KB	0	0	0	01:18:32
6	*.tampfl.dsl-w.verizon.net	2	0	0.0 KB	0	0	0	01:02:44
7	*.208-100-26.static.steadfastdns.net	2	0	0.0 KB	0	0	0	00:00:01
TOTAL: 7		465	78	132.5 KB	51	10	7	80:03:57

NNRP auth users [Top 20]:

User	Conn
moussa	287
ohlandl	6
kev009	1
TOTAL: 3	294

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.153	0.960	0.604	0.000	33:11:11
63.142.120.8	3.665	1.263	0.000	15:43:16
tempe0.bbox.io	5.347	1.211	0.003	09:07:00
68-185-181-64.dhcp.mdsn.wi.charter.com	3.219	0.711	0.015	07:56:15
dhcp-089-099-203-254.chello.nl	1.357	0.266	0.000	05:53:05
202.89.176.220	27.432	7.358	0.768	04:50:43
challenger.nielsenmedia.com	0.339	0.056	0.000	01:18:32
pool-71-98-160-36.tampfl.dsl-w.verizon.net	0.158	0.063	0.000	01:02:44
138.108.60.60	0.184	0.047	0.000	01:00:59
94.160.219.132	0.126	0.045	0.000	00:00:01
94.166.93.77	0.064	0.016	0.000	00:00:01
ip230.208-100-26.static.steadfastdns.net	0.136	0.016	0.000	00:00:01
5.87.80.210	0.065	0.016	0.000	00:00:01
94.167.133.99	0.105	0.008	0.000	00:00:01
TOTAL: 14	43.157	11.680	0.786	80:03:57

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	50
162.212.88.153	8
challenger.nielsenmedia.com	4
138.108.60.60	2
ip230.208-100-26.static.steadfastdns.net	2
94.160.219.132	2
pool-71-98-160-36.tampfl.dsl-w.verizon.net	2
94.167.133.99	1
94.166.93.77	1
5.87.80.210	1
TOTAL: 10	73

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	10	0
tempe0.bbox.io	10	0
68-185-181-64.dhcp.mdsn.wi.charter.com	8	0
pool-71-98-160-36.tampfl.dsl-w.verizon.net	2	0
challenger.nielsenmedia.com	2	0
138.108.60.60	2	0
TOTAL: 6	34	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	55
2	comp.ai.neural-nets	6
3	comp.os.vms	6
4	comp.sys.ibm.pc.games.action	3
5	comp.arch	2
6	comp.sys.ibm.as400.misc	2
7	comp.ai.nat-lang	1
8	comp.ai.philosophy	1
9	comp.os.cpm	1
10	comp.sys.ibm.pc.games.war-historical	1
TOTAL: 10		78

Daily Usenet report for csiph.com

Mar 23 04:15:00 -- Mar 24 04:15:00