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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	23543	51.0%	6.1 MB	66.5%
innd	17875	38.7%	2.3 MB	25.6%
innfeed	3518	7.6%	609.5 KB	6.5%
nnrpd	1128	2.4%	124.0 KB	1.3%
nocem	65	0.1%	7.3 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	46130	100.0%	9.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	384018	56.2%
Negative hits	275995	40.4%
Do not exist	22807	3.3%
Cache misses	419	0.1%
TOTAL: 4	683239	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.293	0.0%	27	0.000	10.852	51.000
article cleanup	00:00:00.124	0.0%	21978	0.000	0.006	0.024
article logging	00:00:00.477	0.0%	22554	0.000	0.021	0.171
article parse	00:00:02.910	0.0%	85283	0.000	0.034	0.412
article write	00:01:16.589	0.1%	18858	0.153	4.061	33.261
artlog/artcncl	00:00:00.000	0.0%	27	0.000	0.000	0.000
artlog/artparse	00:00:00.020	0.0%	873	0.000	0.023	1.000
data move	00:00:00.243	0.0%	643262	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.069	0.0%	26	0.000	2.654	29.000
hishave/artcncl	00:00:00.030	0.0%	27	0.000	1.111	17.000
hishave/artparse	00:00:00.000	0.0%	866	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:42.650	0.0%	683466	0.001	0.062	0.538
history sync	00:00:00.927	0.0%	338	0.000	2.743	11.500
history write	00:00:54.158	0.1%	21947	0.038	2.468	10.927
hiswrite/artcncl	00:00:00.012	0.0%	1	12.000	12.000	12.000
hiswrite/artparse	00:00:02.155	0.0%	866	0.000	2.488	17.000
idle	23:45:33.591	99.6%	643683	67.698	132.882	482.466
nntp read	00:00:02.593	0.0%	652256	0.002	0.004	0.007
overview write	00:01:02.072	0.1%	18858	0.098	3.292	24.727
perl filter	00:00:30.276	0.0%	21939	1.049	1.380	1.884
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.319	0.0%	37781	0.000	0.008	0.029
TOTAL: 23:50:49.097	23:50:09.508	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.046	0.0%	19148	0.000	0.002	0.016
article prepare	00:00:00.005	0.0%	11304	0.000	0.000	0.013
article read	00:00:00.205	0.0%	1229	0.000	0.167	4.273
backlog stats	00:00:00.218	0.0%	425313	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.772	0.0%	340481	0.000	0.005	0.009
data write	00:00:01.863	0.0%	314032	0.001	0.006	0.012
idle	23:54:20.958	100.0%	425313	124.999	202.347	662.286
status file	00:00:00.207	0.0%	296	0.000	0.699	20.000
TOTAL: 23:54:35.203	23:54:25.274	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	57:45:14.471	99.9%	699	339.000	297445.595	600208.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.016	0.0%	1546	0.000	0.010	0.167
readart	00:00:00.043	0.0%	3	0.000	14.333	42.000
TOTAL: 57:50:15.713	57:45:14.530	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	17938	3887	14020	31	21%	23:11:41
2	news-out.aioe.org	5	19336	3775	15278	283	19%	24:21:42
3	feeder.eternal-september.org	3	20548	3087	17280	181	15%	23:36:25
4	csiph-out.news.xs4all.nl	859	20318	1270	18156	892	6%	71:26:39
5	csiph-out.feeder.erje.net	1404	92687	1165	90426	1096	1%	116:38:36
6	newsfeed.neva.ru	145	18059	1143	16688	228	6%	71:19:05
7	news-out.mixmin.net	3	19718	1045	18309	364	5%	24:08:49
8	csiph-out.news.weretis.net	4	36099	1003	34903	193	2%	44:19:19
9	newsfeed.fu-berlin.de	26	17504	847	16332	325	4%	26:08:11
10	csiph-out.feed.uzoreto.com	864	29159	360	28432	367	1%	71:11:17
11	news.freedyn.net	1	21541	351	21022	168	1%	23:59:57
12	news.fcku.it	15	2218	250	1967	1	11%	21:41:15
13	csiph-out.news.tnetconsulting.net	1	18723	133	18572	18	0%	23:59:56
14	news-out.neodome.net	1	19504	123	19359	22	0%	23:59:54
15	nntp.pasdenom.info	2	11721	95	11607	19	0%	20:42:30
16	news.swapon.de	2	1685	45	1638	2	2%	26:38:05
17	news.samoylyk.net	1	19123	16	19104	3	0%	23:59:50
18	news.bbs.nz	2	18577	7	18570	0	0%	23:59:54
19	localhost	29	3	3	0	0	100%	00:00:02
20	xanadu-bbs.net	16	100	0	100	0	0%	08:12:42
TOTAL: 20		3386	404561	18605	381763	4193	4%	693:35:49

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.3 MB	2.5 KB	1.9 MB	13.3 MB	85%	3.5 KB
2	news-out.aioe.org	8.6 MB	6.3 KB	578.2 KB	9.2 MB	93%	2.3 KB
3	feeder.eternal-september.org	7.8 MB	11.9 KB	5.5 MB	13.4 MB	58%	4.2 KB
4	csiph-out.feeder.erje.net	7.1 MB	7.8 KB	56.7 MB	63.8 MB	11%	28.9 KB
5	csiph-out.news.xs4all.nl	3.3 MB	0.9 KB	9.8 MB	13.2 MB	25%	6.2 KB
6	csiph-out.news.weretis.net	3.1 MB	2.4 KB	1.6 MB	4.7 MB	66%	4.0 KB
7	news-out.mixmin.net	3.0 MB	8.8 KB	602.5 KB	3.6 MB	83%	2.6 KB
8	newsfeed.neva.ru	2.8 MB	14.5 KB	617.6 KB	3.4 MB	81%	2.5 KB
9	newsfeed.fu-berlin.de	2.1 MB	0.0 KB	755.0 KB	2.8 MB	73%	2.4 KB
10	csiph-out.feed.uzoreto.com	1.1 MB	6.8 KB	8.5 MB	9.6 MB	11%	13.6 KB
11	news.freedyn.net	1.1 MB	5.0 KB	1.4 MB	2.5 MB	43%	5.0 KB
12	csiph-out.news.tnetconsulting.net	454.8 KB	7.8 KB	163.7 KB	626.3 KB	72%	4.1 KB
13	news.fcku.it	420.4 KB	0.0 KB	2.3 KB	422.6 KB	99%	1.7 KB
14	news-out.neodome.net	399.5 KB	9.7 KB	490.1 KB	899.4 KB	44%	6.2 KB
15	nntp.pasdenom.info	203.7 KB	3.4 KB	28.2 KB	235.3 KB	86%	2.1 KB
16	news.swapon.de	135.9 KB	0.0 KB	871.5 KB	1007.4 KB	13%	21.4 KB
17	news.samoylyk.net	53.5 KB	8.9 KB	8.9 KB	71.3 KB	75%	3.8 KB
18	news.bbs.nz	17.2 KB	0.0 KB	0.0 KB	17.2 KB	100%	2.5 KB
19	localhost	3.0 KB	0.0 KB	0.0 KB	3.0 KB	100%	1.0 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		53.1 MB	97.0 KB	89.5 MB	142.7 MB	37%	6.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 9 04:15:00 - 04:59:59	220	1.2%	0.08	732.8 KB	1.3%	0.27
Apr 9 05:00:00 - 05:59:59	439	2.3%	0.12	1.2 MB	2.3%	0.35
Apr 9 06:00:00 - 06:59:59	514	2.7%	0.14	1.8 MB	3.3%	0.50
Apr 9 07:00:00 - 07:59:59	741	3.9%	0.21	2.0 MB	3.7%	0.57
Apr 9 08:00:00 - 08:59:59	915	4.8%	0.25	2.6 MB	4.8%	0.73
Apr 9 09:00:00 - 09:59:59	852	4.5%	0.24	2.8 MB	5.2%	0.79
Apr 9 10:00:00 - 10:59:59	935	4.9%	0.26	2.7 MB	5.1%	0.78
Apr 9 11:00:00 - 11:59:59	885	4.7%	0.25	2.1 MB	3.9%	0.59
Apr 9 12:00:00 - 12:59:59	882	4.7%	0.24	2.1 MB	3.9%	0.60
Apr 9 13:00:00 - 13:59:59	923	4.9%	0.26	2.5 MB	4.6%	0.70
Apr 9 14:00:00 - 14:59:59	1116	5.9%	0.31	3.3 MB	6.1%	0.94
Apr 9 15:00:00 - 15:59:59	1195	6.3%	0.33	2.9 MB	5.4%	0.83
Apr 9 16:00:00 - 16:59:59	1181	6.2%	0.33	2.8 MB	5.3%	0.81
Apr 9 17:00:00 - 17:59:59	1140	6.0%	0.32	3.2 MB	5.9%	0.90
Apr 9 18:00:00 - 18:59:59	1087	5.7%	0.30	3.1 MB	5.8%	0.89
Apr 9 19:00:00 - 19:59:59	981	5.2%	0.27	2.5 MB	4.6%	0.71
Apr 9 20:00:00 - 20:59:59	930	4.9%	0.26	2.6 MB	4.8%	0.73
Apr 9 21:00:00 - 21:59:59	908	4.8%	0.25	2.6 MB	4.9%	0.75
Apr 9 22:00:00 - 22:59:59	733	3.9%	0.20	2.6 MB	4.8%	0.73
Apr 9 23:00:00 - 23:59:59	600	3.2%	0.17	1.9 MB	3.6%	0.55
Apr 10 00:00:00 - 00:59:59	512	2.7%	0.14	1.6 MB	3.1%	0.47
Apr 10 01:00:00 - 01:59:59	448	2.4%	0.12	1.5 MB	2.8%	0.43
Apr 10 02:00:00 - 02:59:59	388	2.1%	0.11	1.5 MB	2.7%	0.41
Apr 10 03:00:00 - 03:59:59	311	1.6%	0.09	918.4 KB	1.7%	0.26
Apr 10 04:00:00 - 04:15:00	75	0.4%	0.08	188.9 KB	0.3%	0.21
TOTAL: 24:00:00	18911	100.0%	0.22	53.7 MB	100.0%	0.64

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	902	22	1	879
2	csiph-out.feeder.erje.net	867	46	4	817
3	newsfeed.fu-berlin.de	723	44	0	679
4	news-out.aioe.org	397	63	2	332
5	news-out.mixmin.net	388	9	3	376
6	csiph-out.feed.uzoreto.com	370	8	3	359
7	newsfeed.neva.ru	242	100	5	137
8	csiph-out.news.weretis.net	239	44	1	194
9	feeder.eternal-september.org	185	27	5	153
10	news.freedyn.net	178	6	3	169
11	newsfeeds.xmission.com	43	2	1	40
12	news-out.neodome.net	22	2	4	16
13	nntp.pasdenom.info	19	0	1	18
14	csiph-out.news.tnetconsulting.net	13	11	2	0
15	news.swapon.de	4	0	0	4
16	news.samoylyk.net	3	0	3	0
17	news.fcku.it	1	0	0	1
TOTAL: 17		4596	384	38	4174

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	60
alt.computer.workshop	43
spline.eisfair	23
alt.bbs.synchronet	21
mozilla.general	19
mozilla.support.seamonkey	19
alt.politics.usa	15
alt.survival	15
mozilla.support.firefox	9
oesterreich.tratsch	8
lada.auto	8
mozilla.dev.platform	6
alt.politics	6
mozilla.dev.l10n.new-locales	6
tor.forsale	6
lada.movies	6
lada.kitchen	5
alt.binaries.pictures.purebeauty	5
it-alt.sport.calcio.juventus	4
spline.fli4l.dev	4
TOTAL: 77	384

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1588
EMP (phn path)	476
EMP (phl)	296
EMP (phn nph)	163
0	116
HTML Multipart	25
Too many newsgroups	22
Scoring filter	17
Binary: misplaced binary	8
Binary Payload	6
Too many newsgroups (meow)	3
HTML post	2
TOTAL: 12	2722

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	145
	csiph-out.feed.uzoreto.com	28
	csiph-out.news.xs4all.nl	21
	TOTAL: 3	194
