Daily Usenet report for csiph.com: Feb 5 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	51542	45.2%	9.8 MB	61.9%
nnrpd	33828	29.7%	2.9 MB	18.0%
innd	25357	22.2%	2.7 MB	16.7%
innfeed	3232	2.8%	546.6 KB	3.4%
nocem	46	0.0%	4.5 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	114006	100.0%	15.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	580301	56.3%
Negative hits	398950	38.7%
Do not exist	50078	4.9%
Cache misses	957	0.1%
TOTAL: 4	1030286	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.227	0.0%	404	0.000	7.988	63.000
article cleanup	00:00:00.270	0.0%	50128	0.000	0.005	0.027
article logging	00:00:00.957	0.0%	51019	0.000	0.019	1.155
article parse	00:00:02.284	0.0%	212336	0.002	0.011	0.063
article write	00:01:09.583	0.1%	28587	0.217	2.434	5.774
artlog/artcncl	00:00:00.010	0.0%	379	0.000	0.026	0.333
artlog/artparse	00:00:00.004	0.0%	200	0.000	0.020	1.000
data move	00:00:00.376	0.0%	1024658	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.870	0.0%	402	0.000	2.164	63.000
hishave/artcncl	00:00:00.185	0.0%	404	0.000	0.458	1.411
hishave/artparse	00:00:00.001	0.0%	199	0.000	0.005	0.167
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:30.257	0.0%	1033683	0.002	0.029	0.121
history sync	00:00:03.452	0.0%	364	0.000	9.484	55.500
history write	00:02:45.754	0.2%	50089	0.057	3.309	9.868
hiswrite/artcncl	00:00:00.008	0.0%	2	0.000	4.000	8.000
hiswrite/artparse	00:00:00.517	0.0%	199	0.000	2.598	35.667
idle	23:50:45.121	99.3%	1036320	50.664	82.836	267.360
nntp read	00:00:03.558	0.0%	1049839	0.002	0.003	0.006
overview write	00:02:14.032	0.2%	28587	0.649	4.689	22.678
perl filter	00:02:10.638	0.2%	50011	1.658	2.612	4.315
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.502	0.0%	57213	0.000	0.009	0.023
TOTAL: 24:00:56.316	23:59:51.606	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.089	0.0%	28605	0.000	0.003	0.027
article prepare	00:00:00.009	0.0%	50196	0.000	0.000	0.004
article read	00:00:00.959	0.0%	6433	0.000	0.149	4.182
backlog stats	00:00:00.358	0.0%	688168	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.651	0.0%	496741	0.002	0.005	0.009
data write	00:00:03.346	0.0%	476903	0.002	0.007	0.012
idle	23:53:14.900	100.0%	688168	71.861	124.962	384.876
status file	00:00:00.212	0.0%	313	0.000	0.677	3.250
TOTAL: 23:53:36.999	23:53:22.524	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:11.197	0.0%	48638	0.000	0.230	0.465
idle	148:00:10.626	99.9%	81662	404.395	6524.585	900223.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.051	0.0%	164256	0.000	0.006	0.250
readart	00:00:00.092	0.0%	62	0.000	1.484	55.000
TOTAL: 148:06:43.214	148:00:22.966	99.9%	-	-	-	-

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	34157	5949	25044	3164	17%	23:44:42
2	csiph-out.news.weretis.net	3	65838	4618	60683	537	7%	51:26:39
3	csiph-out.feeder.erje.net	1152	103857	3894	98002	1961	3%	95:00:21
4	feeder.eternal-september.org	12	44002	3727	38585	1690	8%	27:31:54
5	newsfeed.neva.ru	144	63434	2473	54455	6506	3%	71:09:44
6	news-out.aioe.org	3	27593	2459	25092	42	8%	24:09:56
7	newsfeed.fu-berlin.de	47	33712	1414	32022	276	4%	34:05:34
8	news-out.mixmin.net	3	32451	1191	29475	1785	3%	24:08:52
9	news.redatomik.org	2	29098	592	28495	11	2%	26:55:27
10	newsfeeds.xmission.com	1	27877	516	27348	13	1%	23:14:13
11	news.freedyn.net	4	33018	510	32253	255	1%	24:10:05
12	news.fcku.it	1	9613	468	9137	8	4%	24:37:43
13	xanadu-bbs.net	1	48412	413	42545	5454	0%	24:45:20
14	news.swapon.de	4	2263	155	2103	5	6%	24:08:41
15	au2pb.net	1	33603	121	33439	43	0%	26:13:07
16	nntp.pasdenom.info	2	28834	5	28821	8	0%	23:59:32
17	news.bbs.geek.nz	2	29253	5	29247	1	0%	24:08:50
18	localhost	35	1	1	0	0	100%	00:00:00
TOTAL: 18		1705	647016	28511	596746	21759	4%	573:30:40

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	16.8 MB	0.0 KB	29.9 MB	46.7 MB	36%	5.2 KB
2	csiph-out.feeder.erje.net	15.4 MB	61.4 KB	6.8 MB	22.2 MB	69%	3.9 KB
3	csiph-out.news.weretis.net	12.8 MB	1.1 KB	9.3 MB	22.1 MB	57%	4.4 KB
4	feeder.eternal-september.org	9.4 MB	48.2 KB	18.3 MB	27.7 MB	33%	5.2 KB
5	newsfeed.neva.ru	7.5 MB	7.1 KB	59.7 MB	67.2 MB	11%	7.7 KB
6	news-out.aioe.org	6.2 MB	0.0 KB	84.6 KB	6.2 MB	98%	2.6 KB
7	news-out.mixmin.net	4.8 MB	17.7 KB	2.9 MB	7.7 MB	62%	2.6 KB
8	newsfeed.fu-berlin.de	3.3 MB	0.0 KB	602.0 KB	3.9 MB	84%	2.3 KB
9	news.freedyn.net	2.0 MB	2.9 KB	1.6 MB	3.6 MB	54%	4.9 KB
10	newsfeeds.xmission.com	1.9 MB	0.0 KB	159.1 KB	2.1 MB	92%	4.0 KB
11	news.redatomik.org	1.3 MB	5.1 KB	248.7 KB	1.5 MB	83%	2.6 KB
12	xanadu-bbs.net	998.4 KB	46.9 KB	48.0 MB	49.0 MB	1%	8.5 KB
13	news.fcku.it	879.5 KB	0.0 KB	12.0 KB	891.6 KB	98%	1.9 KB
14	news.swapon.de	415.8 KB	6.1 KB	18.9 KB	440.8 KB	94%	2.8 KB
15	au2pb.net	394.3 KB	0.0 KB	211.0 KB	605.3 KB	65%	3.7 KB
16	nntp.pasdenom.info	9.4 KB	0.0 KB	176.8 KB	186.2 KB	5%	14.3 KB
17	news.bbs.geek.nz	6.0 KB	0.0 KB	1.8 KB	7.9 KB	76%	1.3 KB
18	localhost	3.2 KB	0.0 KB	0.0 KB	3.2 KB	100%	3.2 KB
TOTAL: 18		83.9 MB	196.4 KB	177.9 MB	261.9 MB	32%	5.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 5 04:15:00 - 04:59:59	429	1.5%	0.16	1.5 MB	1.8%	0.57
Feb 5 05:00:00 - 05:59:59	618	2.2%	0.17	2.0 MB	2.4%	0.57
Feb 5 06:00:00 - 06:59:59	659	2.3%	0.18	3.0 MB	3.6%	0.85
Feb 5 07:00:00 - 07:59:59	861	3.0%	0.24	2.4 MB	2.8%	0.67
Feb 5 08:00:00 - 08:59:59	1266	4.4%	0.35	3.8 MB	4.5%	1.07
Feb 5 09:00:00 - 09:59:59	1269	4.4%	0.35	3.3 MB	4.0%	0.95
Feb 5 10:00:00 - 10:59:59	1369	4.8%	0.38	3.5 MB	4.2%	0.99
Feb 5 11:00:00 - 11:59:59	1248	4.4%	0.35	3.3 MB	4.0%	0.95
Feb 5 12:00:00 - 12:59:59	1330	4.7%	0.37	3.8 MB	4.5%	1.08
Feb 5 13:00:00 - 13:59:59	1496	5.2%	0.42	4.0 MB	4.8%	1.14
Feb 5 14:00:00 - 14:59:59	1604	5.6%	0.45	4.7 MB	5.7%	1.35
Feb 5 15:00:00 - 15:59:59	1758	6.2%	0.49	4.9 MB	5.8%	1.38
Feb 5 16:00:00 - 16:59:59	1972	6.9%	0.55	5.6 MB	6.7%	1.60
Feb 5 17:00:00 - 17:59:59	1691	5.9%	0.47	5.1 MB	6.1%	1.46
Feb 5 18:00:00 - 18:59:59	1546	5.4%	0.43	4.4 MB	5.3%	1.26
Feb 5 19:00:00 - 19:59:59	1477	5.2%	0.41	4.4 MB	5.2%	1.24
Feb 5 20:00:00 - 20:59:59	1381	4.8%	0.38	4.2 MB	5.0%	1.19
Feb 5 21:00:00 - 21:59:59	1331	4.7%	0.37	3.8 MB	4.5%	1.07
Feb 5 22:00:00 - 22:59:59	1327	4.7%	0.37	3.8 MB	4.5%	1.08
Feb 5 23:00:00 - 23:59:59	1095	3.8%	0.30	3.5 MB	4.1%	0.99
Feb 6 00:00:00 - 00:59:59	810	2.8%	0.23	2.3 MB	2.8%	0.66
Feb 6 01:00:00 - 01:59:59	832	2.9%	0.23	2.7 MB	3.2%	0.76
Feb 6 02:00:00 - 02:59:59	577	2.0%	0.16	1.7 MB	2.0%	0.48
Feb 6 03:00:00 - 03:59:59	453	1.6%	0.13	1.6 MB	1.9%	0.46
Feb 6 04:00:00 - 04:15:00	131	0.5%	0.15	655.7 KB	0.8%	0.73
TOTAL: 24:00:00	28530	100.0%	0.33	83.9 MB	100.0%	0.99

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	6575	1312	3	5260
2	xanadu-bbs.net	5397	32	3	5362
3	usenet.blueworldhosting.com	3168	1381	0	1787
4	csiph-out.feeder.erje.net	2029	437	11	1581
5	news-out.mixmin.net	1794	0	5	1789
6	feeder.eternal-september.org	1761	142	8	1611
7	csiph-out.news.weretis.net	780	329	2	449
8	newsfeed.fu-berlin.de	688	24	0	664
9	news.freedyn.net	263	2	1	260
10	news-out.aioe.org	55	37	0	18
11	news.swapon.de	42	0	3	39
12	au2pb.net	39	28	1	10
13	news.redatomik.org	15	0	3	12
14	newsfeeds.xmission.com	10	7	0	3
15	news.fcku.it	9	0	0	9
16	nntp.pasdenom.info	7	2	0	5
17	news.bbs.geek.nz	1	1	0	0
TOTAL: 17		22633	3734	40	18859

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	708
mailing.freebsd.pkg-fallout	298
lada.talk	170
alt.binaries.multimedia.tatu	169
mailing.freebsd.svn-ports-head	162
mailing.freebsd.svn-ports-all	161
ut.test	153
mailing.freebsd.ports-bugs	109
lada.auto	100
alt.politics.scorched-earth	87
it-alt.sport.calcio.juventus	70
mozilla.dev.tree-alerts	59
alt.survival	44
mailing.openssl.cvs	42
mailing.openbsd.source-changes	41
mailing.freebsd.svn-src-all	40
fa.freebsd.cvs-all	39
mailing.freebsd.svn-src-head	38
pld.cvs.commit	38
fa.openbsd.source-changes	34
TOTAL: 282	3734

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12370
EMP (phn path)	2650
EMP (phl)	972
Binary: misplaced rar	482
PFM bot misc	431
EMP (phn nph)	138
Too many newsgroups	107
Scoring filter (9)	63
Scoring filter (21)	52
Scoring filter (25)	40
Scoring filter (18)	39
User-issued cancel	30
HTML Multipart	26
Scoring filter (20)	25
Too many newsgroups (meow)	25
Scoring filter (10)	25
Binary Payload	18
Scoring filter (16)	17
Scoring filter (23)	15
Scoring filter (15)	14
TOTAL: 46	17692

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	73
	usenet.blueworldhosting.com	4
	TOTAL: 2	77
