Daily Usenet report for csiph.com: Sep 2 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	51429	48.7%	7.5 MB	60.4%
nnrpd	32062	30.3%	2.7 MB	21.5%
innd	20293	19.2%	2.0 MB	16.1%
innfeed	1865	1.8%	264.9 KB	2.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	105650	100.0%	12.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	272477	46.7%
Negative hits	254822	43.7%
Do not exist	50468	8.7%
Cache misses	5600	1.0%
TOTAL: 4	583367	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.212	0.0%	238	0.000	0.891	10.000
article cleanup	00:00:00.276	0.0%	48925	0.000	0.006	0.017
article logging	00:00:00.614	0.0%	49384	0.000	0.012	0.032
article parse	00:00:03.690	0.0%	386950	0.002	0.010	0.015
article write	00:00:06.598	0.0%	28451	0.140	0.232	0.370
artlog/artcncl	00:00:00.002	0.0%	196	0.000	0.010	1.000
artlog/artparse	00:00:00.020	0.0%	1857	0.000	0.011	0.500
data move	00:00:00.353	0.0%	880609	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.007	0.0%	237	0.000	0.030	1.000
hishave/artcncl	00:00:00.000	0.0%	238	0.000	0.000	0.000
hishave/artparse	00:00:00.005	0.0%	1857	0.000	0.003	0.059
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.411	0.0%	584306	0.000	0.002	0.007
history sync	00:00:00.523	0.0%	310	0.000	1.687	3.500
history write	00:00:12.689	0.0%	48924	0.087	0.259	0.321
hiswrite/artcncl	00:00:00.001	0.0%	1	1.000	1.000	1.000
hiswrite/artparse	00:00:00.472	0.0%	1857	0.000	0.254	3.000
idle	23:57:44.437	99.8%	860454	19.410	100.255	319.764
nntp read	00:00:02.745	0.0%	859090	0.001	0.003	0.005
overview write	00:00:05.535	0.0%	28451	0.082	0.195	8.392
perl filter	00:01:32.584	0.1%	48924	1.048	1.892	3.480
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.498	0.0%	56902	0.000	0.009	0.025
TOTAL: 24:00:28.373	23:59:52.672	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.068	0.0%	28397	0.000	0.002	0.017
article prepare	00:00:00.000	0.0%	7060	0.000	0.000	0.000
article read	00:00:00.225	0.0%	1429	0.000	0.157	7.333
backlog stats	00:00:00.118	0.0%	320104	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.355	0.0%	245635	0.001	0.006	0.010
data write	00:00:01.851	0.0%	219593	0.002	0.008	0.021
idle	23:52:58.415	100.0%	320104	153.400	268.595	839.312
status file	00:00:00.092	0.0%	186	0.000	0.495	1.000
TOTAL: 23:53:06.110	23:53:02.124	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.166	0.0%	8384	0.013	0.020	0.024
idle	56:28:53.663	100.0%	39816	0.000	5106.833	600183.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.465	0.0%	80422	0.000	0.006	0.333
readart	00:00:00.002	0.0%	44	0.000	0.045	1.000
TOTAL: 56:30:19.799	56:28:54.296	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	2	45595	7502	35676	2417	16%	24:11:53
2	au2pb.net	1	31597	6350	24151	1096	20%	24:00:01
3	xanadu-bbs.net	1	51059	4384	37738	8937	8%	24:04:57
4	news-out.mixmin.net	4	34596	3819	28308	2469	11%	24:12:37
5	newsfeed.neva.ru	143	58894	2921	49199	6774	4%	71:43:30
6	newsfeeds.xmission.com	0	29519	1843	27500	176	6%	24:25:05
7	newsfeed.fu-berlin.de	64	33919	1406	32063	450	4%	35:22:37
8	nntp.pasdenom.info	2	29253	282	28897	74	0%	23:49:54
9	news.swapon.de	1	2964	228	2723	13	7%	24:47:49
10	localhost	48	14230	0	14230	0	0%	00:00:59
TOTAL: 10		266	331626	28735	280485	22406	8%	276:39:22

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	21.7 MB	0.0 KB	18.2 MB	39.9 MB	54%	4.1 KB
2	au2pb.net	16.8 MB	0.0 KB	7.1 MB	23.9 MB	70%	3.3 KB
3	xanadu-bbs.net	13.2 MB	39.0 KB	321.2 MB	334.4 MB	3%	25.7 KB
4	news-out.mixmin.net	12.4 MB	0.0 KB	10.6 MB	23.0 MB	53%	3.7 KB
5	newsfeed.neva.ru	9.3 MB	0.0 KB	43.7 MB	53.0 MB	17%	5.6 KB
6	newsfeeds.xmission.com	5.6 MB	0.0 KB	2.1 MB	7.7 MB	72%	3.9 KB
7	newsfeed.fu-berlin.de	3.3 MB	0.0 KB	1.1 MB	4.4 MB	74%	2.4 KB
8	news.swapon.de	640.7 KB	0.0 KB	57.7 KB	698.4 KB	91%	2.9 KB
9	nntp.pasdenom.info	626.6 KB	0.0 KB	335.3 KB	961.9 KB	65%	2.7 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		83.6 MB	39.0 KB	404.4 MB	488.0 MB	17%	9.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 2 04:15:00 - 04:59:59	416	1.5%	0.15	1.4 MB	1.7%	0.52
Sep 2 05:00:00 - 05:59:59	650	2.3%	0.18	2.2 MB	2.7%	0.63
Sep 2 06:00:00 - 06:59:59	799	2.8%	0.22	2.3 MB	2.8%	0.66
Sep 2 07:00:00 - 07:59:59	1163	4.1%	0.32	3.0 MB	3.7%	0.87
Sep 2 08:00:00 - 08:59:59	1278	4.5%	0.35	3.5 MB	4.2%	0.99
Sep 2 09:00:00 - 09:59:59	1521	5.3%	0.42	4.4 MB	5.3%	1.24
Sep 2 10:00:00 - 10:59:59	1372	4.8%	0.38	3.8 MB	4.6%	1.07
Sep 2 11:00:00 - 11:59:59	1342	4.7%	0.37	3.5 MB	4.3%	1.00
Sep 2 12:00:00 - 12:59:59	1573	5.5%	0.44	4.3 MB	5.2%	1.22
Sep 2 13:00:00 - 13:59:59	1521	5.3%	0.42	4.3 MB	5.2%	1.21
Sep 2 14:00:00 - 14:59:59	1669	5.9%	0.46	5.4 MB	6.6%	1.54
Sep 2 15:00:00 - 15:59:59	1706	6.0%	0.47	4.6 MB	5.6%	1.31
Sep 2 16:00:00 - 16:59:59	1582	5.6%	0.44	4.4 MB	5.3%	1.25
Sep 2 17:00:00 - 17:59:59	1634	5.7%	0.45	5.2 MB	6.4%	1.49
Sep 2 18:00:00 - 18:59:59	1536	5.4%	0.43	4.0 MB	4.9%	1.14
Sep 2 19:00:00 - 19:59:59	1488	5.2%	0.41	4.3 MB	5.2%	1.22
Sep 2 20:00:00 - 20:59:59	1551	5.5%	0.43	4.3 MB	5.2%	1.22
Sep 2 21:00:00 - 21:59:59	1307	4.6%	0.36	3.9 MB	4.8%	1.12
Sep 2 22:00:00 - 22:59:59	923	3.2%	0.26	2.8 MB	3.4%	0.80
Sep 2 23:00:00 - 23:59:59	823	2.9%	0.23	2.3 MB	2.8%	0.66
Sep 3 00:00:00 - 00:59:59	691	2.4%	0.19	2.3 MB	2.8%	0.65
Sep 3 01:00:00 - 01:59:59	591	2.1%	0.16	2.1 MB	2.5%	0.60
Sep 3 02:00:00 - 02:59:59	496	1.7%	0.14	1.5 MB	1.8%	0.43
Sep 3 03:00:00 - 03:59:59	657	2.3%	0.18	2.0 MB	2.5%	0.58
Sep 3 04:00:00 - 04:15:00	152	0.5%	0.17	444.2 KB	0.5%	0.49
TOTAL: 24:00:00	28441	100.0%	0.33	82.3 MB	100.0%	0.97

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	8921	679	1	8241
2	newsfeed.neva.ru	6785	1533	0	5252
3	news-out.mixmin.net	2478	5	0	2473
4	feeder.eternal-september.org	2433	237	0	2196
5	au2pb.net	1117	1032	0	85
6	newsfeed.fu-berlin.de	785	46	0	739
7	newsfeeds.xmission.com	177	151	0	26
8	nntp.pasdenom.info	73	67	0	6
9	news.swapon.de	23	0	0	23
TOTAL: 9		22792	3750	1	19041

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	688
lada.talk	270
ut.test	225
alt.politics	132
mailing.freebsd.svn-ports-all	123
mailing.freebsd.svn-ports-head	118
lada.auto	95
tin.it.sport.calcio	85
mailing.freebsd.ports-bugs	78
alt.job	73
it-alt.sport.calcio.juventus	72
alt.windows7.general	62
alt.politics.scorched-earth	47
mailing.freebsd.svn-src-all	46
mailing.freebsd.svn-src-head	41
fa.freebsd.cvs-all	41
mpc.lists.freebsd.ports.bugs	38
free.it.calcio.juventus	36
pld.cvs.commit	36
mailing.freebsd.questions	33
TOTAL: 270	3750

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12943
EMP (phn path)	2510
EMP (phl)	791
EMP (phn nph)	215
Too many newsgroups	84
HTML Multipart	79
PFM bot misc	60
Binary Image: misplaced jpg	19
HTML Image Tags	7
Too many newsgroups (low_xpost)	7
Too many newsgroups (meow)	4
HTML post	4
Binary Payload	3
Binary: misplaced rar	1
TOTAL: 14	16727

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	1632
	news-out.mixmin.net	103
	feeder.eternal-september.org	68
	au2pb.net	28
	newsfeeds.xmission.com	19
	nntp.pasdenom.info	4
	TOTAL: 6	1854
