Daily Usenet report for csiph.com: Apr 2 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	44576	42.7%	3.9 MB	28.4%
inn	37206	35.6%	7.3 MB	52.8%
innd	19355	18.5%	2.1 MB	15.0%
innfeed	3149	3.0%	531.9 KB	3.7%
nocem	114	0.1%	11.2 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	104401	100.0%	13.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	436783	56.1%
Negative hits	304169	39.1%
Do not exist	36268	4.7%
Cache misses	747	0.1%
TOTAL: 4	777967	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.441	0.0%	668	0.000	8.145	22.000
article cleanup	00:00:00.252	0.0%	35734	0.000	0.007	0.031
article logging	00:00:00.656	0.0%	36268	0.000	0.018	0.232
article parse	00:00:02.481	0.0%	149175	0.002	0.017	0.377
article write	00:00:36.539	0.0%	22184	0.178	1.647	15.367
artlog/artcncl	00:00:00.007	0.0%	567	0.000	0.012	0.500
artlog/artparse	00:00:00.008	0.0%	416	0.000	0.019	1.000
data move	00:00:00.279	0.0%	777749	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.042	0.0%	642	0.000	0.065	11.000
hishave/artcncl	00:00:00.007	0.0%	668	0.000	0.010	0.083
hishave/artparse	00:00:00.002	0.0%	416	0.000	0.005	0.125
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:16.216	0.0%	779029	0.002	0.021	0.122
history sync	00:00:02.064	0.0%	357	0.000	5.782	62.000
history write	00:00:54.321	0.1%	35683	0.065	1.522	7.600
hiswrite/artcncl	00:00:00.008	0.0%	26	0.308	0.308	0.308
hiswrite/artparse	00:00:01.156	0.0%	416	0.000	2.779	28.545
idle	23:54:53.561	99.6%	794180	58.777	108.406	268.743
nntp read	00:00:02.664	0.0%	801311	0.001	0.003	0.006
overview write	00:01:35.194	0.1%	22184	0.811	4.291	79.700
perl filter	00:01:26.938	0.1%	35683	1.618	2.436	3.986
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.420	0.0%	44474	0.000	0.009	0.042
TOTAL: 24:00:52.484	23:59:58.256	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.070	0.0%	22215	0.000	0.003	0.019
article prepare	00:00:00.002	0.0%	38524	0.000	0.000	0.005
article read	00:00:01.637	0.0%	4497	0.000	0.364	8.462
backlog stats	00:00:00.236	0.0%	529868	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.923	0.0%	379734	0.001	0.005	0.009
data write	00:00:02.590	0.0%	362904	0.003	0.007	0.015
idle	23:53:47.102	100.0%	529868	86.375	162.356	465.435
status file	00:00:00.248	0.0%	251	0.000	0.988	9.500
TOTAL: 23:54:05.107	23:53:53.808	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.727	0.0%	16744	0.083	0.163	0.348
idle	64:45:24.156	99.4%	72412	77.954	3219.413	600446.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.867	0.0%	145980	0.000	0.006	0.500
readart	00:00:18.522	0.0%	9088	0.000	2.038	62.000
TOTAL: 65:09:45.413	64:45:46.272	99.4%	-	-	-	-

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	25287	4540	19445	1302	17%	23:44:51
2	csiph-out.feeder.erje.net	1152	82657	4455	75710	2492	5%	94:56:37
3	feeder.eternal-september.org	9	31250	2868	27498	884	9%	25:28:42
4	csiph-out.news.weretis.net	4	52994	2836	48605	1553	5%	49:45:45
5	news-out.aioe.org	2	20715	1661	19040	14	8%	24:09:56
6	newsfeed.neva.ru	147	41828	1608	35373	4847	3%	71:37:22
7	news-out.mixmin.net	3	25516	1251	22299	1966	4%	24:08:47
8	newsfeed.fu-berlin.de	28	22420	1111	20960	349	4%	26:35:24
9	newsfeeds.xmission.com	1	22888	499	22377	12	2%	26:16:15
10	news.freedyn.net	4	24969	314	24473	182	1%	24:10:03
11	news.fcku.it	1	6738	275	6463	0	4%	21:26:42
12	news.redatomik.org	1	17139	213	16922	4	1%	20:26:52
13	news.swapon.de	2	3743	183	3557	3	4%	45:59:08
14	au2pb.net	1	29379	152	29192	35	0%	26:13:07
15	xanadu-bbs.net	1	33169	142	31110	1917	0%	23:24:38
16	nntp.pasdenom.info	3	20611	96	20491	24	0%	24:08:37
17	news.bbs.geek.nz	1	23391	9	23379	3	0%	23:59:46
18	localhost	42	8	8	0	0	100%	00:00:00
TOTAL: 18		1690	484702	22221	446894	15587	4%	576:32:32

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	18.8 MB	65.9 KB	3.5 MB	22.3 MB	84%	3.3 KB
2	usenet.blueworldhosting.com	12.9 MB	0.0 KB	13.3 MB	26.2 MB	49%	4.6 KB
3	csiph-out.news.weretis.net	8.7 MB	4.3 KB	22.2 MB	30.9 MB	28%	7.2 KB
4	feeder.eternal-september.org	8.1 MB	4.9 KB	11.5 MB	19.6 MB	41%	5.3 KB
5	newsfeed.neva.ru	5.6 MB	676.2 KB	52.0 MB	58.3 MB	9%	9.2 KB
6	news-out.mixmin.net	5.0 MB	30.7 KB	3.7 MB	8.7 MB	57%	2.8 KB
7	news-out.aioe.org	4.4 MB	0.0 KB	26.9 KB	4.5 MB	99%	2.7 KB
8	newsfeed.fu-berlin.de	2.5 MB	0.0 KB	751.1 KB	3.3 MB	77%	2.3 KB
9	news.freedyn.net	1.4 MB	0.0 KB	1.8 MB	3.2 MB	43%	6.6 KB
10	newsfeeds.xmission.com	1.2 MB	0.0 KB	137.8 KB	1.3 MB	89%	2.6 KB
11	news.redatomik.org	593.4 KB	0.0 KB	534.5 KB	1.1 MB	52%	5.2 KB
12	news.fcku.it	513.0 KB	0.0 KB	0.0 KB	513.0 KB	100%	1.9 KB
13	news.swapon.de	493.4 KB	0.0 KB	21.9 KB	515.3 KB	95%	2.8 KB
14	au2pb.net	441.5 KB	0.0 KB	340.2 KB	781.7 KB	56%	4.2 KB
15	nntp.pasdenom.info	404.3 KB	0.0 KB	48.6 KB	452.9 KB	89%	3.8 KB
16	xanadu-bbs.net	363.3 KB	21.7 KB	18.3 MB	18.7 MB	1%	9.3 KB
17	news.bbs.geek.nz	16.0 KB	0.0 KB	4.7 KB	20.7 KB	77%	1.7 KB
18	localhost	10.5 KB	0.0 KB	0.0 KB	10.5 KB	100%	1.3 KB
TOTAL: 18		71.3 MB	803.6 KB	128.1 MB	200.2 MB	35%	5.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 2 04:15:00 - 04:59:59	595	2.7%	0.22	2.5 MB	3.5%	0.94
Apr 2 05:00:00 - 05:59:59	538	2.4%	0.15	1.7 MB	2.4%	0.49
Apr 2 06:00:00 - 06:59:59	637	2.9%	0.18	2.1 MB	2.9%	0.58
Apr 2 07:00:00 - 07:59:59	839	3.8%	0.23	3.0 MB	4.2%	0.85
Apr 2 08:00:00 - 08:59:59	1038	4.7%	0.29	3.6 MB	5.1%	1.04
Apr 2 09:00:00 - 09:59:59	1116	5.0%	0.31	4.5 MB	6.3%	1.27
Apr 2 10:00:00 - 10:59:59	878	4.0%	0.24	2.6 MB	3.6%	0.74
Apr 2 11:00:00 - 11:59:59	948	4.3%	0.26	3.0 MB	4.2%	0.85
Apr 2 12:00:00 - 12:59:59	991	4.5%	0.28	3.1 MB	4.3%	0.87
Apr 2 13:00:00 - 13:59:59	1179	5.3%	0.33	4.8 MB	6.8%	1.37
Apr 2 14:00:00 - 14:59:59	1196	5.4%	0.33	3.5 MB	4.9%	0.99
Apr 2 15:00:00 - 15:59:59	1290	5.8%	0.36	3.8 MB	5.4%	1.08
Apr 2 16:00:00 - 16:59:59	1505	6.8%	0.42	4.5 MB	6.3%	1.27
Apr 2 17:00:00 - 17:59:59	1277	5.8%	0.35	3.3 MB	4.7%	0.95
Apr 2 18:00:00 - 18:59:59	1133	5.1%	0.31	2.9 MB	4.1%	0.83
Apr 2 19:00:00 - 19:59:59	1128	5.1%	0.31	3.4 MB	4.8%	0.96
Apr 2 20:00:00 - 20:59:59	1091	4.9%	0.30	3.3 MB	4.7%	0.95
Apr 2 21:00:00 - 21:59:59	960	4.3%	0.27	2.6 MB	3.6%	0.73
Apr 2 22:00:00 - 22:59:59	871	3.9%	0.24	3.3 MB	4.7%	0.95
Apr 2 23:00:00 - 23:59:59	687	3.1%	0.19	2.3 MB	3.2%	0.66
Apr 3 00:00:00 - 00:59:59	583	2.6%	0.16	1.8 MB	2.5%	0.51
Apr 3 01:00:00 - 01:59:59	687	3.1%	0.19	2.0 MB	2.8%	0.57
Apr 3 02:00:00 - 02:59:59	399	1.8%	0.11	1.2 MB	1.7%	0.34
Apr 3 03:00:00 - 03:59:59	506	2.3%	0.14	1.9 MB	2.6%	0.53
Apr 3 04:00:00 - 04:15:00	119	0.5%	0.13	452.5 KB	0.6%	0.50
TOTAL: 24:00:00	22191	100.0%	0.26	71.1 MB	100.0%	0.84

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.neva.ru	4806	580	30	0	4196
2	news-out.mixmin.net	1979	6	7	0	1966
3	xanadu-bbs.net	1850	23	0	0	1827
4	csiph-out.news.weretis.net	1516	149	2	0	1365
5	usenet.blueworldhosting.com	1301	648	0	0	653
6	csiph-out.feeder.erje.net	1035	254	12	1	768
7	feeder.eternal-september.org	898	90	0	0	808
8	newsfeed.fu-berlin.de	760	32	0	0	728
9	news.freedyn.net	182	1	0	0	181
10	au2pb.net	33	25	0	0	8
11	news-out.aioe.org	28	12	0	0	16
12	nntp.pasdenom.info	26	16	0	0	10
13	news.swapon.de	14	0	0	0	14
14	newsfeeds.xmission.com	12	9	0	0	3
15	news.redatomik.org	7	2	0	0	5
16	news.bbs.geek.nz	1	1	0	0	0
TOTAL: 16		14448	1848	51	1	12548

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	204
mailing.freebsd.pkg-fallout	141
lada.talk	108
ut.test	105
mailing.freebsd.svn-ports-all	76
mailing.freebsd.svn-ports-head	71
lada.auto	64
it-alt.sport.calcio.juventus	45
alt.survival	43
mpc.lists.freebsd.ports.bugs	43
mailing.freebsd.ports-bugs	42
mailing.openbsd.tech	38
fa.openbsd.tech	38
mailing.openbsd.source-changes	37
fa.openbsd.source-changes	25
alt.windows7.general	25
mailing.openssl.cvs	25
lada.commerce	23
mailing.openbsd.misc	21
24hoursupport.helpdesk	19
TOTAL: 208	1848

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

