Daily Usenet report for csiph.com: May 6 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21455	49.8%	5.6 MB	65.3%
innd	17146	39.8%	2.3 MB	26.2%
innfeed	3485	8.1%	636.9 KB	7.2%
nnrpd	977	2.3%	105.9 KB	1.2%
nocem	18	0.0%	2.3 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	43082	100.0%	8.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	333256	56.8%
Negative hits	231992	39.6%
Do not exist	20781	3.5%
Cache misses	347	0.1%
TOTAL: 4	586376	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.268	0.0%	31	0.000	8.645	26.000
article cleanup	00:00:00.126	0.0%	20606	0.000	0.006	0.040
article logging	00:00:00.337	0.0%	21170	0.000	0.016	0.218
article parse	00:00:00.895	0.0%	60969	0.000	0.015	0.137
article write	00:00:13.805	0.0%	17676	0.173	0.781	31.911
artlog/artcncl	00:00:00.000	0.0%	31	0.000	0.000	0.000
artlog/artparse	00:00:00.034	0.0%	272	0.000	0.125	1.632
data move	00:00:00.168	0.0%	545856	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.043	0.0%	30	0.000	1.433	14.000
hishave/artcncl	00:00:00.010	0.0%	31	0.000	0.323	1.000
hishave/artparse	00:00:00.000	0.0%	271	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:13.540	0.0%	588201	0.001	0.023	0.143
history sync	00:00:00.951	0.0%	384	0.000	2.477	23.000
history write	00:00:26.888	0.0%	20591	0.228	1.306	5.738
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.319	0.0%	270	0.000	1.181	10.000
idle	23:57:40.007	99.8%	552697	87.981	156.071	473.768
nntp read	00:00:02.008	0.0%	554305	0.001	0.004	0.007
overview write	00:01:21.125	0.1%	17676	0.096	4.590	632.675
perl filter	00:00:28.460	0.0%	20590	1.150	1.382	2.283
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.277	0.0%	35369	0.000	0.008	0.032
TOTAL: 24:01:08.184	24:00:29.261	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.053	0.0%	17737	0.000	0.003	0.019
article prepare	00:00:00.000	0.0%	14264	0.000	0.000	0.000
article read	00:00:00.363	0.0%	1971	0.000	0.184	4.250
backlog stats	00:00:00.229	0.0%	405726	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.464	0.0%	320424	0.001	0.005	0.010
data write	00:00:01.788	0.0%	305095	0.002	0.006	0.011
idle	23:54:01.119	100.0%	405726	120.130	212.067	603.077
status file	00:00:00.204	0.0%	265	0.000	0.770	2.000
TOTAL: 23:54:12.732	23:54:05.220	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	43:09:22.732	99.8%	970	199.000	160167.765	900022.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:36.303	0.0%	83782	0.000	0.433	0.449
readart	00:00:00.728	0.0%	419	0.000	1.737	42.000
TOTAL: 43:14:59.109	43:09:59.763	99.8%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
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	newsfeeds.xmission.com	2	16838	4432	12359	47	26%	23:44:50
2	news-out.aioe.org	4	16993	4057	12867	69	23%	24:12:55
3	feeder.eternal-september.org	2	20268	2587	17510	171	12%	26:25:04
4	csiph-out.feeder.erje.net	1440	85725	1186	84150	389	1%	118:39:48
5	newsfeed.neva.ru	146	18433	971	17135	327	5%	72:05:52
6	news-out.mixmin.net	3	18416	924	17192	300	5%	24:08:57
7	csiph-out.news.xs4all.nl	860	18913	911	17082	920	4%	71:27:05
8	csiph-out.news.weretis.net	4	37613	802	36624	187	2%	51:22:41
9	newsfeed.fu-berlin.de	17	16164	772	15104	288	4%	25:25:04
10	csiph-out.feed.uzoreto.com	864	26910	416	26063	431	1%	71:11:58
11	news.fcku.it	10	1824	213	1609	2	11%	21:04:23
12	csiph-out.news.tnetconsulting.net	2	17422	169	17228	25	0%	23:59:58
13	news-out.neodome.net	1	18386	90	18282	14	0%	23:59:52
14	news.swapon.de	7	1554	48	1506	0	3%	23:50:32
15	nntp.pasdenom.info	2	12353	44	12285	24	0%	23:58:27
16	news.bbs.nz	1	16652	6	16646	0	0%	23:59:52
17	news.samoylyk.net	0	12348	5	12342	1	0%	17:22:22
18	localhost	30	4	4	0	0	100%	00:00:04
19	xanadu-bbs.net	18	547	0	547	0	0%	21:07:30
TOTAL: 19		3413	357363	17637	336531	3195	4%	688:07:14

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	13.8 MB	0.0 KB	2.6 MB	16.4 MB	84%	3.7 KB
2	news-out.aioe.org	9.7 MB	1.4 KB	246.5 KB	9.9 MB	97%	2.5 KB
3	csiph-out.feeder.erje.net	7.3 MB	4.2 KB	6.1 MB	13.3 MB	54%	8.7 KB
4	feeder.eternal-september.org	6.9 MB	1.4 KB	1.2 MB	8.1 MB	84%	3.0 KB
5	news-out.mixmin.net	2.7 MB	1.4 KB	754.7 KB	3.4 MB	78%	2.9 KB
6	csiph-out.news.xs4all.nl	2.6 MB	1.4 KB	9.6 MB	12.2 MB	21%	6.8 KB
7	csiph-out.news.weretis.net	2.3 MB	1.4 KB	2.2 MB	4.5 MB	50%	4.6 KB
8	newsfeed.neva.ru	2.0 MB	4.2 KB	1.2 MB	3.2 MB	63%	2.5 KB
9	newsfeed.fu-berlin.de	1.7 MB	0.0 KB	866.8 KB	2.6 MB	67%	2.5 KB
10	csiph-out.feed.uzoreto.com	1.3 MB	1.3 KB	8.4 MB	9.7 MB	13%	11.8 KB
11	csiph-out.news.tnetconsulting.net	500.2 KB	3.3 KB	190.8 KB	694.3 KB	72%	3.6 KB
12	news-out.neodome.net	422.1 KB	1.4 KB	169.8 KB	593.3 KB	71%	5.7 KB
13	news.fcku.it	350.5 KB	1.4 KB	2.4 KB	354.3 KB	98%	1.6 KB
14	news.swapon.de	116.8 KB	0.0 KB	0.0 KB	116.8 KB	100%	2.4 KB
15	nntp.pasdenom.info	82.5 KB	0.0 KB	33.5 KB	116.1 KB	71%	1.7 KB
16	news.samoylyk.net	17.0 KB	1.4 KB	1.4 KB	19.8 KB	85%	3.3 KB
17	news.bbs.nz	9.5 KB	0.0 KB	0.0 KB	9.5 KB	100%	1.6 KB
18	localhost	4.4 KB	0.0 KB	0.0 KB	4.4 KB	100%	1.1 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		51.7 MB	24.1 KB	33.5 MB	85.2 MB	60%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 6 04:15:00 - 04:59:59	227	1.3%	0.08	853.4 KB	1.6%	0.32
May 6 05:00:00 - 05:59:59	375	2.1%	0.10	1.0 MB	2.0%	0.30
May 6 06:00:00 - 06:59:59	610	3.5%	0.17	2.8 MB	5.3%	0.79
May 6 07:00:00 - 07:59:59	758	4.3%	0.21	1.9 MB	3.6%	0.54
May 6 08:00:00 - 08:59:59	879	5.0%	0.24	2.6 MB	5.1%	0.75
May 6 09:00:00 - 09:59:59	940	5.3%	0.26	3.0 MB	5.9%	0.87
May 6 10:00:00 - 10:59:59	821	4.6%	0.23	2.3 MB	4.4%	0.65
May 6 11:00:00 - 11:59:59	779	4.4%	0.22	2.2 MB	4.2%	0.62
May 6 12:00:00 - 12:59:59	900	5.1%	0.25	2.6 MB	5.0%	0.74
May 6 13:00:00 - 13:59:59	988	5.6%	0.27	2.6 MB	5.1%	0.75
May 6 14:00:00 - 14:59:59	1091	6.2%	0.30	3.1 MB	6.0%	0.89
May 6 15:00:00 - 15:59:59	1024	5.8%	0.28	2.9 MB	5.6%	0.83
May 6 16:00:00 - 16:59:59	997	5.6%	0.28	2.7 MB	5.2%	0.77
May 6 17:00:00 - 17:59:59	1004	5.7%	0.28	2.7 MB	5.1%	0.76
May 6 18:00:00 - 18:59:59	941	5.3%	0.26	2.8 MB	5.4%	0.80
May 6 19:00:00 - 19:59:59	961	5.4%	0.27	2.8 MB	5.4%	0.80
May 6 20:00:00 - 20:59:59	880	5.0%	0.24	2.4 MB	4.6%	0.68
May 6 21:00:00 - 21:59:59	731	4.1%	0.20	1.9 MB	3.7%	0.55
May 6 22:00:00 - 22:59:59	613	3.5%	0.17	1.7 MB	3.3%	0.49
May 6 23:00:00 - 23:59:59	437	2.5%	0.12	1.3 MB	2.5%	0.37
May 7 00:00:00 - 00:59:59	403	2.3%	0.11	1.2 MB	2.4%	0.35
May 7 01:00:00 - 01:59:59	422	2.4%	0.12	1.5 MB	2.9%	0.43
May 7 02:00:00 - 02:59:59	413	2.3%	0.11	1.2 MB	2.4%	0.35
May 7 03:00:00 - 03:59:59	355	2.0%	0.10	1.2 MB	2.3%	0.35
May 7 04:00:00 - 04:15:00	115	0.7%	0.13	513.0 KB	1.0%	0.57
TOTAL: 24:00:00	17664	100.0%	0.20	52.0 MB	100.0%	0.62

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	922	25	1	896
2	newsfeed.fu-berlin.de	667	17	0	650
3	csiph-out.feed.uzoreto.com	436	10	1	425
4	csiph-out.feeder.erje.net	395	37	3	355
5	newsfeed.neva.ru	333	38	3	292
6	news-out.mixmin.net	314	0	1	313
7	news-out.aioe.org	214	65	1	148
8	csiph-out.news.weretis.net	199	52	1	146
9	feeder.eternal-september.org	156	16	1	139
10	newsfeeds.xmission.com	54	3	0	51
11	nntp.pasdenom.info	24	1	0	23
12	csiph-out.news.tnetconsulting.net	19	17	1	1
13	news-out.neodome.net	14	2	1	11
14	news.swapon.de	12	0	0	12
15	news.fcku.it	2	0	1	1
16	news.samoylyk.net	1	0	1	0
TOTAL: 16		3762	283	16	3463

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	26
alt.bbs.synchronet	24
alt.computer.workshop	22
mozilla.general	16
mozilla.support.firefox	16
alt.politics.usa	15
spline.eisfair	11
oesterreich.tratsch	10
alt.paranormal.spells	10
alt.survival	8
mozilla.test	7
mozilla.dev.platform	6
alt.binaries.ebooks	5
alt.binaries.pictures.purebeauty	5
alt.windows7.general	5
alt.job	4
fido7.ru.android	4
free.it.religioni.scientology	4
alt.magick.folk	4
lada.kitchen	3
TOTAL: 74	283

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1719
EMP (phn path)	408
EMP (phl)	239
EMP (phn nph)	87
0	57
Too many newsgroups	53
HTML Multipart	26
Binary Payload	20
Binary: misplaced binary	11
HTML post	3
Scoring filter	3
Too many newsgroups (meow)	2
TOTAL: 12	2628

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	65
	csiph-out.feed.uzoreto.com	5
	csiph-out.news.xs4all.nl	4
	TOTAL: 3	74
