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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	70223	57.6%	7.5 MB	45.0%
inn	32802	26.9%	6.9 MB	40.9%
innd	15731	12.9%	1.8 MB	10.9%
innfeed	3208	2.6%	541.0 KB	3.2%
nocem	55	0.0%	6.0 KB	0.0%
TOTAL: 5	122019	100.0%	16.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	368638	55.5%
Negative hits	262720	39.6%
Do not exist	31923	4.8%
Cache misses	427	0.1%
TOTAL: 4	663708	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.914	0.0%	182	0.000	5.022	48.000
article cleanup	00:00:00.258	0.0%	31874	0.000	0.008	0.038
article logging	00:00:00.555	0.0%	32414	0.000	0.017	0.486
article parse	00:00:01.044	0.0%	95069	0.000	0.011	0.073
article write	00:04:03.741	0.3%	21708	0.235	11.228	53.985
artlog/artcncl	00:00:00.002	0.0%	157	0.000	0.013	0.200
artlog/artparse	00:00:00.001	0.0%	247	0.000	0.004	0.200
data move	00:00:00.203	0.0%	629356	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.170	0.0%	178	0.000	0.955	25.000
hishave/artcncl	00:00:00.143	0.0%	182	0.000	0.786	7.778
hishave/artparse	00:00:00.000	0.0%	246	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:18.356	0.0%	666112	0.003	0.028	0.465
history sync	00:00:01.784	0.0%	354	0.000	5.040	71.667
history write	00:00:42.963	0.0%	31859	0.071	1.349	12.434
hiswrite/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hiswrite/artparse	00:00:00.253	0.0%	239	0.000	1.059	7.636
idle	23:52:11.372	99.4%	634097	77.190	135.518	421.316
nntp read	00:00:02.915	0.0%	645191	0.002	0.005	0.009
overview write	00:01:23.344	0.1%	21708	0.275	3.839	122.245
perl filter	00:00:59.779	0.1%	31856	1.378	1.877	4.483
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.397	0.0%	43464	0.000	0.009	0.032
TOTAL: 24:00:48.548	23:59:48.194	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.060	0.0%	21664	0.000	0.003	0.028
article prepare	00:00:00.005	0.0%	43072	0.000	0.000	0.014
article read	00:00:14.828	0.0%	8075	0.000	1.836	15.780
backlog stats	00:00:00.296	0.0%	394945	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.513	0.0%	307931	0.002	0.008	0.016
data write	00:00:02.177	0.0%	290531	0.002	0.007	0.016
idle	23:53:17.133	100.0%	394945	122.158	217.745	634.002
status file	00:00:00.384	0.0%	283	0.000	1.357	13.667
TOTAL: 23:53:45.688	23:53:37.396	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	35:00:13.491	95.7%	870898	43.333	144.694	600079.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:21.181	0.0%	2475622	0.000	0.009	0.070
readart	01:31:39.979	4.2%	795964	0.000	6.910	26.156
TOTAL: 36:34:02.432	36:32:14.651	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1151	106941	9956	90669	6316	9%	95:08:16
2	feeder.eternal-september.org	5	28548	3214	24405	929	11%	25:25:04
3	news-out.aioe.org	2	20893	2631	18184	78	12%	24:09:01
4	csiph-out.news.weretis.net	4	43102	1958	40612	532	4%	45:45:40
5	newsfeed.fu-berlin.de	33	24264	1200	22749	315	4%	30:47:30
6	newsfeed.neva.ru	153	37651	775	35283	1593	2%	71:35:35
7	news.redatomik.org	1	17537	710	16809	18	4%	21:47:37
8	news-out.mixmin.net	3	25227	450	24333	444	1%	24:08:55
9	newsfeeds.xmission.com	3	22044	411	21611	22	1%	26:15:31
10	news.freedyn.net	3	24493	235	24031	227	0%	24:12:57
11	news.swapon.de	3	2274	86	2187	1	3%	23:36:04
12	news.fcku.it	2	8333	81	8185	67	0%	23:59:49
13	xanadu-bbs.net	6	748	40	707	1	5%	20:04:21
14	nntp.pasdenom.info	2	23853	4	23829	20	0%	23:59:53
15	news.bbs.geek.nz	1	17755	3	17749	3	0%	23:59:52
16	localhost	33	0	0	0	0	0%	00:00:00
TOTAL: 16		1405	403663	21754	371343	10566	5%	504:56:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	31.6 MB	90.1 KB	21.5 MB	53.2 MB	59%	3.3 KB
2	feeder.eternal-september.org	8.3 MB	0.0 KB	11.5 MB	19.8 MB	42%	4.9 KB
3	news-out.aioe.org	6.6 MB	0.0 KB	98.1 KB	6.7 MB	98%	2.5 KB
4	csiph-out.news.weretis.net	6.4 MB	0.0 KB	4.7 MB	11.1 MB	57%	4.6 KB
5	news-out.mixmin.net	2.7 MB	0.0 KB	1.1 MB	3.8 MB	70%	4.3 KB
6	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	625.2 KB	2.9 MB	79%	2.0 KB
7	newsfeed.neva.ru	2.1 MB	3.9 KB	7.9 MB	10.0 MB	21%	4.3 KB
8	news.redatomik.org	1.6 MB	0.0 KB	398.5 KB	1.9 MB	79%	2.7 KB
9	newsfeeds.xmission.com	1.2 MB	0.0 KB	769.7 KB	1.9 MB	61%	4.6 KB
10	news.freedyn.net	799.3 KB	0.0 KB	4.4 MB	5.2 MB	15%	11.5 KB
11	news.swapon.de	231.4 KB	0.0 KB	843.4 KB	1.0 MB	21%	12.4 KB
12	news.fcku.it	161.4 KB	25.1 KB	4.3 MB	4.5 MB	3%	31.2 KB
13	xanadu-bbs.net	100.3 KB	0.0 KB	1.1 KB	101.4 KB	98%	2.5 KB
14	nntp.pasdenom.info	6.7 KB	0.0 KB	799.3 KB	806.0 KB	0%	33.6 KB
15	news.bbs.geek.nz	3.7 KB	0.0 KB	229.4 KB	233.1 KB	1%	38.9 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		64.1 MB	119.1 KB	59.1 MB	123.2 MB	51%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 6 04:15:00 - 04:59:59	269	1.2%	0.10	736.6 KB	1.1%	0.27
Nov 6 05:00:00 - 05:59:59	378	1.7%	0.10	1.1 MB	1.7%	0.31
Nov 6 06:00:00 - 06:59:59	370	1.7%	0.10	992.8 KB	1.5%	0.28
Nov 6 07:00:00 - 07:59:59	574	2.6%	0.16	1.9 MB	3.0%	0.55
Nov 6 08:00:00 - 08:59:59	978	4.5%	0.27	3.7 MB	5.7%	1.04
Nov 6 09:00:00 - 09:59:59	1092	5.0%	0.30	3.9 MB	6.2%	1.12
Nov 6 10:00:00 - 10:59:59	1071	4.9%	0.30	3.1 MB	4.9%	0.89
Nov 6 11:00:00 - 11:59:59	996	4.6%	0.28	2.8 MB	4.4%	0.81
Nov 6 12:00:00 - 12:59:59	1051	4.8%	0.29	2.8 MB	4.4%	0.80
Nov 6 13:00:00 - 13:59:59	1095	5.0%	0.30	2.9 MB	4.5%	0.82
Nov 6 14:00:00 - 14:59:59	1093	5.0%	0.30	2.9 MB	4.5%	0.83
Nov 6 15:00:00 - 15:59:59	1171	5.4%	0.33	3.5 MB	5.5%	1.01
Nov 6 16:00:00 - 16:59:59	1238	5.7%	0.34	3.4 MB	5.3%	0.96
Nov 6 17:00:00 - 17:59:59	1349	6.2%	0.37	4.1 MB	6.4%	1.17
Nov 6 18:00:00 - 18:59:59	1324	6.1%	0.37	3.7 MB	5.7%	1.05
Nov 6 19:00:00 - 19:59:59	1209	5.6%	0.34	3.6 MB	5.7%	1.04
Nov 6 20:00:00 - 20:59:59	1165	5.4%	0.32	3.1 MB	4.8%	0.88
Nov 6 21:00:00 - 21:59:59	1234	5.7%	0.34	3.5 MB	5.4%	0.98
Nov 6 22:00:00 - 22:59:59	967	4.5%	0.27	2.7 MB	4.2%	0.76
Nov 6 23:00:00 - 23:59:59	897	4.1%	0.25	2.8 MB	4.4%	0.80
Nov 7 00:00:00 - 00:59:59	613	2.8%	0.17	1.8 MB	2.8%	0.51
Nov 7 01:00:00 - 01:59:59	569	2.6%	0.16	1.6 MB	2.5%	0.46
Nov 7 02:00:00 - 02:59:59	510	2.3%	0.14	1.6 MB	2.5%	0.45
Nov 7 03:00:00 - 03:59:59	401	1.8%	0.11	1.5 MB	2.3%	0.42
Nov 7 04:00:00 - 04:15:00	94	0.4%	0.10	295.4 KB	0.5%	0.33
TOTAL: 24:00:00	21708	100.0%	0.25	64.0 MB	100.0%	0.76

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	6366	306	14	6046
2	newsfeed.neva.ru	1555	246	1	1308
3	feeder.eternal-september.org	886	63	0	823
4	newsfeed.fu-berlin.de	630	27	0	603
5	csiph-out.news.weretis.net	539	103	0	436
6	news-out.mixmin.net	455	2	0	453
7	news.freedyn.net	227	0	0	227
8	news-out.aioe.org	123	71	0	52
9	news.fcku.it	67	0	1	66
10	news.redatomik.org	39	0	0	39
11	nntp.pasdenom.info	19	1	0	18
12	newsfeeds.xmission.com	18	0	0	18
13	news.swapon.de	11	0	0	11
14	news.bbs.geek.nz	1	0	0	1
15	xanadu-bbs.net	1	0	0	1
TOTAL: 15		10937	819	16	10102

