Daily Usenet report for csiph.com: Jan 10 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20899	48.6%	5.3 MB	63.6%
innd	17944	41.7%	2.3 MB	28.0%
innfeed	3442	8.0%	643.1 KB	7.5%
nnrpd	682	1.6%	74.8 KB	0.9%
nocem	29	0.1%	3.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	42997	100.0%	8.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	339366	57.9%
Negative hits	226425	38.6%
Do not exist	20424	3.5%
Cache misses	299	0.1%
TOTAL: 4	586514	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.264	0.0%	23	0.000	11.478	18.625
article cleanup	00:00:00.113	0.0%	19883	0.000	0.006	0.029
article logging	00:00:00.312	0.0%	20332	0.000	0.015	0.593
article parse	00:00:00.909	0.0%	65420	0.000	0.014	0.047
article write	00:00:12.199	0.0%	16228	0.154	0.752	23.741
artlog/artcncl	00:00:00.000	0.0%	23	0.000	0.000	0.000
artlog/artparse	00:00:00.005	0.0%	554	0.000	0.009	0.250
data move	00:00:00.180	0.0%	550479	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.023	0.0%	22	0.000	1.045	1.625
hishave/artcncl	00:00:00.011	0.0%	23	0.000	0.478	1.125
hishave/artparse	00:00:00.001	0.0%	549	0.000	0.002	0.143
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.458	0.0%	586285	0.002	0.008	0.136
history sync	00:00:01.064	0.0%	377	0.000	2.822	56.500
history write	00:00:11.895	0.0%	19887	0.179	0.598	8.508
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.279	0.0%	549	0.000	0.508	6.000
idle	23:57:44.096	99.8%	561962	79.984	153.505	506.370
nntp read	00:00:02.143	0.0%	563143	0.001	0.004	0.011
overview write	00:01:46.570	0.1%	16228	0.101	6.567	1440.714
perl filter	00:00:26.846	0.0%	19882	0.979	1.350	2.381
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.271	0.0%	32485	0.000	0.008	0.025
TOTAL: 24:01:04.388	24:00:31.639	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.036	0.0%	16349	0.000	0.002	0.025
article prepare	00:00:00.002	0.0%	16664	0.000	0.000	0.008
article read	00:00:00.282	0.0%	1475	0.000	0.191	22.000
backlog stats	00:00:00.196	0.0%	395622	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.375	0.0%	305108	0.001	0.005	0.008
data write	00:00:01.745	0.0%	292020	0.002	0.006	0.013
idle	23:54:59.758	100.0%	395622	114.319	217.631	644.600
status file	00:00:00.166	0.0%	247	0.000	0.672	5.000
TOTAL: 23:55:10.484	23:55:03.560	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	26:52:23.167	100.0%	518	330.333	186762.871	600095.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.005	0.0%	1190	0.000	0.004	0.167
readart	00:00:00.796	0.0%	54	0.000	14.741	43.000
TOTAL: 26:52:44.751	26:52:23.968	100.0%	-	-	-	-

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	csiph-out.feeder.erje.net	1440	81058	4485	76077	496	5%	118:53:25
2	news-out.aioe.org	2	15933	3204	12615	114	20%	24:09:57
3	feeder.eternal-september.org	2	18141	2299	15402	440	12%	23:54:35
4	newsfeeds.xmission.com	2	15738	1291	14378	69	8%	24:23:21
5	news-out.mixmin.net	3	16880	857	15805	218	5%	24:02:52
6	csiph-out.news.xs4all.nl	861	18671	855	16589	1227	4%	71:28:32
7	newsfeed.fu-berlin.de	8	16537	787	15548	202	4%	25:55:34
8	newsfeed.neva.ru	158	18660	688	17257	715	3%	72:06:42
9	csiph-out.news.weretis.net	3	33530	686	32671	173	2%	47:59:41
10	news.freedyn.net	1	19503	298	19037	168	1%	23:59:57
11	news.fcku.it	11	2081	235	1837	9	11%	21:28:01
12	csiph-out.feed.uzoreto.com	864	26346	234	25839	273	0%	71:13:00
13	news-out.neodome.net	2	17140	128	16969	43	0%	23:59:53
14	nntp.pasdenom.info	2	11142	111	11007	24	0%	23:59:49
15	csiph-out.news.tnetconsulting.net	2	16582	70	16506	6	0%	23:59:58
16	news.swapon.de	4	1841	40	1800	1	2%	23:45:14
17	localhost	36	10	10	0	0	100%	00:00:04
18	news.samoylyk.net	2	15793	3	15786	4	0%	24:55:10
19	xanadu-bbs.net	22	543	1	542	0	0%	23:17:05
20	news.bbs.nz	2	16154	0	16154	0	0%	23:59:51
TOTAL: 20		3427	362283	16282	341819	4182	4%	717:32:41

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	18.6 MB	0.0 KB	12.2 MB	30.8 MB	60%	6.3 KB
2	news-out.aioe.org	8.0 MB	0.0 KB	442.5 KB	8.4 MB	94%	2.6 KB
3	feeder.eternal-september.org	6.8 MB	0.0 KB	1.8 MB	8.7 MB	78%	3.2 KB
4	newsfeeds.xmission.com	4.5 MB	0.0 KB	4.0 MB	8.5 MB	52%	6.4 KB
5	csiph-out.news.xs4all.nl	2.8 MB	0.0 KB	13.0 MB	15.8 MB	17%	7.8 KB
6	news-out.mixmin.net	2.4 MB	0.0 KB	547.6 KB	2.9 MB	81%	2.8 KB
7	csiph-out.news.weretis.net	2.1 MB	0.0 KB	2.4 MB	4.4 MB	46%	5.3 KB
8	newsfeed.fu-berlin.de	1.9 MB	0.0 KB	497.3 KB	2.4 MB	79%	2.5 KB
9	newsfeed.neva.ru	1.9 MB	0.0 KB	3.2 MB	5.0 MB	36%	3.7 KB
10	news.freedyn.net	1.1 MB	1.2 KB	1.3 MB	2.4 MB	46%	5.3 KB
11	csiph-out.feed.uzoreto.com	815.2 KB	0.0 KB	5.6 MB	6.4 MB	12%	13.0 KB
12	news.fcku.it	414.6 KB	0.0 KB	9.0 KB	423.7 KB	97%	1.7 KB
13	csiph-out.news.tnetconsulting.net	318.0 KB	0.0 KB	238.6 KB	556.6 KB	57%	7.3 KB
14	news-out.neodome.net	300.8 KB	0.0 KB	1.8 MB	2.1 MB	14%	12.5 KB
15	nntp.pasdenom.info	203.7 KB	0.0 KB	32.9 KB	236.7 KB	86%	1.8 KB
16	news.swapon.de	110.8 KB	0.0 KB	2.4 KB	113.2 KB	97%	2.8 KB
17	localhost	13.3 KB	0.0 KB	0.0 KB	13.3 KB	100%	1.3 KB
18	news.samoylyk.net	9.4 KB	0.0 KB	213.2 KB	222.6 KB	4%	31.8 KB
19	xanadu-bbs.net	9.1 KB	0.0 KB	0.0 KB	9.1 KB	100%	9.1 KB
20	news.bbs.nz	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		52.1 MB	1.2 KB	47.3 MB	99.4 MB	52%	5.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 10 04:15:00 - 04:59:59	240	1.5%	0.09	886.0 KB	1.7%	0.33
Jan 10 05:00:00 - 05:59:59	301	1.9%	0.08	1.1 MB	2.2%	0.32
Jan 10 06:00:00 - 06:59:59	496	3.1%	0.14	2.0 MB	3.8%	0.57
Jan 10 07:00:00 - 07:59:59	460	2.8%	0.13	1.6 MB	3.2%	0.47
Jan 10 08:00:00 - 08:59:59	600	3.7%	0.17	1.5 MB	2.9%	0.42
Jan 10 09:00:00 - 09:59:59	769	4.7%	0.21	2.0 MB	3.9%	0.58
Jan 10 10:00:00 - 10:59:59	687	4.2%	0.19	2.2 MB	4.2%	0.62
Jan 10 11:00:00 - 11:59:59	653	4.0%	0.18	2.3 MB	4.5%	0.66
Jan 10 12:00:00 - 12:59:59	705	4.3%	0.20	2.0 MB	3.9%	0.57
Jan 10 13:00:00 - 13:59:59	856	5.3%	0.24	2.5 MB	4.9%	0.72
Jan 10 14:00:00 - 14:59:59	851	5.2%	0.24	2.6 MB	5.1%	0.75
Jan 10 15:00:00 - 15:59:59	1010	6.2%	0.28	3.3 MB	6.3%	0.93
Jan 10 16:00:00 - 16:59:59	919	5.7%	0.26	2.5 MB	4.8%	0.71
Jan 10 17:00:00 - 17:59:59	961	5.9%	0.27	3.6 MB	7.0%	1.04
Jan 10 18:00:00 - 18:59:59	915	5.6%	0.25	2.7 MB	5.1%	0.76
Jan 10 19:00:00 - 19:59:59	975	6.0%	0.27	3.1 MB	6.0%	0.89
Jan 10 20:00:00 - 20:59:59	821	5.1%	0.23	2.3 MB	4.5%	0.67
Jan 10 21:00:00 - 21:59:59	824	5.1%	0.23	2.5 MB	4.9%	0.72
Jan 10 22:00:00 - 22:59:59	731	4.5%	0.20	2.0 MB	3.9%	0.58
Jan 10 23:00:00 - 23:59:59	656	4.0%	0.18	2.5 MB	4.8%	0.72
Jan 11 00:00:00 - 00:59:59	507	3.1%	0.14	2.1 MB	4.0%	0.58
Jan 11 01:00:00 - 01:59:59	494	3.0%	0.14	1.8 MB	3.4%	0.50
Jan 11 02:00:00 - 02:59:59	374	2.3%	0.10	1.0 MB	2.0%	0.30
Jan 11 03:00:00 - 03:59:59	338	2.1%	0.09	1.3 MB	2.6%	0.38
Jan 11 04:00:00 - 04:15:00	76	0.5%	0.08	314.6 KB	0.6%	0.35
TOTAL: 24:00:00	16219	100.0%	0.19	51.9 MB	100.0%	0.62

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1230	60	0	1170
2	newsfeed.neva.ru	718	104	0	614
3	newsfeed.fu-berlin.de	542	60	0	482
4	csiph-out.feeder.erje.net	498	103	0	395
5	feeder.eternal-september.org	462	6	0	456
6	csiph-out.feed.uzoreto.com	274	15	0	259
7	news-out.mixmin.net	222	8	0	214
8	news-out.aioe.org	189	103	0	86
9	csiph-out.news.weretis.net	180	95	0	85
10	news.freedyn.net	168	6	1	161
11	newsfeeds.xmission.com	71	0	0	71
12	news-out.neodome.net	49	2	0	47
13	nntp.pasdenom.info	24	0	0	24
14	csiph-out.news.tnetconsulting.net	9	4	0	5
15	news.fcku.it	9	8	0	1
16	news.swapon.de	8	0	0	8
17	news.samoylyk.net	4	0	0	4
TOTAL: 17		4657	574	1	4082

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	217
lada.talk	44
mozilla.support.seamonkey	41
mozilla.support.firefox	22
alt.binaries.pictures.purebeauty	18
alt.binaries.ebooks	18
spline.eisfair	16
it-alt.sport.calcio.juventus	15
lada.auto	13
alt.politics.usa	12
lada.kitchen	9
alt.fan.snuffles	9
alt.music.pink-floyd.publius	8
mozilla.support.thunderbird	8
oesterreich.tratsch	7
mozilla.test	6
lada.photo	6
alt.survival	6
mozilla.dev.servo	6
alt.windows7.general	6
TOTAL: 78	574

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2332
EMP (phn path)	214
EMP (phn nph)	209
EMP (phl)	86
0	76
Binary: misplaced binary	71
Too many newsgroups	52
Scoring filter	19
HTML Multipart	12
Too many newsgroups (meow)	5
Too many newsgroups (low_xpost)	1
MID-Bot	1
Binary Payload	1
TOTAL: 13	3079

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	51
	csiph-out.feed.uzoreto.com	34
	csiph-out.news.xs4all.nl	29
	TOTAL: 3	114
