Daily Usenet report for csiph.com: Jan 2 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	319047	48.6%	33.0 MB	53.2%
innd	299875	45.6%	25.6 MB	41.3%
nnrpd	35040	5.3%	3.0 MB	4.8%
innfeed	2869	0.4%	452.4 KB	0.7%
nocem	183	0.0%	17.3 KB	0.0%
controlchan	2	0.0%	0.1 KB	0.0%
TOTAL: 6	657016	100.0%	62.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	1706313	62.1%
Negative hits	569809	20.8%
Do not exist	325867	11.9%
Cache misses	143527	5.2%
TOTAL: 4	2745516	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.106	0.0%	739	0.000	1.497	30.333
article cleanup	00:00:00.919	0.0%	305822	0.000	0.003	0.021
article logging	00:00:02.515	0.0%	306380	0.000	0.008	0.055
article parse	00:00:48.249	0.1%	3216056	0.003	0.015	0.085
article write	00:00:27.918	0.0%	24474	0.230	1.141	5.492
artlog/artcncl	00:00:00.011	0.0%	583	0.000	0.019	1.000
artlog/artparse	00:00:00.211	0.0%	12053	0.000	0.018	0.555
data move	00:00:02.583	0.0%	4239584	0.000	0.001	0.001
hisgrep/artcncl	00:00:00.119	0.0%	737	0.000	0.161	14.000
hishave/artcncl	00:00:00.001	0.0%	739	0.000	0.001	0.003
hishave/artparse	00:00:00.040	0.0%	12012	0.000	0.003	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:34.490	0.0%	2735929	0.001	0.013	0.573
history sync	00:00:01.913	0.0%	312	0.000	6.131	78.500
history write	00:03:49.334	0.3%	305702	0.043	0.750	14.356
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
hiswrite/artparse	00:00:24.079	0.0%	12012	0.000	2.005	17.154
idle	23:46:45.337	99.1%	4335222	8.159	19.746	287.800
nntp read	00:00:13.743	0.0%	4373156	0.001	0.003	0.006
overview write	00:01:47.961	0.1%	24474	0.290	4.411	22.321
perl filter	00:03:29.546	0.2%	305606	0.342	0.686	4.829
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.422	0.0%	49124	0.000	0.009	0.027
TOTAL: 24:00:20.364	23:58:30.497	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.074	0.0%	24532	0.000	0.003	0.023
article prepare	00:00:00.009	0.0%	47862	0.000	0.000	0.004
article read	00:00:00.902	0.0%	6461	0.000	0.140	2.300
backlog stats	00:00:00.237	0.0%	511102	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.961	0.0%	362986	0.000	0.005	0.011
data write	00:00:02.416	0.0%	348431	0.004	0.007	0.015
idle	23:53:16.166	100.0%	511102	94.591	168.256	520.653
status file	00:00:00.147	0.0%	241	0.000	0.610	3.000
TOTAL: 23:53:29.499	23:53:21.912	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:06.449	0.0%	2291	0.083	2.815	2.829
idle	68:23:16.042	100.0%	36346	171.667	6773.676	600177.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.439	0.0%	73798	0.000	0.006	0.167
readart	00:00:00.515	0.0%	96	0.000	5.365	182.000
TOTAL: 68:25:04.346	68:23:23.445	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	288	302507	7333	26958	268216	2%	23:45:01
2	csiph-out.feeder.erje.net	1152	1217071	4086	1204848	8137	0%	95:00:00
3	feeder.eternal-september.org	4	38584	3283	34933	368	8%	23:39:45
4	news-out.mixmin.net	3	27735	1974	25035	726	7%	24:17:59
5	au2pb.net	1	27513	1904	25444	165	6%	28:37:25
6	newsfeed.neva.ru	144	77580	1691	72962	2927	2%	71:55:20
7	newsfeed.fu-berlin.de	30	26459	1580	24801	78	5%	29:48:43
8	news.redatomik.org	1	26922	1281	25002	639	4%	22:24:25
9	newsfeeds.xmission.com	1	23563	796	22706	61	3%	25:24:50
10	news.fcku.it	2	5006	348	4658	0	6%	29:38:31
11	news.freedyn.net	51	43006	279	42669	58	0%	35:11:36
12	news.swapon.de	3	4237	110	4123	4	2%	44:02:31
13	xanadu-bbs.net	11	316020	105	303895	12020	0%	81:14:51
14	nntp.pasdenom.info	3	21933	22	21889	22	0%	24:08:36
15	news.bbs.geek.nz	2	22400	2	22393	5	0%	23:59:29
16	localhost	33	0	0	0	0	0%	00:00:00
TOTAL: 16		1729	2180536	24794	1862316	293426	1%	583:09:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	19.8 MB	4.1 KB	420.9 MB	440.7 MB	4%	1.6 KB
2	csiph-out.feeder.erje.net	18.9 MB	382.9 KB	18.0 MB	37.2 MB	50%	3.1 KB
3	feeder.eternal-september.org	8.8 MB	18.8 KB	5.1 MB	13.9 MB	63%	3.9 KB
4	news-out.mixmin.net	6.8 MB	22.8 KB	1.4 MB	8.2 MB	82%	3.1 KB
5	newsfeed.neva.ru	5.5 MB	170.9 KB	30.9 MB	36.6 MB	15%	8.1 KB
6	au2pb.net	4.2 MB	1.6 KB	693.6 KB	4.9 MB	86%	2.4 KB
7	newsfeed.fu-berlin.de	4.0 MB	4.0 KB	142.9 KB	4.1 MB	96%	2.6 KB
8	news.redatomik.org	3.1 MB	12.7 KB	6.5 MB	9.6 MB	32%	5.1 KB
9	newsfeeds.xmission.com	2.5 MB	0.0 KB	1.1 MB	3.6 MB	69%	4.3 KB
10	news.freedyn.net	965.8 KB	0.0 KB	1007.0 KB	1.9 MB	48%	5.9 KB
11	news.fcku.it	622.7 KB	0.0 KB	0.0 KB	622.7 KB	100%	1.8 KB
12	xanadu-bbs.net	314.9 KB	0.0 KB	4.3 GB	4.3 GB	0%	374.2 KB
13	news.swapon.de	291.8 KB	0.0 KB	980.1 KB	1.2 MB	22%	11.2 KB
14	nntp.pasdenom.info	62.5 KB	0.0 KB	151.3 KB	213.8 KB	29%	4.9 KB
15	news.bbs.geek.nz	2.9 KB	0.0 KB	5.5 KB	8.4 KB	34%	1.2 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		75.7 MB	617.8 KB	4.8 GB	4.9 GB	1%	16.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 2 04:15:00 - 04:59:59	342	1.4%	0.13	1.0 MB	1.4%	0.39
Jan 2 05:00:00 - 05:59:59	768	3.1%	0.21	3.0 MB	4.0%	0.86
Jan 2 06:00:00 - 06:59:59	465	1.9%	0.13	1.5 MB	1.9%	0.41
Jan 2 07:00:00 - 07:59:59	633	2.6%	0.18	2.9 MB	3.9%	0.82
Jan 2 08:00:00 - 08:59:59	831	3.4%	0.23	2.4 MB	3.2%	0.68
Jan 2 09:00:00 - 09:59:59	963	3.9%	0.27	2.7 MB	3.6%	0.76
Jan 2 10:00:00 - 10:59:59	1089	4.5%	0.30	2.9 MB	3.9%	0.83
Jan 2 11:00:00 - 11:59:59	1153	4.7%	0.32	3.5 MB	4.7%	1.00
Jan 2 12:00:00 - 12:59:59	1184	4.8%	0.33	4.3 MB	5.7%	1.21
Jan 2 13:00:00 - 13:59:59	1243	5.1%	0.35	3.6 MB	4.9%	1.04
Jan 2 14:00:00 - 14:59:59	1277	5.2%	0.35	4.2 MB	5.6%	1.19
Jan 2 15:00:00 - 15:59:59	1383	5.7%	0.38	4.0 MB	5.3%	1.13
Jan 2 16:00:00 - 16:59:59	1357	5.5%	0.38	3.8 MB	5.1%	1.09
Jan 2 17:00:00 - 17:59:59	1474	6.0%	0.41	4.2 MB	5.6%	1.19
Jan 2 18:00:00 - 18:59:59	1572	6.4%	0.44	5.4 MB	7.2%	1.54
Jan 2 19:00:00 - 19:59:59	1399	5.7%	0.39	4.0 MB	5.4%	1.15
Jan 2 20:00:00 - 20:59:59	1352	5.5%	0.38	3.7 MB	4.9%	1.04
Jan 2 21:00:00 - 21:59:59	1251	5.1%	0.35	3.7 MB	4.9%	1.04
Jan 2 22:00:00 - 22:59:59	1117	4.6%	0.31	3.0 MB	4.0%	0.86
Jan 2 23:00:00 - 23:59:59	931	3.8%	0.26	2.8 MB	3.7%	0.79
Jan 3 00:00:00 - 00:59:59	751	3.1%	0.21	2.3 MB	3.1%	0.66
Jan 3 01:00:00 - 01:59:59	660	2.7%	0.18	2.1 MB	2.8%	0.60
Jan 3 02:00:00 - 02:59:59	726	3.0%	0.20	2.1 MB	2.8%	0.60
Jan 3 03:00:00 - 03:59:59	456	1.9%	0.13	1.5 MB	2.0%	0.43
Jan 3 04:00:00 - 04:15:00	90	0.4%	0.10	328.8 KB	0.4%	0.37
TOTAL: 24:00:00	24467	100.0%	0.28	75.0 MB	100.0%	0.89

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	268305	896	1	267408
2	xanadu-bbs.net	11984	11	0	11973
3	csiph-out.feeder.erje.net	8146	242	110	7794
4	newsfeed.neva.ru	2941	615	29	2297
5	news-out.mixmin.net	735	0	6	729
6	news.redatomik.org	625	0	2	623
7	newsfeed.fu-berlin.de	555	22	1	532
8	feeder.eternal-september.org	395	76	6	313
9	au2pb.net	156	123	1	32
10	newsfeeds.xmission.com	63	52	0	11
11	news.freedyn.net	47	5	0	42
12	nntp.pasdenom.info	22	19	0	3
13	news.bbs.geek.nz	12	12	0	0
14	news.swapon.de	9	0	0	9
15	news.fcku.it	2	0	0	2
TOTAL: 15		293997	2073	156	291768

