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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18850	48.3%	4.8 MB	63.3%
innd	15535	39.8%	2.0 MB	26.8%
innfeed	3547	9.1%	647.8 KB	8.3%
nnrpd	1089	2.8%	117.3 KB	1.5%
nocem	25	0.1%	2.9 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39047	100.0%	7.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	310112	57.2%
Negative hits	213366	39.4%
Do not exist	18213	3.4%
Cache misses	320	0.1%
TOTAL: 4	542011	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.661	0.0%	31	0.000	21.323	71.667
article cleanup	00:00:00.123	0.0%	18006	0.000	0.007	0.038
article logging	00:00:00.316	0.0%	18535	0.000	0.017	0.204
article parse	00:00:00.758	0.0%	52871	0.000	0.014	0.093
article write	00:00:25.271	0.0%	15208	0.156	1.662	42.204
artlog/artcncl	00:00:00.001	0.0%	31	0.000	0.032	0.333
artlog/artparse	00:00:00.001	0.0%	309	0.000	0.003	0.333
data move	00:00:00.124	0.0%	520838	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.138	0.0%	31	0.000	4.452	39.667
hishave/artcncl	00:00:00.008	0.0%	31	0.000	0.258	1.000
hishave/artparse	00:00:00.001	0.0%	300	0.000	0.003	0.043
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:13.205	0.0%	543630	0.002	0.024	0.163
history sync	00:00:00.913	0.0%	387	0.000	2.359	23.333
history write	00:00:20.964	0.0%	17995	0.480	1.165	6.100
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.307	0.0%	299	0.000	1.027	5.800
idle	23:55:25.464	99.6%	525337	89.879	163.943	586.249
nntp read	00:00:01.939	0.0%	528283	0.001	0.004	0.007
overview write	00:03:36.801	0.3%	15208	0.235	14.256	3287.306
perl filter	00:00:25.029	0.0%	17986	1.060	1.392	2.392
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.244	0.0%	30441	0.000	0.008	0.049
TOTAL: 24:01:06.480	24:00:32.268	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.028	0.0%	15427	0.000	0.002	0.021
article prepare	00:00:00.000	0.0%	14640	0.000	0.000	0.000
article read	00:00:00.376	0.0%	1649	0.000	0.228	9.000
backlog stats	00:00:00.174	0.0%	364873	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.345	0.0%	286946	0.001	0.005	0.011
data write	00:00:01.633	0.0%	266074	0.003	0.006	0.011
idle	23:54:48.113	100.0%	364873	113.651	235.940	882.370
status file	00:00:02.814	0.0%	304	0.000	9.257	2557.000
TOTAL: 23:55:02.337	23:54:54.483	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	50:44:15.810	99.8%	789	295.833	231502.928	600125.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.013	0.0%	1957	0.000	0.007	0.167
readart	00:00:00.555	0.0%	96	0.000	5.781	42.000
TOTAL: 50:48:57.159	50:44:16.378	99.8%	-	-	-	-

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	newsfeeds.xmission.com	3	14408	3685	10687	36	25%	23:40:59
2	csiph-out.news.xs4all.nl	517	17771	3314	12717	1740	18%	68:27:52
3	feeder.eternal-september.org	4	17065	1993	14983	89	11%	25:19:39
4	news-out.mixmin.net	2	15803	1837	13755	211	11%	24:08:26
5	news-out.aioe.org	2	14609	948	13559	102	6%	23:59:42
6	newsfeed.fu-berlin.de	4	13167	805	12322	40	6%	22:21:21
7	csiph-out.news.weretis.net	2	43813	694	42889	230	1%	63:37:33
8	csiph-out.feeder.erje.net	1440	74056	648	73274	134	0%	118:48:43
9	newsfeed.neva.ru	141	15098	553	14305	240	3%	71:21:52
10	news.fcku.it	13	1832	306	1517	9	16%	22:26:46
11	news-out.neodome.net	1	16188	175	16007	6	1%	23:59:52
12	csiph-out.feed.uzoreto.com	864	22905	58	22618	229	0%	71:12:22
13	csiph-out.news.tnetconsulting.net	2	15907	43	15824	40	0%	23:59:56
14	news.freedyn.net	1	18166	40	18094	32	0%	23:59:57
15	nntp.pasdenom.info	2	9796	40	9726	30	0%	23:59:39
16	news.swapon.de	9	1343	32	1311	0	2%	23:19:33
17	news.bbs.nz	1	15172	32	15140	0	0%	23:59:54
18	localhost	34	8	8	0	0	100%	00:00:08
19	news.samoylyk.net	1	14779	3	14776	0	0%	23:59:53
20	xanadu-bbs.net	27	410	0	410	0	0%	20:39:22
TOTAL: 20		3070	342296	15214	323914	3168	4%	723:23:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	12.2 MB	0.0 KB	2.1 MB	14.3 MB	85%	3.9 KB
2	csiph-out.news.xs4all.nl	8.4 MB	5.0 KB	13.2 MB	21.6 MB	38%	4.4 KB
3	feeder.eternal-september.org	5.4 MB	0.0 KB	2.7 MB	8.0 MB	66%	4.0 KB
4	news-out.mixmin.net	3.9 MB	9.0 KB	422.3 KB	4.3 MB	90%	2.2 KB
5	csiph-out.feeder.erje.net	3.6 MB	20.2 KB	3.3 MB	6.9 MB	51%	9.0 KB
6	news-out.aioe.org	3.3 MB	5.0 KB	273.0 KB	3.6 MB	92%	3.5 KB
7	csiph-out.news.weretis.net	1.9 MB	21.1 KB	810.5 KB	2.7 MB	69%	3.0 KB
8	newsfeed.fu-berlin.de	1.8 MB	0.0 KB	104.5 KB	1.9 MB	94%	2.3 KB
9	newsfeed.neva.ru	1.2 MB	15.0 KB	590.0 KB	1.7 MB	66%	2.3 KB
10	news.fcku.it	552.9 KB	0.0 KB	12.5 KB	565.4 KB	97%	1.8 KB
11	news-out.neodome.net	520.8 KB	9.4 KB	13.8 KB	543.9 KB	95%	3.0 KB
12	news.freedyn.net	413.6 KB	5.0 KB	971.8 KB	1.4 MB	29%	19.3 KB
13	csiph-out.feed.uzoreto.com	301.7 KB	4.9 KB	5.1 MB	5.4 MB	5%	19.2 KB
14	csiph-out.news.tnetconsulting.net	172.3 KB	0.0 KB	90.0 KB	262.3 KB	65%	3.2 KB
15	nntp.pasdenom.info	95.0 KB	0.0 KB	37.9 KB	132.9 KB	71%	1.9 KB
16	news.swapon.de	68.2 KB	0.0 KB	0.0 KB	68.2 KB	100%	2.1 KB
17	news.bbs.nz	55.0 KB	0.0 KB	0.0 KB	55.0 KB	100%	1.7 KB
18	localhost	14.0 KB	0.0 KB	0.0 KB	14.0 KB	100%	1.8 KB
19	news.samoylyk.net	10.1 KB	0.0 KB	0.0 KB	10.1 KB	100%	3.4 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		43.7 MB	94.5 KB	29.7 MB	73.5 MB	59%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 29 04:15:00 - 04:59:59	241	1.6%	0.09	982.3 KB	2.2%	0.36
Sep 29 05:00:00 - 05:59:59	391	2.6%	0.11	1.3 MB	3.0%	0.38
Sep 29 06:00:00 - 06:59:59	460	3.0%	0.13	1.1 MB	2.6%	0.32
Sep 29 07:00:00 - 07:59:59	613	4.0%	0.17	1.6 MB	3.7%	0.46
Sep 29 08:00:00 - 08:59:59	746	4.9%	0.21	2.1 MB	4.8%	0.60
Sep 29 09:00:00 - 09:59:59	721	4.7%	0.20	1.9 MB	4.4%	0.55
Sep 29 10:00:00 - 10:59:59	680	4.5%	0.19	1.8 MB	4.1%	0.51
Sep 29 11:00:00 - 11:59:59	645	4.2%	0.18	1.6 MB	3.6%	0.45
Sep 29 12:00:00 - 12:59:59	758	5.0%	0.21	2.0 MB	4.6%	0.57
Sep 29 13:00:00 - 13:59:59	818	5.4%	0.23	2.3 MB	5.2%	0.65
Sep 29 14:00:00 - 14:59:59	1033	6.8%	0.29	3.1 MB	7.1%	0.87
Sep 29 15:00:00 - 15:59:59	956	6.3%	0.27	2.7 MB	6.3%	0.78
Sep 29 16:00:00 - 16:59:59	938	6.2%	0.26	2.7 MB	6.3%	0.78
Sep 29 17:00:00 - 17:59:59	911	6.0%	0.25	2.6 MB	6.0%	0.74
Sep 29 18:00:00 - 18:59:59	798	5.2%	0.22	2.2 MB	5.1%	0.63
Sep 29 19:00:00 - 19:59:59	836	5.5%	0.23	2.4 MB	5.6%	0.69
Sep 29 20:00:00 - 20:59:59	728	4.8%	0.20	2.0 MB	4.6%	0.56
Sep 29 21:00:00 - 21:59:59	604	4.0%	0.17	1.9 MB	4.3%	0.53
Sep 29 22:00:00 - 22:59:59	516	3.4%	0.14	1.5 MB	3.3%	0.41
Sep 29 23:00:00 - 23:59:59	414	2.7%	0.12	1.2 MB	2.8%	0.34
Sep 30 00:00:00 - 00:59:59	359	2.4%	0.10	1.2 MB	2.7%	0.33
Sep 30 01:00:00 - 01:59:59	276	1.8%	0.08	760.7 KB	1.7%	0.21
Sep 30 02:00:00 - 02:59:59	318	2.1%	0.09	1.0 MB	2.4%	0.29
Sep 30 03:00:00 - 03:59:59	330	2.2%	0.09	1.2 MB	2.8%	0.35
Sep 30 04:00:00 - 04:15:00	111	0.7%	0.12	324.7 KB	0.7%	0.36
TOTAL: 24:00:00	15201	100.0%	0.18	43.5 MB	100.0%	0.52

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1775	110	1	1664
2	newsfeed.fu-berlin.de	468	14	0	454
3	news-out.mixmin.net	263	2	3	258
4	newsfeed.neva.ru	241	18	3	220
5	csiph-out.feed.uzoreto.com	225	3	1	221
6	csiph-out.news.weretis.net	160	20	3	137
7	csiph-out.feeder.erje.net	138	31	4	103
8	news-out.aioe.org	100	53	1	46
9	feeder.eternal-september.org	73	37	0	36
10	newsfeeds.xmission.com	45	10	0	35
11	csiph-out.news.tnetconsulting.net	40	37	0	3
12	nntp.pasdenom.info	30	0	0	30
13	news.freedyn.net	29	0	1	28
14	news.swapon.de	13	0	0	13
15	news-out.neodome.net	9	0	3	6
16	news.fcku.it	9	9	0	0
17	news.samoylyk.net	1	0	0	1
TOTAL: 17		3619	344	20	3255

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it-alt.sport.calcio.juventus	39
alt.bbs.synchronet	29
alt.windows7.general	26
scinet.stats	23
alt.math.undergrad	22
alt.computer.workshop	17
mozilla.support.seamonkey	15
alt.politics	12
alt.survival	11
alt.politics.usa	10
mozilla.support.calendar	9
lada.talk	9
spline.eisfair	8
mozilla.support.thunderbird	8
alt.philosophy	7
alt.testing	6
free.it.religioni.scientology	6
mozilla.dev.apps.thunderbird	5
mozilla.support.firefox	4
alt.current-events.epidemics	4
TOTAL: 70	344

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1742
EMP (phn path)	215
EMP (phl)	167
Too many newsgroups	125
0	71
EMP (phn nph)	53
Scoring filter	18
Binary: misplaced binary	12
HTML Multipart	9
HTML post	2
TOTAL: 10	2414

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	132
	csiph-out.feeder.erje.net	63
	csiph-out.feed.uzoreto.com	54
	newsfeeds.xmission.com	30
	news.freedyn.net	16
	feeder.eternal-september.org	7
	csiph-out.news.weretis.net	2
	csiph-out.news.tnetconsulting.net	1
	TOTAL: 8	305