Huge articles
	csiph-out.feeder.erje.net	221
	csiph-out.news.xs4all.nl	117
	newsfeeds.xmission.com	66
	csiph-out.feed.uzoreto.com	64
	news-out.neodome.net	38
	csiph-out.news.weretis.net	20
	news.freedyn.net	8
	csiph-out.news.tnetconsulting.net	5
	feeder.eternal-september.org	4
	news.samoylyk.net	4
	TOTAL: 11	549
Including strange strings
	newsfeed.fu-berlin.de	330
	news-out.aioe.org	71
	csiph-out.news.weretis.net	18
	news.swapon.de	7
	news-out.mixmin.net	6
	newsfeed.neva.ru	4
	csiph-out.news.xs4all.nl	4
	news-out.neodome.net	2
	newsfeeds.xmission.com	2
	csiph-out.feeder.erje.net	2
	TOTAL: 12	449
No colon-space in header
	csiph-out.news.xs4all.nl	5
	TOTAL: 1	5
TOTAL: 4		1117

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	21220	928	15288	2	1	4%	23:59:55
2	news.freedyn.net	16234	625	15240	39	0	3%	23:59:55
3	news.samoylyk.net	16894	598	15615	3	34	3%	23:59:55
4	fu-berlin.de	15350	563	14787	0	0	3%	23:59:41
5	news.bbs.nz	30402	493	15130	2	1	1%	23:59:42
6	usenet.pasdenom.info	16290	151	15304	64	3	0%	23:59:55
7	tnet	18035	121	15507	1	1	0%	23:59:55
8	neva.ru	14957	115	14544	104	0	0%	23:59:55
9	aioe	11976	57	11512	0	0	0%	23:59:55
10	neodome.net	16696	38	15983	0	0	0%	23:59:55
11	newsfeed.xs4all.nl	15827	37	15158	8	101	0%	23:59:55
12	erje	13884	28	11478	58	13	0%	23:59:55
13	news.uzoreto.com	15927	22	15473	56	0	0%	23:59:50
14	eternal-september	13752	11	13215	0	0	0%	23:59:55
15	xmission	16933	11	14305	0	0	0%	23:59:55
16	news.mixmin.net	15074	10	14513	0	0	0%	23:59:55
17	news.swapon.de	1821	10	1794	0	0	0%	23:50:40
18	weretis.net	15676	10	14748	1	1	0%	23:59:55
19	news.fcku.it	1740	0	1720	0	0	0%	21:30:06
TOTAL: 19		288688	3828	251314	338	155	1%	453:18:49

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	8.2 MB	7.7 KB	8.2 MB	0.1 KB/s	9.1 KB	23:59:55
2	news.freedyn.net	7.5 MB	61.3 KB	7.6 MB	0.1 KB/s	11.7 KB	23:59:55
3	news.samoylyk.net	7.3 MB	2.8 KB	7.3 MB	0.1 KB/s	12.5 KB	23:59:55
4	fu-berlin.de	7.3 MB	0.0 KB	7.3 MB	0.1 KB/s	13.2 KB	23:59:41
5	news.bbs.nz	1.2 MB	3.4 KB	1.2 MB	0.0 KB/s	2.6 KB	23:59:42
6	usenet.pasdenom.info	494.4 KB	197.3 KB	691.7 KB	0.0 KB/s	3.2 KB	23:59:55
7	neodome.net	292.1 KB	0.0 KB	292.1 KB	0.0 KB/s	7.7 KB	23:59:55
8	tnet	269.6 KB	1.0 KB	270.6 KB	0.0 KB/s	2.2 KB	23:59:55
9	neva.ru	239.6 KB	263.4 KB	503.1 KB	0.0 KB/s	2.3 KB	23:59:55
10	newsfeed.xs4all.nl	165.2 KB	35.5 KB	200.6 KB	0.0 KB/s	4.5 KB	23:59:55
11	aioe	107.5 KB	0.0 KB	107.5 KB	0.0 KB/s	1.9 KB	23:59:55
12	erje	61.6 KB	371.5 KB	433.1 KB	0.0 KB/s	5.0 KB	23:59:55
13	news.uzoreto.com	35.3 KB	481.0 KB	516.3 KB	0.0 KB/s	6.6 KB	23:59:50
14	eternal-september	15.6 KB	0.0 KB	15.6 KB	0.0 KB/s	1.4 KB	23:59:55
15	xmission	15.6 KB	0.0 KB	15.6 KB	0.0 KB/s	1.4 KB	23:59:55
16	weretis.net	14.5 KB	20.8 KB	35.3 KB	0.0 KB/s	3.2 KB	23:59:55
17	news.mixmin.net	14.5 KB	0.0 KB	14.5 KB	0.0 KB/s	1.5 KB	23:59:55
18	news.swapon.de	13.4 KB	0.0 KB	13.4 KB	0.0 KB/s	1.3 KB	23:50:40
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:30:06
TOTAL: 19		33.3 MB	1.4 MB	34.7 MB	0.0 KB/s	8.5 KB	453:18:49

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	54	20	28.8 KB	11	0	0	14:21:34
2	71-90-73-253.dhcp.ftbg.wi.charter.com	38	18	28.2 KB	15	10	10	09:04:16
3	208-71-239-109.cust.centrio.cz	2	11	46.4 KB	3	0	0	00:56:11
4	ip72-222-200-117.ph.ph.cox.net	5	5	6.8 KB	1	0	0	02:30:38
TOTAL: 4		99	54	110.2 KB	30	10	10	26:52:44

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	54	20	28.8 KB	11	0	0	14:21:34
2	*.dhcp.ftbg.wi.charter.com	38	18	28.2 KB	15	10	10	09:04:16
3	*.cust.centrio.cz	2	11	46.4 KB	3	0	0	00:56:11
4	*.ph.ph.cox.net	5	5	6.8 KB	1	0	0	02:30:38
5	unresolved	2	0	0.0 KB	0	0	0	00:00:02
TOTAL: 5		101	54	110.2 KB	30	10	10	26:52:44

