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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	43868	39.7%	3.8 MB	25.3%
inn	43264	39.2%	8.5 MB	56.6%
innd	20097	18.2%	2.2 MB	14.4%
innfeed	3131	2.8%	565.5 KB	3.7%
nocem	76	0.1%	7.3 KB	0.0%
TOTAL: 5	110436	100.0%	15.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	523268	52.9%
Negative hits	422552	42.7%
Do not exist	42302	4.3%
Cache misses	684	0.1%
TOTAL: 4	988806	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.642	0.0%	239	0.000	2.686	72.000
article cleanup	00:00:00.247	0.0%	42280	0.000	0.006	0.028
article logging	00:00:00.664	0.0%	42825	0.003	0.016	0.148
article parse	00:00:01.528	0.0%	153998	0.003	0.010	0.023
article write	00:01:02.811	0.1%	26257	0.211	2.392	43.993
artlog/artcncl	00:00:00.001	0.0%	215	0.000	0.005	0.056
artlog/artparse	00:00:00.002	0.0%	210	0.000	0.010	0.333
data move	00:00:00.307	0.0%	927291	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.019	0.0%	222	0.000	0.086	2.000
hishave/artcncl	00:00:00.000	0.0%	239	0.000	0.000	0.000
hishave/artparse	00:00:00.002	0.0%	208	0.000	0.010	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.966	0.0%	992564	0.001	0.004	0.037
history sync	00:00:00.949	0.0%	325	0.000	2.920	9.667
history write	00:00:21.405	0.0%	42230	0.094	0.507	5.221
hiswrite/artcncl	00:00:00.006	0.0%	17	0.000	0.353	2.000
hiswrite/artparse	00:00:00.102	0.0%	208	0.000	0.490	5.000
idle	23:54:41.685	99.6%	940385	58.085	91.539	236.266
nntp read	00:00:03.281	0.0%	947108	0.002	0.003	0.007
overview write	00:01:22.934	0.1%	26257	0.181	3.159	87.336
perl filter	00:01:45.019	0.1%	42223	1.544	2.487	4.644
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.466	0.0%	52584	0.000	0.009	0.024
TOTAL: 24:00:29.923	23:59:26.036	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.097	0.0%	26373	0.000	0.004	0.019
article prepare	00:00:00.002	0.0%	27720	0.000	0.000	0.007
article read	00:00:00.856	0.0%	3184	0.000	0.269	10.889
backlog stats	00:00:00.296	0.0%	571973	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.316	0.0%	432468	0.002	0.005	0.011
data write	00:00:02.840	0.0%	415909	0.004	0.007	0.014
idle	23:54:38.001	100.0%	571973	85.487	150.493	490.741
status file	00:00:00.333	0.0%	265	0.000	1.257	107.000
TOTAL: 23:54:53.421	23:54:44.741	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.091	0.0%	10794	0.045	0.194	0.543
idle	43:07:06.377	99.1%	69059	81.596	2247.736	600152.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.814	0.0%	139246	0.000	0.006	0.167
readart	00:00:16.841	0.0%	12199	0.000	1.381	74.000
TOTAL: 43:29:36.624	43:07:26.123	99.2%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.neva.ru	146	41474	6011	29551	5912	14%	71:41:06
2	csiph-out.feeder.erje.net	1152	139043	5212	128176	5655	3%	94:58:01
3	feeder.eternal-september.org	6	37314	3812	32518	984	10%	24:50:56
4	news-out.mixmin.net	2	29102	3794	24583	725	13%	24:08:55
5	usenet.blueworldhosting.com	288	30622	1706	27065	1851	5%	23:44:52
6	news-out.aioe.org	3	25663	1499	24122	42	5%	24:09:48
7	newsfeed.fu-berlin.de	60	31452	1446	29687	319	4%	39:02:57
8	news.freedyn.net	4	28751	827	27886	38	2%	24:09:21
9	csiph-out.news.weretis.net	4	59258	602	58065	591	1%	46:10:03
10	newsfeeds.xmission.com	1	25701	490	25173	38	1%	21:41:29
11	news.fcku.it	1	10637	405	10185	47	3%	24:12:11
12	news.redatomik.org	1	24029	238	23784	7	0%	22:26:07
13	nntp.pasdenom.info	2	27394	33	27353	8	0%	23:59:52
14	xanadu-bbs.net	7	873	24	849	0	2%	21:25:17
15	news.bbs.geek.nz	2	26796	21	26774	1	0%	23:59:41
16	au2pb.net	1	3556	17	3526	13	0%	05:28:12
17	localhost	42	9	9	0	0	100%	00:00:00
18	news.swapon.de	1	100	5	95	0	5%	01:47:31
TOTAL: 18		1723	541774	26151	499392	16231	4%	517:56:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	20.3 MB	223.7 KB	23.4 MB	43.9 MB	46%	4.1 KB
2	newsfeed.neva.ru	16.2 MB	64.1 KB	47.6 MB	63.8 MB	25%	5.5 KB
3	news-out.mixmin.net	13.6 MB	5.8 KB	2.2 MB	15.8 MB	85%	3.6 KB
4	feeder.eternal-september.org	9.9 MB	20.0 KB	15.2 MB	25.1 MB	39%	5.4 KB
5	usenet.blueworldhosting.com	5.4 MB	0.0 KB	17.1 MB	22.5 MB	23%	6.5 KB
6	news-out.aioe.org	3.5 MB	4.1 KB	76.7 KB	3.6 MB	97%	2.4 KB
7	newsfeed.fu-berlin.de	3.0 MB	1.4 KB	837.3 KB	3.9 MB	78%	2.2 KB
8	news.freedyn.net	2.7 MB	5.6 KB	606.3 KB	3.3 MB	82%	3.9 KB
9	csiph-out.news.weretis.net	2.0 MB	8.4 KB	10.7 MB	12.7 MB	15%	10.9 KB
10	newsfeeds.xmission.com	1.6 MB	3.1 KB	1012.4 KB	2.6 MB	61%	5.0 KB
11	news.fcku.it	827.9 KB	3.5 KB	2.9 MB	3.7 MB	21%	8.4 KB
12	news.redatomik.org	517.2 KB	1.4 KB	729.5 KB	1.2 MB	41%	5.1 KB
13	nntp.pasdenom.info	71.4 KB	1.4 KB	16.5 KB	89.4 KB	79%	2.2 KB
14	au2pb.net	46.9 KB	7.3 KB	32.4 KB	86.7 KB	54%	2.9 KB
15	xanadu-bbs.net	46.5 KB	0.0 KB	0.0 KB	46.5 KB	100%	1.9 KB
16	news.bbs.geek.nz	39.0 KB	1.4 KB	1.4 KB	41.8 KB	93%	1.9 KB
17	news.swapon.de	14.5 KB	0.0 KB	0.0 KB	14.5 KB	100%	2.9 KB
18	localhost	9.2 KB	0.0 KB	0.0 KB	9.2 KB	100%	1.0 KB
TOTAL: 18		79.8 MB	351.3 KB	122.3 MB	202.4 MB	39%	4.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 21 04:15:00 - 04:59:59	513	2.0%	0.19	2.3 MB	2.9%	0.88
Jun 21 05:00:00 - 05:59:59	723	2.8%	0.20	3.6 MB	4.4%	1.01
Jun 21 06:00:00 - 06:59:59	731	2.8%	0.20	2.1 MB	2.6%	0.58
Jun 21 07:00:00 - 07:59:59	1220	4.6%	0.34	3.3 MB	4.1%	0.93
Jun 21 08:00:00 - 08:59:59	1120	4.3%	0.31	2.9 MB	3.6%	0.83
Jun 21 09:00:00 - 09:59:59	1105	4.2%	0.31	2.6 MB	3.3%	0.75
Jun 21 10:00:00 - 10:59:59	1201	4.6%	0.33	3.8 MB	4.7%	1.08
Jun 21 11:00:00 - 11:59:59	1172	4.5%	0.33	3.0 MB	3.8%	0.87
Jun 21 12:00:00 - 12:59:59	1299	4.9%	0.36	3.8 MB	4.7%	1.07
Jun 21 13:00:00 - 13:59:59	1331	5.1%	0.37	3.6 MB	4.5%	1.02
Jun 21 14:00:00 - 14:59:59	1487	5.7%	0.41	4.6 MB	5.7%	1.31
Jun 21 15:00:00 - 15:59:59	1510	5.8%	0.42	4.6 MB	5.8%	1.32
Jun 21 16:00:00 - 16:59:59	1623	6.2%	0.45	5.7 MB	7.1%	1.62
Jun 21 17:00:00 - 17:59:59	1452	5.5%	0.40	4.6 MB	5.7%	1.30
Jun 21 18:00:00 - 18:59:59	1354	5.2%	0.38	4.1 MB	5.1%	1.17
Jun 21 19:00:00 - 19:59:59	1537	5.9%	0.43	5.1 MB	6.3%	1.44
Jun 21 20:00:00 - 20:59:59	1381	5.3%	0.38	3.7 MB	4.6%	1.04
Jun 21 21:00:00 - 21:59:59	1378	5.2%	0.38	3.8 MB	4.7%	1.07
Jun 21 22:00:00 - 22:59:59	1043	4.0%	0.29	3.4 MB	4.2%	0.95
Jun 21 23:00:00 - 23:59:59	700	2.7%	0.19	2.0 MB	2.5%	0.57
Jun 22 00:00:00 - 00:59:59	641	2.4%	0.18	2.0 MB	2.5%	0.57
Jun 22 01:00:00 - 01:59:59	552	2.1%	0.15	1.8 MB	2.3%	0.52
Jun 22 02:00:00 - 02:59:59	509	1.9%	0.14	1.8 MB	2.3%	0.52
Jun 22 03:00:00 - 03:59:59	525	2.0%	0.15	1.7 MB	2.1%	0.48
Jun 22 04:00:00 - 04:15:00	153	0.6%	0.17	558.5 KB	0.7%	0.62
TOTAL: 24:00:00	26260	100.0%	0.30	80.3 MB	100.0%	0.95

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	TooOld	Other
1	newsfeed.neva.ru	5963	1556	8	0	0	4399
2	csiph-out.feeder.erje.net	5693	556	21	0	0	5116
3	usenet.blueworldhosting.com	1847	879	0	1	0	967
4	feeder.eternal-september.org	1009	126	7	1	0	875
5	news-out.mixmin.net	761	5	1	0	0	755
6	newsfeed.fu-berlin.de	685	19	1	0	0	665
7	csiph-out.news.weretis.net	588	298	2	0	0	288
8	news.fcku.it	51	0	6	0	0	45
9	au2pb.net	48	43	1	0	0	4
10	news-out.aioe.org	45	39	0	0	0	6
11	newsfeeds.xmission.com	36	26	1	0	0	9
12	news.freedyn.net	36	2	1	0	0	33
13	news.swapon.de	10	0	0	0	0	10
14	nntp.pasdenom.info	8	3	1	0	4	0
15	news.redatomik.org	7	0	1	0	0	6
16	news.bbs.geek.nz	1	0	1	0	0	0
17	xanadu-bbs.net	1	0	0	0	0	1
TOTAL: 17		16789	3552	52	2	4	13179

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	1130
it-alt.sport.calcio.juventus	153
lada.talk	146
mailing.freebsd.pkg-fallout	138
ut.test	120
mailing.freebsd.svn-ports-all	107
mailing.freebsd.svn-ports-head	104
lada.auto	104
mailing.freebsd.ports-bugs	63
mailing.gcc.gcc-cvs	50
alt.survival	46
alt.windows7.general	45
mozilla.general	38
gmane.linux.alsa.devel	37
mailing.freebsd.svn-src-all	37
fa.freebsd.cvs-all	34
mozilla.support.firefox	32
mailing.openbsd.tech	32
mailing.openbsd.misc	32
mailing.freebsd.current	32
TOTAL: 241	3552

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

