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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17602	46.0%	4.4 MB	60.5%
innd	16103	42.1%	2.1 MB	29.3%
innfeed	3492	9.1%	627.9 KB	8.5%
nnrpd	1045	2.7%	114.7 KB	1.6%
nocem	44	0.1%	5.2 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	38287	100.0%	7.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	284205	56.4%
Negative hits	202991	40.2%
Do not exist	16974	3.4%
Cache misses	168	0.0%
TOTAL: 4	504338	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.164	0.0%	14	0.000	11.714	19.750
article cleanup	00:00:00.107	0.0%	16928	0.000	0.006	0.034
article logging	00:00:00.497	0.0%	17440	0.000	0.028	1.239
article parse	00:00:00.731	0.0%	47340	0.000	0.015	0.129
article write	00:00:32.760	0.0%	13559	0.191	2.416	59.111
artlog/artcncl	00:00:00.002	0.0%	14	0.000	0.143	1.000
artlog/artparse	00:00:00.005	0.0%	134	0.000	0.037	0.333
data move	00:00:00.152	0.0%	476874	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.015	0.0%	14	0.000	1.071	1.750
hishave/artcncl	00:00:00.005	0.0%	14	0.000	0.357	0.625
hishave/artparse	00:00:00.001	0.0%	123	0.000	0.008	0.091
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:35.617	0.0%	504924	0.002	0.071	0.279
history sync	00:00:01.147	0.0%	384	0.000	2.987	56.667
history write	00:00:53.531	0.1%	16875	0.593	3.172	11.750
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.330	0.0%	122	0.000	2.705	20.667
idle	23:56:19.945	99.7%	479286	94.688	179.809	616.774
nntp read	00:00:01.889	0.0%	485086	0.001	0.004	0.008
overview write	00:01:32.435	0.1%	13559	0.185	6.817	655.200
perl filter	00:00:22.713	0.0%	16864	1.007	1.347	2.026
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.233	0.0%	27162	0.000	0.009	0.038
TOTAL: 24:01:01.364	24:00:22.279	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.044	0.0%	13843	0.000	0.003	0.028
article prepare	00:00:00.001	0.0%	13516	0.000	0.000	0.010
article read	00:00:00.347	0.0%	1566	0.000	0.222	14.667
backlog stats	00:00:00.172	0.0%	321535	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.175	0.0%	248613	0.000	0.005	0.015
data write	00:00:01.399	0.0%	236444	0.002	0.006	0.015
idle	23:54:09.593	100.0%	321535	145.741	267.621	980.448
status file	00:00:00.263	0.0%	301	0.000	0.874	21.000
TOTAL: 23:54:22.407	23:54:12.994	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	51:07:14.508	99.9%	653	68.000	281829.262	600101.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.008	0.0%	1476	0.000	0.005	0.167
readart	00:00:00.211	0.0%	23	0.000	9.174	42.000
TOTAL: 51:11:26.242	51:07:14.727	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	13027	3246	9752	29	24%	24:24:22
2	csiph-out.news.xs4all.nl	576	16286	2195	12317	1774	13%	67:37:13
3	news-out.mixmin.net	2	14979	2186	12460	333	14%	24:08:57
4	feeder.eternal-september.org	1	15000	1753	13172	75	11%	21:17:58
5	news-out.aioe.org	2	13046	1069	11881	96	8%	23:59:53
6	newsfeed.fu-berlin.de	4	18125	915	17047	163	5%	32:52:17
7	csiph-out.feeder.erje.net	1440	69131	647	68343	141	0%	118:42:27
8	csiph-out.news.weretis.net	3	19637	526	18901	210	2%	35:54:26
9	newsfeed.neva.ru	139	13828	385	12920	523	2%	72:02:18
10	news.fcku.it	10	1458	266	1191	1	18%	21:33:05
11	csiph-out.feed.uzoreto.com	864	21344	130	21057	157	0%	71:11:08
12	news-out.neodome.net	2	15602	130	15463	9	0%	23:58:53
13	news.bbs.nz	2	13350	67	13280	3	0%	23:59:48
14	nntp.pasdenom.info	2	8307	48	8236	23	0%	23:59:16
15	csiph-out.news.tnetconsulting.net	2	13844	34	13780	30	0%	23:59:56
16	news.swapon.de	16	1206	32	1173	1	2%	23:16:46
17	news.freedyn.net	1	16764	26	16720	18	0%	23:57:54
18	localhost	31	5	5	0	0	100%	00:00:00
19	news.samoylyk.net	3	13115	4	13108	3	0%	24:53:45
20	xanadu-bbs.net	46	230	0	230	0	0%	17:35:08
TOTAL: 20		3148	298284	13664	281031	3589	4%	699:25:30

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	10.2 MB	0.0 KB	1.6 MB	11.8 MB	86%	3.7 KB
2	csiph-out.news.xs4all.nl	5.8 MB	7.1 KB	9.4 MB	15.3 MB	38%	3.9 KB
3	csiph-out.feeder.erje.net	4.8 MB	18.4 KB	1.7 MB	6.5 MB	73%	8.5 KB
4	feeder.eternal-september.org	4.4 MB	6.0 KB	659.0 KB	5.1 MB	87%	2.8 KB
5	news-out.mixmin.net	4.1 MB	7.0 KB	698.5 KB	4.8 MB	85%	2.0 KB
6	news-out.aioe.org	3.6 MB	6.9 KB	253.0 KB	3.8 MB	93%	3.4 KB
7	newsfeed.fu-berlin.de	2.2 MB	2.2 KB	398.0 KB	2.6 MB	84%	2.5 KB
8	csiph-out.news.weretis.net	1.4 MB	7.1 KB	874.9 KB	2.2 MB	61%	3.1 KB
9	newsfeed.neva.ru	992.5 KB	20.0 KB	1.6 MB	2.6 MB	37%	2.9 KB
10	csiph-out.feed.uzoreto.com	716.3 KB	12.3 KB	3.1 MB	3.9 MB	18%	13.8 KB
11	news.freedyn.net	450.3 KB	7.0 KB	456.9 KB	914.2 KB	49%	20.8 KB
12	news-out.neodome.net	434.2 KB	7.2 KB	48.4 KB	489.8 KB	88%	3.5 KB
13	news.fcku.it	404.6 KB	2.1 KB	2.1 KB	408.8 KB	98%	1.5 KB
14	news.bbs.nz	180.2 KB	0.0 KB	5.8 KB	186.1 KB	96%	2.7 KB
15	nntp.pasdenom.info	114.7 KB	0.0 KB	29.7 KB	144.4 KB	79%	2.0 KB
16	csiph-out.news.tnetconsulting.net	92.6 KB	7.1 KB	60.5 KB	160.1 KB	57%	2.5 KB
17	news.swapon.de	76.4 KB	1.6 KB	1.6 KB	79.7 KB	95%	2.4 KB
18	news.samoylyk.net	8.7 KB	6.1 KB	6.1 KB	20.9 KB	41%	3.0 KB
19	localhost	5.0 KB	0.0 KB	0.0 KB	5.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		39.9 MB	118.1 KB	20.9 MB	61.0 MB	65%	3.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 4 04:15:00 - 04:59:59	186	1.4%	0.07	451.8 KB	1.1%	0.17
Oct 4 05:00:00 - 05:59:59	303	2.2%	0.08	759.7 KB	1.8%	0.21
Oct 4 06:00:00 - 06:59:59	456	3.4%	0.13	1.9 MB	4.7%	0.54
Oct 4 07:00:00 - 07:59:59	540	4.0%	0.15	1.9 MB	4.7%	0.54
Oct 4 08:00:00 - 08:59:59	528	3.9%	0.15	1.6 MB	3.9%	0.44
Oct 4 09:00:00 - 09:59:59	680	5.0%	0.19	2.6 MB	6.4%	0.73
Oct 4 10:00:00 - 10:59:59	634	4.7%	0.18	1.7 MB	4.2%	0.48
Oct 4 11:00:00 - 11:59:59	554	4.1%	0.15	1.4 MB	3.5%	0.40
Oct 4 12:00:00 - 12:59:59	598	4.4%	0.17	1.4 MB	3.4%	0.39
Oct 4 13:00:00 - 13:59:59	847	6.2%	0.24	2.9 MB	7.2%	0.82
Oct 4 14:00:00 - 14:59:59	688	5.1%	0.19	1.8 MB	4.5%	0.52
Oct 4 15:00:00 - 15:59:59	917	6.8%	0.25	2.5 MB	6.2%	0.71
Oct 4 16:00:00 - 16:59:59	842	6.2%	0.23	2.3 MB	5.7%	0.65
Oct 4 17:00:00 - 17:59:59	834	6.1%	0.23	2.2 MB	5.4%	0.62
Oct 4 18:00:00 - 18:59:59	746	5.5%	0.21	2.0 MB	5.0%	0.57
Oct 4 19:00:00 - 19:59:59	683	5.0%	0.19	1.8 MB	4.6%	0.52
Oct 4 20:00:00 - 20:59:59	711	5.2%	0.20	2.0 MB	4.9%	0.56
Oct 4 21:00:00 - 21:59:59	748	5.5%	0.21	2.2 MB	5.5%	0.63
Oct 4 22:00:00 - 22:59:59	418	3.1%	0.12	1.5 MB	3.8%	0.43
Oct 4 23:00:00 - 23:59:59	387	2.9%	0.11	1012.4 KB	2.5%	0.28
Oct 5 00:00:00 - 00:59:59	337	2.5%	0.09	1.0 MB	2.6%	0.30
Oct 5 01:00:00 - 01:59:59	311	2.3%	0.09	967.1 KB	2.3%	0.27
Oct 5 02:00:00 - 02:59:59	263	1.9%	0.07	821.3 KB	2.0%	0.23
Oct 5 03:00:00 - 03:59:59	248	1.8%	0.07	901.2 KB	2.2%	0.25
Oct 5 04:00:00 - 04:15:00	108	0.8%	0.12	777.1 KB	1.9%	0.86
TOTAL: 24:00:00	13567	100.0%	0.16	40.2 MB	100.0%	0.48

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1833	63	4	1766
2	newsfeed.neva.ru	519	140	11	368
3	newsfeed.fu-berlin.de	487	28	1	458
4	news-out.mixmin.net	389	31	4	354
5	csiph-out.news.weretis.net	166	10	4	152
6	csiph-out.feed.uzoreto.com	157	2	7	148
7	csiph-out.feeder.erje.net	141	47	10	84
8	news-out.aioe.org	124	72	4	48
9	feeder.eternal-september.org	82	44	3	35
10	newsfeeds.xmission.com	31	6	0	25
11	nntp.pasdenom.info	23	0	0	23
12	news.freedyn.net	21	0	4	17
13	csiph-out.news.tnetconsulting.net	20	17	3	0
14	news.swapon.de	14	0	1	13
15	news-out.neodome.net	9	1	4	4
16	news.samoylyk.net	3	0	3	0
17	news.fcku.it	1	0	1	0
TOTAL: 17		4020	461	64	3495

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	129
alt.computer.workshop	67
alt.bbs.synchronet	31
it-alt.sport.calcio.juventus	30
scinet.stats	20
alt.politics	17
alt.politics.usa	16
mozilla.support.firefox	16
alt.survival	15
spline.eisfair	10
lada.auto	10
alt.binaries.pictures.purebeauty	10
alt.philosophy	7
oesterreich.tratsch	7
alt.binaries.ebook	7
mozilla.support.seamonkey	7
alt.windows7.general	6
cakewalk.audio	6
alt.binaries.ebooks	3
alt.sex.erotica.female	3
TOTAL: 58	461

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2013
EMP (phn path)	436
EMP (phn nph)	120
EMP (phl)	85
Too many newsgroups	80
0	70
HTML Multipart	17
Scoring filter	15
Binary: misplaced binary	11
Too many newsgroups (meow)	1
Binary Payload	1
TOTAL: 11	2849

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.news.xs4all.nl	37
	csiph-out.feeder.erje.net	29
	newsfeeds.xmission.com	22
	csiph-out.feed.uzoreto.com	17
	news.freedyn.net	10
	feeder.eternal-september.org	5
	csiph-out.news.weretis.net	2
	newsfeed.fu-berlin.de	1
	TOTAL: 8	123
