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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	48544	40.2%	9.3 MB	56.9%
nnrpd	43831	36.3%	3.9 MB	23.7%
innd	25031	20.7%	2.6 MB	16.0%
innfeed	3240	2.7%	550.7 KB	3.3%
nocem	139	0.1%	13.9 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	120786	100.0%	16.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	565060	54.9%
Negative hits	414843	40.3%
Do not exist	48440	4.7%
Cache misses	742	0.1%
TOTAL: 4	1029085	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.432	0.0%	296	0.000	1.459	22.714
article cleanup	00:00:00.274	0.0%	47434	0.000	0.006	0.033
article logging	00:00:00.788	0.0%	47904	0.000	0.016	0.445
article parse	00:00:02.033	0.0%	198837	0.002	0.010	0.038
article write	00:00:53.769	0.1%	27644	0.165	1.945	20.269
artlog/artcncl	00:00:00.002	0.0%	209	0.000	0.010	0.143
artlog/artparse	00:00:00.002	0.0%	424	0.000	0.005	0.143
data move	00:00:00.420	0.0%	1018852	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.057	0.0%	295	0.000	0.193	12.000
hishave/artcncl	00:00:00.004	0.0%	296	0.000	0.014	1.000
hishave/artparse	00:00:00.001	0.0%	421	0.000	0.002	0.077
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:10.744	0.0%	1030397	0.001	0.010	0.182
history sync	00:00:02.192	0.0%	330	0.000	6.642	103.500
history write	00:00:59.689	0.1%	47392	0.058	1.259	24.920
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.321	0.0%	419	0.000	0.766	19.000
idle	23:53:54.785	99.5%	1035216	49.156	83.108	294.424
nntp read	00:00:03.462	0.0%	1041509	0.001	0.003	0.006
overview write	00:01:24.034	0.1%	27644	0.403	3.040	52.327
perl filter	00:02:04.611	0.1%	47372	1.565	2.630	4.107
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.501	0.0%	55422	0.000	0.009	0.031
TOTAL: 24:00:43.708	23:59:38.121	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.069	0.0%	28610	0.000	0.002	0.017
article prepare	00:00:00.005	0.0%	57148	0.000	0.000	0.004
article read	00:00:02.500	0.0%	8711	0.000	0.287	11.000
backlog stats	00:00:00.307	0.0%	649989	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.436	0.0%	465829	0.002	0.005	0.012
data write	00:00:03.291	0.0%	457636	0.004	0.007	0.013
idle	23:52:52.292	100.0%	649989	70.512	132.267	523.403
status file	00:00:00.191	0.0%	285	0.000	0.670	1.500
TOTAL: 23:53:10.089	23:53:01.091	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.556	0.0%	6805	0.076	0.082	0.086
idle	45:38:49.133	99.2%	63579	78.103	2584.645	600171.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.822	0.0%	128369	0.000	0.014	5.363
readart	00:00:20.122	0.0%	17929	0.000	1.122	62.000
TOTAL: 46:01:33.062	45:39:11.633	99.2%	-	-	-	-

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	34708	5369	26618	2721	15%	23:45:19
2	news-out.mixmin.net	4	33319	5331	25383	2605	15%	24:17:57
3	csiph-out.feeder.erje.net	1152	109698	3369	101607	4722	3%	94:58:35
4	feeder.eternal-september.org	1	42399	3287	36465	2647	7%	23:59:57
5	csiph-out.news.weretis.net	3	69739	3200	64806	1733	4%	54:11:56
6	newsfeed.neva.ru	144	47738	1959	39025	6754	4%	71:16:15
7	news-out.aioe.org	3	26923	1577	25323	23	5%	24:12:04
8	newsfeed.fu-berlin.de	33	28931	1204	27077	650	4%	28:21:42
9	newsfeeds.xmission.com	1	26429	863	25549	17	3%	24:00:33
10	news.freedyn.net	3	33379	607	32562	210	1%	24:10:08
11	news.fcku.it	2	11119	407	10707	5	3%	28:30:28
12	au2pb.net	1	28880	157	28671	52	0%	26:13:07
13	news.swapon.de	5	2163	115	2044	4	5%	23:39:29
14	news.redatomik.org	1	25009	112	24892	5	0%	22:40:03
15	nntp.pasdenom.info	14	27098	109	26973	16	0%	29:58:24
16	xanadu-bbs.net	1	39589	53	38671	865	0%	21:55:05
17	news.bbs.geek.nz	3	24447	9	24437	1	0%	24:08:47
18	localhost	37	5	5	0	0	100%	00:00:00
TOTAL: 18		1696	611573	27733	560810	23030	4%	570:19:49

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.mixmin.net	22.9 MB	14.7 KB	11.6 MB	34.5 MB	66%	4.5 KB
2	csiph-out.feeder.erje.net	16.1 MB	30.5 KB	6.9 MB	23.0 MB	69%	2.9 KB
3	usenet.blueworldhosting.com	15.4 MB	0.0 KB	26.8 MB	42.2 MB	36%	5.3 KB
4	csiph-out.news.weretis.net	15.2 MB	0.0 KB	21.2 MB	36.5 MB	41%	7.6 KB
5	feeder.eternal-september.org	8.6 MB	51.1 KB	26.0 MB	34.7 MB	24%	6.0 KB
6	newsfeed.neva.ru	7.4 MB	64.5 KB	52.4 MB	59.9 MB	12%	7.0 KB
7	news-out.aioe.org	3.7 MB	0.0 KB	28.7 KB	3.7 MB	99%	2.4 KB
8	newsfeed.fu-berlin.de	3.2 MB	0.0 KB	1.6 MB	4.8 MB	67%	2.6 KB
9	newsfeeds.xmission.com	2.3 MB	0.0 KB	340.9 KB	2.6 MB	87%	3.1 KB
10	news.freedyn.net	2.0 MB	7.5 KB	1.8 MB	3.8 MB	52%	4.7 KB
11	news.fcku.it	740.2 KB	0.0 KB	91.6 KB	831.8 KB	88%	2.0 KB
12	nntp.pasdenom.info	494.9 KB	1.3 KB	216.0 KB	712.1 KB	69%	5.7 KB
13	au2pb.net	487.4 KB	0.0 KB	152.8 KB	640.2 KB	76%	3.1 KB
14	news.redatomik.org	369.8 KB	0.0 KB	92.7 KB	462.5 KB	79%	4.0 KB
15	news.swapon.de	327.9 KB	0.0 KB	427.7 KB	755.6 KB	43%	6.3 KB
16	xanadu-bbs.net	116.4 KB	90.3 KB	8.3 MB	8.5 MB	1%	9.5 KB
17	news.bbs.geek.nz	21.2 KB	0.0 KB	4.9 KB	26.1 KB	81%	2.6 KB
18	localhost	7.2 KB	0.0 KB	0.0 KB	7.2 KB	100%	1.4 KB
TOTAL: 18		99.3 MB	259.8 KB	157.9 MB	257.4 MB	38%	5.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 12 04:15:00 - 04:59:59	271	1.0%	0.10	992.7 KB	1.0%	0.37
Mar 12 05:00:00 - 05:59:59	478	1.7%	0.13	1.4 MB	1.4%	0.39
Mar 12 06:00:00 - 06:59:59	538	1.9%	0.15	1.9 MB	2.0%	0.55
Mar 12 07:00:00 - 07:59:59	747	2.7%	0.21	2.4 MB	2.4%	0.68
Mar 12 08:00:00 - 08:59:59	982	3.6%	0.27	3.0 MB	3.1%	0.87
Mar 12 09:00:00 - 09:59:59	954	3.5%	0.27	2.8 MB	2.9%	0.80
Mar 12 10:00:00 - 10:59:59	1064	3.8%	0.30	2.8 MB	2.9%	0.80
Mar 12 11:00:00 - 11:59:59	1094	4.0%	0.30	3.2 MB	3.2%	0.90
Mar 12 12:00:00 - 12:59:59	1232	4.5%	0.34	3.3 MB	3.4%	0.94
Mar 12 13:00:00 - 13:59:59	1238	4.5%	0.34	3.7 MB	3.8%	1.05
Mar 12 14:00:00 - 14:59:59	1089	3.9%	0.30	3.1 MB	3.2%	0.88
Mar 12 15:00:00 - 15:59:59	1472	5.3%	0.41	5.0 MB	5.1%	1.43
Mar 12 16:00:00 - 16:59:59	1827	6.6%	0.51	7.9 MB	8.0%	2.24
Mar 12 17:00:00 - 17:59:59	1748	6.3%	0.49	6.3 MB	6.4%	1.79
Mar 12 18:00:00 - 18:59:59	1695	6.1%	0.47	6.4 MB	6.5%	1.82
Mar 12 19:00:00 - 19:59:59	1729	6.3%	0.48	6.4 MB	6.5%	1.81
Mar 12 20:00:00 - 20:59:59	1927	7.0%	0.54	8.1 MB	8.3%	2.30
Mar 12 21:00:00 - 21:59:59	1938	7.0%	0.54	7.6 MB	7.8%	2.17
Mar 12 22:00:00 - 22:59:59	1468	5.3%	0.41	5.5 MB	5.6%	1.57
Mar 12 23:00:00 - 23:59:59	1116	4.0%	0.31	4.4 MB	4.5%	1.25
Mar 13 00:00:00 - 00:59:59	849	3.1%	0.24	3.2 MB	3.3%	0.91
Mar 13 01:00:00 - 01:59:59	777	2.8%	0.22	3.1 MB	3.1%	0.87
Mar 13 02:00:00 - 02:59:59	718	2.6%	0.20	3.0 MB	3.0%	0.85
Mar 13 03:00:00 - 03:59:59	565	2.0%	0.16	2.0 MB	2.0%	0.56
Mar 13 04:00:00 - 04:15:00	132	0.5%	0.15	751.1 KB	0.7%	0.83
TOTAL: 24:00:00	27648	100.0%	0.32	98.1 MB	100.0%	1.16

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.neva.ru	6831	761	11	0	6059
2	usenet.blueworldhosting.com	2721	1071	0	2	1648
3	feeder.eternal-september.org	2679	158	5	0	2516
4	news-out.mixmin.net	2674	8	6	0	2660
5	csiph-out.news.weretis.net	1730	146	0	0	1584
6	csiph-out.feeder.erje.net	1711	263	6	1	1441
7	newsfeed.fu-berlin.de	1023	51	2	0	970
8	xanadu-bbs.net	945	7	11	0	927
9	news.freedyn.net	213	1	2	0	210
10	au2pb.net	51	48	0	0	3
11	news-out.aioe.org	31	23	0	0	8
12	news.swapon.de	27	0	0	0	27
13	newsfeeds.xmission.com	19	12	0	0	7
14	nntp.pasdenom.info	16	8	1	0	7
15	news.fcku.it	9	0	0	0	9
16	news.redatomik.org	4	0	0	0	4
17	news.bbs.geek.nz	3	2	1	0	0
TOTAL: 17		20687	2559	45	3	18080

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.pkg-fallout	253
fa.linux.kernel	234
ut.test	230
lada.talk	114
mailing.freebsd.ports-bugs	104
lada.auto	95
mailing.freebsd.svn-src-all	84
fa.freebsd.cvs-all	83
mailing.freebsd.svn-ports-head	77
mailing.freebsd.svn-ports-all	77
alt.windows7.general	66
it-alt.sport.calcio.juventus	53
mailing.freebsd.svn-src-stable	52
alt.politics.scorched-earth	48
mailing.openssl.cvs	45
mailing.database.pgsql-general	41
alt.survival	38
mailing.freebsd.svn-src-stable-10	36
mailing.freebsd.svn-src-head	32
24hoursupport.helpdesk	27
TOTAL: 202	2559

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

