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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	43938	40.2%	3.8 MB	26.3%
inn	40769	37.3%	7.9 MB	54.2%
innd	21498	19.7%	2.3 MB	15.5%
innfeed	3140	2.9%	602.3 KB	4.0%
nocem	56	0.1%	5.3 KB	0.0%
TOTAL: 5	109401	100.0%	14.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	473128	56.1%
Negative hits	330094	39.1%
Do not exist	39913	4.7%
Cache misses	557	0.1%
TOTAL: 4	843692	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.869	0.0%	195	0.000	4.456	36.125
article cleanup	00:00:00.285	0.0%	39040	0.000	0.007	0.031
article logging	00:00:00.671	0.0%	39589	0.000	0.017	1.102
article parse	00:00:01.582	0.0%	145459	0.003	0.011	0.141
article write	00:01:50.164	0.1%	23313	0.365	4.725	52.338
artlog/artcncl	00:00:00.000	0.0%	179	0.000	0.000	0.000
artlog/artparse	00:00:00.006	0.0%	1012	0.000	0.006	0.022
data move	00:00:00.297	0.0%	810069	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.131	0.0%	190	0.000	0.689	14.000
hishave/artcncl	00:00:00.002	0.0%	195	0.000	0.010	1.000
hishave/artparse	00:00:00.001	0.0%	387	0.000	0.003	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:07.248	0.0%	845679	0.001	0.009	0.389
history sync	00:00:01.430	0.0%	326	0.000	4.387	104.500
history write	00:00:29.415	0.0%	39636	0.090	0.742	16.649
hiswrite/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hiswrite/artparse	00:00:00.276	0.0%	387	0.000	0.713	79.000
idle	23:54:00.453	99.5%	833625	57.145	103.212	307.190
nntp read	00:00:02.879	0.0%	840606	0.001	0.003	0.006
overview write	00:01:33.119	0.1%	23313	0.147	3.994	102.456
perl filter	00:01:31.191	0.1%	38969	1.521	2.340	3.819
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.404	0.0%	46674	0.000	0.009	0.024
TOTAL: 24:00:37.823	23:59:40.423	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.073	0.0%	23272	0.000	0.003	0.024
article prepare	00:00:00.003	0.0%	21464	0.000	0.000	0.004
article read	00:00:01.143	0.0%	2138	0.000	0.535	25.000
backlog stats	00:00:00.260	0.0%	534074	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.036	0.0%	396832	0.001	0.005	0.009
data write	00:00:02.631	0.0%	376682	0.002	0.007	0.012
idle	23:54:42.032	100.0%	534074	89.483	161.180	504.499
status file	00:00:00.275	0.0%	259	0.000	1.062	33.000
TOTAL: 23:54:56.824	23:54:48.453	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	24:23:19.482	98.4%	57125	79.262	1536.971	600422.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:01:03.231	0.1%	115589	0.000	0.547	189.561
readart	00:00:44.903	0.1%	25872	0.000	1.736	73.000
TOTAL: 24:47:41.923	24:25:07.616	98.5%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	288	27002	4922	20104	1976	18%	23:44:50
2	csiph-out.feeder.erje.net	1152	128626	4140	117087	7399	3%	94:58:03
3	feeder.eternal-september.org	3	33909	3537	29065	1307	10%	24:13:33
4	csiph-out.news.weretis.net	4	58584	3314	54547	723	5%	50:49:26
5	news-out.aioe.org	3	22571	1823	20717	31	8%	24:09:02
6	newsfeed.neva.ru	146	48203	1568	42668	3967	3%	72:23:05
7	newsfeed.fu-berlin.de	19	24204	1205	22413	586	4%	25:26:48
8	news-out.mixmin.net	3	26504	1027	24972	505	3%	24:08:52
9	newsfeeds.xmission.com	1	19381	410	18963	8	2%	18:05:07
10	news.fcku.it	1	9559	360	9110	89	3%	22:04:49
11	news.freedyn.net	4	26254	352	25818	84	1%	24:08:42
12	news.redatomik.org	1	22416	82	22334	0	0%	22:26:07
13	nntp.pasdenom.info	3	23100	81	23011	8	0%	24:08:56
14	au2pb.net	1	5356	74	5271	11	1%	06:09:48
15	news.swapon.de	4	2014	71	1942	1	3%	23:45:48
16	xanadu-bbs.net	14	612	21	587	4	3%	21:35:57
17	localhost	51	16	16	0	0	100%	00:00:00
18	news.bbs.geek.nz	2	24625	4	24621	0	0%	23:59:45
TOTAL: 18		1700	502936	23007	463230	16699	4%	526:18:38

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	15.9 MB	96.7 KB	26.4 MB	42.4 MB	37%	3.8 KB
2	usenet.blueworldhosting.com	13.3 MB	0.0 KB	22.7 MB	36.0 MB	36%	5.3 KB
3	csiph-out.news.weretis.net	9.2 MB	4.5 KB	8.6 MB	17.8 MB	51%	4.5 KB
4	feeder.eternal-september.org	8.7 MB	2.2 KB	19.9 MB	28.6 MB	30%	6.0 KB
5	newsfeed.neva.ru	4.5 MB	0.0 KB	34.5 MB	39.0 MB	11%	7.2 KB
6	news-out.mixmin.net	4.4 MB	0.0 KB	1.6 MB	6.0 MB	73%	4.0 KB
7	news-out.aioe.org	4.1 MB	0.0 KB	75.8 KB	4.2 MB	98%	2.3 KB
8	newsfeed.fu-berlin.de	2.5 MB	0.0 KB	1.3 MB	3.8 MB	66%	2.1 KB
9	newsfeeds.xmission.com	1.3 MB	0.0 KB	371.9 KB	1.6 MB	77%	4.0 KB
10	news.freedyn.net	963.1 KB	0.0 KB	484.8 KB	1.4 MB	66%	3.3 KB
11	news.fcku.it	698.0 KB	37.9 KB	4.2 MB	5.0 MB	13%	11.3 KB
12	au2pb.net	187.6 KB	0.0 KB	30.6 KB	218.2 KB	85%	2.6 KB
13	news.redatomik.org	184.0 KB	0.0 KB	0.0 KB	184.0 KB	100%	2.2 KB
14	news.swapon.de	177.1 KB	0.0 KB	5.9 KB	183.0 KB	96%	2.5 KB
15	nntp.pasdenom.info	154.1 KB	0.0 KB	16.3 KB	170.3 KB	90%	1.9 KB
16	xanadu-bbs.net	65.3 KB	0.0 KB	8.5 KB	73.8 KB	88%	3.0 KB
17	localhost	18.6 KB	0.0 KB	0.0 KB	18.6 KB	100%	1.2 KB
18	news.bbs.geek.nz	4.9 KB	0.0 KB	0.0 KB	4.9 KB	100%	1.2 KB
TOTAL: 18		66.2 MB	141.3 KB	120.2 MB	186.5 MB	35%	4.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 25 04:15:00 - 04:59:59	417	1.8%	0.15	1.6 MB	2.3%	0.59
Jun 25 05:00:00 - 05:59:59	601	2.6%	0.17	2.3 MB	3.4%	0.65
Jun 25 06:00:00 - 06:59:59	614	2.6%	0.17	1.6 MB	2.4%	0.46
Jun 25 07:00:00 - 07:59:59	851	3.7%	0.24	2.2 MB	3.2%	0.62
Jun 25 08:00:00 - 08:59:59	1060	4.5%	0.29	4.2 MB	6.3%	1.21
Jun 25 09:00:00 - 09:59:59	955	4.1%	0.27	2.5 MB	3.7%	0.70
Jun 25 10:00:00 - 10:59:59	1147	4.9%	0.32	3.3 MB	5.0%	0.95
Jun 25 11:00:00 - 11:59:59	1289	5.5%	0.36	3.8 MB	5.6%	1.07
Jun 25 12:00:00 - 12:59:59	1181	5.1%	0.33	3.3 MB	4.8%	0.92
Jun 25 13:00:00 - 13:59:59	1286	5.5%	0.36	3.3 MB	4.9%	0.93
Jun 25 14:00:00 - 14:59:59	1374	5.9%	0.38	3.4 MB	5.1%	0.98
Jun 25 15:00:00 - 15:59:59	1385	5.9%	0.38	4.4 MB	6.6%	1.26
Jun 25 16:00:00 - 16:59:59	1452	6.2%	0.40	3.9 MB	5.9%	1.12
Jun 25 17:00:00 - 17:59:59	1297	5.6%	0.36	3.4 MB	5.1%	0.98
Jun 25 18:00:00 - 18:59:59	1317	5.7%	0.37	3.7 MB	5.5%	1.04
Jun 25 19:00:00 - 19:59:59	1127	4.8%	0.31	2.9 MB	4.4%	0.83
Jun 25 20:00:00 - 20:59:59	1270	5.4%	0.35	3.5 MB	5.2%	1.00
Jun 25 21:00:00 - 21:59:59	1108	4.8%	0.31	3.4 MB	5.1%	0.98
Jun 25 22:00:00 - 22:59:59	879	3.8%	0.24	2.6 MB	3.9%	0.75
Jun 25 23:00:00 - 23:59:59	680	2.9%	0.19	1.9 MB	2.8%	0.54
Jun 26 00:00:00 - 00:59:59	555	2.4%	0.15	1.5 MB	2.3%	0.44
Jun 26 01:00:00 - 01:59:59	452	1.9%	0.13	1.2 MB	1.7%	0.33
Jun 26 02:00:00 - 02:59:59	477	2.0%	0.13	1.5 MB	2.2%	0.41
Jun 26 03:00:00 - 03:59:59	423	1.8%	0.12	1.3 MB	2.0%	0.38
Jun 26 04:00:00 - 04:15:00	109	0.5%	0.12	387.1 KB	0.6%	0.43
TOTAL: 24:00:00	23306	100.0%	0.27	67.1 MB	100.0%	0.80

