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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	55526	46.1%	8.0 MB	56.9%
nnrpd	32148	26.7%	2.7 MB	18.9%
innd	30767	25.5%	3.1 MB	22.1%
innfeed	2010	1.7%	305.8 KB	2.1%
TOTAL: 4	120451	100.0%	14.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	341638	52.6%
Negative hits	252654	38.9%
Do not exist	54565	8.4%
Cache misses	291	0.0%
TOTAL: 4	649148	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.272	0.0%	197	0.000	1.381	20.000
article cleanup	00:00:00.339	0.0%	54352	0.000	0.006	0.024
article logging	00:00:00.672	0.0%	54869	0.000	0.012	0.036
article parse	00:00:02.125	0.0%	237427	0.002	0.009	0.021
article write	00:00:58.480	0.1%	27585	0.163	2.120	8.588
artlog/artcncl	00:00:00.003	0.0%	160	0.000	0.019	1.000
artlog/artparse	00:00:00.007	0.0%	429	0.000	0.016	0.500
data move	00:00:00.229	0.0%	645394	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.041	0.0%	194	0.000	0.211	3.000
hishave/artcncl	00:00:00.001	0.0%	197	0.000	0.005	0.056
hishave/artparse	00:00:00.000	0.0%	290	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:02.729	0.0%	650698	0.001	0.004	0.076
history sync	00:00:01.585	0.0%	359	0.000	4.415	86.500
history write	00:00:32.844	0.0%	54458	0.103	0.603	14.424
hiswrite/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hiswrite/artparse	00:00:00.112	0.0%	287	0.000	0.390	4.000
idle	23:55:21.563	99.6%	690253	52.066	124.768	404.870
nntp read	00:00:02.364	0.0%	694181	0.001	0.003	0.006
overview write	00:00:55.843	0.1%	27585	0.344	2.024	27.739
perl filter	00:02:14.391	0.2%	54319	0.931	2.474	4.695
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.479	0.0%	55170	0.000	0.009	0.031
TOTAL: 24:00:55.314	24:00:14.079	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.090	0.0%	27762	0.000	0.003	0.021
article prepare	00:00:00.002	0.0%	8460	0.000	0.000	0.013
article read	00:00:00.284	0.0%	1562	0.000	0.182	5.111
backlog stats	00:00:00.123	0.0%	338470	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.395	0.0%	264714	0.000	0.005	0.010
data write	00:00:01.772	0.0%	241840	0.002	0.007	0.015
idle	23:54:51.623	100.0%	338470	152.434	254.355	750.413
status file	00:00:00.093	0.0%	190	0.000	0.489	1.000
TOTAL: 23:54:59.908	23:54:55.382	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.173	0.0%	6069	0.000	0.029	0.333
idle	42:22:44.623	99.9%	37616	0.000	4055.844	600138.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.498	0.0%	76476	0.000	0.007	0.500
readart	00:00:01.607	0.0%	32676	0.000	0.049	72.000
TOTAL: 42:24:03.487	42:22:46.901	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	51719	6366	40888	4465	12%	28:35:02
2	usenet.blueworldhosting.com	1440	53437	4928	35549	12960	9%	23:45:38
3	au2pb.net	1	31688	4736	26350	602	14%	27:19:34
4	news-out.mixmin.net	2	31880	4294	25539	2047	13%	24:08:40
5	newsfeed.neva.ru	141	88335	2455	81463	4417	2%	72:31:16
6	xanadu-bbs.net	1	53882	1821	49500	2561	3%	23:43:21
7	newsfeeds.xmission.com	0	26590	1306	25178	106	4%	22:03:00
8	newsfeed.fu-berlin.de	57	28413	1301	27002	110	4%	30:09:35
9	news.swapon.de	1	2258	221	2036	1	9%	22:05:43
10	nntp.pasdenom.info	3	27095	203	26850	42	0%	24:08:37
11	localhost	27	1	1	0	0	100%	00:00:00
TOTAL: 11		1692	395298	27632	340355	27311	6%	298:30:26

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	16.9 MB	257.4 KB	55.0 MB	72.2 MB	23%	6.8 KB
2	usenet.blueworldhosting.com	14.3 MB	64.7 KB	136.8 MB	151.1 MB	9%	8.7 KB
3	news-out.mixmin.net	13.5 MB	0.0 KB	3.6 MB	17.1 MB	79%	2.8 KB
4	au2pb.net	11.5 MB	0.0 KB	2.1 MB	13.6 MB	84%	2.6 KB
5	newsfeed.neva.ru	7.2 MB	89.2 KB	31.3 MB	38.6 MB	18%	5.7 KB
6	xanadu-bbs.net	5.1 MB	12.6 KB	29.1 MB	34.2 MB	14%	8.0 KB
7	newsfeeds.xmission.com	3.9 MB	0.0 KB	1.1 MB	5.0 MB	78%	3.6 KB
8	newsfeed.fu-berlin.de	3.0 MB	0.0 KB	141.1 KB	3.1 MB	95%	2.3 KB
9	news.swapon.de	568.2 KB	0.0 KB	8.2 KB	576.4 KB	98%	2.6 KB
10	nntp.pasdenom.info	461.9 KB	0.0 KB	239.5 KB	701.5 KB	65%	2.9 KB
11	localhost	1.4 KB	0.0 KB	0.0 KB	1.4 KB	100%	1.4 KB
TOTAL: 11		76.5 MB	424.0 KB	259.3 MB	336.2 MB	22%	6.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 21 04:15:00 - 04:59:59	391	1.4%	0.14	1.1 MB	1.5%	0.43
Dec 21 05:00:00 - 05:59:59	532	1.9%	0.15	1.7 MB	2.2%	0.49
Dec 21 06:00:00 - 06:59:59	693	2.5%	0.19	2.6 MB	3.5%	0.75
Dec 21 07:00:00 - 07:59:59	827	3.0%	0.23	2.5 MB	3.3%	0.71
Dec 21 08:00:00 - 08:59:59	1173	4.3%	0.33	3.3 MB	4.3%	0.94
Dec 21 09:00:00 - 09:59:59	1365	4.9%	0.38	3.8 MB	4.9%	1.07
Dec 21 10:00:00 - 10:59:59	1483	5.4%	0.41	4.4 MB	5.7%	1.24
Dec 21 11:00:00 - 11:59:59	1344	4.9%	0.37	3.4 MB	4.5%	0.98
Dec 21 12:00:00 - 12:59:59	1166	4.2%	0.32	2.9 MB	3.8%	0.83
Dec 21 13:00:00 - 13:59:59	1259	4.6%	0.35	3.1 MB	4.0%	0.87
Dec 21 14:00:00 - 14:59:59	1546	5.6%	0.43	3.9 MB	5.1%	1.12
Dec 21 15:00:00 - 15:59:59	1591	5.8%	0.44	3.9 MB	5.1%	1.10
Dec 21 16:00:00 - 16:59:59	1541	5.6%	0.43	4.0 MB	5.3%	1.14
Dec 21 17:00:00 - 17:59:59	1440	5.2%	0.40	3.9 MB	5.1%	1.11
Dec 21 18:00:00 - 18:59:59	1470	5.3%	0.41	3.9 MB	5.1%	1.11
Dec 21 19:00:00 - 19:59:59	1550	5.6%	0.43	4.1 MB	5.4%	1.17
Dec 21 20:00:00 - 20:59:59	1547	5.6%	0.43	4.0 MB	5.3%	1.15
Dec 21 21:00:00 - 21:59:59	1440	5.2%	0.40	3.6 MB	4.7%	1.02
Dec 21 22:00:00 - 22:59:59	1262	4.6%	0.35	3.6 MB	4.7%	1.01
Dec 21 23:00:00 - 23:59:59	1038	3.8%	0.29	2.9 MB	3.8%	0.83
Dec 22 00:00:00 - 00:59:59	921	3.3%	0.26	3.0 MB	3.9%	0.86
Dec 22 01:00:00 - 01:59:59	683	2.5%	0.19	2.1 MB	2.7%	0.59
Dec 22 02:00:00 - 02:59:59	656	2.4%	0.18	2.3 MB	3.1%	0.66
Dec 22 03:00:00 - 03:59:59	531	1.9%	0.15	1.8 MB	2.3%	0.50
Dec 22 04:00:00 - 04:15:00	135	0.5%	0.15	430.0 KB	0.6%	0.48
TOTAL: 24:00:00	27584	100.0%	0.32	76.3 MB	100.0%	0.90

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	12985	878	5	12102
2	newsfeed.neva.ru	4432	1478	7	2947
3	feeder.eternal-september.org	4415	231	20	4164
4	xanadu-bbs.net	2596	376	1	2219
5	news-out.mixmin.net	2072	13	0	2059
6	au2pb.net	590	563	0	27
7	newsfeed.fu-berlin.de	491	46	0	445
8	newsfeeds.xmission.com	115	94	0	21
9	news.swapon.de	44	0	0	44
10	nntp.pasdenom.info	42	36	0	6
TOTAL: 10		27782	3715	33	24034

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	764
lada.talk	183
alt.politics	135
mailing.freebsd.svn-ports-all	125
ut.test	125
mailing.freebsd.svn-ports-head	119
mpc.lists.freebsd.ports.bugs	114
mailing.freebsd.ports-bugs	114
lada.auto	103
mailing.freebsd.pkg-fallout	93
fa.linux.680x0	78
it-alt.sport.calcio.juventus	78
fa.freebsd.cvs-all	66
mailing.freebsd.svn-src-all	66
alt.survival	55
mailing.freebsd.svn-src-head	54
mailing.openbsd.misc	47
alt.politics.scorched-earth	44
alt.windows7.general	39
gmane.linux.alsa.devel	37
TOTAL: 266	3715

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	18604
EMP (phn path)	3255
EMP (phl)	916
PFM bot misc	133
Too many newsgroups	89
HTML Multipart	74
HTML Image Tags	7
User-issued spam cancel	6
HTML post	1
Binary Payload	1
Binary: misplaced cmd	1
Binary: misplaced sfv	1
Binary Image: misplaced jpg	1
TOTAL: 13	23089

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	146
	feeder.eternal-september.org	63
	usenet.blueworldhosting.com	53
	newsfeeds.xmission.com	14
	news-out.mixmin.net	7
	au2pb.net	6
	nntp.pasdenom.info	1
	TOTAL: 7	290
