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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17972	44.6%	4.7 MB	60.3%
innd	17528	43.5%	2.3 MB	30.0%
innfeed	3648	9.1%	650.0 KB	8.2%
nnrpd	1063	2.6%	118.7 KB	1.5%
nocem	41	0.1%	4.8 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40253	100.0%	7.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	299366	56.6%
Negative hits	211749	40.0%
Do not exist	17400	3.3%
Cache misses	272	0.1%
TOTAL: 4	528787	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.511	0.0%	18	0.000	28.389	58.429
article cleanup	00:00:00.130	0.0%	17057	0.000	0.008	0.050
article logging	00:00:00.390	0.0%	17567	0.000	0.022	0.500
article parse	00:00:01.534	0.0%	54458	0.000	0.028	0.231
article write	00:00:34.553	0.0%	14626	0.176	2.362	59.014
artlog/artcncl	00:00:00.000	0.0%	18	0.000	0.000	0.000
artlog/artparse	00:00:00.006	0.0%	413	0.000	0.015	0.333
data move	00:00:00.195	0.0%	498809	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.108	0.0%	18	0.000	6.000	13.000
hishave/artcncl	00:00:00.061	0.0%	18	0.000	3.389	18.000
hishave/artparse	00:00:00.000	0.0%	408	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:36.553	0.0%	530122	0.002	0.069	0.313
history sync	00:00:01.029	0.0%	382	0.000	2.694	13.000
history write	00:00:43.591	0.1%	17049	0.818	2.557	6.626
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:01.058	0.0%	408	0.000	2.593	12.300
idle	23:55:41.853	99.6%	501780	100.163	171.673	570.963
nntp read	00:00:01.960	0.0%	506828	0.001	0.004	0.007
overview write	00:02:10.629	0.2%	14626	0.231	8.931	647.948
perl filter	00:00:24.102	0.0%	17044	1.080	1.414	2.445
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.246	0.0%	29293	0.000	0.008	0.060
TOTAL: 24:00:55.855	24:00:18.509	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.035	0.0%	15279	0.000	0.002	0.059
article prepare	00:00:00.003	0.0%	13700	0.000	0.000	0.006
article read	00:00:00.346	0.0%	1804	0.000	0.192	12.000
backlog stats	00:00:00.197	0.0%	346250	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.235	0.0%	272160	0.001	0.005	0.009
data write	00:00:01.534	0.0%	255400	0.001	0.006	0.014
idle	23:55:02.481	100.0%	346250	141.937	248.671	725.373
status file	00:00:00.306	0.0%	329	0.000	0.930	4.667
TOTAL: 23:55:14.623	23:55:06.137	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	50:08:36.365	99.8%	714	495.600	252824.041	600146.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.012	0.0%	1678	0.000	0.007	0.200
readart	00:00:00.390	0.0%	53	0.000	7.358	42.000
TOTAL: 50:13:27.185	50:08:36.767	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.mixmin.net	3	15436	2937	12226	273	19%	24:08:54
2	newsfeeds.xmission.com	2	13802	2868	10899	35	20%	23:06:34
3	feeder.eternal-september.org	1	16437	2033	14326	78	12%	24:46:09
4	news-out.aioe.org	1	14394	1231	13093	70	8%	23:59:58
5	csiph-out.news.xs4all.nl	1071	16105	1129	13946	1030	7%	76:52:53
6	csiph-out.news.weretis.net	4	42219	1044	40859	316	2%	65:36:34
7	newsfeed.fu-berlin.de	3	14638	877	13697	64	5%	24:50:45
8	newsfeed.neva.ru	144	13546	818	12407	321	6%	71:54:31
9	csiph-out.feeder.erje.net	1440	73461	658	72526	277	0%	118:46:54
10	news.fcku.it	14	1829	317	1500	12	17%	21:57:40
11	csiph-out.news.tnetconsulting.net	1	23661	224	23398	39	0%	36:37:34
12	csiph-out.feed.uzoreto.com	864	22074	183	21519	372	0%	71:16:41
13	news-out.neodome.net	2	15839	178	15610	51	1%	23:59:53
14	nntp.pasdenom.info	2	9321	83	9220	18	0%	23:58:55
15	news.freedyn.net	2	17408	53	17277	78	0%	23:59:43
16	news.swapon.de	9	1204	30	1173	1	2%	24:32:02
17	news.bbs.nz	1	14293	22	14271	0	0%	23:59:51
18	news.samoylyk.net	2	14326	19	14305	2	0%	23:59:48
19	localhost	38	12	12	0	0	100%	00:00:04
20	xanadu-bbs.net	40	438	0	437	1	0%	20:26:42
TOTAL: 20		3644	340443	14716	322689	3038	4%	748:52:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	9.0 MB	0.0 KB	2.5 MB	11.4 MB	78%	4.0 KB
2	news-out.mixmin.net	5.8 MB	2.4 KB	604.9 KB	6.4 MB	90%	2.0 KB
3	feeder.eternal-september.org	5.2 MB	5.8 KB	965.8 KB	6.2 MB	84%	3.0 KB
4	news-out.aioe.org	4.2 MB	9.3 KB	214.0 KB	4.4 MB	95%	3.4 KB
5	csiph-out.feeder.erje.net	4.0 MB	0.0 KB	3.7 MB	7.7 MB	52%	8.4 KB
6	csiph-out.news.weretis.net	3.3 MB	5.8 KB	2.9 MB	6.2 MB	52%	4.7 KB
7	csiph-out.news.xs4all.nl	3.2 MB	0.0 KB	12.4 MB	15.5 MB	20%	7.4 KB
8	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	180.3 KB	2.4 MB	92%	2.7 KB
9	newsfeed.neva.ru	1.9 MB	14.8 KB	894.4 KB	2.8 MB	68%	2.5 KB
10	csiph-out.feed.uzoreto.com	859.7 KB	0.0 KB	11.9 MB	12.7 MB	6%	23.4 KB
11	csiph-out.news.tnetconsulting.net	639.1 KB	0.0 KB	435.8 KB	1.0 MB	59%	4.1 KB
12	news.fcku.it	532.6 KB	0.0 KB	16.9 KB	549.5 KB	96%	1.7 KB
13	news-out.neodome.net	462.2 KB	2.4 KB	128.8 KB	593.4 KB	77%	2.6 KB
14	news.freedyn.net	412.3 KB	28.5 KB	1.9 MB	2.4 MB	17%	18.4 KB
15	nntp.pasdenom.info	205.6 KB	0.0 KB	29.8 KB	235.4 KB	87%	2.3 KB
16	news.samoylyk.net	100.6 KB	2.4 KB	2.4 KB	105.3 KB	95%	5.0 KB
17	news.swapon.de	61.1 KB	0.0 KB	104.4 KB	165.5 KB	36%	5.3 KB
18	news.bbs.nz	38.9 KB	0.0 KB	0.0 KB	38.9 KB	100%	1.8 KB
19	localhost	14.0 KB	0.0 KB	0.0 KB	14.0 KB	100%	1.2 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	1.8 KB	1.8 KB	0%	1.8 KB
TOTAL: 20		42.0 MB	71.3 KB	38.7 MB	80.8 MB	52%	4.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 4 04:15:00 - 04:59:59	290	2.0%	0.11	1.2 MB	2.8%	0.44
Sep 4 05:00:00 - 05:59:59	377	2.6%	0.10	1.3 MB	3.2%	0.38
Sep 4 06:00:00 - 06:59:59	426	2.9%	0.12	1.0 MB	2.5%	0.29
Sep 4 07:00:00 - 07:59:59	640	4.4%	0.18	1.7 MB	4.2%	0.49
Sep 4 08:00:00 - 08:59:59	774	5.3%	0.21	2.2 MB	5.3%	0.62
Sep 4 09:00:00 - 09:59:59	801	5.5%	0.22	2.2 MB	5.2%	0.62
Sep 4 10:00:00 - 10:59:59	726	5.0%	0.20	2.0 MB	4.8%	0.57
Sep 4 11:00:00 - 11:59:59	719	4.9%	0.20	1.9 MB	4.5%	0.53
Sep 4 12:00:00 - 12:59:59	718	4.9%	0.20	1.8 MB	4.4%	0.52
Sep 4 13:00:00 - 13:59:59	664	4.5%	0.18	1.8 MB	4.3%	0.51
Sep 4 14:00:00 - 14:59:59	864	5.9%	0.24	2.9 MB	7.0%	0.83
Sep 4 15:00:00 - 15:59:59	868	5.9%	0.24	2.6 MB	6.3%	0.74
Sep 4 16:00:00 - 16:59:59	912	6.2%	0.25	2.2 MB	5.4%	0.64
Sep 4 17:00:00 - 17:59:59	759	5.2%	0.21	2.5 MB	6.0%	0.71
Sep 4 18:00:00 - 18:59:59	753	5.2%	0.21	1.9 MB	4.7%	0.55
Sep 4 19:00:00 - 19:59:59	748	5.1%	0.21	2.0 MB	4.7%	0.56
Sep 4 20:00:00 - 20:59:59	653	4.5%	0.18	1.7 MB	4.0%	0.47
Sep 4 21:00:00 - 21:59:59	576	3.9%	0.16	1.4 MB	3.4%	0.41
Sep 4 22:00:00 - 22:59:59	538	3.7%	0.15	1.4 MB	3.4%	0.40
Sep 4 23:00:00 - 23:59:59	443	3.0%	0.12	1.5 MB	3.7%	0.43
Sep 5 00:00:00 - 00:59:59	346	2.4%	0.10	1.2 MB	2.9%	0.34
Sep 5 01:00:00 - 01:59:59	392	2.7%	0.11	1.3 MB	3.0%	0.36
Sep 5 02:00:00 - 02:59:59	255	1.7%	0.07	736.5 KB	1.7%	0.20
Sep 5 03:00:00 - 03:59:59	295	2.0%	0.08	895.5 KB	2.1%	0.25
Sep 5 04:00:00 - 04:15:00	73	0.5%	0.08	226.5 KB	0.5%	0.25
TOTAL: 24:00:00	14610	100.0%	0.17	41.6 MB	100.0%	0.49

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1035	55	0	980
2	csiph-out.feed.uzoreto.com	375	12	0	363
3	newsfeed.fu-berlin.de	373	39	0	334
4	news-out.mixmin.net	367	10	1	356
5	newsfeed.neva.ru	340	102	4	234
6	csiph-out.news.weretis.net	260	91	1	168
7	csiph-out.feeder.erje.net	165	42	0	123
8	news-out.aioe.org	121	67	2	52
9	feeder.eternal-september.org	81	43	1	37
10	news.freedyn.net	79	1	1	77
11	news-out.neodome.net	51	13	1	37
12	newsfeeds.xmission.com	36	4	0	32
13	csiph-out.news.tnetconsulting.net	20	17	0	3
14	nntp.pasdenom.info	18	0	0	18
15	news.fcku.it	12	5	0	7
16	news.swapon.de	7	0	0	7
17	news.samoylyk.net	2	0	2	0
18	xanadu-bbs.net	1	0	0	1
TOTAL: 18		3343	501	13	2829

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	89
alt.computer.workshop	72
scinet.stats	27
spline.eisfair	26
alt.bbs.synchronet	21
alt.binaries.pictures.purebeauty	19
alt.tv.comedy-central.daily-show	17
it-alt.sport.calcio.juventus	15
alt.slack.goathead	14
alt.politics	13
mozilla.support.seamonkey	13
alt.politics.usa	11
mozilla.support.firefox	9
mozilla.support.thunderbird	9
alt.philosophy	8
rocksolid.test.test	8
mozilla.general	8
alt.survival	8
at.jobs	7
att.jobs	7
TOTAL: 79	501

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1350
EMP (phl)	213
EMP (phn path)	153
0	68
EMP (phn nph)	63
Too many newsgroups	41
Binary: misplaced binary	16
Scoring filter	5
HTML Multipart	1
TOTAL: 9	1910

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	109
	csiph-out.feed.uzoreto.com	18
	csiph-out.news.xs4all.nl	14
	TOTAL: 3	141
