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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	43461	60.2%	8.0 MB	71.5%
innd	24477	33.9%	2.6 MB	22.8%
innfeed	3183	4.4%	554.0 KB	4.8%
nnrpd	936	1.3%	100.9 KB	0.9%
nocem	86	0.1%	8.7 KB	0.1%
TOTAL: 5	72143	100.0%	11.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	431615	55.3%
Negative hits	306525	39.3%
Do not exist	41985	5.4%
Cache misses	708	0.1%
TOTAL: 4	780833	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.401	0.0%	277	0.000	5.058	40.000
article cleanup	00:00:00.317	0.0%	42545	0.000	0.007	0.035
article logging	00:00:00.611	0.0%	43165	0.000	0.014	0.381
article parse	00:00:01.301	0.0%	156023	0.000	0.008	0.044
article write	00:03:38.499	0.3%	23168	0.373	9.431	63.422
artlog/artcncl	00:00:00.003	0.0%	203	0.000	0.015	0.250
artlog/artparse	00:00:00.000	0.0%	93	0.000	0.000	0.000
data move	00:00:00.304	0.0%	708575	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.221	0.0%	276	0.000	0.801	8.750
hishave/artcncl	00:00:00.101	0.0%	277	0.000	0.365	5.444
hishave/artparse	00:00:00.001	0.0%	83	0.000	0.012	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:13.538	0.0%	783723	0.002	0.017	0.310
history sync	00:00:01.252	0.0%	356	0.000	3.517	27.667
history write	00:00:51.487	0.1%	41975	0.088	1.227	17.717
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.045	0.0%	83	0.000	0.542	5.000
idle	23:51:18.875	99.3%	711087	64.612	120.771	359.868
nntp read	00:00:03.445	0.0%	725203	0.002	0.005	0.008
overview write	00:01:59.927	0.1%	23168	0.275	5.176	73.013
perl filter	00:01:38.330	0.1%	41921	1.584	2.346	3.842
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.435	0.0%	46411	0.000	0.009	0.032
TOTAL: 24:00:54.032	23:59:50.093	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.081	0.0%	23148	0.000	0.003	0.032
article prepare	00:00:00.003	0.0%	23624	0.000	0.000	0.004
article read	00:00:02.746	0.0%	3688	0.000	0.745	21.714
backlog stats	00:00:00.372	0.0%	429045	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.711	0.0%	328879	0.004	0.008	0.013
data write	00:00:02.391	0.0%	313434	0.002	0.008	0.015
idle	23:53:39.179	100.0%	429045	122.055	200.490	503.575
status file	00:00:00.268	0.0%	288	0.000	0.931	12.250
TOTAL: 23:53:57.136	23:53:47.751	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.732	0.0%	7006	0.063	0.390	0.524
idle	23:17:15.660	99.8%	32856	121.786	2551.609	600096.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.673	0.0%	71408	0.000	0.009	0.083
readart	00:02:51.092	0.2%	23819	0.000	7.183	49.000
TOTAL: 23:20:43.197	23:20:10.157	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	126374	7051	109631	9692	5%	95:02:45
2	csiph-out.news.weretis.net	8	46788	4703	41362	723	10%	45:41:07
3	feeder.eternal-september.org	57	37783	3302	28536	5945	8%	37:01:57
4	news-out.aioe.org	10	22863	2525	20252	86	11%	24:23:43
5	newsfeed.neva.ru	144	51675	1430	47693	2552	2%	71:39:46
6	newsfeed.fu-berlin.de	49	21582	1036	20446	100	4%	31:04:51
7	news.redatomik.org	7	27365	993	26217	155	3%	29:07:43
8	news-out.mixmin.net	2	24335	842	23316	177	3%	24:08:52
9	newsfeeds.xmission.com	3	21127	805	20303	19	3%	22:19:34
10	xanadu-bbs.net	8	944	147	775	22	15%	23:29:15
11	news.freedyn.net	4	24667	107	24455	105	0%	24:09:50
12	news.fcku.it	1	9611	105	9461	45	1%	23:59:57
13	news.swapon.de	4	2015	63	1950	2	3%	23:46:27
14	nntp.pasdenom.info	1	36370	18	36326	26	0%	23:59:56
15	news.bbs.geek.nz	1	19338	4	19333	1	0%	17:07:45
16	localhost	38	0	0	0	0	0%	00:00:00
TOTAL: 16		1489	472837	23131	430056	19650	4%	517:03:28

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	21.7 MB	2.1 MB	56.3 MB	80.2 MB	27%	4.9 KB
2	csiph-out.news.weretis.net	13.4 MB	1.9 KB	8.7 MB	22.1 MB	60%	4.2 KB
3	feeder.eternal-september.org	8.8 MB	4.8 MB	75.1 MB	88.7 MB	9%	9.8 KB
4	news-out.aioe.org	6.5 MB	0.0 KB	201.6 KB	6.7 MB	97%	2.6 KB
5	news-out.mixmin.net	4.9 MB	0.0 KB	1.2 MB	6.1 MB	80%	6.1 KB
6	newsfeed.neva.ru	3.5 MB	347.7 KB	27.0 MB	30.8 MB	11%	7.9 KB
7	news.redatomik.org	2.9 MB	1.9 KB	1.4 MB	4.3 MB	67%	3.8 KB
8	newsfeeds.xmission.com	2.4 MB	0.0 KB	963.2 KB	3.4 MB	72%	4.2 KB
9	newsfeed.fu-berlin.de	2.4 MB	0.0 KB	350.3 KB	2.7 MB	87%	2.5 KB
10	news.freedyn.net	514.3 KB	0.0 KB	1.2 MB	1.7 MB	30%	8.1 KB
11	xanadu-bbs.net	462.7 KB	0.0 KB	108.1 KB	570.8 KB	81%	3.4 KB
12	news.swapon.de	196.3 KB	0.0 KB	3.0 KB	199.2 KB	98%	3.1 KB
13	news.fcku.it	147.0 KB	0.0 KB	525.7 KB	672.7 KB	21%	4.5 KB
14	nntp.pasdenom.info	33.4 KB	0.0 KB	130.2 KB	163.7 KB	20%	3.7 KB
15	news.bbs.geek.nz	10.1 KB	0.0 KB	614.3 KB	624.3 KB	1%	124.9 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		67.9 MB	7.3 MB	173.7 MB	248.8 MB	27%	6.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 15 04:15:00 - 04:59:59	403	1.7%	0.15	1.6 MB	2.3%	0.59
Dec 15 05:00:00 - 05:59:59	553	2.4%	0.15	2.0 MB	2.9%	0.57
Dec 15 06:00:00 - 06:59:59	548	2.4%	0.15	2.2 MB	3.2%	0.63
Dec 15 07:00:00 - 07:59:59	705	3.0%	0.20	2.0 MB	2.9%	0.56
Dec 15 08:00:00 - 08:59:59	935	4.0%	0.26	2.7 MB	4.0%	0.78
Dec 15 09:00:00 - 09:59:59	973	4.2%	0.27	2.9 MB	4.3%	0.83
Dec 15 10:00:00 - 10:59:59	1213	5.2%	0.34	3.0 MB	4.5%	0.86
Dec 15 11:00:00 - 11:59:59	1090	4.7%	0.30	2.8 MB	4.1%	0.79
Dec 15 12:00:00 - 12:59:59	1080	4.7%	0.30	2.9 MB	4.2%	0.82
Dec 15 13:00:00 - 13:59:59	1121	4.8%	0.31	3.0 MB	4.3%	0.84
Dec 15 14:00:00 - 14:59:59	1223	5.3%	0.34	3.2 MB	4.7%	0.91
Dec 15 15:00:00 - 15:59:59	1350	5.8%	0.38	3.6 MB	5.2%	1.01
Dec 15 16:00:00 - 16:59:59	1332	5.7%	0.37	3.8 MB	5.6%	1.08
Dec 15 17:00:00 - 17:59:59	1346	5.8%	0.37	4.0 MB	5.9%	1.15
Dec 15 18:00:00 - 18:59:59	1374	5.9%	0.38	4.2 MB	6.1%	1.19
Dec 15 19:00:00 - 19:59:59	1181	5.1%	0.33	3.4 MB	5.0%	0.96
Dec 15 20:00:00 - 20:59:59	1259	5.4%	0.35	3.5 MB	5.1%	0.99
Dec 15 21:00:00 - 21:59:59	1140	4.9%	0.32	3.1 MB	4.6%	0.90
Dec 15 22:00:00 - 22:59:59	1105	4.8%	0.31	3.1 MB	4.6%	0.90
Dec 15 23:00:00 - 23:59:59	873	3.8%	0.24	3.1 MB	4.5%	0.87
Dec 16 00:00:00 - 00:59:59	739	3.2%	0.21	2.5 MB	3.7%	0.72
Dec 16 01:00:00 - 01:59:59	468	2.0%	0.13	1.5 MB	2.2%	0.43
Dec 16 02:00:00 - 02:59:59	451	1.9%	0.13	1.6 MB	2.3%	0.45
Dec 16 03:00:00 - 03:59:59	594	2.6%	0.17	2.0 MB	2.9%	0.57
Dec 16 04:00:00 - 04:15:00	116	0.5%	0.13	469.9 KB	0.7%	0.52
TOTAL: 24:00:00	23172	100.0%	0.27	68.2 MB	100.0%	0.81

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	9755	439	176	9140
2	feeder.eternal-september.org	5738	54	388	5296
3	newsfeed.neva.ru	2556	210	27	2319
4	csiph-out.news.weretis.net	810	201	1	608
5	newsfeed.fu-berlin.de	538	29	0	509
6	news-out.mixmin.net	184	1	0	183
7	news.redatomik.org	159	0	1	158
8	news-out.aioe.org	115	31	0	84
9	news.freedyn.net	107	0	0	107
10	news.fcku.it	48	0	0	48
11	nntp.pasdenom.info	26	1	0	25
12	xanadu-bbs.net	22	0	0	22
13	newsfeeds.xmission.com	20	1	0	19
14	news.swapon.de	8	0	0	8
TOTAL: 14		20086	967	593	18526

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	99
ut.test	84
it.annunci.varie	48
it.annunci.immobiliari	46
it.annunci.commerciali	44
mpc.lists.freebsd.ports.bugs	39
mozilla.dev.platform	37
alt.windows7.general	31
it-alt.comp.software.openoffice	31
it-alt.sport.calcio.juventus	28
alt.courts.pretrial-services	27
gmane.linux.alsa.devel	26
lada.auto	23
lada.photo	21
spline.eisfair	17
mpc.lists.nanog	16
gmane.linux.kernel	15
gmane.comp.freedesktop.xorg.drivers.intel	15
lada.kitchen	15
mozilla.dev.developer-tools	12
TOTAL: 137	967

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	15730
EMP (phn path)	1475
EMP (phl)	355
Binary Payload	42
Too many newsgroups	28
Scoring filter (12)	21
Scoring filter (10)	18
HTML Multipart	14
User-issued cancel	14
Scoring filter (8)	11
Scoring filter (14)	11
Scoring filter (9)	9
Scoring filter (13)	7
Scoring filter (15)	6
Scoring filter (18)	5
Binary: misplaced par2	4
Binary Image: misplaced jpg	4
Scoring filter (19)	3
HTML Image Tags	3
Scoring filter (17)	3
TOTAL: 27	17771

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	75	0	91	91
TOTAL: 1	75	0	91	91

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	44
	TOTAL: 1	44
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	TOTAL: 1	4
Huge articles
	csiph-out.news.weretis.net	19
	feeder.eternal-september.org	17
	news-out.mixmin.net	16
	newsfeeds.xmission.com	14
	news.redatomik.org	11
	newsfeed.fu-berlin.de	2
	news.fcku.it	2
	news.freedyn.net	1
	TOTAL: 8	82
