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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	26204	41.1%	5.6 MB	56.4%
nnrpd	21208	33.3%	2.2 MB	22.4%
innd	13092	20.5%	1.6 MB	15.9%
innfeed	3113	4.9%	522.5 KB	5.2%
nocem	111	0.2%	11.7 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	63729	100.0%	9.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	277617	53.8%
Negative hits	212914	41.2%
Do not exist	25418	4.9%
Cache misses	271	0.1%
TOTAL: 4	516220	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.606	0.0%	279	0.000	5.756	62.833
article cleanup	00:00:00.180	0.0%	24640	0.000	0.007	0.023
article logging	00:00:04.989	0.0%	25121	0.000	0.199	3.932
article parse	00:00:10.681	0.0%	78847	0.000	0.135	1.267
article write	00:03:05.537	0.2%	17970	0.284	10.325	91.755
artlog/artcncl	00:00:00.060	0.0%	200	0.000	0.300	3.800
artlog/artparse	00:00:00.476	0.0%	914	0.000	0.521	5.194
data move	00:00:00.331	0.0%	504273	0.000	0.001	0.033
hisgrep/artcncl	00:00:00.523	0.0%	279	0.000	1.875	25.188
hishave/artcncl	00:00:00.217	0.0%	279	0.000	0.778	18.667
hishave/artparse	00:00:00.007	0.0%	909	0.000	0.008	0.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:52.381	0.2%	517754	0.001	0.333	2.204
history sync	00:00:04.649	0.0%	370	0.000	12.565	170.000
history write	00:03:48.645	0.3%	24644	1.010	9.278	64.155
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:09.124	0.0%	909	0.000	10.037	152.000
idle	23:41:20.200	98.6%	488642	96.596	174.525	491.979
nntp read	00:00:02.416	0.0%	511627	0.002	0.005	0.012
overview write	00:07:07.416	0.5%	17970	0.952	23.785	257.741
perl filter	00:00:56.344	0.1%	24596	1.280	2.291	10.979
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.359	0.0%	36045	0.000	0.010	0.031
TOTAL: 24:01:03.537	23:59:46.141	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.055	0.0%	18004	0.000	0.003	0.031
article prepare	00:00:00.003	0.0%	32732	0.000	0.000	0.004
article read	00:00:02.364	0.0%	5434	0.000	0.435	17.880
backlog stats	00:00:00.205	0.0%	318150	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.762	0.0%	249356	0.002	0.007	0.014
data write	00:00:01.472	0.0%	235482	0.002	0.006	0.011
idle	23:54:50.513	100.0%	318150	162.286	270.597	702.600
status file	00:00:00.790	0.0%	261	0.000	3.027	192.000
TOTAL: 23:55:05.290	23:54:57.164	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	20:02:23.077	99.6%	78012	82.647	924.769	601529.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.945	0.0%	156574	0.000	0.006	0.091
readart	00:01:53.982	0.2%	8938	0.000	12.753	546.000
TOTAL: 20:06:38.351	20:04:18.004	99.8%	-	-	-	-

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	4	36574	5866	30266	442	16%	48:27:31
2	csiph-out.feeder.erje.net	1152	78831	2921	72390	3520	3%	94:57:14
3	news-out.mixmin.net	3	19408	2614	15646	1148	13%	24:08:50
4	feeder.eternal-september.org	5	21347	2179	18426	742	10%	24:37:42
5	news.redatomik.org	1	17731	1552	16153	26	8%	25:13:32
6	newsfeed.neva.ru	153	19805	968	17439	1398	4%	71:44:41
7	newsfeed.fu-berlin.de	25	15511	772	14528	211	4%	24:40:43
8	news-out.aioe.org	1	17475	701	16765	9	4%	23:59:57
9	newsfeeds.xmission.com	1	16163	287	15874	2	1%	22:38:21
10	news.swapon.de	1	1605	34	1570	1	2%	23:10:31
11	nntp.pasdenom.info	2	16279	23	16253	3	0%	23:59:09
12	news.freedyn.net	2	19792	22	19749	21	0%	23:59:45
13	xanadu-bbs.net	16	602	16	586	0	2%	22:29:20
14	news.fcku.it	1	6984	7	6937	40	0%	23:59:58
15	localhost	37	4	4	0	0	100%	00:00:01
16	news.bbs.geek.nz	1	15316	2	15313	1	0%	23:59:48
TOTAL: 16		1405	303427	17968	277895	7564	5%	502:07:03

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	16.8 MB	10.7 KB	8.1 MB	24.9 MB	67%	4.0 KB
2	csiph-out.feeder.erje.net	13.8 MB	0.0 KB	49.1 MB	63.0 MB	21%	10.0 KB
3	news-out.mixmin.net	8.0 MB	4.3 KB	2.5 MB	10.6 MB	75%	2.9 KB
4	feeder.eternal-september.org	6.0 MB	6.3 KB	8.9 MB	14.9 MB	40%	5.2 KB
5	news.redatomik.org	3.5 MB	10.7 KB	51.6 KB	3.6 MB	98%	2.3 KB
6	newsfeed.neva.ru	2.7 MB	0.0 KB	7.1 MB	9.7 MB	27%	4.2 KB
7	news-out.aioe.org	2.4 MB	4.3 KB	24.9 KB	2.4 MB	98%	3.4 KB
8	newsfeed.fu-berlin.de	1.7 MB	0.8 KB	505.8 KB	2.2 MB	77%	2.3 KB
9	newsfeeds.xmission.com	657.6 KB	4.3 KB	71.2 KB	733.1 KB	89%	2.5 KB
10	news.swapon.de	99.0 KB	0.0 KB	80.3 KB	179.4 KB	55%	5.1 KB
11	news.freedyn.net	75.1 KB	6.3 KB	1.0 MB	1.1 MB	6%	26.5 KB
12	nntp.pasdenom.info	68.8 KB	0.0 KB	3.9 KB	72.7 KB	94%	2.8 KB
13	news.fcku.it	51.3 KB	0.0 KB	1.7 MB	1.7 MB	2%	37.3 KB
14	xanadu-bbs.net	44.9 KB	0.0 KB	0.0 KB	44.9 KB	100%	2.8 KB
15	news.bbs.geek.nz	10.4 KB	4.3 KB	4.3 KB	19.1 KB	54%	6.4 KB
16	localhost	6.3 KB	0.0 KB	0.0 KB	6.3 KB	100%	1.6 KB
TOTAL: 16		55.9 MB	52.0 KB	79.2 MB	135.1 MB	41%	5.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 12 04:15:00 - 04:59:59	250	1.4%	0.09	782.5 KB	1.4%	0.29
Aug 12 05:00:00 - 05:59:59	431	2.4%	0.12	1.3 MB	2.3%	0.37
Aug 12 06:00:00 - 06:59:59	513	2.9%	0.14	1.9 MB	3.4%	0.54
Aug 12 07:00:00 - 07:59:59	795	4.4%	0.22	2.9 MB	5.3%	0.84
Aug 12 08:00:00 - 08:59:59	837	4.7%	0.23	3.6 MB	6.4%	1.02
Aug 12 09:00:00 - 09:59:59	745	4.2%	0.21	2.4 MB	4.2%	0.67
Aug 12 10:00:00 - 10:59:59	790	4.4%	0.22	2.3 MB	4.1%	0.65
Aug 12 11:00:00 - 11:59:59	845	4.7%	0.23	2.7 MB	4.9%	0.78
Aug 12 12:00:00 - 12:59:59	787	4.4%	0.22	2.2 MB	4.0%	0.63
Aug 12 13:00:00 - 13:59:59	977	5.4%	0.27	2.6 MB	4.7%	0.74
Aug 12 14:00:00 - 14:59:59	939	5.2%	0.26	2.9 MB	5.2%	0.83
Aug 12 15:00:00 - 15:59:59	945	5.3%	0.26	3.3 MB	5.9%	0.93
Aug 12 16:00:00 - 16:59:59	1034	5.8%	0.29	3.1 MB	5.5%	0.87
Aug 12 17:00:00 - 17:59:59	992	5.5%	0.28	2.6 MB	4.7%	0.75
Aug 12 18:00:00 - 18:59:59	952	5.3%	0.26	3.3 MB	5.9%	0.93
Aug 12 19:00:00 - 19:59:59	956	5.3%	0.27	2.6 MB	4.7%	0.75
Aug 12 20:00:00 - 20:59:59	925	5.2%	0.26	2.6 MB	4.6%	0.73
Aug 12 21:00:00 - 21:59:59	771	4.3%	0.21	2.2 MB	3.9%	0.62
Aug 12 22:00:00 - 22:59:59	672	3.7%	0.19	2.2 MB	3.9%	0.61
Aug 12 23:00:00 - 23:59:59	722	4.0%	0.20	1.9 MB	3.4%	0.54
Aug 13 00:00:00 - 00:59:59	565	3.1%	0.16	1.7 MB	3.0%	0.48
Aug 13 01:00:00 - 01:59:59	509	2.8%	0.14	1.6 MB	2.8%	0.45
Aug 13 02:00:00 - 02:59:59	487	2.7%	0.14	1.7 MB	3.0%	0.48
Aug 13 03:00:00 - 03:59:59	387	2.2%	0.11	1.4 MB	2.4%	0.38
Aug 13 04:00:00 - 04:15:00	121	0.7%	0.13	318.4 KB	0.6%	0.35
TOTAL: 24:00:00	17947	100.0%	0.21	55.9 MB	100.0%	0.66

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	3579	199	0	3380
2	newsfeed.neva.ru	1400	190	0	1210
3	news-out.mixmin.net	1171	8	0	1163
4	feeder.eternal-september.org	740	33	0	707
5	newsfeed.fu-berlin.de	540	21	1	518
6	csiph-out.news.weretis.net	504	158	0	346
7	news.redatomik.org	43	0	0	43
8	news.fcku.it	38	0	0	38
9	news.freedyn.net	20	0	0	20
10	news-out.aioe.org	11	6	0	5
11	news.swapon.de	8	0	0	8
12	nntp.pasdenom.info	2	1	0	1
13	newsfeeds.xmission.com	2	0	0	2
TOTAL: 13		8058	616	1	7441