Huge articles
	csiph-out.feed.uzoreto.com	131
	csiph-out.news.xs4all.nl	118
	csiph-out.feeder.erje.net	62
	newsfeeds.xmission.com	30
	news.freedyn.net	27
	csiph-out.news.weretis.net	19
	feeder.eternal-september.org	11
	csiph-out.news.tnetconsulting.net	3
	news-out.mixmin.net	2
	news.swapon.de	1
	TOTAL: 10	404
Including strange strings
	newsfeed.fu-berlin.de	315
	news-out.mixmin.net	100
	news-out.aioe.org	51
	csiph-out.news.weretis.net	16
	csiph-out.news.xs4all.nl	13
	news.swapon.de	6
	csiph-out.feed.uzoreto.com	3
	newsfeed.neva.ru	2
	newsfeeds.xmission.com	2
	csiph-out.feeder.erje.net	2
	TOTAL: 10	510
No colon-space in header
	csiph-out.news.xs4all.nl	3
	csiph-out.feeder.erje.net	2
	TOTAL: 2	5
TOTAL: 4		1060

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17665	1458	13124	28	152	8%	23:59:53
2	fu-berlin.de	13624	381	13243	0	0	2%	23:59:52
3	news.samoylyk.net	14879	373	14213	4	0	2%	23:59:49
4	news.bbs.nz	27620	305	13903	24	0	1%	23:59:02
5	tnet	16248	130	14106	0	0	0%	23:59:50
6	news.freedyn.net	14611	52	14297	1	0	0%	23:59:53
7	xmission	13117	39	11134	1	19	0%	23:59:53
8	neva.ru	13294	38	13054	144	0	0%	23:59:46
9	newsfeed.xs4all.nl	13877	36	13341	13	497	0%	23:59:52
10	news.uzoreto.com	13878	29	13597	147	0	0%	23:59:53
11	eternal-september	12909	28	12109	12	0	0%	23:59:34
12	usenet.pasdenom.info	14767	22	14125	5	12	0%	23:59:53
13	aioe	10340	21	9946	0	0	0%	23:59:49
14	neodome.net	14777	21	14401	0	0	0%	23:59:53
15	news.mixmin.net	11359	20	11081	1	0	0%	23:59:26
16	erje	14476	15	13827	14	0	0%	23:59:07
17	news.swapon.de	1221	13	1201	0	0	1%	23:23:05
18	weretis.net	13249	12	13117	0	0	0%	23:59:53
19	news.fcku.it	1400	0	1399	0	0	0%	21:30:00
TOTAL: 19		253311	2993	225218	394	680	1%	452:48:23

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.4 MB	82.7 KB	6.5 MB	0.1 KB/s	4.5 KB	23:59:53
2	fu-berlin.de	3.4 MB	0.0 KB	3.4 MB	0.0 KB/s	9.0 KB	23:59:52
3	news.samoylyk.net	3.3 MB	17.1 KB	3.3 MB	0.0 KB/s	9.1 KB	23:59:49
4	news.bbs.nz	789.9 KB	107.8 KB	897.7 KB	0.0 KB/s	2.7 KB	23:59:02
5	news.freedyn.net	274.9 KB	6.3 KB	281.2 KB	0.0 KB/s	5.3 KB	23:59:53
6	tnet	262.4 KB	0.0 KB	262.4 KB	0.0 KB/s	2.0 KB	23:59:50
7	newsfeed.xs4all.nl	91.7 KB	64.7 KB	156.3 KB	0.0 KB/s	3.2 KB	23:59:52
8	xmission	80.7 KB	1.6 KB	82.3 KB	0.0 KB/s	2.1 KB	23:59:53
9	usenet.pasdenom.info	80.3 KB	21.3 KB	101.6 KB	0.0 KB/s	3.8 KB	23:59:53
10	neva.ru	75.7 KB	354.4 KB	430.1 KB	0.0 KB/s	2.4 KB	23:59:46
11	eternal-september	72.2 KB	66.4 KB	138.6 KB	0.0 KB/s	3.5 KB	23:59:34
12	news.mixmin.net	69.2 KB	1.7 KB	70.9 KB	0.0 KB/s	3.4 KB	23:59:26
13	news.uzoreto.com	49.5 KB	396.4 KB	445.9 KB	0.0 KB/s	2.5 KB	23:59:53
14	neodome.net	42.1 KB	0.0 KB	42.1 KB	0.0 KB/s	2.0 KB	23:59:53
15	aioe	31.2 KB	0.0 KB	31.2 KB	0.0 KB/s	1.5 KB	23:59:49
16	erje	20.5 KB	79.1 KB	99.6 KB	0.0 KB/s	3.4 KB	23:59:07
17	news.swapon.de	15.9 KB	0.0 KB	15.9 KB	0.0 KB/s	1.2 KB	23:23:05
18	weretis.net	14.0 KB	0.0 KB	14.0 KB	0.0 KB/s	1.2 KB	23:59:53
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:30:00
TOTAL: 19		15.0 MB	1.2 MB	16.2 MB	0.0 KB/s	4.9 KB	452:48:23

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	096-042-018-019.res.spectrum.com	29	22	28.1 KB	19	12	9	06:51:13
2	a131033.upc-a.chello.nl	54	17	23.7 KB	5	0	0	16:34:14
3	8.44.58.66	1	11	12.8 KB	1	0	0	00:00:10
4	ip72-222-200-117.ph.ph.cox.net	5	3	4.8 KB	1	0	0	02:27:01
TOTAL: 4		89	53	69.3 KB	26	12	9	50:13:26

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.res.spectrum.com	29	22	28.1 KB	19	12	9	06:51:13
2	*.upc-a.chello.nl	54	17	23.7 KB	5	0	0	16:34:14
3	unresolved	74	11	12.8 KB	1	0	0	24:20:45
4	*.ph.ph.cox.net	5	3	4.8 KB	1	0	0	02:27:01
5	*.20.97.83.ro.ovo.sc	1	0	0.0 KB	0	0	0	00:00:11
TOTAL: 5		163	53	69.3 KB	26	12	9	50:13:26

