Daily Usenet report for csiph.com: Aug 25 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19244	46.9%	5.0 MB	62.4%
innd	16941	41.3%	2.2 MB	28.0%
innfeed	3522	8.6%	648.0 KB	8.0%
nnrpd	1273	3.1%	135.5 KB	1.7%
nocem	43	0.1%	4.9 KB	0.1%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	41024	100.0%	8.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	315006	56.8%
Negative hits	221027	39.8%
Do not exist	18576	3.3%
Cache misses	378	0.1%
TOTAL: 4	554987	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.317	0.0%	21	0.000	15.095	24.000
article cleanup	00:00:00.118	0.0%	18461	0.000	0.006	0.033
article logging	00:00:00.363	0.0%	18998	0.000	0.019	0.920
article parse	00:00:00.713	0.0%	54244	0.000	0.013	0.187
article write	00:00:11.932	0.0%	15491	0.147	0.770	22.175
artlog/artcncl	00:00:00.000	0.0%	21	0.000	0.000	0.000
artlog/artparse	00:00:00.002	0.0%	239	0.000	0.008	0.200
data move	00:00:00.176	0.0%	519938	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.008	0.0%	20	0.000	0.400	1.000
hishave/artcncl	00:00:00.004	0.0%	21	0.000	0.190	0.500
hishave/artparse	00:00:00.001	0.0%	219	0.000	0.005	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.539	0.0%	557536	0.001	0.008	0.045
history sync	00:00:00.809	0.0%	383	0.000	2.112	12.500
history write	00:00:10.132	0.0%	18460	0.226	0.549	2.190
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.190	0.0%	219	0.000	0.868	15.600
idle	23:58:58.595	99.9%	527672	91.753	163.622	460.945
nntp read	00:00:02.051	0.0%	528003	0.002	0.004	0.007
overview write	00:00:36.875	0.0%	15491	0.174	2.380	46.767
perl filter	00:00:26.103	0.0%	18439	1.075	1.416	2.156
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.256	0.0%	31025	0.000	0.008	0.031
TOTAL: 24:01:06.679	24:00:33.184	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.031	0.0%	15610	0.000	0.002	0.016
article prepare	00:00:00.004	0.0%	22332	0.000	0.000	0.015
article read	00:00:00.648	0.0%	3064	0.000	0.211	5.714
backlog stats	00:00:00.212	0.0%	358991	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.320	0.0%	284794	0.000	0.005	0.011
data write	00:00:01.617	0.0%	271554	0.002	0.006	0.012
idle	23:54:40.628	100.0%	358991	131.535	239.785	671.714
status file	00:00:00.250	0.0%	280	0.000	0.893	13.500
TOTAL: 23:54:50.425	23:54:44.710	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	57:02:05.071	99.7%	919	60.000	223422.275	600217.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:03:40.342	0.1%	2198	0.000	100.247	1124.133
readart	00:00:01.011	0.0%	93	0.000	10.871	42.000
TOTAL: 57:10:58.929	57:05:46.424	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	3	14843	3653	11138	52	24%	23:40:45
2	news-out.mixmin.net	2	16048	2343	13424	281	14%	24:08:53
3	feeder.eternal-september.org	4	18362	2310	15964	88	12%	26:55:52
4	news-out.aioe.org	3	15101	1930	13050	121	12%	24:08:59
5	newsfeed.neva.ru	148	15414	1070	13856	488	6%	72:04:11
6	newsfeed.fu-berlin.de	9	15120	896	14093	131	5%	26:13:20
7	csiph-out.news.xs4all.nl	861	17267	888	15378	1001	5%	71:27:17
8	csiph-out.feeder.erje.net	1392	77023	852	75803	368	1%	117:18:35
9	csiph-out.news.weretis.net	4	18079	698	17266	115	3%	28:58:32
10	news.fcku.it	10	1753	241	1509	3	13%	21:36:39
11	csiph-out.feed.uzoreto.com	864	24070	201	23408	461	0%	71:11:05
12	news-out.neodome.net	1	16491	201	16280	10	1%	23:59:55
13	nntp.pasdenom.info	2	9899	123	9766	10	1%	23:58:41
14	news.freedyn.net	2	18586	51	18437	98	0%	23:59:56
15	news.swapon.de	8	1435	37	1396	2	2%	23:06:15
16	csiph-out.news.tnetconsulting.net	1	14534	16	14486	32	0%	23:59:56
17	localhost	39	13	13	0	0	100%	00:00:04
18	news.samoylyk.net	2	15213	10	15202	1	0%	24:58:52
19	news.bbs.nz	2	12320	4	12315	1	0%	23:59:50
20	xanadu-bbs.net	35	438	0	438	0	0%	21:09:18
TOTAL: 20		3392	322009	15537	303209	3263	4%	696:56:55

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.2 MB	0.0 KB	3.8 MB	14.9 MB	74%	4.1 KB
2	feeder.eternal-september.org	6.3 MB	2.7 KB	982.7 KB	7.3 MB	86%	3.1 KB
3	news-out.aioe.org	5.2 MB	2.7 KB	330.5 KB	5.5 MB	94%	2.7 KB
4	news-out.mixmin.net	5.0 MB	1.2 KB	536.7 KB	5.6 MB	90%	2.2 KB
5	csiph-out.feeder.erje.net	4.2 MB	2.3 KB	2.2 MB	6.4 MB	65%	5.3 KB
6	newsfeed.neva.ru	3.1 MB	3.5 KB	1.3 MB	4.3 MB	70%	2.9 KB
7	csiph-out.news.xs4all.nl	2.4 MB	3.1 KB	6.6 MB	9.0 MB	26%	4.9 KB
8	csiph-out.news.weretis.net	2.1 MB	2.4 KB	1.7 MB	3.7 MB	55%	4.7 KB
9	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	511.7 KB	2.5 MB	80%	2.5 KB
10	csiph-out.feed.uzoreto.com	967.1 KB	0.0 KB	10.8 MB	11.8 MB	8%	18.2 KB
11	news-out.neodome.net	600.7 KB	1.2 KB	140.0 KB	741.9 KB	80%	3.5 KB
12	news.freedyn.net	455.0 KB	1.2 KB	2.7 MB	3.2 MB	13%	21.9 KB
13	news.fcku.it	386.2 KB	0.0 KB	6.1 KB	392.3 KB	98%	1.6 KB
14	nntp.pasdenom.info	291.3 KB	0.0 KB	16.6 KB	307.9 KB	94%	2.3 KB
15	news.swapon.de	86.3 KB	1.2 KB	3.7 KB	91.2 KB	94%	2.3 KB
16	csiph-out.news.tnetconsulting.net	83.3 KB	1.3 KB	353.7 KB	438.3 KB	19%	9.1 KB
17	news.samoylyk.net	27.0 KB	1.2 KB	1.2 KB	29.3 KB	92%	2.7 KB
18	localhost	16.6 KB	0.0 KB	0.0 KB	16.6 KB	100%	1.3 KB
19	news.bbs.nz	7.1 KB	0.0 KB	2.3 KB	9.4 KB	75%	1.9 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		44.2 MB	24.0 KB	31.9 MB	76.2 MB	58%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 25 04:15:00 - 04:59:59	245	1.6%	0.09	1.1 MB	2.6%	0.43
Aug 25 05:00:00 - 05:59:59	476	3.1%	0.13	1.4 MB	3.2%	0.40
Aug 25 06:00:00 - 06:59:59	498	3.2%	0.14	1.1 MB	2.6%	0.33
Aug 25 07:00:00 - 07:59:59	528	3.4%	0.15	1.7 MB	3.9%	0.49
Aug 25 08:00:00 - 08:59:59	670	4.3%	0.19	2.1 MB	4.7%	0.59
Aug 25 09:00:00 - 09:59:59	692	4.5%	0.19	1.7 MB	3.9%	0.48
Aug 25 10:00:00 - 10:59:59	752	4.9%	0.21	1.9 MB	4.2%	0.53
Aug 25 11:00:00 - 11:59:59	634	4.1%	0.18	1.6 MB	3.6%	0.45
Aug 25 12:00:00 - 12:59:59	738	4.8%	0.20	1.8 MB	4.1%	0.51
Aug 25 13:00:00 - 13:59:59	829	5.4%	0.23	2.3 MB	5.1%	0.64
Aug 25 14:00:00 - 14:59:59	935	6.0%	0.26	2.6 MB	5.9%	0.74
Aug 25 15:00:00 - 15:59:59	863	5.6%	0.24	2.6 MB	5.9%	0.74
Aug 25 16:00:00 - 16:59:59	847	5.5%	0.24	2.3 MB	5.3%	0.66
Aug 25 17:00:00 - 17:59:59	867	5.6%	0.24	2.3 MB	5.2%	0.65
Aug 25 18:00:00 - 18:59:59	860	5.6%	0.24	2.4 MB	5.4%	0.68
Aug 25 19:00:00 - 19:59:59	809	5.2%	0.22	2.0 MB	4.5%	0.57
Aug 25 20:00:00 - 20:59:59	767	5.0%	0.21	2.3 MB	5.2%	0.65
Aug 25 21:00:00 - 21:59:59	816	5.3%	0.23	2.4 MB	5.4%	0.68
Aug 25 22:00:00 - 22:59:59	643	4.2%	0.18	1.8 MB	4.1%	0.51
Aug 25 23:00:00 - 23:59:59	452	2.9%	0.13	1.5 MB	3.5%	0.43
Aug 26 00:00:00 - 00:59:59	411	2.7%	0.11	1.4 MB	3.2%	0.39
Aug 26 01:00:00 - 01:59:59	380	2.5%	0.11	1.4 MB	3.2%	0.40
Aug 26 02:00:00 - 02:59:59	360	2.3%	0.10	1.1 MB	2.4%	0.30
Aug 26 03:00:00 - 03:59:59	310	2.0%	0.09	954.1 KB	2.1%	0.27
Aug 26 04:00:00 - 04:15:00	87	0.6%	0.10	448.2 KB	1.0%	0.50
TOTAL: 24:00:00	15469	100.0%	0.18	44.1 MB	100.0%	0.52

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1012	37	2	973
2	newsfeed.fu-berlin.de	538	35	0	503
3	newsfeed.neva.ru	487	65	3	419
4	csiph-out.feed.uzoreto.com	461	14	0	447
5	news-out.mixmin.net	328	3	1	324
6	csiph-out.feeder.erje.net	246	62	2	182
7	csiph-out.news.weretis.net	231	62	3	166
8	news-out.aioe.org	150	83	2	65
9	news.freedyn.net	94	1	1	92
10	feeder.eternal-september.org	77	21	2	54
11	newsfeeds.xmission.com	60	3	0	57
12	csiph-out.news.tnetconsulting.net	26	24	2	0
13	news.swapon.de	18	0	1	17
14	nntp.pasdenom.info	11	0	0	11
15	news-out.neodome.net	11	0	1	10
16	news.fcku.it	3	1	0	2
17	news.samoylyk.net	2	0	1	1
18	news.bbs.nz	1	0	0	1
TOTAL: 18		3756	411	21	3324

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.bbs.synchronet	39
lada.talk	39
alt.computer.workshop	33
alt.tv.comedy-central.daily-show	33
mozilla.support.thunderbird	30
alt.politics.usa	26
spline.eisfair	19
it-alt.sport.calcio.juventus	17
mozilla.support.seamonkey	17
scinet.stats	15
alt.math.undergrad	13
alt.survival	11
mozilla.general	11
alt.binaries.pictures.purebeauty	9
lada.auto	7
alt.philosophy	7
alt.politics	6
mozilla.dev.security.policy	6
alt.binaries.ebooks	5
free.it.religioni.scientology	5
TOTAL: 59	411

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1916
EMP (phn path)	225
EMP (phl)	156
EMP (phn nph)	87
0	65
Too many newsgroups	46
HTML Multipart	30
Scoring filter	14
HTML post	2
Binary: misplaced binary	1
TOTAL: 10	2542

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	75
	csiph-out.feed.uzoreto.com	8
	csiph-out.news.xs4all.nl	6
	TOTAL: 3	89
