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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	55102	49.4%	8.1 MB	60.9%
nnrpd	32527	29.2%	2.7 MB	20.4%
innd	22010	19.7%	2.2 MB	16.6%
innfeed	1882	1.7%	297.1 KB	2.2%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	111522	100.0%	13.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	287052	47.0%
Negative hits	265741	43.5%
Do not exist	54167	8.9%
Cache misses	3690	0.6%
TOTAL: 4	610650	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.379	0.0%	330	0.000	4.179	20.400
article cleanup	00:00:00.335	0.0%	53422	0.000	0.006	0.022
article logging	00:00:00.653	0.0%	54008	0.000	0.012	0.083
article parse	00:00:02.994	0.0%	294048	0.002	0.010	0.065
article write	00:01:31.172	0.1%	29695	0.160	3.070	8.936
artlog/artcncl	00:00:00.000	0.0%	265	0.000	0.000	0.000
artlog/artparse	00:00:00.013	0.0%	860	0.000	0.015	1.000
data move	00:00:00.277	0.0%	781284	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.035	0.0%	329	0.000	0.106	11.000
hishave/artcncl	00:00:00.001	0.0%	330	0.000	0.003	0.008
hishave/artparse	00:00:00.007	0.0%	857	0.000	0.008	0.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.221	0.0%	611283	0.001	0.005	0.062
history sync	00:00:01.177	0.0%	328	0.000	3.588	46.500
history write	00:00:46.295	0.1%	53418	0.095	0.867	5.709
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.503	0.0%	854	0.000	0.589	61.000
idle	23:54:33.739	99.6%	765671	23.685	112.416	377.511
nntp read	00:00:02.450	0.0%	767137	0.000	0.003	0.006
overview write	00:01:06.822	0.1%	29695	0.478	2.250	8.552
perl filter	00:01:42.628	0.1%	53417	1.011	1.921	4.421
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.540	0.0%	59390	0.000	0.009	0.039
TOTAL: 24:00:36.081	23:59:54.241	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.091	0.0%	29784	0.000	0.003	0.023
article prepare	00:00:00.001	0.0%	8184	0.000	0.000	0.018
article read	00:00:00.245	0.0%	1587	0.000	0.154	5.750
backlog stats	00:00:00.116	0.0%	325240	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.378	0.0%	251879	0.000	0.005	0.010
data write	00:00:01.943	0.0%	228304	0.001	0.009	0.016
idle	23:54:19.454	100.0%	325240	146.943	264.603	789.653
status file	00:00:00.108	0.0%	203	0.000	0.532	1.000
TOTAL: 23:54:27.514	23:54:23.336	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.011	0.0%	27884	0.000	0.072	7.400
idle	93:21:31.591	99.9%	59399	0.000	5658.203	600237.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.727	0.0%	119982	0.000	0.006	0.333
readart	00:00:24.177	0.0%	10188	0.000	2.373	2.384
TOTAL: 93:25:12.081	93:21:58.506	99.9%	-	-	-	-

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	19	49712	8834	33249	7629	17%	28:28:37
2	au2pb.net	1	32811	5346	26217	1248	16%	23:57:32
3	xanadu-bbs.net	3	53039	3997	43787	5255	7%	24:34:43
4	news-out.mixmin.net	4	36025	3599	29782	2644	9%	24:10:44
5	newsfeed.neva.ru	147	62989	3372	52676	6941	5%	71:42:45
6	newsfeeds.xmission.com	1	30324	2646	27500	178	8%	23:38:44
7	newsfeed.fu-berlin.de	69	32366	1319	30747	300	4%	33:46:03
8	news.swapon.de	3	2313	298	2006	9	12%	24:03:48
9	nntp.pasdenom.info	4	44396	267	43970	159	0%	37:30:47
10	localhost	50	11039	0	11039	0	0%	00:01:01
TOTAL: 10		301	355014	29678	300973	24363	8%	291:54:44

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	25.4 MB	2.4 KB	63.7 MB	89.1 MB	28%	5.5 KB
2	au2pb.net	13.8 MB	0.0 KB	5.6 MB	19.5 MB	71%	3.0 KB
3	newsfeed.neva.ru	12.1 MB	0.0 KB	52.7 MB	64.7 MB	18%	6.4 KB
4	news-out.mixmin.net	11.3 MB	2.4 KB	5.8 MB	17.1 MB	66%	2.8 KB
5	xanadu-bbs.net	11.1 MB	10.9 KB	137.9 MB	148.9 MB	7%	16.5 KB
6	newsfeeds.xmission.com	7.9 MB	0.0 KB	4.0 MB	11.9 MB	66%	4.3 KB
7	newsfeed.fu-berlin.de	3.0 MB	0.0 KB	1.1 MB	4.1 MB	73%	2.6 KB
8	news.swapon.de	751.7 KB	0.0 KB	4.0 MB	4.7 MB	15%	15.8 KB
9	nntp.pasdenom.info	618.0 KB	34.6 KB	863.5 KB	1.5 MB	40%	3.6 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		85.9 MB	50.3 KB	275.5 MB	361.5 MB	23%	6.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 19 04:15:00 - 04:59:59	398	1.3%	0.15	1.3 MB	1.5%	0.48
Oct 19 05:00:00 - 05:59:59	603	2.0%	0.17	2.0 MB	2.3%	0.56
Oct 19 06:00:00 - 06:59:59	761	2.6%	0.21	2.1 MB	2.4%	0.60
Oct 19 07:00:00 - 07:59:59	1100	3.7%	0.31	2.9 MB	3.4%	0.83
Oct 19 08:00:00 - 08:59:59	1300	4.4%	0.36	3.6 MB	4.2%	1.02
Oct 19 09:00:00 - 09:59:59	1456	4.9%	0.40	3.7 MB	4.2%	1.04
Oct 19 10:00:00 - 10:59:59	1383	4.7%	0.38	3.9 MB	4.6%	1.12
Oct 19 11:00:00 - 11:59:59	1364	4.6%	0.38	3.4 MB	3.9%	0.96
Oct 19 12:00:00 - 12:59:59	1726	5.8%	0.48	4.7 MB	5.5%	1.35
Oct 19 13:00:00 - 13:59:59	1578	5.3%	0.44	4.7 MB	5.5%	1.34
Oct 19 14:00:00 - 14:59:59	1679	5.7%	0.47	4.3 MB	5.0%	1.23
Oct 19 15:00:00 - 15:59:59	1936	6.5%	0.54	5.8 MB	6.7%	1.64
Oct 19 16:00:00 - 16:59:59	1860	6.3%	0.52	5.1 MB	5.9%	1.44
Oct 19 17:00:00 - 17:59:59	1645	5.5%	0.46	4.4 MB	5.1%	1.26
Oct 19 18:00:00 - 18:59:59	1642	5.5%	0.46	4.3 MB	5.0%	1.22
Oct 19 19:00:00 - 19:59:59	1517	5.1%	0.42	4.0 MB	4.7%	1.15
Oct 19 20:00:00 - 20:59:59	1476	5.0%	0.41	4.6 MB	5.4%	1.32
Oct 19 21:00:00 - 21:59:59	1551	5.2%	0.43	4.6 MB	5.4%	1.32
Oct 19 22:00:00 - 22:59:59	1149	3.9%	0.32	3.2 MB	3.7%	0.91
Oct 19 23:00:00 - 23:59:59	807	2.7%	0.22	2.5 MB	2.9%	0.71
Oct 20 00:00:00 - 00:59:59	682	2.3%	0.19	2.1 MB	2.5%	0.61
Oct 20 01:00:00 - 01:59:59	702	2.4%	0.20	4.0 MB	4.7%	1.14
Oct 20 02:00:00 - 02:59:59	621	2.1%	0.17	2.4 MB	2.8%	0.69
Oct 20 03:00:00 - 03:59:59	569	1.9%	0.16	1.7 MB	2.0%	0.49
Oct 20 04:00:00 - 04:15:00	155	0.5%	0.17	499.1 KB	0.6%	0.55
TOTAL: 24:00:00	29660	100.0%	0.34	85.9 MB	100.0%	1.02