Groups	Count
alt.binaries.pictures.guns	1
nz.politics.announce	1
alt.culture.china	1
TOTAL: 3	3

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	10697
EMP (phn path)	4575
EMP (phl)	969
PFM bot misc	373
EMP (phn nph)	232
Scoring filter (8)	41
Scoring filter (18)	40
HTML Multipart	37
Too many newsgroups	30
Scoring filter (10)	28
Scoring filter (19)	17
Scoring filter (9)	15
User-issued cancel	14
Binary Payload	14
Too many newsgroups (low_xpost)	13
Binary: misplaced rar	11
Scoring filter (21)	10
HTML post	9
Scoring filter (15)	9
Scoring filter (20)	7
TOTAL: 37	17169

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	133	0	136	136
TOTAL: 1	133	0	136	136

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	14
	usenet.blueworldhosting.com	3
	TOTAL: 2	17
Huge articles
	news-out.mixmin.net	143
	csiph-out.news.weretis.net	135
	usenet.blueworldhosting.com	64
	feeder.eternal-september.org	32
	xanadu-bbs.net	17
	news.freedyn.net	16
	newsfeeds.xmission.com	4
	nntp.pasdenom.info	3
	news.swapon.de	2
	news.redatomik.org	2
	TOTAL: 12	421
Including strange strings
	newsfeed.fu-berlin.de	334
	news-out.mixmin.net	33
	feeder.eternal-september.org	27
	news.swapon.de	23
	csiph-out.feeder.erje.net	20
	csiph-out.news.weretis.net	12
	news-out.aioe.org	7
	newsfeed.neva.ru	6
	news.fcku.it	4
	newsfeeds.xmission.com	3
	TOTAL: 11	470