Huge articles
	csiph-out.news.weretis.net	64
	usenet.blueworldhosting.com	53
	feeder.eternal-september.org	33
	xanadu-bbs.net	33
	news.freedyn.net	5
	news-out.mixmin.net	3
	nntp.pasdenom.info	3
	news.redatomik.org	2
	newsfeeds.xmission.com	2
	TOTAL: 9	198
Including strange strings
	newsfeed.fu-berlin.de	448
	csiph-out.news.weretis.net	244
	csiph-out.feeder.erje.net	68
	feeder.eternal-september.org	46
	news.swapon.de	37
	news-out.aioe.org	14
	news.freedyn.net	10
	news-out.mixmin.net	9
	newsfeed.neva.ru	4
	news.redatomik.org	4
	TOTAL: 14	891
No colon-space in header
	usenet.blueworldhosting.com	1
	TOTAL: 1	1
TOTAL: 4		1167

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	erje	30605	3683	20757	133	2	12%	23:59:37
2	news.freedyn.net	32038	1629	26380	8	0	5%	23:59:45
3	xanadu-bbs	30668	1373	26731	2	20	4%	23:59:51
4	news.bbs.geek.nz	52051	1342	25994	15	1	2%	23:59:51
5	fu-berlin.de	26761	1009	25752	0	0	3%	23:59:44
6	aioe	27310	633	22905	37	0	2%	23:59:51
7	usenet.pasdenom.info	36213	347	26556	1622	90	0%	23:59:51
8	news.redatomik.org	32569	229	26539	12	0	0%	23:59:51
9	au2pb	27982	176	27077	25	0	0%	23:59:51
10	eternal-september	27964	29	23047	1	0	0%	23:59:37
11	xmission	33482	27	27004	2	0	0%	23:59:50
12	neva.ru	29430	19	24325	169	0	0%	23:59:45
13	weretis.net	22833	16	22293	1	0	0%	23:59:47
14	news.fcku.it	4142	14	3498	0	0	0%	23:04:09
15	news.mixmin.net	29803	13	25811	0	0	0%	23:59:31
16	news.swapon.de	2400	1	2173	2	0	0%	23:50:10
17	bwh	22688	1	21324	1	0	0%	23:59:51
TOTAL: 17		468939	10541	378166	2030	113	2%	406:50:52

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	10.7 MB	78.0 KB	10.8 MB	0.1 KB/s	6.8 KB	23:59:45
2	erje	10.4 MB	786.2 KB	11.2 MB	0.1 KB/s	3.0 KB	23:59:37
3	xanadu-bbs	10.1 MB	6.2 KB	10.1 MB	0.1 KB/s	7.5 KB	23:59:51
4	fu-berlin.de	8.8 MB	0.0 KB	8.8 MB	0.1 KB/s	8.9 KB	23:59:44
5	news.bbs.geek.nz	3.8 MB	74.6 KB	3.8 MB	0.0 KB/s	2.9 KB	23:59:51
6	aioe	1.8 MB	239.6 KB	2.1 MB	0.0 KB/s	3.2 KB	23:59:51
7	usenet.pasdenom.info	1.4 MB	9.9 MB	11.3 MB	0.1 KB/s	5.9 KB	23:59:51
8	news.redatomik.org	833.7 KB	169.8 KB	1003.6 KB	0.0 KB/s	4.2 KB	23:59:51
9	au2pb	760.5 KB	264.3 KB	1.0 MB	0.0 KB/s	5.1 KB	23:59:51
10	eternal-september	111.1 KB	0.7 KB	111.8 KB	0.0 KB/s	3.7 KB	23:59:37
11	xmission	77.3 KB	4.5 KB	81.8 KB	0.0 KB/s	2.8 KB	23:59:50
12	neva.ru	77.0 KB	649.3 KB	726.3 KB	0.0 KB/s	3.9 KB	23:59:45
13	weretis.net	64.2 KB	4.0 KB	68.2 KB	0.0 KB/s	4.0 KB	23:59:47
14	news.fcku.it	41.0 KB	0.0 KB	41.0 KB	0.0 KB/s	2.9 KB	23:04:09
15	news.mixmin.net	31.7 KB	0.0 KB	31.7 KB	0.0 KB/s	2.4 KB	23:59:31
16	bwh	3.2 KB	11.1 KB	14.3 KB	0.0 KB/s	7.2 KB	23:59:51
17	news.swapon.de	1.6 KB	3.9 KB	5.5 KB	0.0 KB/s	1.8 KB	23:50:10
TOTAL: 17		48.9 MB	12.1 MB	61.1 MB	0.0 KB/s	5.0 KB	406:50:52

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	53	179.1 KB	52	0	0	04:20:47
2	challenger.nielsenmedia.com	7	4	7.4 KB	3	0	0	02:01:26
3	tempe0.bbox.io	18	3	7.2 KB	2	1	1	05:34:21
4	pool-71-98-160-84.tampfl.dsl-w.verizon.net	2	2	4.1 KB	1	0	0	01:02:33
TOTAL: 4		315	62	197.8 KB	58	1	1	148:06:38

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	369	53	179.1 KB	52	0	0	122:07:21
2	*.nielsenmedia.com	7	4	7.4 KB	3	0	0	02:01:26
3	*.bbox.io	18	3	7.2 KB	2	1	1	05:34:21
4	*.tampfl.dsl-w.verizon.net	2	2	4.1 KB	1	0	0	01:02:33
5	*.dynamic.upc.nl	2	0	0.0 KB	0	0	0	00:04:01
6	*.dynamic.caiway.nl	13	0	0.0 KB	0	0	0	03:05:44
7	*.chello.nl	32	0	0.0 KB	0	0	0	14:11:09
TOTAL: 7		443	62	197.8 KB	58	1	1	148:06:38

