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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	22335	47.5%	5.9 MB	63.6%
innd	17111	36.4%	2.3 MB	24.9%
innfeed	6609	14.1%	980.8 KB	10.4%
nnrpd	833	1.8%	91.9 KB	1.0%
nocem	85	0.2%	9.1 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	46974	100.0%	9.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	379020	57.2%
Negative hits	260979	39.4%
Do not exist	21601	3.3%
Cache misses	1239	0.2%
TOTAL: 4	662839	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.801	0.0%	335	0.000	11.346	51.000
article cleanup	00:00:00.103	0.0%	21558	0.000	0.005	0.032
article logging	00:00:00.341	0.0%	22140	0.000	0.015	0.121
article parse	00:00:01.121	0.0%	68359	0.000	0.016	0.139
article write	00:00:08.509	0.0%	18621	0.116	0.457	6.137
artlog/artcncl	00:00:00.003	0.0%	335	0.000	0.009	0.010
artlog/artparse	00:00:00.004	0.0%	483	0.000	0.008	0.500
data move	00:00:00.212	0.0%	620094	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.598	0.0%	335	0.000	1.785	13.000
hishave/artcncl	00:00:00.390	0.0%	335	0.000	1.164	13.000
hishave/artparse	00:00:00.002	0.0%	479	0.000	0.004	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:13.823	0.0%	674662	0.001	0.020	0.208
history sync	00:00:01.018	0.0%	377	0.000	2.700	12.500
history write	00:00:30.691	0.0%	21502	0.038	1.427	9.118
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.522	0.0%	479	0.000	1.090	10.000
idle	23:57:52.388	99.7%	624543	78.937	138.137	602.285
nntp read	00:00:02.330	0.0%	627293	0.001	0.004	0.009
overview write	00:01:44.635	0.1%	18621	0.117	5.619	1105.592
perl filter	00:00:28.963	0.0%	21498	1.119	1.347	2.226
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.287	0.0%	37325	0.000	0.008	0.036
TOTAL: 24:01:48.552	24:01:09.741	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.053	0.0%	45245	0.000	0.001	0.022
article prepare	00:00:00.001	0.0%	21720	0.000	0.000	0.000
article read	00:00:03.687	0.0%	3474	0.000	1.061	1.634
backlog stats	00:00:00.252	0.0%	441674	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.549	0.0%	345351	0.001	0.004	0.012
data write	00:00:01.824	0.0%	332754	0.001	0.005	0.012
idle	23:53:43.346	100.0%	441674	40.804	194.767	712.722
status file	00:00:01.017	0.0%	1575	0.000	0.646	2.000
TOTAL: 23:54:00.128	23:53:51.729	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	37:08:10.496	99.8%	573	215.500	233316.747	600150.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.002	0.0%	1318	0.000	0.002	0.167
readart	00:00:00.355	0.0%	33	0.000	10.758	55.000
TOTAL: 37:13:06.485	37:08:10.853	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	18574	4562	13960	52	24%	25:44:39
2	news-out.aioe.org	4	18891	3720	14954	217	19%	24:09:38
3	feeder.eternal-september.org	4	21161	2622	18247	292	12%	26:16:54
4	csiph-out.feeder.erje.net	1440	91996	1283	90196	517	1%	118:46:32
5	csiph-out.news.weretis.net	5	40947	1244	39552	151	3%	52:38:12
6	newsfeed.neva.ru	140	19108	1054	17791	263	5%	71:30:08
7	news-out.mixmin.net	1	19357	1025	17936	396	5%	23:59:53
8	csiph-out.news.xs4all.nl	861	19948	1011	18195	742	5%	71:26:29
9	newsfeed.fu-berlin.de	28	17558	779	16486	293	4%	27:43:53
10	news.freedyn.net	3	21115	349	20687	79	1%	24:09:01
11	csiph-out.feed.uzoreto.com	864	27854	325	27219	310	1%	71:11:44
12	news.fcku.it	9	2403	300	2102	1	12%	22:25:28
13	csiph-out.news.tnetconsulting.net	2	26944	296	26475	173	1%	33:11:59
14	news-out.neodome.net	2	19456	162	19284	10	0%	23:59:41
15	nntp.pasdenom.info	5	13576	79	13483	14	0%	23:57:01
16	news.swapon.de	2	1504	44	1452	8	2%	22:42:40
17	news.bbs.nz	2	18580	25	18555	0	0%	23:59:48
18	localhost	36	10	10	0	0	100%	00:00:04
19	news.samoylyk.net	2	18582	7	18573	2	0%	23:59:29
20	xanadu-bbs.net	23	1022	0	1022	0	0%	19:10:39
TOTAL: 20		3435	418586	18897	396169	3520	4%	731:03:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	13.7 MB	2.5 KB	4.2 MB	17.9 MB	76%	4.0 KB
2	news-out.aioe.org	8.9 MB	4.4 KB	528.4 KB	9.4 MB	94%	2.4 KB
3	csiph-out.feeder.erje.net	7.4 MB	88.6 KB	9.4 MB	16.9 MB	43%	9.6 KB
4	feeder.eternal-september.org	6.5 MB	4.4 KB	2.1 MB	8.7 MB	75%	3.1 KB
5	csiph-out.news.weretis.net	4.3 MB	20.1 KB	1.9 MB	6.1 MB	69%	4.5 KB
6	news-out.mixmin.net	3.4 MB	4.5 KB	778.2 KB	4.1 MB	81%	3.0 KB
7	csiph-out.news.xs4all.nl	3.0 MB	4.5 KB	11.2 MB	14.1 MB	21%	8.3 KB
8	newsfeed.neva.ru	2.5 MB	13.5 KB	818.1 KB	3.3 MB	75%	2.6 KB
9	newsfeed.fu-berlin.de	1.8 MB	0.0 KB	627.6 KB	2.4 MB	74%	2.3 KB
10	news.freedyn.net	1.3 MB	5.8 KB	1.4 MB	2.7 MB	48%	6.4 KB
11	csiph-out.feed.uzoreto.com	1.2 MB	4.4 KB	8.0 MB	9.3 MB	13%	15.0 KB
12	csiph-out.news.tnetconsulting.net	945.1 KB	7.7 KB	820.9 KB	1.7 MB	53%	3.8 KB
13	news-out.neodome.net	564.2 KB	4.6 KB	13.0 KB	581.8 KB	96%	3.4 KB
14	news.fcku.it	517.6 KB	0.0 KB	3.4 KB	521.0 KB	99%	1.7 KB
15	nntp.pasdenom.info	181.5 KB	0.0 KB	25.3 KB	206.7 KB	87%	2.2 KB
16	news.swapon.de	127.6 KB	1.9 KB	3.1 MB	3.3 MB	3%	64.3 KB
17	news.bbs.nz	37.4 KB	0.0 KB	0.0 KB	37.4 KB	100%	1.5 KB
18	news.samoylyk.net	21.6 KB	4.5 KB	4.5 KB	30.7 KB	70%	3.4 KB
19	localhost	17.6 KB	0.0 KB	0.0 KB	17.6 KB	100%	1.8 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		56.3 MB	171.5 KB	44.8 MB	101.3 MB	55%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 2 04:15:00 - 04:59:59	276	1.5%	0.10	1.0 MB	1.9%	0.39
Apr 2 05:00:00 - 05:59:59	333	1.8%	0.09	1004.5 KB	1.8%	0.28
Apr 2 06:00:00 - 06:59:59	544	3.0%	0.15	1.8 MB	3.4%	0.52
Apr 2 07:00:00 - 07:59:59	730	4.0%	0.20	1.9 MB	3.5%	0.54
Apr 2 08:00:00 - 08:59:59	799	4.4%	0.22	1.9 MB	3.6%	0.55
Apr 2 09:00:00 - 09:59:59	896	4.9%	0.25	2.5 MB	4.7%	0.72
Apr 2 10:00:00 - 10:59:59	884	4.8%	0.25	2.7 MB	5.1%	0.77
Apr 2 11:00:00 - 11:59:59	944	5.2%	0.26	2.6 MB	4.8%	0.74
Apr 2 12:00:00 - 12:59:59	918	5.0%	0.26	2.3 MB	4.3%	0.66
Apr 2 13:00:00 - 13:59:59	1092	6.0%	0.30	2.7 MB	5.0%	0.77
Apr 2 14:00:00 - 14:59:59	1005	5.5%	0.28	2.8 MB	5.2%	0.80
Apr 2 15:00:00 - 15:59:59	1099	6.0%	0.31	3.4 MB	6.3%	0.96
Apr 2 16:00:00 - 16:59:59	1009	5.5%	0.28	2.6 MB	4.8%	0.74
Apr 2 17:00:00 - 17:59:59	1080	5.9%	0.30	3.0 MB	5.5%	0.84
Apr 2 18:00:00 - 18:59:59	1056	5.8%	0.29	3.9 MB	7.2%	1.10
Apr 2 19:00:00 - 19:59:59	1008	5.5%	0.28	3.0 MB	5.6%	0.85
Apr 2 20:00:00 - 20:59:59	980	5.4%	0.27	3.1 MB	5.8%	0.90
Apr 2 21:00:00 - 21:59:59	821	4.5%	0.23	2.2 MB	4.1%	0.64
Apr 2 22:00:00 - 22:59:59	703	3.8%	0.20	2.5 MB	4.6%	0.70
Apr 2 23:00:00 - 23:59:59	544	3.0%	0.15	1.5 MB	2.9%	0.44
Apr 3 00:00:00 - 00:59:59	400	2.2%	0.11	1.2 MB	2.3%	0.35
Apr 3 01:00:00 - 01:59:59	408	2.2%	0.11	1.6 MB	2.9%	0.45
Apr 3 02:00:00 - 02:59:59	353	1.9%	0.10	1.4 MB	2.6%	0.39
Apr 3 03:00:00 - 03:59:59	342	1.9%	0.10	972.3 KB	1.8%	0.27
Apr 3 04:00:00 - 04:15:00	92	0.5%	0.10	262.1 KB	0.5%	0.29
TOTAL: 24:00:00	18316	100.0%	0.21	53.9 MB	100.0%	0.64

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	743	47	2	694
2	newsfeed.fu-berlin.de	726	88	0	638
3	csiph-out.feeder.erje.net	473	110	13	350
4	news-out.mixmin.net	403	2	2	399
5	news-out.aioe.org	326	83	2	241
6	csiph-out.feed.uzoreto.com	312	14	2	296
7	feeder.eternal-september.org	290	29	3	258
8	newsfeed.neva.ru	266	84	6	176
9	csiph-out.news.weretis.net	163	69	2	92
10	csiph-out.news.tnetconsulting.net	89	27	3	59
11	news.freedyn.net	79	3	3	73
12	newsfeeds.xmission.com	62	1	1	60
13	news.swapon.de	20	0	1	19
14	nntp.pasdenom.info	14	0	0	14
15	news-out.neodome.net	11	3	2	6
16	news.samoylyk.net	2	0	2	0
17	news.fcku.it	1	1	0	0
TOTAL: 17		3980	561	44	3375

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	93
lada.talk	68
spline.eisfair	55
alt.binaries.pictures.purebeauty	44
alt.bbs.synchronet	37
alt.survival	25
mozilla.support.thunderbird	22
alt.politics.usa	18
0.test	12
mozilla.general	11
free.it.religioni.scientology	10
oesterreich.tratsch	8
lada.auto	8
mozilla.support.seamonkey	8
alt.binaries.ebooks	7
ba.forsale	6
it-alt.comp.software.gratuito	6
oesterreich.test	5
rocksolid.shared.test	5
alt.music.pink-floyd.publius	4
TOTAL: 84	561

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1475
EMP (phn path)	351
EMP (phl)	163
0	119
Too many newsgroups	80
EMP (phn nph)	72
HTML Multipart	27
Binary Payload	19
Binary: misplaced binary	8
Scoring filter	1
Too many newsgroups (low_xpost)	1
HTML post	1
TOTAL: 12	2317

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	60
	csiph-out.news.xs4all.nl	4
	csiph-out.feed.uzoreto.com	4
	TOTAL: 3	68
