Daily Usenet report for csiph.com: Sep 7 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19212	45.6%	4.9 MB	61.0%
innd	18105	43.0%	2.4 MB	29.9%
innfeed	3660	8.7%	627.6 KB	7.6%
nnrpd	1076	2.6%	119.3 KB	1.5%
nocem	64	0.2%	7.4 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	42118	100.0%	8.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	312841	54.9%
Negative hits	216116	37.9%
Cache misses	22251	3.9%
Do not exist	18505	3.2%
TOTAL: 4	569713	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.565	0.0%	28	0.000	20.179	56.667
article cleanup	00:00:00.118	0.0%	18466	0.000	0.006	0.037
article logging	00:00:00.369	0.0%	19009	0.000	0.019	0.487
article parse	00:00:00.739	0.0%	51834	0.000	0.014	0.240
article write	00:00:12.392	0.0%	15260	0.146	0.812	20.718
artlog/artcncl	00:00:00.000	0.0%	28	0.000	0.000	0.000
artlog/artparse	00:00:00.005	0.0%	191	0.000	0.026	1.000
data move	00:00:00.167	0.0%	515566	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.044	0.0%	28	0.000	1.571	7.000
hishave/artcncl	00:00:00.021	0.0%	28	0.000	0.750	15.000
hishave/artparse	00:00:00.002	0.0%	184	0.000	0.011	0.091
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.792	0.0%	572969	0.002	0.008	0.076
history sync	00:00:01.135	0.0%	372	0.000	3.051	8.000
history write	00:00:15.602	0.0%	18473	0.417	0.845	4.115
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.272	0.0%	184	0.000	1.478	8.000
idle	23:58:35.860	99.8%	523345	90.870	164.931	495.663
nntp read	00:00:01.986	0.0%	523821	0.002	0.004	0.008
overview write	00:00:51.418	0.1%	15260	0.093	3.369	228.469
perl filter	00:00:25.892	0.0%	18463	0.943	1.402	1.959
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.266	0.0%	30582	0.000	0.009	0.030
TOTAL: 24:01:05.214	24:00:31.645	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.034	0.0%	18954	0.000	0.002	0.018
article prepare	00:00:00.002	0.0%	19408	0.000	0.000	0.011
article read	00:00:00.567	0.0%	2844	0.000	0.199	7.167
backlog stats	00:00:00.204	0.0%	371996	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.279	0.0%	289059	0.001	0.004	0.009
data write	00:00:01.647	0.0%	270031	0.002	0.006	0.012
idle	23:54:50.586	100.0%	371996	118.199	231.429	668.294
status file	00:00:00.234	0.0%	324	0.000	0.722	2.000
TOTAL: 23:55:04.253	23:54:54.553	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	49:51:28.336	99.8%	739	321.333	242880.022	600244.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.013	0.0%	1722	0.000	0.008	0.167
readart	00:00:00.587	0.0%	55	0.000	10.673	42.000
TOTAL: 49:56:19.272	49:51:28.936	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	14802	3859	10895	48	26%	24:11:04
2	news-out.mixmin.net	3	16238	2845	12961	432	17%	24:08:45
3	feeder.eternal-september.org	3	16375	1942	14361	72	11%	22:21:25
4	news-out.aioe.org	2	14967	1338	13560	69	8%	23:59:52
5	csiph-out.news.xs4all.nl	1036	17333	1093	15063	1177	6%	85:56:27
6	newsfeed.fu-berlin.de	11	17711	991	16565	155	5%	31:06:19
7	csiph-out.feeder.erje.net	1440	75425	865	74295	265	1%	118:41:07
8	csiph-out.news.weretis.net	4	29588	845	28591	152	2%	47:59:42
9	newsfeed.neva.ru	151	15561	713	14344	504	4%	71:46:47
10	news.fcku.it	8	1710	269	1437	4	15%	22:16:06
11	csiph-out.feed.uzoreto.com	864	43798	198	43142	458	0%	71:21:17
12	news-out.neodome.net	2	16473	148	16318	7	0%	24:08:59
13	nntp.pasdenom.info	2	9991	98	9890	3	0%	23:58:42
14	news.swapon.de	7	1336	50	1286	0	3%	23:12:14
15	csiph-out.news.tnetconsulting.net	2	13799	44	13738	17	0%	23:59:49
16	news.freedyn.net	1	18535	40	18424	71	0%	23:59:57
17	news.bbs.nz	2	13572	5	13567	0	0%	23:59:43
18	localhost	30	4	4	0	0	100%	00:00:00
19	news.samoylyk.net	3	15790	4	15782	4	0%	19:31:46
20	xanadu-bbs.net	33	366	1	365	0	0%	19:42:56
TOTAL: 20		3606	353374	15352	334584	3438	4%	726:22:57

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	13.4 MB	0.0 KB	2.3 MB	15.7 MB	85%	4.1 KB
2	news-out.mixmin.net	5.6 MB	0.0 KB	943.2 KB	6.5 MB	85%	2.0 KB
3	feeder.eternal-september.org	5.3 MB	0.0 KB	415.2 KB	5.7 MB	92%	2.9 KB
4	csiph-out.feeder.erje.net	4.8 MB	0.0 KB	4.0 MB	8.8 MB	54%	8.0 KB
5	news-out.aioe.org	4.7 MB	0.0 KB	300.1 KB	5.0 MB	94%	3.6 KB
6	csiph-out.news.xs4all.nl	3.3 MB	0.0 KB	6.7 MB	9.9 MB	32%	4.5 KB
7	csiph-out.news.weretis.net	2.5 MB	0.0 KB	673.0 KB	3.1 MB	78%	3.2 KB
8	newsfeed.fu-berlin.de	2.4 MB	0.0 KB	428.2 KB	2.8 MB	85%	2.5 KB
9	newsfeed.neva.ru	1.7 MB	0.0 KB	1.2 MB	2.9 MB	58%	2.4 KB
10	csiph-out.feed.uzoreto.com	945.3 KB	0.0 KB	5.4 MB	6.4 MB	14%	9.9 KB
11	news.fcku.it	470.0 KB	0.0 KB	8.2 KB	478.2 KB	98%	1.8 KB
12	news-out.neodome.net	379.7 KB	0.0 KB	72.5 KB	452.2 KB	83%	2.9 KB
13	news.freedyn.net	288.8 KB	0.0 KB	614.2 KB	903.0 KB	31%	8.1 KB
14	nntp.pasdenom.info	212.5 KB	0.0 KB	3.9 KB	216.4 KB	98%	2.1 KB
15	csiph-out.news.tnetconsulting.net	189.8 KB	2.0 KB	55.7 KB	247.4 KB	76%	4.1 KB
16	news.swapon.de	122.7 KB	0.0 KB	0.0 KB	122.7 KB	100%	2.5 KB
17	xanadu-bbs.net	26.3 KB	0.0 KB	0.0 KB	26.3 KB	100%	26.3 KB
18	news.bbs.nz	17.6 KB	0.0 KB	0.0 KB	17.6 KB	100%	3.5 KB
19	news.samoylyk.net	11.4 KB	0.0 KB	4.0 KB	15.3 KB	74%	1.9 KB
20	localhost	6.8 KB	0.0 KB	0.0 KB	6.8 KB	100%	1.7 KB
TOTAL: 20		46.2 MB	2.0 KB	23.0 MB	69.2 MB	66%	3.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 7 04:15:00 - 04:59:59	256	1.7%	0.09	894.1 KB	1.9%	0.33
Sep 7 05:00:00 - 05:59:59	394	2.6%	0.11	1.2 MB	2.6%	0.34
Sep 7 06:00:00 - 06:59:59	431	2.8%	0.12	1.3 MB	2.7%	0.36
Sep 7 07:00:00 - 07:59:59	628	4.1%	0.17	1.9 MB	4.1%	0.54
Sep 7 08:00:00 - 08:59:59	688	4.5%	0.19	1.8 MB	3.9%	0.51
Sep 7 09:00:00 - 09:59:59	626	4.1%	0.17	1.7 MB	3.6%	0.47
Sep 7 10:00:00 - 10:59:59	668	4.4%	0.19	1.7 MB	3.7%	0.49
Sep 7 11:00:00 - 11:59:59	756	5.0%	0.21	2.0 MB	4.3%	0.56
Sep 7 12:00:00 - 12:59:59	731	4.8%	0.20	1.9 MB	4.2%	0.55
Sep 7 13:00:00 - 13:59:59	707	4.6%	0.20	1.8 MB	3.9%	0.52
Sep 7 14:00:00 - 14:59:59	927	6.1%	0.26	2.8 MB	6.1%	0.79
Sep 7 15:00:00 - 15:59:59	864	5.7%	0.24	2.9 MB	6.3%	0.82
Sep 7 16:00:00 - 16:59:59	826	5.4%	0.23	2.2 MB	4.8%	0.63
Sep 7 17:00:00 - 17:59:59	1018	6.7%	0.28	3.2 MB	7.0%	0.92
Sep 7 18:00:00 - 18:59:59	942	6.2%	0.26	3.4 MB	7.4%	0.97
Sep 7 19:00:00 - 19:59:59	941	6.2%	0.26	2.8 MB	6.1%	0.80
Sep 7 20:00:00 - 20:59:59	752	4.9%	0.21	2.2 MB	4.8%	0.63
Sep 7 21:00:00 - 21:59:59	597	3.9%	0.17	1.8 MB	3.9%	0.51
Sep 7 22:00:00 - 22:59:59	560	3.7%	0.16	1.7 MB	3.8%	0.49
Sep 7 23:00:00 - 23:59:59	449	2.9%	0.12	1.7 MB	3.6%	0.48
Sep 8 00:00:00 - 00:59:59	385	2.5%	0.11	1.2 MB	2.6%	0.34
Sep 8 01:00:00 - 01:59:59	382	2.5%	0.11	1.1 MB	2.3%	0.30
Sep 8 02:00:00 - 02:59:59	279	1.8%	0.08	984.8 KB	2.1%	0.27
Sep 8 03:00:00 - 03:59:59	354	2.3%	0.10	1.4 MB	3.1%	0.40
Sep 8 04:00:00 - 04:15:00	93	0.6%	0.10	480.3 KB	1.0%	0.53
TOTAL: 24:00:00	15254	100.0%	0.18	46.1 MB	100.0%	0.55