Huge articles
	csiph-out.feeder.erje.net	97
	csiph-out.feed.uzoreto.com	53
	csiph-out.news.xs4all.nl	50
	newsfeeds.xmission.com	38
	csiph-out.news.weretis.net	16
	feeder.eternal-september.org	6
	news-out.mixmin.net	3
	newsfeed.fu-berlin.de	3
	news-out.neodome.net	3
	csiph-out.news.tnetconsulting.net	1
	TOTAL: 10	270
Including strange strings
	newsfeed.fu-berlin.de	369
	news-out.aioe.org	140
	csiph-out.news.weretis.net	16
	news.swapon.de	12
	news-out.mixmin.net	8
	csiph-out.feeder.erje.net	6
	newsfeeds.xmission.com	4
	csiph-out.feed.uzoreto.com	3
	newsfeed.neva.ru	3
	csiph-out.news.xs4all.nl	3
	TOTAL: 10	564
No colon-space in header
	csiph-out.news.xs4all.nl	1
	TOTAL: 1	1
TOTAL: 4		909

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.nz	32945	941	16117	71	1	2%	23:59:55
2	xanadu-bbs	20392	920	16735	7	1	4%	23:59:55
3	fu-berlin.de	16663	526	16137	0	0	3%	23:59:54
4	news.samoylyk.net	12197	395	11559	5	5700	3%	23:59:55
5	tnet	18330	118	17011	1	0	0%	23:59:53
6	news.freedyn.net	18013	86	17577	1	0	0%	23:59:55
7	erje	20350	76	16079	243	0	0%	23:59:55
8	neva.ru	16173	36	15934	52	0	0%	23:59:55
9	newsfeed.xs4all.nl	17167	27	16507	8	109	0%	23:59:54
10	usenet.pasdenom.info	17948	19	17065	2	11	0%	23:59:55
11	aioe	12777	9	12269	0	0	0%	23:59:55
12	news.uzoreto.com	16971	7	16705	5	0	0%	23:59:32
13	weretis.net	16572	7	16299	0	0	0%	23:59:55
14	xmission	13885	6	12614	0	0	0%	23:59:55
15	eternal-september	14908	6	14432	1	0	0%	23:59:34
16	neodome.net	17986	6	17497	0	0	0%	23:59:49
17	news.mixmin.net	16477	5	15989	0	0	0%	23:59:55
18	news.swapon.de	1669	4	1609	0	0	0%	23:49:42
19	news.fcku.it	1605	0	1594	0	0	0%	21:51:16
TOTAL: 19		303028	3194	269729	396	5822	1%	453:38:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.4 MB	42.4 KB	6.5 MB	0.1 KB/s	7.1 KB	23:59:55
2	fu-berlin.de	5.3 MB	0.0 KB	5.3 MB	0.1 KB/s	10.3 KB	23:59:54
3	news.samoylyk.net	4.7 MB	100.5 KB	4.8 MB	0.1 KB/s	12.2 KB	23:59:55
4	news.bbs.nz	2.7 MB	341.4 KB	3.0 MB	0.0 KB/s	3.0 KB	23:59:55
5	news.freedyn.net	654.4 KB	1.2 KB	655.5 KB	0.0 KB/s	7.5 KB	23:59:55
6	tnet	297.2 KB	1.2 KB	298.4 KB	0.0 KB/s	2.5 KB	23:59:53
7	erje	163.3 KB	740.0 KB	903.3 KB	0.0 KB/s	2.8 KB	23:59:55
8	newsfeed.xs4all.nl	156.4 KB	48.1 KB	204.6 KB	0.0 KB/s	5.8 KB	23:59:54
9	usenet.pasdenom.info	106.5 KB	33.9 KB	140.4 KB	0.0 KB/s	6.7 KB	23:59:55
10	neva.ru	79.9 KB	147.0 KB	226.9 KB	0.0 KB/s	2.6 KB	23:59:55
11	aioe	26.4 KB	0.0 KB	26.4 KB	0.0 KB/s	2.9 KB	23:59:55
12	news.uzoreto.com	24.1 KB	10.5 KB	34.6 KB	0.0 KB/s	2.9 KB	23:59:32
13	neodome.net	23.0 KB	0.0 KB	23.0 KB	0.0 KB/s	3.8 KB	23:59:49
14	weretis.net	22.3 KB	0.0 KB	22.3 KB	0.0 KB/s	3.2 KB	23:59:55
15	eternal-september	21.3 KB	5.3 KB	26.6 KB	0.0 KB/s	3.8 KB	23:59:34
16	xmission	21.3 KB	0.0 KB	21.3 KB	0.0 KB/s	3.6 KB	23:59:55
17	news.mixmin.net	20.2 KB	0.0 KB	20.2 KB	0.0 KB/s	4.0 KB	23:59:55
18	news.swapon.de	4.4 KB	0.0 KB	4.4 KB	0.0 KB/s	1.1 KB	23:49:42
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:51:16
TOTAL: 19		20.6 MB	1.4 MB	22.0 MB	0.0 KB/s	6.3 KB	453:38:39

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ppp-2-84-163-204.home.otenet.gr	13	405	782.4 KB	5	0	0	00:05:17
2	a131033.upc-a.chello.nl	47	8	8.4 KB	4	0	0	10:03:15
3	047-035-184-003.res.spectrum.com	24	6	6.9 KB	5	4	4	06:06:24
TOTAL: 3		84	419	797.7 KB	14	4	4	43:14:57

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.home.otenet.gr	13	405	782.4 KB	5	0	0	00:05:17
2	*.upc-a.chello.nl	47	8	8.4 KB	4	0	0	10:03:15
3	*.res.spectrum.com	24	6	6.9 KB	5	4	4	06:06:24
4	*.hsd1.wa.comcast.net	2	0	0.0 KB	0	0	0	01:00:01
5	*.cust.centrio.cz	3	0	0.0 KB	0	0	0	01:30:09
6	unresolved	78	0	0.0 KB	0	0	0	24:29:50
TOTAL: 6		167	419	797.7 KB	14	4	4	43:14:57