Unwanted newsgroups [Top 20]:

Newsgroup	Count
ut.test	141
lada.talk	97
it-alt.sport.calcio.juventus	95
alt.windows7.general	52
mpc.lists.freebsd.ports.bugs	27
mpc.lists.freebsd.wireless	24
gmane.linux.alsa.devel	22
spline.eisfair	22
lada.auto	22
alt.survival	15
mpc.lists.freebsd.gnome	13
alt.english.usage	12
lada.movies	12
mozilla.support.firefox	11
mozilla.general	10
alt.politics.usa	8
alt.binaries.sounds.mp3.progressive-country	8
mozilla.support.seamonkey	8
mpc.lists.freebsd.x11	8
alt.politics	7
TOTAL: 132	819

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	6607
EMP (phn path)	1557
EMP (phl)	771
EMP (phn nph)	130
Too many newsgroups	63
User-issued cancel	28
Scoring filter (18)	25
Binary Payload	19
Scoring filter (9)	16
Scoring filter (8)	12
Scoring filter (12)	12
Scoring filter (10)	11
HTML Multipart	10
Poison newsgroup	8
Scoring filter (11)	6
Scoring filter (14)	6
Binary Image: misplaced jpg	5
Scoring filter (22)	5
HTML post	5
Scoring filter (19)	5
TOTAL: 29	9313

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	48	0	53	53
TOTAL: 1	48	0	53	53

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
Huge articles
	feeder.eternal-september.org	86
	news.fcku.it	55
	news.freedyn.net	34
	news.redatomik.org	19
	newsfeeds.xmission.com	16
	news-out.mixmin.net	12
	csiph-out.news.weretis.net	12
	nntp.pasdenom.info	10
	news.bbs.geek.nz	1
	news.swapon.de	1
	TOTAL: 10	246
