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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19213	47.1%	4.9 MB	63.3%
innd	17651	43.3%	2.2 MB	28.9%
innfeed	3501	8.6%	576.2 KB	7.3%
nnrpd	324	0.8%	37.6 KB	0.5%
nocem	64	0.2%	7.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40754	100.0%	7.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	274388	56.9%
Negative hits	188933	39.2%
Do not exist	18503	3.8%
Cache misses	228	0.0%
TOTAL: 4	482052	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.029	0.0%	134	0.000	0.216	1.000
article cleanup	00:00:00.107	0.0%	17837	0.000	0.006	0.044
article logging	00:00:00.244	0.0%	18250	0.000	0.013	0.052
article parse	00:00:00.925	0.0%	70782	0.000	0.013	0.040
article write	00:00:05.423	0.0%	15069	0.163	0.360	2.081
artlog/artcncl	00:00:00.000	0.0%	102	0.000	0.000	0.000
artlog/artparse	00:00:00.010	0.0%	699	0.000	0.014	0.250
data move	00:00:00.144	0.0%	465383	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.003	0.0%	129	0.000	0.023	0.500
hishave/artcncl	00:00:00.000	0.0%	134	0.000	0.000	0.000
hishave/artparse	00:00:00.001	0.0%	699	0.000	0.001	0.125
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.254	0.0%	482163	0.001	0.007	0.016
history sync	00:00:00.679	0.0%	370	0.000	1.835	5.500
history write	00:00:08.373	0.0%	17831	0.042	0.470	2.689
hiswrite/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hiswrite/artparse	00:00:00.301	0.0%	699	0.000	0.431	1.500
idle	23:49:11.435	99.9%	473965	101.961	180.924	553.665
nntp read	00:00:01.777	0.0%	472649	0.001	0.004	0.007
overview write	00:00:22.532	0.0%	15069	0.109	1.495	247.295
perl filter	00:00:31.402	0.0%	17831	1.148	1.761	5.641
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.246	0.0%	30196	0.000	0.008	0.039
TOTAL: 23:51:00.112	23:50:26.885	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.038	0.0%	15162	0.000	0.003	0.031
article prepare	00:00:00.003	0.0%	19642	0.000	0.000	0.010
article read	00:00:00.318	0.0%	1775	0.000	0.179	11.500
backlog stats	00:00:00.218	0.0%	336852	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.201	0.0%	256241	0.000	0.005	0.012
data write	00:00:01.630	0.0%	239949	0.002	0.007	0.016
idle	23:53:41.341	100.0%	336852	139.128	255.368	824.163
status file	00:00:00.244	0.0%	338	0.000	0.722	2.000
TOTAL: 23:53:51.638	23:53:44.993	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	10:39:06.265	100.0%	252	214.500	152167.718	450647.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.001	0.0%	596	0.000	0.002	0.143
readart	00:00:00.305	0.0%	18	0.000	16.944	47.000
TOTAL: 10:39:18.858	10:39:06.571	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
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	15107	2725	12364	18	18%	26:38:41
2	feeder.eternal-september.org	4	16708	2085	14567	56	12%	25:23:26
3	csiph-out.news.xs4all.nl	860	16601	1715	13879	1007	10%	71:24:27
4	news.freedyn.net	2	17643	1662	14951	1030	9%	24:09:02
5	csiph-out.news.weretis.net	5	29907	1609	28063	235	5%	47:30:16
6	news-out.aioe.org	3	14458	1418	13035	5	9%	24:09:54
7	csiph-out.feeder.erje.net	1440	71731	1206	70172	353	1%	118:41:09
8	newsfeed.fu-berlin.de	9	14146	887	13163	96	6%	25:25:26
9	news-out.mixmin.net	2	15580	857	14542	181	5%	23:59:43
10	newsfeed.neva.ru	146	17710	608	16802	300	3%	72:04:14
11	csiph-out.feed.uzoreto.com	864	23417	352	22845	220	1%	71:11:45
12	news.fcku.it	16	1174	72	1101	1	6%	22:11:55
13	nntp.pasdenom.info	2	10075	66	10001	8	0%	23:59:23
14	news.swapon.de	10	1348	30	1318	0	2%	24:45:47
15	news.samoylyk.net	2	14416	21	14394	1	0%	23:59:37
16	news.bbs.nz	1	13137	8	13129	0	0%	23:59:53
17	localhost	38	6	6	0	0	100%	00:00:09
18	xanadu-bbs.net	42	325	2	323	0	0%	21:33:03
TOTAL: 18		3449	293489	15329	274649	3511	5%	671:07:50

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	9.4 MB	0.0 KB	13.0 MB	22.4 MB	41%	14.7 KB
2	newsfeeds.xmission.com	8.0 MB	0.0 KB	395.7 KB	8.4 MB	95%	3.1 KB
3	feeder.eternal-september.org	5.5 MB	0.0 KB	679.8 KB	6.2 MB	89%	3.0 KB
4	csiph-out.news.weretis.net	5.2 MB	1.3 KB	1.9 MB	7.1 MB	73%	3.9 KB
5	csiph-out.news.xs4all.nl	4.8 MB	35.3 KB	10.8 MB	15.6 MB	30%	5.9 KB
6	news.freedyn.net	4.4 MB	10.6 KB	46.1 MB	50.4 MB	8%	19.2 KB
7	news-out.aioe.org	3.6 MB	0.0 KB	10.3 KB	3.6 MB	99%	2.6 KB
8	news-out.mixmin.net	2.4 MB	4.7 KB	467.9 KB	2.8 MB	83%	2.8 KB
9	newsfeed.fu-berlin.de	2.1 MB	0.0 KB	285.2 KB	2.4 MB	88%	2.5 KB
10	newsfeed.neva.ru	1.5 MB	1.4 KB	1.0 MB	2.6 MB	59%	2.9 KB
11	csiph-out.feed.uzoreto.com	1.2 MB	0.0 KB	4.1 MB	5.3 MB	22%	9.5 KB
12	nntp.pasdenom.info	145.4 KB	0.0 KB	14.3 KB	159.6 KB	91%	2.2 KB
13	news.fcku.it	134.0 KB	0.0 KB	64.1 KB	198.1 KB	67%	2.7 KB
14	news.swapon.de	83.7 KB	0.0 KB	0.0 KB	83.7 KB	100%	2.8 KB
15	news.samoylyk.net	76.5 KB	0.0 KB	40.6 KB	117.1 KB	65%	5.3 KB
16	news.bbs.nz	13.8 KB	0.0 KB	0.0 KB	13.8 KB	100%	1.7 KB
17	localhost	9.3 KB	0.0 KB	0.0 KB	9.3 KB	100%	1.6 KB
18	xanadu-bbs.net	4.0 KB	0.0 KB	0.0 KB	4.0 KB	100%	2.0 KB
TOTAL: 18		48.5 MB	53.4 KB	78.8 MB	127.4 MB	38%	6.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 8 04:15:00 - 04:59:59	204	1.3%	0.08	808.5 KB	1.6%	0.30
Sep 8 05:00:00 - 05:59:59	323	2.1%	0.09	986.0 KB	2.0%	0.27
Sep 8 06:00:00 - 06:59:59	449	3.0%	0.12	1.8 MB	3.8%	0.51
Sep 8 07:00:00 - 07:59:59	522	3.4%	0.14	1.7 MB	3.5%	0.48
Sep 8 08:00:00 - 08:59:59	645	4.3%	0.18	2.3 MB	4.8%	0.65
Sep 8 09:00:00 - 09:59:59	730	4.8%	0.20	3.5 MB	7.3%	1.00
Sep 8 10:00:00 - 10:59:59	682	4.5%	0.19	2.4 MB	5.0%	0.69
Sep 8 11:00:00 - 11:59:59	749	4.9%	0.21	2.2 MB	4.5%	0.61
Sep 8 12:00:00 - 12:59:59	715	4.7%	0.20	1.8 MB	3.8%	0.52
Sep 8 13:00:00 - 13:59:59	750	5.0%	0.21	1.9 MB	4.0%	0.55
Sep 8 14:00:00 - 14:59:59	824	5.4%	0.23	2.4 MB	5.0%	0.69
Sep 8 15:00:00 - 15:59:59	859	5.7%	0.24	2.8 MB	5.7%	0.78
Sep 8 16:00:00 - 16:59:59	1029	6.8%	0.29	3.1 MB	6.4%	0.88
Sep 8 17:00:00 - 17:59:59	838	5.5%	0.23	2.5 MB	5.2%	0.71
Sep 8 18:00:00 - 18:59:59	823	5.4%	0.23	2.5 MB	5.2%	0.71
Sep 8 19:00:00 - 19:59:59	807	5.3%	0.22	2.3 MB	4.8%	0.66
Sep 8 20:00:00 - 20:59:59	840	5.5%	0.23	2.6 MB	5.4%	0.74
Sep 8 21:00:00 - 21:59:59	753	5.0%	0.21	2.1 MB	4.3%	0.59
Sep 8 22:00:00 - 22:59:59	603	4.0%	0.17	2.0 MB	4.2%	0.57
Sep 8 23:00:00 - 23:59:59	439	2.9%	0.12	1.3 MB	2.7%	0.37
Sep 9 00:00:00 - 00:59:59	398	2.6%	0.11	1.1 MB	2.2%	0.30
Sep 9 01:00:00 - 01:59:59	411	2.7%	0.11	1.3 MB	2.6%	0.36
Sep 9 02:00:00 - 02:59:59	327	2.2%	0.09	1.3 MB	2.8%	0.38
Sep 9 03:00:00 - 03:59:59	310	2.0%	0.09	929.7 KB	1.9%	0.26
Sep 9 04:00:00 - 04:15:00	111	0.7%	0.12	592.8 KB	1.2%	0.66
TOTAL: 24:00:00	15141	100.0%	0.18	48.1 MB	100.0%	0.57

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1040	27	1	1012
2	news.freedyn.net	1028	14	2	1012
3	newsfeed.fu-berlin.de	459	26	0	433
4	csiph-out.feeder.erje.net	362	67	0	295
5	newsfeed.neva.ru	301	55	1	245
6	csiph-out.news.weretis.net	264	58	1	205
7	csiph-out.feed.uzoreto.com	221	5	0	216
8	news-out.mixmin.net	191	2	1	188
9	feeder.eternal-september.org	56	9	0	47
10	newsfeeds.xmission.com	15	1	0	14
11	news-out.aioe.org	10	4	0	6
12	nntp.pasdenom.info	7	0	0	7
13	news.swapon.de	6	0	0	6
14	news.fcku.it	1	0	0	1
TOTAL: 14		3961	268	6	3687

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	43
alt.binaries.pictures.purebeauty	33
alt.bbs.synchronet	29
spline.eisfair	17
alt.pl.nieruchomosci.gielda	11
alt.windows7.general	10
oesterreich.tratsch	8
alt.survival	8
mozilla.support.thunderbird	7
mozilla.support.firefox	7
alt.binaries.lumpyt	6
lada.kitchen	6
mozilla.dev.platform	5
mozilla.general	5
mozilla.dev.security.policy	4
alt.politics	3
rocksolid.nodes	3
cakewalk.audio	3
biz.mlm	3
mozilla.dev.ports.os2	3
TOTAL: 61	268

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2149
EMP (phn path)	105
EMP (phl)	90
EMP (phn nph)	73
EMP (fsl)	38
Too many newsgroups	23
HTML Multipart	16
User-issued cancel	15
Binary Payload	12
Binary: misplaced rar	12
Scoring filter (10)	5
User-issued spam cancel	4
Scoring filter (9)	2
Binary Image: misplaced jpg	1
Scoring filter (22)	1
Scoring filter (8)	1
TOTAL: 16	2547

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	50	0	63	63
TOTAL: 1	50	8	63	63

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	news.freedyn.net	365
	csiph-out.feeder.erje.net	246
	csiph-out.news.xs4all.nl	52
	csiph-out.feed.uzoreto.com	25
	csiph-out.news.weretis.net	23
	feeder.eternal-september.org	8
	newsfeeds.xmission.com	3
	news-out.mixmin.net	2
	newsfeed.fu-berlin.de	1
	news.fcku.it	1
	TOTAL: 10	726
