Daily Usenet report for csiph.com: Sep 30 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	24581	49.4%	6.1 MB	65.3%
innd	18087	36.3%	2.3 MB	24.4%
innfeed	6544	13.2%	935.5 KB	9.7%
nnrpd	475	1.0%	54.2 KB	0.6%
nocem	60	0.1%	6.8 KB	0.1%
controlchan	13	0.0%	2.8 KB	0.0%
TOTAL: 6	49760	100.0%	9.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	317657	56.7%
Negative hits	217772	38.9%
Do not exist	23778	4.2%
Cache misses	1052	0.2%
TOTAL: 4	560259	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.411	0.0%	119	0.000	3.454	29.400
article cleanup	00:00:00.144	0.0%	23142	0.000	0.006	0.023
article logging	00:00:00.343	0.0%	23600	0.000	0.015	0.058
article parse	00:00:01.251	0.0%	82625	0.000	0.015	0.083
article write	00:00:10.289	0.0%	19847	0.165	0.518	5.333
artlog/artcncl	00:00:00.000	0.0%	82	0.000	0.000	0.000
artlog/artparse	00:00:00.009	0.0%	905	0.000	0.010	0.333
data move	00:00:00.137	0.0%	526293	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.047	0.0%	119	0.000	0.395	4.100
hishave/artcncl	00:00:00.044	0.0%	119	0.000	0.370	4.300
hishave/artparse	00:00:00.004	0.0%	900	0.000	0.004	0.167
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.896	0.0%	563234	0.001	0.007	0.222
history sync	00:00:00.915	0.0%	371	0.000	2.466	6.500
history write	00:00:12.305	0.0%	23078	0.031	0.533	4.953
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.476	0.0%	900	0.000	0.529	5.667
idle	23:58:12.105	99.8%	535641	55.797	161.101	569.576
nntp read	00:00:02.125	0.0%	534891	0.001	0.004	0.010
overview write	00:01:08.490	0.1%	19847	0.126	3.451	756.785
perl filter	00:00:37.923	0.0%	23071	1.138	1.644	5.780
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.286	0.0%	39748	0.000	0.007	0.033
TOTAL: 24:01:04.284	24:00:31.200	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.071	0.0%	40358	0.000	0.002	0.023
article prepare	00:00:00.006	0.0%	106168	0.000	0.000	0.014
article read	00:00:09.621	0.0%	10612	0.000	0.907	2.481
backlog stats	00:00:00.190	0.0%	399409	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.400	0.0%	299708	0.001	0.005	0.010
data write	00:00:01.879	0.0%	292712	0.000	0.006	0.011
idle	23:54:07.836	100.0%	399409	34.275	215.438	624.654
status file	00:00:01.138	0.0%	1622	0.000	0.702	2.000
TOTAL: 23:54:28.932	23:54:22.141	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.572	0.0%	6793	0.079	0.084	0.086
idle	20:24:01.359	100.0%	7144	176.774	10280.145	600148.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.528	0.0%	14468	0.000	0.036	33.214
readart	00:00:00.459	0.0%	40	0.000	11.475	49.000
TOTAL: 20:24:19.557	20:24:02.918	100.0%	-	-	-	-

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
usenet@film.rlss.okayama-u.ac.jp	0	0	1	0	1	1
TOTAL	0	0	1	0	1	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1441	94970	4826	89634	510	5%	118:51:15
2	csiph-out.news.weretis.net	4	33177	3313	29625	239	9%	48:42:05
3	news.freedyn.net	3	19789	2165	16483	1141	10%	24:08:46
4	feeder.eternal-september.org	2	17805	1946	15771	88	10%	23:12:27
5	newsfeeds.xmission.com	2	16480	1774	14693	13	10%	26:00:06
6	csiph-out.news.xs4all.nl	861	18361	1615	15435	1311	8%	71:25:19
7	newsfeed.neva.ru	143	20768	1148	19265	355	5%	71:15:29
8	news-out.aioe.org	1	15950	849	15083	18	5%	23:59:58
9	news-out.mixmin.net	2	17062	827	16089	146	4%	23:59:52
10	newsfeed.fu-berlin.de	17	13894	774	13067	53	5%	24:07:11
11	news.fcku.it	10	2067	284	1782	1	13%	21:36:35
12	csiph-out.feed.uzoreto.com	864	26115	218	25611	286	0%	71:11:32
13	nntp.pasdenom.info	2	11476	58	11402	16	0%	23:58:38
14	news.swapon.de	7	1414	24	1389	1	1%	24:37:04
15	localhost	43	9	9	0	0	100%	00:00:01
16	news.bbs.nz	1	14823	7	14816	0	0%	23:59:50
17	news.samoylyk.net	2	16023	6	16005	12	0%	24:55:20
18	xanadu-bbs.net	15	1116	1	1115	0	0%	18:59:17
TOTAL: 18		3420	341299	19844	317265	4190	5%	665:00:45

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	15.5 MB	99.6 KB	13.8 MB	29.4 MB	52%	5.6 KB
2	csiph-out.news.weretis.net	9.6 MB	0.0 KB	4.9 MB	14.6 MB	66%	4.2 KB
3	feeder.eternal-september.org	5.0 MB	0.0 KB	382.0 KB	5.4 MB	93%	2.7 KB
4	newsfeeds.xmission.com	5.0 MB	0.0 KB	777.5 KB	5.7 MB	86%	3.3 KB
5	news.freedyn.net	5.0 MB	0.0 KB	42.9 MB	47.9 MB	10%	14.8 KB
6	csiph-out.news.xs4all.nl	4.3 MB	0.0 KB	14.1 MB	18.4 MB	23%	6.4 KB
7	newsfeed.neva.ru	2.6 MB	0.0 KB	1.2 MB	3.8 MB	68%	2.6 KB
8	news-out.mixmin.net	2.3 MB	0.0 KB	316.2 KB	2.6 MB	88%	2.7 KB
9	news-out.aioe.org	2.2 MB	0.0 KB	51.2 KB	2.2 MB	97%	2.6 KB
10	newsfeed.fu-berlin.de	1.8 MB	0.0 KB	137.4 KB	2.0 MB	93%	2.4 KB
11	csiph-out.feed.uzoreto.com	827.7 KB	0.0 KB	6.5 MB	7.3 MB	11%	14.9 KB
12	news.fcku.it	532.3 KB	0.0 KB	0.9 KB	533.3 KB	99%	1.9 KB
13	nntp.pasdenom.info	142.9 KB	0.0 KB	21.2 KB	164.1 KB	87%	2.2 KB
14	news.swapon.de	73.9 KB	0.0 KB	23.3 KB	97.2 KB	76%	3.9 KB
15	news.samoylyk.net	18.4 KB	0.0 KB	1.5 MB	1.5 MB	1%	85.3 KB
16	localhost	10.2 KB	0.0 KB	0.0 KB	10.2 KB	100%	1.1 KB
17	news.bbs.nz	9.8 KB	0.0 KB	0.0 KB	9.8 KB	100%	1.4 KB
18	xanadu-bbs.net	2.1 KB	0.0 KB	0.0 KB	2.1 KB	100%	2.1 KB
TOTAL: 18		54.9 MB	99.6 KB	86.6 MB	141.6 MB	38%	6.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 30 04:15:00 - 04:59:59	253	1.3%	0.09	1.0 MB	1.9%	0.39
Sep 30 05:00:00 - 05:59:59	423	2.1%	0.12	1.9 MB	3.5%	0.55
Sep 30 06:00:00 - 06:59:59	501	2.5%	0.14	1.8 MB	3.2%	0.50
Sep 30 07:00:00 - 07:59:59	719	3.6%	0.20	2.1 MB	3.8%	0.59
Sep 30 08:00:00 - 08:59:59	726	3.7%	0.20	1.9 MB	3.5%	0.54
Sep 30 09:00:00 - 09:59:59	668	3.4%	0.19	1.6 MB	2.9%	0.46
Sep 30 10:00:00 - 10:59:59	2570	12.9%	0.71	5.2 MB	9.5%	1.48
Sep 30 11:00:00 - 11:59:59	773	3.9%	0.21	2.0 MB	3.7%	0.58
Sep 30 12:00:00 - 12:59:59	796	4.0%	0.22	1.9 MB	3.5%	0.55
Sep 30 13:00:00 - 13:59:59	896	4.5%	0.25	2.2 MB	4.1%	0.64
Sep 30 14:00:00 - 14:59:59	1100	5.5%	0.31	3.8 MB	6.9%	1.08
Sep 30 15:00:00 - 15:59:59	990	5.0%	0.28	3.8 MB	7.0%	1.09
Sep 30 16:00:00 - 16:59:59	978	4.9%	0.27	3.4 MB	6.2%	0.96
Sep 30 17:00:00 - 17:59:59	889	4.5%	0.25	2.3 MB	4.2%	0.65
Sep 30 18:00:00 - 18:59:59	2457	12.4%	0.68	5.0 MB	9.1%	1.41
Sep 30 19:00:00 - 19:59:59	810	4.1%	0.23	2.1 MB	3.9%	0.60
Sep 30 20:00:00 - 20:59:59	873	4.4%	0.24	2.5 MB	4.6%	0.72
Sep 30 21:00:00 - 21:59:59	713	3.6%	0.20	1.9 MB	3.5%	0.54
Sep 30 22:00:00 - 22:59:59	661	3.3%	0.18	2.0 MB	3.7%	0.58
Sep 30 23:00:00 - 23:59:59	526	2.7%	0.15	1.4 MB	2.5%	0.39
Oct 1 00:00:00 - 00:59:59	380	1.9%	0.11	1.1 MB	1.9%	0.30
Oct 1 01:00:00 - 01:59:59	358	1.8%	0.10	1.0 MB	1.8%	0.29
Oct 1 02:00:00 - 02:59:59	366	1.8%	0.10	1.3 MB	2.4%	0.38
Oct 1 03:00:00 - 03:59:59	327	1.6%	0.09	1020.2 KB	1.8%	0.28
Oct 1 04:00:00 - 04:15:00	95	0.5%	0.11	466.8 KB	0.8%	0.52
TOTAL: 24:00:00	19848	100.0%	0.23	54.8 MB	100.0%	0.65

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1356	26	0	1330
2	news.freedyn.net	1147	15	0	1132
3	csiph-out.feeder.erje.net	512	79	69	364
4	newsfeed.fu-berlin.de	435	10	0	425
5	newsfeed.neva.ru	355	67	0	288
6	csiph-out.feed.uzoreto.com	289	3	0	286
7	csiph-out.news.weretis.net	244	81	0	163
8	news-out.mixmin.net	158	0	0	158
9	feeder.eternal-september.org	90	17	0	73
10	news-out.aioe.org	19	16	0	3
11	nntp.pasdenom.info	16	0	0	16
12	newsfeeds.xmission.com	14	0	0	14
13	news.samoylyk.net	12	0	0	12
14	news.swapon.de	5	0	0	5
15	news.fcku.it	1	1	0	0
TOTAL: 15		4653	315	69	4269

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	50
alt.binaries.pictures.purebeauty	26
mozilla.support.seamonkey	15
mozilla.support.firefox	14
it-alt.sport.calcio.juventus	12
alt.religion	11
mozilla.general	9
alt.biz.accounting	9
alt.politics.usa	8
alt.survival	7
lada.auto	7
alt.slack.goathead	7
fido7.ru.android	6
mozilla.support.thunderbird	5
alt.windows7.general	5
cakewalk.audio	5
alt.bbs.synchronet	5
alt.music.pink-floyd.publius	5
alt.binaries.new-movies	4
spline.eisfair	3
TOTAL: 97	315

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2467
EMP (phn path)	169
Too many newsgroups	105
HTML Multipart	31
EMP (phn nph)	28
EMP (phl)	26
User-issued cancel	23
User-issued spam cancel	12
Binary: misplaced rar	10
Scoring filter (12)	7
Scoring filter (13)	5
Scoring filter (10)	5
Binary Payload	5
Scoring filter (8)	4
HTML Image Tags	3
Scoring filter (9)	1
Too many newsgroups (meow)	1
Scoring filter (11)	1
Scoring filter (14)	1
TOTAL: 19	2904

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	41	0	42	42
TOTAL: 1	41	12	42	42

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	news.freedyn.net	346
	csiph-out.feeder.erje.net	252
	csiph-out.news.xs4all.nl	140
	csiph-out.feed.uzoreto.com	71
	csiph-out.news.weretis.net	66
	newsfeeds.xmission.com	11
	news.samoylyk.net	11
	feeder.eternal-september.org	2
	news-out.mixmin.net	1
	TOTAL: 9	900