Sites sending bad articles:

Server		Total	Group	Duplic	TooOld	Other
1	feeder.eternal-september.org	7682	465	1	0	7216
2	newsfeed.neva.ru	7042	1765	0	0	5277
3	xanadu-bbs.net	5382	707	1	0	4674
4	news-out.mixmin.net	2675	29	1	0	2645
5	au2pb.net	1268	1205	0	1	62
6	newsfeed.fu-berlin.de	767	42	0	0	725
7	newsfeeds.xmission.com	187	141	0	0	46
8	nntp.pasdenom.info	124	114	1	0	9
9	news.swapon.de	51	0	0	0	51
TOTAL: 9		25178	4468	4	1	20705

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	961
alt.politics.scorched-earth	219
mailing.freebsd.svn-ports-all	187
it-alt.sport.calcio.juventus	179
mailing.freebsd.svn-ports-head	170
mailing.freebsd.ports-bugs	126
ut.test	122
lada.auto	97
alt.job	93
lada.talk	82
alt.politics	79
mailing.freebsd.svn-src-all	65
fa.freebsd.cvs-all	64
mailing.freebsd.svn-src-head	63
mailing.openbsd.source-changes	63
mailing.gcc.gcc-cvs	58
pld.cvs.commit	57
mailing.openbsd.misc	56
mailing.freebsd.pkg-fallout	55
tin.it.sport.calcio	54
TOTAL: 269	4468

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	14409
EMP (phn path)	3209
EMP (phl)	1053
EMP (phn nph)	240
Too many newsgroups	117
Too many newsgroups (low_xpost)	78
HTML Multipart	72
PFM bot misc	34
Binary Image: misplaced jpg	28
Binary: non-binary distribution	12
HTML post	3
HTML Image Tags	2
User-issued spam cancel	2
TOTAL: 13	19259

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	691
	feeder.eternal-september.org	63
	newsfeeds.xmission.com	37
	au2pb.net	34
	news-out.mixmin.net	17
	news.swapon.de	9
	newsfeed.fu-berlin.de	6
	nntp.pasdenom.info	3
	TOTAL: 8	860
