Daily Usenet report for csiph.com: Nov 3 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	69630	51.7%	7.5 MB	41.3%
inn	40436	30.0%	7.8 MB	43.1%
innd	21282	15.8%	2.3 MB	12.9%
innfeed	3213	2.4%	507.8 KB	2.7%
nocem	46	0.0%	5.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	134608	100.0%	18.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	424676	55.6%
Negative hits	298558	39.1%
Do not exist	39622	5.2%
Cache misses	569	0.1%
TOTAL: 4	763425	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.185	0.0%	244	0.000	4.857	51.100
article cleanup	00:00:00.274	0.0%	39600	0.000	0.007	0.024
article logging	00:00:01.128	0.0%	40183	0.000	0.028	0.677
article parse	00:00:01.267	0.0%	133397	0.000	0.009	0.061
article write	00:04:15.931	0.3%	23413	1.396	10.931	74.424
artlog/artcncl	00:00:00.001	0.0%	189	0.000	0.005	0.100
artlog/artparse	00:00:00.001	0.0%	74	0.000	0.014	0.500
data move	00:00:00.320	0.0%	701059	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.141	0.0%	223	0.000	0.632	9.000
hishave/artcncl	00:00:00.052	0.0%	244	0.000	0.213	1.889
hishave/artparse	00:00:00.001	0.0%	73	0.000	0.014	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:10.705	0.1%	764488	0.002	0.092	0.818
history sync	00:00:04.179	0.0%	365	0.000	11.449	231.500
history write	00:02:29.675	0.2%	39523	0.173	3.787	43.859
hiswrite/artcncl	00:00:00.104	0.0%	21	4.952	4.952	4.952
hiswrite/artparse	00:00:00.134	0.0%	73	0.000	1.836	53.000
idle	23:47:10.408	99.0%	705789	68.627	121.326	412.692
nntp read	00:00:03.204	0.0%	726067	0.002	0.004	0.008
overview write	00:02:54.914	0.2%	23413	0.565	7.471	100.500
perl filter	00:01:32.605	0.1%	39353	1.427	2.353	3.989
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.445	0.0%	46865	0.000	0.009	0.040
TOTAL: 24:00:52.205	23:59:46.674	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.071	0.0%	23511	0.000	0.003	0.017
article prepare	00:00:00.003	0.0%	36280	0.000	0.000	0.003
article read	00:00:09.567	0.0%	6583	0.000	1.453	14.931
backlog stats	00:00:00.365	0.0%	437223	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.499	0.0%	333366	0.003	0.007	0.015
data write	00:00:02.403	0.0%	317292	0.002	0.008	0.015
idle	23:53:15.844	100.0%	437223	106.551	196.686	549.067
status file	00:00:00.821	0.0%	277	0.000	2.964	105.000
TOTAL: 23:53:40.732	23:53:31.573	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.042	0.0%	782	0.054	0.054	0.054
idle	37:51:08.670	99.1%	369264	0.000	369.028	601075.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:07.852	0.0%	968617	0.000	0.008	0.500
readart	00:18:54.214	0.8%	267310	0.000	4.243	48.000
TOTAL: 38:11:37.626	38:10:10.778	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	123620	7618	105928	10074	6%	95:02:12
2	csiph-out.news.weretis.net	4	53926	4336	48498	1092	8%	51:19:59
3	feeder.eternal-september.org	7	34850	3402	30270	1178	9%	25:48:35
4	news-out.aioe.org	5	22924	2986	19908	30	13%	24:09:39
5	newsfeed.neva.ru	141	49808	1126	45581	3101	2%	72:04:21
6	newsfeed.fu-berlin.de	68	21597	1029	20312	256	4%	30:59:49
7	news.redatomik.org	1	23928	957	22933	38	3%	26:21:42
8	news-out.mixmin.net	3	25747	939	24438	370	3%	24:08:33
9	newsfeeds.xmission.com	1	23306	603	22703	0	2%	25:14:31
10	xanadu-bbs.net	9	831	154	672	5	18%	25:34:54
11	news.swapon.de	2	3867	137	3727	3	3%	47:25:02
12	news.freedyn.net	2	26127	80	26006	41	0%	24:05:17
13	news.fcku.it	2	9427	70	9347	10	0%	23:59:40
14	news.bbs.geek.nz	1	22174	8	22166	0	0%	23:59:51
15	nntp.pasdenom.info	2	32986	7	32955	24	0%	23:59:06
16	localhost	33	0	0	0	0	0%	00:00:00
TOTAL: 16		1433	475118	23452	435444	16222	4%	544:13:11

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	23.8 MB	368.4 KB	70.3 MB	94.5 MB	25%	5.5 KB
2	csiph-out.news.weretis.net	12.5 MB	0.0 KB	12.7 MB	25.3 MB	49%	4.8 KB
3	feeder.eternal-september.org	8.6 MB	167.5 KB	14.9 MB	23.7 MB	36%	5.3 KB
4	news-out.aioe.org	7.1 MB	0.0 KB	74.1 KB	7.2 MB	98%	2.4 KB
5	news-out.mixmin.net	4.8 MB	1.1 KB	1.7 MB	6.5 MB	73%	5.1 KB
6	newsfeed.neva.ru	2.9 MB	548.2 KB	27.3 MB	30.7 MB	9%	7.4 KB
7	news.redatomik.org	2.6 MB	0.0 KB	684.7 KB	3.2 MB	79%	3.3 KB
8	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	585.1 KB	2.6 MB	77%	2.1 KB
9	newsfeeds.xmission.com	1.7 MB	0.0 KB	0.0 KB	1.7 MB	100%	2.9 KB
10	xanadu-bbs.net	405.7 KB	0.0 KB	86.1 KB	491.8 KB	82%	3.1 KB
11	news.swapon.de	391.6 KB	0.0 KB	1.6 MB	2.0 MB	19%	14.3 KB
12	news.freedyn.net	323.7 KB	0.0 KB	678.4 KB	1002.0 KB	32%	8.3 KB
13	news.fcku.it	108.6 KB	0.0 KB	361.7 KB	470.3 KB	23%	5.9 KB
14	nntp.pasdenom.info	19.3 KB	0.0 KB	397.7 KB	417.0 KB	4%	13.5 KB
15	news.bbs.geek.nz	11.8 KB	0.0 KB	0.0 KB	11.8 KB	100%	1.5 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		67.4 MB	1.1 MB	131.4 MB	199.8 MB	33%	5.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 3 04:15:00 - 04:59:59	323	1.4%	0.12	1.0 MB	1.5%	0.39
Nov 3 05:00:00 - 05:59:59	576	2.5%	0.16	2.2 MB	3.3%	0.63
Nov 3 06:00:00 - 06:59:59	612	2.6%	0.17	2.2 MB	3.2%	0.61
Nov 3 07:00:00 - 07:59:59	748	3.2%	0.21	1.9 MB	2.8%	0.54
Nov 3 08:00:00 - 08:59:59	957	4.1%	0.27	2.4 MB	3.6%	0.69
Nov 3 09:00:00 - 09:59:59	1048	4.5%	0.29	3.4 MB	5.0%	0.96
Nov 3 10:00:00 - 10:59:59	1052	4.5%	0.29	2.7 MB	4.1%	0.78
Nov 3 11:00:00 - 11:59:59	1028	4.4%	0.29	2.7 MB	4.0%	0.76
Nov 3 12:00:00 - 12:59:59	1060	4.5%	0.29	2.8 MB	4.2%	0.80
Nov 3 13:00:00 - 13:59:59	1102	4.7%	0.31	2.8 MB	4.1%	0.79
Nov 3 14:00:00 - 14:59:59	1310	5.6%	0.36	3.5 MB	5.2%	0.99
Nov 3 15:00:00 - 15:59:59	1482	6.3%	0.41	4.4 MB	6.5%	1.25
Nov 3 16:00:00 - 16:59:59	1587	6.8%	0.44	4.6 MB	6.8%	1.30
Nov 3 17:00:00 - 17:59:59	1398	6.0%	0.39	4.2 MB	6.3%	1.20
Nov 3 18:00:00 - 18:59:59	1481	6.3%	0.41	4.5 MB	6.7%	1.29
Nov 3 19:00:00 - 19:59:59	1336	5.7%	0.37	3.7 MB	5.5%	1.06
Nov 3 20:00:00 - 20:59:59	1346	5.7%	0.37	3.6 MB	5.4%	1.04
Nov 3 21:00:00 - 21:59:59	1198	5.1%	0.33	3.1 MB	4.6%	0.88
Nov 3 22:00:00 - 22:59:59	968	4.1%	0.27	2.5 MB	3.7%	0.72
Nov 3 23:00:00 - 23:59:59	696	3.0%	0.19	2.0 MB	3.0%	0.57
Nov 4 00:00:00 - 00:59:59	633	2.7%	0.18	2.4 MB	3.5%	0.67
Nov 4 01:00:00 - 01:59:59	485	2.1%	0.13	1.3 MB	2.0%	0.38
Nov 4 02:00:00 - 02:59:59	458	2.0%	0.13	1.5 MB	2.3%	0.44
Nov 4 03:00:00 - 03:59:59	426	1.8%	0.12	1.4 MB	2.1%	0.39
Nov 4 04:00:00 - 04:15:00	106	0.5%	0.12	419.6 KB	0.6%	0.47
TOTAL: 24:00:00	23416	100.0%	0.27	67.4 MB	100.0%	0.80

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	10112	405	31	9676
2	newsfeed.neva.ru	3131	354	32	2745
3	feeder.eternal-september.org	1206	62	13	1131
4	csiph-out.news.weretis.net	1134	149	0	985
5	newsfeed.fu-berlin.de	688	32	0	656
6	news-out.mixmin.net	379	1	1	377
7	news-out.aioe.org	45	27	0	18
8	news.redatomik.org	42	0	0	42
9	news.freedyn.net	41	0	0	41
10	nntp.pasdenom.info	24	2	0	22
11	news.swapon.de	14	0	0	14
12	news.fcku.it	6	0	0	6
13	xanadu-bbs.net	5	0	0	5
14	newsfeeds.xmission.com	4	0	0	4
TOTAL: 14		16831	1032	77	15722

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	194
ut.test	171
lada.auto	59
mozilla.dev.security.policy	33
alt.survival	30
it-alt.sport.calcio.juventus	29
gmane.linux.alsa.devel	29
gmane.comp.hardware.netbook.arm.sunxi	26
lada.photo	24
mozilla.support.thunderbird	23
spline.eisfair	23
alt.windows7.general	22
hk.politics	17
it.annunci.immobiliari	15
it.annunci.commerciali	15
it.annunci.varie	15
gmane.comp.bacula.user	14
cakewalk.audio	13
alt.english.usage	13
gmane.linux.kernel	12
TOTAL: 143	1032

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11145
EMP (phn path)	2286
EMP (phl)	894
EMP (phn nph)	243
Binary Payload	89
Too many newsgroups	59
HTML Multipart	23
Scoring filter (18)	20
Binary: non-binary distribution	20
Scoring filter (11)	14
User-issued cancel	11
Scoring filter (10)	10
Scoring filter (17)	9
Scoring filter (14)	8
Scoring filter (12)	4
HTML Image Tags	4
Scoring filter (8)	4
Scoring filter (19)	3
U2 violation - invalid distribution	3
Too many newsgroups (meow)	3
TOTAL: 51	14891

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	38	0	77	77
TOTAL: 1	38	0	77	77

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	170
	TOTAL: 1	170
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	TOTAL: 1	4
Huge articles
	news-out.mixmin.net	20
	feeder.eternal-september.org	14
	csiph-out.news.weretis.net	13
	news.redatomik.org	11
	nntp.pasdenom.info	5
	news.freedyn.net	4
	news.fcku.it	2
	news.swapon.de	2
	newsfeeds.xmission.com	2
	xanadu-bbs.net	1
	TOTAL: 11	75