No colon-space in header
	usenet.blueworldhosting.com	3
	TOTAL: 1	3
TOTAL: 4		911

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	xanadu-bbs	45435	4458	22384	742	2	0	9%	23:59:55
2	erje	30307	2266	21777	88	0	9	7%	23:59:56
3	news.freedyn.net	29994	1354	25666	2	0	0	4%	23:59:53
4	news.bbs.geek.nz	49551	1115	25550	10	0	0	2%	23:59:56
5	fu-berlin.de	25993	974	25019	0	0	0	3%	23:59:56
6	aioe	26793	841	22776	15	0	0	3%	23:59:55
7	xmission	31895	205	25488	17	0	0	0%	23:59:55
8	usenet.pasdenom.info	33498	177	25928	1423	0	1011	0%	23:54:56
9	news.redatomik.org	31582	164	26156	15	0	0	0%	23:59:56
10	au2pb	27269	162	26345	6	0	0	0%	23:59:56
11	eternal-september	28080	19	22968	0	0	0	0%	23:59:56
12	neva.ru	29402	18	24288	153	0	0	0%	23:59:55
13	weretis.net	20705	15	20152	6	0	0	0%	23:59:56
14	news.mixmin.net	24521	15	21027	0	0	0	0%	23:59:56
15	news.swapon.de	2441	15	2077	8	0	0	0%	23:49:14
16	news.fcku.it	2224	11	1870	0	0	1	0%	22:25:14
17	bwh	22479	7	21179	1	0	0	0%	23:59:56
TOTAL: 17		462169	11816	360650	2486	2	1021	2%	406:08:21

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	20.6 MB	2.4 MB	22.9 MB	0.3 KB/s	4.5 KB	23:59:55
2	news.freedyn.net	9.8 MB	7.1 KB	9.8 MB	0.1 KB/s	7.4 KB	23:59:53
3	fu-berlin.de	8.5 MB	0.0 KB	8.5 MB	0.1 KB/s	9.0 KB	23:59:56
4	erje	6.5 MB	403.7 KB	6.9 MB	0.1 KB/s	3.0 KB	23:59:56
5	news.bbs.geek.nz	2.9 MB	62.0 KB	3.0 MB	0.0 KB/s	2.7 KB	23:59:56
6	aioe	2.4 MB	93.7 KB	2.5 MB	0.0 KB/s	3.0 KB	23:59:55
7	usenet.pasdenom.info	627.1 KB	9.4 MB	10.0 MB	0.1 KB/s	6.4 KB	23:54:56
8	xmission	573.1 KB	53.3 KB	626.5 KB	0.0 KB/s	2.8 KB	23:59:55
9	au2pb	428.6 KB	39.7 KB	468.3 KB	0.0 KB/s	2.8 KB	23:59:56
10	news.redatomik.org	364.8 KB	132.1 KB	496.9 KB	0.0 KB/s	2.8 KB	23:59:56
11	neva.ru	71.3 KB	462.8 KB	534.1 KB	0.0 KB/s	3.1 KB	23:59:55
12	eternal-september	37.3 KB	0.0 KB	37.3 KB	0.0 KB/s	2.0 KB	23:59:56
13	news.fcku.it	36.8 KB	0.0 KB	36.8 KB	0.0 KB/s	3.3 KB	22:25:14
14	news.swapon.de	32.1 KB	17.4 KB	49.5 KB	0.0 KB/s	2.2 KB	23:49:14
15	weretis.net	31.9 KB	85.0 KB	116.9 KB	0.0 KB/s	5.6 KB	23:59:56
16	news.mixmin.net	28.9 KB	0.0 KB	28.9 KB	0.0 KB/s	1.9 KB	23:59:56
17	bwh	11.7 KB	0.9 KB	12.6 KB	0.0 KB/s	1.6 KB	23:59:56
TOTAL: 17		53.0 MB	13.1 MB	66.0 MB	0.0 KB/s	4.7 KB	406:08:21

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp140-01-845526598.dsl.bell.ca	50	111	129.9 KB	25	0	0	00:34:10
2	202.89.176.220	287	42	131.2 KB	37	0	0	04:33:12
3	tempe0.bbox.io	29	5	7.2 KB	1	0	0	05:26:10
4	68-185-181-64.dhcp.mdsn.wi.charter.com	24	5	7.2 KB	5	5	4	05:18:44
5	dhcp-089-099-203-254.chello.nl	8	4	6.3 KB	2	0	0	03:02:23
TOTAL: 5		398	167	281.8 KB	70	5	4	46:01:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	50	111	129.9 KB	25	0	0	00:34:10
2	unresolved	298	42	131.2 KB	37	0	0	28:57:15
3	*.dhcp.mdsn.wi.charter.com	24	5	7.2 KB	5	5	4	05:18:44
4	*.bbox.io	29	5	7.2 KB	1	0	0	05:26:10
5	*.chello.nl	8	4	6.3 KB	2	0	0	03:02:23
6	*.tampfl.dsl-w.verizon.net	7	0	0.0 KB	0	0	0	02:42:44
TOTAL: 6		416	167	281.8 KB	70	5	4	46:01:28