Including strange strings
	newsfeed.fu-berlin.de	363
	csiph-out.feeder.erje.net	68
	news-out.aioe.org	45
	csiph-out.news.weretis.net	19
	feeder.eternal-september.org	15
	news.swapon.de	10
	news.redatomik.org	8
	newsfeed.neva.ru	7
	news-out.mixmin.net	5
	TOTAL: 9	540
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 4		788

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	35872	5450	15374	111	2	15%	23:59:54
2	news.freedyn.net	21826	973	20491	6	0	4%	23:59:56
3	xanadu-bbs	23212	778	20881	0	0	3%	23:59:56
4	fu-berlin.de	20206	719	19486	0	0	3%	23:59:56
5	usenet.pasdenom.info	24205	55	19083	2568	0	0%	23:59:55
6	news.redatomik.org	20595	16	20069	8	0	0%	23:59:56
7	aioe	18134	13	17372	2	0	0%	23:59:48
8	xmission	24282	10	20562	3	0	0%	23:59:56
9	weretis.net	18703	6	18386	4	0	0%	23:59:56
10	eternal-september	18391	1	17454	0	0	0%	23:59:53
11	news.mixmin.net	19724	1	19260	0	0	0%	23:59:55
12	news.swapon.de	2286	1	2249	0	0	0%	23:59:30
13	erje	11638	0	11558	23	0	0%	23:59:53
14	news.fcku.it	1932	0	1899	0	0	0%	22:51:17
15	au2pb	0	0	0	0	20939	0%	23:58:42
16	neva.ru	20608	0	19969	22	0	0%	23:59:49
17	bwh	0	0	0	0	20926	0%	23:58:42
TOTAL: 17		281614	8023	244093	2747	41867	2%	406:46:54

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	14.1 MB	420.4 KB	14.5 MB	0.2 KB/s	2.7 KB	23:59:54
2	news.freedyn.net	6.8 MB	23.8 KB	6.8 MB	0.1 KB/s	7.1 KB	23:59:56
3	xanadu-bbs	6.3 MB	0.0 KB	6.3 MB	0.1 KB/s	8.3 KB	23:59:56
4	fu-berlin.de	6.2 MB	0.0 KB	6.2 MB	0.1 KB/s	8.8 KB	23:59:56
5	usenet.pasdenom.info	130.1 KB	9.4 MB	9.5 MB	0.1 KB/s	3.7 KB	23:59:55
6	news.redatomik.org	47.0 KB	23.2 KB	70.3 KB	0.0 KB/s	2.9 KB	23:59:56
7	xmission	31.8 KB	6.3 KB	38.1 KB	0.0 KB/s	2.9 KB	23:59:56
8	aioe	24.8 KB	6.3 KB	31.1 KB	0.0 KB/s	2.1 KB	23:59:48
9	weretis.net	15.9 KB	27.9 KB	43.8 KB	0.0 KB/s	4.4 KB	23:59:56
10	eternal-september	2.8 KB	0.0 KB	2.8 KB	0.0 KB/s	2.8 KB	23:59:53
11	news.mixmin.net	1.5 KB	0.0 KB	1.5 KB	0.0 KB/s	1.5 KB	23:59:55
12	news.swapon.de	1.5 KB	0.0 KB	1.5 KB	0.0 KB/s	1.5 KB	23:59:30
13	erje	0.0 KB	71.8 KB	71.8 KB	0.0 KB/s	3.1 KB	23:59:53
14	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:51:17
15	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
16	neva.ru	0.0 KB	54.9 KB	54.9 KB	0.0 KB/s	2.5 KB	23:59:49
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
TOTAL: 17		33.7 MB	10.0 MB	43.7 MB	0.0 KB/s	4.2 KB	406:46:54

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca	103	366865	1.6 GB	1751	23:42:35
2	47.192.187.101	7	3	5.8 KB	2	02:19:46
3	challenger.nielsenmedia.com	5	3	5.8 KB	2	01:00:56
TOTAL: 3		115	366871	1.6 GB	1755	36:34:01

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	103	366865	1.6 GB	1751	23:42:35
2	*.nielsenmedia.com	5	3	5.8 KB	2	01:00:56
3	unresolved	9	3	5.8 KB	2	02:21:24
4	*.bbox.io	6	0	0.0 KB	0	02:30:16
5	*.dhcp.mdsn.wi.charter.com	5	0	0.0 KB	0	01:47:45
6	*.chello.nl	32	0	0.0 KB	0	05:11:02
TOTAL: 6		160	366871	1.6 GB	1755	36:34:01

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca	75.091	148.047	23:42:35
dhcp-089-099-203-254.chello.nl	2.112	0.577	05:11:02
tempe0.bbox.io	0.566	0.146	02:30:16
47.192.187.101	0.588	0.144	02:19:46
68-185-181-64.dhcp.mdsn.wi.charter.com	0.344	0.085	01:47:45
challenger.nielsenmedia.com	0.391	0.150	01:00:56
71.94.21.184	0.766	1.695	00:01:30
95.238.49.27	0.073	0.016	00:00:07
TOTAL: 8	79.931	150.860	36:34:01