Sites sending bad articles:

Server		Total	Group	Other
1	csiph-out.news.xs4all.nl	1179	20	1159
2	news-out.mixmin.net	512	3	509
3	newsfeed.neva.ru	506	93	413
4	newsfeed.fu-berlin.de	489	36	453
5	csiph-out.feed.uzoreto.com	458	17	441
6	csiph-out.feeder.erje.net	263	61	202
7	csiph-out.news.weretis.net	162	53	109
8	news-out.aioe.org	113	52	61
9	feeder.eternal-september.org	77	43	34
10	news.freedyn.net	75	0	75
11	newsfeeds.xmission.com	52	7	45
12	news.swapon.de	17	0	17
13	csiph-out.news.tnetconsulting.net	9	6	3
14	news-out.neodome.net	8	2	6
15	news.fcku.it	4	3	1
16	news.samoylyk.net	4	0	4
17	nntp.pasdenom.info	3	0	3
TOTAL: 17		3931	396	3535

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	72
alt.computer.workshop	53
mozilla.support.thunderbird	35
scinet.stats	27
alt.survival	18
alt.politics	15
alt.binaries.pictures.purebeauty	15
lada.auto	13
alt.bbs.synchronet	12
it-alt.comp.software.mozilla	11
alt.politics.usa	10
alt.windows7.general	10
att.jobs	8
mozilla.governance	7
it-alt.sport.calcio.juventus	6
spline.eisfair.dev	6
alt.philosophy	6
at.jobs	5
mozilla.support.seamonkey	4
cakewalk.audio	4
TOTAL: 60	396

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2147
EMP (phl)	198
EMP (phn path)	107
EMP (phn nph)	98
0	83
Binary: misplaced binary	76
Too many newsgroups	52
Scoring filter	15
Too many newsgroups (meow)	15
HTML Multipart	11
HTML post	1
TOTAL: 11	2803

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	147
	csiph-out.feed.uzoreto.com	25
	csiph-out.news.xs4all.nl	20
	news-out.neodome.net	1
	TOTAL: 4	193
