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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19976	48.0%	5.1 MB	63.2%
innd	17450	42.0%	2.3 MB	28.3%
innfeed	3484	8.4%	633.4 KB	7.6%
nnrpd	633	1.5%	68.8 KB	0.8%
nocem	48	0.1%	5.6 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	41592	100.0%	8.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	332188	56.8%
Negative hits	232613	39.8%
Do not exist	19402	3.3%
Cache misses	293	0.1%
TOTAL: 4	584496	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.555	0.0%	39	0.000	14.231	27.900
article cleanup	00:00:00.102	0.0%	19211	0.000	0.005	0.032
article logging	00:00:00.264	0.0%	19670	0.000	0.013	0.314
article parse	00:00:00.737	0.0%	56843	0.000	0.013	0.052
article write	00:00:05.445	0.0%	15809	0.168	0.344	8.946
artlog/artcncl	00:00:00.000	0.0%	39	0.000	0.000	0.000
artlog/artparse	00:00:00.009	0.0%	313	0.000	0.029	0.500
data move	00:00:00.163	0.0%	543245	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.018	0.0%	39	0.000	0.462	1.000
hishave/artcncl	00:00:00.002	0.0%	39	0.000	0.051	0.100
hishave/artparse	00:00:00.000	0.0%	312	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.100	0.0%	587642	0.001	0.009	0.034
history sync	00:00:00.792	0.0%	377	0.000	2.101	7.250
history write	00:00:11.519	0.0%	19209	0.017	0.600	2.681
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.213	0.0%	312	0.000	0.683	5.000
idle	23:59:12.960	99.9%	551622	89.160	156.544	584.815
nntp read	00:00:02.036	0.0%	551866	0.001	0.004	0.009
overview write	00:00:26.439	0.0%	15809	0.069	1.672	55.984
perl filter	00:00:25.273	0.0%	19208	1.087	1.316	2.000
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.248	0.0%	31666	0.000	0.008	0.026
TOTAL: 24:01:02.911	24:00:31.875	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.032	0.0%	15828	0.000	0.002	0.027
article prepare	00:00:00.004	0.0%	14460	0.000	0.000	0.014
article read	00:00:00.268	0.0%	1725	0.000	0.155	5.500
backlog stats	00:00:00.167	0.0%	364370	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.285	0.0%	290710	0.000	0.004	0.014
data write	00:00:01.544	0.0%	277902	0.002	0.006	0.011
idle	23:54:20.659	100.0%	364370	132.606	236.190	991.308
status file	00:00:00.168	0.0%	268	0.000	0.627	2.000
TOTAL: 23:54:31.054	23:54:24.127	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	27:41:46.814	100.0%	439	242.000	227122.583	600191.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.685	0.0%	978	0.000	0.700	8.908
readart	00:00:00.212	0.0%	24	0.000	8.833	42.000
TOTAL: 27:42:15.178	27:41:47.711	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	15112	4022	11065	25	26%	23:09:47
2	news-out.aioe.org	3	15723	3387	12131	205	21%	24:08:38
3	feeder.eternal-september.org	3	17562	2159	15117	286	12%	22:56:35
4	csiph-out.news.xs4all.nl	861	17892	1078	15643	1171	6%	71:32:02
5	csiph-out.feeder.erje.net	1440	80871	939	79355	577	1%	118:44:03
6	newsfeed.neva.ru	141	17576	831	16303	442	4%	72:02:57
7	newsfeed.fu-berlin.de	12	15900	787	14963	150	4%	25:53:00
8	csiph-out.news.weretis.net	5	33056	772	32136	148	2%	48:08:48
9	news-out.mixmin.net	1	16675	670	15767	238	4%	23:59:52
10	news.freedyn.net	1	18892	385	18331	176	2%	23:59:52
11	csiph-out.feed.uzoreto.com	863	24915	185	24516	214	0%	71:24:24
12	news.fcku.it	8	2404	178	2217	9	7%	22:29:52
13	csiph-out.news.tnetconsulting.net	1	33726	83	33623	20	0%	13:08:15
14	nntp.pasdenom.info	2	11335	63	11259	13	0%	23:58:31
15	news-out.neodome.net	2	17031	62	16946	23	0%	23:59:53
16	news.swapon.de	10	1417	19	1398	0	1%	23:33:02
17	news.bbs.nz	1	16029	8	16020	1	0%	23:59:53
18	news.samoylyk.net	1	15874	6	15867	1	0%	23:59:53
19	localhost	30	4	4	0	0	100%	00:00:05
20	xanadu-bbs.net	31	360	0	360	0	0%	19:55:39
TOTAL: 20		3418	372354	15638	353017	3699	4%	701:05:01

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.2 MB	0.0 KB	1.1 MB	12.3 MB	90%	3.1 KB
2	news-out.aioe.org	8.2 MB	1.2 KB	605.7 KB	8.8 MB	93%	2.5 KB
3	csiph-out.feeder.erje.net	6.0 MB	0.0 KB	10.6 MB	16.6 MB	36%	11.2 KB
4	feeder.eternal-september.org	5.6 MB	1.9 KB	812.3 KB	6.4 MB	87%	2.7 KB
5	csiph-out.news.xs4all.nl	3.4 MB	0.0 KB	9.7 MB	13.1 MB	25%	5.9 KB
6	csiph-out.news.weretis.net	2.3 MB	5.5 KB	2.2 MB	4.5 MB	50%	5.0 KB
7	newsfeed.neva.ru	2.0 MB	0.0 KB	1.3 MB	3.4 MB	60%	2.7 KB
8	newsfeed.fu-berlin.de	1.9 MB	0.0 KB	471.0 KB	2.4 MB	80%	2.6 KB
9	news-out.mixmin.net	1.8 MB	0.0 KB	520.8 KB	2.3 MB	77%	2.6 KB
10	news.freedyn.net	1.3 MB	0.0 KB	1.6 MB	2.9 MB	45%	5.3 KB
11	csiph-out.feed.uzoreto.com	617.8 KB	0.0 KB	4.0 MB	4.6 MB	13%	11.9 KB
12	news.fcku.it	312.3 KB	0.0 KB	13.2 KB	325.5 KB	95%	1.7 KB
13	csiph-out.news.tnetconsulting.net	263.0 KB	0.0 KB	423.0 KB	685.9 KB	38%	6.7 KB
14	news-out.neodome.net	157.9 KB	0.0 KB	672.8 KB	830.7 KB	19%	9.8 KB
15	nntp.pasdenom.info	124.6 KB	0.0 KB	22.8 KB	147.4 KB	84%	1.9 KB
16	news.swapon.de	55.5 KB	0.0 KB	0.0 KB	55.5 KB	100%	2.9 KB
17	news.bbs.nz	30.5 KB	0.0 KB	46.9 KB	77.5 KB	39%	8.6 KB
18	news.samoylyk.net	17.5 KB	0.0 KB	1.3 KB	18.8 KB	93%	2.7 KB
19	localhost	4.5 KB	0.0 KB	0.0 KB	4.5 KB	100%	1.1 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		45.2 MB	8.6 KB	34.1 MB	79.3 MB	56%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 12 04:15:00 - 04:59:59	213	1.4%	0.08	496.8 KB	1.1%	0.18
Feb 12 05:00:00 - 05:59:59	305	1.9%	0.08	1.1 MB	2.5%	0.32
Feb 12 06:00:00 - 06:59:59	410	2.6%	0.11	1.1 MB	2.5%	0.32
Feb 12 07:00:00 - 07:59:59	498	3.2%	0.14	1.7 MB	3.8%	0.49
Feb 12 08:00:00 - 08:59:59	606	3.8%	0.17	1.7 MB	3.7%	0.48
Feb 12 09:00:00 - 09:59:59	789	5.0%	0.22	2.5 MB	5.5%	0.71
Feb 12 10:00:00 - 10:59:59	795	5.0%	0.22	2.0 MB	4.4%	0.57
Feb 12 11:00:00 - 11:59:59	690	4.4%	0.19	2.1 MB	4.6%	0.59
Feb 12 12:00:00 - 12:59:59	718	4.6%	0.20	1.8 MB	4.0%	0.51
Feb 12 13:00:00 - 13:59:59	856	5.4%	0.24	2.1 MB	4.7%	0.60
Feb 12 14:00:00 - 14:59:59	858	5.4%	0.24	2.2 MB	4.8%	0.62
Feb 12 15:00:00 - 15:59:59	867	5.5%	0.24	2.7 MB	6.0%	0.77
Feb 12 16:00:00 - 16:59:59	900	5.7%	0.25	2.2 MB	4.9%	0.63
Feb 12 17:00:00 - 17:59:59	907	5.8%	0.25	2.5 MB	5.4%	0.70
Feb 12 18:00:00 - 18:59:59	962	6.1%	0.27	2.4 MB	5.3%	0.68
Feb 12 19:00:00 - 19:59:59	913	5.8%	0.25	2.9 MB	6.3%	0.81
Feb 12 20:00:00 - 20:59:59	895	5.7%	0.25	2.5 MB	5.5%	0.71
Feb 12 21:00:00 - 21:59:59	784	5.0%	0.22	2.2 MB	4.9%	0.63
Feb 12 22:00:00 - 22:59:59	762	4.8%	0.21	1.9 MB	4.2%	0.55
Feb 12 23:00:00 - 23:59:59	555	3.5%	0.15	2.1 MB	4.7%	0.60
Feb 13 00:00:00 - 00:59:59	469	3.0%	0.13	1.6 MB	3.4%	0.44
Feb 13 01:00:00 - 01:59:59	367	2.3%	0.10	1.3 MB	2.9%	0.37
Feb 13 02:00:00 - 02:59:59	312	2.0%	0.09	985.5 KB	2.1%	0.27
Feb 13 03:00:00 - 03:59:59	257	1.6%	0.07	1.1 MB	2.5%	0.32
Feb 13 04:00:00 - 04:15:00	64	0.4%	0.07	269.6 KB	0.6%	0.30
TOTAL: 24:00:00	15752	100.0%	0.18	45.5 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1178	82	0	1096
2	csiph-out.feeder.erje.net	593	79	0	514
3	newsfeed.fu-berlin.de	447	30	0	417
4	newsfeed.neva.ru	441	61	0	380
5	feeder.eternal-september.org	298	16	2	280
6	news-out.aioe.org	271	172	1	98
7	news-out.mixmin.net	241	6	0	235
8	csiph-out.feed.uzoreto.com	215	5	0	210
9	csiph-out.news.weretis.net	196	74	0	122
10	news.freedyn.net	180	14	0	166
11	newsfeeds.xmission.com	49	10	0	39
12	csiph-out.news.tnetconsulting.net	28	24	0	4
13	news-out.neodome.net	24	2	0	22
14	nntp.pasdenom.info	13	0	0	13
15	news.fcku.it	9	9	0	0
16	news.samoylyk.net	1	0	0	1
17	news.swapon.de	1	0	0	1
TOTAL: 17		4185	584	3	3598

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	165
alt.bbs.synchronet	89
it-alt.sport.calcio.juventus	25
lada.talk	24
alt.windows7.general	16
mozilla.general	14
alt.politics.usa	14
lada.test	12
alt.forsale.seattle	12
mozilla.support.seamonkey	11
alt.survival	10
alt.binaries.pictures.purebeauty	10
aol.neighborhood.ca.fresno.marketplace	9
mozilla.support.firefox	9
alt.politics	9
spline.eisfair	8
alt.binaries.ebooks	8
lada.movies	6
alt.philosophy	6
oesterreich.tratsch	6
TOTAL: 89	584

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2047
EMP (phn path)	260
EMP (phn nph)	228
EMP (phl)	146
0	94
Too many newsgroups	23
HTML Multipart	18
Scoring filter	7
Binary Payload	5
Binary: misplaced binary	1
HTML post	1
TOTAL: 11	2830

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	102
	csiph-out.feed.uzoreto.com	14
	csiph-out.news.xs4all.nl	12
	TOTAL: 3	128