Including strange strings
	newsfeed.fu-berlin.de	375
	feeder.eternal-september.org	47
	news.swapon.de	43
	news-out.mixmin.net	21
	au2pb.net	13
	newsfeeds.xmission.com	6
	usenet.blueworldhosting.com	5
	newsfeed.neva.ru	3
	xanadu-bbs.net	3
	TOTAL: 9	516
No colon-space in header
	usenet.blueworldhosting.com	139
	TOTAL: 1	139
TOTAL: 3		945

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	32127	422	26302	660	6	1%	23:59:57
2	au2pb	23660	186	22494	262	0	0%	23:59:55
3	xanadu-bbs	27206	101	25543	152	24	0%	23:59:57
4	xmission	31034	51	25903	6	1	0%	23:59:57
5	fu-berlin.de	25840	23	25758	18	115	0%	23:59:57
6	neva.ru	27741	22	24770	163	78	0%	23:59:57
7	news.mixmin.net	25435	16	23179	0	0	0%	23:59:57
8	eternal-september	23165	15	20353	11	0	0%	23:59:57
9	news.swapon.de	2240	2	2178	6	0	0%	23:55:48
10	bwh	22788	1	22359	0	0	0%	23:59:57
TOTAL: 10		241236	839	218839	1278	224	0%	239:55:19

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	1.4 MB	2.2 MB	3.6 MB	3.5 KB	23:59:57
2	au2pb	875.0 KB	572.0 KB	1.4 MB	3.2 KB	23:59:55
3	xanadu-bbs	531.7 KB	298.0 KB	829.7 KB	3.3 KB	23:59:57
4	xmission	134.6 KB	65.5 KB	200.1 KB	3.5 KB	23:59:57
5	fu-berlin.de	98.6 KB	25.1 KB	123.6 KB	3.0 KB	23:59:57
6	neva.ru	95.2 KB	992.2 KB	1.1 MB	5.9 KB	23:59:57
7	eternal-september	84.4 KB	18.9 KB	103.3 KB	4.0 KB	23:59:57
8	news.mixmin.net	63.1 KB	0.0 KB	63.1 KB	3.9 KB	23:59:57
9	news.swapon.de	5.8 KB	29.1 KB	34.9 KB	4.4 KB	23:55:48
10	bwh	1.4 KB	0.0 KB	1.4 KB	1.4 KB	23:59:57
TOTAL: 10		3.3 MB	4.2 MB	7.4 MB	3.6 KB	239:55:19

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	202.89.176.220	288	98	278.2 KB	91	1	04:41:07
2	tempe0.bbox.io	34	4	6.2 KB	4	0	06:47:10
3	dhcp-089-099-203-254.chello.nl	14	2	3.1 KB	2	0	05:17:35
4	71.94.21.184	2	1	3.5 KB	1	0	00:00:02
TOTAL: 4		338	105	290.9 KB	98	1	42:23:59

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	319	99	281.7 KB	92	1	25:15:37
2	*.bbox.io	34	4	6.2 KB	4	0	06:47:10
3	*.chello.nl	14	2	3.1 KB	2	0	05:17:35
4	*.ip-188-165-239.eu	20	0	0.0 KB	0	0	00:04:04
5	*.hsd1.nj.comcast.net	10	0	0.0 KB	0	0	04:59:31
TOTAL: 5		397	105	290.9 KB	98	1	42:23:59

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.221	0.351	0.354	0.000	20:34:24
tempe0.bbox.io	3.002	0.478	0.000	06:47:10
dhcp-089-099-203-254.chello.nl	1.390	0.189	0.000	05:17:35
c-73-195-247-24.hsd1.nj.comcast.net	0.855	0.180	0.000	04:59:31
202.89.176.220	30.289	6.169	0.732	04:41:07
ns342002.ip-188-165-239.eu	1.622	0.281	0.000	00:04:04
71.94.21.184	0.944	0.762	0.000	00:00:02
69.160.37.54	1.989	0.346	0.000	00:00:02
TOTAL: 8	40.442	8.759	0.732	42:23:59

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
ns342002.ip-188-165-239.eu	20
c-73-195-247-24.hsd1.nj.comcast.net	10
162.212.88.221	4
TOTAL: 4	59

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	104	99.0%
2	alt	1	1.0%
TOTAL: 2		105	100.0%

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

Newsgroup		Count
1	comp.arch	50
2	comp.sys.ibm.pc.games.action	10
3	comp.os.vms	8
4	comp.arch.fpga	6
5	comp.sys.ibm.ps2.hardware	6
6	comp.sys.ibm.pc.games.war-historical	5
7	comp.ai.philosophy	5
8	comp.arch.embedded	4
9	comp.os.os2.apps	4
10	comp.os.linux.networking	1
11	alt.test	1
12	comp.answers	1
13	comp.unix.aix	1
14	comp.ai.neural-nets	1
15	comp.os.os2.advocacy	1
16	comp.windows.x.kde	1
TOTAL: 16		105

Daily Usenet report for csiph.com

Dec 21 04:15:00 -- Dec 22 04:15:00