Huge articles
	csiph-out.feeder.erje.net	67
	newsfeeds.xmission.com	36
	csiph-out.feed.uzoreto.com	27
	csiph-out.news.xs4all.nl	26
	news.freedyn.net	13
	csiph-out.news.weretis.net	3
	csiph-out.news.tnetconsulting.net	3
	feeder.eternal-september.org	2
	news-out.mixmin.net	2
	news-out.neodome.net	1
	TOTAL: 10	180
Including strange strings
	newsfeed.fu-berlin.de	372
	news-out.mixmin.net	76
	news-out.aioe.org	46
	news.swapon.de	17
	csiph-out.news.weretis.net	13
	csiph-out.news.xs4all.nl	7
	newsfeeds.xmission.com	6
	feeder.eternal-september.org	2
	csiph-out.feeder.erje.net	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 10	542
No colon-space in header
	csiph-out.news.xs4all.nl	5
	csiph-out.feed.uzoreto.com	1
	TOTAL: 2	6
TOTAL: 4		921

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18647	2271	12964	36	701	12%	23:59:53
2	news.bbs.nz	28843	622	14222	18	1	2%	23:59:45
3	news.samoylyk.net	17185	406	16204	4	1402	2%	23:58:38
4	fu-berlin.de	14239	368	13870	0	0	2%	23:59:43
5	neva.ru	14046	174	13609	144	0	1%	23:59:52
6	tnet	16679	166	14703	0	0	0%	23:59:23
7	erje	16409	82	13935	272	0	0%	23:59:40
8	news.freedyn.net	15392	74	14907	0	0	0%	23:59:52
9	newsfeed.xs4all.nl	14635	61	13985	13	241	0%	23:59:52
10	aioe	11062	20	10480	0	0	0%	23:59:43
11	usenet.pasdenom.info	15478	20	14744	4	14	0%	23:59:52
12	eternal-september	13348	12	12681	7	0	0%	23:59:29
13	xmission	13591	11	10929	1	0	0%	23:59:24
14	news.mixmin.net	12229	10	11787	0	0	0%	23:59:52
15	neodome.net	15647	7	15083	0	0	0%	23:59:49
16	news.uzoreto.com	14981	6	14532	36	0	0%	23:59:52
17	weretis.net	14171	5	13974	0	0	0%	23:59:25
18	news.swapon.de	1465	5	1413	0	0	0%	23:20:30
19	news.fcku.it	1341	0	1341	0	0	0%	20:36:26
TOTAL: 19		269388	4320	235363	535	2359	1%	451:51:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	9.0 MB	154.6 KB	9.2 MB	0.1 KB/s	4.1 KB	23:59:53
2	news.samoylyk.net	3.6 MB	83.2 KB	3.7 MB	0.0 KB/s	9.3 KB	23:58:38
3	fu-berlin.de	3.4 MB	0.0 KB	3.4 MB	0.0 KB/s	9.5 KB	23:59:43
4	news.bbs.nz	1.9 MB	116.5 KB	2.0 MB	0.0 KB/s	3.2 KB	23:59:45
5	news.freedyn.net	666.1 KB	0.0 KB	666.1 KB	0.0 KB/s	9.0 KB	23:59:52
6	tnet	638.9 KB	0.0 KB	638.9 KB	0.0 KB/s	3.8 KB	23:59:23
7	neva.ru	576.1 KB	477.0 KB	1.0 MB	0.0 KB/s	3.3 KB	23:59:52
8	erje	219.9 KB	1.3 MB	1.5 MB	0.0 KB/s	4.5 KB	23:59:40
9	newsfeed.xs4all.nl	155.4 KB	72.7 KB	228.1 KB	0.0 KB/s	3.1 KB	23:59:52
10	usenet.pasdenom.info	114.6 KB	27.1 KB	141.7 KB	0.0 KB/s	5.9 KB	23:59:52
11	news.mixmin.net	91.9 KB	0.0 KB	91.9 KB	0.0 KB/s	9.2 KB	23:59:52
12	eternal-september	60.7 KB	23.7 KB	84.3 KB	0.0 KB/s	4.4 KB	23:59:29
13	neodome.net	49.5 KB	0.0 KB	49.5 KB	0.0 KB/s	7.1 KB	23:59:49
14	aioe	44.9 KB	0.0 KB	44.9 KB	0.0 KB/s	2.2 KB	23:59:43
15	news.swapon.de	18.2 KB	0.0 KB	18.2 KB	0.0 KB/s	3.6 KB	23:20:30
16	xmission	18.1 KB	2.3 KB	20.5 KB	0.0 KB/s	1.7 KB	23:59:24
17	news.uzoreto.com	12.4 KB	215.5 KB	227.9 KB	0.0 KB/s	5.4 KB	23:59:52
18	weretis.net	9.1 KB	0.0 KB	9.1 KB	0.0 KB/s	1.8 KB	23:59:25
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:36:26
TOTAL: 19		20.6 MB	2.5 MB	23.0 MB	0.0 KB/s	4.9 KB	451:51:00

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	61	30	48.4 KB	8	0	0	16:46:26
2	096-042-018-019.res.spectrum.com	30	25	67.1 KB	17	4	4	05:58:37
TOTAL: 2		91	55	115.5 KB	25	4	4	49:56:18

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	61	30	48.4 KB	8	0	0	16:46:26
2	*.res.spectrum.com	30	25	67.1 KB	17	4	4	05:58:37
3	unresolved	75	0	0.0 KB	0	0	0	24:10:43
4	*.keff.org	1	0	0.0 KB	0	0	0	00:00:10
5	*.hsd1.wa.comcast.net	2	0	0.0 KB	0	0	0	01:00:01
6	*.ph.ph.cox.net	2	0	0.0 KB	0	0	0	02:00:18
TOTAL: 6		171	55	115.5 KB	25	4	4	49:56:18