Including strange strings
	newsfeed.fu-berlin.de	360
	news-out.mixmin.net	59
	csiph-out.news.xs4all.nl	52
	news-out.aioe.org	22
	news.swapon.de	13
	newsfeeds.xmission.com	3
	csiph-out.news.weretis.net	1
	csiph-out.feeder.erje.net	1
	feeder.eternal-september.org	1
	TOTAL: 9	512
No colon-space in header
	csiph-out.news.xs4all.nl	8
	csiph-out.feeder.erje.net	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	11
TOTAL: 4		691

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	16834	1136	12403	24	147	6%	23:59:31
2	news.bbs.nz	25350	511	12516	23	0	2%	23:56:09
3	news.samoylyk.net	13931	491	13065	1	156	3%	23:57:19
4	fu-berlin.de	12560	488	12072	0	0	3%	23:50:54
5	neva.ru	12567	140	12315	18	0	1%	23:50:11
6	tnet	14131	102	12906	0	0	0%	23:50:11
7	news.freedyn.net	13266	59	12930	0	0	0%	23:50:11
8	erje	14743	57	12607	114	0	0%	23:51:20
9	newsfeed.xs4all.nl	11648	46	11191	0	0	0%	23:50:11
10	aioe	9463	18	9118	1	0	0%	23:50:11
11	usenet.pasdenom.info	13494	14	12952	4	0	0%	23:51:26
12	neodome.net	13734	9	13374	0	0	0%	23:55:53
13	eternal-september	11404	7	11072	0	0	0%	23:50:11
14	xmission	12203	7	9733	2	0	0%	23:50:11
15	news.mixmin.net	10765	6	10507	0	0	0%	23:50:11
16	news.swapon.de	1195	6	1187	0	0	0%	22:58:10
17	weretis.net	12562	5	12337	1	0	0%	23:50:11
18	news.uzoreto.com	12538	4	12321	90	0	0%	23:50:11
19	news.fcku.it	1119	0	1117	0	0	0%	21:13:30
TOTAL: 19		233507	3106	205723	278	303	1%	449:56:02

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.9 MB	73.1 KB	7.0 MB	0.1 KB/s	6.2 KB	23:59:31
2	news.samoylyk.net	4.7 MB	1.2 KB	4.7 MB	0.1 KB/s	9.8 KB	23:57:19
3	fu-berlin.de	4.5 MB	0.0 KB	4.5 MB	0.1 KB/s	9.4 KB	23:50:54
4	news.bbs.nz	1.4 MB	70.2 KB	1.5 MB	0.0 KB/s	2.8 KB	23:56:09
5	news.freedyn.net	829.9 KB	0.0 KB	829.9 KB	0.0 KB/s	14.1 KB	23:50:11
6	neva.ru	306.6 KB	73.8 KB	380.4 KB	0.0 KB/s	2.4 KB	23:50:11
7	tnet	207.7 KB	0.0 KB	207.7 KB	0.0 KB/s	2.0 KB	23:50:11
8	newsfeed.xs4all.nl	158.6 KB	0.0 KB	158.6 KB	0.0 KB/s	3.4 KB	23:50:11
9	erje	132.9 KB	480.7 KB	613.5 KB	0.0 KB/s	3.6 KB	23:51:20
10	usenet.pasdenom.info	97.3 KB	12.2 KB	109.5 KB	0.0 KB/s	6.1 KB	23:51:26
11	eternal-september	42.6 KB	0.0 KB	42.6 KB	0.0 KB/s	6.1 KB	23:50:11
12	news.mixmin.net	39.2 KB	0.0 KB	39.2 KB	0.0 KB/s	6.5 KB	23:50:11
13	news.swapon.de	38.9 KB	0.0 KB	38.9 KB	0.0 KB/s	6.5 KB	22:58:10
14	aioe	38.0 KB	1.2 KB	39.2 KB	0.0 KB/s	2.1 KB	23:50:11
15	neodome.net	14.2 KB	0.0 KB	14.2 KB	0.0 KB/s	1.6 KB	23:55:53
16	xmission	10.9 KB	4.7 KB	15.5 KB	0.0 KB/s	1.7 KB	23:50:11
17	news.uzoreto.com	9.6 KB	248.0 KB	257.6 KB	0.0 KB/s	2.7 KB	23:50:11
18	weretis.net	4.6 KB	1.1 KB	5.8 KB	0.0 KB/s	1.0 KB	23:50:11
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:13:30
TOTAL: 19		19.4 MB	966.2 KB	20.4 MB	0.0 KB/s	6.2 KB	449:56:02

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	62	16	20.1 KB	6	0	0	19:06:10
2	096-042-018-108.res.spectrum.com	31	7	8.0 KB	6	5	5	08:40:48
TOTAL: 2		93	23	28.0 KB	12	5	5	51:11:25

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	62	16	20.1 KB	6	0	0	19:06:10
2	*.res.spectrum.com	31	7	8.0 KB	6	5	5	08:40:48
3	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
4	*.home.otenet.gr	4	0	0.0 KB	0	0	0	00:00:04
5	*.ph.ph.cox.net	12	0	0.0 KB	0	0	0	03:43:37
6	unresolved	61	0	0.0 KB	0	0	0	19:40:43
TOTAL: 6		171	23	28.0 KB	12	5	5	51:11:25