Huge articles
	csiph-out.feeder.erje.net	636
	csiph-out.news.xs4all.nl	65
	csiph-out.feed.uzoreto.com	61
	feeder.eternal-september.org	42
	newsfeeds.xmission.com	29
	csiph-out.news.weretis.net	16
	news-out.neodome.net	8
	news.freedyn.net	7
	news-out.mixmin.net	3
	news.swapon.de	2
	TOTAL: 10	869
Including strange strings
	newsfeed.fu-berlin.de	403
	news-out.aioe.org	119
	csiph-out.news.weretis.net	16
	newsfeeds.xmission.com	12
	news-out.mixmin.net	10
	newsfeed.neva.ru	6
	csiph-out.news.xs4all.nl	3
	csiph-out.feed.uzoreto.com	3
	news.swapon.de	2
	feeder.eternal-september.org	1
	TOTAL: 11	576
No colon-space in header
	csiph-out.news.xs4all.nl	5
	csiph-out.feeder.erje.net	1
	TOTAL: 2	6
TOTAL: 4		1645

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.samoylyk.net	19577	531	18348	7	0	2%	23:58:40
2	fu-berlin.de	17847	529	17318	0	0	2%	23:58:45
3	news.freedyn.net	18940	526	17929	21	0	2%	23:53:36
4	xanadu-bbs	6498	361	5067	0	13483	5%	23:59:53
5	news.bbs.nz	35617	309	17993	3	0	0%	23:50:15
6	tnet	19838	110	18222	0	0	0%	23:50:59
7	newsfeed.xs4all.nl	18084	57	17417	7	115	0%	23:54:14
8	xmission	16692	42	14296	2	0	0%	23:58:53
9	aioe	14438	18	13727	0	0	0%	23:53:11
10	erje	19033	17	17466	82	138	0%	23:57:55
11	news.uzoreto.com	18137	16	17813	26	0	0%	23:50:15
12	neodome.net	19429	15	18679	0	0	0%	23:50:15
13	usenet.pasdenom.info	15976	13	15316	4	2963	0%	23:59:53
14	news.mixmin.net	18150	13	17038	0	0	0%	23:57:17
15	eternal-september	15773	3	14998	12	0	0%	23:59:53
16	news.swapon.de	1662	3	1619	0	0	0%	23:31:43
17	weretis.net	17426	3	17194	1	0	0%	23:58:43
18	neva.ru	17080	3	16881	89	0	0%	23:59:53
19	news.fcku.it	1839	0	1829	0	0	0%	20:55:00
TOTAL: 19		312036	2569	279150	254	16699	0%	451:19:13

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	fu-berlin.de	5.2 MB	0.0 KB	5.2 MB	0.1 KB/s	10.0 KB	23:58:45
2	news.samoylyk.net	5.2 MB	12.2 KB	5.2 MB	0.1 KB/s	9.9 KB	23:58:40
3	news.freedyn.net	5.2 MB	64.0 KB	5.2 MB	0.1 KB/s	9.8 KB	23:53:36
4	xanadu-bbs	2.7 MB	0.0 KB	2.7 MB	0.0 KB/s	7.5 KB	23:59:53
5	news.bbs.nz	872.4 KB	8.7 KB	881.1 KB	0.0 KB/s	2.8 KB	23:50:15
6	tnet	320.1 KB	0.0 KB	320.1 KB	0.0 KB/s	2.9 KB	23:50:59
7	newsfeed.xs4all.nl	176.6 KB	17.0 KB	193.6 KB	0.0 KB/s	3.0 KB	23:54:14
8	xmission	97.7 KB	3.7 KB	101.4 KB	0.0 KB/s	2.3 KB	23:58:53
9	usenet.pasdenom.info	62.9 KB	9.2 KB	72.1 KB	0.0 KB/s	4.2 KB	23:59:53
10	aioe	35.0 KB	0.0 KB	35.0 KB	0.0 KB/s	1.9 KB	23:53:11
11	news.uzoreto.com	28.8 KB	108.6 KB	137.4 KB	0.0 KB/s	3.3 KB	23:50:15
12	erje	26.3 KB	333.9 KB	360.3 KB	0.0 KB/s	3.6 KB	23:57:55
13	neodome.net	25.0 KB	0.0 KB	25.0 KB	0.0 KB/s	1.7 KB	23:50:15
14	news.mixmin.net	24.3 KB	0.0 KB	24.3 KB	0.0 KB/s	1.9 KB	23:57:17
15	eternal-september	3.0 KB	140.1 KB	143.1 KB	0.0 KB/s	9.5 KB	23:59:53
16	news.swapon.de	3.0 KB	0.0 KB	3.0 KB	0.0 KB/s	1.0 KB	23:31:43
17	weretis.net	3.0 KB	1.2 KB	4.2 KB	0.0 KB/s	1.0 KB	23:58:43
18	neva.ru	3.0 KB	285.4 KB	288.3 KB	0.0 KB/s	3.1 KB	23:59:53
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:55:00
TOTAL: 19		19.8 MB	984.0 KB	20.8 MB	0.0 KB/s	7.5 KB	451:19:13

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	96-42-18-55.dhcp.mdsn.wi.charter.com	29	3	3.0 KB	3	3	3	08:16:04
TOTAL: 1		29	3	3.0 KB	3	3	3	57:50:14

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.mdsn.wi.charter.com	29	3	3.0 KB	3	3	3	08:16:04
2	*.cust.centrio.cz	1	0	0.0 KB	0	0	0	00:30:14
3	*.upc-a.chello.nl	70	0	0.0 KB	0	0	0	22:32:15
4	unresolved	79	0	0.0 KB	0	0	0	23:59:55
5	*.ph.ph.cox.net	5	0	0.0 KB	0	0	0	02:31:44
TOTAL: 5		184	3	3.0 KB	3	3	3	57:50:14