Including strange strings
	newsfeed.fu-berlin.de	442
	csiph-out.feeder.erje.net	61
	csiph-out.news.weretis.net	37
	news-out.aioe.org	29
	feeder.eternal-september.org	22
	news-out.mixmin.net	9
	news.swapon.de	6
	news.redatomik.org	6
	newsfeeds.xmission.com	5
	newsfeed.neva.ru	2
	TOTAL: 11	620
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 5		751

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	42710	1517	21107	28	13	3%	23:59:48
2	news.freedyn.net	23593	843	22207	10	7	3%	23:59:56
3	erje	17399	554	15406	37	0	3%	23:59:56
4	xanadu-bbs	24804	528	22493	1	5	2%	23:59:56
5	fu-berlin.de	21862	460	21402	0	0	2%	23:59:56
6	usenet.pasdenom.info	25190	206	21393	1546	0	0%	23:59:56
7	news.redatomik.org	22570	47	21741	5	33	0%	23:59:56
8	weretis.net	17383	20	16811	0	0	0%	23:59:56
9	xmission	25561	17	21753	0	7	0%	23:59:52
10	aioe	20201	15	18771	10	0	0%	23:59:55
11	neva.ru	22016	6	20814	58	0	0%	23:59:42
12	news.swapon.de	2103	4	2034	2	0	0%	23:48:47
13	news.fcku.it	2915	3	2843	0	0	0%	22:28:25
14	eternal-september	20677	2	19052	0	0	0%	23:59:51
15	news.mixmin.net	21949	1	20739	0	0	0%	23:59:56
16	bwh	0	0	0	0	22634	0%	23:58:43
17	au2pb	0	0	0	0	22668	0%	23:58:43
TOTAL: 17		310933	4223	268566	1697	45367	1%	406:13:14

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	4.9 MB	85.1 KB	5.0 MB	0.1 KB/s	6.0 KB	23:59:56
2	news.bbs.geek.nz	4.3 MB	142.1 KB	4.5 MB	0.1 KB/s	3.0 KB	23:59:48
3	xanadu-bbs	3.9 MB	5.4 KB	3.9 MB	0.0 KB/s	7.5 KB	23:59:56
4	fu-berlin.de	3.7 MB	0.0 KB	3.7 MB	0.0 KB/s	8.3 KB	23:59:56
5	erje	2.0 MB	177.5 KB	2.1 MB	0.0 KB/s	3.7 KB	23:59:56
6	usenet.pasdenom.info	785.2 KB	5.8 MB	6.6 MB	0.1 KB/s	3.8 KB	23:59:56
7	news.redatomik.org	212.9 KB	14.0 KB	226.9 KB	0.0 KB/s	4.4 KB	23:59:56
8	weretis.net	65.9 KB	0.0 KB	65.9 KB	0.0 KB/s	3.3 KB	23:59:56
9	neva.ru	53.0 KB	208.9 KB	261.9 KB	0.0 KB/s	4.1 KB	23:59:42
10	xmission	45.4 KB	0.0 KB	45.4 KB	0.0 KB/s	2.7 KB	23:59:52
11	aioe	32.0 KB	76.5 KB	108.5 KB	0.0 KB/s	4.3 KB	23:59:55
12	eternal-september	23.3 KB	0.0 KB	23.3 KB	0.0 KB/s	11.6 KB	23:59:51
13	news.swapon.de	9.2 KB	10.0 KB	19.2 KB	0.0 KB/s	3.2 KB	23:48:47
14	news.fcku.it	4.3 KB	0.0 KB	4.3 KB	0.0 KB/s	1.4 KB	22:28:25
15	news.mixmin.net	3.7 KB	0.0 KB	3.7 KB	0.0 KB/s	3.7 KB	23:59:56
16	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:43
17	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:43
TOTAL: 17		20.0 MB	6.5 MB	26.5 MB	0.0 KB/s	4.6 KB	406:13:14

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp130-02-70-24-221-55.dsl.bell.ca	10	2806	9.8 MB	78	01:02:12
2	194-73-239-109.cust.centrio.cz	25	18	49.1 KB	6	03:51:52
3	tempe0.bbox.io	19	1	0.9 KB	1	05:01:18
TOTAL: 3		54	2825	9.8 MB	85	23:20:42

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	10	2806	9.8 MB	78	01:02:12
2	*.cust.centrio.cz	25	18	49.1 KB	6	03:51:52
3	*.bbox.io	19	1	0.9 KB	1	05:01:18
4	*.dhcp.mdsn.wi.charter.com	3	0	0.0 KB	0	01:30:36
5	*.164.22.98.dynamic.ip.windstream.net	2	0	0.0 KB	0	08:05:55
6	*.chello.nl	19	0	0.0 KB	0	02:48:43
7	unresolved	2	0	0.0 KB	0	01:00:03
TOTAL: 7		80	2825	9.8 MB	85	23:20:42