Groups	Count
alt.bigfoot	1
alt.culture.china	1
TOTAL: 2	2

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9303
EMP (phn path)	1888
EMP (phl)	658
EMP (phn nph)	123
Too many newsgroups	91
HTML Multipart	33
Scoring filter (18)	21
Scoring filter (17)	21
Scoring filter (16)	18
Binary Payload	17
Scoring filter (12)	16
Scoring filter (10)	14
User-issued cancel	13
Scoring filter (19)	13
Scoring filter (11)	11
Binary: misplaced PAR2	9
Scoring filter (14)	9
Scoring filter (21)	8
Scoring filter (9)	6
HTML post	6
TOTAL: 91	12421

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	csiph-out.news.weretis.net	90
	feeder.eternal-september.org	36
	usenet.blueworldhosting.com	33
	news-out.mixmin.net	20
	newsfeeds.xmission.com	9
	news.fcku.it	6
	news.redatomik.org	6
	news.freedyn.net	4
	au2pb.net	2
	TOTAL: 9	206
Including strange strings
	newsfeed.fu-berlin.de	416
	news-out.mixmin.net	39
	feeder.eternal-september.org	31
	csiph-out.feeder.erje.net	30
	news.swapon.de	10
	newsfeed.neva.ru	10
	news-out.aioe.org	5
	usenet.blueworldhosting.com	4
	csiph-out.news.weretis.net	3
	au2pb.net	1
	TOTAL: 10	549