Including strange strings
	newsfeed.fu-berlin.de	357
	feeder.eternal-september.org	39
	au2pb.net	26
	news-out.mixmin.net	18
	news.swapon.de	11
	newsfeeds.xmission.com	5
	xanadu-bbs.net	4
	TOTAL: 7	460
TOTAL: 2		2314

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	35264	264	26957	941	3	0%	23:59:52
2	au2pb	22897	171	21809	128	0	0%	23:59:58
3	xanadu-bbs	25795	84	23958	32	12	0%	23:59:58
4	fu-berlin.de	26700	47	26641	12	0	0%	23:59:44
5	xmission	33237	15	26522	3	0	0%	23:59:43
6	news.mixmin.net	25249	14	24498	4	0	0%	23:59:55
7	eternal-september	21613	4	20485	0	0	0%	23:59:58
8	news.swapon.de	2709	2	2670	7	0	0%	23:54:13
9	neva.ru	26235	2	25340	36	0	0%	23:59:54
TOTAL: 9		219699	603	198880	1163	15	0%	215:53:15

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	1015.0 KB	2.6 MB	3.6 MB	3.0 KB	23:59:52
2	au2pb	779.9 KB	1.0 MB	1.8 MB	6.1 KB	23:59:58
3	fu-berlin.de	717.7 KB	17.1 KB	734.7 KB	12.5 KB	23:59:44
4	xanadu-bbs	637.2 KB	62.9 KB	700.1 KB	6.0 KB	23:59:58
5	news.mixmin.net	73.2 KB	6.9 KB	80.1 KB	4.5 KB	23:59:55
6	xmission	39.8 KB	77.8 KB	117.6 KB	6.5 KB	23:59:43
7	eternal-september	28.9 KB	0.0 KB	28.9 KB	7.2 KB	23:59:58
8	neva.ru	9.3 KB	210.2 KB	219.5 KB	5.8 KB	23:59:54
9	news.swapon.de	5.1 KB	15.9 KB	21.0 KB	2.3 KB	23:54:13
TOTAL: 9		3.2 MB	4.0 MB	7.2 MB	4.2 KB	215:53:15

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	44	112.3 KB	41	04:23:21
2	challenger.nielsenmedia.com	8	0	0.0 KB	1	01:01:45
TOTAL: 2		296	44	112.3 KB	42	56:30:15

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	317	44	112.3 KB	41	32:47:17
2	*.chello.nl	49	0	0.0 KB	0	19:20:56
3	*.160.61.188.dynamic.wline.res.cust.swisscom.ch	2	0	0.0 KB	0	00:30:13
4	*.nielsenmedia.com	8	0	0.0 KB	1	01:01:45
5	*.br.br.cox.net	1	0	0.0 KB	0	00:07:37
6	*.bbox.io	2	0	0.0 KB	0	00:30:11
7	*.tu.ok.cox.net	2	0	0.0 KB	0	01:00:09
8	*.tampfl.dsl-w.verizon.net	17	0	0.0 KB	0	01:12:05
TOTAL: 8		398	44	112.3 KB	42	56:30:15

