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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	55561	41.4%	9.9 MB	56.5%
nnrpd	43642	32.5%	3.9 MB	22.1%
innd	31859	23.7%	3.2 MB	18.4%
innfeed	3216	2.4%	541.6 KB	3.0%
nocem	29	0.0%	2.9 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	134308	100.0%	17.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	575126	54.9%
Negative hits	416780	39.8%
Do not exist	54735	5.2%
Cache misses	743	0.1%
TOTAL: 4	1047384	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.592	0.0%	171	0.000	3.462	15.333
article cleanup	00:00:00.346	0.0%	54689	0.000	0.006	0.028
article logging	00:00:00.729	0.0%	55309	0.000	0.013	0.060
article parse	00:00:02.183	0.0%	213453	0.000	0.010	0.168
article write	00:00:50.505	0.1%	27311	0.179	1.849	11.556
artlog/artcncl	00:00:00.001	0.0%	163	0.000	0.006	0.091
artlog/artparse	00:00:00.000	0.0%	83	0.000	0.000	0.000
data move	00:00:00.357	0.0%	1003107	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.116	0.0%	170	0.000	0.682	11.000
hishave/artcncl	00:00:00.073	0.0%	171	0.000	0.427	2.355
hishave/artparse	00:00:00.000	0.0%	83	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:12.980	0.0%	1048684	0.001	0.012	0.091
history sync	00:00:02.847	0.0%	339	0.000	8.398	76.000
history write	00:01:44.956	0.1%	54635	0.056	1.921	8.812
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.287	0.0%	83	0.000	3.458	98.000
idle	23:52:36.594	99.4%	1015470	45.500	84.647	310.887
nntp read	00:00:03.324	0.0%	1027151	0.001	0.003	0.006
overview write	00:01:35.436	0.1%	27311	0.915	3.494	20.159
perl filter	00:02:31.546	0.2%	54624	1.167	2.774	4.599
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.472	0.0%	54649	0.000	0.009	0.027
TOTAL: 24:00:44.178	23:59:43.344	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.075	0.0%	27391	0.000	0.003	0.024
article prepare	00:00:00.004	0.0%	27624	0.000	0.000	0.007
article read	00:00:00.426	0.0%	2836	0.000	0.150	5.111
backlog stats	00:00:00.307	0.0%	647399	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.363	0.0%	470921	0.001	0.005	0.011
data write	00:00:03.069	0.0%	451773	0.004	0.007	0.013
idle	23:53:07.495	100.0%	647399	72.917	132.820	396.702
status file	00:00:00.200	0.0%	293	0.000	0.683	1.571
TOTAL: 23:53:25.777	23:53:13.939	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.066	0.0%	15580	0.109	0.133	0.152
idle	80:42:15.201	100.0%	72961	77.998	3982.062	600659.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.846	0.0%	147075	0.000	0.006	0.500
readart	00:00:22.220	0.0%	11450	0.000	1.941	48.000
TOTAL: 80:43:58.937	80:42:40.333	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	288	33014	5240	25575	2199	15%	23:44:56
2	csiph-out.feeder.erje.net	1152	104480	4701	97306	2473	4%	94:57:37
3	feeder.eternal-september.org	17	48780	4050	40725	4005	8%	27:36:36
4	csiph-out.news.weretis.net	4	71838	2814	68405	619	3%	58:23:13
5	newsfeed.neva.ru	148	67233	2571	53304	11358	3%	71:55:22
6	news-out.mixmin.net	3	31467	2230	27580	1657	7%	24:08:53
7	news-out.aioe.org	2	26006	2178	23796	32	8%	24:09:58
8	newsfeed.fu-berlin.de	50	30543	1428	28491	624	4%	32:34:31
9	news.redatomik.org	1	21155	550	20600	5	2%	20:25:08
10	news.fcku.it	1	8904	480	8419	5	5%	24:37:42
11	news.freedyn.net	3	31913	378	31215	320	1%	24:10:08
12	xanadu-bbs.net	1	52844	264	48513	4067	0%	25:04:49
13	newsfeeds.xmission.com	1	24036	229	23800	7	0%	19:22:14
14	au2pb.net	1	33814	157	33624	33	0%	26:13:07
15	news.swapon.de	3	2549	109	2411	29	4%	23:35:43
16	nntp.pasdenom.info	3	27141	43	27094	4	0%	24:08:33
17	localhost	31	1	1	0	0	100%	00:00:00
18	news.bbs.geek.nz	1	29112	1	29111	0	0%	07:55:53
TOTAL: 18		1710	644830	27424	589969	27437	4%	553:04:23

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	17.3 MB	226.5 KB	10.4 MB	27.9 MB	61%	4.0 KB
2	usenet.blueworldhosting.com	14.8 MB	3.2 KB	16.1 MB	31.0 MB	47%	4.3 KB
3	feeder.eternal-september.org	10.1 MB	24.1 KB	46.2 MB	56.4 MB	17%	7.2 KB
4	csiph-out.news.weretis.net	8.8 MB	0.0 KB	6.7 MB	15.5 MB	56%	4.6 KB
5	news-out.mixmin.net	8.1 MB	3.9 KB	2.7 MB	10.8 MB	74%	2.8 KB
6	newsfeed.neva.ru	7.1 MB	206.5 KB	107.1 MB	114.4 MB	6%	8.4 KB
7	news-out.aioe.org	5.1 MB	0.0 KB	35.6 KB	5.1 MB	99%	2.4 KB
8	newsfeed.fu-berlin.de	3.2 MB	0.0 KB	992.5 KB	4.2 MB	76%	2.1 KB
9	news.freedyn.net	1.6 MB	0.0 KB	3.4 MB	5.0 MB	32%	7.3 KB
10	news.redatomik.org	1.2 MB	0.0 KB	6.3 KB	1.2 MB	99%	2.2 KB
11	news.fcku.it	891.5 KB	0.0 KB	8.1 KB	899.5 KB	99%	1.9 KB
12	xanadu-bbs.net	832.9 KB	0.0 KB	25.6 MB	26.4 MB	3%	6.2 KB
13	newsfeeds.xmission.com	623.4 KB	0.0 KB	12.5 KB	635.9 KB	98%	2.7 KB
14	au2pb.net	463.2 KB	0.0 KB	169.2 KB	632.3 KB	73%	3.3 KB
15	news.swapon.de	313.9 KB	0.0 KB	83.9 KB	397.9 KB	78%	2.9 KB
16	nntp.pasdenom.info	82.5 KB	0.0 KB	67.3 KB	149.8 KB	55%	3.2 KB
17	news.bbs.geek.nz	8.3 KB	0.0 KB	0.0 KB	8.3 KB	100%	8.3 KB
18	localhost	1.0 KB	0.0 KB	0.0 KB	1.0 KB	100%	1.0 KB
TOTAL: 18		80.5 MB	464.3 KB	219.6 MB	300.6 MB	26%	5.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 19 04:15:00 - 04:59:59	402	1.5%	0.15	1.2 MB	1.5%	0.47
Feb 19 05:00:00 - 05:59:59	586	2.1%	0.16	2.2 MB	2.7%	0.62
Feb 19 06:00:00 - 06:59:59	749	2.7%	0.21	2.8 MB	3.5%	0.79
Feb 19 07:00:00 - 07:59:59	963	3.5%	0.27	2.9 MB	3.7%	0.84
Feb 19 08:00:00 - 08:59:59	1322	4.8%	0.37	4.0 MB	5.0%	1.14
Feb 19 09:00:00 - 09:59:59	1381	5.1%	0.38	3.7 MB	4.6%	1.04
Feb 19 10:00:00 - 10:59:59	1375	5.0%	0.38	4.1 MB	5.1%	1.17
Feb 19 11:00:00 - 11:59:59	1186	4.3%	0.33	3.4 MB	4.3%	0.97
Feb 19 12:00:00 - 12:59:59	1384	5.1%	0.38	4.3 MB	5.4%	1.22
Feb 19 13:00:00 - 13:59:59	1479	5.4%	0.41	3.8 MB	4.7%	1.07
Feb 19 14:00:00 - 14:59:59	1438	5.3%	0.40	4.1 MB	5.2%	1.17
Feb 19 15:00:00 - 15:59:59	1606	5.9%	0.45	4.7 MB	5.9%	1.33
Feb 19 16:00:00 - 16:59:59	1629	6.0%	0.45	4.9 MB	6.2%	1.40
Feb 19 17:00:00 - 17:59:59	1458	5.3%	0.41	4.2 MB	5.3%	1.21
Feb 19 18:00:00 - 18:59:59	1476	5.4%	0.41	4.3 MB	5.3%	1.21
Feb 19 19:00:00 - 19:59:59	1359	5.0%	0.38	3.5 MB	4.3%	0.98
Feb 19 20:00:00 - 20:59:59	1149	4.2%	0.32	3.1 MB	3.9%	0.89
Feb 19 21:00:00 - 21:59:59	1612	5.9%	0.45	4.7 MB	5.8%	1.32
Feb 19 22:00:00 - 22:59:59	1266	4.6%	0.35	3.7 MB	4.7%	1.07
Feb 19 23:00:00 - 23:59:59	895	3.3%	0.25	2.4 MB	3.0%	0.68
Feb 20 00:00:00 - 00:59:59	706	2.6%	0.20	2.2 MB	2.7%	0.62
Feb 20 01:00:00 - 01:59:59	709	2.6%	0.20	2.3 MB	2.8%	0.64
Feb 20 02:00:00 - 02:59:59	609	2.2%	0.17	1.7 MB	2.1%	0.49
Feb 20 03:00:00 - 03:59:59	463	1.7%	0.13	1.3 MB	1.7%	0.38
Feb 20 04:00:00 - 04:15:00	115	0.4%	0.13	541.9 KB	0.7%	0.60
TOTAL: 24:00:00	27317	100.0%	0.32	80.0 MB	100.0%	0.95

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	11382	1229	21	10132
2	feeder.eternal-september.org	4058	82	5	3971
3	xanadu-bbs.net	4055	33	0	4022
4	csiph-out.feeder.erje.net	2510	321	26	2163
5	usenet.blueworldhosting.com	2202	1015	1	1186
6	news-out.mixmin.net	1669	7	1	1661
7	newsfeed.fu-berlin.de	1109	30	0	1079
8	csiph-out.news.weretis.net	613	241	0	372
9	news.freedyn.net	330	1	0	329
10	news-out.aioe.org	55	33	0	22
11	news.swapon.de	50	0	0	50
12	au2pb.net	26	21	0	5
13	newsfeeds.xmission.com	7	7	0	0
14	news.redatomik.org	6	0	0	6
15	news.fcku.it	5	0	0	5
16	nntp.pasdenom.info	4	2	0	2
TOTAL: 16		28081	3022	54	25005

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	736
lada.talk	108
ut.test	102
mailing.freebsd.svn-ports-all	81
mailing.freebsd.svn-ports-head	80
mailing.freebsd.ports-bugs	72
lada.auto	68
mailing.freebsd.pkg-fallout	67
mailing.freebsd.svn-src-all	64
mailing.freebsd.www	63
mailing.freebsd.doc	63
mailing.freebsd.svn-src-head	62
fa.freebsd.cvs-all	60
it-alt.sport.calcio.juventus	46
mailing.openssl.cvs	39
mailing.gcc.gcc-cvs	35
mailing.postfix.users	32
mailing.gcc.gcc	31
mailing.openbsd.misc	31
spline.eisfair	28
TOTAL: 267	3022

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	17868
EMP (phn path)	3570
PFM bot misc	879
EMP (phl)	824
User-issued cancel	464
EMP (phn nph)	149
Too many newsgroups	97
Scoring filter (18)	49
Scoring filter (20)	27
Binary Payload	25
Scoring filter (19)	25
HTML Multipart	24
Scoring filter (10)	21
Binary: misplaced rar	21
Too many newsgroups (meow)	18
Scoring filter (25)	17
Scoring filter (22)	17
Scoring filter (9)	17
Scoring filter (15)	16
HTML Image Tags	15
TOTAL: 46	24295

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	9
	usenet.blueworldhosting.com	2
	TOTAL: 2	11