Huge articles
	csiph-out.feeder.erje.net	157
	csiph-out.news.xs4all.nl	121
	csiph-out.feed.uzoreto.com	91
	newsfeeds.xmission.com	50
	csiph-out.news.weretis.net	15
	feeder.eternal-september.org	15
	news.freedyn.net	9
	news.swapon.de	7
	news-out.mixmin.net	4
	csiph-out.news.tnetconsulting.net	4
	TOTAL: 10	473
Including strange strings
	newsfeed.fu-berlin.de	406
	news-out.aioe.org	105
	csiph-out.news.weretis.net	21
	news.swapon.de	12
	news-out.mixmin.net	10
	newsfeeds.xmission.com	10
	csiph-out.feeder.erje.net	8
	newsfeed.neva.ru	3
	news.freedyn.net	2
	csiph-out.news.xs4all.nl	2
	TOTAL: 12	581
No colon-space in header
	csiph-out.news.xs4all.nl	2
	csiph-out.feeder.erje.net	2
	TOTAL: 2	4
TOTAL: 4		1126

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	xanadu-bbs	46769	2865	39360	40	2	2584	6%	23:59:55
2	news.bbs.nz	34878	484	17354	15	0	0	1%	23:59:31
3	news.samoylyk.net	19753	407	17894	8	0	0	2%	23:59:50
4	fu-berlin.de	17300	402	16898	0	0	0	2%	23:59:55
5	news.freedyn.net	18387	399	17493	24	0	0	2%	23:59:55
6	tnet	19508	155	17758	0	0	0	0%	23:59:55
7	newsfeed.xs4all.nl	18020	76	17193	15	0	107	0%	23:59:54
8	neva.ru	16787	56	16418	108	0	0	0%	23:59:55
9	usenet.pasdenom.info	21087	46	18028	32	0	44	0%	23:59:44
10	aioe	14027	36	13444	0	0	0	0%	23:59:53
11	xmission	16310	35	13489	2	0	0	0%	23:59:55
12	erje	17960	25	16799	27	0	0	0%	23:59:54
13	neodome.net	18749	24	18076	0	0	0	0%	23:59:52
14	news.mixmin.net	17477	20	16626	0	0	0	0%	23:59:52
15	eternal-september	15820	16	15182	0	0	0	0%	23:59:50
16	news.uzoreto.com	17892	15	17520	86	0	0	0%	23:59:55
17	weretis.net	16831	10	16601	1	0	0	0%	23:59:55
18	news.swapon.de	1642	10	1585	0	0	0	0%	23:58:39
19	news.fcku.it	1953	0	1947	0	0	0	0%	21:56:14
TOTAL: 19		351150	5081	309665	358	2	2735	1%	453:52:33

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	16.6 MB	145.9 KB	16.7 MB	0.2 KB/s	5.9 KB	23:59:55
2	news.freedyn.net	4.6 MB	30.3 KB	4.6 MB	0.1 KB/s	11.2 KB	23:59:55
3	fu-berlin.de	4.6 MB	0.0 KB	4.6 MB	0.1 KB/s	11.7 KB	23:59:55
4	news.samoylyk.net	4.6 MB	21.7 KB	4.6 MB	0.1 KB/s	11.4 KB	23:59:50
5	news.bbs.nz	1.5 MB	30.5 KB	1.5 MB	0.0 KB/s	3.1 KB	23:59:31
6	tnet	466.3 KB	0.0 KB	466.3 KB	0.0 KB/s	3.0 KB	23:59:55
7	newsfeed.xs4all.nl	301.1 KB	45.1 KB	346.2 KB	0.0 KB/s	3.8 KB	23:59:54
8	usenet.pasdenom.info	241.6 KB	139.9 KB	381.4 KB	0.0 KB/s	4.9 KB	23:59:44
9	neva.ru	137.2 KB	328.1 KB	465.3 KB	0.0 KB/s	2.8 KB	23:59:55
10	eternal-september	99.0 KB	0.0 KB	99.0 KB	0.0 KB/s	6.2 KB	23:59:50
11	xmission	78.3 KB	2.2 KB	80.5 KB	0.0 KB/s	2.2 KB	23:59:55
12	aioe	67.9 KB	0.0 KB	67.9 KB	0.0 KB/s	1.9 KB	23:59:53
13	erje	37.8 KB	269.0 KB	306.8 KB	0.0 KB/s	5.9 KB	23:59:54
14	neodome.net	36.3 KB	0.0 KB	36.3 KB	0.0 KB/s	1.5 KB	23:59:52
15	news.mixmin.net	30.7 KB	0.0 KB	30.7 KB	0.0 KB/s	1.5 KB	23:59:52
16	news.uzoreto.com	27.1 KB	477.3 KB	504.4 KB	0.0 KB/s	5.0 KB	23:59:55
17	weretis.net	17.6 KB	1.1 KB	18.7 KB	0.0 KB/s	1.7 KB	23:59:55
18	news.swapon.de	17.1 KB	0.0 KB	17.1 KB	0.0 KB/s	1.7 KB	23:58:39
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:56:14
TOTAL: 19		33.4 MB	1.5 MB	34.8 MB	0.0 KB/s	6.6 KB	453:52:33

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	96-42-18-55.dhcp.mdsn.wi.charter.com	20	23	48.6 KB	14	10	8	04:56:05
2	a131033.upc-a.chello.nl	23	9	24.0 KB	2	0	0	05:00:52
3	5-168-143-94.cust.centrio.cz	4	1	1.6 KB	1	0	0	02:00:15
TOTAL: 3		47	33	74.2 KB	17	10	8	37:13:05

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.mdsn.wi.charter.com	20	23	48.6 KB	14	10	8	04:56:05
2	*.upc-a.chello.nl	23	9	24.0 KB	2	0	0	05:00:52
3	*.cust.centrio.cz	4	1	1.6 KB	1	0	0	02:00:15
4	unresolved	76	0	0.0 KB	0	0	0	24:15:43
5	*.ph.ph.cox.net	2	0	0.0 KB	0	0	0	01:00:07
TOTAL: 5		125	33	74.2 KB	17	10	8	37:13:05

