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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	45236	38.4%	8.3 MB	54.1%
nnrpd	43452	36.9%	3.8 MB	24.8%
innd	25779	21.9%	2.7 MB	17.6%
innfeed	3215	2.7%	541.2 KB	3.4%
nocem	113	0.1%	11.7 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	117796	100.0%	15.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	507016	56.1%
Negative hits	350939	38.9%
Do not exist	44548	4.9%
Cache misses	557	0.1%
TOTAL: 4	903060	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.232	0.0%	233	0.000	0.996	21.000
article cleanup	00:00:00.266	0.0%	44449	0.000	0.006	0.022
article logging	00:00:00.554	0.0%	44921	0.000	0.012	0.067
article parse	00:00:01.927	0.0%	178703	0.001	0.011	0.076
article write	00:00:51.491	0.1%	23741	0.233	2.169	11.994
artlog/artcncl	00:00:00.002	0.0%	137	0.000	0.015	1.000
artlog/artparse	00:00:00.004	0.0%	201	0.000	0.020	1.000
data move	00:00:00.317	0.0%	880146	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.015	0.0%	232	0.000	0.065	5.000
hishave/artcncl	00:00:00.003	0.0%	233	0.000	0.013	0.214
hishave/artparse	00:00:00.001	0.0%	200	0.000	0.005	0.036
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:18.593	0.0%	904488	0.002	0.021	0.102
history sync	00:00:02.764	0.0%	346	0.000	7.988	153.000
history write	00:01:21.641	0.1%	44430	0.093	1.838	7.582
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.377	0.0%	200	0.000	1.885	40.000
idle	23:53:51.549	99.5%	912114	54.375	94.321	268.934
nntp read	00:00:03.046	0.0%	920354	0.001	0.003	0.006
overview write	00:01:22.217	0.1%	23741	1.095	3.463	33.147
perl filter	00:01:53.757	0.1%	44374	1.439	2.564	4.383
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.431	0.0%	47586	0.000	0.009	0.027
TOTAL: 24:00:46.749	23:59:49.187	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.067	0.0%	23974	0.000	0.003	0.017
article prepare	00:00:00.003	0.0%	27324	0.000	0.000	0.005
article read	00:00:00.793	0.0%	2918	0.000	0.272	14.182
backlog stats	00:00:00.260	0.0%	568748	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.151	0.0%	411941	0.002	0.005	0.009
data write	00:00:02.735	0.0%	392558	0.003	0.007	0.013
idle	23:53:37.320	100.0%	568748	64.794	151.240	434.658
status file	00:00:00.199	0.0%	290	0.000	0.686	1.250
TOTAL: 23:53:54.175	23:53:43.528	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:03.556	0.0%	63012	0.000	0.056	0.778
idle	91:48:16.836	99.6%	118616	78.230	2786.275	600152.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.390	0.0%	283714	0.000	0.008	1.633
readart	00:00:21.152	0.0%	12154	0.000	1.740	66.000
TOTAL: 92:08:22.979	91:48:43.934	99.6%	-	-	-	-

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	29426	5178	21764	2484	17%	23:44:43
2	csiph-out.feeder.erje.net	1152	92194	5088	85636	1470	5%	94:58:40
3	news-out.mixmin.net	3	29430	2671	24351	2408	9%	24:11:57
4	feeder.eternal-september.org	4	39670	2613	35679	1378	6%	25:07:52
5	csiph-out.news.weretis.net	4	50089	1921	47422	746	3%	40:29:08
6	newsfeed.neva.ru	153	56478	1569	46772	8137	2%	71:57:28
7	news-out.aioe.org	2	23273	1418	21812	43	6%	24:09:58
8	newsfeed.fu-berlin.de	24	25570	1082	23900	588	4%	25:53:12
9	news.redatomik.org	17	26688	502	26144	42	1%	26:34:54
10	news.fcku.it	2	8474	472	8002	0	5%	29:09:55
11	newsfeeds.xmission.com	1	21240	445	20790	5	2%	22:35:38
12	news.freedyn.net	3	28457	220	28065	172	0%	24:08:36
13	au2pb.net	1	26063	147	25882	34	0%	26:13:07
14	xanadu-bbs.net	5	43047	84	39667	3296	0%	24:51:47
15	news.swapon.de	5	2913	63	2836	14	2%	23:36:24
16	nntp.pasdenom.info	2	23759	30	23724	5	0%	23:59:30
17	news.bbs.geek.nz	2	22566	5	22561	0	0%	23:59:43
18	localhost	38	3	3	0	0	100%	00:00:01
TOTAL: 18		1706	549340	23511	505007	20822	4%	555:42:33

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	17.5 MB	15.6 KB	4.7 MB	22.1 MB	78%	3.5 KB
2	usenet.blueworldhosting.com	16.0 MB	0.0 KB	23.8 MB	39.8 MB	40%	5.3 KB
3	news-out.mixmin.net	8.5 MB	3.8 KB	4.8 MB	13.3 MB	63%	2.7 KB
4	feeder.eternal-september.org	6.9 MB	0.0 KB	14.4 MB	21.2 MB	32%	5.4 KB
5	csiph-out.news.weretis.net	6.1 MB	0.0 KB	8.2 MB	14.4 MB	42%	5.5 KB
6	newsfeed.neva.ru	4.8 MB	131.8 KB	66.1 MB	71.0 MB	6%	7.5 KB
7	news-out.aioe.org	3.5 MB	0.0 KB	60.6 KB	3.5 MB	98%	2.5 KB
8	newsfeed.fu-berlin.de	2.6 MB	0.0 KB	1.5 MB	4.1 MB	62%	2.5 KB
9	newsfeeds.xmission.com	1.1 MB	0.0 KB	92.8 KB	1.2 MB	92%	2.8 KB
10	news.freedyn.net	1019.0 KB	0.0 KB	2.0 MB	3.0 MB	33%	7.8 KB
11	news.redatomik.org	1001.2 KB	0.0 KB	145.5 KB	1.1 MB	87%	2.1 KB
12	news.fcku.it	878.4 KB	0.0 KB	0.0 KB	878.4 KB	100%	1.9 KB
13	au2pb.net	431.1 KB	0.0 KB	933.5 KB	1.3 MB	31%	7.5 KB
14	xanadu-bbs.net	404.5 KB	0.0 KB	29.5 MB	29.9 MB	1%	9.1 KB
15	news.swapon.de	196.1 KB	0.0 KB	40.8 KB	236.8 KB	82%	3.1 KB
16	nntp.pasdenom.info	59.4 KB	0.0 KB	175.0 KB	234.5 KB	25%	6.7 KB
17	news.bbs.geek.nz	7.2 KB	0.0 KB	0.0 KB	7.2 KB	100%	1.4 KB
18	localhost	3.7 KB	0.0 KB	0.0 KB	3.7 KB	100%	1.2 KB
TOTAL: 18		70.8 MB	151.2 KB	156.5 MB	227.5 MB	31%	5.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 28 04:15:00 - 04:59:59	383	1.6%	0.14	1.1 MB	1.6%	0.43
Feb 28 05:00:00 - 05:59:59	410	1.7%	0.11	1.3 MB	1.9%	0.38
Feb 28 06:00:00 - 06:59:59	490	2.1%	0.14	1.7 MB	2.3%	0.47
Feb 28 07:00:00 - 07:59:59	631	2.7%	0.18	1.7 MB	2.4%	0.49
Feb 28 08:00:00 - 08:59:59	801	3.4%	0.22	2.4 MB	3.4%	0.70
Feb 28 09:00:00 - 09:59:59	849	3.6%	0.24	2.2 MB	3.1%	0.63
Feb 28 10:00:00 - 10:59:59	1124	4.7%	0.31	3.3 MB	4.6%	0.94
Feb 28 11:00:00 - 11:59:59	1184	5.0%	0.33	3.7 MB	5.2%	1.06
Feb 28 12:00:00 - 12:59:59	1071	4.5%	0.30	3.4 MB	4.7%	0.96
Feb 28 13:00:00 - 13:59:59	1143	4.8%	0.32	3.2 MB	4.4%	0.90
Feb 28 14:00:00 - 14:59:59	1436	6.0%	0.40	5.2 MB	7.3%	1.48
Feb 28 15:00:00 - 15:59:59	1400	5.9%	0.39	4.9 MB	6.9%	1.41
Feb 28 16:00:00 - 16:59:59	1295	5.5%	0.36	3.3 MB	4.6%	0.95
Feb 28 17:00:00 - 17:59:59	1356	5.7%	0.38	3.8 MB	5.3%	1.07
Feb 28 18:00:00 - 18:59:59	1341	5.6%	0.37	3.8 MB	5.3%	1.08
Feb 28 19:00:00 - 19:59:59	1276	5.4%	0.35	3.5 MB	4.9%	1.01
Feb 28 20:00:00 - 20:59:59	1327	5.6%	0.37	3.6 MB	5.0%	1.02
Feb 28 21:00:00 - 21:59:59	1440	6.1%	0.40	4.1 MB	5.8%	1.17
Feb 28 22:00:00 - 22:59:59	1304	5.5%	0.36	3.8 MB	5.2%	1.07
Feb 28 23:00:00 - 23:59:59	957	4.0%	0.27	2.8 MB	3.9%	0.80
Feb 29 00:00:00 - 00:59:59	785	3.3%	0.22	2.6 MB	3.6%	0.73
Feb 29 01:00:00 - 01:59:59	622	2.6%	0.17	2.2 MB	3.0%	0.61
Feb 29 02:00:00 - 02:59:59	484	2.0%	0.13	1.6 MB	2.3%	0.47
Feb 29 03:00:00 - 03:59:59	491	2.1%	0.14	1.7 MB	2.4%	0.48
Feb 29 04:00:00 - 04:15:00	138	0.6%	0.15	670.2 KB	0.9%	0.74
TOTAL: 24:00:00	23738	100.0%	0.27	71.7 MB	100.0%	0.85

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	8106	821	16	7269
2	xanadu-bbs.net	3323	29	0	3294
3	usenet.blueworldhosting.com	2487	952	0	1535
4	news-out.mixmin.net	2398	3	1	2394
5	csiph-out.feeder.erje.net	1490	303	3	1184
6	feeder.eternal-september.org	1349	105	0	1244
7	newsfeed.fu-berlin.de	1026	28	0	998
8	csiph-out.news.weretis.net	807	123	0	684
9	news.freedyn.net	172	1	0	171
10	news-out.aioe.org	54	48	0	6
11	au2pb.net	52	49	0	3
12	news.redatomik.org	52	0	0	52
13	news.swapon.de	26	0	0	26
14	newsfeeds.xmission.com	9	6	0	3
15	nntp.pasdenom.info	5	2	0	3
16	news.fcku.it	5	0	0	5
TOTAL: 16		21361	2470	20	18871

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	286
ut.test	256
mailing.freebsd.ports-bugs	211
lada.talk	195
it-alt.sport.calcio.juventus	90
mailing.freebsd.svn-ports-all	89
mailing.freebsd.svn-ports-head	80
mailing.openssl.cvs	43
mailing.freebsd.pkg-fallout	37
mailing.openbsd.tech	35
fa.openbsd.tech	35
alt.survival	33
mpc.lists.nanog	32
mailing.freebsd.svn-src-all	30
fa.freebsd.cvs-all	29
mailing.openbsd.source-changes	26
fa.openbsd.source-changes	26
mozilla.dev.ports.os2	25
alt.politics	24
mailing.freebsd.svn-src-head	21
TOTAL: 212	2470

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12397
EMP (phn path)	3319
EMP (phl)	1132
PFM bot misc	571
EMP (phn nph)	307
Binary: misplaced rar	117
User-issued cancel	58
Too many newsgroups	35
Scoring filter (21)	21
Binary Payload	20
Scoring filter (11)	19
HTML Multipart	16
Scoring filter (25)	12
Scoring filter (10)	12
Scoring filter (12)	12
Scoring filter (17)	11
HTML Image Tags	8
Scoring filter (27)	7
Scoring filter (20)	7
Scoring filter (18)	6
TOTAL: 39	18143

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	51
	usenet.blueworldhosting.com	4
	TOTAL: 2	55
