Daily Usenet report for csiph.com: Feb 4 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19857	48.2%	5.2 MB	64.0%
innd	17315	42.0%	2.3 MB	27.7%
innfeed	3506	8.5%	632.9 KB	7.5%
nnrpd	502	1.2%	56.1 KB	0.7%
nocem	50	0.1%	5.9 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	41231	100.0%	8.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	335938	58.4%
Negative hits	219960	38.2%
Do not exist	19225	3.3%
Cache misses	198	0.0%
TOTAL: 4	575321	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.224	0.0%	21	0.000	10.667	23.667
article cleanup	00:00:00.122	0.0%	19005	0.000	0.006	0.030
article logging	00:00:00.275	0.0%	19533	0.000	0.014	0.219
article parse	00:00:00.841	0.0%	57511	0.000	0.015	0.085
article write	00:00:08.252	0.0%	16429	0.137	0.502	20.812
artlog/artcncl	00:00:00.001	0.0%	21	0.000	0.048	0.333
artlog/artparse	00:00:00.017	0.0%	311	0.000	0.055	0.923
data move	00:00:00.175	0.0%	540308	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.007	0.0%	21	0.000	0.333	1.000
hishave/artcncl	00:00:00.003	0.0%	21	0.000	0.143	1.000
hishave/artparse	00:00:00.001	0.0%	307	0.000	0.003	0.143
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:05.186	0.0%	577336	0.001	0.009	0.176
history sync	00:00:00.856	0.0%	381	0.000	2.247	19.250
history write	00:00:11.257	0.0%	19006	0.017	0.592	5.935
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.276	0.0%	304	0.000	0.908	5.000
idle	23:59:10.560	99.9%	550322	91.274	156.909	394.983
nntp read	00:00:02.021	0.0%	550954	0.001	0.004	0.007
overview write	00:00:28.296	0.0%	16429	0.101	1.722	29.479
perl filter	00:00:24.934	0.0%	19002	1.056	1.312	1.905
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.282	0.0%	32908	0.000	0.009	0.031
TOTAL: 24:01:05.492	24:00:33.586	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.046	0.0%	16735	0.000	0.003	0.030
article prepare	00:00:00.000	0.0%	13876	0.000	0.000	0.000
article read	00:00:00.224	0.0%	1434	0.000	0.156	22.500
backlog stats	00:00:00.213	0.0%	400068	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.436	0.0%	310144	0.001	0.005	0.011
data write	00:00:01.714	0.0%	296195	0.001	0.006	0.010
idle	23:54:44.226	100.0%	400068	134.666	215.174	619.663
status file	00:00:00.186	0.0%	270	0.000	0.689	7.000
TOTAL: 23:54:55.707	23:54:48.045	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	22:38:06.710	100.0%	356	332.000	228895.253	900156.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.621	0.0%	94648	0.000	0.007	0.167
readart	00:00:00.134	0.0%	32	0.000	4.188	41.000
TOTAL: 22:38:25.723	22:38:07.465	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1438	77993	4417	73339	237	5%	118:49:41
2	news-out.aioe.org	3	16158	2982	13075	101	18%	24:09:41
3	feeder.eternal-september.org	4	17488	2225	15041	222	12%	22:53:28
4	newsfeeds.xmission.com	2	15109	1080	14008	21	7%	21:59:13
5	news-out.mixmin.net	2	17314	884	15942	488	5%	23:59:42
6	newsfeed.fu-berlin.de	15	15301	857	14383	61	5%	24:34:16
7	newsfeed.neva.ru	149	17331	854	16128	349	4%	71:52:49
8	csiph-out.news.weretis.net	4	19962	779	19052	131	3%	31:51:38
9	csiph-out.news.xs4all.nl	862	17709	648	16375	686	3%	71:20:18
10	news.freedyn.net	2	18744	486	18059	199	2%	24:08:58
11	news.fcku.it	9	2441	378	2059	4	15%	23:03:37
12	csiph-out.feed.uzoreto.com	864	25712	205	25223	284	0%	71:11:59
13	news-out.neodome.net	2	17433	96	17291	46	0%	23:59:52
14	nntp.pasdenom.info	2	11516	87	11419	10	0%	23:57:55
15	news.swapon.de	5	1408	33	1373	2	2%	22:02:11
16	csiph-out.news.tnetconsulting.net	1	16272	29	16234	9	0%	23:59:56
17	news.samoylyk.net	4	16663	10	16644	9	0%	25:42:40
18	news.bbs.nz	2	15986	6	15980	0	0%	23:59:39
19	localhost	28	2	2	0	0	100%	00:00:03
20	xanadu-bbs.net	67	473	0	473	0	0%	65:17:45
TOTAL: 20		3465	341015	16058	322098	2859	4%	738:55:21

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	14.0 MB	0.0 KB	478.3 KB	14.4 MB	96%	3.2 KB
2	news-out.aioe.org	7.4 MB	0.0 KB	384.9 KB	7.8 MB	95%	2.6 KB
3	feeder.eternal-september.org	6.0 MB	5.2 KB	2.5 MB	8.5 MB	70%	3.5 KB
4	newsfeeds.xmission.com	3.8 MB	0.0 KB	1.4 MB	5.3 MB	72%	4.9 KB
5	news-out.mixmin.net	2.5 MB	0.0 KB	943.7 KB	3.5 MB	73%	2.6 KB
6	csiph-out.news.weretis.net	2.5 MB	0.0 KB	2.6 MB	5.1 MB	48%	5.7 KB
7	newsfeed.neva.ru	2.0 MB	0.0 KB	834.2 KB	2.8 MB	71%	2.4 KB
8	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	240.1 KB	2.2 MB	89%	2.5 KB
9	csiph-out.news.xs4all.nl	1.9 MB	0.0 KB	10.2 MB	12.1 MB	15%	9.3 KB
10	news.freedyn.net	1.3 MB	0.0 KB	1.1 MB	2.4 MB	53%	3.6 KB
11	csiph-out.feed.uzoreto.com	768.7 KB	0.0 KB	7.1 MB	7.8 MB	9%	16.4 KB
12	news.fcku.it	612.0 KB	0.0 KB	4.6 KB	616.6 KB	99%	1.6 KB
13	news-out.neodome.net	321.9 KB	0.0 KB	1.7 MB	2.0 MB	15%	14.3 KB
14	nntp.pasdenom.info	198.8 KB	0.0 KB	18.1 KB	216.9 KB	91%	2.2 KB
15	csiph-out.news.tnetconsulting.net	121.1 KB	0.0 KB	85.6 KB	206.7 KB	58%	5.4 KB
16	news.swapon.de	112.2 KB	0.0 KB	849.4 KB	961.6 KB	11%	27.5 KB
17	news.samoylyk.net	44.1 KB	0.0 KB	1.9 MB	2.0 MB	2%	107.0 KB
18	news.bbs.nz	26.3 KB	0.0 KB	0.0 KB	26.3 KB	100%	4.4 KB
19	localhost	6.4 KB	0.0 KB	0.0 KB	6.4 KB	100%	3.2 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		45.5 MB	5.2 KB	32.3 MB	77.8 MB	58%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 4 04:15:00 - 04:59:59	218	1.3%	0.08	686.0 KB	1.4%	0.25
Feb 4 05:00:00 - 05:59:59	379	2.3%	0.11	1.4 MB	3.0%	0.39
Feb 4 06:00:00 - 06:59:59	415	2.5%	0.12	1.1 MB	2.4%	0.31
Feb 4 07:00:00 - 07:59:59	520	3.2%	0.14	1.5 MB	3.2%	0.42
Feb 4 08:00:00 - 08:59:59	569	3.5%	0.16	1.5 MB	3.2%	0.43
Feb 4 09:00:00 - 09:59:59	777	4.7%	0.22	1.9 MB	4.1%	0.54
Feb 4 10:00:00 - 10:59:59	764	4.7%	0.21	1.8 MB	4.0%	0.52
Feb 4 11:00:00 - 11:59:59	755	4.6%	0.21	2.3 MB	5.0%	0.66
Feb 4 12:00:00 - 12:59:59	758	4.6%	0.21	2.0 MB	4.2%	0.56
Feb 4 13:00:00 - 13:59:59	882	5.4%	0.24	2.3 MB	4.9%	0.64
Feb 4 14:00:00 - 14:59:59	894	5.4%	0.25	2.4 MB	5.2%	0.68
Feb 4 15:00:00 - 15:59:59	993	6.0%	0.28	3.1 MB	6.7%	0.89
Feb 4 16:00:00 - 16:59:59	1018	6.2%	0.28	2.9 MB	6.2%	0.83
Feb 4 17:00:00 - 17:59:59	963	5.9%	0.27	2.3 MB	5.0%	0.66
Feb 4 18:00:00 - 18:59:59	911	5.5%	0.25	2.3 MB	5.0%	0.66
Feb 4 19:00:00 - 19:59:59	905	5.5%	0.25	2.7 MB	5.8%	0.76
Feb 4 20:00:00 - 20:59:59	821	5.0%	0.23	2.1 MB	4.6%	0.60
Feb 4 21:00:00 - 21:59:59	823	5.0%	0.23	2.6 MB	5.5%	0.73
Feb 4 22:00:00 - 22:59:59	768	4.7%	0.21	2.2 MB	4.7%	0.62
Feb 4 23:00:00 - 23:59:59	605	3.7%	0.17	2.0 MB	4.2%	0.56
Feb 5 00:00:00 - 00:59:59	513	3.1%	0.14	1.6 MB	3.5%	0.47
Feb 5 01:00:00 - 01:59:59	410	2.5%	0.11	1.5 MB	3.2%	0.43
Feb 5 02:00:00 - 02:59:59	324	2.0%	0.09	866.4 KB	1.8%	0.24
Feb 5 03:00:00 - 03:59:59	356	2.2%	0.10	1.3 MB	2.8%	0.37
Feb 5 04:00:00 - 04:15:00	81	0.5%	0.09	207.4 KB	0.4%	0.23
TOTAL: 24:00:00	16422	100.0%	0.19	46.5 MB	100.0%	0.55

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	688	25	0	663
2	news-out.mixmin.net	491	18	0	473
3	newsfeed.fu-berlin.de	477	40	0	437
4	newsfeed.neva.ru	349	35	0	314
5	csiph-out.feed.uzoreto.com	285	8	0	277
6	csiph-out.feeder.erje.net	243	79	0	164
7	feeder.eternal-september.org	232	17	2	213
8	news.freedyn.net	203	1	0	202
9	news-out.aioe.org	178	67	0	111
10	csiph-out.news.weretis.net	164	66	0	98
11	news-out.neodome.net	46	0	0	46
12	newsfeeds.xmission.com	25	1	0	24
13	nntp.pasdenom.info	10	0	0	10
14	news.samoylyk.net	9	0	0	9
15	csiph-out.news.tnetconsulting.net	7	3	1	3
16	news.fcku.it	4	3	0	1
17	news.swapon.de	3	0	0	3
TOTAL: 17		3414	363	3	3048

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	126
alt.politics.usa	30
it-alt.sport.calcio.juventus	15
alt.bbs.synchronet	13
alt.religion	11
spline.eisfair	10
lada.commerce	10
oesterreich.tratsch	9
lada.auto	9
alt.binaries.pictures.purebeauty	7
mozilla.support.thunderbird	6
alt.binaries.ebooks	6
mozilla.support.seamonkey	6
alt.survival	5
alt.politics	5
mozilla.general	4
alt.philosophy	4
lada.photo	4
free.it.religioni.scientology	3
lada.talk	3
TOTAL: 76	363

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1556
EMP (phl)	195
EMP (phn nph)	175
EMP (phn path)	150
0	72
HTML Multipart	27
Too many newsgroups	22
Scoring filter	8
Binary: misplaced binary	3
U2 violation - invalid distribution	2
Too many newsgroups (low_xpost)	1
HTML post	1
TOTAL: 12	2212

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	44
	TOTAL: 1	44