Groups	Count
alt.binaries.sounds.mp3.jazz.vocals	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	7733
EMP (phn path)	1797
EMP (phl)	808
Binary: misplaced rar	408
EMP (phn nph)	194
Too many newsgroups	123
PFM bot misc	111
Scoring filter (25)	37
Scoring filter (8)	34
HTML Multipart	32
Scoring filter (18)	29
Scoring filter (20)	21
Scoring filter (14)	19
Binary Payload	18
Scoring filter (21)	18
Scoring filter (26)	17
Scoring filter (28)	14
Scoring filter (22)	13
Scoring filter (16)	13
User-issued spam cancel	12
TOTAL: 58	11611

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	106	0	140	140
TOTAL: 1	106	0	140	140

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	133
	csiph-out.news.weretis.net	123
	usenet.blueworldhosting.com	67
	feeder.eternal-september.org	56
	news.freedyn.net	13
	news-out.mixmin.net	5
	news.redatomik.org	3
	au2pb.net	1
	newsfeed.fu-berlin.de	1
	newsfeeds.xmission.com	1
	TOTAL: 10	403
Including strange strings
	newsfeed.fu-berlin.de	395
	csiph-out.news.weretis.net	28
	feeder.eternal-september.org	26
	csiph-out.feeder.erje.net	25
	news-out.mixmin.net	20
	news.swapon.de	14
	news-out.aioe.org	14
	newsfeed.neva.ru	8
	nntp.pasdenom.info	2
	newsfeeds.xmission.com	1
	TOTAL: 11	534
