Daily Usenet report for csiph.com: Aug 14 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	29761	40.9%	6.4 MB	56.7%
nnrpd	25878	35.6%	2.7 MB	24.1%
innd	13730	18.9%	1.6 MB	14.6%
innfeed	3235	4.5%	516.9 KB	4.5%
nocem	86	0.1%	10.0 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	72691	100.0%	11.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	316224	53.4%
Negative hits	240851	40.7%
Do not exist	28904	4.9%
Cache misses	5687	1.0%
TOTAL: 4	591666	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.378	0.0%	229	0.000	10.384	68.900
article cleanup	00:00:00.211	0.0%	27793	0.000	0.008	0.027
article logging	00:00:07.047	0.0%	28312	0.000	0.249	2.255
article parse	00:00:15.205	0.0%	90385	0.004	0.168	1.481
article write	00:03:40.240	0.3%	20583	0.284	10.700	67.500
artlog/artcncl	00:00:00.198	0.0%	171	0.000	1.158	16.625
artlog/artparse	00:00:00.364	0.0%	1295	0.000	0.281	43.000
data move	00:00:00.273	0.0%	567646	0.000	0.000	0.035
hisgrep/artcncl	00:00:00.346	0.0%	227	0.000	1.524	29.000
hishave/artcncl	00:00:00.265	0.0%	229	0.000	1.157	15.000
hishave/artparse	00:00:00.004	0.0%	1291	0.000	0.003	0.083
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:03:34.027	0.2%	593917	0.002	0.360	2.871
history sync	00:00:04.983	0.0%	326	0.000	15.285	146.000
history write	00:05:18.633	0.4%	27787	2.370	11.467	63.262
hiswrite/artcncl	00:00:00.017	0.0%	2	7.000	8.500	10.000
hiswrite/artparse	00:00:13.452	0.0%	1291	0.000	10.420	83.000
idle	23:34:08.884	98.2%	544487	92.708	155.833	381.939
nntp read	00:00:02.555	0.0%	577782	0.002	0.004	0.010
overview write	00:10:30.149	0.7%	20583	1.154	30.615	200.397
perl filter	00:01:01.541	0.1%	27771	1.739	2.216	6.895
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.363	0.0%	41245	0.000	0.009	0.027
TOTAL: 24:00:29.351	23:59:01.135	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.083	0.0%	26811	0.000	0.003	0.053
article prepare	00:00:00.004	0.0%	29852	0.000	0.000	0.009
article read	00:00:02.414	0.0%	5200	0.000	0.464	27.900
backlog stats	00:00:00.189	0.0%	354223	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.855	0.0%	281171	0.002	0.007	0.012
data write	00:00:01.682	0.0%	268281	0.002	0.006	0.011
idle	23:54:15.912	100.0%	354223	137.177	242.943	932.656
status file	00:00:00.847	0.0%	314	0.000	2.697	70.000
TOTAL: 23:54:32.272	23:54:22.986	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.191	0.0%	1023	0.000	2.142	3.000
idle	144:51:30.263	97.5%	4820388	0.000	108.184	900344.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:01:04.657	0.0%	11268608	0.000	0.006	0.077
readart	03:35:42.091	2.4%	4778229	0.000	2.709	223.000
TOTAL: 148:33:08.965	148:28:19.202	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.news.weretis.net	3	40858	6404	33835	619	15%	45:57:43
2	csiph-out.feeder.erje.net	1152	87241	4245	78501	4495	4%	94:57:40
3	feeder.eternal-september.org	4	24079	2776	20542	761	11%	24:37:40
4	news-out.aioe.org	4	20433	1687	18686	60	8%	24:09:29
5	newsfeed.neva.ru	146	22618	1459	19351	1808	6%	71:22:40
6	news.redatomik.org	1	21834	1431	20380	23	6%	28:55:24
7	newsfeed.fu-berlin.de	52	20518	1087	19256	175	5%	33:38:12
8	news-out.mixmin.net	3	21498	1068	19948	482	4%	24:08:51
9	newsfeeds.xmission.com	2	31349	437	30910	2	1%	36:10:10
10	news.swapon.de	2	1800	52	1745	3	2%	24:09:27
11	news.freedyn.net	2	22282	30	22226	26	0%	23:59:43
12	news.fcku.it	1	7877	27	7836	14	0%	23:59:54
13	nntp.pasdenom.info	2	19240	13	19226	1	0%	23:58:56
14	xanadu-bbs.net	15	724	9	715	0	1%	22:56:29
15	localhost	37	3	3	0	0	100%	00:00:07
16	news.bbs.geek.nz	2	10203	1	10202	0	0%	06:25:33
TOTAL: 16		1428	352557	20729	323359	8469	5%	509:27:58

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	18.7 MB	10.4 KB	11.3 MB	30.0 MB	62%	4.4 KB
2	csiph-out.feeder.erje.net	17.3 MB	0.0 KB	69.6 MB	86.9 MB	19%	10.2 KB
3	feeder.eternal-september.org	8.2 MB	10.3 KB	6.4 MB	14.6 MB	56%	4.2 KB
4	news-out.aioe.org	4.8 MB	10.5 KB	108.1 KB	5.0 MB	97%	2.9 KB
5	news-out.mixmin.net	4.5 MB	8.9 KB	1.9 MB	6.4 MB	70%	4.2 KB
6	news.redatomik.org	4.2 MB	0.0 KB	622.8 KB	4.8 MB	87%	3.4 KB
7	newsfeed.neva.ru	4.0 MB	1.4 KB	8.0 MB	12.0 MB	33%	3.8 KB
8	newsfeed.fu-berlin.de	2.5 MB	0.0 KB	587.4 KB	3.1 MB	81%	2.5 KB
9	newsfeeds.xmission.com	1.0 MB	10.5 KB	10.5 KB	1.1 MB	98%	2.5 KB
10	news.swapon.de	209.2 KB	0.0 KB	1.2 MB	1.4 MB	14%	26.3 KB
11	news.freedyn.net	97.4 KB	0.0 KB	759.1 KB	856.5 KB	11%	15.3 KB
12	news.fcku.it	74.8 KB	0.0 KB	161.4 KB	236.1 KB	31%	5.8 KB
13	nntp.pasdenom.info	33.8 KB	0.0 KB	0.8 KB	34.6 KB	97%	2.5 KB
14	xanadu-bbs.net	18.5 KB	0.0 KB	0.0 KB	18.5 KB	100%	2.1 KB
15	localhost	3.9 KB	0.0 KB	0.0 KB	3.9 KB	100%	1.3 KB
16	news.bbs.geek.nz	1.3 KB	0.0 KB	0.0 KB	1.3 KB	100%	1.3 KB
TOTAL: 16		65.8 MB	52.0 KB	100.5 MB	166.4 MB	39%	5.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 14 04:15:00 - 04:59:59	349	1.7%	0.13	1.5 MB	2.3%	0.56
Aug 14 05:00:00 - 05:59:59	534	2.6%	0.15	2.2 MB	3.3%	0.61
Aug 14 06:00:00 - 06:59:59	566	2.8%	0.16	2.0 MB	3.1%	0.58
Aug 14 07:00:00 - 07:59:59	736	3.6%	0.20	2.3 MB	3.4%	0.65
Aug 14 08:00:00 - 08:59:59	823	4.0%	0.23	2.2 MB	3.3%	0.62
Aug 14 09:00:00 - 09:59:59	781	3.8%	0.22	2.2 MB	3.3%	0.62
Aug 14 10:00:00 - 10:59:59	851	4.1%	0.24	2.3 MB	3.5%	0.66
Aug 14 11:00:00 - 11:59:59	885	4.3%	0.25	2.4 MB	3.6%	0.68
Aug 14 12:00:00 - 12:59:59	874	4.2%	0.24	2.3 MB	3.5%	0.66
Aug 14 13:00:00 - 13:59:59	1019	5.0%	0.28	3.3 MB	5.0%	0.93
Aug 14 14:00:00 - 14:59:59	1152	5.6%	0.32	3.9 MB	5.9%	1.11
Aug 14 15:00:00 - 15:59:59	1205	5.9%	0.33	4.4 MB	6.7%	1.25
Aug 14 16:00:00 - 16:59:59	1350	6.6%	0.38	4.3 MB	6.6%	1.23
Aug 14 17:00:00 - 17:59:59	1135	5.5%	0.32	3.7 MB	5.6%	1.04
Aug 14 18:00:00 - 18:59:59	1122	5.5%	0.31	3.7 MB	5.7%	1.07
Aug 14 19:00:00 - 19:59:59	1174	5.7%	0.33	4.0 MB	6.1%	1.14
Aug 14 20:00:00 - 20:59:59	1095	5.3%	0.30	3.3 MB	5.0%	0.94
Aug 14 21:00:00 - 21:59:59	948	4.6%	0.26	2.7 MB	4.0%	0.75
Aug 14 22:00:00 - 22:59:59	774	3.8%	0.21	2.6 MB	3.9%	0.74
Aug 14 23:00:00 - 23:59:59	757	3.7%	0.21	2.4 MB	3.6%	0.67
Aug 15 00:00:00 - 00:59:59	613	3.0%	0.17	1.9 MB	2.9%	0.54
Aug 15 01:00:00 - 01:59:59	660	3.2%	0.18	2.2 MB	3.3%	0.61
Aug 15 02:00:00 - 02:59:59	570	2.8%	0.16	2.1 MB	3.1%	0.58
Aug 15 03:00:00 - 03:59:59	474	2.3%	0.13	1.7 MB	2.5%	0.48
Aug 15 04:00:00 - 04:15:00	126	0.6%	0.14	532.2 KB	0.8%	0.59
TOTAL: 24:00:00	20573	100.0%	0.24	65.9 MB	100.0%	0.78

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	4523	346	0	4177
2	newsfeed.neva.ru	1835	304	1	1530
3	feeder.eternal-september.org	777	49	0	728
4	csiph-out.news.weretis.net	667	234	0	433
5	newsfeed.fu-berlin.de	560	23	0	537
6	news-out.mixmin.net	494	2	0	492
7	news-out.aioe.org	65	52	0	13
8	news.redatomik.org	39	0	0	39
9	news.freedyn.net	26	7	0	19
10	news.fcku.it	15	9	0	6
11	news.swapon.de	13	0	0	13
12	newsfeeds.xmission.com	3	0	0	3
13	nntp.pasdenom.info	1	1	0	0
TOTAL: 13		9018	1027	1	7990