Huge articles
	csiph-out.feed.uzoreto.com	56
	newsfeeds.xmission.com	52
	csiph-out.feeder.erje.net	41
	news.freedyn.net	37
	csiph-out.news.weretis.net	13
	csiph-out.news.xs4all.nl	12
	feeder.eternal-september.org	6
	newsfeed.fu-berlin.de	4
	news-out.neodome.net	3
	news-out.mixmin.net	1
	TOTAL: 10	225
Including strange strings
	newsfeed.fu-berlin.de	406
	news-out.mixmin.net	45
	news-out.aioe.org	44
	news.swapon.de	16
	csiph-out.news.weretis.net	13
	csiph-out.news.xs4all.nl	4
	newsfeeds.xmission.com	4
	news.samoylyk.net	1
	csiph-out.feeder.erje.net	1
	news.fcku.it	1
	TOTAL: 11	536
No colon-space in header
	csiph-out.news.xs4all.nl	14
	csiph-out.feeder.erje.net	3
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	18
TOTAL: 4		868

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.nz	27203	2379	12725	0	0	8%	23:59:56
2	xanadu-bbs	19062	1353	14089	28	0	7%	23:59:45
3	fu-berlin.de	14462	365	14097	0	0	2%	23:59:40
4	news.samoylyk.net	15948	353	15100	5	6	2%	23:59:56
5	tnet	16693	281	14829	2	0	1%	23:59:42
6	neva.ru	13946	85	13629	139	0	0%	23:59:56
7	news.freedyn.net	15476	61	15106	1	0	0%	23:59:48
8	newsfeed.xs4all.nl	14913	58	14439	15	131	0%	23:59:55
9	erje	14916	44	14223	216	9	0%	23:59:56
10	xmission	13545	40	11341	10	0	0%	23:59:56
11	eternal-september	13390	28	12834	0	0	0%	23:59:56
12	aioe	11545	26	11035	2	0	0%	23:59:56
13	usenet.pasdenom.info	15649	26	14953	6	25	0%	23:59:56
14	news.swapon.de	1436	17	1412	0	0	1%	23:27:33
15	news.mixmin.net	12937	16	12595	0	0	0%	23:59:45
16	neodome.net	15625	14	15195	0	0	0%	23:59:31
17	weretis.net	14415	14	14260	0	0	0%	23:59:47
18	news.uzoreto.com	15229	7	14873	17	0	0%	23:59:55
19	news.fcku.it	1426	0	1425	0	0	0%	20:51:39
TOTAL: 19		267816	5167	238160	441	171	1%	452:16:28

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.nz	6.7 MB	0.0 KB	6.7 MB	0.1 KB/s	2.9 KB	23:59:56
2	xanadu-bbs	5.6 MB	146.0 KB	5.8 MB	0.1 KB/s	4.3 KB	23:59:45
3	fu-berlin.de	2.8 MB	0.0 KB	2.8 MB	0.0 KB/s	7.7 KB	23:59:40
4	news.samoylyk.net	2.7 MB	8.5 KB	2.7 MB	0.0 KB/s	7.9 KB	23:59:56
5	tnet	797.1 KB	2.4 KB	799.5 KB	0.0 KB/s	2.8 KB	23:59:42
6	news.freedyn.net	235.0 KB	2.4 KB	237.4 KB	0.0 KB/s	3.8 KB	23:59:48
7	neva.ru	230.7 KB	394.7 KB	625.4 KB	0.0 KB/s	2.8 KB	23:59:56
8	newsfeed.xs4all.nl	133.0 KB	51.2 KB	184.2 KB	0.0 KB/s	2.5 KB	23:59:55
9	xmission	111.2 KB	21.3 KB	132.4 KB	0.0 KB/s	2.6 KB	23:59:56
10	erje	96.5 KB	677.9 KB	774.4 KB	0.0 KB/s	3.0 KB	23:59:56
11	eternal-september	68.7 KB	0.0 KB	68.7 KB	0.0 KB/s	2.5 KB	23:59:56
12	usenet.pasdenom.info	62.3 KB	18.6 KB	81.0 KB	0.0 KB/s	2.5 KB	23:59:56
13	aioe	55.7 KB	1.9 KB	57.7 KB	0.0 KB/s	2.1 KB	23:59:56
14	news.mixmin.net	25.8 KB	0.0 KB	25.8 KB	0.0 KB/s	1.6 KB	23:59:45
15	news.swapon.de	25.0 KB	0.0 KB	25.0 KB	0.0 KB/s	1.5 KB	23:27:33
16	neodome.net	23.8 KB	0.0 KB	23.8 KB	0.0 KB/s	1.7 KB	23:59:31
17	weretis.net	21.4 KB	0.0 KB	21.4 KB	0.0 KB/s	1.5 KB	23:59:47
18	news.uzoreto.com	19.2 KB	29.4 KB	48.6 KB	0.0 KB/s	2.0 KB	23:59:55
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:51:39
TOTAL: 19		19.7 MB	1.3 MB	21.0 MB	0.0 KB/s	3.8 KB	452:16:28

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	p2e5b5b6a.dip0.t-ipconnect.de	1	40	178.5 KB	2	0	0	00:04:44
2	047-035-184-231.res.spectrum.com	39	24	37.8 KB	16	13	12	10:54:32
3	a131033.upc-a.chello.nl	71	22	31.6 KB	9	0	0	20:11:34
4	ppp-2-84-161-83.home.otenet.gr	1	7	11.0 KB	1	0	0	00:00:06
TOTAL: 4		112	93	258.9 KB	28	13	12	57:10:57

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dip0.t-ipconnect.de	1	40	178.5 KB	2	0	0	00:04:44
2	*.res.spectrum.com	39	24	37.8 KB	16	13	12	10:54:32
3	*.upc-a.chello.nl	71	22	31.6 KB	9	0	0	20:11:34
4	*.home.otenet.gr	1	7	11.0 KB	1	0	0	00:00:06
5	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:12
6	unresolved	75	0	0.0 KB	0	0	0	23:59:46
7	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 7		192	93	258.9 KB	28	13	12	57:10:57

