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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20906	49.0%	5.5 MB	64.7%
innd	17244	40.5%	2.3 MB	27.0%
innfeed	3550	8.3%	622.3 KB	7.2%
nnrpd	913	2.1%	99.0 KB	1.1%
nocem	10	0.0%	1.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	42624	100.0%	8.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	333650	56.4%
Negative hits	236829	40.0%
Do not exist	20179	3.4%
Cache misses	713	0.1%
TOTAL: 4	591371	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.516	0.0%	320	0.000	17.238	131.000
article cleanup	00:00:00.108	0.0%	20334	0.000	0.005	0.033
article logging	00:00:00.312	0.0%	20996	0.000	0.015	0.276
article parse	00:00:00.800	0.0%	62327	0.000	0.013	0.555
article write	00:00:10.891	0.0%	17626	0.148	0.618	19.731
artlog/artcncl	00:00:00.004	0.0%	320	0.000	0.013	0.013
artlog/artparse	00:00:00.002	0.0%	201	0.000	0.010	0.250
data move	00:00:00.191	0.0%	552307	0.000	0.000	0.004
hisgrep/artcncl	00:00:00.360	0.0%	320	0.000	1.125	130.000
hishave/artcncl	00:00:00.220	0.0%	320	0.000	0.688	4.000
hishave/artparse	00:00:00.000	0.0%	198	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:05.833	0.0%	601143	0.002	0.010	0.128
history sync	00:00:00.886	0.0%	377	0.000	2.350	15.500
history write	00:00:13.623	0.0%	20309	0.209	0.671	3.981
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.267	0.0%	197	0.000	1.355	31.750
idle	23:56:33.068	99.7%	559399	84.072	154.082	432.613
nntp read	00:00:02.192	0.0%	561101	0.001	0.004	0.008
overview write	00:02:44.389	0.2%	17626	0.140	9.327	1617.197
perl filter	00:00:27.759	0.0%	20306	1.084	1.367	2.336
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.298	0.0%	35262	0.000	0.008	0.027
TOTAL: 24:01:05.020	24:00:26.719	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.032	0.0%	18811	0.000	0.002	0.029
article prepare	00:00:00.003	0.0%	15936	0.000	0.000	0.014
article read	00:00:00.427	0.0%	2053	0.000	0.208	3.750
backlog stats	00:00:00.218	0.0%	406275	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.465	0.0%	319279	0.001	0.005	0.010
data write	00:00:01.801	0.0%	303678	0.002	0.006	0.012
idle	23:53:27.525	100.0%	406275	111.333	211.698	641.633
status file	00:00:00.233	0.0%	288	0.000	0.809	2.167
TOTAL: 23:53:39.642	23:53:31.704	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	41:45:45.968	99.8%	584	143.500	257441.726	600118.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.004	0.0%	1432	0.000	0.003	0.167
readart	00:00:00.512	0.0%	67	0.000	7.642	42.000
TOTAL: 41:50:34.518	41:45:46.484	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	2	16758	4085	12630	43	24%	24:06:58
2	newsfeeds.xmission.com	6	15973	3683	12249	41	23%	22:45:23
3	feeder.eternal-september.org	4	19299	2722	16360	217	14%	25:07:47
4	csiph-out.feeder.erje.net	1440	87678	1460	85915	303	1%	118:46:33
5	csiph-out.news.xs4all.nl	859	18888	1294	16850	744	6%	71:29:06
6	newsfeed.fu-berlin.de	12	18624	925	17510	189	4%	29:04:05
7	news-out.mixmin.net	2	18524	904	17275	345	4%	23:59:45
8	csiph-out.news.weretis.net	3	35664	861	34603	200	2%	49:20:46
9	newsfeed.neva.ru	148	16477	552	15709	216	3%	71:55:14
10	csiph-out.feed.uzoreto.com	864	27158	442	26143	573	1%	71:11:56
11	csiph-out.news.tnetconsulting.net	1	18125	289	17811	25	1%	27:03:04
12	news.fcku.it	13	1562	170	1390	2	10%	22:02:51
13	nntp.pasdenom.info	5	11715	94	11592	29	0%	23:56:03
14	news-out.neodome.net	2	18656	87	18543	26	0%	23:59:47
15	news.swapon.de	1	1813	53	1750	10	2%	22:32:53
16	news.samoylyk.net	4	17595	15	17574	6	0%	24:54:43
17	localhost	29	3	3	0	0	100%	00:00:04
18	news.bbs.nz	1	17094	3	17091	0	0%	23:59:52
19	xanadu-bbs.net	54	684	1	683	0	0%	42:24:31
TOTAL: 19		3450	362290	17643	341678	2969	4%	718:41:21

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	10.7 MB	0.0 KB	2.8 MB	13.5 MB	79%	3.7 KB
2	news-out.aioe.org	10.0 MB	0.0 KB	113.1 KB	10.1 MB	98%	2.5 KB
3	feeder.eternal-september.org	7.7 MB	1.8 KB	1.1 MB	8.8 MB	87%	3.1 KB
4	csiph-out.feeder.erje.net	7.4 MB	71.8 KB	4.9 MB	12.4 MB	59%	7.2 KB
5	csiph-out.news.xs4all.nl	3.7 MB	8.2 KB	5.3 MB	9.0 MB	40%	4.5 KB
6	news-out.mixmin.net	2.6 MB	5.4 KB	604.6 KB	3.2 MB	81%	2.6 KB
7	csiph-out.news.weretis.net	2.5 MB	4.0 KB	1.5 MB	4.0 MB	62%	3.8 KB
8	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	467.8 KB	2.8 MB	83%	2.5 KB
9	csiph-out.feed.uzoreto.com	1.5 MB	6.4 KB	6.4 MB	7.9 MB	19%	8.0 KB
10	newsfeed.neva.ru	1.5 MB	0.0 KB	736.4 KB	2.2 MB	67%	2.9 KB
11	csiph-out.news.tnetconsulting.net	811.8 KB	1.8 KB	129.0 KB	942.6 KB	86%	3.0 KB
12	news-out.neodome.net	365.6 KB	1.8 KB	418.6 KB	786.0 KB	46%	7.0 KB
13	news.fcku.it	268.5 KB	0.0 KB	4.3 KB	272.8 KB	98%	1.6 KB
14	nntp.pasdenom.info	196.8 KB	0.0 KB	38.9 KB	235.7 KB	83%	1.9 KB
15	news.swapon.de	160.9 KB	0.0 KB	6.6 MB	6.7 MB	2%	109.1 KB
16	news.samoylyk.net	50.5 KB	1.8 KB	829.5 KB	881.8 KB	5%	42.0 KB
17	localhost	4.6 KB	0.0 KB	0.0 KB	4.6 KB	100%	1.5 KB
18	news.bbs.nz	3.4 KB	0.0 KB	0.0 KB	3.4 KB	100%	1.1 KB
19	xanadu-bbs.net	1.8 KB	0.0 KB	0.0 KB	1.8 KB	100%	1.8 KB
TOTAL: 19		51.7 MB	102.9 KB	31.8 MB	83.6 MB	61%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 2 04:15:00 - 04:59:59	268	1.5%	0.10	860.3 KB	1.7%	0.32
May 2 05:00:00 - 05:59:59	411	2.4%	0.11	1.3 MB	2.7%	0.38
May 2 06:00:00 - 06:59:59	526	3.0%	0.15	2.1 MB	4.1%	0.59
May 2 07:00:00 - 07:59:59	677	3.9%	0.19	2.3 MB	4.6%	0.66
May 2 08:00:00 - 08:59:59	726	4.2%	0.20	2.1 MB	4.1%	0.59
May 2 09:00:00 - 09:59:59	764	4.4%	0.21	2.4 MB	4.7%	0.67
May 2 10:00:00 - 10:59:59	775	4.5%	0.22	2.2 MB	4.3%	0.61
May 2 11:00:00 - 11:59:59	750	4.3%	0.21	2.0 MB	4.1%	0.58
May 2 12:00:00 - 12:59:59	915	5.3%	0.25	2.4 MB	4.8%	0.68
May 2 13:00:00 - 13:59:59	1096	6.3%	0.30	2.9 MB	5.8%	0.83
May 2 14:00:00 - 14:59:59	978	5.6%	0.27	2.6 MB	5.3%	0.75
May 2 15:00:00 - 15:59:59	1019	5.9%	0.28	3.1 MB	6.1%	0.87
May 2 16:00:00 - 16:59:59	999	5.8%	0.28	2.6 MB	5.2%	0.74
May 2 17:00:00 - 17:59:59	973	5.6%	0.27	3.0 MB	6.0%	0.85
May 2 18:00:00 - 18:59:59	966	5.6%	0.27	2.7 MB	5.4%	0.76
May 2 19:00:00 - 19:59:59	973	5.6%	0.27	2.6 MB	5.3%	0.75
May 2 20:00:00 - 20:59:59	802	4.6%	0.22	2.0 MB	4.0%	0.57
May 2 21:00:00 - 21:59:59	752	4.3%	0.21	2.3 MB	4.5%	0.64
May 2 22:00:00 - 22:59:59	650	3.8%	0.18	1.8 MB	3.6%	0.52
May 2 23:00:00 - 23:59:59	522	3.0%	0.14	1.5 MB	3.0%	0.43
May 3 00:00:00 - 00:59:59	457	2.6%	0.13	1.4 MB	2.8%	0.40
May 3 01:00:00 - 01:59:59	527	3.0%	0.15	1.5 MB	2.9%	0.42
May 3 02:00:00 - 02:59:59	353	2.0%	0.10	1.1 MB	2.2%	0.31
May 3 03:00:00 - 03:59:59	355	2.0%	0.10	1.1 MB	2.3%	0.33
May 3 04:00:00 - 04:15:00	99	0.6%	0.11	256.0 KB	0.5%	0.28
TOTAL: 24:00:00	17333	100.0%	0.20	50.1 MB	100.0%	0.59

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Other
1	csiph-out.news.xs4all.nl	748	27	0	3	718
2	newsfeed.fu-berlin.de	642	20	0	0	622
3	csiph-out.feed.uzoreto.com	580	5	0	0	575
4	news-out.mixmin.net	346	3	0	1	342
5	csiph-out.feeder.erje.net	290	43	1	0	246
6	newsfeed.neva.ru	219	21	0	0	198
7	feeder.eternal-september.org	208	12	0	1	195
8	csiph-out.news.weretis.net	183	41	0	1	141
9	news-out.aioe.org	172	32	0	0	140
10	newsfeeds.xmission.com	49	3	0	0	46
11	nntp.pasdenom.info	29	0	0	0	29
12	news.swapon.de	28	0	0	0	28
13	csiph-out.news.tnetconsulting.net	25	18	0	1	6
14	news-out.neodome.net	21	2	0	1	18
15	news.samoylyk.net	6	0	0	1	5
16	news.fcku.it	2	1	0	0	1
TOTAL: 16		3548	228	1	9	3310