Huge articles
	csiph-out.news.weretis.net	71
	usenet.blueworldhosting.com	59
	feeder.eternal-september.org	20
	news-out.mixmin.net	18
	news.freedyn.net	17
	xanadu-bbs.net	9
	nntp.pasdenom.info	3
	newsfeeds.xmission.com	1
	newsfeed.fu-berlin.de	1
	news.redatomik.org	1
	TOTAL: 10	200
Including strange strings
	newsfeed.fu-berlin.de	368
	csiph-out.feeder.erje.net	25
	csiph-out.news.weretis.net	20
	news-out.mixmin.net	15
	news.swapon.de	12
	news.redatomik.org	8
	feeder.eternal-september.org	7
	news-out.aioe.org	6
	news.fcku.it	5
	newsfeed.neva.ru	3
	TOTAL: 12	472
TOTAL: 3		727

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	26169	1237	22254	17	0	4%	23:59:46
2	xanadu-bbs	26114	1212	22431	2	157	4%	23:59:53
3	fu-berlin.de	22303	983	21320	0	0	4%	23:59:50
4	news.bbs.geek.nz	43258	491	22166	13	1	1%	23:59:53
5	aioe	22848	386	19482	16	0	1%	23:59:52
6	news.redatomik.org	37445	200	21986	20	112	0%	23:59:53
7	usenet.pasdenom.info	30964	186	21876	1646	10	0%	23:59:53
8	au2pb	23267	87	22409	7	0	0%	23:59:47
9	xmission	28204	46	22152	1	0	0%	23:59:54
10	news.mixmin.net	23292	26	19517	0	0	0%	23:59:22
11	eternal-september	24188	22	19173	0	0	0%	23:59:53
12	weretis.net	20744	21	20121	1	0	0%	23:59:33
13	news.fcku.it	2011	19	1733	0	0	0%	22:42:25
14	erje	18808	10	18450	3	0	0%	23:59:53
15	neva.ru	25653	8	20663	169	0	0%	23:59:45
16	news.swapon.de	2343	7	2080	9	0	0%	23:45:52
17	bwh	18604	4	17416	1	0	0%	23:59:32
TOTAL: 17		396215	4945	315229	1905	280	1%	406:24:56

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	8.6 MB	49.2 KB	8.6 MB	0.1 KB/s	7.0 KB	23:59:46
2	xanadu-bbs	8.2 MB	4.2 KB	8.2 MB	0.1 KB/s	6.9 KB	23:59:53
3	fu-berlin.de	7.6 MB	0.0 KB	7.6 MB	0.1 KB/s	8.0 KB	23:59:50
4	news.bbs.geek.nz	1.2 MB	45.6 KB	1.3 MB	0.0 KB/s	2.6 KB	23:59:53
5	aioe	1.0 MB	69.8 KB	1.1 MB	0.0 KB/s	2.8 KB	23:59:52
6	usenet.pasdenom.info	646.0 KB	9.0 MB	9.6 MB	0.1 KB/s	5.4 KB	23:59:53
7	news.redatomik.org	508.6 KB	54.8 KB	563.3 KB	0.0 KB/s	2.6 KB	23:59:53
8	au2pb	220.4 KB	30.9 KB	251.3 KB	0.0 KB/s	2.7 KB	23:59:47
9	xmission	117.5 KB	3.3 KB	120.8 KB	0.0 KB/s	2.6 KB	23:59:54
10	news.mixmin.net	56.6 KB	0.0 KB	56.6 KB	0.0 KB/s	2.2 KB	23:59:22
11	weretis.net	48.7 KB	6.6 KB	55.2 KB	0.0 KB/s	2.5 KB	23:59:33
12	eternal-september	45.2 KB	0.0 KB	45.2 KB	0.0 KB/s	2.1 KB	23:59:53
13	erje	44.5 KB	14.9 KB	59.3 KB	0.0 KB/s	4.6 KB	23:59:53
14	news.fcku.it	36.9 KB	0.0 KB	36.9 KB	0.0 KB/s	1.9 KB	22:42:25
15	news.swapon.de	21.7 KB	25.9 KB	47.6 KB	0.0 KB/s	3.0 KB	23:45:52
16	neva.ru	19.4 KB	677.8 KB	697.2 KB	0.0 KB/s	3.9 KB	23:59:45
17	bwh	7.3 KB	2.0 KB	9.3 KB	0.0 KB/s	1.9 KB	23:59:32
TOTAL: 17		28.4 MB	9.9 MB	38.4 MB	0.0 KB/s	5.7 KB	406:24:56

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	28	73.4 KB	27	0	0	04:46:12
2	mtrlpq2314w-lp140-01-845526598.dsl.bell.ca	48	18	42.4 KB	14	0	0	00:31:51
3	dhcp-089-099-203-254.chello.nl	13	3	3.5 KB	2	0	0	05:26:14
4	68-185-181-64.dhcp.mdsn.wi.charter.com	12	3	3.7 KB	3	2	2	03:30:16
5	tempe0.bbox.io	38	2	2.7 KB	2	1	1	07:04:39
6	206.217.197.145	1	1	0.9 KB	1	0	0	00:30:44
TOTAL: 6		400	55	126.5 KB	49	3	3	92:08:18

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	291	29	74.3 KB	28	0	0	05:17:03
2	*.dsl.bell.ca	48	18	42.4 KB	14	0	0	00:31:51
3	*.dhcp.mdsn.wi.charter.com	12	3	3.7 KB	3	2	2	03:30:16
4	*.chello.nl	13	3	3.5 KB	2	0	0	05:26:14
5	*.bbox.io	38	2	2.7 KB	2	1	1	07:04:39
6	*.ip-188-165-239.eu	4	0	0.0 KB	0	0	0	00:00:46
7	*.dsl.klmzmi.sbcglobal.net	1	0	0.0 KB	0	0	0	00:00:01
8	*.tampfl.dsl-w.verizon.net	3	0	0.0 KB	0	0	0	01:30:03
TOTAL: 8		410	55	126.5 KB	49	3	3	92:08:18