NNRP auth users [Top 20]:

User	Conn
ohlandl	4
TOTAL: 1	4

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.848	1.340	0.000	24:10:16
a131033.upc-a.chello.nl	4.421	1.024	0.000	16:46:26
096-042-018-019.res.spectrum.com	2.571	0.582	0.010	05:58:37
ip72-222-200-117.ph.ph.cox.net	0.431	0.089	0.000	02:00:18
c-73-140-175-55.hsd1.wa.comcast.net	0.129	0.032	0.000	01:00:01
119.28.152.128	0.057	0.024	0.000	00:00:15
scan.keff.org	0.070	0.008	0.000	00:00:10
162.243.128.179	0.052	0.029	0.000	00:00:09
151.44.24.130	0.069	0.008	0.000	00:00:01
TOTAL: 9	12.648	3.136	0.010	49:56:18

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
c-73-140-175-55.hsd1.wa.comcast.net	2
ip72-222-200-117.ph.ph.cox.net	2
119.28.152.128	1
scan.keff.org	1
162.243.128.179	1
151.44.24.130	1
TOTAL: 7	80

NNRP unrecognized commands (by host):

System	Conn
119.28.152.128	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
096-042-018-019.res.spectrum.com	7	1
ip72-222-200-117.ph.ph.cox.net	4	0
c-73-140-175-55.hsd1.wa.comcast.net	2	0
91.187.33.87	1	0
TOTAL: 4	14	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Sep 7 04:15:00 -- Sep 8 04:15:00