Unwanted newsgroups [Top 20]:

Newsgroup	Count
ut.test	150
lada.talk	113
it-alt.sport.calcio.juventus	99
lada.auto	70
gmane.linux.kernel	55
it.annunci.commerciali	52
it.annunci.varie	48
it.annunci.immobiliari	25
mozilla.dev.platform	22
alt.survival	20
alt.computer.workshop	19
alt.politics	13
gmane.linux.alsa.devel	12
mpc.lists.nanog	12
mozilla.dev.security.policy	12
alt.windows7.general	12
alt.2600	11
lada.photo	11
mozilla.support.firefox	9
ab.test	9
TOTAL: 133	1027

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	5357
EMP (phn path)	450
EMP (phn nph)	114
Too many newsgroups	74
Binary Payload	34
Scoring filter (10)	20
User-issued cancel	17
Scoring filter (11)	12
HTML Multipart	11
Scoring filter (20)	10
Scoring filter (12)	9
Scoring filter (8)	8
Poison newsgroup	6
EMP (fsl)	6
Scoring filter (9)	6
Scoring filter (23)	5
Too many newsgroups (low_xpost)	5
Binary: misplaced 008	2
Scoring filter (14)	2
EMP (phl)	2
TOTAL: 24	6154

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	79	0	89	89
TOTAL: 1	79	0	89	89

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	csiph-out.feeder.erje.net	1068
	csiph-out.news.weretis.net	153
	feeder.eternal-september.org	36
	news-out.mixmin.net	11
	news.freedyn.net	10
	newsfeed.fu-berlin.de	7
	news.swapon.de	3
	news.redatomik.org	3
	newsfeeds.xmission.com	1
	news.fcku.it	1
	TOTAL: 10	1293