TOTAL: 2		937

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	24310	1796	20242	1	10	7%	23:59:53
2	news.freedyn.net	25695	1701	20159	8	1	6%	23:59:48
3	news.bbs.geek.nz	39595	1645	19172	26	1	4%	23:59:50
4	fu-berlin.de	20803	1056	19747	0	0	5%	23:59:48
5	aioe	20821	360	17897	14	1	1%	23:59:49
6	usenet.pasdenom.info	28234	227	20094	1775	66	0%	23:59:47
7	xmission	27434	208	20430	19	1	0%	23:59:53
8	news.redatomik.org	25375	110	20372	18	1	0%	23:59:52
9	au2pb	21412	105	20584	10	0	0%	23:59:53
10	weretis.net	18008	57	17408	8	0	0%	23:59:53
11	erje	20204	24	17231	317	1	0%	23:59:48
12	news.mixmin.net	22335	23	19205	2	1	0%	23:59:26
13	eternal-september	21986	16	17672	0	1	0%	23:59:52
14	neva.ru	23048	15	18921	94	1	0%	23:59:47
15	bwh	17090	11	16185	8	0	0%	23:59:53
16	news.swapon.de	2063	6	1789	5	0	0%	23:52:14
17	news.fcku.it	0	0	0	0	1627	0%	23:58:40
TOTAL: 17		358413	7360	287108	2305	1712	2%	407:48:06

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	10.8 MB	18.0 KB	10.8 MB	0.1 KB/s	6.2 KB	23:59:53
2	news.freedyn.net	10.7 MB	24.2 KB	10.7 MB	0.1 KB/s	6.4 KB	23:59:48
3	fu-berlin.de	9.1 MB	0.0 KB	9.1 MB	0.1 KB/s	8.8 KB	23:59:48
4	news.bbs.geek.nz	4.2 MB	75.8 KB	4.3 MB	0.1 KB/s	2.6 KB	23:59:50
5	aioe	889.6 KB	95.6 KB	985.2 KB	0.0 KB/s	2.6 KB	23:59:49
6	usenet.pasdenom.info	852.2 KB	10.5 MB	11.3 MB	0.1 KB/s	5.8 KB	23:59:47
7	xmission	470.6 KB	41.7 KB	512.4 KB	0.0 KB/s	2.3 KB	23:59:53
8	news.redatomik.org	312.5 KB	88.8 KB	401.3 KB	0.0 KB/s	3.1 KB	23:59:52
9	au2pb	254.0 KB	55.2 KB	309.2 KB	0.0 KB/s	2.7 KB	23:59:53
10	weretis.net	151.5 KB	79.4 KB	230.9 KB	0.0 KB/s	3.6 KB	23:59:53
11	erje	56.8 KB	899.6 KB	956.4 KB	0.0 KB/s	2.8 KB	23:59:48
12	news.mixmin.net	49.7 KB	1.8 KB	51.5 KB	0.0 KB/s	2.1 KB	23:59:26
13	neva.ru	36.4 KB	332.8 KB	369.2 KB	0.0 KB/s	3.4 KB	23:59:47
14	eternal-september	30.2 KB	0.0 KB	30.2 KB	0.0 KB/s	1.9 KB	23:59:52
15	bwh	18.1 KB	18.5 KB	36.6 KB	0.0 KB/s	1.9 KB	23:59:53
16	news.swapon.de	9.7 KB	7.7 KB	17.4 KB	0.0 KB/s	1.6 KB	23:52:14
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:40
TOTAL: 17		37.8 MB	12.2 MB	50.0 MB	0.0 KB/s	5.3 KB	407:48:06

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	59	154.9 KB	54	0	0	04:57:30
2	68-185-181-64.dhcp.mdsn.wi.charter.com	37	39	65.9 KB	12	7	7	06:09:33
3	mtrlpq2314w-lp140-01-845526598.dsl.bell.ca	52	34	41.1 KB	9	0	0	00:32:28
4	tempe0.bbox.io	48	21	32.7 KB	5	1	1	08:19:32
5	dhcp-089-099-203-254.chello.nl	14	18	29.8 KB	3	0	0	04:48:51
TOTAL: 5		439	171	324.4 KB	83	8	8	65:09:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	297	59	154.9 KB	54	0	0	39:32:49
2	*.dhcp.mdsn.wi.charter.com	37	39	65.9 KB	12	7	7	06:09:33
3	*.dsl.bell.ca	52	34	41.1 KB	9	0	0	00:32:28
4	*.bbox.io	48	21	32.7 KB	5	1	1	08:19:32
5	*.chello.nl	14	18	29.8 KB	3	0	0	04:48:51
6	*.nielsenmedia.com	2	0	0.0 KB	0	0	0	01:00:07
7	*.tampfl.dsl-w.verizon.net	3	0	0.0 KB	0	0	0	01:30:05
8	*.140.22.98.dynamic.ip.windstream.net	1	0	0.0 KB	0	0	0	03:16:12
TOTAL: 8		454	171	324.4 KB	83	8	8	65:09:40