Including strange strings
	newsfeed.fu-berlin.de	368
	csiph-out.news.xs4all.nl	44
	csiph-out.news.weretis.net	21
	news-out.mixmin.net	8
	news.swapon.de	4
	news.freedyn.net	3
	csiph-out.feed.uzoreto.com	3
	newsfeeds.xmission.com	2
	csiph-out.feeder.erje.net	2
	news.samoylyk.net	1
	TOTAL: 12	458
No colon-space in header
	csiph-out.news.xs4all.nl	2
	csiph-out.feeder.erje.net	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	4
TOTAL: 4		1407

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	xanadu-bbs	40943	9812	27894	111	10	2395	23%	23:59:56
2	news.samoylyk.net	20610	3806	15962	73	0	29	18%	23:59:39
3	news.freedyn.net	17927	3805	13709	85	0	0	21%	23:59:22
4	fu-berlin.de	18852	3796	14944	74	0	0	20%	23:59:44
5	news.bbs.nz	31245	259	15778	1	0	0	0%	23:59:56
6	usenet.pasdenom.info	20168	90	15901	3798	0	112	0%	23:59:56
7	erje	19913	80	14606	220	0	0	0%	23:59:56
8	newsfeed.xs4all.nl	18238	79	17222	4	0	34	0%	23:59:55
9	aioe	14425	47	13941	0	0	0	0%	23:59:56
10	news.uzoreto.com	18920	32	18515	172	0	0	0%	23:59:55
11	xmission	18467	22	14284	0	0	0	0%	23:59:56
12	news.mixmin.net	15352	18	14960	0	0	0	0%	23:59:48
13	neva.ru	15194	16	14512	146	0	0	0%	23:59:56
14	weretis.net	12855	12	12640	1	0	0	0%	23:59:03
15	news.swapon.de	1472	11	1442	0	0	0	0%	23:49:10
16	eternal-september	14378	9	13945	0	0	0	0%	23:59:48
17	news.fcku.it	1688	0	1687	0	0	0	0%	20:33:51
18	news.redatomik.org	0	0	0	0	0	16049	0%	23:59:56
TOTAL: 18		300647	21894	241942	4685	10	18619	7%	428:19:43

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	36.2 MB	308.2 KB	36.5 MB	0.4 KB/s	3.8 KB	23:59:56
2	news.freedyn.net	12.8 MB	181.9 KB	13.0 MB	0.2 KB/s	3.4 KB	23:59:22
3	news.samoylyk.net	12.8 MB	159.1 KB	12.9 MB	0.2 KB/s	3.4 KB	23:59:39
4	fu-berlin.de	12.7 MB	169.0 KB	12.9 MB	0.2 KB/s	3.4 KB	23:59:44
5	news.bbs.nz	588.7 KB	1.9 KB	590.6 KB	0.0 KB/s	2.3 KB	23:59:56
6	newsfeed.xs4all.nl	289.4 KB	7.3 KB	296.7 KB	0.0 KB/s	3.6 KB	23:59:55
7	usenet.pasdenom.info	206.3 KB	12.7 MB	12.9 MB	0.2 KB/s	3.4 KB	23:59:56
8	erje	153.7 KB	548.9 KB	702.6 KB	0.0 KB/s	2.3 KB	23:59:56
9	news.uzoreto.com	117.9 KB	550.8 KB	668.7 KB	0.0 KB/s	3.3 KB	23:59:55
10	aioe	69.5 KB	0.0 KB	69.5 KB	0.0 KB/s	1.5 KB	23:59:56
11	xmission	32.8 KB	0.0 KB	32.8 KB	0.0 KB/s	1.5 KB	23:59:56
12	neva.ru	31.1 KB	300.6 KB	331.7 KB	0.0 KB/s	2.0 KB	23:59:56
13	news.mixmin.net	22.0 KB	0.0 KB	22.0 KB	0.0 KB/s	1.2 KB	23:59:48
14	weretis.net	16.4 KB	6.0 KB	22.4 KB	0.0 KB/s	1.7 KB	23:59:03
15	news.swapon.de	14.0 KB	0.0 KB	14.0 KB	0.0 KB/s	1.3 KB	23:49:10
16	eternal-september	10.2 KB	0.0 KB	10.2 KB	0.0 KB/s	1.1 KB	23:59:48
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:33:51
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
TOTAL: 18		76.0 MB	14.9 MB	90.9 MB	0.1 KB/s	3.5 KB	428:19:43

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	33	17	27.7 KB	9	0	0	08:12:10
2	66-188-82-154.dhcp.mdsn.wi.charter.com	32	16	24.6 KB	12	9	9	10:46:41
3	208-71-239-109.cust.centrio.cz	2	7	23.6 KB	1	0	0	00:56:47
TOTAL: 3		67	40	75.9 KB	22	9	9	20:24:18

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	33	17	27.7 KB	9	0	0	08:12:10
2	*.dhcp.mdsn.wi.charter.com	32	16	24.6 KB	12	9	9	10:46:41
3	*.cust.centrio.cz	2	7	23.6 KB	1	0	0	00:56:47
4	unresolved	6	0	0.0 KB	0	0	0	00:28:40
TOTAL: 4		73	40	75.9 KB	22	9	9	20:24:18