Sites sending bad articles:

Server		Total	Group	Duplic	TooOld	Other
1	csiph-out.feeder.erje.net	7425	383	20	0	7022
2	newsfeed.neva.ru	3982	455	0	0	3527
3	usenet.blueworldhosting.com	1977	762	0	0	1215
4	feeder.eternal-september.org	1352	62	1	0	1289
5	newsfeed.fu-berlin.de	1017	47	0	0	970
6	csiph-out.news.weretis.net	732	120	0	0	612
7	news-out.mixmin.net	516	0	1	0	515
8	news.freedyn.net	83	0	0	0	83
9	news.fcku.it	78	0	1	0	77
10	news-out.aioe.org	45	19	0	0	26
11	au2pb.net	45	39	1	0	5
12	newsfeeds.xmission.com	11	6	0	0	5
13	nntp.pasdenom.info	8	1	0	1	6
14	news.redatomik.org	6	0	0	0	6
15	xanadu-bbs.net	4	0	0	0	4
16	news.swapon.de	4	0	0	0	4
TOTAL: 16		17285	1894	24	1	15366

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	247
mailing.freebsd.pkg-fallout	236
ut.test	159
mailing.freebsd.ports-bugs	74
lada.talk	61
mailing.freebsd.svn-ports-all	55
mailing.freebsd.svn-ports-head	48
spline.eisfair.dev	44
it-alt.sport.calcio.juventus	44
alt.windows7.general	41
mozilla.general	40
fa.freebsd.cvs-all	33
mailing.freebsd.svn-src-all	33
mailing.freebsd.svn-src-head	31
alt.survival	28
mailing.freebsd.current	24
fa.netbsd.bugs	23
fa.freebsd.current	21
mozilla.support.firefox	20
free.it.religioni.scientology	19
TOTAL: 200	1894

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9636
EMP (phn path)	2148
PFM bot misc	720
EMP (phl)	656
EMP (phn nph)	190
Too many newsgroups	76
Binary: misplaced PAR2	60
Binary Payload	31
HTML Multipart	26
Scoring filter (18)	22
Binary: misplaced rar	18
Scoring filter (8)	16
Scoring filter (9)	14
Scoring filter (12)	13
User-issued cancel	13
Scoring filter (16)	13
Scoring filter (19)	12
Scoring filter (20)	12
Scoring filter (21)	12
Scoring filter (23)	10
TOTAL: 35	13759

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	47	0	54	54
TOTAL: 1	47	0	54	54

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	40
	usenet.blueworldhosting.com	1
	TOTAL: 2	41