Bad Message-ID's offered
	csiph-out.feeder.erje.net	3
	usenet.blueworldhosting.com	1
	TOTAL: 2	4
Huge articles
	csiph-out.news.weretis.net	37
	usenet.blueworldhosting.com	14
	feeder.eternal-september.org	13
	news-out.mixmin.net	8
	xanadu-bbs.net	5
	news.freedyn.net	5
	nntp.pasdenom.info	1
	TOTAL: 7	83
Including strange strings
	newsfeed.fu-berlin.de	435
	csiph-out.news.weretis.net	37
	csiph-out.feeder.erje.net	36
	feeder.eternal-september.org	23
	newsfeed.neva.ru	23
	news-out.aioe.org	22
	news.swapon.de	21
	news-out.mixmin.net	16
	news.fcku.it	1
	au2pb.net	1
	TOTAL: 11	616
TOTAL: 4		714

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	30249	1326	25602	4	0	4%	23:59:53
2	xanadu-bbs	29614	1140	25915	1	10	3%	23:59:53
3	fu-berlin.de	25513	939	24574	0	0	3%	23:59:53
4	news.bbs.geek.nz	50494	760	25530	30	0	1%	23:59:51
5	aioe	26212	365	22440	40	0	1%	23:59:53
6	usenet.pasdenom.info	34487	267	25627	1378	2	0%	23:59:53
7	au2pb	27109	98	26107	5	0	0%	23:59:46
8	news.redatomik.org	31155	77	25584	9	0	0%	23:59:53
9	xmission	34154	70	25858	9	0	0%	23:59:53
10	news.mixmin.net	27838	24	23764	0	0	0%	23:59:45
11	erje	26445	23	22404	95	0	0%	23:59:53
12	news.fcku.it	3696	19	3194	0	0	0%	23:02:58
13	weretis.net	23548	15	23138	5	0	0%	23:59:51
14	eternal-september	26800	9	21817	1	0	0%	23:59:53
15	neva.ru	27943	9	22996	198	0	0%	23:59:52
16	bwh	22097	1	20940	0	108	0%	23:59:53
17	news.swapon.de	2562	1	2249	3	0	0%	23:55:52
TOTAL: 17		449916	5143	367739	1778	120	1%	406:56:45

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	8.8 MB	10.7 KB	8.8 MB	0.1 KB/s	6.8 KB	23:59:53
2	xanadu-bbs	8.2 MB	13.9 KB	8.2 MB	0.1 KB/s	7.4 KB	23:59:53
3	fu-berlin.de	7.8 MB	0.0 KB	7.8 MB	0.1 KB/s	8.5 KB	23:59:53
4	news.bbs.geek.nz	2.0 MB	99.3 KB	2.1 MB	0.0 KB/s	2.7 KB	23:59:51
5	aioe	980.7 KB	130.0 KB	1.1 MB	0.0 KB/s	2.7 KB	23:59:53
6	usenet.pasdenom.info	969.5 KB	8.4 MB	9.4 MB	0.1 KB/s	5.8 KB	23:59:53
7	au2pb	288.0 KB	29.8 KB	317.8 KB	0.0 KB/s	3.1 KB	23:59:46
8	news.redatomik.org	208.5 KB	26.3 KB	234.8 KB	0.0 KB/s	2.7 KB	23:59:53
9	xmission	156.6 KB	19.2 KB	175.8 KB	0.0 KB/s	2.2 KB	23:59:53
10	news.mixmin.net	76.5 KB	0.0 KB	76.5 KB	0.0 KB/s	3.2 KB	23:59:45
11	news.fcku.it	56.7 KB	0.0 KB	56.7 KB	0.0 KB/s	3.0 KB	23:02:58
12	erje	42.4 KB	354.3 KB	396.7 KB	0.0 KB/s	3.4 KB	23:59:53
13	weretis.net	36.8 KB	12.8 KB	49.6 KB	0.0 KB/s	2.5 KB	23:59:51
14	eternal-september	19.4 KB	1.3 KB	20.8 KB	0.0 KB/s	2.1 KB	23:59:53
15	neva.ru	18.1 KB	688.8 KB	706.9 KB	0.0 KB/s	3.4 KB	23:59:52
16	bwh	1.0 KB	0.0 KB	1.0 KB	0.0 KB/s	1.0 KB	23:59:53
17	news.swapon.de	1.0 KB	8.5 KB	9.5 KB	0.0 KB/s	2.4 KB	23:55:52
TOTAL: 17		29.5 MB	9.8 MB	39.3 MB	0.0 KB/s	5.8 KB	406:56:45

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	101	288.4 KB	94	0	0	04:36:53
2	mtrlpq2314w-lp140-01-845526598.dsl.bell.ca	48	49	72.0 KB	23	0	0	00:34:54
3	92-108-162-83.dynamic.upc.nl	2	12	15.3 KB	1	0	0	00:32:23
4	dhcp-089-099-203-254.chello.nl	27	5	6.3 KB	2	0	0	09:24:25
5	68-185-181-64.dhcp.mdsn.wi.charter.com	10	1	1.0 KB	1	1	1	02:55:52
6	tempe0.bbox.io	39	1	1.0 KB	1	0	0	05:03:42
TOTAL: 6		414	169	384.0 KB	122	1	1	80:43:54

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	292	101	288.4 KB	94	0	0	58:38:14
2	*.dsl.bell.ca	48	49	72.0 KB	23	0	0	00:34:54
3	*.dynamic.upc.nl	2	12	15.3 KB	1	0	0	00:32:23
4	*.chello.nl	27	5	6.3 KB	2	0	0	09:24:25
5	*.bbox.io	39	1	1.0 KB	1	0	0	05:03:42
6	*.dhcp.mdsn.wi.charter.com	10	1	1.0 KB	1	1	1	02:55:52
7	*.tampfl.dsl-w.verizon.net	3	0	0.0 KB	0	0	0	02:04:18
8	*.nielsenmedia.com	3	0	0.0 KB	0	0	0	01:30:03
TOTAL: 8		424	169	384.0 KB	122	1	1	80:43:54

