Daily Usenet report for csiph.com: Dec 20 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	46219	43.7%	6.9 MB	55.3%
nnrpd	32475	30.7%	2.7 MB	21.7%
innd	24941	23.6%	2.6 MB	20.6%
innfeed	2030	1.9%	306.9 KB	2.4%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	105666	100.0%	12.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	286391	53.6%
Negative hits	202545	37.9%
Do not exist	45169	8.5%
Cache misses	417	0.1%
TOTAL: 4	534522	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.857	0.0%	437	0.000	4.249	17.000
article cleanup	00:00:00.279	0.0%	44824	0.000	0.006	0.027
article logging	00:00:00.546	0.0%	45424	0.000	0.012	0.044
article parse	00:00:02.079	0.0%	201397	0.002	0.010	0.096
article write	00:00:35.913	0.0%	25066	0.202	1.433	14.828
artlog/artcncl	00:00:00.006	0.0%	381	0.000	0.016	0.111
artlog/artparse	00:00:00.007	0.0%	437	0.000	0.016	1.000
data move	00:00:00.190	0.0%	544738	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.022	0.0%	428	0.000	0.051	16.000
hishave/artcncl	00:00:00.003	0.0%	437	0.000	0.007	0.032
hishave/artparse	00:00:00.001	0.0%	317	0.000	0.003	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:02.040	0.0%	535010	0.002	0.004	0.039
history sync	00:00:01.183	0.0%	359	0.000	3.295	74.667
history write	00:00:22.540	0.0%	44900	0.054	0.502	7.721
hiswrite/artcncl	00:00:00.002	0.0%	9	0.000	0.222	2.000
hiswrite/artparse	00:00:00.362	0.0%	317	0.000	1.142	26.364
idle	23:56:42.784	99.7%	582789	77.047	147.914	517.693
nntp read	00:00:02.037	0.0%	584987	0.001	0.003	0.007
overview write	00:00:45.810	0.1%	25066	0.227	1.828	21.051
perl filter	00:01:45.472	0.1%	44776	0.921	2.356	4.772
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.446	0.0%	50132	0.000	0.009	0.037
TOTAL: 24:00:57.469	24:00:23.579	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.064	0.0%	25015	0.000	0.003	0.024
article prepare	00:00:00.002	0.0%	12620	0.000	0.000	0.014
article read	00:00:00.365	0.0%	2246	0.000	0.163	3.267
backlog stats	00:00:00.114	0.0%	323760	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.264	0.0%	245423	0.000	0.005	0.014
data write	00:00:01.652	0.0%	225090	0.002	0.007	0.015
idle	23:54:12.563	100.0%	323760	116.543	265.791	1020.100
status file	00:00:00.106	0.0%	199	0.000	0.533	12.000
TOTAL: 23:54:22.620	23:54:16.130	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.208	0.0%	49376	0.000	0.045	0.211
idle	109:01:43.312	99.8%	80914	0.000	4850.870	600149.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.999	0.0%	163234	0.000	0.006	0.333
readart	00:00:02.950	0.0%	65033	0.000	0.045	62.000
TOTAL: 109:12:25.592	109:01:49.469	99.8%	-	-	-	-

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	20	41847	6041	32889	2917	14%	28:22:37
2	usenet.blueworldhosting.com	1439	44105	4799	29356	9950	10%	23:47:03
3	news-out.mixmin.net	3	27256	3191	22442	1623	11%	22:53:36
4	au2pb.net	1	23810	2964	20513	333	12%	22:06:32
5	xanadu-bbs.net	1	43934	2842	39236	1856	6%	23:26:14
6	newsfeeds.xmission.com	1	24433	1734	22555	144	7%	25:24:50
7	newsfeed.neva.ru	145	74745	1641	70020	3084	2%	72:11:29
8	newsfeed.fu-berlin.de	32	27070	1535	25455	80	5%	30:29:30
9	news.swapon.de	5	2126	132	1989	5	6%	23:05:29
10	nntp.pasdenom.info	3	22250	128	22080	42	0%	24:08:37
11	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 11		1676	331576	25007	286535	20034	7%	295:55:57

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	16.6 MB	198.7 KB	35.0 MB	51.8 MB	32%	5.9 KB
2	usenet.blueworldhosting.com	14.6 MB	25.4 KB	111.3 MB	125.9 MB	11%	8.7 KB
3	news-out.mixmin.net	10.4 MB	14.4 KB	2.8 MB	13.2 MB	78%	2.8 KB
4	xanadu-bbs.net	7.9 MB	0.0 KB	35.2 MB	43.1 MB	18%	9.4 KB
5	au2pb.net	6.7 MB	2.8 KB	883.3 KB	7.6 MB	88%	2.3 KB
6	newsfeed.neva.ru	5.8 MB	32.6 KB	23.6 MB	29.5 MB	19%	6.4 KB
7	newsfeeds.xmission.com	5.4 MB	0.0 KB	746.2 KB	6.1 MB	88%	3.3 KB
8	newsfeed.fu-berlin.de	3.5 MB	0.0 KB	123.5 KB	3.7 MB	96%	2.3 KB
9	news.swapon.de	346.2 KB	0.0 KB	1.4 MB	1.8 MB	19%	13.1 KB
10	nntp.pasdenom.info	287.2 KB	1.0 KB	278.7 KB	566.9 KB	50%	3.3 KB
11	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 11		71.6 MB	274.8 KB	211.2 MB	283.1 MB	25%	6.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 20 04:15:00 - 04:59:59	460	1.8%	0.17	2.0 MB	2.8%	0.76
Dec 20 05:00:00 - 05:59:59	451	1.8%	0.13	1.5 MB	2.2%	0.44
Dec 20 06:00:00 - 06:59:59	513	2.0%	0.14	1.7 MB	2.4%	0.49
Dec 20 07:00:00 - 07:59:59	619	2.5%	0.17	1.7 MB	2.3%	0.48
Dec 20 08:00:00 - 08:59:59	932	3.7%	0.26	2.9 MB	4.1%	0.83
Dec 20 09:00:00 - 09:59:59	961	3.8%	0.27	2.4 MB	3.4%	0.69
Dec 20 10:00:00 - 10:59:59	1731	6.9%	0.48	6.9 MB	9.6%	1.96
Dec 20 11:00:00 - 11:59:59	1120	4.5%	0.31	2.9 MB	4.0%	0.81
Dec 20 12:00:00 - 12:59:59	1204	4.8%	0.33	3.1 MB	4.3%	0.88
Dec 20 13:00:00 - 13:59:59	1191	4.8%	0.33	3.3 MB	4.6%	0.93
Dec 20 14:00:00 - 14:59:59	1258	5.0%	0.35	3.1 MB	4.3%	0.88
Dec 20 15:00:00 - 15:59:59	1322	5.3%	0.37	3.6 MB	5.0%	1.03
Dec 20 16:00:00 - 16:59:59	1428	5.7%	0.40	3.9 MB	5.4%	1.10
Dec 20 17:00:00 - 17:59:59	1453	5.8%	0.40	4.1 MB	5.7%	1.16
Dec 20 18:00:00 - 18:59:59	1379	5.5%	0.38	3.9 MB	5.4%	1.10
Dec 20 19:00:00 - 19:59:59	1358	5.4%	0.38	3.4 MB	4.8%	0.97
Dec 20 20:00:00 - 20:59:59	1498	6.0%	0.42	4.0 MB	5.5%	1.13
Dec 20 21:00:00 - 21:59:59	1364	5.4%	0.38	3.5 MB	4.9%	0.99
Dec 20 22:00:00 - 22:59:59	1223	4.9%	0.34	3.2 MB	4.4%	0.91
Dec 20 23:00:00 - 23:59:59	1016	4.1%	0.28	2.7 MB	3.8%	0.78
Dec 21 00:00:00 - 00:59:59	756	3.0%	0.21	2.4 MB	3.3%	0.67
Dec 21 01:00:00 - 01:59:59	613	2.4%	0.17	1.9 MB	2.6%	0.54
Dec 21 02:00:00 - 02:59:59	573	2.3%	0.16	1.8 MB	2.5%	0.51
Dec 21 03:00:00 - 03:59:59	502	2.0%	0.14	1.8 MB	2.5%	0.52
Dec 21 04:00:00 - 04:15:00	111	0.4%	0.12	320.4 KB	0.4%	0.36
TOTAL: 24:00:00	25036	100.0%	0.29	71.9 MB	100.0%	0.85

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	usenet.blueworldhosting.com	9962	613	2	1	9346
2	newsfeed.neva.ru	3085	690	2	0	2393
3	feeder.eternal-september.org	3067	219	31	0	2817
4	xanadu-bbs.net	1909	316	0	0	1593
5	news-out.mixmin.net	1643	2	7	0	1634
6	newsfeed.fu-berlin.de	541	34	0	0	507
7	au2pb.net	390	337	1	0	52
8	newsfeeds.xmission.com	144	138	0	0	6
9	nntp.pasdenom.info	41	37	1	0	3
10	news.swapon.de	20	0	0	0	20
TOTAL: 10		20802	2386	44	1	18371

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	235
ut.test	198
it-alt.sport.calcio.juventus	139
alt.politics	130
mailing.freebsd.pkg-fallout	100
lada.talk	85
mailing.freebsd.ports-bugs	82
mpc.lists.freebsd.ports.bugs	82
alt.windows7.general	66
lada.auto	58
mailing.openbsd.ports-changes	53
mailing.freebsd.svn-ports-all	44
mailing.freebsd.svn-ports-head	42
mailing.database.pgsql-general	41
mozilla.support.firefox	40
mailing.freebsd.svn-src-all	38
mailing.freebsd.svn-src-head	36
fa.freebsd.cvs-all	36
mailing.openbsd.misc	34
mailing.freebsd.questions	29
TOTAL: 204	2386

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
nz.politics.announce	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12014
EMP (phn path)	4239
EMP (phl)	805
PFM bot misc	145
Too many newsgroups	69
HTML Multipart	35
HTML Image Tags	8
HTML post	8
Binary Image: misplaced jpg	2
User-issued spam cancel	2
Binary: misplaced par2	1
Too many newsgroups (low_xpost)	1
TOTAL: 12	17329

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	usenet.blueworldhosting.com	4
	TOTAL: 1	4
