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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	53962	48.0%	7.6 MB	58.9%
nnrpd	32924	29.3%	2.8 MB	21.3%
innd	23610	21.0%	2.3 MB	17.7%
innfeed	1864	1.7%	293.8 KB	2.2%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	112361	100.0%	13.0 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	270528	46.1%
Positive hits	262878	44.8%
Do not exist	53013	9.0%
Cache misses	144	0.0%
TOTAL: 4	586563	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.504	0.0%	178	0.000	2.831	41.000
article cleanup	00:00:00.322	0.0%	52274	0.000	0.006	0.020
article logging	00:00:00.658	0.0%	52794	0.000	0.012	0.032
article parse	00:00:02.593	0.0%	273391	0.000	0.009	0.029
article write	00:00:12.356	0.0%	27367	0.169	0.451	0.884
artlog/artcncl	00:00:00.002	0.0%	166	0.000	0.012	0.200
artlog/artparse	00:00:00.009	0.0%	857	0.000	0.011	0.500
data move	00:00:00.301	0.0%	731278	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.001	0.0%	177	0.000	0.006	0.333
hishave/artcncl	00:00:00.003	0.0%	178	0.000	0.017	0.167
hishave/artparse	00:00:00.002	0.0%	857	0.000	0.002	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.840	0.0%	586627	0.001	0.003	0.007
history sync	00:00:00.585	0.0%	307	0.000	1.906	3.500
history write	00:00:15.837	0.0%	52213	0.047	0.303	0.405
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.308	0.0%	856	0.000	0.360	3.000
idle	23:47:12.610	99.8%	719552	26.750	119.008	431.377
nntp read	00:00:02.276	0.0%	720907	0.001	0.003	0.006
overview write	00:00:07.465	0.0%	27367	0.080	0.273	1.239
perl filter	00:01:50.477	0.1%	52212	0.991	2.116	4.471
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.463	0.0%	54734	0.000	0.008	0.029
TOTAL: 23:50:26.777	23:49:48.612	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.090	0.0%	27413	0.000	0.003	0.024
article prepare	00:00:00.001	0.0%	7732	0.000	0.000	0.019
article read	00:00:00.228	0.0%	1414	0.000	0.161	22.500
backlog stats	00:00:00.107	0.0%	303893	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.246	0.0%	235166	0.000	0.005	0.015
data write	00:00:01.615	0.0%	211909	0.003	0.008	0.015
idle	23:53:51.537	100.0%	303893	158.022	283.098	758.913
status file	00:00:00.085	0.0%	186	0.000	0.457	1.000
TOTAL: 23:54:02.346	23:53:54.909	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.607	0.0%	51849	0.000	0.031	0.333
idle	142:15:10.633	99.9%	83465	0.000	6135.633	600214.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.212	0.0%	168199	0.000	0.007	1.656
readart	00:00:05.577	0.0%	4463	0.000	1.250	1.273
TOTAL: 142:19:30.408	142:15:19.029	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	48211	7639	36572	4000	15%	24:02:14
2	au2pb.net	1	30200	5174	24011	1015	17%	24:43:44
3	xanadu-bbs.net	1	53071	3922	41385	7764	7%	23:56:16
4	news-out.mixmin.net	4	34269	3793	27655	2821	11%	24:19:37
5	newsfeed.neva.ru	149	61116	3027	48505	9584	4%	71:54:49
6	newsfeeds.xmission.com	1	27575	1949	25506	120	7%	22:56:56
7	newsfeed.fu-berlin.de	45	33294	1314	31537	443	3%	32:55:44
8	nntp.pasdenom.info	5	28230	401	27640	189	1%	24:18:40
9	news.swapon.de	3	2872	314	2532	26	10%	28:14:48
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		237	318838	27533	265343	25962	8%	277:22:48

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	21.6 MB	39.7 KB	26.3 MB	47.9 MB	45%	4.2 KB
2	au2pb.net	15.3 MB	0.0 KB	6.8 MB	22.1 MB	69%	3.7 KB
3	news-out.mixmin.net	11.7 MB	0.0 KB	5.4 MB	17.1 MB	68%	2.6 KB
4	xanadu-bbs.net	11.4 MB	28.3 KB	161.5 MB	173.0 MB	6%	15.2 KB
5	newsfeed.neva.ru	9.7 MB	52.7 KB	88.5 MB	98.2 MB	9%	8.0 KB
6	newsfeeds.xmission.com	5.6 MB	0.0 KB	2.7 MB	8.3 MB	67%	4.1 KB
7	newsfeed.fu-berlin.de	3.0 MB	4.8 KB	1.2 MB	4.3 MB	71%	2.5 KB
8	nntp.pasdenom.info	995.5 KB	55.4 KB	1.1 MB	2.1 MB	45%	3.7 KB
9	news.swapon.de	805.7 KB	0.0 KB	823.8 KB	1.6 MB	49%	4.8 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		80.2 MB	180.9 KB	294.4 MB	374.7 MB	21%	7.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 30 04:15:00 - 04:59:59	345	1.3%	0.13	1019.5 KB	1.2%	0.38
Oct 30 05:00:00 - 05:59:59	532	1.9%	0.15	1.7 MB	2.2%	0.49
Oct 30 06:00:00 - 06:59:59	692	2.5%	0.19	3.0 MB	3.7%	0.84
Oct 30 07:00:00 - 07:59:59	926	3.4%	0.26	2.6 MB	3.2%	0.74
Oct 30 08:00:00 - 08:59:59	1181	4.3%	0.33	3.2 MB	4.0%	0.90
Oct 30 09:00:00 - 09:59:59	1420	5.2%	0.39	4.5 MB	5.7%	1.29
Oct 30 10:00:00 - 10:59:59	1339	4.9%	0.37	3.6 MB	4.5%	1.02
Oct 30 11:00:00 - 11:59:59	1340	4.9%	0.37	3.4 MB	4.2%	0.96
Oct 30 12:00:00 - 12:59:59	1406	5.1%	0.39	3.9 MB	4.9%	1.10
Oct 30 13:00:00 - 13:59:59	1457	5.3%	0.40	3.7 MB	4.6%	1.05
Oct 30 14:00:00 - 14:59:59	1437	5.2%	0.40	4.0 MB	5.1%	1.15
Oct 30 15:00:00 - 15:59:59	1645	6.0%	0.46	5.1 MB	6.4%	1.45
Oct 30 16:00:00 - 16:59:59	1639	6.0%	0.46	5.0 MB	6.2%	1.41
Oct 30 17:00:00 - 17:59:59	1720	6.3%	0.48	4.5 MB	5.7%	1.28
Oct 30 18:00:00 - 18:59:59	1577	5.7%	0.44	4.3 MB	5.4%	1.24
Oct 30 19:00:00 - 19:59:59	1434	5.2%	0.40	4.2 MB	5.2%	1.18
Oct 30 20:00:00 - 20:59:59	1439	5.2%	0.40	3.8 MB	4.8%	1.09
Oct 30 21:00:00 - 21:59:59	1268	4.6%	0.35	3.6 MB	4.5%	1.02
Oct 30 22:00:00 - 22:59:59	1091	4.0%	0.30	3.2 MB	4.0%	0.91
Oct 30 23:00:00 - 23:59:59	1034	3.8%	0.29	3.1 MB	3.9%	0.89
Oct 31 00:00:00 - 00:59:59	800	2.9%	0.22	2.6 MB	3.3%	0.75
Oct 31 01:00:00 - 01:59:59	573	2.1%	0.16	1.7 MB	2.1%	0.49
Oct 31 02:00:00 - 02:59:59	485	1.8%	0.13	1.5 MB	1.8%	0.41
Oct 31 03:00:00 - 03:59:59	534	1.9%	0.15	2.2 MB	2.8%	0.62
Oct 31 04:00:00 - 04:15:00	133	0.5%	0.15	526.4 KB	0.6%	0.58
TOTAL: 24:00:00	27447	100.0%	0.32	79.8 MB	100.0%	0.95