NNRP auth users [Top 20]:

User	Conn
ohlandl	9
ctomczyk	2
TOTAL: 2	11

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
66-188-82-154.dhcp.mdsn.wi.charter.com	2.766	0.475	0.019	10:46:41
a131033.upc-a.chello.nl	2.686	0.501	0.000	08:12:10
208-71-239-109.cust.centrio.cz	0.209	0.054	0.005	00:56:47
172.221.41.102	0.296	0.513	0.000	00:28:35
94.161.90.46	0.136	0.023	0.000	00:00:02
94.162.133.84	0.124	0.039	0.000	00:00:02
TOTAL: 6	6.217	1.605	0.024	20:24:18

Curious NNRP server explorers [Top 20]:

System	Conn
172.221.41.102	2
94.162.133.84	2
94.161.90.46	2
TOTAL: 3	6

NNRP client timeouts [Top 20]:

System	Conn	Peer
66-188-82-154.dhcp.mdsn.wi.charter.com	9	0
208-71-239-109.cust.centrio.cz	1	0
TOTAL: 2	10	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	40	100.0%
TOTAL: 1		40	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	33
2	comp.lang.javascript	7
TOTAL: 2		40

Daily Usenet report for csiph.com

Sep 30 04:15:00 -- Oct 1 04:15:00