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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17667	47.3%	4.6 MB	62.8%
innd	15256	40.8%	2.0 MB	27.7%
innfeed	3505	9.4%	608.1 KB	8.2%
nnrpd	897	2.4%	98.3 KB	1.3%
nocem	37	0.1%	4.4 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	37363	100.0%	7.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	278025	53.5%
Negative hits	224177	43.1%
Do not exist	17111	3.3%
Cache misses	260	0.1%
TOTAL: 4	519573	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.432	0.0%	26	0.000	16.615	71.000
article cleanup	00:00:00.123	0.0%	16843	0.000	0.007	0.043
article logging	00:00:00.377	0.0%	17306	0.000	0.022	0.373
article parse	00:00:00.924	0.0%	56275	0.000	0.016	0.063
article write	00:00:40.379	0.0%	14507	0.188	2.783	54.900
artlog/artcncl	00:00:00.000	0.0%	26	0.000	0.000	0.000
artlog/artparse	00:00:00.008	0.0%	346	0.000	0.023	1.000
data move	00:00:00.177	0.0%	492551	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.016	0.0%	26	0.000	0.615	9.000
hishave/artcncl	00:00:00.051	0.0%	26	0.000	1.962	25.000
hishave/artparse	00:00:00.002	0.0%	339	0.000	0.006	0.200
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:16.057	0.0%	521350	0.003	0.031	0.110
history sync	00:00:00.867	0.0%	339	0.000	2.558	48.000
history write	00:00:21.352	0.0%	16850	0.456	1.267	5.578
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.380	0.0%	339	0.000	1.121	5.000
idle	23:56:10.789	99.7%	498833	96.249	172.745	496.266
nntp read	00:00:01.844	0.0%	502322	0.001	0.004	0.008
overview write	00:02:05.360	0.1%	14507	0.191	8.641	943.929
perl filter	00:00:23.854	0.0%	16843	1.122	1.416	2.395
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.250	0.0%	29051	0.000	0.009	0.037
TOTAL: 24:00:40.820	24:00:03.242	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.031	0.0%	14991	0.000	0.002	0.045
article prepare	00:00:00.001	0.0%	8404	0.000	0.000	0.013
article read	00:00:00.327	0.0%	1424	0.000	0.230	12.000
backlog stats	00:00:00.160	0.0%	291596	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.084	0.0%	231480	0.001	0.005	0.012
data write	00:00:01.294	0.0%	217476	0.002	0.006	0.014
idle	23:54:40.595	100.0%	291596	166.058	295.205	813.851
status file	00:00:00.464	0.0%	307	0.000	1.511	8.656
TOTAL: 23:54:50.198	23:54:43.956	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	37:29:26.054	99.9%	654	365.000	206370.113	600113.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.013	0.0%	1545	0.000	0.008	0.167
readart	00:00:00.588	0.0%	50	0.000	11.760	42.000
TOTAL: 37:32:19.378	37:29:26.655	99.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	134
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	154

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.xs4all.nl	559	16593	3480	11631	1482	20%	67:54:14
2	news-out.mixmin.net	2	15159	2213	12779	167	14%	24:08:58
3	feeder.eternal-september.org	4	15336	1987	13315	34	12%	23:01:35
4	newsfeeds.xmission.com	4	14289	1938	12310	41	13%	25:35:19
5	news-out.aioe.org	2	13851	1088	12688	75	7%	23:59:55
6	newsfeed.fu-berlin.de	14	13480	797	12662	21	5%	24:42:59
7	csiph-out.news.weretis.net	4	28979	781	28015	183	2%	46:33:30
8	newsfeed.neva.ru	146	9306	728	8330	248	7%	71:57:18
9	csiph-out.feeder.erje.net	1440	70144	615	69396	133	0%	118:47:14
10	csiph-out.feed.uzoreto.com	864	21660	316	21109	235	1%	71:13:15
11	news.fcku.it	14	1804	286	1511	7	15%	22:13:04
12	news-out.neodome.net	1	15421	180	15238	3	1%	23:59:53
13	news.swapon.de	7	1593	40	1553	0	2%	25:37:06
14	nntp.pasdenom.info	2	5842	39	5797	6	0%	16:55:15
15	news.freedyn.net	2	16874	17	16839	18	0%	23:59:56
16	csiph-out.news.tnetconsulting.net	1	8364	9	8353	2	0%	16:25:12
17	localhost	31	5	5	0	0	100%	00:00:04
18	news.bbs.nz	2	12962	2	12960	0	0%	23:59:53
19	news.samoylyk.net	3	8025	0	8025	0	0%	15:03:21
TOTAL: 19		3102	289687	14521	272511	2655	5%	666:08:01

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.xs4all.nl	9.4 MB	17.9 MB	27.4 MB	34%	5.7 KB
2	newsfeeds.xmission.com	6.4 MB	2.1 MB	8.5 MB	75%	4.4 KB
3	feeder.eternal-september.org	5.4 MB	152.0 KB	5.5 MB	97%	2.8 KB
4	news-out.mixmin.net	4.6 MB	407.5 KB	5.0 MB	92%	2.2 KB
5	news-out.aioe.org	4.0 MB	183.1 KB	4.2 MB	95%	3.7 KB
6	csiph-out.feeder.erje.net	3.4 MB	4.1 MB	7.5 MB	45%	10.3 KB
7	csiph-out.news.weretis.net	2.2 MB	608.6 KB	2.8 MB	78%	3.0 KB
8	newsfeed.neva.ru	2.1 MB	783.9 KB	2.8 MB	72%	3.0 KB
9	newsfeed.fu-berlin.de	1.7 MB	47.7 KB	1.8 MB	97%	2.2 KB
10	csiph-out.feed.uzoreto.com	1.1 MB	8.9 MB	10.0 MB	10%	18.5 KB
11	news-out.neodome.net	527.6 KB	8.0 KB	535.6 KB	98%	2.9 KB
12	news.fcku.it	492.0 KB	12.3 KB	504.2 KB	97%	1.7 KB
13	news.freedyn.net	240.2 KB	503.6 KB	743.8 KB	32%	21.3 KB
14	news.swapon.de	136.8 KB	0.0 KB	136.8 KB	100%	3.4 KB
15	nntp.pasdenom.info	86.1 KB	7.7 KB	93.8 KB	91%	2.1 KB
16	csiph-out.news.tnetconsulting.net	22.8 KB	3.2 KB	26.0 KB	87%	2.4 KB
17	localhost	7.7 KB	0.0 KB	7.7 KB	100%	1.5 KB
18	news.bbs.nz	2.9 KB	0.0 KB	2.9 KB	100%	1.5 KB
19	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		41.8 MB	35.7 MB	77.5 MB	53%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 21 04:15:00 - 04:59:59	190	1.3%	0.07	768.1 KB	1.8%	0.28
Sep 21 05:00:00 - 05:59:59	403	2.8%	0.11	1.2 MB	2.9%	0.34
Sep 21 06:00:00 - 06:59:59	436	3.0%	0.12	1.3 MB	3.2%	0.38
Sep 21 07:00:00 - 07:59:59	588	4.1%	0.16	1.5 MB	3.5%	0.42
Sep 21 08:00:00 - 08:59:59	645	4.4%	0.18	2.3 MB	5.6%	0.66
Sep 21 09:00:00 - 09:59:59	863	5.9%	0.24	2.3 MB	5.4%	0.64
Sep 21 10:00:00 - 10:59:59	652	4.5%	0.18	1.8 MB	4.3%	0.51
Sep 21 11:00:00 - 11:59:59	693	4.8%	0.19	1.6 MB	4.0%	0.47
Sep 21 12:00:00 - 12:59:59	767	5.3%	0.21	2.0 MB	4.8%	0.57
Sep 21 13:00:00 - 13:59:59	778	5.4%	0.22	2.1 MB	4.9%	0.58
Sep 21 14:00:00 - 14:59:59	793	5.5%	0.22	2.1 MB	5.1%	0.60
Sep 21 15:00:00 - 15:59:59	863	5.9%	0.24	2.5 MB	6.1%	0.72
Sep 21 16:00:00 - 16:59:59	896	6.2%	0.25	2.5 MB	6.0%	0.71
Sep 21 17:00:00 - 17:59:59	792	5.5%	0.22	2.2 MB	5.3%	0.63
Sep 21 18:00:00 - 18:59:59	750	5.2%	0.21	2.1 MB	5.1%	0.60
Sep 21 19:00:00 - 19:59:59	748	5.2%	0.21	1.9 MB	4.5%	0.53
Sep 21 20:00:00 - 20:59:59	691	4.8%	0.19	1.9 MB	4.5%	0.53
Sep 21 21:00:00 - 21:59:59	712	4.9%	0.20	2.2 MB	5.4%	0.63
Sep 21 22:00:00 - 22:59:59	451	3.1%	0.13	1.5 MB	3.7%	0.44
Sep 21 23:00:00 - 23:59:59	352	2.4%	0.10	1.1 MB	2.6%	0.31
Sep 22 00:00:00 - 00:59:59	356	2.5%	0.10	1.1 MB	2.6%	0.31
Sep 22 01:00:00 - 01:59:59	381	2.6%	0.11	1.4 MB	3.2%	0.38
Sep 22 02:00:00 - 02:59:59	336	2.3%	0.09	928.1 KB	2.2%	0.26
Sep 22 03:00:00 - 03:59:59	278	1.9%	0.08	843.1 KB	2.0%	0.23
Sep 22 04:00:00 - 04:15:00	96	0.7%	0.11	566.5 KB	1.3%	0.63
TOTAL: 24:00:00	14510	100.0%	0.17	41.6 MB	100.0%	0.49

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	csiph-out.news.xs4all.nl	1513	112	1	1400
2	newsfeed.fu-berlin.de	376	17	0	359
3	newsfeed.neva.ru	258	49	0	209
4	csiph-out.feed.uzoreto.com	233	10	0	223
5	news-out.mixmin.net	204	0	0	204
6	csiph-out.news.weretis.net	190	65	0	125
7	csiph-out.feeder.erje.net	132	30	0	102
8	news-out.aioe.org	94	68	0	26
9	newsfeeds.xmission.com	48	1	0	47
10	feeder.eternal-september.org	36	29	0	7
11	news.freedyn.net	19	0	0	19
12	news.swapon.de	10	0	0	10
13	news.fcku.it	7	7	0	0
14	nntp.pasdenom.info	6	0	0	6
15	csiph-out.news.tnetconsulting.net	3	0	0	3
16	news-out.neodome.net	3	0	0	3
TOTAL: 16		3132	388	1	2743

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it-alt.sport.calcio.juventus	72
scinet.stats	27
alt.bbs.synchronet	23
mozilla.support.seamonkey	22
lada.auto	18
mozilla.support.thunderbird	17
alt.windows7.general	15
lada.talk	14
alt.tv.comedy-central.daily-show	11
alt.philosophy	11
oesterreich.tratsch	10
spline.eisfair	9
att.jobs	9
alt.job	9
at.jobs	9
alt.binaries.ebook	8
alt.politics	7
alt.binaries.pictures.purebeauty	7
alt.math.undergrad	6
lada.kitchen	6
TOTAL: 62	388

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
misc.taxes.moderated	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1439
EMP (phl)	195
EMP (phn path)	119
Too many newsgroups	54
0	46
EMP (phn nph)	39
Scoring filter	31
HTML Multipart	10
Binary: misplaced binary	6
Too many newsgroups (meow)	1
U2 violation - invalid distribution	1
TOTAL: 11	1941

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	csiph-out.feed.uzoreto.com	1
	csiph-out.news.xs4all.nl	1
	TOTAL: 3	52