NNRP auth users [Top 20]:

User	Conn
ctomczyk	11
TOTAL: 1	11

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
h27.164.22.98.dynamic.ip.windstream.net	0.420	0.613	0.000	08:05:55
tempe0.bbox.io	1.523	0.410	0.000	05:01:18
194-73-239-109.cust.centrio.cz	2.054	0.391	0.031	03:51:52
dhcp-089-099-203-254.chello.nl	1.223	0.362	0.000	02:48:43
68-185-181-64.dhcp.mdsn.wi.charter.com	0.201	0.062	0.000	01:30:36
mtrlpq2314w-lp130-02-70-24-221-55.dsl.bell.ca	2.827	3.937	0.000	01:02:12
174.47.44.30	0.120	0.055	0.000	01:00:03
TOTAL: 7	8.368	5.830	0.031	23:20:42

Curious NNRP server explorers [Top 20]:

System	Conn
dhcp-089-099-203-254.chello.nl	19
68-185-181-64.dhcp.mdsn.wi.charter.com	3
h27.164.22.98.dynamic.ip.windstream.net	2
174.47.44.30	2
TOTAL: 4	26

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	10	0
194-73-239-109.cust.centrio.cz	7	0
68-185-181-64.dhcp.mdsn.wi.charter.com	3	0
h27.164.22.98.dynamic.ip.windstream.net	2	0
174.47.44.30	2	0
TOTAL: 5	24	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	1127	39.9%
2	linux	817	28.9%
3	fr	598	21.2%
4	uk	126	4.5%
5	comp	61	2.2%
6	rec	54	1.9%
7	misc	18	0.6%
8	aus	13	0.5%
9	sci	4	0.1%
10	soc	4	0.1%
11	talk	3	0.1%
TOTAL: 11		2825	100.0%

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