Including strange strings
	newsfeed.fu-berlin.de	380
	csiph-out.news.xs4all.nl	56
	news-out.mixmin.net	50
	news-out.aioe.org	14
	news.swapon.de	13
	csiph-out.news.weretis.net	7
	newsfeeds.xmission.com	4
	csiph-out.feeder.erje.net	1
	feeder.eternal-september.org	1
	news-out.neodome.net	1
	TOTAL: 10	527
No colon-space in header
	csiph-out.news.xs4all.nl	8
	csiph-out.feeder.erje.net	1
	TOTAL: 2	9
TOTAL: 4		893

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19306	1096	14081	23	257	5%	23:59:54
2	news.bbs.nz	28528	686	14033	22	0	2%	23:59:21
3	fu-berlin.de	14156	451	13705	0	0	3%	23:59:49
4	news.samoylyk.net	15996	432	14760	6	0	2%	23:59:45
5	neva.ru	14028	211	13573	35	0	1%	23:59:44
6	tnet	16636	160	14605	1	0	0%	23:59:54
7	newsfeed.xs4all.nl	12241	74	11727	1	0	0%	23:59:53
8	news.freedyn.net	15230	40	14785	0	0	0%	23:59:48
9	usenet.pasdenom.info	15349	36	14685	3	0	0%	23:59:54
10	xmission	14014	36	10928	1	0	0%	23:59:49
11	news.uzoreto.com	13687	29	13271	206	0	0%	23:59:35
12	news.mixmin.net	13117	23	12686	0	0	0%	23:59:54
13	neodome.net	15484	23	14961	0	0	0%	23:59:54
14	eternal-september	13201	14	12670	4	0	0%	23:59:54
15	weretis.net	14462	10	14068	0	0	0%	23:59:33
16	aioe	11329	8	10733	0	0	0%	23:59:20
17	news.swapon.de	1433	8	1392	0	0	0%	23:29:32
18	erje	14622	6	14308	28	0	0%	23:59:49
19	news.fcku.it	1452	0	1450	0	0	0%	22:02:58
TOTAL: 19		264271	3343	232421	330	257	1%	453:28:20

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.1 MB	68.3 KB	5.1 MB	0.1 KB/s	4.7 KB	23:59:54
2	fu-berlin.de	3.1 MB	0.0 KB	3.1 MB	0.0 KB/s	7.0 KB	23:59:49
3	news.samoylyk.net	3.1 MB	6.1 KB	3.1 MB	0.0 KB/s	7.2 KB	23:59:45
4	news.bbs.nz	1.8 MB	115.9 KB	1.9 MB	0.0 KB/s	2.8 KB	23:59:21
5	neva.ru	449.2 KB	72.1 KB	521.3 KB	0.0 KB/s	2.1 KB	23:59:44
6	tnet	371.6 KB	1.9 KB	373.5 KB	0.0 KB/s	2.3 KB	23:59:54
7	news.freedyn.net	289.9 KB	0.0 KB	289.9 KB	0.0 KB/s	7.2 KB	23:59:48
8	newsfeed.xs4all.nl	177.2 KB	1.2 KB	178.3 KB	0.0 KB/s	2.4 KB	23:59:53
9	usenet.pasdenom.info	111.2 KB	9.3 KB	120.5 KB	0.0 KB/s	3.1 KB	23:59:54
10	xmission	79.5 KB	1.9 KB	81.4 KB	0.0 KB/s	2.2 KB	23:59:49
11	news.mixmin.net	79.3 KB	0.0 KB	79.3 KB	0.0 KB/s	3.4 KB	23:59:54
12	news.uzoreto.com	63.2 KB	503.6 KB	566.9 KB	0.0 KB/s	2.4 KB	23:59:35
13	neodome.net	54.5 KB	0.0 KB	54.5 KB	0.0 KB/s	2.4 KB	23:59:54
14	eternal-september	24.4 KB	4.6 KB	29.0 KB	0.0 KB/s	1.6 KB	23:59:54
15	weretis.net	17.6 KB	0.0 KB	17.6 KB	0.0 KB/s	1.8 KB	23:59:33
16	aioe	14.1 KB	0.0 KB	14.1 KB	0.0 KB/s	1.8 KB	23:59:20
17	news.swapon.de	14.1 KB	0.0 KB	14.1 KB	0.0 KB/s	1.8 KB	23:29:32
18	erje	10.5 KB	96.7 KB	107.2 KB	0.0 KB/s	3.2 KB	23:59:49
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:02:58
TOTAL: 19		14.8 MB	881.7 KB	15.6 MB	0.0 KB/s	4.4 KB	453:28:20

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	096-042-018-108.res.spectrum.com	18	39	79.8 KB	17	5	4	05:24:55
2	a131033.upc-a.chello.nl	66	31	57.1 KB	10	0	0	18:22:58
3	ip72-222-200-117.ph.ph.cox.net	9	26	51.5 KB	30	3	2	03:40:25
TOTAL: 3		93	96	188.4 KB	57	8	6	50:48:56

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.res.spectrum.com	18	39	79.8 KB	17	5	4	05:24:55
2	*.upc-a.chello.nl	66	31	57.1 KB	10	0	0	18:22:58
3	*.ph.ph.cox.net	9	26	51.5 KB	30	3	2	03:40:25
4	*.20.97.83.ro.ovo.sc	1	0	0.0 KB	0	0	0	00:00:11
5	unresolved	70	0	0.0 KB	0	0	0	23:20:26
TOTAL: 5		164	96	188.4 KB	57	8	6	50:48:56

NNRP auth users [Top 20]:

User	Conn
ohlandl	4
kev009	2
TOTAL: 2	6

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	5.137	1.179	0.000	23:20:24
a131033.upc-a.chello.nl	4.862	1.004	0.000	18:22:58
096-042-018-108.res.spectrum.com	1.795	0.312	0.011	05:24:55
ip72-222-200-117.ph.ph.cox.net	0.882	0.140	0.006	03:40:25
34.20.97.83.ro.ovo.sc	0.056	0.024	0.000	00:00:11
151.68.238.34	0.067	0.008	0.000	00:00:01
TOTAL: 6	12.799	2.667	0.017	50:48:56

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	69
151.68.238.34	1
34.20.97.83.ro.ovo.sc	1
TOTAL: 3	71

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Sep 29 04:15:00 -- Sep 30 04:15:00