NNRP auth users [Top 20]:

User	Conn
ohlandl	5
TOTAL: 1	5

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.139	0.889	0.000	19:40:33
a131033.upc-a.chello.nl	4.257	0.935	0.000	19:06:10
096-042-018-108.res.spectrum.com	2.251	0.465	0.011	08:40:48
ip72-222-200-117.ph.ph.cox.net	0.784	0.183	0.000	03:43:37
162.243.128.11	0.072	0.008	0.000	00:00:09
ppp-2-84-172-192.home.otenet.gr	0.269	0.033	0.000	00:00:04
scan-141.security.ipip.net	0.050	0.029	0.000	00:00:00
TOTAL: 7	11.822	2.542	0.011	51:11:25

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	60
ip72-222-200-117.ph.ph.cox.net	12
ppp-2-84-172-192.home.otenet.gr	4
scan-141.security.ipip.net	1
162.243.128.11	1
TOTAL: 5	78

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

Command	Count
Host: 69.160.37.58:119	1
Connection: close	1
User-Agent: HTTP Banner Detection (https...	1
GET / HTTP/1.1	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
096-042-018-108.res.spectrum.com	10	0
ip72-222-200-117.ph.ph.cox.net	6	0
TOTAL: 2	16	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Oct 4 04:15:00 -- Oct 5 04:15:00