Huge articles
	csiph-out.news.xs4all.nl	113
	csiph-out.feed.uzoreto.com	74
	news-out.neodome.net	31
	csiph-out.news.weretis.net	30
	newsfeeds.xmission.com	21
	news.freedyn.net	10
	news.samoylyk.net	7
	feeder.eternal-september.org	7
	news-out.mixmin.net	3
	csiph-out.news.tnetconsulting.net	3
	TOTAL: 12	303
Including strange strings
	newsfeed.fu-berlin.de	401
	news-out.aioe.org	82
	csiph-out.news.weretis.net	24
	csiph-out.feeder.erje.net	5
	news.freedyn.net	5
	news-out.mixmin.net	4
	csiph-out.news.xs4all.nl	4
	newsfeeds.xmission.com	2
	news.swapon.de	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 10	529
No colon-space in header
	csiph-out.news.xs4all.nl	3
	csiph-out.feeder.erje.net	1
	TOTAL: 2	4
TOTAL: 4		880

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	21258	875	15547	0	0	4%	23:59:55
2	news.freedyn.net	16258	595	15296	25	0	3%	23:59:27
3	news.samoylyk.net	17211	422	15988	2	184	2%	23:59:54
4	fu-berlin.de	15356	398	14957	0	0	2%	23:59:54
5	news.bbs.nz	31297	340	15655	2	1	1%	23:59:12
6	usenet.pasdenom.info	16763	199	15694	22	25	1%	23:59:54
7	aioe	12888	67	12268	0	0	0%	23:59:50
8	tnet	18705	59	15943	0	0	0%	23:59:50
9	newsfeed.xs4all.nl	16616	55	15602	13	130	0%	23:59:54
10	news.uzoreto.com	16315	36	15763	106	0	0%	23:59:54
11	neva.ru	15109	30	14774	131	0	0%	23:58:49
12	neodome.net	16908	27	16207	0	0	0%	23:59:54
13	erje	13958	23	11879	4	0	0%	23:59:51
14	news.mixmin.net	15585	10	14929	0	0	0%	23:59:26
15	weretis.net	15417	8	14945	1	0	0%	23:59:44
16	eternal-september	14196	6	13559	0	0	0%	23:59:48
17	xmission	17224	5	14786	0	0	0%	23:59:55
18	news.swapon.de	1516	2	1495	0	0	0%	23:43:34
19	news.fcku.it	1877	0	1857	0	0	0%	22:25:30
TOTAL: 19		294457	3157	257144	306	340	1%	454:04:15

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	4.6 MB	0.0 KB	4.6 MB	0.1 KB/s	5.4 KB	23:59:55
2	news.freedyn.net	3.9 MB	50.7 KB	4.0 MB	0.0 KB/s	6.6 KB	23:59:27
3	news.samoylyk.net	3.3 MB	1.8 KB	3.3 MB	0.0 KB/s	7.9 KB	23:59:54
4	fu-berlin.de	3.2 MB	0.0 KB	3.2 MB	0.0 KB/s	8.3 KB	23:59:54
5	news.bbs.nz	912.7 KB	10.1 KB	922.8 KB	0.0 KB/s	2.7 KB	23:59:12
6	usenet.pasdenom.info	707.9 KB	207.4 KB	915.3 KB	0.0 KB/s	4.1 KB	23:59:54
7	newsfeed.xs4all.nl	220.0 KB	69.8 KB	289.7 KB	0.0 KB/s	4.3 KB	23:59:54
8	aioe	210.9 KB	0.0 KB	210.9 KB	0.0 KB/s	3.1 KB	23:59:50
9	erje	210.3 KB	50.2 KB	260.6 KB	0.0 KB/s	9.7 KB	23:59:51
10	neodome.net	181.4 KB	0.0 KB	181.4 KB	0.0 KB/s	6.7 KB	23:59:54
11	tnet	140.7 KB	0.0 KB	140.7 KB	0.0 KB/s	2.4 KB	23:59:50
12	news.uzoreto.com	108.8 KB	419.9 KB	528.7 KB	0.0 KB/s	3.7 KB	23:59:54
13	neva.ru	66.2 KB	294.4 KB	360.6 KB	0.0 KB/s	2.2 KB	23:58:49
14	eternal-september	29.5 KB	0.0 KB	29.5 KB	0.0 KB/s	4.9 KB	23:59:48
15	weretis.net	27.8 KB	37.3 KB	65.1 KB	0.0 KB/s	7.2 KB	23:59:44
16	news.mixmin.net	22.7 KB	0.0 KB	22.7 KB	0.0 KB/s	2.3 KB	23:59:26
17	xmission	15.2 KB	0.0 KB	15.2 KB	0.0 KB/s	3.0 KB	23:59:55
18	news.swapon.de	6.4 KB	0.0 KB	6.4 KB	0.0 KB/s	3.2 KB	23:43:34
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:25:30
TOTAL: 19		17.9 MB	1.1 MB	19.0 MB	0.0 KB/s	5.6 KB	454:04:15

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	56	14	30.5 KB	2	0	0	13:03:02
2	69.160.37.57	1	11	22.0 KB	1	0	0	00:11:00
3	66-188-80-165.dhcp.mdsn.wi.charter.com	23	4	10.8 KB	3	3	1	08:32:56
4	cpc78679-glfd7-2-0-cust204.6-2.cable.virginm.net	1	3	5.9 KB	1	0	0	00:01:02
TOTAL: 4		81	32	69.2 KB	7	3	1	22:38:25

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	56	14	30.5 KB	2	0	0	13:03:02
2	unresolved	9	11	22.0 KB	1	0	0	00:41:18
3	*.dhcp.mdsn.wi.charter.com	23	4	10.8 KB	3	3	1	08:32:56
4	*.6-2.cable.virginm.net	1	3	5.9 KB	1	0	0	00:01:02
5	*.nat.epc.tmcz.cz	1	0	0.0 KB	0	0	0	00:20:05
TOTAL: 5		90	32	69.2 KB	7	3	1	22:38:25