NNRP auth users [Top 20]:

User	Conn
moussa	288
ohlandl	1
TOTAL: 2	289

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.221	0.569	0.783	0.000	54:01:20
dhcp-089-099-203-254.chello.nl	2.273	0.495	0.000	09:24:25
tempe0.bbox.io	3.111	0.753	0.000	05:03:42
202.89.176.220	28.679	7.197	0.733	04:36:53
68-185-181-64.dhcp.mdsn.wi.charter.com	0.882	0.191	0.003	02:55:52
pool-71-98-160-36.tampfl.dsl-w.verizon.net	0.349	0.124	0.000	02:04:18
challenger.nielsenmedia.com	0.222	0.066	0.000	01:30:03
mtrlpq2314w-lp140-01-845526598.dsl.bell.ca	6.933	2.929	0.000	00:34:54
92-108-162-83.dynamic.upc.nl	0.241	0.039	0.000	00:32:23
TOTAL: 9	43.259	12.577	0.736	80:43:54

Curious NNRP server explorers [Top 20]:

System	Conn
162.212.88.221	4
challenger.nielsenmedia.com	3
pool-71-98-160-36.tampfl.dsl-w.verizon.net	3
TOTAL: 3	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	14	0
tempe0.bbox.io	9	0
68-185-181-64.dhcp.mdsn.wi.charter.com	4	0
pool-71-98-160-36.tampfl.dsl-w.verizon.net	4	0
challenger.nielsenmedia.com	3	0
92-108-162-83.dynamic.upc.nl	1	0
TOTAL: 6	35	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	120	71.0%
2	alt	38	22.5%
3	rec	3	1.8%
4	bit	3	1.8%
5	uk	2	1.2%
6	sci	2	1.2%
7	fr	1	0.6%
TOTAL: 7		169	100.0%

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

Newsgroup		Count
1	comp.os.vms	47
2	alt.drugs.heroin	30
3	comp.sys.ibm.ps2.hardware	20
4	comp.sys.ibm.pc.games.action	15
5	comp.arch	13
6	comp.sys.ibm.pc.hardware.storage	8
7	comp.os.cpm	5
8	comp.sys.ibm.pc.games.rpg	4
9	comp.os.msdos.programmer	3
10	bit.listserv.ibm-main	3
11	sci.physics	2
12	comp.ai.neural-nets	2
13	alt.atheism	2
14	uk.d-i-y	2
15	alt.happy.valley	2
16	fr.soc.politique	1
17	alt.sports.football.pro.sd-chargers	1
18	comp.os.msdos.djgpp	1
19	rec.heraldry	1
20	rec.outdoors.rv-travel	1
21	comp.os.linux.networking	1
22	comp.sys.ibm.pc.hardware.chips	1
23	alt.sports.basketball.nba.gs-warriors	1
24	alt.rush-limbaugh	1
25	rec.arts.tv	1
26	alt.support.diabetes	1
TOTAL: 26		169

Daily Usenet report for csiph.com

Feb 19 04:15:00 -- Feb 20 04:15:00