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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21181	48.7%	5.4 MB	63.8%
innd	17745	40.8%	2.3 MB	27.6%
innfeed	3464	8.0%	622.7 KB	7.2%
nnrpd	1036	2.4%	113.7 KB	1.3%
nocem	30	0.1%	3.4 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	43457	100.0%	8.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	343993	57.7%
Negative hits	231453	38.8%
Do not exist	20304	3.4%
Cache misses	529	0.1%
TOTAL: 4	596279	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:09.535	0.0%	320	0.000	29.797	30.724
article cleanup	00:00:00.110	0.0%	20002	0.000	0.005	0.043
article logging	00:00:00.301	0.0%	20429	0.000	0.015	0.143
article parse	00:00:00.872	0.0%	61661	0.000	0.014	0.052
article write	00:00:26.170	0.0%	16435	0.171	1.592	80.789
artlog/artcncl	00:00:00.002	0.0%	320	0.000	0.006	0.007
artlog/artparse	00:00:00.008	0.0%	440	0.000	0.018	0.250
data move	00:00:00.221	0.0%	552533	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.086	0.0%	320	0.000	0.269	21.000
hishave/artcncl	00:00:00.035	0.0%	320	0.000	0.109	0.429
hishave/artparse	00:00:00.002	0.0%	434	0.000	0.005	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:07.505	0.0%	597264	0.002	0.013	0.125
history sync	00:00:01.448	0.0%	378	0.000	3.831	131.667
history write	00:00:14.098	0.0%	19945	0.243	0.707	5.422
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.296	0.0%	434	0.000	0.682	6.000
idle	23:57:36.681	99.8%	557060	87.266	154.843	536.953
nntp read	00:00:02.228	0.0%	561981	0.001	0.004	0.006
overview write	00:01:15.976	0.1%	16435	0.106	4.623	122.289
perl filter	00:00:26.886	0.0%	19939	1.068	1.348	2.169
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.255	0.0%	32900	0.000	0.008	0.030
TOTAL: 24:01:01.197	24:00:22.715	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.039	0.0%	17010	0.000	0.002	0.017
article prepare	00:00:00.002	0.0%	15368	0.000	0.000	0.004
article read	00:00:00.300	0.0%	1483	0.000	0.202	22.000
backlog stats	00:00:00.213	0.0%	379880	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.483	0.0%	302050	0.002	0.005	0.010
data write	00:00:01.699	0.0%	289170	0.002	0.006	0.011
idle	23:54:36.080	100.0%	379880	96.516	226.588	726.507
status file	00:00:00.173	0.0%	262	0.000	0.660	2.000
TOTAL: 23:54:47.551	23:54:39.989	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	43:24:53.759	99.8%	700	1237.000	223276.799	600094.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.006	0.0%	1583	0.000	0.004	0.167
readart	00:00:00.379	0.0%	53	0.000	7.151	42.000
TOTAL: 43:29:52.471	43:24:54.144	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	15971	4535	11394	42	28%	24:16:43
2	news-out.aioe.org	3	16134	3225	12773	136	19%	24:08:57
3	feeder.eternal-september.org	2	18366	2293	15860	213	12%	23:52:44
4	csiph-out.feeder.erje.net	1440	81770	1002	80318	450	1%	118:53:20
5	csiph-out.news.xs4all.nl	860	18691	903	16424	1364	4%	71:28:14
6	csiph-out.news.weretis.net	2	32203	883	31181	139	2%	47:59:47
7	newsfeed.neva.ru	144	19109	854	17727	528	4%	71:27:37
8	news-out.mixmin.net	2	17133	724	16058	351	4%	23:59:44
9	newsfeed.fu-berlin.de	12	15159	713	14280	166	4%	24:15:55
10	news.freedyn.net	2	19687	528	18954	205	2%	24:09:01
11	news.fcku.it	9	2300	278	2013	9	12%	21:29:40
12	csiph-out.feed.uzoreto.com	864	26374	157	25931	286	0%	71:08:50
13	csiph-out.news.tnetconsulting.net	1	15006	142	14844	20	0%	23:59:57
14	news-out.neodome.net	2	17297	97	17189	11	0%	23:59:52
15	news.swapon.de	5	1463	32	1426	5	2%	24:24:44
16	nntp.pasdenom.info	3	11713	30	11672	11	0%	23:56:58
17	localhost	41	15	15	0	0	100%	00:00:03
18	news.samoylyk.net	2	16283	11	16270	2	0%	24:54:16
19	news.bbs.nz	1	14525	6	14519	0	0%	23:59:53
20	xanadu-bbs.net	22	480	3	477	0	0%	23:03:43
TOTAL: 20		3419	359679	16431	339310	3938	4%	715:29:58

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	13.3 MB	0.0 KB	2.6 MB	15.9 MB	83%	3.5 KB
2	news-out.aioe.org	7.7 MB	4.8 KB	405.6 KB	8.1 MB	95%	2.5 KB
3	csiph-out.feeder.erje.net	6.2 MB	135.5 KB	11.0 MB	17.4 MB	35%	12.2 KB
4	feeder.eternal-september.org	5.8 MB	7.6 KB	801.1 KB	6.6 MB	88%	2.7 KB
5	csiph-out.news.xs4all.nl	2.9 MB	0.0 KB	12.2 MB	15.1 MB	19%	6.8 KB
6	csiph-out.news.weretis.net	2.8 MB	4.9 KB	2.5 MB	5.2 MB	52%	5.3 KB
7	news-out.mixmin.net	2.1 MB	14.5 KB	787.7 KB	2.9 MB	73%	2.8 KB
8	newsfeed.neva.ru	1.9 MB	36.2 KB	2.5 MB	4.4 MB	43%	3.3 KB
9	news.freedyn.net	1.7 MB	8.1 KB	1.0 MB	2.7 MB	62%	3.8 KB
10	newsfeed.fu-berlin.de	1.6 MB	0.0 KB	435.4 KB	2.0 MB	79%	2.4 KB
11	csiph-out.feed.uzoreto.com	695.7 KB	3.2 KB	5.7 MB	6.4 MB	10%	14.9 KB
12	news.fcku.it	428.0 KB	0.0 KB	9.4 KB	437.5 KB	97%	1.5 KB
13	csiph-out.news.tnetconsulting.net	397.7 KB	2.9 KB	44.2 KB	444.8 KB	89%	2.7 KB
14	news-out.neodome.net	283.9 KB	5.1 KB	86.1 KB	375.2 KB	75%	3.5 KB
15	news.swapon.de	99.8 KB	2.2 KB	1.4 MB	1.5 MB	6%	40.3 KB
16	nntp.pasdenom.info	66.9 KB	0.0 KB	17.1 KB	83.9 KB	79%	2.0 KB
17	news.samoylyk.net	29.6 KB	5.5 KB	5.5 KB	40.6 KB	72%	3.1 KB
18	xanadu-bbs.net	26.1 KB	0.0 KB	0.0 KB	26.1 KB	100%	8.7 KB
19	localhost	24.6 KB	0.0 KB	0.0 KB	24.6 KB	100%	1.6 KB
20	news.bbs.nz	15.7 KB	0.0 KB	0.0 KB	15.7 KB	100%	2.6 KB
TOTAL: 20		48.0 MB	230.7 KB	41.4 MB	89.7 MB	53%	4.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 2 04:15:00 - 04:59:59	185	1.1%	0.07	534.7 KB	1.1%	0.20
Mar 2 05:00:00 - 05:59:59	711	4.3%	0.20	3.1 MB	6.5%	0.90
Mar 2 06:00:00 - 06:59:59	357	2.2%	0.10	1.2 MB	2.4%	0.33
Mar 2 07:00:00 - 07:59:59	465	2.8%	0.13	1.6 MB	3.3%	0.46
Mar 2 08:00:00 - 08:59:59	676	4.1%	0.19	2.0 MB	4.2%	0.57
Mar 2 09:00:00 - 09:59:59	710	4.3%	0.20	2.0 MB	4.1%	0.55
Mar 2 10:00:00 - 10:59:59	736	4.5%	0.20	2.0 MB	4.2%	0.57
Mar 2 11:00:00 - 11:59:59	820	5.0%	0.23	2.5 MB	5.1%	0.70
Mar 2 12:00:00 - 12:59:59	765	4.7%	0.21	2.0 MB	4.2%	0.58
Mar 2 13:00:00 - 13:59:59	902	5.5%	0.25	2.2 MB	4.7%	0.64
Mar 2 14:00:00 - 14:59:59	898	5.5%	0.25	2.4 MB	5.0%	0.69
Mar 2 15:00:00 - 15:59:59	1006	6.1%	0.28	3.0 MB	6.1%	0.84
Mar 2 16:00:00 - 16:59:59	862	5.2%	0.24	2.3 MB	4.8%	0.66
Mar 2 17:00:00 - 17:59:59	1007	6.1%	0.28	2.7 MB	5.6%	0.76
Mar 2 18:00:00 - 18:59:59	900	5.5%	0.25	2.3 MB	4.7%	0.64
Mar 2 19:00:00 - 19:59:59	866	5.3%	0.24	2.7 MB	5.5%	0.76
Mar 2 20:00:00 - 20:59:59	821	5.0%	0.23	2.2 MB	4.7%	0.64
Mar 2 21:00:00 - 21:59:59	822	5.0%	0.23	2.2 MB	4.7%	0.64
Mar 2 22:00:00 - 22:59:59	712	4.3%	0.20	2.0 MB	4.1%	0.56
Mar 2 23:00:00 - 23:59:59	501	3.0%	0.14	1.8 MB	3.6%	0.50
Mar 3 00:00:00 - 00:59:59	449	2.7%	0.12	1.3 MB	2.7%	0.37
Mar 3 01:00:00 - 01:59:59	514	3.1%	0.14	1.5 MB	3.1%	0.42
Mar 3 02:00:00 - 02:59:59	362	2.2%	0.10	1.2 MB	2.5%	0.34
Mar 3 03:00:00 - 03:59:59	327	2.0%	0.09	1.4 MB	2.9%	0.39
Mar 3 04:00:00 - 04:15:00	58	0.4%	0.06	156.9 KB	0.3%	0.17
TOTAL: 24:00:00	16432	100.0%	0.19	48.1 MB	100.0%	0.57

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1358	40	0	1318
2	newsfeed.neva.ru	522	45	10	467
3	newsfeed.fu-berlin.de	485	32	0	453
4	csiph-out.feeder.erje.net	452	33	32	387
5	news-out.mixmin.net	354	0	4	350
6	csiph-out.feed.uzoreto.com	290	8	1	281
7	news-out.aioe.org	225	120	2	103
8	news.freedyn.net	216	4	3	209
9	feeder.eternal-september.org	203	24	3	176
10	csiph-out.news.weretis.net	141	86	2	53
11	csiph-out.news.tnetconsulting.net	88	28	1	59
12	newsfeeds.xmission.com	46	1	0	45
13	news-out.neodome.net	13	1	2	10
14	news.swapon.de	13	0	1	12
15	nntp.pasdenom.info	12	0	0	12
16	news.fcku.it	9	8	0	1
17	news.samoylyk.net	2	0	2	0
TOTAL: 17		4429	430	63	3936

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	53
alt.bbs.synchronet	46
lada.talk	27
it-alt.sport.calcio.juventus	27
alt.politics.usa	24
mozilla.support.seamonkey	19
alt.survival	18
mozilla.support.thunderbird	15
it-alt.comp.software.mozilla	13
mozilla.dev.security.policy	13
alt.pl.nieruchomosci.gielda	12
alt.windows7.general	12
alt.tv.star-trek	11
oesterreich.tratsch	9
lada.auto	8
alt.music.pink-floyd.publius	7
mozilla.dev.platform	7
spline.eisfair	6
mozilla.support.firefox	6
lada.commerce	5
TOTAL: 77	430

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2411
EMP (phn path)	214
EMP (phl)	150
EMP (phn nph)	148
0	53
Too many newsgroups	36
Scoring filter	18
HTML Multipart	11
Too many newsgroups (meow)	3
HTML post	1
Binary: misplaced binary	1
TOTAL: 11	3046

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	csiph-out.news.xs4all.nl	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	52
Huge articles
	csiph-out.feeder.erje.net	194
	csiph-out.news.xs4all.nl	114
	csiph-out.feed.uzoreto.com	64
	newsfeeds.xmission.com	36
	csiph-out.news.weretis.net	24
	news.freedyn.net	11
	news-out.mixmin.net	6
	news.swapon.de	3
	feeder.eternal-september.org	3
	news-out.neodome.net	1
	TOTAL: 11	457