NNRP auth users [Top 20]:

User	Conn
moussa	288
ohlandl	2
kev009	1
TOTAL: 3	291

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
h235.157.22.98.dynamic.ip.windstream.net	1.238	2.690	0.000	68:47:22
tempe0.bbox.io	3.202	0.631	0.003	07:04:39
dhcp-089-099-203-254.chello.nl	1.257	0.226	0.000	05:26:14
202.89.176.220	26.293	7.079	0.715	04:46:12
68-185-181-64.dhcp.mdsn.wi.charter.com	1.004	0.289	0.004	03:30:16
pool-71-98-160-36.tampfl.dsl-w.verizon.net	0.251	0.086	0.000	01:30:03
mtrlpq2314w-lp140-01-845526598.dsl.bell.ca	6.976	2.697	0.000	00:31:51
206.217.197.145	0.228	0.118	0.000	00:30:44
ns342002.ip-188-165-239.eu	0.382	0.081	0.000	00:00:46
196.52.22.61	0.195	0.242	0.000	00:00:06
adsl-76-235-162-114.dsl.klmzmi.sbcglobal.net	0.086	0.024	0.000	00:00:01
TOTAL: 11	41.112	14.163	0.722	92:08:18

Curious NNRP server explorers [Top 20]:

System	Conn
ns342002.ip-188-165-239.eu	4
pool-71-98-160-36.tampfl.dsl-w.verizon.net	3
196.52.22.61	1
50.96.159.243	1
adsl-76-235-162-114.dsl.klmzmi.sbcglobal.net	1
TOTAL: 5	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	10	0
tempe0.bbox.io	8	0
68-185-181-64.dhcp.mdsn.wi.charter.com	5	0
pool-71-98-160-36.tampfl.dsl-w.verizon.net	3	0
206.217.197.145	1	0
h235.157.22.98.dynamic.ip.windstream.net	1	0
TOTAL: 6	28	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	37	67.3%
2	alt	10	18.2%
3	sci	5	9.1%
4	bit	1	1.8%
5	rec	1	1.8%
6	uk	1	1.8%
TOTAL: 6		55	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	12
2	comp.os.vms	9
3	comp.ai.neural-nets	7
4	comp.arch.embedded	5
5	sci.physics	5
6	alt.support.dissociation	4
7	alt.happy.valley	2
8	comp.sys.ibm.pc.hardware.storage	1
9	bit.listserv.ibm-main	1
10	comp.arch.fpga	1
11	alt.drugs.heroin	1
12	rec.arts.tv	1
13	uk.radio.amateur	1
14	alt.sports.basketball.nba.gs-warriors	1
15	alt.agnosticism	1
16	alt.autos.toyota	1
17	comp.ai.genetic	1
18	comp.os.msdos.djgpp	1
TOTAL: 18		55

Daily Usenet report for csiph.com

Feb 28 04:15:00 -- Feb 29 04:15:00