Including strange strings
	newsfeed.fu-berlin.de	410
	csiph-out.feeder.erje.net	54
	csiph-out.news.weretis.net	48
	feeder.eternal-september.org	20
	news-out.aioe.org	15
	news.swapon.de	12
	news.redatomik.org	11
	news-out.mixmin.net	9
	newsfeed.neva.ru	4
	newsfeeds.xmission.com	2
	TOTAL: 10	585
TOTAL: 4		834

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	40358	4451	18256	66	36	11%	23:59:56
2	news.freedyn.net	24158	962	22369	5	0	3%	23:59:56
3	xanadu-bbs	24963	660	22588	15	84	2%	23:59:56
4	fu-berlin.de	21967	610	21357	0	0	2%	23:59:56
5	usenet.pasdenom.info	26233	105	21325	1979	8	0%	23:59:56
6	aioe	19906	79	18333	1	0	0%	23:59:55
7	xmission	25776	54	22048	1	23	0%	23:59:56
8	news.redatomik.org	22724	47	21755	0	0	0%	23:59:56
9	weretis.net	18014	17	17499	2	0	0%	23:59:56
10	erje	15727	13	15666	13	0	0%	23:59:56
11	neva.ru	22731	3	21333	22	0	0%	23:59:55
12	news.mixmin.net	22347	2	20894	0	0	0%	23:59:49
13	eternal-september	21506	1	19087	0	0	0%	23:59:38
14	news.fcku.it	2937	0	2826	0	0	0%	22:50:53
15	news.swapon.de	2144	0	2011	1	0	0%	23:54:15
16	bwh	0	0	0	0	22769	0%	23:58:42
17	au2pb	0	0	0	0	22781	0%	23:58:42
TOTAL: 17		311491	7004	267347	2105	45701	2%	406:41:13

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	11.6 MB	189.3 KB	11.8 MB	0.1 KB/s	2.7 KB	23:59:56
2	news.freedyn.net	6.5 MB	13.6 KB	6.5 MB	0.1 KB/s	6.9 KB	23:59:56
3	xanadu-bbs	5.6 MB	24.3 KB	5.7 MB	0.1 KB/s	8.6 KB	23:59:56
4	fu-berlin.de	5.5 MB	0.0 KB	5.5 MB	0.1 KB/s	9.3 KB	23:59:56
5	usenet.pasdenom.info	291.3 KB	7.8 MB	8.0 MB	0.1 KB/s	4.0 KB	23:59:56
6	aioe	220.6 KB	1.0 KB	221.7 KB	0.0 KB/s	2.8 KB	23:59:55
7	xmission	181.2 KB	1.6 KB	182.9 KB	0.0 KB/s	3.3 KB	23:59:56
8	news.redatomik.org	139.3 KB	0.0 KB	139.3 KB	0.0 KB/s	3.0 KB	23:59:56
9	weretis.net	42.1 KB	27.9 KB	70.0 KB	0.0 KB/s	3.7 KB	23:59:56
10	erje	25.6 KB	49.4 KB	75.0 KB	0.0 KB/s	2.9 KB	23:59:56
11	news.mixmin.net	10.6 KB	0.0 KB	10.6 KB	0.0 KB/s	5.3 KB	23:59:49
12	neva.ru	8.5 KB	74.8 KB	83.2 KB	0.0 KB/s	3.3 KB	23:59:55
13	eternal-september	1.3 KB	0.0 KB	1.3 KB	0.0 KB/s	1.3 KB	23:59:38
14	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:50:53
15	news.swapon.de	0.0 KB	3.6 KB	3.6 KB	0.0 KB/s	3.6 KB	23:54:15
16	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
17	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
TOTAL: 17		30.2 MB	8.1 MB	38.3 MB	0.0 KB/s	4.3 KB	406:41:13

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca	117	115008	320.2 MB	963	09:48:14
2	challenger.nielsenmedia.com	16	5	6.6 KB	5	05:01:37
3	47.192.187.101	2	1	1.2 KB	1	00:36:11
4	dhcp-089-099-203-254.chello.nl	43	1	1.8 KB	1	13:10:47
TOTAL: 4		178	115015	320.2 MB	970	38:11:36

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	117	115008	320.2 MB	963	09:48:14
2	*.nielsenmedia.com	16	5	6.6 KB	5	05:01:37
3	*.chello.nl	43	1	1.8 KB	1	13:10:47
4	unresolved	2	1	1.2 KB	1	00:36:11
5	*.169.22.98.dynamic.ip.windstream.net	2	0	0.0 KB	0	01:20:32
6	*.bbox.io	15	0	0.0 KB	0	05:07:17
7	*.dhcp.mdsn.wi.charter.com	8	0	0.0 KB	0	03:06:54
8	*.50-82-r.retail.telecomitalia.it	1	0	0.0 KB	0	00:00:01
TOTAL: 8		204	115015	320.2 MB	970	38:11:36

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
dhcp-089-099-203-254.chello.nl	2.914	0.703	13:10:47
mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca	37.551	58.439	09:48:14
tempe0.bbox.io	1.356	0.283	05:07:17
challenger.nielsenmedia.com	1.290	0.339	05:01:37
68-185-181-64.dhcp.mdsn.wi.charter.com	0.563	0.127	03:06:54
h197.169.22.98.dynamic.ip.windstream.net	0.112	0.060	01:20:32
47.192.187.101	0.182	0.024	00:36:11
host158-25-dynamic.50-82-r.retail.telecomitalia.it	0.049	0.041	00:00:01
TOTAL: 8	44.017	60.016	38:11:36