Including strange strings
	newsfeed.fu-berlin.de	379
	csiph-out.feeder.erje.net	43
	csiph-out.news.weretis.net	37
	news.redatomik.org	18
	news-out.mixmin.net	12
	news.swapon.de	10
	news-out.aioe.org	9
	feeder.eternal-september.org	4
	newsfeed.neva.ru	4
	newsfeeds.xmission.com	2
	TOTAL: 10	518
No colon-space in header
	csiph-out.feeder.erje.net	3
	TOTAL: 1	3
TOTAL: 3		1814

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	38599	3593	21299	97	1098	9%	23:52:20
2	xanadu-bbs	22014	737	19769	7	145	3%	23:54:49
3	news.freedyn.net	21316	730	19730	1	0	3%	23:50:04
4	fu-berlin.de	19334	533	18796	0	0	2%	23:54:54
5	usenet.pasdenom.info	20804	146	18977	1371	5	0%	23:51:31
6	aioe	17100	46	16636	0	0	0%	23:56:10
7	news.redatomik.org	18951	23	18602	3	0	0%	23:50:04
8	erje	16791	23	16196	10	15	0%	23:55:27
9	eternal-september	17436	15	16993	0	0	0%	23:54:36
10	weretis.net	13215	10	13104	0	0	0%	23:57:25
11	xmission	20758	6	19425	0	0	0%	23:55:30
12	news.swapon.de	1776	6	1764	0	0	0%	23:47:06
13	neva.ru	18421	5	18102	97	0	0%	23:50:04
14	news.mixmin.net	18607	3	18328	0	0	0%	23:50:04
15	news.fcku.it	1164	1	1149	0	0	0%	21:39:34
16	bwh	0	0	0	0	19943	0%	23:50:05
17	au2pb	0	0	0	0	19956	0%	23:50:05
TOTAL: 17		266286	5877	238870	1586	41162	2%	403:39:48

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	9.8 MB	448.0 KB	10.3 MB	0.1 KB/s	2.8 KB	23:52:20
2	xanadu-bbs	7.0 MB	13.1 KB	7.0 MB	0.1 KB/s	9.6 KB	23:54:49
3	news.freedyn.net	6.9 MB	1.4 KB	6.9 MB	0.1 KB/s	9.6 KB	23:50:04
4	fu-berlin.de	6.4 MB	0.0 KB	6.4 MB	0.1 KB/s	12.2 KB	23:54:54
5	usenet.pasdenom.info	295.3 KB	7.7 MB	8.0 MB	0.1 KB/s	5.4 KB	23:51:31
6	aioe	97.9 KB	0.0 KB	97.9 KB	0.0 KB/s	2.1 KB	23:56:10
7	news.redatomik.org	57.1 KB	11.5 KB	68.6 KB	0.0 KB/s	2.6 KB	23:50:04
8	erje	38.9 KB	15.6 KB	54.5 KB	0.0 KB/s	1.7 KB	23:55:27
9	eternal-september	36.4 KB	0.0 KB	36.4 KB	0.0 KB/s	2.4 KB	23:54:36
10	weretis.net	23.0 KB	0.0 KB	23.0 KB	0.0 KB/s	2.3 KB	23:57:25
11	xmission	9.5 KB	0.0 KB	9.5 KB	0.0 KB/s	1.6 KB	23:55:30
12	news.swapon.de	9.5 KB	0.0 KB	9.5 KB	0.0 KB/s	1.6 KB	23:47:06
13	neva.ru	7.8 KB	212.3 KB	220.1 KB	0.0 KB/s	2.2 KB	23:50:04
14	news.mixmin.net	3.9 KB	0.0 KB	3.9 KB	0.0 KB/s	1.3 KB	23:50:04
15	news.fcku.it	3.7 KB	0.0 KB	3.7 KB	0.0 KB/s	3.7 KB	21:39:34
16	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:05
17	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:05
TOTAL: 17		30.6 MB	8.4 MB	39.0 MB	0.0 KB/s	5.3 KB	403:39:48

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp130-02-70-24-223-70.dsl.bell.ca	1169	813724	2.8 GB	3627	0	0	136:51:58
2	144.138.90.254	48	65	155.3 KB	43	0	0	00:37:33
3	tempe0.bbox.io	3	10	19.0 KB	1	0	0	01:30:47
4	a131033.upc-a.chello.nl	15	7	11.1 KB	2	0	0	03:13:16
5	71-90-122-151.dhcp.eucl.wi.charter.com	13	3	3.9 KB	2	3	2	01:55:48
TOTAL: 5		1248	813809	2.8 GB	3675	3	2	148:32:59

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	1169	813724	2.8 GB	3627	0	0	136:51:58
2	unresolved	50	65	155.3 KB	43	0	0	01:16:57
3	*.bbox.io	3	10	19.0 KB	1	0	0	01:30:47
4	*.upc-a.chello.nl	15	7	11.1 KB	2	0	0	03:13:16
5	*.dhcp.eucl.wi.charter.com	13	3	3.9 KB	2	3	2	01:55:48
6	*.drr02.clwr.fl.frontiernet.net	2	0	0.0 KB	0	0	0	01:00:04
7	*.dhcp.chtrptr.net	2	0	0.0 KB	0	0	0	00:32:12
8	*.cust.centrio.cz	4	0	0.0 KB	0	0	0	01:22:25
9	*.compute-1.amazonaws.com	1	0	0.0 KB	0	0	0	00:00:00
10	*.nielsenmedia.com	2	0	0.0 KB	0	0	0	00:49:28
TOTAL: 10		1261	813809	2.8 GB	3675	3	2	148:32:59