No colon-space in header
	usenet.blueworldhosting.com	2
	TOTAL: 1	2
TOTAL: 3		757

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	48623	1657	23692	27	1	3%	23:59:54
2	news.freedyn.net	27080	1157	24256	8	0	4%	23:59:44
3	xanadu-bbs	29983	982	25248	1	0	3%	23:59:56
4	fu-berlin.de	24544	861	23683	0	0	3%	23:59:56
5	aioe	23692	210	22116	6	0	0%	23:59:49
6	weretis.net	25200	161	23248	45	0	0%	23:59:53
7	au2pb	28004	125	25138	3	163	0%	23:59:56
8	usenet.pasdenom.info	29323	106	24868	1253	0	0%	23:59:56
9	news.redatomik.org	25704	100	24686	8	0	0%	23:59:56
10	xmission	33021	89	24757	5	0	0%	23:59:54
11	news.mixmin.net	22563	33	21358	0	0	0%	23:59:56
12	eternal-september	23050	15	21132	0	0	0%	23:59:56
13	neva.ru	19742	12	18044	39	0	0%	23:59:54
14	bwh	26392	10	23408	0	167	0%	23:59:56
15	erje	21664	9	20893	15	7	0%	23:59:56
16	news.swapon.de	2325	7	2258	6	0	0%	23:59:01
17	news.fcku.it	3009	0	2884	0	0	0%	21:35:09
TOTAL: 17		413919	5534	351669	1416	338	1%	405:32:42

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	9.9 MB	55.8 KB	10.0 MB	0.1 KB/s	8.8 KB	23:59:44
2	xanadu-bbs	9.3 MB	1.4 KB	9.3 MB	0.1 KB/s	9.7 KB	23:59:56
3	fu-berlin.de	9.0 MB	0.0 KB	9.0 MB	0.1 KB/s	10.7 KB	23:59:56
4	news.bbs.geek.nz	4.0 MB	64.4 KB	4.0 MB	0.0 KB/s	2.5 KB	23:59:54
5	aioe	585.9 KB	15.4 KB	601.3 KB	0.0 KB/s	2.8 KB	23:59:49
6	weretis.net	445.9 KB	517.7 KB	963.6 KB	0.0 KB/s	4.7 KB	23:59:53
7	usenet.pasdenom.info	364.9 KB	10.0 MB	10.3 MB	0.1 KB/s	7.8 KB	23:59:56
8	au2pb	347.7 KB	29.2 KB	376.9 KB	0.0 KB/s	2.9 KB	23:59:56
9	news.redatomik.org	277.2 KB	25.2 KB	302.5 KB	0.0 KB/s	2.8 KB	23:59:56
10	xmission	214.9 KB	10.7 KB	225.7 KB	0.0 KB/s	2.4 KB	23:59:54
11	news.mixmin.net	101.2 KB	0.0 KB	101.2 KB	0.0 KB/s	3.1 KB	23:59:56
12	neva.ru	22.8 KB	139.6 KB	162.4 KB	0.0 KB/s	3.2 KB	23:59:54
13	eternal-september	22.3 KB	0.0 KB	22.3 KB	0.0 KB/s	1.5 KB	23:59:56
14	erje	11.6 KB	137.4 KB	148.9 KB	0.0 KB/s	6.2 KB	23:59:56
15	bwh	11.1 KB	0.0 KB	11.1 KB	0.0 KB/s	1.1 KB	23:59:56
16	news.swapon.de	8.5 KB	8.5 KB	17.0 KB	0.0 KB/s	1.3 KB	23:59:01
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:35:09
TOTAL: 17		34.6 MB	11.0 MB	45.6 MB	0.0 KB/s	6.7 KB	405:32:42

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	286	81	204.8 KB	71	0	0	05:10:17
2	tempe0.bbox.io	7	13	20.5 KB	1	0	0	03:06:29
3	mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	120	11	27.4 KB	10	0	0	00:40:12
4	dhcp-089-099-203-254.chello.nl	25	9	9.3 KB	2	0	0	05:19:02
5	68-185-181-64.dhcp.mdsn.wi.charter.com	29	9	9.3 KB	9	9	8	08:17:20
6	92-108-162-83.dynamic.upc.nl	2	1	1.0 KB	1	0	0	01:00:33
TOTAL: 6		469	124	272.3 KB	94	9	8	43:29:31

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	293	81	204.8 KB	71	0	0	19:12:03
2	*.bbox.io	7	13	20.5 KB	1	0	0	03:06:29
3	*.dsl.bell.ca	120	11	27.4 KB	10	0	0	00:40:12
4	*.dhcp.mdsn.wi.charter.com	29	9	9.3 KB	9	9	8	08:17:20
5	*.chello.nl	25	9	9.3 KB	2	0	0	05:19:02
6	*.dynamic.upc.nl	2	1	1.0 KB	1	0	0	01:00:33
7	*.nielsenmedia.com	6	0	0.0 KB	0	0	0	01:30:36
8	*.151.22.98.dynamic.ip.windstream.net	1	0	0.0 KB	0	0	0	04:23:13
TOTAL: 8		483	124	272.3 KB	94	9	8	43:29:31