NNRP auth users [Top 20]:

User	Conn
ohlandl	9
TOTAL: 1	9

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	5.070	1.105	0.000	24:20:24
a131033.upc-a.chello.nl	3.704	0.758	0.000	16:34:14
096-042-018-019.res.spectrum.com	2.446	0.525	0.037	06:51:13
ip72-222-200-117.ph.ph.cox.net	0.542	0.031	0.000	02:27:01
34.20.97.83.ro.ovo.sc	0.063	0.016	0.000	00:00:11
8.44.58.66	0.113	0.008	0.000	00:00:10
192.241.234.244	0.063	0.016	0.000	00:00:09
TOTAL: 7	12.001	2.459	0.037	50:13:26

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
34.20.97.83.ro.ovo.sc	1
192.241.234.244	1
TOTAL: 3	74

NNRP client timeouts [Top 20]:

System	Conn	Peer
096-042-018-019.res.spectrum.com	9	1
ip72-222-200-117.ph.ph.cox.net	4	0
91.187.33.87	2	0
TOTAL: 3	15	1

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	51	94.4%
2	news	3	5.6%
TOTAL: 2		54	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	51
2	news.software.nntp	3
TOTAL: 2		54

Daily Usenet report for csiph.com

Sep 4 04:15:00 -- Sep 5 04:15:00