Including strange strings
	newsfeed.fu-berlin.de	301
	news-out.aioe.org	87
	csiph-out.news.weretis.net	11
	news.swapon.de	8
	news.freedyn.net	5
	news-out.mixmin.net	4
	newsfeeds.xmission.com	4
	newsfeed.neva.ru	2
	csiph-out.feeder.erje.net	2
	csiph-out.news.xs4all.nl	2
	TOTAL: 11	427
No colon-space in header
	csiph-out.news.xs4all.nl	3
	csiph-out.feeder.erje.net	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	6
TOTAL: 4		942

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19450	1011	15414	3	0	5%	23:59:30
2	news.bbs.nz	31007	531	15487	14	0	1%	23:59:40
3	news.freedyn.net	16164	413	15398	6	0	2%	23:59:08
4	news.samoylyk.net	17028	405	16013	1	68	2%	23:59:55
5	fu-berlin.de	15519	403	15116	0	0	2%	23:59:55
6	tnet	17224	195	15845	0	0	1%	23:59:55
7	usenet.pasdenom.info	16715	126	15805	80	420	0%	23:59:55
8	aioe	12386	77	11887	1	0	0%	23:59:55
9	newsfeed.xs4all.nl	15777	53	15329	5	116	0%	23:59:54
10	neva.ru	15075	33	14808	133	0	0%	23:59:55
11	erje	15407	23	15114	138	0	0%	23:59:38
12	news.uzoreto.com	16064	23	15747	49	0	0%	23:59:37
13	neodome.net	16808	23	16276	0	0	0%	23:59:50
14	xmission	13808	22	11469	1	0	0%	23:59:04
15	news.mixmin.net	15574	20	15090	0	0	0%	23:59:55
16	news.swapon.de	1638	15	1568	0	0	0%	23:51:29
17	eternal-september	14139	15	13639	0	0	0%	23:59:49
18	weretis.net	15107	15	14921	2	0	0%	23:59:55
19	news.fcku.it	1924	0	1916	0	0	0%	20:58:18
TOTAL: 19		286814	3403	256842	433	604	1%	452:45:17

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.7 MB	13.0 KB	5.7 MB	0.1 KB/s	5.8 KB	23:59:30
2	news.freedyn.net	4.3 MB	9.8 KB	4.4 MB	0.1 KB/s	10.6 KB	23:59:08
3	fu-berlin.de	4.3 MB	0.0 KB	4.3 MB	0.1 KB/s	10.9 KB	23:59:55
4	news.samoylyk.net	4.3 MB	1.4 KB	4.3 MB	0.1 KB/s	10.8 KB	23:59:55
5	news.bbs.nz	1.4 MB	84.9 KB	1.5 MB	0.0 KB/s	2.7 KB	23:59:40
6	tnet	504.8 KB	0.0 KB	504.8 KB	0.0 KB/s	2.6 KB	23:59:55
7	usenet.pasdenom.info	380.5 KB	338.5 KB	719.0 KB	0.0 KB/s	3.5 KB	23:59:55
8	newsfeed.xs4all.nl	213.3 KB	12.4 KB	225.7 KB	0.0 KB/s	3.9 KB	23:59:54
9	aioe	156.6 KB	6.0 KB	162.6 KB	0.0 KB/s	2.1 KB	23:59:55
10	neva.ru	60.5 KB	254.3 KB	314.8 KB	0.0 KB/s	1.9 KB	23:59:55
11	neodome.net	54.3 KB	0.0 KB	54.3 KB	0.0 KB/s	2.4 KB	23:59:50
12	xmission	43.1 KB	2.3 KB	45.4 KB	0.0 KB/s	2.0 KB	23:59:04
13	news.uzoreto.com	42.3 KB	151.2 KB	193.5 KB	0.0 KB/s	2.7 KB	23:59:37
14	erje	41.4 KB	355.5 KB	396.8 KB	0.0 KB/s	2.5 KB	23:59:38
15	news.mixmin.net	35.4 KB	0.0 KB	35.4 KB	0.0 KB/s	1.8 KB	23:59:55
16	news.swapon.de	24.7 KB	0.0 KB	24.7 KB	0.0 KB/s	1.6 KB	23:51:29
17	eternal-september	24.7 KB	0.0 KB	24.7 KB	0.0 KB/s	1.6 KB	23:59:49
18	weretis.net	24.7 KB	7.7 KB	32.4 KB	0.0 KB/s	1.9 KB	23:59:55
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:58:18
TOTAL: 19		21.5 MB	1.2 MB	22.7 MB	0.0 KB/s	6.1 KB	452:45:17

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-190-164-53.dhcp.eucl.wi.charter.com	50	27	47.6 KB	21	15	10	12:01:41
2	a131033.upc-a.chello.nl	17	26	50.9 KB	4	0	0	05:27:53
TOTAL: 2		67	53	98.6 KB	25	15	10	43:29:51

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.eucl.wi.charter.com	50	27	47.6 KB	21	15	10	12:01:41
2	*.upc-a.chello.nl	17	26	50.9 KB	4	0	0	05:27:53
3	unresolved	73	0	0.0 KB	0	0	0	23:59:54
4	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	01:00:07
5	*.nat.epc.tmcz.cz	3	0	0.0 KB	0	0	0	01:00:14
TOTAL: 5		147	53	98.6 KB	25	15	10	43:29:51

NNRP auth users [Top 20]:

User	Conn
ohlandl	10
ctomczyk	3
TOTAL: 2	13

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.984	1.082	0.000	23:59:44
68-190-164-53.dhcp.eucl.wi.charter.com	4.129	0.835	0.025	12:01:41
a131033.upc-a.chello.nl	1.297	0.232	0.000	05:27:53
89-24-34-212.nat.epc.tmcz.cz	0.201	0.032	0.008	01:00:14
ip72-222-200-117.ph.ph.cox.net	0.200	0.045	0.000	01:00:07
192.241.221.99	0.069	0.008	0.000	00:00:09
TOTAL: 6	10.880	2.234	0.033	43:29:51

Curious NNRP server explorers [Top 20]:

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-53.dhcp.eucl.wi.charter.com	5	0
89-24-34-212.nat.epc.tmcz.cz	3	3
ip72-222-200-117.ph.ph.cox.net	2	0
a131033.upc-a.chello.nl	2	0
TOTAL: 4	12	3

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Mar 2 04:15:00 -- Mar 3 04:15:00