NNRP auth users [Top 20]:

User	Conn
moussa	286
ohlandl	8
TOTAL: 2	294

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
216.239.174.89	0.373	0.300	0.000	13:31:34
68-185-181-64.dhcp.mdsn.wi.charter.com	3.071	0.617	0.023	08:17:20
dhcp-089-099-203-254.chello.nl	2.237	0.536	0.000	05:19:02
202.89.176.220	30.605	7.274	0.772	05:10:17
h53.151.22.98.dynamic.ip.windstream.net	0.315	0.287	0.000	04:23:13
tempe0.bbox.io	0.947	0.170	0.000	03:06:29
challenger.nielsenmedia.com	0.524	0.113	0.000	01:30:36
92-108-162-83.dynamic.upc.nl	0.165	0.049	0.000	01:00:33
mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	15.595	4.176	0.000	00:40:12
71.98.160.36	0.083	0.030	0.000	00:30:02
2.157.31.93	0.075	0.022	0.000	00:00:02
5.87.12.44	0.084	0.017	0.000	00:00:01
5.86.44.139	0.092	0.023	0.000	00:00:01
94.167.102.19	0.087	0.024	0.000	00:00:01
94.161.221.66	0.055	0.032	0.000	00:00:00
94.164.160.187	0.056	0.024	0.000	00:00:00
TOTAL: 16	54.364	13.694	0.795	43:29:31