Huge articles
	usenet.blueworldhosting.com	134
	feeder.eternal-september.org	114
	news.fcku.it	61
	csiph-out.news.weretis.net	48
	news-out.mixmin.net	13
	newsfeeds.xmission.com	5
	news.freedyn.net	5
	news.redatomik.org	4
	au2pb.net	2
	TOTAL: 9	386
Including strange strings
	newsfeed.fu-berlin.de	421
	csiph-out.feeder.erje.net	34
	csiph-out.news.weretis.net	33
	feeder.eternal-september.org	26
	news-out.aioe.org	14
	news-out.mixmin.net	10
	newsfeed.neva.ru	5
	news.swapon.de	3
	news.redatomik.org	2
	news.fcku.it	2
	TOTAL: 10	550
No colon-space in header
	csiph-out.feeder.erje.net	624
	usenet.blueworldhosting.com	1
	TOTAL: 2	625
TOTAL: 4		1602

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	%Took	Elapsed
1	news.freedyn.net	26147	1088	21844	15	4%	23:59:56
2	xanadu-bbs	26167	930	22333	7	3%	23:59:56
3	fu-berlin.de	21744	779	20965	0	3%	23:59:13
4	news.bbs.geek.nz	43388	611	21869	10	1%	23:59:55
5	aioe	21631	195	19834	5	0%	23:59:55
6	usenet.pasdenom.info	29592	99	21993	1131	0%	23:59:56
7	news.redatomik.org	23631	95	22104	9	0%	23:59:56
8	weretis.net	20085	94	18580	21	0%	23:59:56
9	au2pb	24120	63	22316	3	0%	23:59:29
10	xmission	25641	46	21874	0	0%	23:59:56
11	news.mixmin.net	22547	37	21084	0	0%	23:59:52
12	eternal-september	20881	23	18582	0	0%	23:59:54
13	erje	20167	22	19019	10	0%	23:59:56
14	neva.ru	23598	17	20463	33	0%	23:59:56
15	bwh	19376	16	17412	0	0%	23:59:36
16	news.swapon.de	2117	9	2028	7	0%	23:53:42
17	news.fcku.it	2413	0	2148	0	0%	23:04:44
TOTAL: 17		373245	4124	314448	1251	1%	406:55:48

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	8.2 MB	42.0 KB	8.2 MB	0.1 KB/s	7.7 KB	23:59:56
2	xanadu-bbs	7.8 MB	13.9 KB	7.8 MB	0.1 KB/s	8.6 KB	23:59:56
3	fu-berlin.de	7.5 MB	0.0 KB	7.5 MB	0.1 KB/s	9.8 KB	23:59:13
4	news.bbs.geek.nz	1.6 MB	22.0 KB	1.6 MB	0.0 KB/s	2.7 KB	23:59:55
5	aioe	458.8 KB	16.5 KB	475.4 KB	0.0 KB/s	2.4 KB	23:59:55
6	usenet.pasdenom.info	304.4 KB	8.6 MB	8.9 MB	0.1 KB/s	7.4 KB	23:59:56
7	news.redatomik.org	234.1 KB	19.0 KB	253.1 KB	0.0 KB/s	2.4 KB	23:59:56
8	weretis.net	198.4 KB	247.7 KB	446.1 KB	0.0 KB/s	3.9 KB	23:59:56
9	au2pb	144.9 KB	5.5 KB	150.4 KB	0.0 KB/s	2.3 KB	23:59:29
10	xmission	85.1 KB	0.0 KB	85.1 KB	0.0 KB/s	1.9 KB	23:59:56
11	news.mixmin.net	78.5 KB	0.0 KB	78.5 KB	0.0 KB/s	2.1 KB	23:59:52
12	eternal-september	30.8 KB	0.0 KB	30.8 KB	0.0 KB/s	1.3 KB	23:59:54
13	erje	27.3 KB	26.1 KB	53.3 KB	0.0 KB/s	1.7 KB	23:59:56
14	neva.ru	20.2 KB	180.8 KB	201.0 KB	0.0 KB/s	4.0 KB	23:59:56
15	bwh	18.7 KB	0.0 KB	18.7 KB	0.0 KB/s	1.2 KB	23:59:36
16	news.swapon.de	10.1 KB	8.6 KB	18.7 KB	0.0 KB/s	1.2 KB	23:53:42
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:04:44
TOTAL: 17		26.7 MB	9.1 MB	35.8 MB	0.0 KB/s	6.8 KB	406:55:48

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	55	152.1 KB	49	0	0	05:01:39
2	tempe0.bbox.io	24	19	23.9 KB	7	1	1	06:44:05
3	68-185-181-64.dhcp.mdsn.wi.charter.com	24	18	22.9 KB	15	15	12	04:45:58
4	mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	120	18	38.1 KB	16	0	0	00:36:20
5	dhcp-089-099-203-254.chello.nl	22	12	15.6 KB	6	0	0	05:29:31
TOTAL: 5		478	122	252.6 KB	93	16	13	24:47:37

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	300	55	152.1 KB	49	0	0	07:11:41
2	*.bbox.io	24	19	23.9 KB	7	1	1	06:44:05
3	*.dsl.bell.ca	120	18	38.1 KB	16	0	0	00:36:20
4	*.dhcp.mdsn.wi.charter.com	24	18	22.9 KB	15	15	12	04:45:58
5	*.chello.nl	22	12	15.6 KB	6	0	0	05:29:31
TOTAL: 5		490	122	252.6 KB	93	16	13	24:47:37