Unwanted newsgroups [Top 20]:

Newsgroup	Count
spline.eisfair	19
alt.bbs.synchronet	19
alt.politics.usa	14
alt.survival	10
lada.talk	8
spline.fli4l.geschnatter	8
alt.windows7.general	7
mozilla.support.seamonkey	7
alt.politics	6
alt.philosophy	6
alt.binaries.ebook	6
alt.paranormal.spells	6
alt.binaries.e-book-flood	5
alt.english.usage	5
alt.binaries.pictures.purebeauty	5
mozilla.support.thunderbird	5
lada.movies	5
alt.binaries.bnb	3
oesterreich.tratsch	3
att.jobs	3
TOTAL: 81	228

Unwanted distributions [Top 20]:

Distribution	Count
local	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1644
EMP (phn path)	371
EMP (phl)	156
EMP (phn nph)	105
Too many newsgroups	66
0	53
Binary Payload	29
HTML Multipart	15
Binary: misplaced binary	6
Too many newsgroups (low_xpost)	2
HTML post	2
Scoring filter	1
Too many newsgroups (meow)	1
TOTAL: 13	2451

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	csiph-out.feed.uzoreto.com	3
	csiph-out.news.xs4all.nl	2
	TOTAL: 3	55
Huge articles
	csiph-out.feeder.erje.net	81
	newsfeeds.xmission.com	39
	csiph-out.feed.uzoreto.com	24
	csiph-out.news.xs4all.nl	21
	csiph-out.news.weretis.net	12
	news.swapon.de	10
	feeder.eternal-september.org	6
	news.samoylyk.net	1
	TOTAL: 8	194