Including strange strings
	newsfeed.fu-berlin.de	440
	feeder.eternal-september.org	45
	news.swapon.de	42
	news-out.mixmin.net	27
	au2pb.net	12
	xanadu-bbs.net	11
	newsfeeds.xmission.com	8
	newsfeed.neva.ru	1
	TOTAL: 8	586
TOTAL: 2		1446

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	25516	272	23903	114	0	1%	23:59:37
2	usenet.pasdenom.info	35226	250	28232	960	72	0%	23:59:57
3	xanadu-bbs	28198	183	25383	45	52	0%	23:59:54
4	fu-berlin.de	27907	54	27822	31	0	0%	23:59:57
5	news.mixmin.net	26814	22	25831	23	34	0%	23:59:57
6	xmission	33455	20	26740	2	0	0%	23:59:57
7	eternal-september	21546	4	20417	3	0	0%	23:59:55
8	neva.ru	27699	2	26082	63	0	0%	23:59:57
9	news.swapon.de	2062	0	2051	2	0	0%	23:54:16
TOTAL: 9		228423	807	206461	1243	158	0%	215:53:27

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	1.7 MB	1.7 MB	3.4 MB	2.9 KB	23:59:57
2	au2pb	1.2 MB	314.2 KB	1.5 MB	4.0 KB	23:59:37
3	xanadu-bbs	1.1 MB	93.4 KB	1.2 MB	5.2 KB	23:59:54
4	fu-berlin.de	249.9 KB	42.9 KB	292.8 KB	3.4 KB	23:59:57
5	news.mixmin.net	99.2 KB	57.8 KB	157.0 KB	3.5 KB	23:59:57
6	xmission	42.4 KB	6.7 KB	49.1 KB	2.2 KB	23:59:57
7	eternal-september	18.2 KB	4.0 KB	22.2 KB	3.2 KB	23:59:55
8	neva.ru	5.3 KB	233.2 KB	238.5 KB	3.7 KB	23:59:57
9	news.swapon.de	0.0 KB	4.1 KB	4.1 KB	2.1 KB	23:54:16
TOTAL: 9		4.4 MB	2.4 MB	6.8 MB	3.4 KB	215:53:27

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	51	162.0 KB	45	0	0	04:13:41
TOTAL: 1		288	51	162.0 KB	45	0	0	93:25:07

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	433	51	162.0 KB	45	75:15:30
2	*.nielsenmedia.com	5	0	0.0 KB	0	02:30:03
3	*.tampfl.dsl-w.verizon.net	2	0	0.0 KB	0	01:00:07
4	*.ip-188-165-239.eu	10	0	0.0 KB	0	00:16:03
5	*.bbox.io	6	0	0.0 KB	0	00:33:31
6	*.br.br.cox.net	1	0	0.0 KB	0	00:00:06
7	*.chello.nl	33	0	0.0 KB	0	13:49:42
TOTAL: 7		490	51	162.0 KB	45	93:25:07

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	1.707	1.108	0.000	58:13:03
dhcp-089-099-203-254.chello.nl	2.550	0.462	0.000	13:49:42
63.142.117.252	8.096	2.119	0.000	12:48:13
202.89.176.220	25.573	6.356	0.708	04:13:41
challenger.nielsenmedia.com	0.395	0.087	0.000	02:30:03
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.125	0.022	0.000	01:00:07
tempe0.bbox.io	0.500	0.071	0.000	00:33:31
ns342002.ip-188-165-239.eu	0.753	0.363	0.000	00:16:03
173.0.15.150	0.385	0.966	0.000	00:00:30
ip70-186-188-12.br.br.cox.net	0.144	0.032	0.000	00:00:06
69.160.37.54	2.102	0.373	0.000	00:00:02
TOTAL: 11	42.330	11.959	0.708	93:25:07

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.117.252	107
dhcp-089-099-203-254.chello.nl	33
69.160.37.54	25
162.212.88.214	12
ns342002.ip-188-165-239.eu	10
tempe0.bbox.io	6
challenger.nielsenmedia.com	5
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2
ip70-186-188-12.br.br.cox.net	1
173.0.15.150	1
TOTAL: 10	202

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.os.vms	23
2	comp.sys.ibm.pc.games.action	8
3	comp.os.linux.networking	7
4	comp.arch.embedded	4
5	comp.os.msdos.misc	2
6	comp.os.os2.advocacy	2
7	comp.ai.neural-nets	2
8	comp.sys.ibm.pc.hardware.chips	1
9	comp.sys.ibm.pc.games.war-historical	1
10	comp.answers	1
TOTAL: 10		51

Daily Usenet report for csiph.com

Oct 19 04:15:00 -- Oct 20 04:15:00