Unwanted newsgroups [Top 20]:

Newsgroup	Count
ut.test	209
mailing.freebsd.pkg-fallout	149
fa.linux.kernel	136
mailing.freebsd.ports-bugs	91
mpc.lists.freebsd.ports.bugs	91
alt.survival	67
mailing.freebsd.svn-ports-head	67
mailing.freebsd.svn-ports-all	67
lada.talk	61
pld.cvs.commit	49
mailing.openbsd.ports-changes	36
alt.binaries.pictures.female.nonude	34
mailing.freebsd.svn-src-all	33
mailing.freebsd.svn-src-head	33
mailing.freebsd.kde	31
fa.freebsd.cvs-all	31
alt.slack.goathead	28
0	26
fa.openbsd.tech	24
mailing.openbsd.tech	24
TOTAL: 213	2073

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	273837
EMP (phn path)	2250
EMP (phl)	1028
PFM bot misc	672
Binary: misplaced rar	599
Too many newsgroups	111
Scoring filter (26)	72
EMP (phn nph)	51
HTML Multipart	42
Scoring filter (21)	37
Scoring filter (10)	36
Scoring filter (19)	31
User-issued cancel	28
Binary: misplaced rev	26
Scoring filter (24)	21
Scoring filter (8)	20
Scoring filter (28)	20
Scoring filter (23)	19
Scoring filter (18)	18
Scoring filter (9)	18
TOTAL: 42	279094

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	175	0	185	185
TOTAL: 1	175	0	185	185

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	54
	TOTAL: 1	54