Including strange strings
	newsfeed.fu-berlin.de	461
	news-out.aioe.org	127
	csiph-out.news.weretis.net	20
	news.swapon.de	18
	news-out.mixmin.net	12
	csiph-out.feed.uzoreto.com	8
	newsfeeds.xmission.com	6
	csiph-out.news.xs4all.nl	4
	csiph-out.feeder.erje.net	3
	newsfeed.neva.ru	2
	TOTAL: 11	662
No colon-space in header
	csiph-out.news.xs4all.nl	3
	TOTAL: 1	3
TOTAL: 4		914

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	21599	1295	16026	9	51	5%	23:59:54
2	fu-berlin.de	16282	560	15722	0	0	3%	23:59:55
3	news.samoylyk.net	17968	540	16767	11	183	3%	23:59:54
4	news.bbs.nz	32471	364	16303	7	0	1%	23:59:51
5	tnet	17868	105	16591	1	0	0%	23:59:55
6	erje	18206	87	14992	470	0	0%	23:59:14
7	news.freedyn.net	17644	78	17242	0	0	0%	23:59:55
8	newsfeed.xs4all.nl	16429	47	15816	9	132	0%	23:59:54
9	usenet.pasdenom.info	17572	42	16768	55	27	0%	23:59:39
10	neva.ru	16150	30	15937	84	0	0%	23:59:55
11	news.uzoreto.com	16521	19	16186	113	0	0%	23:59:54
12	news.mixmin.net	16040	11	15542	0	0	0%	23:59:54
13	neodome.net	17640	10	17153	0	0	0%	23:59:54
14	aioe	13075	10	11942	19	0	0%	23:59:55
15	xmission	14611	5	13045	0	861	0%	23:59:55
16	eternal-september	14363	3	13876	0	0	0%	23:59:25
17	weretis.net	15950	3	15774	1	0	0%	23:59:39
18	news.swapon.de	1897	2	1871	1	0	0%	23:55:40
19	news.fcku.it	1331	0	1326	0	0	0%	21:56:04
TOTAL: 19		303617	3211	268879	780	1254	1%	453:48:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.5 MB	44.9 KB	6.6 MB	0.1 KB/s	5.1 KB	23:59:54
2	fu-berlin.de	4.8 MB	0.0 KB	4.8 MB	0.1 KB/s	8.8 KB	23:59:55
3	news.samoylyk.net	4.7 MB	108.4 KB	4.8 MB	0.1 KB/s	8.9 KB	23:59:54
4	news.bbs.nz	976.8 KB	24.8 KB	1001.5 KB	0.0 KB/s	2.7 KB	23:59:51
5	news.freedyn.net	735.7 KB	0.0 KB	735.7 KB	0.0 KB/s	9.4 KB	23:59:55
6	tnet	288.0 KB	4.4 KB	292.4 KB	0.0 KB/s	2.8 KB	23:59:55
7	erje	198.7 KB	1.5 MB	1.7 MB	0.0 KB/s	3.1 KB	23:59:14
8	newsfeed.xs4all.nl	153.5 KB	40.6 KB	194.1 KB	0.0 KB/s	3.5 KB	23:59:54
9	usenet.pasdenom.info	116.9 KB	239.9 KB	356.8 KB	0.0 KB/s	3.7 KB	23:59:39
10	neva.ru	72.2 KB	215.1 KB	287.3 KB	0.0 KB/s	2.5 KB	23:59:55
11	news.uzoreto.com	50.8 KB	499.7 KB	550.5 KB	0.0 KB/s	4.2 KB	23:59:54
12	news.mixmin.net	40.2 KB	0.0 KB	40.2 KB	0.0 KB/s	3.7 KB	23:59:54
13	neodome.net	36.4 KB	0.0 KB	36.4 KB	0.0 KB/s	3.6 KB	23:59:54
14	aioe	16.8 KB	87.2 KB	104.0 KB	0.0 KB/s	3.6 KB	23:59:55
15	xmission	12.7 KB	0.0 KB	12.7 KB	0.0 KB/s	2.5 KB	23:59:55
16	eternal-september	4.6 KB	0.0 KB	4.6 KB	0.0 KB/s	1.5 KB	23:59:25
17	weretis.net	4.6 KB	1.1 KB	5.7 KB	0.0 KB/s	1.4 KB	23:59:39
18	news.swapon.de	3.6 KB	0.9 KB	4.6 KB	0.0 KB/s	1.5 KB	23:55:40
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:56:04
TOTAL: 19		18.7 MB	2.7 MB	21.4 MB	0.0 KB/s	5.5 KB	453:48:26

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ppp-2-84-163-204.home.otenet.gr	11	24	45.9 KB	2	0	0	00:00:23
2	a131033.upc-a.chello.nl	46	23	44.4 KB	9	0	0	11:55:18
3	047-035-184-003.res.spectrum.com	20	18	32.0 KB	9	3	3	05:55:47
4	ppp-2-84-172-200.home.otenet.gr	1	2	2.2 KB	1	0	0	00:00:03
TOTAL: 4		78	67	124.4 KB	21	3	3	41:50:33

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.home.otenet.gr	12	26	48.0 KB	3	0	0	00:00:27
2	*.upc-a.chello.nl	46	23	44.4 KB	9	0	0	11:55:18
3	*.res.spectrum.com	20	18	32.0 KB	9	3	3	05:55:47
4	unresolved	75	0	0.0 KB	0	0	0	23:59:00
TOTAL: 4		153	67	124.4 KB	21	3	3	41:50:33

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	5.061	1.198	0.000	23:58:56
a131033.upc-a.chello.nl	3.525	0.675	0.000	11:55:18
047-035-184-003.res.spectrum.com	1.700	0.333	0.007	05:55:47
ppp-2-84-163-204.home.otenet.gr	0.788	0.130	0.000	00:00:23
ppp-2-84-172-200.home.otenet.gr	0.114	0.008	0.000	00:00:03
94.161.151.1	0.055	0.024	0.000	00:00:01
94.163.47.212	0.064	0.014	0.000	00:00:01
94.163.192.57	0.078	0.000	0.000	00:00:01
183.136.225.45	0.065	0.016	0.000	00:00:00
TOTAL: 9	11.450	2.398	0.007	41:50:33

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	71
94.163.192.57	1
94.161.151.1	1
183.136.225.45	1
94.163.47.212	1
TOTAL: 5	75

NNRP unrecognized commands (by host):

System	Conn
183.136.225.45	5
TOTAL: 1	5

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	1
Accept: /	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
Connection: keep-alive	1
Host: 69.160.37.58:119	1
TOTAL: 5	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
047-035-184-003.res.spectrum.com	6	0
TOTAL: 1	6	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

May 2 04:15:00 -- May 3 04:15:00