NNRP auth users [Top 20]:

User	Conn
ohlandl	10
ctomczyk	2
TOTAL: 2	12

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	4.109	0.744	0.000	14:21:34
71-90-73-253.dhcp.ftbg.wi.charter.com	3.201	0.543	0.023	09:04:16
ip72-222-200-117.ph.ph.cox.net	0.521	0.087	0.000	02:30:38
208-71-239-109.cust.centrio.cz	0.227	0.015	0.006	00:56:11
94.162.80.111	0.054	0.023	0.000	00:00:01
94.164.40.56	0.062	0.015	0.000	00:00:01
TOTAL: 6	8.174	1.427	0.029	26:52:44

Curious NNRP server explorers [Top 20]:

System	Conn
94.164.40.56	1
94.162.80.111	1
TOTAL: 2	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-90-73-253.dhcp.ftbg.wi.charter.com	6	0
ip72-222-200-117.ph.ph.cox.net	5	0
208-71-239-109.cust.centrio.cz	1	0
TOTAL: 3	12	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	53	98.1%
2	pl	1	1.9%
TOTAL: 2		54	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	43
2	comp.lang.javascript	10
3	pl.comp.www.nowe-strony	1
TOTAL: 3		54

Daily Usenet report for csiph.com

Jan 10 04:15:00 -- Jan 11 04:15:00