NNRP auth users [Top 20]:

User	Conn
moussa	288
ohlandl	12
kev009	1
TOTAL: 3	301

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
tempe0.bbox.io	2.272	0.545	0.003	06:44:05
dhcp-089-099-203-254.chello.nl	2.238	0.450	0.000	05:29:31
202.89.176.220	29.923	7.469	0.848	05:01:39
68-185-181-64.dhcp.mdsn.wi.charter.com	2.888	0.553	0.034	04:45:58
71.98.160.36	0.436	0.109	0.000	02:08:23
mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	14.954	3.967	0.000	00:36:20
196.52.18.4	0.520	1.047	0.000	00:01:32
94.164.80.189	0.085	0.031	0.000	00:00:02
94.165.44.244	0.093	0.016	0.000	00:00:01
TOTAL: 9	53.409	14.187	0.885	24:47:37

Curious NNRP server explorers [Top 20]:

System	Conn
71.98.160.36	5
216.239.174.89	4
94.165.44.244	1
196.52.18.4	1
94.164.80.189	1
TOTAL: 5	12

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	13	0
71.98.160.36	3	0
68-185-181-64.dhcp.mdsn.wi.charter.com	3	0
TOTAL: 3	19	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	104	85.2%
2	uk	11	9.0%
3	alt	3	2.5%
4	sci	2	1.6%
5	rec	2	1.6%
TOTAL: 5		122	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	68
2	comp.os.vms	12
3	comp.arch.embedded	8
4	comp.arch	6
5	uk.railway	3
6	comp.sys.hp.hardware	3
7	uk.legal	3
8	comp.sys.ibm.pc.hardware.storage	3
9	alt.happy.valley	2
10	uk.rec.sheds	2
11	comp.sys.ibm.as400.misc	2
12	sci.physics	2
13	uk.sci.weather	2
14	uk.people.silversurfers	1
15	alt.bumbling.idiots.the.fbi	1
16	rec.arts.tv	1
17	comp.os.os2.misc	1
18	rec.woodworking	1
19	comp.os.cpm	1
TOTAL: 19		122

Daily Usenet report for csiph.com

Jun 25 04:15:00 -- Jun 26 04:15:00