Daily Usenet report for csiph.com: Mar 3 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19886	48.3%	5.2 MB	63.8%
innd	17036	41.4%	2.2 MB	27.5%
innfeed	3472	8.4%	647.1 KB	7.8%
nnrpd	712	1.7%	77.0 KB	0.9%
nocem	35	0.1%	4.1 KB	0.0%
TOTAL: 5	41141	100.0%	8.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	334653	58.0%
Negative hits	223073	38.6%
Do not exist	19310	3.3%
Cache misses	273	0.0%
TOTAL: 4	577309	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.565	0.0%	27	0.000	20.926	34.600
article cleanup	00:00:00.111	0.0%	18851	0.000	0.006	0.030
article logging	00:00:00.296	0.0%	19307	0.000	0.015	0.370
article parse	00:00:01.109	0.0%	63204	0.000	0.018	0.099
article write	00:00:19.868	0.0%	16105	0.154	1.234	32.983
artlog/artcncl	00:00:00.000	0.0%	27	0.000	0.000	0.000
artlog/artparse	00:00:00.008	0.0%	565	0.000	0.014	0.333
data move	00:00:00.201	0.0%	547153	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.009	0.0%	27	0.000	0.333	1.000
hishave/artcncl	00:00:00.002	0.0%	27	0.000	0.074	1.000
hishave/artparse	00:00:00.001	0.0%	564	0.000	0.002	0.037
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:10.098	0.0%	578281	0.002	0.017	0.178
history sync	00:00:00.902	0.0%	387	0.000	2.331	16.333
history write	00:00:14.928	0.0%	18812	0.194	0.794	3.889
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.497	0.0%	564	0.000	0.881	5.000
idle	23:58:30.352	99.8%	552120	86.219	156.325	486.085
nntp read	00:00:02.055	0.0%	554668	0.001	0.004	0.008
overview write	00:00:50.908	0.1%	16105	0.134	3.161	90.617
perl filter	00:00:25.432	0.0%	18811	1.062	1.352	2.673
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.281	0.0%	32245	0.000	0.009	0.045
TOTAL: 24:01:10.127	24:00:37.623	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.027	0.0%	16207	0.000	0.002	0.018
article prepare	00:00:00.004	0.0%	13968	0.000	0.000	0.050
article read	00:00:00.205	0.0%	1200	0.000	0.171	10.500
backlog stats	00:00:00.206	0.0%	370015	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.345	0.0%	296465	0.001	0.005	0.009
data write	00:00:01.708	0.0%	283626	0.001	0.006	0.012
idle	23:53:21.420	100.0%	370015	136.996	232.427	569.639
status file	00:00:00.191	0.0%	281	0.000	0.680	2.000
TOTAL: 23:53:30.997	23:53:25.106	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	35:43:47.097	99.8%	503	590.300	255719.875	600216.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.781	0.0%	1180	0.000	2.357	26.663
readart	00:00:00.165	0.0%	27	0.000	6.111	42.000
TOTAL: 35:48:35.775	35:43:50.043	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	newsfeeds.xmission.com	3	15024	4334	10673	17	28%	22:50:30
2	news-out.aioe.org	2	15585	3391	12058	136	21%	24:09:03
3	feeder.eternal-september.org	2	17066	2062	14798	206	12%	22:18:44
4	csiph-out.feeder.erje.net	1440	80369	944	79048	377	1%	118:42:30
5	csiph-out.news.xs4all.nl	861	17490	862	15642	986	4%	71:27:53
6	newsfeed.fu-berlin.de	8	17503	762	16520	221	4%	28:02:07
7	csiph-out.news.weretis.net	3	32843	731	31993	119	2%	47:59:46
8	newsfeed.neva.ru	139	18847	707	17905	235	3%	72:30:21
9	news-out.mixmin.net	2	16562	680	15559	323	4%	23:59:34
10	news.freedyn.net	3	18668	589	17900	179	3%	24:08:59
11	news.fcku.it	14	2513	331	2174	8	13%	22:29:58
12	csiph-out.news.tnetconsulting.net	6	29521	259	29049	213	0%	41:55:52
13	csiph-out.feed.uzoreto.com	864	24582	132	24137	313	0%	71:06:54
14	news-out.neodome.net	1	16931	108	16815	8	0%	23:59:54
15	news.swapon.de	3	1599	33	1566	0	2%	23:37:01
16	nntp.pasdenom.info	2	11764	27	11673	64	0%	23:58:48
17	news.bbs.nz	1	15622	12	15610	0	0%	23:59:53
18	news.samoylyk.net	2	15914	4	15908	2	0%	23:59:47
19	localhost	27	1	1	0	0	100%	00:00:04
20	xanadu-bbs.net	25	444	0	444	0	0%	20:40:41
TOTAL: 20		3408	368848	15969	349472	3407	4%	731:58:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	12.4 MB	25.6 KB	1.1 MB	13.5 MB	91%	3.2 KB
2	news-out.aioe.org	8.0 MB	7.6 KB	468.8 KB	8.4 MB	94%	2.4 KB
3	csiph-out.feeder.erje.net	7.6 MB	18.2 KB	9.7 MB	17.3 MB	43%	13.4 KB
4	feeder.eternal-september.org	5.2 MB	25.7 KB	671.2 KB	5.8 MB	88%	2.6 KB
5	csiph-out.news.xs4all.nl	2.6 MB	5.4 KB	16.1 MB	18.7 MB	14%	10.4 KB
6	csiph-out.news.weretis.net	2.2 MB	27.1 KB	4.5 MB	6.6 MB	32%	8.0 KB
7	news.freedyn.net	1.9 MB	24.7 KB	2.3 MB	4.2 MB	45%	5.7 KB
8	news-out.mixmin.net	1.9 MB	27.0 KB	809.0 KB	2.7 MB	70%	2.8 KB
9	newsfeed.fu-berlin.de	1.8 MB	0.0 KB	591.6 KB	2.3 MB	75%	2.4 KB
10	newsfeed.neva.ru	1.5 MB	17.2 KB	1001.5 KB	2.5 MB	60%	2.7 KB
11	csiph-out.news.tnetconsulting.net	810.8 KB	3.9 KB	865.3 KB	1.6 MB	48%	3.6 KB
12	news.fcku.it	539.4 KB	0.0 KB	8.6 KB	548.0 KB	98%	1.6 KB
13	csiph-out.feed.uzoreto.com	518.8 KB	7.5 KB	9.9 MB	10.4 MB	4%	24.0 KB
14	news-out.neodome.net	268.7 KB	5.2 KB	63.0 KB	337.0 KB	79%	2.9 KB
15	news.swapon.de	88.9 KB	0.0 KB	0.0 KB	88.9 KB	100%	2.7 KB
16	nntp.pasdenom.info	70.1 KB	21.8 KB	107.9 KB	199.8 KB	35%	2.2 KB
17	news.bbs.nz	51.2 KB	0.0 KB	0.0 KB	51.2 KB	100%	4.3 KB
18	news.samoylyk.net	7.2 KB	5.3 KB	5.3 KB	17.9 KB	40%	3.0 KB
19	localhost	1.0 KB	0.0 KB	0.0 KB	1.0 KB	100%	1.0 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		47.3 MB	222.2 KB	48.0 MB	95.5 MB	49%	5.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 3 04:15:00 - 04:59:59	238	1.5%	0.09	784.8 KB	1.6%	0.29
Mar 3 05:00:00 - 05:59:59	369	2.3%	0.10	1.4 MB	2.9%	0.39
Mar 3 06:00:00 - 06:59:59	440	2.7%	0.12	2.7 MB	5.8%	0.78
Mar 3 07:00:00 - 07:59:59	462	2.9%	0.13	1.6 MB	3.3%	0.45
Mar 3 08:00:00 - 08:59:59	670	4.2%	0.19	1.8 MB	3.8%	0.52
Mar 3 09:00:00 - 09:59:59	761	4.7%	0.21	2.1 MB	4.3%	0.59
Mar 3 10:00:00 - 10:59:59	761	4.7%	0.21	2.0 MB	4.2%	0.57
Mar 3 11:00:00 - 11:59:59	793	4.9%	0.22	2.3 MB	4.9%	0.66
Mar 3 12:00:00 - 12:59:59	728	4.5%	0.20	1.9 MB	4.0%	0.54
Mar 3 13:00:00 - 13:59:59	893	5.5%	0.25	2.3 MB	4.8%	0.64
Mar 3 14:00:00 - 14:59:59	891	5.5%	0.25	2.3 MB	4.8%	0.65
Mar 3 15:00:00 - 15:59:59	963	6.0%	0.27	2.8 MB	5.8%	0.78
Mar 3 16:00:00 - 16:59:59	876	5.4%	0.24	2.2 MB	4.6%	0.62
Mar 3 17:00:00 - 17:59:59	865	5.4%	0.24	2.4 MB	5.1%	0.69
Mar 3 18:00:00 - 18:59:59	1018	6.3%	0.28	2.7 MB	5.7%	0.77
Mar 3 19:00:00 - 19:59:59	992	6.2%	0.28	3.2 MB	6.7%	0.91
Mar 3 20:00:00 - 20:59:59	794	4.9%	0.22	2.3 MB	4.9%	0.66
Mar 3 21:00:00 - 21:59:59	715	4.4%	0.20	1.8 MB	3.7%	0.51
Mar 3 22:00:00 - 22:59:59	760	4.7%	0.21	2.1 MB	4.4%	0.60
Mar 3 23:00:00 - 23:59:59	500	3.1%	0.14	2.0 MB	4.1%	0.56
Mar 4 00:00:00 - 00:59:59	451	2.8%	0.13	1.4 MB	2.9%	0.39
Mar 4 01:00:00 - 01:59:59	345	2.1%	0.10	1001.1 KB	2.1%	0.28
Mar 4 02:00:00 - 02:59:59	401	2.5%	0.11	1.1 MB	2.2%	0.30
Mar 4 03:00:00 - 03:59:59	321	2.0%	0.09	1.3 MB	2.7%	0.37
Mar 4 04:00:00 - 04:15:00	103	0.6%	0.11	383.3 KB	0.8%	0.43
TOTAL: 24:00:00	16110	100.0%	0.19	47.7 MB	100.0%	0.56

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	990	42	2	946
2	newsfeed.fu-berlin.de	500	33	0	467
3	csiph-out.feeder.erje.net	378	59	6	313
4	news-out.mixmin.net	329	0	3	326
5	csiph-out.feed.uzoreto.com	309	3	2	304
6	news-out.aioe.org	251	105	3	143
7	newsfeed.neva.ru	235	58	7	170
8	feeder.eternal-september.org	212	19	3	190
9	news.freedyn.net	175	7	3	165
10	csiph-out.news.weretis.net	134	57	3	74
11	csiph-out.news.tnetconsulting.net	130	20	1	109
12	nntp.pasdenom.info	63	0	1	62
13	newsfeeds.xmission.com	22	1	2	19
14	news.fcku.it	8	8	0	0
15	news-out.neodome.net	7	0	2	5
16	news.swapon.de	4	0	0	4
17	news.samoylyk.net	2	0	2	0
TOTAL: 17		3749	412	40	3297

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	50
alt.bbs.synchronet	42
lada.talk	40
it-alt.sport.calcio.juventus	34
alt.binaries.pictures.purebeauty	32
mozilla.support.seamonkey	22
alt.politics.usa	20
alt.windows7.general	17
spline.eisfair	12
alt.survival	8
mozilla.dev.security.policy	8
alt.music.pink-floyd.publius	8
it-alt.comp.software.openoffice	6
mozilla.support.thunderbird	5
lada.commerce	5
lada.auto	4
alt.philosophy	4
mozilla.test	4
al.christnet.bible	3
alt.binaries.ebook	3
TOTAL: 79	412

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1576
EMP (phn path)	214
EMP (phn nph)	162
EMP (phl)	139
0	138
HTML Multipart	29
Too many newsgroups	19
Scoring filter	7
Binary: misplaced binary	5
Binary Payload	5
Too many newsgroups (meow)	1
TOTAL: 11	2295

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	csiph-out.feed.uzoreto.com	2
	csiph-out.news.xs4all.nl	1
	TOTAL: 3	53