NNRP auth users [Top 20]:

User	Conn
ohlandl	4
ctomczyk	3
TOTAL: 2	7

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.757	1.159	0.000	23:59:44
a131033.upc-a.chello.nl	3.348	0.659	0.000	10:03:15
047-035-184-003.res.spectrum.com	1.674	0.446	0.010	06:06:24
5-168-143-94.cust.centrio.cz	0.182	0.056	0.009	01:30:09
c-73-140-175-55.hsd1.wa.comcast.net	0.129	0.023	0.000	01:00:01
218.75.38.212	0.063	0.016	0.000	00:30:00
ppp-2-84-163-204.home.otenet.gr	1.145	0.336	0.000	00:05:17
94.164.12.115	0.063	0.016	0.000	00:00:01
94.161.236.54	0.056	0.021	0.000	00:00:01
94.163.201.213	0.069	0.009	0.000	00:00:01
5.87.226.23	0.059	0.017	0.000	00:00:01
94.161.243.169	0.069	0.008	0.000	00:00:01
TOTAL: 12	11.614	2.766	0.019	43:14:57

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
5-168-143-94.cust.centrio.cz	3
c-73-140-175-55.hsd1.wa.comcast.net	2
94.164.12.115	1
5.87.226.23	1
94.163.201.213	1
218.75.38.212	1
94.161.236.54	1
94.161.243.169	1
TOTAL: 9	83

NNRP unrecognized commands (by host):

System	Conn
218.75.38.212	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.0	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
047-035-184-003.res.spectrum.com	5	0
5-168-143-94.cust.centrio.cz	3	0
c-73-140-175-55.hsd1.wa.comcast.net	2	0
218.75.38.212	1	0
ppp-2-84-163-204.home.otenet.gr	1	1
TOTAL: 5	12	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

May 6 04:15:00 -- May 7 04:15:00