NNRP auth users [Top 20]:

User	Conn
moussa	48
ctomczyk	4
ohlandl	2
TOTAL: 3	54

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mtrlpq2314w-lp130-02-70-24-223-70.dsl.bell.ca	380.178	473.542	0.000	136:51:58
a131033.upc-a.chello.nl	1.182	0.231	0.000	03:13:16
71-90-122-151.dhcp.eucl.wi.charter.com	1.042	0.242	0.008	01:55:48
tempe0.bbox.io	0.332	0.055	0.000	01:30:47
204-73-239-109.cust.centrio.cz	0.323	0.047	0.017	01:22:25
47-192-186-209.drr02.clwr.fl.frontiernet.net	0.137	0.023	0.000	01:00:04
challenger.nielsenmedia.com	0.167	0.039	0.000	00:49:28
216.239.174.218	0.116	0.008	0.000	00:39:24
144.138.90.254	5.205	1.173	0.175	00:37:33
172-221-043-207.dhcp.chtrptr.net	0.220	0.129	0.000	00:32:12
ec2-54-226-224-115.compute-1.amazonaws.com	0.056	0.008	0.000	00:00:00
TOTAL: 11	388.958	475.497	0.200	148:32:59

Curious NNRP server explorers [Top 20]:

System	Conn
204-73-239-109.cust.centrio.cz	4
47-192-186-209.drr02.clwr.fl.frontiernet.net	2
challenger.nielsenmedia.com	2
172-221-043-207.dhcp.chtrptr.net	2
216.239.174.218	2
ec2-54-226-224-115.compute-1.amazonaws.com	1
TOTAL: 6	13

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	3	0
47-192-186-209.drr02.clwr.fl.frontiernet.net	2	0
204-73-239-109.cust.centrio.cz	2	0
71-90-122-151.dhcp.eucl.wi.charter.com	2	0
challenger.nielsenmedia.com	1	0
216.239.174.218	1	0
TOTAL: 6	11	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	704272	100.0%
2	comp	104	0.0%
3	uk	50	0.0%
4	rec	47	0.0%
5	talk	3	0.0%
6	misc	2	0.0%
7	soc	2	0.0%
8	fr	1	0.0%
9	can	1	0.0%
TOTAL: 9		704482	100.0%

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