Unwanted newsgroups [Top 20]:

Newsgroup	Count
ut.test	82
lada.talk	59
lada.photo	53
alt.computer.workshop	48
gmane.linux.kernel	29
gmane.linux.alsa.devel	27
alt.windows7.general	22
mpc.lists.freebsd.gnome	19
mozilla.support.firefox	17
mozilla.dev.security.policy	14
gmane.comp.hardware.netbook.arm.sunxi	13
alt.politics	13
it-alt.sport.calcio.juventus	13
alt.binaries.moovee	10
alt.survival	9
spline.eisfair	8
mozilla.support.seamonkey	8
oesterreich.tratsch	7
alt.philosophy	6
mpc.lists.nanog	5
TOTAL: 101	616

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	5192
EMP (phn path)	515
EMP (phn nph)	118
Too many newsgroups	53
Binary Payload	25
Scoring filter (8)	16
HTML Multipart	15
User-issued cancel	9
Scoring filter (11)	7
Scoring filter (16)	7
Scoring filter (10)	6
HTML post	6
Scoring filter (18)	5
Scoring filter (9)	5
Scoring filter (14)	3
Cancel for rejected article	2
Binary Image: misplaced jpg	2
Poison newsgroup	2
Scoring filter (13)	1
Binary: misplaced 027	1
TOTAL: 24	5994

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	105	0	117	117
TOTAL: 1	105	0	117	117

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	csiph-out.feeder.erje.net	746
	csiph-out.news.weretis.net	113
	feeder.eternal-september.org	29
	news.freedyn.net	12
	news.fcku.it	9
	news-out.mixmin.net	7
	newsfeeds.xmission.com	1
	news.swapon.de	1
	newsfeed.fu-berlin.de	1
	TOTAL: 9	919