Curious NNRP server explorers [Top 20]:

System	Conn
challenger.nielsenmedia.com	6
5.87.12.44	1
71.98.160.36	1
5.86.44.139	1
94.161.221.66	1
2.157.31.93	1
94.164.160.187	1
h53.151.22.98.dynamic.ip.windstream.net	1
94.167.102.19	1
TOTAL: 9	14

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-185-181-64.dhcp.mdsn.wi.charter.com	7	0
tempe0.bbox.io	6	0
challenger.nielsenmedia.com	3	0
92-108-162-83.dynamic.upc.nl	2	0
71.98.160.36	1	0
TOTAL: 5	19	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	114	91.9%
2	rec	4	3.2%
3	uk	4	3.2%
4	alt	2	1.6%
TOTAL: 4		124	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	41
2	comp.arch	29
3	comp.os.vms	20
4	comp.os.cpm	6
5	comp.ai.neural-nets	6
6	comp.sys.ibm.pc.games.action	4
7	rec.arts.tv	4
8	comp.windows.x	2
9	comp.os.msdos.djgpp	2
10	comp.archives.ms-windows.discuss	2
11	alt.home.repair	1
12	uk.rec.drugs.cannabis	1
13	uk.media.tv.misc	1
14	comp.os.os2.misc	1
15	uk.politics.misc	1
16	alt.life.sucks	1
17	uk.rec.sheds	1
18	comp.sys.mac.system	1
TOTAL: 18		124

Daily Usenet report for csiph.com

Jun 21 04:15:00 -- Jun 22 04:15:00