Huge articles
	csiph-out.news.xs4all.nl	186
	csiph-out.feeder.erje.net	172
	csiph-out.feed.uzoreto.com	109
	csiph-out.news.weretis.net	38
	news.freedyn.net	17
	newsfeeds.xmission.com	14
	news-out.mixmin.net	4
	feeder.eternal-september.org	4
	csiph-out.news.tnetconsulting.net	2
	newsfeed.fu-berlin.de	1
	TOTAL: 10	547
Including strange strings
	newsfeed.fu-berlin.de	303
	news-out.aioe.org	117
	csiph-out.news.weretis.net	10
	newsfeeds.xmission.com	5
	news.freedyn.net	4
	news.swapon.de	4
	csiph-out.news.xs4all.nl	4
	newsfeed.neva.ru	3
	news-out.mixmin.net	3
	news-out.neodome.net	1
	TOTAL: 12	456
No colon-space in header
	csiph-out.news.xs4all.nl	1
	TOTAL: 1	1
TOTAL: 4		1057

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18946	886	15213	10	43	4%	23:59:56
2	fu-berlin.de	15306	538	14768	0	0	3%	23:59:01
3	news.samoylyk.net	16707	530	15569	5	0	3%	23:59:56
4	news.freedyn.net	15797	527	14887	13	0	3%	23:59:45
5	news.bbs.nz	30344	388	15173	1	1	1%	23:59:54
6	usenet.pasdenom.info	16168	143	15381	26	0	0%	23:59:56
7	tnet	16677	124	15453	0	0	0%	23:59:56
8	neva.ru	14933	51	14599	97	0	0%	23:59:38
9	newsfeed.xs4all.nl	15486	47	15038	5	91	0%	23:59:55
10	aioe	11910	27	11434	2	0	0%	23:59:48
11	neodome.net	16533	11	15947	0	0	0%	23:59:56
12	news.mixmin.net	15270	10	14760	0	0	0%	23:59:56
13	news.uzoreto.com	15794	4	15457	12	0	0%	23:59:52
14	xmission	12981	4	11059	1	0	0%	23:59:05
15	erje	15351	3	15060	23	4	0%	23:59:56
16	news.swapon.de	1672	2	1648	0	0	0%	23:59:24
17	weretis.net	14914	1	14759	0	0	0%	23:59:51
18	eternal-september	13736	1	13229	0	0	0%	23:59:56
19	news.fcku.it	2054	0	2046	0	0	0%	21:59:41
TOTAL: 19		280579	3297	251480	195	139	1%	453:55:22

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.2 MB	29.3 KB	7.2 MB	0.1 KB/s	8.2 KB	23:59:56
2	news.freedyn.net	6.4 MB	19.1 KB	6.4 MB	0.1 KB/s	12.1 KB	23:59:45
3	fu-berlin.de	6.4 MB	0.0 KB	6.4 MB	0.1 KB/s	12.1 KB	23:59:01
4	news.samoylyk.net	6.3 MB	4.7 KB	6.3 MB	0.1 KB/s	12.1 KB	23:59:56
5	news.bbs.nz	958.7 KB	1.4 KB	960.1 KB	0.0 KB/s	2.5 KB	23:59:54
6	usenet.pasdenom.info	319.3 KB	171.8 KB	491.1 KB	0.0 KB/s	2.9 KB	23:59:56
7	tnet	268.5 KB	0.0 KB	268.5 KB	0.0 KB/s	2.2 KB	23:59:56
8	newsfeed.xs4all.nl	137.4 KB	14.4 KB	151.8 KB	0.0 KB/s	2.9 KB	23:59:55
9	neva.ru	93.9 KB	180.1 KB	274.0 KB	0.0 KB/s	1.9 KB	23:59:38
10	news.mixmin.net	59.1 KB	0.0 KB	59.1 KB	0.0 KB/s	5.9 KB	23:59:56
11	aioe	56.3 KB	2.0 KB	58.3 KB	0.0 KB/s	2.0 KB	23:59:48
12	news.uzoreto.com	26.3 KB	24.9 KB	51.2 KB	0.0 KB/s	3.2 KB	23:59:52
13	neodome.net	23.5 KB	0.0 KB	23.5 KB	0.0 KB/s	2.1 KB	23:59:56
14	news.swapon.de	13.3 KB	0.0 KB	13.3 KB	0.0 KB/s	6.7 KB	23:59:24
15	xmission	7.1 KB	1.5 KB	8.7 KB	0.0 KB/s	1.7 KB	23:59:05
16	erje	6.1 KB	77.5 KB	83.6 KB	0.0 KB/s	3.2 KB	23:59:56
17	weretis.net	1.0 KB	0.0 KB	1.0 KB	0.0 KB/s	1.0 KB	23:59:51
18	eternal-september	1.0 KB	0.0 KB	1.0 KB	0.0 KB/s	1.0 KB	23:59:56
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:59:41
TOTAL: 19		28.2 MB	526.9 KB	28.7 MB	0.0 KB/s	8.4 KB	453:55:22

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	p2e5b5b21.dip0.t-ipconnect.de	1	16	22.5 KB	2	0	0	00:00:22
2	a131033.upc-a.chello.nl	13	9	10.1 KB	2	0	0	03:14:32
3	68-190-164-53.dhcp.eucl.wi.charter.com	18	2	2.4 KB	2	1	1	05:46:06
TOTAL: 3		32	27	35.0 KB	6	1	1	35:48:35

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dip0.t-ipconnect.de	1	16	22.5 KB	2	0	0	00:00:22
2	*.upc-a.chello.nl	13	9	10.1 KB	2	0	0	03:14:32
3	*.dhcp.eucl.wi.charter.com	18	2	2.4 KB	2	1	1	05:46:06
4	unresolved	73	0	0.0 KB	0	0	0	23:57:12
5	*.nat.epc.tmcz.cz	1	0	0.0 KB	0	0	0	00:20:05
6	*.ph.ph.cox.net	3	0	0.0 KB	0	0	0	02:30:16
TOTAL: 6		109	27	35.0 KB	6	1	1	35:48:35