Including strange strings
	newsfeed.fu-berlin.de	311
	csiph-out.news.weretis.net	51
	csiph-out.feeder.erje.net	46
	news-out.mixmin.net	35
	news.redatomik.org	17
	news.swapon.de	7
	feeder.eternal-september.org	6
	news-out.aioe.org	3
	newsfeed.neva.ru	3
	newsfeeds.xmission.com	1
	TOTAL: 10	480
No colon-space in header
	csiph-out.feeder.erje.net	5
	TOTAL: 1	5
TOTAL: 3		1404

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.bbs.geek.nz	29447	3675	13456	71	1	0	12%	23:50:11
2	news.freedyn.net	18518	874	16980	1	0	0	4%	23:49:50
3	xanadu-bbs	19307	861	17058	4	0	80	4%	23:58:37
4	fu-berlin.de	16877	640	16237	0	0	0	3%	23:50:11
5	usenet.pasdenom.info	18158	138	16112	1612	0	3	0%	23:50:57
6	aioe	15334	75	14871	2	0	0	0%	23:50:11
7	erje	15421	17	14849	7	0	0	0%	23:50:11
8	news.redatomik.org	16193	11	15715	3	0	0	0%	23:52:21
9	xmission	17908	9	16787	2	0	0	0%	23:50:11
10	neva.ru	16207	8	15902	147	0	0	0%	23:50:11
11	weretis.net	11205	8	11031	0	1	0	0%	23:52:40
12	news.mixmin.net	14632	5	14344	0	0	0	0%	23:50:11
13	news.swapon.de	1680	4	1673	0	0	0	0%	23:53:48
14	eternal-september	15321	4	14863	0	0	0	0%	23:50:11
15	au2pb	0	0	0	0	0	17216	0%	23:50:07
16	bwh	0	0	0	0	0	17210	0%	23:50:07
17	news.fcku.it	1021	0	1012	0	0	0	0%	22:01:35
TOTAL: 17		227229	6329	200890	1849	2	34509	2%	403:41:30

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	10.0 MB	305.1 KB	10.3 MB	0.1 KB/s	2.8 KB	23:50:11
2	xanadu-bbs	7.3 MB	9.8 KB	7.3 MB	0.1 KB/s	8.7 KB	23:58:37
3	news.freedyn.net	7.3 MB	1.0 KB	7.3 MB	0.1 KB/s	8.5 KB	23:49:50
4	fu-berlin.de	6.8 MB	0.0 KB	6.8 MB	0.1 KB/s	10.8 KB	23:50:11
5	usenet.pasdenom.info	296.5 KB	8.4 MB	8.7 MB	0.1 KB/s	5.1 KB	23:50:57
6	aioe	155.9 KB	7.1 KB	163.1 KB	0.0 KB/s	2.1 KB	23:50:11
7	erje	58.6 KB	62.5 KB	121.1 KB	0.0 KB/s	5.0 KB	23:50:11
8	xmission	29.2 KB	8.6 KB	37.8 KB	0.0 KB/s	3.4 KB	23:50:11
9	news.redatomik.org	25.9 KB	6.7 KB	32.6 KB	0.0 KB/s	2.3 KB	23:52:21
10	weretis.net	21.9 KB	0.0 KB	21.9 KB	0.0 KB/s	2.7 KB	23:52:40
11	neva.ru	13.9 KB	285.4 KB	299.3 KB	0.0 KB/s	1.9 KB	23:50:11
12	news.mixmin.net	9.4 KB	0.0 KB	9.4 KB	0.0 KB/s	1.9 KB	23:50:11
13	news.swapon.de	6.3 KB	0.0 KB	6.3 KB	0.0 KB/s	1.6 KB	23:53:48
14	eternal-september	6.3 KB	0.0 KB	6.3 KB	0.0 KB/s	1.6 KB	23:50:11
15	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:07
16	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:07
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:01:35
TOTAL: 17		32.0 MB	9.0 MB	41.1 MB	0.0 KB/s	5.1 KB	403:41:30

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp130-02-70-24-223-70.dsl.bell.ca	1200	114	270.5 KB	78	0	0	02:42:14
2	144.138.90.254	47	31	87.8 KB	27	0	0	00:37:24
3	cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	2	9	13.6 KB	1	0	0	00:07:28
4	tempe0.bbox.io	16	9	14.3 KB	5	0	0	05:24:51
5	71-90-122-151.dhcp.eucl.wi.charter.com	8	6	10.0 KB	6	4	4	02:33:27
6	a131033.upc-a.chello.nl	21	4	6.1 KB	3	0	0	05:18:16
7	challenger.nielsenmedia.com	2	1	3.0 KB	1	0	0	00:53:17
8	47-192-186-209.drr02.clwr.fl.frontiernet.net	3	1	3.0 KB	1	0	0	01:29:15
TOTAL: 8		1299	175	408.4 KB	122	4	4	20:06:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	1200	114	270.5 KB	78	0	0	02:42:14
2	unresolved	47	31	87.8 KB	27	0	0	00:37:24
3	*.bbox.io	16	9	14.3 KB	5	0	0	05:24:51
4	*.19-1.cable.virginm.net	2	9	13.6 KB	1	0	0	00:07:28
5	*.dhcp.eucl.wi.charter.com	8	6	10.0 KB	6	4	4	02:33:27
6	*.upc-a.chello.nl	21	4	6.1 KB	3	0	0	05:18:16
7	*.drr02.clwr.fl.frontiernet.net	3	1	3.0 KB	1	0	0	01:29:15
8	*.nielsenmedia.com	2	1	3.0 KB	1	0	0	00:53:17
9	*.cust.centrio.cz	2	0	0.0 KB	0	0	0	01:00:12
TOTAL: 9		1301	175	408.4 KB	122	4	4	20:06:28