Including strange strings
	newsfeed.fu-berlin.de	368
	csiph-out.news.xs4all.nl	17
	csiph-out.news.weretis.net	8
	news.swapon.de	6
	news-out.aioe.org	6
	news-out.mixmin.net	5
	feeder.eternal-september.org	2
	csiph-out.feeder.erje.net	1
	news.freedyn.net	1
	TOTAL: 9	414
TOTAL: 3		1185

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	xanadu-bbs	18306	1140	13998	0	0	9	6%	23:59:55
2	news.samoylyk.net	15786	632	14495	2	0	1	4%	24:00:58
3	fu-berlin.de	14128	613	13514	0	0	1	4%	23:59:42
4	news.freedyn.net	13710	607	12758	30	0	1	4%	23:59:50
5	erje	16753	419	13240	113	0	1	2%	23:59:47
6	news.bbs.nz	28264	283	14219	7	0	1	1%	24:00:48
7	usenet.pasdenom.info	15541	89	14331	653	0	1	0%	23:59:55
8	newsfeed.xs4all.nl	13664	42	12852	5	0	60	0%	24:02:30
9	news.uzoreto.com	14573	27	14257	113	0	0	0%	24:09:32
10	neva.ru	13944	22	13614	122	0	0	0%	23:59:52
11	aioe	13055	16	12503	1	1	0	0%	24:08:14
12	news.mixmin.net	13922	14	13503	0	0	0	0%	23:59:52
13	xmission	15913	10	11883	0	0	0	0%	23:59:14
14	weretis.net	13093	8	12827	2	0	5	0%	24:01:11
15	news.swapon.de	1339	6	1317	0	0	0	0%	23:19:14
16	eternal-september	12811	5	12344	0	0	0	0%	23:59:41
17	news.fcku.it	1038	0	1037	0	0	0	0%	21:39:12
18	news.redatomik.org	0	0	0	0	0	14567	0%	24:09:33
TOTAL: 18		235840	3933	202692	1048	1	14647	1%	429:29:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	9.1 MB	0.0 KB	9.1 MB	0.1 KB/s	8.2 KB	23:59:55
2	fu-berlin.de	7.8 MB	0.0 KB	7.8 MB	0.1 KB/s	13.0 KB	23:59:42
3	news.samoylyk.net	7.8 MB	48.8 KB	7.8 MB	0.1 KB/s	12.6 KB	24:00:58
4	news.freedyn.net	7.7 MB	60.1 KB	7.8 MB	0.1 KB/s	12.6 KB	23:59:50
5	erje	1.1 MB	576.5 KB	1.6 MB	0.0 KB/s	3.2 KB	23:59:47
6	news.bbs.nz	700.8 KB	23.4 KB	724.2 KB	0.0 KB/s	2.5 KB	24:00:48
7	usenet.pasdenom.info	209.7 KB	7.9 MB	8.1 MB	0.1 KB/s	11.2 KB	23:59:55
8	newsfeed.xs4all.nl	199.9 KB	13.5 KB	213.3 KB	0.0 KB/s	4.5 KB	24:02:30
9	news.uzoreto.com	106.1 KB	635.8 KB	742.0 KB	0.0 KB/s	5.3 KB	24:09:32
10	neva.ru	51.4 KB	311.2 KB	362.6 KB	0.0 KB/s	2.5 KB	23:59:52
11	aioe	38.1 KB	2.1 KB	40.2 KB	0.0 KB/s	2.4 KB	24:08:14
12	news.mixmin.net	24.4 KB	0.0 KB	24.4 KB	0.0 KB/s	1.7 KB	23:59:52
13	xmission	21.0 KB	0.0 KB	21.0 KB	0.0 KB/s	2.1 KB	23:59:14
14	weretis.net	13.4 KB	2.3 KB	15.7 KB	0.0 KB/s	1.6 KB	24:01:11
15	news.swapon.de	9.3 KB	0.0 KB	9.3 KB	0.0 KB/s	1.6 KB	23:19:14
16	eternal-september	7.1 KB	0.0 KB	7.1 KB	0.0 KB/s	1.4 KB	23:59:41
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:39:12
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:09:33
TOTAL: 18		34.8 MB	9.5 MB	44.4 MB	0.0 KB/s	9.1 KB	429:29:00

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-190-164-204.dhcp.eucl.wi.charter.com	20	8	12.5 KB	7	6	5	05:24:18
2	cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	2	5	7.1 KB	2	0	0	00:37:27
3	a131033.upc-a.chello.nl	13	5	14.8 KB	2	0	0	03:34:50
TOTAL: 3		35	18	34.4 KB	11	6	5	10:39:18

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.eucl.wi.charter.com	20	8	12.5 KB	7	6	5	05:24:18
2	*.upc-a.chello.nl	13	5	14.8 KB	2	0	0	03:34:50
3	*.19-1.cable.virginm.net	2	5	7.1 KB	2	0	0	00:37:27
4	*.ph.ph.cox.net	2	0	0.0 KB	0	0	0	01:00:07
5	unresolved	7	0	0.0 KB	0	0	0	00:00:09
6	*.cust.centrio.cz	1	0	0.0 KB	0	0	0	00:02:25
TOTAL: 6		45	18	34.4 KB	11	6	5	10:39:18