NNRP auth users [Top 20]:

User	Conn
ohlandl	1
ctomczyk	1
TOTAL: 2	2

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.621	1.139	0.000	23:57:12
68-190-164-53.dhcp.eucl.wi.charter.com	1.222	0.259	0.003	05:46:06
a131033.upc-a.chello.nl	0.941	0.166	0.000	03:14:32
ip72-222-200-117.ph.ph.cox.net	0.504	0.124	0.000	02:30:16
89-24-34-212.nat.epc.tmcz.cz	0.070	0.009	0.003	00:20:05
p2e5b5b21.dip0.t-ipconnect.de	0.121	0.097	0.000	00:00:22
TOTAL: 6	7.479	1.794	0.006	35:48:35

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	73
ip72-222-200-117.ph.ph.cox.net	3
89-24-34-212.nat.epc.tmcz.cz	1
TOTAL: 3	77

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-53.dhcp.eucl.wi.charter.com	7	0
ip72-222-200-117.ph.ph.cox.net	5	0
89-24-34-212.nat.epc.tmcz.cz	1	1
TOTAL: 3	13	1

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	15	55.6%
2	comp	11	40.7%
3	de	1	3.7%
TOTAL: 3		27	100.0%

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

Newsgroup		Count
1	alt.free.newsservers	15
2	comp.sys.ibm.ps2.hardware	11
3	de.sci.electronics	1
TOTAL: 3		27

Daily Usenet report for csiph.com

Mar 3 04:15:00 -- Mar 4 04:15:00