NNRP auth users [Top 20]:

User	Conn
moussa	288
kev009	1
TOTAL: 2	289

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
63.142.120.8	6.623	3.274	0.000	61:52:21
162.212.88.221	0.697	0.745	0.000	46:10:58
dhcp-089-099-203-254.chello.nl	2.703	0.515	0.000	14:11:09
71.94.21.184	0.261	0.529	0.000	09:13:11
tempe0.bbox.io	1.781	0.284	0.003	05:34:21
202.89.176.220	27.881	6.902	0.712	04:20:47
041-020-158-163.dynamic.caiway.nl	0.988	0.316	0.000	03:05:44
challenger.nielsenmedia.com	0.839	0.099	0.000	02:01:26
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.157	0.055	0.000	01:02:33
138.108.60.60	0.070	0.039	0.000	00:30:02
92-108-162-83.dynamic.upc.nl	0.156	0.069	0.000	00:04:01
TOTAL: 11	42.156	12.827	0.715	148:06:38

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	80
dhcp-089-099-203-254.chello.nl	32
041-020-158-163.dynamic.caiway.nl	13
92-108-162-83.dynamic.upc.nl	2
138.108.60.60	1
TOTAL: 5	128

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	27	0
tempe0.bbox.io	11	0
041-020-158-163.dynamic.caiway.nl	5	0
challenger.nielsenmedia.com	4	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2	0
138.108.60.60	1	0
TOTAL: 6	50	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	58	93.5%
2	news	4	6.5%
TOTAL: 2		62	100.0%

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

Newsgroup		Count
1	comp.arch.embedded	13
2	comp.sys.ibm.pc.games.action	10
3	comp.os.vms	8
4	comp.lang.awk	6
5	comp.ai.neural-nets	6
6	comp.arch	4
7	news.admin.peering	4
8	comp.os.qnx	3
9	comp.os.cpm	3
10	comp.arch.fpga	2
11	comp.sys.ibm.pc.games.war-historical	1
12	comp.sys.ibm.as400.misc	1
13	comp.sys.ibm.pc.games.rpg	1
TOTAL: 13		62

Daily Usenet report for csiph.com

Feb 5 04:15:00 -- Feb 6 04:15:00