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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	59944	49.2%	8.4 MB	59.6%
nnrpd	32273	26.5%	2.7 MB	19.3%
innd	27692	22.7%	2.7 MB	19.1%
innfeed	1985	1.6%	286.7 KB	2.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	121895	100.0%	14.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	299343	46.9%
Negative hits	279556	43.8%
Do not exist	59126	9.3%
Cache misses	190	0.0%
TOTAL: 4	638215	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.410	0.0%	214	0.000	1.916	143.000
article cleanup	00:00:00.341	0.0%	58448	0.000	0.006	0.022
article logging	00:00:00.741	0.0%	58928	0.002	0.013	0.028
article parse	00:00:02.683	0.0%	301775	0.000	0.009	0.017
article write	00:00:12.601	0.0%	29300	0.170	0.430	0.765
artlog/artcncl	00:00:00.004	0.0%	194	0.000	0.021	0.200
artlog/artparse	00:00:00.014	0.0%	802	0.000	0.017	0.500
data move	00:00:00.290	0.0%	782003	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.005	0.0%	213	0.000	0.023	0.100
hishave/artcncl	00:00:00.002	0.0%	214	0.000	0.009	0.125
hishave/artparse	00:00:00.003	0.0%	802	0.000	0.004	0.111
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.898	0.0%	638457	0.001	0.003	0.006
history sync	00:00:00.489	0.0%	315	0.000	1.552	3.000
history write	00:00:14.543	0.0%	58390	0.091	0.249	0.351
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.216	0.0%	801	0.000	0.270	3.000
idle	23:57:07.797	99.8%	772061	29.448	111.685	413.795
nntp read	00:00:02.398	0.0%	774343	0.001	0.003	0.005
overview write	00:00:07.323	0.0%	29300	0.105	0.250	1.134
perl filter	00:02:07.034	0.1%	58390	0.948	2.176	4.288
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.478	0.0%	58600	0.000	0.008	0.021
TOTAL: 24:00:37.463	23:59:59.270	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.080	0.0%	29727	0.000	0.003	0.014
article prepare	00:00:00.000	0.0%	7484	0.000	0.000	0.000
article read	00:00:00.223	0.0%	1458	0.000	0.153	15.000
backlog stats	00:00:00.097	0.0%	324355	0.000	0.000	0.001
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.308	0.0%	250675	0.001	0.005	0.010
data write	00:00:01.640	0.0%	226246	0.001	0.007	0.013
idle	23:54:35.883	100.0%	324355	153.887	265.376	712.708
status file	00:00:00.108	0.0%	228	0.000	0.474	1.000
TOTAL: 23:54:43.455	23:54:39.339	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.296	0.0%	13748	0.017	0.022	0.028
idle	78:44:45.773	99.9%	45368	0.000	6248.584	600261.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:19.973	0.0%	91961	0.000	0.217	92.156
readart	00:00:03.960	0.0%	7597	0.000	0.521	45.000
TOTAL: 78:47:10.496	78:45:10.002	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	9	54366	8565	38305	7496	15%	25:04:38
2	au2pb.net	1	31764	6793	23733	1238	21%	24:07:34
3	xanadu-bbs.net	1	58624	4586	45867	8171	7%	23:53:32
4	news-out.mixmin.net	4	36602	3589	30062	2951	9%	24:09:32
5	newsfeeds.xmission.com	1	30715	2187	28399	129	7%	25:41:37
6	newsfeed.neva.ru	146	80507	1712	69278	9517	2%	72:08:49
7	newsfeed.fu-berlin.de	59	33436	1360	31871	205	4%	33:37:13
8	nntp.pasdenom.info	22	30006	310	29528	168	1%	25:34:23
9	news.swapon.de	1	2393	286	2101	6	11%	22:18:58
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		270	358413	29388	299144	29881	8%	276:36:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	24.2 MB	239.7 KB	70.3 MB	94.8 MB	25%	6.0 KB
2	au2pb.net	17.3 MB	0.0 KB	7.7 MB	24.9 MB	69%	3.2 KB
3	xanadu-bbs.net	12.9 MB	106.1 KB	136.7 MB	149.7 MB	8%	12.0 KB
4	news-out.mixmin.net	11.6 MB	10.6 KB	6.6 MB	18.2 MB	63%	2.9 KB
5	newsfeeds.xmission.com	6.6 MB	10.5 KB	3.9 MB	10.5 MB	63%	4.6 KB
6	newsfeed.neva.ru	5.4 MB	362.8 KB	92.2 MB	97.9 MB	5%	8.9 KB
7	newsfeed.fu-berlin.de	3.1 MB	0.0 KB	603.4 KB	3.7 MB	84%	2.4 KB
8	nntp.pasdenom.info	752.8 KB	0.0 KB	1.1 MB	1.8 MB	40%	3.9 KB
9	news.swapon.de	701.6 KB	0.0 KB	1.7 MB	2.4 MB	28%	8.4 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		82.5 MB	729.7 KB	320.7 MB	403.9 MB	20%	7.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 28 04:15:00 - 04:59:59	399	1.4%	0.15	1.1 MB	1.4%	0.43
Oct 28 05:00:00 - 05:59:59	642	2.2%	0.18	2.0 MB	2.4%	0.56
Oct 28 06:00:00 - 06:59:59	685	2.3%	0.19	1.9 MB	2.3%	0.53
Oct 28 07:00:00 - 07:59:59	988	3.4%	0.27	2.8 MB	3.5%	0.81
Oct 28 08:00:00 - 08:59:59	1290	4.4%	0.36	4.4 MB	5.4%	1.25
Oct 28 09:00:00 - 09:59:59	1386	4.7%	0.39	4.3 MB	5.3%	1.23
Oct 28 10:00:00 - 10:59:59	1267	4.3%	0.35	3.2 MB	3.8%	0.90
Oct 28 11:00:00 - 11:59:59	1392	4.8%	0.39	3.9 MB	4.7%	1.11
Oct 28 12:00:00 - 12:59:59	1288	4.4%	0.36	3.3 MB	4.0%	0.94
Oct 28 13:00:00 - 13:59:59	1559	5.3%	0.43	4.1 MB	5.0%	1.16
Oct 28 14:00:00 - 14:59:59	1697	5.8%	0.47	4.8 MB	5.8%	1.35
Oct 28 15:00:00 - 15:59:59	1907	6.5%	0.53	5.4 MB	6.6%	1.55
Oct 28 16:00:00 - 16:59:59	1694	5.8%	0.47	4.4 MB	5.4%	1.26
Oct 28 17:00:00 - 17:59:59	1773	6.1%	0.49	4.8 MB	5.9%	1.38
Oct 28 18:00:00 - 18:59:59	1687	5.8%	0.47	4.7 MB	5.8%	1.35
Oct 28 19:00:00 - 19:59:59	1632	5.6%	0.45	4.0 MB	4.9%	1.14
Oct 28 20:00:00 - 20:59:59	1545	5.3%	0.43	3.9 MB	4.7%	1.10
Oct 28 21:00:00 - 21:59:59	1470	5.0%	0.41	4.0 MB	4.9%	1.14
Oct 28 22:00:00 - 22:59:59	1309	4.5%	0.36	3.7 MB	4.5%	1.05
Oct 28 23:00:00 - 23:59:59	971	3.3%	0.27	2.8 MB	3.4%	0.79
Oct 29 00:00:00 - 00:59:59	798	2.7%	0.22	2.3 MB	2.8%	0.65
Oct 29 01:00:00 - 01:59:59	575	2.0%	0.16	1.8 MB	2.2%	0.50
Oct 29 02:00:00 - 02:59:59	601	2.1%	0.17	2.0 MB	2.4%	0.56
Oct 29 03:00:00 - 03:59:59	620	2.1%	0.17	2.2 MB	2.7%	0.63
Oct 29 04:00:00 - 04:15:00	118	0.4%	0.13	335.4 KB	0.4%	0.37
TOTAL: 24:00:00	29293	100.0%	0.34	82.2 MB	100.0%	0.97

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	9423	1291	30	8102
2	xanadu-bbs.net	8249	711	6	7532
3	feeder.eternal-september.org	7612	519	20	7073
4	news-out.mixmin.net	3014	20	1	2993
5	au2pb.net	1256	1177	0	79
6	newsfeed.fu-berlin.de	583	40	0	543
7	nntp.pasdenom.info	169	160	0	9
8	newsfeeds.xmission.com	130	87	1	42
9	news.swapon.de	21	0	0	21
TOTAL: 9		30457	4005	58	26394

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	783
lada.talk	277
it-alt.sport.calcio.juventus	202
alt.politics.scorched-earth	192
mailing.freebsd.pkg-fallout	167
lada.auto	150
mailing.freebsd.ports-bugs	139
alt.politics	83
alt.survival	82
mailing.freebsd.svn-ports-all	81
ut.test	81
mailing.freebsd.svn-ports-head	78
mailing.openbsd.source-changes	65
alt.windows7.general	63
nemo.test	54
pld.cvs.commit	43
mailing.gcc.gcc-cvs	41
mailing.database.pgsql-general	39
mailing.openbsd.misc	39
gmane.linux.alsa.devel	38
TOTAL: 273	4005

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	19933
EMP (phn path)	3576
EMP (phl)	920
EMP (phn nph)	241
PFM bot misc	186
Too many newsgroups	95
HTML Multipart	78
HTML post	31
Binary Image: misplaced jpg	25
Too many newsgroups (low_xpost)	15
HTML Image Tags	9
User-issued spam cancel	1
TOTAL: 12	25110

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	615
	feeder.eternal-september.org	92
	au2pb.net	39
	newsfeeds.xmission.com	31
	news-out.mixmin.net	17
	nntp.pasdenom.info	5
	newsfeed.fu-berlin.de	3
	news.swapon.de	2
	TOTAL: 8	804