Sites sending bad articles:

Server		Total	Group	Duplic	TooOld	Other
1	newsfeed.neva.ru	9475	1409	23	0	8043
2	xanadu-bbs.net	7792	726	3	0	7063
3	feeder.eternal-september.org	4029	399	8	0	3622
4	news-out.mixmin.net	2859	24	0	0	2835
5	au2pb.net	1003	943	0	1	59
6	newsfeed.fu-berlin.de	815	58	2	0	755
7	nntp.pasdenom.info	190	97	25	0	68
8	newsfeeds.xmission.com	134	95	0	0	39
9	news.swapon.de	52	0	0	0	52
TOTAL: 9		26349	3751	61	1	22536

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	747
lada.talk	171
mailing.freebsd.pkg-fallout	168
alt.politics.scorched-earth	155
lada.auto	133
mozilla.dev.tree-alerts	123
it-alt.sport.calcio.juventus	117
ut.test	114
alt.politics	78
mailing.freebsd.svn-ports-all	71
mailing.freebsd.svn-ports-head	70
mailing.openbsd.ports-changes	69
mailing.freebsd.ports-bugs	63
alt.windows7.general	60
mailing.freebsd.svn-src-all	59
fa.freebsd.cvs-all	59
mailing.freebsd.svn-src-head	55
mailing.database.pgsql-general	54
pld.cvs.commit	46
mailing.gcc.gcc-cvs	46
TOTAL: 265	3751

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	16570
EMP (phn path)	3170
EMP (phl)	899
EMP (phn nph)	169
User-issued spam cancel	117
PFM bot misc	113
Too many newsgroups	43
HTML Multipart	36
Binary Image: misplaced jpg	26
HTML Image Tags	8
Too many newsgroups (low_xpost)	4
Binary Payload	1
HTML post	1
TOTAL: 13	21157

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	708
	feeder.eternal-september.org	53
	au2pb.net	41
	newsfeeds.xmission.com	26
	news-out.mixmin.net	16
	nntp.pasdenom.info	7
	news.swapon.de	5
	newsfeed.fu-berlin.de	1
	TOTAL: 8	857