NNRP auth users [Top 20]:

User	Conn
ctomczyk	1
kev009	1
ohlandl	1
timc	1
TOTAL: 4	4

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	3.678	0.876	0.000	13:03:02
66-188-80-165.dhcp.mdsn.wi.charter.com	1.515	0.380	0.005	08:32:56
183.134.104.171	0.039	0.039	0.000	00:30:00
78-80-29-75.nat.epc.tmcz.cz	0.063	0.016	0.002	00:20:05
69.160.37.57	0.387	1.030	0.003	00:11:00
cpc78679-glfd7-2-0-cust204.6-2.cable.virginm.net	0.105	0.016	0.002	00:01:02
162.243.128.69	0.068	0.008	0.000	00:00:09
94.160.29.122	0.288	0.087	0.000	00:00:05
94.165.155.23	0.060	0.017	0.000	00:00:01
TOTAL: 9	6.203	2.469	0.012	22:38:25

Curious NNRP server explorers [Top 20]:

System	Conn
94.160.29.122	5
183.134.104.171	1
162.243.128.69	1
78-80-29-75.nat.epc.tmcz.cz	1
94.165.155.23	1
TOTAL: 5	9

NNRP unrecognized commands (by host):

System	Conn
183.134.104.171	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
66-188-80-165.dhcp.mdsn.wi.charter.com	11	0
78-80-29-75.nat.epc.tmcz.cz	1	1
183.134.104.171	1	0
TOTAL: 3	13	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	29
2	comp.os.os2.misc	3
TOTAL: 2		32

Daily Usenet report for csiph.com

Feb 4 04:15:00 -- Feb 5 04:15:00