Curious NNRP server explorers [Top 20]:

System	Conn
tempe0.bbox.io	15
68-185-181-64.dhcp.mdsn.wi.charter.com	8
h197.169.22.98.dynamic.ip.windstream.net	2
host158-25-dynamic.50-82-r.retail.telecomitalia.it	1
TOTAL: 4	26

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	9	0
challenger.nielsenmedia.com	8	0
68-185-181-64.dhcp.mdsn.wi.charter.com	5	0
h197.169.22.98.dynamic.ip.windstream.net	1	0
47.192.187.101	1	0
TOTAL: 5	24	0

Newsgroup request counts (by category):

Category		Count	Pct
1	uk	77693	54.1%
2	can	37224	25.9%
3	rec	28529	19.9%
4	de	38	0.0%
5	alt	16	0.0%
6	comp	13	0.0%
7	news	5	0.0%
8	it	4	0.0%
9	linux	3	0.0%
10	fr	2	0.0%
11	soc	1	0.0%
12	bit	1	0.0%
13	pl	1	0.0%
14	talk	1	0.0%
15	misc	1	0.0%
TOTAL: 15		143532	100.0%

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

Newsgroup		Count
1	uk.politics.misc	77677
2	can.politics	37224
3	rec.arts.tv	28521
4	uk.legal	11
5	alt.home.repair	7
6	comp.lang.awk	6
7	news.lists.filters	5
8	comp.lang.python	4
9	de.alt.fan.aldi	4
10	de.alt.fan.pluesch	4
11	rec.boats	4
12	de.etc.bahn.misc	4
13	de.etc.sprache.deutsch	3
14	alt.happy.valley	3
15	linux.debian.bugs.rc	3
16	de.comp.os.ms-windows.misc	3
17	fr.rec.loisirs-creatifs	2
18	uk.d-i-y	2
19	de.comm.software.40tude-dialog	2
20	de.soc.recht.misc	2
21	it.comp.console	2
22	de.talk.jokes	2
23	de.comp.lang.python	2
24	alt.atheism	1
25	de.sci.physik	1
26	rec.arts.drwho	1
27	comp.sys.ibm.ps2.hardware	1
28	uk.telecom.mobile	1
29	misc.survivalism	1
30	alt.sports.football.pro.sd-chargers	1
31	it.scienza.matematica	1
32	rec.skiing.alpine	1
33	de.sci.theologie	1
34	alt.politics.clinton	1
35	soc.culture.polish	1
36	rec.autos.makers.jeep+willys	1
37	de.sci.electronics	1
38	comp.lang.python.announce	1
39	de.rec.heimwerken	1
40	de.comm.software.mozilla.mailnews	1
41	comp.lang.lisp	1
42	de.soc.recht.steuern+buchfuehrung	1
43	de.soc.gleichberechtigung	1
44	de.rec.garten	1
45	de.rec.motorrad	1
46	de.rec.musik.hifi	1
47	de.talk.tagesgeschehen	1
48	bit.listserv.ibm-main	1
49	talk.euthanasia	1
50	alt.drugs	1
51	de.soc.politik.misc	1
52	uk.rec.competitions	1
53	uk.net.news.moderation	1
54	alt.military.retired	1
55	pl.pregierz	1
56	rec.gardens	1
57	it.politica	1
58	alt.drugs.hard	1
TOTAL: 58		143532

Daily Usenet report for csiph.com

Nov 3 04:15:00 -- Nov 4 04:15:00