NNRP auth users [Top 20]:

User	Conn
ohlandl	5
ctomczyk	1
TOTAL: 2	6

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
68-190-164-204.dhcp.eucl.wi.charter.com	1.659	0.303	0.011	05:24:18
a131033.upc-a.chello.nl	0.980	0.163	0.000	03:34:50
ip72-222-200-117.ph.ph.cox.net	0.194	0.016	0.000	01:00:07
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	0.226	0.031	0.000	00:37:27
208-71-239-109.cust.centrio.cz	0.078	0.000	0.003	00:02:25
94.166.47.148	0.208	0.031	0.000	00:00:03
125.64.94.211	0.050	0.029	0.000	00:00:02
94.166.118.147	0.070	0.009	0.000	00:00:01
94.162.230.71	0.070	0.008	0.000	00:00:01
94.164.142.39	0.072	0.008	0.000	00:00:01
TOTAL: 10	3.607	0.598	0.014	10:39:18

Curious NNRP server explorers [Top 20]:

System	Conn
94.166.47.148	3
ip72-222-200-117.ph.ph.cox.net	2
94.166.118.147	1
94.162.230.71	1
208-71-239-109.cust.centrio.cz	1
125.64.94.211	1
94.164.142.39	1
TOTAL: 7	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-204.dhcp.eucl.wi.charter.com	2	0
ip72-222-200-117.ph.ph.cox.net	2	0
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1	0
TOTAL: 3	5	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Sep 8 04:15:00 -- Sep 9 04:15:00