Including strange strings
	newsfeed.fu-berlin.de	407
	news.swapon.de	29
	news-out.mixmin.net	27
	feeder.eternal-september.org	26
	xanadu-bbs.net	12
	newsfeeds.xmission.com	9
	newsfeed.neva.ru	7
	au2pb.net	5
	TOTAL: 8	522
TOTAL: 2		1379

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	23317	442	21610	236	0	1%	23:59:54
2	usenet.pasdenom.info	32091	216	26276	553	5	0%	23:59:54
3	xanadu-bbs	25362	192	23273	60	5	0%	23:59:54
4	fu-berlin.de	25822	55	25745	21	0	0%	23:59:54
5	news.mixmin.net	24969	40	23515	0	0	0%	23:59:43
6	xmission	31508	21	25215	4	0	0%	23:59:27
7	eternal-september	20613	7	19335	1	0	0%	23:59:45
8	news.swapon.de	2234	4	2196	9	0	0%	23:57:40
9	neva.ru	25485	2	24199	76	0	0%	23:59:54
TOTAL: 9		211401	979	191364	960	10	0%	215:56:05

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	1.6 MB	681.4 KB	2.2 MB	3.4 KB	23:59:54
2	xanadu-bbs	1.1 MB	150.7 KB	1.2 MB	4.9 KB	23:59:54
3	usenet.pasdenom.info	980.6 KB	1.4 MB	2.3 MB	3.1 KB	23:59:54
4	fu-berlin.de	270.6 KB	26.0 KB	296.6 KB	3.9 KB	23:59:54
5	news.mixmin.net	122.9 KB	0.0 KB	122.9 KB	3.1 KB	23:59:43
6	xmission	39.9 KB	12.8 KB	52.7 KB	2.1 KB	23:59:27
7	eternal-september	39.7 KB	0.7 KB	40.3 KB	5.0 KB	23:59:45
8	news.swapon.de	10.6 KB	21.5 KB	32.2 KB	2.5 KB	23:57:40
9	neva.ru	5.2 KB	342.1 KB	347.3 KB	4.5 KB	23:59:54
TOTAL: 9		4.1 MB	2.6 MB	6.6 MB	3.5 KB	215:56:05

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	87	237.6 KB	76	0	0	04:33:01
TOTAL: 1		288	87	237.6 KB	76	0	0	142:19:25

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	519	87	237.6 KB	76	136:45:22
2	*.tampfl.dsl-w.verizon.net	6	0	0.0 KB	0	01:17:43
3	*.br.br.cox.net	2	0	0.0 KB	0	00:00:22
4	*.nielsenmedia.com	12	0	0.0 KB	0	01:01:03
5	*.bbox.io	8	0	0.0 KB	0	01:00:40
6	*.ip-188-165-239.eu	11	0	0.0 KB	0	00:10:59
7	*.chello.nl	7	0	0.0 KB	0	02:03:13
TOTAL: 7		565	87	237.6 KB	76	142:19:25

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
63.142.120.8	15.652	4.511	0.000	73:48:15
162.212.88.214	0.619	0.770	0.000	58:23:53
202.89.176.220	28.930	5.639	0.716	04:33:01
dhcp-089-099-203-254.chello.nl	0.575	0.118	0.000	02:03:13
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.550	0.126	0.000	01:17:43
challenger.nielsenmedia.com	0.999	0.207	0.000	01:01:03
tempe0.bbox.io	0.648	0.144	0.000	01:00:40
ns342002.ip-188-165-239.eu	1.109	0.324	0.000	00:10:59
ip68-11-166-106.br.br.cox.net	0.192	0.008	0.000	00:00:22
216.240.144.100	0.263	0.345	0.000	00:00:09
69.160.37.54	1.984	0.338	0.000	00:00:02
TOTAL: 11	51.521	12.530	0.716	142:19:25

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	201
69.160.37.54	25
challenger.nielsenmedia.com	12
ns342002.ip-188-165-239.eu	11
tempe0.bbox.io	8
dhcp-089-099-203-254.chello.nl	7
pool-71-98-160-84.tampfl.dsl-w.verizon.net	6
162.212.88.214	4
ip68-11-166-106.br.br.cox.net	2
216.240.144.100	1
TOTAL: 10	277

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.os.vms	43
2	comp.arch	21
3	comp.arch.fpga	16
4	comp.sys.ibm.pc.games.action	3
5	comp.ai.philosophy	2
6	comp.sys.ibm.pc.games.war-historical	1
7	comp.arch.embedded	1
TOTAL: 7		87

Daily Usenet report for csiph.com

Oct 30 04:15:00 -- Oct 31 04:15:00