Huge articles
	csiph-out.feeder.erje.net	188
	csiph-out.news.xs4all.nl	33
	csiph-out.feed.uzoreto.com	27
	csiph-out.news.weretis.net	20
	newsfeeds.xmission.com	15
	news-out.neodome.net	12
	news.freedyn.net	9
	csiph-out.news.tnetconsulting.net	3
	newsfeed.fu-berlin.de	1
	news-out.mixmin.net	1
	TOTAL: 10	309
Including strange strings
	newsfeed.fu-berlin.de	313
	news-out.aioe.org	81
	newsfeeds.xmission.com	23
	csiph-out.news.weretis.net	21
	news-out.mixmin.net	8
	csiph-out.news.xs4all.nl	7
	csiph-out.feeder.erje.net	4
	news.swapon.de	1
	TOTAL: 8	458
TOTAL: 3		895

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19941	1511	14240	1	0	7%	23:59:55
2	news.samoylyk.net	16235	433	15308	4	0	2%	23:59:02
3	fu-berlin.de	14864	408	14456	0	0	2%	23:59:55
4	news.freedyn.net	15529	408	14820	32	0	2%	23:59:55
5	news.bbs.nz	29941	310	14991	5	0	1%	23:58:11
6	tnet	16121	114	15204	0	0	0%	23:59:11
7	usenet.pasdenom.info	15792	100	15117	32	12	0%	23:59:55
8	aioe	11640	32	11309	2	0	0%	23:59:55
9	newsfeed.xs4all.nl	14879	28	14485	5	80	0%	23:59:54
10	neva.ru	14364	15	14176	104	0	0%	23:59:46
11	xmission	12758	13	11218	0	0	0%	23:59:55
12	news.mixmin.net	14925	8	14470	0	0	0%	23:58:19
13	neodome.net	16075	8	15635	0	0	0%	23:59:54
14	news.uzoreto.com	15308	6	15039	11	0	0%	23:59:55
15	eternal-september	13410	4	12989	0	0	0%	23:59:46
16	weretis.net	14645	4	14466	1	0	0%	23:59:49
17	news.swapon.de	1446	4	1427	1	0	0%	23:05:15
18	erje	14997	2	14675	10	0	0%	23:59:39
19	news.fcku.it	2009	0	2002	0	0	0%	21:22:26
TOTAL: 19		274879	3408	246027	208	92	1%	452:20:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.6 MB	2.6 KB	7.6 MB	0.1 KB/s	5.2 KB	23:59:55
2	news.freedyn.net	4.6 MB	50.4 KB	4.7 MB	0.1 KB/s	10.9 KB	23:59:55
3	news.samoylyk.net	4.6 MB	4.3 KB	4.6 MB	0.1 KB/s	10.7 KB	23:59:02
4	fu-berlin.de	4.6 MB	0.0 KB	4.6 MB	0.1 KB/s	11.4 KB	23:59:55
5	news.bbs.nz	880.8 KB	21.7 KB	902.4 KB	0.0 KB/s	2.9 KB	23:58:11
6	usenet.pasdenom.info	420.0 KB	89.7 KB	509.8 KB	0.0 KB/s	3.9 KB	23:59:55
7	tnet	324.1 KB	0.0 KB	324.1 KB	0.0 KB/s	2.8 KB	23:59:11
8	aioe	127.7 KB	3.7 KB	131.5 KB	0.0 KB/s	3.9 KB	23:59:55
9	newsfeed.xs4all.nl	98.0 KB	37.6 KB	135.6 KB	0.0 KB/s	4.1 KB	23:59:54
10	neva.ru	28.7 KB	316.0 KB	344.8 KB	0.0 KB/s	2.9 KB	23:59:46
11	xmission	25.9 KB	0.0 KB	25.9 KB	0.0 KB/s	2.0 KB	23:59:55
12	news.uzoreto.com	11.5 KB	84.7 KB	96.2 KB	0.0 KB/s	5.7 KB	23:59:55
13	neodome.net	10.1 KB	0.0 KB	10.1 KB	0.0 KB/s	1.3 KB	23:59:54
14	news.mixmin.net	9.6 KB	0.0 KB	9.6 KB	0.0 KB/s	1.2 KB	23:58:19
15	news.swapon.de	4.8 KB	1.0 KB	5.8 KB	0.0 KB/s	1.2 KB	23:05:15
16	eternal-september	4.5 KB	0.0 KB	4.5 KB	0.0 KB/s	1.1 KB	23:59:46
17	weretis.net	4.5 KB	2.8 KB	7.2 KB	0.0 KB/s	1.4 KB	23:59:49
18	erje	2.0 KB	22.3 KB	24.3 KB	0.0 KB/s	2.0 KB	23:59:39
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:22:26
TOTAL: 19		23.3 MB	636.9 KB	23.9 MB	0.0 KB/s	6.8 KB	452:20:37

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	p3ee23dc0.dip0.t-ipconnect.de	1	10	20.1 KB	2	0	0	00:00:10
2	68-190-164-53.dhcp.eucl.wi.charter.com	25	6	7.4 KB	3	4	4	06:53:01
3	a131033.upc-a.chello.nl	63	4	5.2 KB	4	0	0	18:08:13
4	78-80-29-16.nat.epc.tmcz.cz	4	4	10.8 KB	2	0	0	01:20:27
TOTAL: 4		93	24	43.4 KB	11	4	4	27:42:14

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dip0.t-ipconnect.de	1	10	20.1 KB	2	0	0	00:00:10
2	*.dhcp.eucl.wi.charter.com	25	6	7.4 KB	3	4	4	06:53:01
3	*.upc-a.chello.nl	63	4	5.2 KB	4	0	0	18:08:13
4	*.nat.epc.tmcz.cz	5	4	10.8 KB	2	0	0	01:40:33
5	*.ph.ph.cox.net	2	0	0.0 KB	0	0	0	01:00:07
6	unresolved	6	0	0.0 KB	0	0	0	00:00:07
TOTAL: 6		102	24	43.4 KB	11	4	4	27:42:14