NNRP auth users [Top 20]:

User	Conn
ohlandl	12
TOTAL: 1	12

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	5.113	1.027	0.000	23:59:42
a131033.upc-a.chello.nl	5.081	1.093	0.000	20:11:34
047-035-184-231.res.spectrum.com	3.214	0.675	0.033	10:54:32
ip72-222-200-117.ph.ph.cox.net	0.437	0.070	0.000	02:00:12
p2e5b5b6a.dip0.t-ipconnect.de	1.318	6.867	0.000	00:04:44
ppp-2-84-161-83.home.otenet.gr	0.089	0.032	0.000	00:00:06
151.38.91.209	0.123	0.032	0.000	00:00:02
151.82.163.123	0.064	0.016	0.000	00:00:01
scan-141.security.ipip.net	0.058	0.017	0.000	00:00:01
TOTAL: 9	15.497	9.829	0.033	57:10:57

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
ip72-222-200-117.ph.ph.cox.net	4
151.38.91.209	2
151.82.163.123	1
scan-141.security.ipip.net	1
TOTAL: 5	80

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
047-035-184-231.res.spectrum.com	12	1
ip72-222-200-117.ph.ph.cox.net	4	0
TOTAL: 2	16	1

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	53	57.0%
2	alt	28	30.1%
3	de	12	12.9%
TOTAL: 3		93	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	53
2	alt.free.newsservers	28
3	de.sci.electronics	12
TOTAL: 3		93

Daily Usenet report for csiph.com

Aug 25 04:15:00 -- Aug 26 04:15:00