NNRP auth users [Top 20]:

User	Conn
moussa	288
ohlandl	7
kev009	1
TOTAL: 3	296

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.153	1.343	0.867	0.000	34:22:08
tempe0.bbox.io	4.383	0.982	0.003	08:19:32
68-185-181-64.dhcp.mdsn.wi.charter.com	3.899	0.761	0.015	06:09:33
202.89.176.220	29.137	7.349	0.744	04:57:30
dhcp-089-099-203-254.chello.nl	1.461	0.328	0.000	04:48:51
h27.140.22.98.dynamic.ip.windstream.net	0.207	0.270	0.000	03:16:12
pool-71-98-160-36.tampfl.dsl-w.verizon.net	0.233	0.045	0.000	01:30:05
challenger.nielsenmedia.com	0.133	0.024	0.000	01:00:07
mtrlpq2314w-lp140-01-845526598.dsl.bell.ca	7.305	2.584	0.000	00:32:28
138.108.60.60	0.068	0.008	0.000	00:13:10
TOTAL: 10	48.169	13.218	0.762	65:09:40

Curious NNRP server explorers [Top 20]:

System	Conn
162.212.88.153	8
pool-71-98-160-36.tampfl.dsl-w.verizon.net	3
challenger.nielsenmedia.com	2
138.108.60.60	1
h27.140.22.98.dynamic.ip.windstream.net	1
TOTAL: 5	15

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	137	80.1%
2	alt	33	19.3%
3	uk	1	0.6%
TOTAL: 3		171	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	87
2	alt.drugs.heroin	29
3	comp.os.vms	12
4	comp.sys.ibm.pc.hardware.storage	10
5	comp.arch	8
6	comp.sys.ibm.pc.games.action	7
7	comp.unix.bsd.freebsd.misc	6
8	comp.ai.neural-nets	4
9	comp.arch.embedded	2
10	alt.atheism	2
11	alt.os.linux	1
12	comp.arch.arithmetic	1
13	uk.d-i-y	1
14	alt.christnet.christianlife	1
TOTAL: 14		171

Daily Usenet report for csiph.com

Apr 2 04:15:00 -- Apr 3 04:15:00