NNRP auth users [Top 20]:

User	Conn
ohlandl	8
ctomczyk	4
TOTAL: 2	12

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	5.451	1.154	0.000	24:15:40
a131033.upc-a.chello.nl	1.628	0.286	0.000	05:00:52
96-42-18-55.dhcp.mdsn.wi.charter.com	1.781	0.407	0.019	04:56:05
5-168-143-94.cust.centrio.cz	0.270	0.080	0.009	02:00:15
ip72-222-200-117.ph.ph.cox.net	0.219	0.029	0.000	01:00:07
94.161.124.188	0.059	0.017	0.000	00:00:01
94.167.140.136	0.063	0.016	0.000	00:00:01
124.156.240.118	0.062	0.016	0.000	00:00:00
TOTAL: 8	9.533	2.005	0.028	37:13:05

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	73
ip72-222-200-117.ph.ph.cox.net	2
124.156.240.118	1
94.161.124.188	1
94.167.140.136	1
TOTAL: 5	78

NNRP unrecognized commands (by host):

System	Conn
124.156.240.118	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
96-42-18-55.dhcp.mdsn.wi.charter.com	4	0
5-168-143-94.cust.centrio.cz	4	0
ip72-222-200-117.ph.ph.cox.net	2	0
91.187.33.87	1	0
TOTAL: 4	11	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	32
2	comp.lang.javascript	1
TOTAL: 2		33

Daily Usenet report for csiph.com

Apr 2 04:15:00 -- Apr 3 04:15:00