NNRP auth users [Top 20]:

User	Conn
moussa	287
ohlandl	4
TOTAL: 2	291

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.153	0.506	0.501	0.000	23:53:14
tempe0.bbox.io	2.627	0.552	0.000	05:26:10
68-185-181-64.dhcp.mdsn.wi.charter.com	2.215	0.485	0.011	05:18:44
202.89.176.220	26.882	7.195	0.732	04:33:12
dhcp-089-099-203-254.chello.nl	0.822	0.142	0.000	03:02:23
pool-71-98-160-36.tampfl.dsl-w.verizon.net	0.489	0.152	0.000	02:42:44
mtrlpq2314w-lp140-01-845526598.dsl.bell.ca	7.254	2.491	0.000	00:34:10
89.99.203.254	0.095	0.016	0.000	00:30:01
199.189.26.5	0.504	0.471	0.000	00:00:29
94.166.110.238	0.158	0.030	0.000	00:00:08
94.166.150.210	0.144	0.038	0.000	00:00:05
94.160.213.223	0.163	0.031	0.000	00:00:02
94.162.64.211	0.126	0.036	0.000	00:00:01
TOTAL: 13	41.985	12.140	0.743	46:01:28

Curious NNRP server explorers [Top 20]:

System	Conn
pool-71-98-160-36.tampfl.dsl-w.verizon.net	7
94.166.110.238	2
94.166.150.210	2
199.189.26.5	2
94.160.213.223	2
94.162.64.211	2
89.99.203.254	1
TOTAL: 7	18

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	8	0
dhcp-089-099-203-254.chello.nl	5	0
pool-71-98-160-36.tampfl.dsl-w.verizon.net	5	0
68-185-181-64.dhcp.mdsn.wi.charter.com	5	0
89.99.203.254	1	0
TOTAL: 5	24	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	100	59.9%
2	comp	57	34.1%
3	sci	7	4.2%
4	fr	1	0.6%
5	uk	1	0.6%
6	rec	1	0.6%
TOTAL: 6		167	100.0%

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

Newsgroup		Count
1	alt.drugs.heroin	98
2	comp.sys.ibm.ps2.hardware	19
3	sci.physics	7
4	comp.ai.neural-nets	7
5	comp.os.msdos.djgpp	6
6	comp.os.msdos.programmer	5
7	comp.sys.ibm.pc.hardware.storage	5
8	comp.arch	4
9	comp.arch.embedded	3
10	comp.os.vms	2
11	comp.sys.ibm.pc.games.action	2
12	alt.stupidity	1
13	comp.sys.ibm.pc.games.war-historical	1
14	alt.home.repair	1
15	comp.archives.ms-windows.discuss	1
16	fr.soc.politique	1
17	rec.arts.sf.written	1
18	comp.sys.ibm.pc.games.naval	1
19	comp.lang.python	1
20	uk.rec.motorcycles	1
TOTAL: 20		167

Daily Usenet report for csiph.com

Mar 12 04:15:00 -- Mar 13 04:15:00