Curious NNRP server explorers [Top 20]:

System	Conn
dhcp-089-099-203-254.chello.nl	32
tempe0.bbox.io	6
68-185-181-64.dhcp.mdsn.wi.charter.com	5
71.94.21.184	1
95.238.49.27	1
TOTAL: 5	45

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	5	0
47.192.187.101	4	0
68-185-181-64.dhcp.mdsn.wi.charter.com	3	0
challenger.nielsenmedia.com	2	0
mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca	1	1
TOTAL: 5	15	1

Newsgroup request counts (by category):

Category		Count	Pct
1	free	178349	57.1%
2	alt	133828	42.9%
3	de	54	0.0%
4	comp	23	0.0%
5	uk	16	0.0%
6	rec	10	0.0%
7	linux	5	0.0%
8	it	4	0.0%
9	misc	4	0.0%
10	fr	4	0.0%
11	soc	2	0.0%
12	sci	1	0.0%
TOTAL: 12		312300	100.0%

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

Newsgroup		Count
1	free.at	178346
2	alt.drugs.heroin	105559
3	alt.politics.obama	28255
4	de.alt.fan.pluesch	14
5	de.alt.fan.aldi	7
6	comp.lang.python	7
7	uk.media.radio.archers	7
8	comp.lang.awk	6
9	de.rec.fotografie	6
10	de.etc.bahn.misc	5
11	comp.lang.python.announce	5
12	alt.happy.valley	5
13	linux.debian.bugs.rc	5
14	rec.food.cooking	4
15	fr.rec.loisirs-creatifs	4
16	de.rec.heimwerken	4
17	uk.legal	3
18	rec.arts.tv	3
19	uk.radio.amateur	2
20	de.comp.sys.mac.misc	2
21	de.sci.ing.elektrotechnik	2
22	de.sci.theologie	2
23	misc.health.diabetes	2
24	comp.os.linux.advocacy	2
25	alt.home.repair	2
26	de.comp.os.ms-windows.misc	2
27	free.it.scienza.fisica	2
28	alt.mag.playboy	1
29	de.etc.sprache.deutsch	1
30	soc.culture.israel	1
31	free.uk.btinternet.chatter.refugees	1
32	misc.phone.mobile.iphone	1
33	de.comp.hardware.laufwerke.festplatten	1
34	soc.genealogy.britain	1
35	comp.dsp	1
36	de.rec.tv.technik	1
37	comp.misc	1
38	it.comp.console	1
39	alt.folklore.computers	1
40	sci.optics	1
41	de.comm.software.mozilla.browser	1
42	it.sport.calcio.milan	1
43	de.rec.fahrrad	1
44	it.discussioni.misteri	1
45	de.etc.fahrzeug.auto	1
46	uk.politics.misc	1
47	uk.rec.drugs.cannabis	1
48	de.etc.post	1
49	uk.telecom.mobile	1
50	de.comm.software.mozilla.nightly-builds	1
51	comp.mobile.android	1
52	alt.atheism	1
53	alt.sports.football.pro.sd-chargers	1
54	it.hobby.fai-da-te	1
55	misc.survivalism	1
56	de.comp.text.tex	1
57	rec.radio.amateur.antenna	1
58	de.talk.tagesgeschehen	1
59	alt.os.linux.ubuntu	1
60	rec.crafts.metalworking	1
61	uk.d-i-y	1
62	rec.boats	1
63	alt.suicide.methods	1
64	alt.drugs.hard	1
TOTAL: 64		312300

Daily Usenet report for csiph.com

Nov 6 04:15:00 -- Nov 7 04:15:00