Including strange strings
	newsfeed.fu-berlin.de	364
	feeder.eternal-september.org	34
	au2pb.net	26
	news-out.mixmin.net	19
	news.swapon.de	15
	xanadu-bbs.net	9
	newsfeed.neva.ru	7
	newsfeeds.xmission.com	6
	TOTAL: 8	480
TOTAL: 2		1284

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	23711	362	21994	180	0	1%	23:59:58
2	usenet.pasdenom.info	34319	210	28071	701	401	0%	23:59:58
3	xanadu-bbs	26711	163	24494	41	13	0%	23:59:58
4	fu-berlin.de	27496	51	27414	31	0	0%	23:59:56
5	news.mixmin.net	27116	21	25608	0	0	0%	23:59:57
6	xmission	34359	19	27021	1	0	0%	23:59:49
7	eternal-september	21514	15	20119	5	57	0%	23:59:58
8	neva.ru	29029	4	26920	61	2	0%	23:59:44
9	news.swapon.de	2283	1	2262	5	0	0%	23:57:20
TOTAL: 9		226538	846	203903	1025	473	0%	215:56:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	1.4 MB	512.5 KB	1.9 MB	3.6 KB	23:59:58
2	usenet.pasdenom.info	997.9 KB	1.5 MB	2.5 MB	2.8 KB	23:59:58
3	xanadu-bbs	897.5 KB	112.1 KB	1009.6 KB	4.9 KB	23:59:58
4	fu-berlin.de	248.2 KB	42.2 KB	290.4 KB	3.5 KB	23:59:56
5	news.mixmin.net	82.0 KB	0.0 KB	82.0 KB	3.9 KB	23:59:57
6	eternal-september	73.7 KB	8.4 KB	82.1 KB	4.1 KB	23:59:58
7	xmission	44.6 KB	12.8 KB	57.4 KB	2.9 KB	23:59:49
8	neva.ru	34.1 KB	281.2 KB	315.3 KB	4.9 KB	23:59:44
9	news.swapon.de	1.4 KB	11.4 KB	12.9 KB	2.1 KB	23:57:20
TOTAL: 9		3.8 MB	2.5 MB	6.2 MB	3.4 KB	215:56:38

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	100	307.8 KB	94	04:35:59
2	challenger.nielsenmedia.com	20	2	3.3 KB	2	02:13:38
3	dhcp-089-099-203-254.chello.nl	50	1	2.1 KB	1	21:05:24
4	tempe0.bbox.io	11	1	2.1 KB	1	01:06:56
TOTAL: 4		369	104	315.2 KB	98	78:47:06

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	318	100	307.8 KB	94	52:11:41
2	*.nielsenmedia.com	20	2	3.3 KB	2	02:13:38
3	*.chello.nl	50	1	2.1 KB	1	21:05:24
4	*.bbox.io	11	1	2.1 KB	1	01:06:56
5	*.tampfl.dsl-w.verizon.net	16	0	0.0 KB	0	02:07:42
6	*.br.br.cox.net	2	0	0.0 KB	0	00:01:43
TOTAL: 6		417	104	315.2 KB	98	78:47:06

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.214	0.700	0.593	0.000	47:35:01
dhcp-089-099-203-254.chello.nl	4.100	0.664	0.000	21:05:24
202.89.176.220	30.052	5.337	0.711	04:35:59
challenger.nielsenmedia.com	1.674	0.355	0.000	02:13:38
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1.243	0.201	0.000	02:07:42
tempe0.bbox.io	0.848	0.124	0.000	01:06:56
ip68-11-166-106.br.br.cox.net	0.189	0.039	0.000	00:01:43
173.0.15.143	0.391	0.408	0.000	00:00:38
69.160.37.54	2.124	0.263	0.000	00:00:02
TOTAL: 9	41.321	7.984	0.711	78:47:06

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
pool-71-98-160-84.tampfl.dsl-w.verizon.net	16
162.212.88.214	4
ip68-11-166-106.br.br.cox.net	2
173.0.15.143	1
TOTAL: 5	48

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	31	0
challenger.nielsenmedia.com	4	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	3	0
tempe0.bbox.io	2	0
TOTAL: 4	40	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	48
2	comp.os.vms	20
3	comp.arch.embedded	16
4	comp.sys.ibm.pc.games.action	6
5	comp.os.msdos.misc	3
6	comp.sys.ibm.ps2.hardware	3
7	comp.os.linux.networking	2
8	comp.lang.awk	2
9	comp.ai.genetic	1
10	comp.os.os2.misc	1
11	comp.ai.alife	1
12	comp.os.os2.announce	1
TOTAL: 12		104

Daily Usenet report for csiph.com

Oct 28 04:15:00 -- Oct 29 04:15:00