Huge articles
	xanadu-bbs.net	11845
	usenet.blueworldhosting.com	83
	feeder.eternal-september.org	31
	news.redatomik.org	21
	newsfeeds.xmission.com	11
	news.freedyn.net	9
	news-out.mixmin.net	9
	nntp.pasdenom.info	2
	news.swapon.de	2
	au2pb.net	2
	TOTAL: 10	12015
Including strange strings
	newsfeed.fu-berlin.de	478
	feeder.eternal-september.org	20
	newsfeed.neva.ru	13
	usenet.blueworldhosting.com	13
	au2pb.net	8
	news-out.mixmin.net	8
	csiph-out.feeder.erje.net	8
	news.swapon.de	7
	news.fcku.it	2
	news.redatomik.org	1
	TOTAL: 10	558
No colon-space in header
	usenet.blueworldhosting.com	7
	csiph-out.feeder.erje.net	3
	TOTAL: 2	10
TOTAL: 4		12637

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.freedyn.net	25120	3339	20859	44	0	31	13%	23:59:56
2	news.bbs.geek.nz	43383	2113	21177	111	0	1	4%	23:59:50
3	xanadu-bbs	34261	1717	21856	463	0	338	5%	23:59:56
4	fu-berlin.de	22480	995	21460	25	0	0	4%	23:59:54
5	usenet.pasdenom.info	30770	455	22154	1837	0	68	1%	23:59:56
6	au2pb	22076	127	21451	68	0	0	0%	23:59:56
7	news.redatomik.org	25884	116	21852	16	0	0	0%	23:59:50
8	xmission	27002	63	22460	3	1	0	0%	23:59:56
9	eternal-september	23112	34	19597	30	0	0	0%	23:59:36
10	news.mixmin.net	24461	19	21107	0	0	0	0%	23:59:56
11	news.fcku.it	1355	6	1104	0	0	0	0%	22:06:00
12	neva.ru	24244	6	21307	164	0	0	0%	23:59:56
13	erje	17824	5	16506	238	0	0	0%	23:59:50
14	news.swapon.de	2489	1	2405	5	0	0	0%	23:48:00
15	bwh	16349	0	15908	0	0	0	0%	23:59:56
TOTAL: 15		340810	8996	271203	3004	1	438	2%	357:52:28

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	17.7 MB	217.8 KB	17.9 MB	0.2 KB/s	5.4 KB	23:59:56
2	xanadu-bbs	10.9 MB	1.0 MB	11.9 MB	0.1 KB/s	5.6 KB	23:59:56
3	fu-berlin.de	8.7 MB	34.7 KB	8.7 MB	0.1 KB/s	8.7 KB	23:59:54
4	news.bbs.geek.nz	6.2 MB	325.1 KB	6.6 MB	0.1 KB/s	3.0 KB	23:59:50
5	usenet.pasdenom.info	1.7 MB	10.1 MB	11.8 MB	0.1 KB/s	5.3 KB	23:59:56
6	au2pb	521.3 KB	151.0 KB	672.3 KB	0.0 KB/s	3.4 KB	23:59:56
7	news.redatomik.org	441.8 KB	44.1 KB	486.0 KB	0.0 KB/s	3.7 KB	23:59:50
8	xmission	160.1 KB	4.6 KB	164.7 KB	0.0 KB/s	2.5 KB	23:59:56
9	eternal-september	109.5 KB	47.5 KB	156.9 KB	0.0 KB/s	2.5 KB	23:59:36
10	news.mixmin.net	91.4 KB	0.0 KB	91.4 KB	0.0 KB/s	4.8 KB	23:59:56
11	neva.ru	34.6 KB	840.6 KB	875.2 KB	0.0 KB/s	5.1 KB	23:59:56
12	erje	16.8 KB	1.2 MB	1.2 MB	0.0 KB/s	5.1 KB	23:59:50
13	news.fcku.it	13.1 KB	0.0 KB	13.1 KB	0.0 KB/s	2.2 KB	22:06:00
14	news.swapon.de	4.0 KB	11.2 KB	15.2 KB	0.0 KB/s	2.5 KB	23:48:00
15	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
TOTAL: 15		46.5 MB	13.9 MB	60.4 MB	0.0 KB/s	5.2 KB	357:52:28

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	68	187.2 KB	66	04:16:12
2	c-73-195-247-24.hsd1.nj.comcast.net	6	9	18.7 KB	3	02:04:32
3	challenger.nielsenmedia.com	4	8	16.1 KB	2	01:00:30
4	tempe0.bbox.io	320	6	6.8 KB	5	53:22:33
5	187.a2c-250-241.astra2connect.com	1	5	6.0 KB	1	00:30:40
TOTAL: 5		619	96	234.9 KB	77	68:24:58

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	289	68	187.2 KB	66	06:15:33
2	*.hsd1.nj.comcast.net	6	9	18.7 KB	3	02:04:32
3	*.nielsenmedia.com	4	8	16.1 KB	2	01:00:30
4	*.bbox.io	320	6	6.8 KB	5	53:22:33
5	*.a2c-250-241.astra2connect.com	1	5	6.0 KB	1	00:30:40
6	*.ip-188-165-239.eu	1	0	0.0 KB	0	00:31:10
7	*.ppps.bbiq.jp	1	0	0.0 KB	0	00:00:01
8	*.chello.nl	10	0	0.0 KB	0	04:39:55
TOTAL: 8		632	96	234.9 KB	77	68:24:58

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
tempe0.bbox.io	26.078	5.779	0.000	53:22:33
dhcp-089-099-203-254.chello.nl	0.833	0.175	0.000	04:39:55
202.89.176.220	26.869	6.921	0.733	04:16:12
c-73-195-247-24.hsd1.nj.comcast.net	0.729	0.100	0.000	02:04:32
50.96.155.42	0.109	0.131	0.000	01:59:20
challenger.nielsenmedia.com	0.398	0.072	0.000	01:00:30
ns342002.ip-188-165-239.eu	0.076	0.008	0.000	00:31:10
187.a2c-250-241.astra2connect.com	0.111	0.016	0.000	00:30:40
116-94-157-145.ppps.bbiq.jp	0.094	0.016	0.000	00:00:01
TOTAL: 9	55.297	13.218	0.733	68:24:58

Curious NNRP server explorers [Top 20]:

System	Conn
dhcp-089-099-203-254.chello.nl	10
116-94-157-145.ppps.bbiq.jp	1
ns342002.ip-188-165-239.eu	1
50.96.155.42	1
TOTAL: 4	13

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	9	0
dhcp-089-099-203-254.chello.nl	9	0
c-73-195-247-24.hsd1.nj.comcast.net	4	0
challenger.nielsenmedia.com	2	0
ns342002.ip-188-165-239.eu	1	0
187.a2c-250-241.astra2connect.com	1	0
TOTAL: 6	26	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	94	98.9%
2	news	1	1.1%
TOTAL: 2		95	100.0%

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

Newsgroup		Count
1	comp.arch	40
2	comp.os.vms	19
3	comp.lang.awk	17
4	comp.sys.ibm.ps2.hardware	9
5	comp.sys.ibm.pc.games.action	5
6	comp.sys.ibm.pc.games.rpg	2
7	comp.sys.mips	1
8	comp.arch.fpga	1
9	news.software.nntp	1
TOTAL: 9		95

Daily Usenet report for csiph.com

Jan 2 04:15:00 -- Jan 3 04:15:00