Newsgroup		Count
1	linux.kernel	817
2	alt.atheism	807
3	fr.soc.politique	598
4	alt.society.liberalism	113
5	alt.comp.freeware	83
6	alt.bible.prophecy	34
7	comp.lang.python	33
8	uk.legal	26
9	uk.d-i-y	21
10	uk.media.radio.archers	20
11	alt.home.repair	19
12	uk.radio.amateur	19
13	misc.survivalism	18
14	rec.boats	18
15	alt.religion.christian	18
16	comp.lang.javascript	18
17	alt.happy.valley	15
18	aus.cars	10
19	alt.sports.football.pro.sd-chargers	8
20	rec.aviation.soaring	7
21	alt.assassination.jfk	6
22	rec.outdoors.rv-travel	6
23	rec.arts.tv	6
24	uk.rec.sheds	6
25	rec.autos.sport.f1	5
26	uk.sci.weather	5
27	uk.railway	5
28	uk.tech.digital-tv	5
29	uk.games.video.misc	5
30	alt.os.linux.mint	4
31	uk.comp.homebuilt	4
32	sci.physics.relativity	3
33	comp.lang.c	3
34	aus.legal	3
35	uk.politics.misc	3
36	talk.politics.guns	3
37	alt.usage.english	3
38	alt.appalachian	3
39	rec.gardens	3
40	rec.crafts.metalworking	2
41	alt.sports.basketball.nba.gs-warriors	2
42	uk.rec.cycling	2
43	alt.os.linux.slackware	2
44	alt.computer	2
45	soc.genealogy.benelux	2
46	alt.baldspot	2
47	sci.space.policy	1
48	alt.agnosticism	1
49	alt.guitar.amps	1
50	rec.photo.digital	1
51	rec.pets.cats.community	1
52	rec.sport.golf	1
53	rec.music.dylan	1
54	alt.suicide.methods	1
55	comp.lang.postscript	1
56	comp.sys.ibm.ps2.hardware	1
57	rec.arts.tv.uk.coronation-st	1
58	soc.culture.usa	1
59	comp.lang.ada	1
60	uk.rec.driving	1
61	uk.rec.drugs.cannabis	1
62	comp.ai.philosophy	1
63	uk.comp.sys.mac	1
64	rec.woodworking	1
65	rec.arts.sf.written	1
66	alt.folklore.computers	1
67	alt.stupidity	1
68	uk.rec.motorcycles	1
69	comp.sys.mac.apps	1
70	uk.people.silversurfers	1
71	comp.mail.eudora.ms-windows	1
72	comp.lang.fortran	1
73	alt.astronomy	1
74	soc.culture.polish	1
TOTAL: 74		2825

Daily Usenet report for csiph.com

Dec 15 04:15:00 -- Dec 16 04:15:00