NNRP auth users [Top 20]:

User	Conn
ohlandl	3
ctomczyk	1
TOTAL: 2	4

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.778	1.118	0.000	23:59:47
a131033.upc-a.chello.nl	4.387	1.210	0.000	22:32:15
96-42-18-55.dhcp.mdsn.wi.charter.com	2.037	0.495	0.056	08:16:04
ip72-222-200-117.ph.ph.cox.net	0.493	0.107	0.000	02:31:44
5-168-143-94.cust.centrio.cz	0.055	0.023	0.003	00:30:14
94.163.92.57	0.125	0.035	0.000	00:00:02
5.87.8.207	0.066	0.016	0.000	00:00:01
94.167.169.204	0.067	0.008	0.000	00:00:01
5.87.38.28	0.066	0.015	0.000	00:00:01
94.167.173.234	0.065	0.016	0.000	00:00:01
94.167.250.220	0.073	0.008	0.000	00:00:01
TOTAL: 11	12.212	3.051	0.059	57:50:14

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
a131033.upc-a.chello.nl	70
ip72-222-200-117.ph.ph.cox.net	5
94.163.92.57	2
5-168-143-94.cust.centrio.cz	1
5.87.38.28	1
94.167.169.204	1
94.167.250.220	1
5.87.8.207	1
94.167.173.234	1
TOTAL: 10	155

NNRP client timeouts [Top 20]:

System	Conn	Peer
96-42-18-55.dhcp.mdsn.wi.charter.com	7	0
ip72-222-200-117.ph.ph.cox.net	5	0
5-168-143-94.cust.centrio.cz	1	0
TOTAL: 3	13	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Apr 9 04:15:00 -- Apr 10 04:15:00