NNRP auth users [Top 20]:

User	Conn
moussa	47
ohlandl	4
ctomczyk	2
TOTAL: 3	53

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
tempe0.bbox.io	1.392	0.265	0.000	05:24:51
a131033.upc-a.chello.nl	1.608	0.359	0.000	05:18:16
mtrlpq2314w-lp130-02-70-24-223-70.dsl.bell.ca	110.192	19.677	0.000	02:42:14
71-90-122-151.dhcp.eucl.wi.charter.com	0.824	0.117	0.020	02:33:27
47-192-186-209.drr02.clwr.fl.frontiernet.net	0.280	0.050	0.000	01:29:15
204-73-239-109.cust.centrio.cz	0.158	0.046	0.010	01:00:12
challenger.nielsenmedia.com	0.272	0.024	0.000	00:53:17
144.138.90.254	4.975	1.056	0.241	00:37:24
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	0.288	0.047	0.000	00:07:28
TOTAL: 9	119.989	21.641	0.271	20:06:28

Curious NNRP server explorers [Top 20]:

System	Conn
204-73-239-109.cust.centrio.cz	2
TOTAL: 1	2

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	80	45.7%
2	uk	33	18.9%
3	rec	33	18.9%
4	alt	22	12.6%
5	soc	3	1.7%
6	misc	3	1.7%
7	fr	1	0.6%
TOTAL: 7		175	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	31
2	rec.boats	15
3	uk.d-i-y	9
4	comp.lang.python	8
5	rec.photo.digital	8
6	comp.lang.c	7
7	uk.media.radio.archers	6
8	comp.os.msdos.djgpp	5
9	comp.os.cpm	5
10	comp.arch	5
11	alt.comp.os.windows-10	4
12	rec.arts.tv	4
13	alt.sports.football.pro.sd-chargers	4
14	alt.home.repair	4
15	alt.support.diabetes	4
16	comp.sys.ibm.pc.games.action	3
17	comp.sys.att	3
18	uk.rec.cycling	3
19	misc.survivalism	3
20	uk.net.news.moderation	3
21	comp.ai.philosophy	3
22	alt.conspiracy	3
23	rec.sport.tennis	2
24	uk.legal	2
25	rec.arts.drwho	2
26	comp.lang.awk	2
27	uk.sci.weather	2
28	soc.culture.polish	2
29	comp.lang.java.programmer	2
30	uk.radio.amateur	2
31	uk.rec.sheds	2
32	uk.tech.broadcast	1
33	soc.retirement	1
34	fr.soc.politique	1
35	alt.os.linux.mint	1
36	comp.mobile.android	1
37	alt.os.linux.ubuntu	1
38	comp.os.msdos.misc	1
39	rec.arts.tv.uk.coronation-st	1
40	alt.sports.basketball.nba.gs-warriors	1
41	comp.arch.embedded	1
42	uk.politics.misc	1
43	uk.comp.sys.mac	1
44	comp.lang.clipper.visual-objects	1
45	comp.arch.fpga	1
46	uk.rec.drugs.cannabis	1
47	rec.outdoors.rv-travel	1
48	comp.os.vms	1
TOTAL: 48		175

Daily Usenet report for csiph.com

Aug 12 04:15:00 -- Aug 13 04:15:00