Huge articles
	csiph-out.news.xs4all.nl	120
	csiph-out.feed.uzoreto.com	80
	csiph-out.feeder.erje.net	72
	newsfeeds.xmission.com	43
	news.freedyn.net	9
	feeder.eternal-september.org	3
	csiph-out.news.tnetconsulting.net	3
	news-out.mixmin.net	1
	csiph-out.news.weretis.net	1
	TOTAL: 9	332
Including strange strings
	newsfeed.fu-berlin.de	355
	news-out.mixmin.net	36
	csiph-out.news.xs4all.nl	35
	news-out.aioe.org	15
	news.swapon.de	10
	csiph-out.news.weretis.net	8
	newsfeeds.xmission.com	3
	csiph-out.feeder.erje.net	1
	TOTAL: 8	463
No colon-space in header
	csiph-out.news.xs4all.nl	5
	csiph-out.feeder.erje.net	2
	TOTAL: 2	7
TOTAL: 4		854

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.nz	26961	974	13110	20	2	3%	23:59:52
2	fu-berlin.de	13550	364	13186	0	0	2%	23:59:44
3	tnet	16508	275	13767	0	0	1%	23:50:10
4	news.samoylyk.net	7784	182	7454	5	7394	2%	23:59:55
5	neva.ru	13078	98	12852	25	0	0%	23:59:55
6	news.freedyn.net	14249	36	14037	0	0	0%	23:59:35
7	newsfeed.xs4all.nl	11230	22	10890	2	0	0%	23:57:10
8	xmission	13598	14	12149	0	0	0%	23:59:51
9	aioe	10295	10	10010	0	0	0%	23:59:55
10	news.mixmin.net	11905	9	11726	0	0	0%	23:59:55
11	eternal-september	12385	7	11969	3	0	0%	23:59:55
12	neodome.net	14429	6	14223	0	0	0%	23:52:52
13	weretis.net	13542	5	13204	0	0	0%	23:59:41
14	news.uzoreto.com	13098	5	12900	19	0	0%	23:50:10
15	usenet.pasdenom.info	7704	4	7579	1	6484	0%	23:59:55
16	news.swapon.de	1592	4	1557	1	0	0%	23:53:26
17	erje	13832	4	13671	12	0	0%	23:59:55
18	news.fcku.it	1389	0	1389	0	0	0%	21:32:59
19	xanadu-bbs	0	0	0	0	14510	0%	23:59:42
TOTAL: 19		217129	2019	195673	88	28390	0%	452:54:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	fu-berlin.de	2.8 MB	0.0 KB	2.8 MB	7.9 KB	23:59:44
2	news.bbs.nz	2.7 MB	149.1 KB	2.9 MB	3.0 KB	23:59:52
3	news.samoylyk.net	1.3 MB	11.6 KB	1.3 MB	7.2 KB	23:59:55
4	tnet	855.6 KB	0.0 KB	855.6 KB	3.1 KB	23:50:10
5	news.freedyn.net	428.2 KB	0.0 KB	428.2 KB	11.9 KB	23:59:35
6	neva.ru	258.3 KB	74.9 KB	333.1 KB	2.7 KB	23:59:55
7	newsfeed.xs4all.nl	47.9 KB	4.6 KB	52.5 KB	2.2 KB	23:57:10
8	xmission	32.4 KB	0.0 KB	32.4 KB	2.3 KB	23:59:51
9	news.uzoreto.com	32.3 KB	39.7 KB	72.1 KB	3.0 KB	23:50:10
10	aioe	19.1 KB	0.0 KB	19.1 KB	1.9 KB	23:59:55
11	news.mixmin.net	15.8 KB	0.0 KB	15.8 KB	1.8 KB	23:59:55
12	usenet.pasdenom.info	15.1 KB	1.3 KB	16.4 KB	3.3 KB	23:59:55
13	eternal-september	10.2 KB	40.3 KB	50.4 KB	5.0 KB	23:59:55
14	neodome.net	8.7 KB	0.0 KB	8.7 KB	1.4 KB	23:52:52
15	weretis.net	7.7 KB	0.0 KB	7.7 KB	1.5 KB	23:59:41
16	erje	6.7 KB	24.6 KB	31.2 KB	2.0 KB	23:59:55
17	news.swapon.de	6.6 KB	1.1 KB	7.7 KB	1.5 KB	23:53:26
18	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0	21:32:59
19	xanadu-bbs	0.0 KB	0.0 KB	0.0 KB	0	23:59:42
TOTAL: 19		8.5 MB	347.1 KB	8.9 MB	4.3 KB	452:54:37

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	096-042-018-108.res.spectrum.com	27	20	46.7 KB	12	5	3	06:48:40
2	a131033.upc-a.chello.nl	23	20	42.8 KB	4	0	0	05:32:45
3	ip72-222-200-117.ph.ph.cox.net	14	10	15.0 KB	12	0	0	04:29:22
TOTAL: 3		64	50	104.4 KB	28	5	3	37:32:18

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	23	20	42.8 KB	4	0	0	05:32:45
2	*.res.spectrum.com	27	20	46.7 KB	12	5	3	06:48:40
3	*.ph.ph.cox.net	14	10	15.0 KB	12	0	0	04:29:22
4	unresolved	40	0	0.0 KB	0	0	0	13:00:35
5	*.net.upcbroadband.cz	24	0	0.0 KB	0	0	0	07:40:54
TOTAL: 5		128	50	104.4 KB	28	5	3	37:32:18

NNRP auth users [Top 20]:

User	Conn
ohlandl	3
TOTAL: 1	3

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	2.777	0.605	0.000	13:00:35
ip-89-176-128-12.net.upcbroadband.cz	1.609	0.370	0.000	07:40:54
096-042-018-108.res.spectrum.com	2.308	0.437	0.009	06:48:40
a131033.upc-a.chello.nl	1.727	0.335	0.000	05:32:45
ip72-222-200-117.ph.ph.cox.net	1.077	0.230	0.000	04:29:22
TOTAL: 5	9.498	1.977	0.009	37:32:18

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	40
ip-89-176-128-12.net.upcbroadband.cz	24
TOTAL: 2	64

NNRP client timeouts [Top 20]:

System	Conn	Peer
096-042-018-108.res.spectrum.com	7	0
ip72-222-200-117.ph.ph.cox.net	6	0
91.187.33.87	1	0
TOTAL: 3	14	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	52
TOTAL: 1		52

Daily Usenet report for csiph.com

Sep 21 04:15:00 -- Sep 22 04:15:00