NNRP auth users [Top 20]:

User	Conn
moussa	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.198	0.485	0.452	0.000	28:23:53
dhcp-089-099-203-254.chello.nl	4.111	0.694	0.000	19:20:56
202.89.176.220	26.234	5.693	0.705	04:23:21
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1.134	0.198	0.000	01:12:05
challenger.nielsenmedia.com	0.522	0.094	0.000	01:01:45
ip72-222-107-224.tu.ok.cox.net	0.160	0.023	0.000	01:00:09
47.160.61.188.dynamic.wline.res.cust.swisscom.ch	0.169	0.045	0.000	00:30:13
tempe0.bbox.io	0.129	0.023	0.000	00:30:11
ip70-186-189-146.br.br.cox.net	0.141	0.033	0.000	00:07:37
69.160.37.54	1.815	0.433	0.000	00:00:02
TOTAL: 10	34.900	7.688	0.705	56:30:15

Curious NNRP server explorers [Top 20]:

System	Conn
dhcp-089-099-203-254.chello.nl	49
69.160.37.54	25
pool-71-98-160-84.tampfl.dsl-w.verizon.net	17
162.212.88.198	4
tempe0.bbox.io	2
ip72-222-107-224.tu.ok.cox.net	2
47.160.61.188.dynamic.wline.res.cust.swisscom.ch	2
ip70-186-189-146.br.br.cox.net	1
TOTAL: 8	102

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	34	0
challenger.nielsenmedia.com	2	0
ip72-222-107-224.tu.ok.cox.net	2	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1	0
tempe0.bbox.io	1	0
47.160.61.188.dynamic.wline.res.cust.swisscom.ch	1	0
TOTAL: 6	41	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	45	100.0%
TOTAL: 1		45	100.0%

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

Newsgroup		Count
1	comp.os.vms	19
2	comp.sys.ibm.pc.games.action	10
3	comp.arch	8
4	comp.sys.ibm.pc.games.war-historical	3
5	comp.sys.ibm.as400.misc	3
6	comp.lang.awk	1
7	comp.sys.ibm.pc.games.rpg	1
TOTAL: 7		45

Daily Usenet report for csiph.com

Sep 2 04:15:00 -- Sep 3 04:15:00