Bad Message-ID's offered
	usenet.blueworldhosting.com	4
	TOTAL: 1	4
Huge articles
	xanadu-bbs.net	162
	usenet.blueworldhosting.com	81
	feeder.eternal-september.org	54
	news-out.mixmin.net	9
	news.swapon.de	5
	nntp.pasdenom.info	3
	newsfeeds.xmission.com	2
	au2pb.net	1
	TOTAL: 8	317
Including strange strings
	newsfeed.fu-berlin.de	461
	au2pb.net	47
	feeder.eternal-september.org	46
	news.swapon.de	15
	usenet.blueworldhosting.com	12
	news-out.mixmin.net	12
	newsfeeds.xmission.com	3
	newsfeed.neva.ru	3
	xanadu-bbs.net	2
	TOTAL: 9	601
No colon-space in header
	usenet.blueworldhosting.com	120
	TOTAL: 1	120
TOTAL: 5		1046

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	30391	603	23577	726	2	1%	23:59:55
2	au2pb	23376	510	21026	492	0	2%	23:59:55
3	xanadu-bbs	23690	282	21751	115	6	1%	23:59:55
4	fu-berlin.de	23147	55	23063	29	0	0%	23:59:49
5	xmission	28718	43	22855	6	0	0%	23:59:30
6	neva.ru	25926	23	22908	211	0	0%	23:59:55
7	eternal-september	21735	22	18414	10	0	0%	23:59:53
8	news.mixmin.net	24595	20	21708	5	0	0%	23:59:55
9	news.swapon.de	2192	1	2080	7	0	0%	23:52:23
10	bwh	19972	0	19600	0	0	0%	23:59:55
TOTAL: 10		223742	1559	196982	1601	8	0%	239:51:05

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	au2pb	2.0 MB	1.1 MB	3.2 MB	0.0 KB/s	3.2 KB	23:59:55
2	usenet.pasdenom.info	1.9 MB	2.9 MB	4.8 MB	0.1 KB/s	3.7 KB	23:59:55
3	xanadu-bbs	1.4 MB	249.3 KB	1.6 MB	0.0 KB/s	4.2 KB	23:59:55
4	fu-berlin.de	346.7 KB	33.6 KB	380.3 KB	0.0 KB/s	4.5 KB	23:59:49
5	neva.ru	184.7 KB	1.3 MB	1.5 MB	0.0 KB/s	6.4 KB	23:59:55
6	eternal-september	169.2 KB	14.9 KB	184.2 KB	0.0 KB/s	5.8 KB	23:59:53
7	xmission	110.5 KB	27.5 KB	138.0 KB	0.0 KB/s	2.8 KB	23:59:30
8	news.mixmin.net	71.0 KB	73.5 KB	144.5 KB	0.0 KB/s	5.8 KB	23:59:55
9	news.swapon.de	2.2 KB	29.1 KB	31.3 KB	0.0 KB/s	3.9 KB	23:52:23
10	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:55
TOTAL: 10		6.2 MB	5.7 MB	11.9 MB	0.0 KB/s	3.9 KB	239:51:05

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	68	186.5 KB	66	04:42:56
2	71.94.21.184	4	2	2.0 KB	2	00:00:05
3	dhcp-089-099-203-254.chello.nl	14	1	2.0 KB	1	06:15:54
TOTAL: 3		306	71	190.5 KB	69	109:12:20

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	431	70	188.5 KB	68	94:48:52
2	*.chello.nl	14	1	2.0 KB	1	06:15:54
3	*.bbox.io	15	0	0.0 KB	0	04:30:15
4	*.hsd1.nj.comcast.net	8	0	0.0 KB	0	03:37:18
TOTAL: 4		468	71	190.5 KB	69	109:12:20

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	11.097	4.387	0.000	82:18:47
162.212.88.221	0.329	0.179	0.000	07:47:00
dhcp-089-099-203-254.chello.nl	1.275	0.188	0.000	06:15:54
202.89.176.220	29.271	5.902	0.724	04:42:56
tempe0.bbox.io	1.674	0.217	0.000	04:30:15
c-73-195-247-24.hsd1.nj.comcast.net	0.689	0.121	0.000	03:37:18
71.94.21.184	1.855	1.602	0.000	00:00:05
69.160.37.54	1.958	0.374	0.000	00:00:02
TOTAL: 8	48.148	12.970	0.724	109:12:20

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	110
69.160.37.54	25
tempe0.bbox.io	15
c-73-195-247-24.hsd1.nj.comcast.net	8
162.212.88.221	4
TOTAL: 5	162

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	11	0
c-73-195-247-24.hsd1.nj.comcast.net	7	0
tempe0.bbox.io	7	0
TOTAL: 3	25	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	69	97.2%
2	alt	2	2.8%
TOTAL: 2		71	100.0%

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

Newsgroup		Count
1	comp.arch	30
2	comp.sys.ibm.pc.games.action	9
3	comp.arch.fpga	9
4	comp.ai.neural-nets	8
5	comp.os.vms	5
6	comp.ai.philosophy	2
7	alt.test	2
8	comp.sys.ibm.as400.misc	1
9	comp.sys.ibm.pc.games.war-historical	1
10	comp.sys.ibm.pc.games.strategic	1
11	comp.os.os2.advocacy	1
12	comp.sys.ibm.ps2.hardware	1
13	comp.sys.mac.wanted	1
TOTAL: 13		71

Daily Usenet report for csiph.com

Dec 20 04:15:00 -- Dec 21 04:15:00