Newsgroup		Count
1	alt.fan.rush-limbaugh	448334
2	alt.usenet.kooks	255894
3	rec.boats	38
4	comp.arch	33
5	comp.sys.ibm.ps2.hardware	23
6	alt.usage.english	13
7	uk.legal	13
8	comp.lang.python	13
9	alt.home.repair	12
10	comp.os.vms	12
11	comp.sys.ibm.pc.games.action	11
12	uk.rec.cycling	10
13	uk.rec.sheds	7
14	uk.d-i-y	5
15	alt.folklore.computers	4
16	uk.rec.motorcycles	4
17	alt.atheism	3
18	rec.arts.tv.uk.coronation-st	3
19	talk.politics.guns	3
20	uk.media.radio.archers	2
21	alt.comp.os.windows-10	2
22	comp.misc	2
23	misc.survivalism	2
24	alt.comp.freeware	2
25	alt.conspiracy	2
26	soc.retirement	2
27	rec.sport.tennis	2
28	alt.global-warming	2
29	comp.arch.fpga	2
30	uk.tech.digital-tv	2
31	alt.sports.football.pro.sd-chargers	2
32	uk.politics.misc	2
33	comp.lang.java.programmer	2
34	uk.media.tv.misc	1
35	comp.sys.raspberry-pi	1
36	uk.sport.cricket	1
37	can.politics	1
38	comp.os.os2.apps	1
39	comp.arch.arithmetic	1
40	comp.ai.philosophy	1
41	rec.arts.tv	1
42	uk.media.radio.bbc-r4	1
43	uk.railway	1
44	alt.os.linux.mint	1
45	fr.rec.photo	1
46	rec.sport.golf	1
47	alt.support.diabetes	1
48	comp.arch.embedded	1
49	uk.tech.broadcast	1
50	rec.photo.digital	1
51	comp.os.cpm	1
52	rec.autos.sport.f1	1
TOTAL: 52		704482

Daily Usenet report for csiph.com

Aug 14 04:15:00 -- Aug 15 04:15:00