NNRP auth users [Top 20]:

User	Conn
ctomczyk	5
ohlandl	4
TOTAL: 2	9

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	4.065	0.981	0.000	18:08:13
68-190-164-53.dhcp.eucl.wi.charter.com	1.711	0.376	0.009	06:53:01
78-80-29-16.nat.epc.tmcz.cz	0.319	0.078	0.010	01:20:27
ip72-222-200-117.ph.ph.cox.net	0.204	0.040	0.000	01:00:07
37-48-45-149.nat.epc.tmcz.cz	0.053	0.026	0.002	00:20:05
p3ee23dc0.dip0.t-ipconnect.de	0.117	0.034	0.000	00:00:10
94.164.37.11	0.127	0.029	0.000	00:00:02
94.164.114.135	0.137	0.016	0.000	00:00:02
117.50.6.160	0.061	0.015	0.000	00:00:01
94.160.21.158	0.067	0.008	0.000	00:00:01
TOTAL: 10	6.861	1.603	0.021	27:42:14

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	2
94.164.37.11	2
94.164.114.135	2
37-48-45-149.nat.epc.tmcz.cz	1
94.160.21.158	1
117.50.6.160	1
TOTAL: 6	9

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-53.dhcp.eucl.wi.charter.com	8	0
78-80-29-16.nat.epc.tmcz.cz	4	4
ip72-222-200-117.ph.ph.cox.net	2	0
37-48-45-149.nat.epc.tmcz.cz	1	1
TOTAL: 4	15	5

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	14	58.3%
2	alt	7	29.2%
3	de	3	12.5%
TOTAL: 3		24	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	10
2	alt.free.newsservers	7
3	comp.lang.javascript	4
4	de.sci.electronics	3
TOTAL: 4		24

Daily Usenet report for csiph.com

Feb 12 04:15:00 -- Feb 13 04:15:00