Daily Usenet report for csiph.com: Jun 19 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	22126	49.1%	5.6 MB	65.0%
innd	18627	41.3%	2.3 MB	27.0%
innfeed	3410	7.6%	591.3 KB	6.8%
nnrpd	853	1.9%	95.9 KB	1.1%
nocem	73	0.2%	7.8 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	45090	100.0%	8.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	313964	53.7%
Negative hits	206385	35.3%
Cache misses	43299	7.4%
Do not exist	21473	3.7%
TOTAL: 4	585121	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.452	0.0%	175	0.000	8.297	115.000
article cleanup	00:00:00.151	0.0%	20290	0.000	0.007	0.037
article logging	00:00:00.527	0.0%	20720	0.000	0.025	0.320
article parse	00:00:05.527	0.0%	100760	0.000	0.055	0.577
article write	00:02:58.363	0.2%	16639	0.516	10.720	88.349
artlog/artcncl	00:00:00.001	0.0%	158	0.000	0.006	0.111
artlog/artparse	00:00:00.025	0.0%	1267	0.000	0.020	0.333
data move	00:00:00.182	0.0%	563701	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.089	0.0%	175	0.000	0.509	4.400
hishave/artcncl	00:00:00.015	0.0%	175	0.000	0.086	1.111
hishave/artparse	00:00:00.004	0.0%	1266	0.000	0.003	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:01.406	0.1%	585839	0.001	0.105	0.719
history sync	00:00:02.712	0.0%	374	0.000	7.251	123.000
history write	00:01:04.919	0.1%	20272	0.221	3.202	12.379
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:04.564	0.0%	1266	0.000	3.605	49.400
idle	23:47:29.446	99.1%	551424	94.587	155.324	486.125
nntp read	00:00:02.646	0.0%	569202	0.001	0.005	0.020
overview write	00:06:49.314	0.5%	16639	1.973	24.600	834.000
perl filter	00:00:36.351	0.0%	20185	1.250	1.801	3.795
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.280	0.0%	33345	0.000	0.008	0.024
TOTAL: 24:00:55.504	24:00:17.974	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.051	0.0%	18299	0.000	0.003	0.023
article prepare	00:00:00.002	0.0%	17878	0.000	0.000	0.010
article read	00:00:06.558	0.0%	2037	0.000	3.219	65.333
backlog stats	00:00:00.174	0.0%	356984	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.614	0.0%	274625	0.000	0.006	0.011
data write	00:00:01.602	0.0%	261830	0.001	0.006	0.014
idle	23:54:10.954	100.0%	356984	96.820	241.050	792.737
status file	00:00:01.346	0.0%	344	0.000	3.913	215.000
TOTAL: 23:54:32.579	23:54:22.301	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:14.783	0.0%	24951	0.000	0.592	1.000
idle	39:23:06.198	99.9%	25626	340.031	5532.904	600083.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.294	0.0%	51501	0.000	0.006	0.167
readart	00:00:00.865	0.0%	35	0.000	24.714	119.500
TOTAL: 39:24:33.276	39:23:22.140	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
mode	30
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	50

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1440	80297	3544	76342	411	4%	118:47:40
2	csiph-out.news.weretis.net	3	33928	2734	30863	331	8%	48:38:16
3	feeder.eternal-september.org	5	18510	2129	16279	102	11%	25:12:10
4	news.freedyn.net	3	20645	1607	16960	2078	7%	24:09:01
5	news-out.aioe.org	3	16215	1523	14669	23	9%	24:09:20
6	newsfeed.neva.ru	150	21181	1219	19182	780	5%	72:04:54
7	newsfeed.fu-berlin.de	15	16619	1031	15490	98	6%	28:03:49
8	news-out.mixmin.net	3	17110	952	15984	174	5%	24:08:15
9	newsfeeds.xmission.com	3	16496	677	15811	8	4%	25:00:33
10	csiph-out.news.xs4all.nl	861	18535	676	17329	530	3%	71:22:18
11	news.fcku.it	10	2282	305	1973	4	13%	23:54:48
12	csiph-out.feed.uzoreto.com	864	48156	300	47471	385	0%	71:07:02
13	nntp.pasdenom.info	16	26244	27	26126	91	0%	24:01:27
14	news.swapon.de	5	1512	19	1492	1	1%	24:40:50
15	news.samoylyk.net	1	16139	16	16122	1	0%	23:59:47
16	news.bbs.nz	1	15301	15	15282	4	0%	23:59:53
17	localhost	43	10	10	0	0	100%	00:00:00
18	xanadu-bbs.net	18	718	0	718	0	0%	24:10:03
TOTAL: 18		3444	369898	16784	348093	5021	4%	677:30:06

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	14.9 MB	0.0 KB	9.9 MB	24.8 MB	59%	6.4 KB
2	csiph-out.news.weretis.net	8.6 MB	16.0 KB	6.3 MB	15.0 MB	57%	5.0 KB
3	feeder.eternal-september.org	5.4 MB	10.8 KB	702.7 KB	6.1 MB	88%	2.8 KB
4	news.freedyn.net	4.4 MB	5.2 KB	120.4 MB	124.8 MB	3%	34.7 KB
5	news-out.aioe.org	3.6 MB	1.8 KB	68.6 KB	3.6 MB	98%	2.4 KB
6	newsfeed.neva.ru	3.1 MB	1.7 KB	3.8 MB	6.8 MB	44%	3.5 KB
7	news-out.mixmin.net	2.9 MB	7.3 KB	409.4 KB	3.3 MB	87%	3.0 KB
8	newsfeed.fu-berlin.de	2.5 MB	0.0 KB	298.4 KB	2.8 MB	89%	2.5 KB
9	newsfeeds.xmission.com	2.3 MB	1.8 KB	386.9 KB	2.7 MB	86%	4.1 KB
10	csiph-out.news.xs4all.nl	1.6 MB	0.0 KB	3.6 MB	5.2 MB	31%	4.4 KB
11	csiph-out.feed.uzoreto.com	1012.0 KB	0.0 KB	4.7 MB	5.7 MB	17%	8.4 KB
12	news.fcku.it	527.6 KB	0.0 KB	102.7 KB	630.4 KB	83%	2.0 KB
13	nntp.pasdenom.info	68.8 KB	1.8 KB	310.2 KB	380.7 KB	18%	3.2 KB
14	news.swapon.de	68.0 KB	1.7 KB	1.7 KB	71.5 KB	95%	3.6 KB
15	news.samoylyk.net	50.0 KB	1.8 KB	1.8 KB	53.5 KB	93%	3.1 KB
16	news.bbs.nz	35.0 KB	1.8 KB	8.1 KB	44.9 KB	77%	2.4 KB
17	localhost	19.1 KB	0.0 KB	0.0 KB	19.1 KB	100%	1.9 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		51.0 MB	51.7 KB	150.9 MB	202.0 MB	25%	9.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 19 04:15:00 - 04:59:59	394	2.4%	0.15	1.4 MB	2.7%	0.52
Jun 19 05:00:00 - 05:59:59	407	2.4%	0.11	1.1 MB	2.1%	0.30
Jun 19 06:00:00 - 06:59:59	538	3.2%	0.15	2.2 MB	4.3%	0.62
Jun 19 07:00:00 - 07:59:59	517	3.1%	0.14	1.5 MB	2.9%	0.43
Jun 19 08:00:00 - 08:59:59	766	4.6%	0.21	2.0 MB	4.0%	0.58
Jun 19 09:00:00 - 09:59:59	907	5.5%	0.25	2.0 MB	4.0%	0.58
Jun 19 10:00:00 - 10:59:59	795	4.8%	0.22	2.5 MB	4.8%	0.70
Jun 19 11:00:00 - 11:59:59	766	4.6%	0.21	2.0 MB	4.0%	0.58
Jun 19 12:00:00 - 12:59:59	791	4.8%	0.22	2.0 MB	4.0%	0.57
Jun 19 13:00:00 - 13:59:59	918	5.5%	0.26	2.7 MB	5.4%	0.77
Jun 19 14:00:00 - 14:59:59	982	5.9%	0.27	3.9 MB	7.7%	1.11
Jun 19 15:00:00 - 15:59:59	994	6.0%	0.28	3.2 MB	6.2%	0.90
Jun 19 16:00:00 - 16:59:59	988	5.9%	0.27	2.9 MB	5.8%	0.84
Jun 19 17:00:00 - 17:59:59	1016	6.1%	0.28	2.8 MB	5.5%	0.79
Jun 19 18:00:00 - 18:59:59	858	5.2%	0.24	2.9 MB	5.7%	0.82
Jun 19 19:00:00 - 19:59:59	842	5.1%	0.23	2.3 MB	4.6%	0.66
Jun 19 20:00:00 - 20:59:59	823	4.9%	0.23	2.3 MB	4.6%	0.67
Jun 19 21:00:00 - 21:59:59	779	4.7%	0.22	2.3 MB	4.5%	0.64
Jun 19 22:00:00 - 22:59:59	595	3.6%	0.17	2.1 MB	4.2%	0.61
Jun 19 23:00:00 - 23:59:59	485	2.9%	0.13	1.5 MB	2.9%	0.42
Jun 20 00:00:00 - 00:59:59	364	2.2%	0.10	1.0 MB	2.0%	0.30
Jun 20 01:00:00 - 01:59:59	302	1.8%	0.08	918.4 KB	1.8%	0.26
Jun 20 02:00:00 - 02:59:59	390	2.3%	0.11	1.6 MB	3.2%	0.46
Jun 20 03:00:00 - 03:59:59	314	1.9%	0.09	1007.3 KB	1.9%	0.28
Jun 20 04:00:00 - 04:15:00	105	0.6%	0.12	570.5 KB	1.1%	0.63
TOTAL: 24:00:00	16636	100.0%	0.19	50.8 MB	100.0%	0.60

Sites sending bad articles:

Server		Total	Group	Duplic	TooOld	Other
1	news.freedyn.net	2007	29	2	0	1976
2	newsfeed.neva.ru	782	184	1	0	597
3	csiph-out.news.xs4all.nl	524	11	0	0	513
4	newsfeed.fu-berlin.de	481	19	0	0	462
5	csiph-out.feeder.erje.net	407	64	0	0	343
6	csiph-out.feed.uzoreto.com	383	14	0	0	369
7	csiph-out.news.weretis.net	322	69	5	0	248
8	news-out.mixmin.net	180	4	2	0	174
9	feeder.eternal-september.org	102	16	3	0	83
10	nntp.pasdenom.info	96	0	1	72	23
11	news-out.aioe.org	27	18	1	0	8
12	news.swapon.de	8	0	1	0	7
13	newsfeeds.xmission.com	5	0	1	0	4
14	news.fcku.it	4	1	0	0	3
15	news.bbs.nz	4	1	1	0	2
16	news.samoylyk.net	1	0	1	0	0
TOTAL: 16		5333	430	19	72	4812

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	149
it-alt.sport.calcio.juventus	36
alt.bbs.synchronet	19
lada.auto	17
alt.sports.hockey.nhl	12
lada.kitchen	10
alt.2600.hackers	9
oesterreich.tratsch	9
alt.windows7.general	8
alt.computer.workshop	8
lada.commerce	7
mozilla.support.firefox	7
mozilla.support.seamonkey	7
mozilla.dev.apps.thunderbird	7
it-alt.comp.software.mozilla	6
spline.eisfair	6
alt.binaries.ebooks	5
alt.religion	4
mozilla.general	4
alt.philosophy	4
TOTAL: 84	430

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2497
EMP (phn path)	144
EMP (phn nph)	121
Binary: misplaced rar	104
Binary Payload	63
Too many newsgroups	48
EMP (phl)	37
HTML Multipart	27
User-issued spam cancel	18
User-issued cancel	16
Scoring filter (8)	7
Scoring filter (10)	5
Binary: misplaced par2	4
Scoring filter (13)	4
Scoring filter (18)	2
Angle-bracket bot	1
Scoring filter (9)	1
Binary: misplaced bat	1
Scoring filter (15)	1
Scoring filter (17)	1
TOTAL: 22	3104

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	39	0	42	42
TOTAL: 1	39	28	42	42

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.news.xs4all.nl	1
	TOTAL: 1	1
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	news.freedyn.net	1001
	csiph-out.feeder.erje.net	173
	csiph-out.news.weretis.net	66
	csiph-out.feed.uzoreto.com	7
	csiph-out.news.xs4all.nl	6
	newsfeeds.xmission.com	3
	newsfeed.fu-berlin.de	2
	news-out.mixmin.net	2
	feeder.eternal-september.org	2
	news.fcku.it	1
	TOTAL: 10	1263
Including strange strings
	newsfeed.fu-berlin.de	388
	news-out.mixmin.net	11
	csiph-out.news.weretis.net	10
	news.swapon.de	7
	news-out.aioe.org	5
	newsfeed.neva.ru	4
	csiph-out.news.xs4all.nl	3
	csiph-out.feeder.erje.net	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 9	430
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 5		1740

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	xanadu-bbs	19131	545	16090	0	0	204	2%	23:59:54
2	news.freedyn.net	15242	526	14372	29	0	0	3%	23:50:04
3	news.samoylyk.net	17295	519	16035	7	0	0	3%	23:51:25
4	fu-berlin.de	15429	478	14951	0	0	0	3%	23:54:35
5	usenet.pasdenom.info	25406	377	15093	1138	1	1456	1%	23:59:54
6	news.bbs.nz	30621	242	15815	7	0	0	0%	23:52:08
7	erje	14791	177	12619	122	0	8	1%	23:55:26
8	newsfeed.xs4all.nl	16552	18	15725	4	0	34	0%	23:56:52
9	eternal-september	14357	12	13884	0	0	0	0%	23:59:54
10	aioe	14479	12	13923	0	0	0	0%	23:50:04
11	news.mixmin.net	15439	11	15035	0	0	0	0%	23:59:54
12	neva.ru	14682	11	14468	101	0	0	0%	23:59:54
13	weretis.net	13821	11	13022	0	0	0	0%	23:50:04
14	xmission	17709	10	15486	2	0	0	0%	23:59:34
15	news.swapon.de	1772	10	1699	0	0	0	0%	23:50:04
16	news.uzoreto.com	16227	9	15898	102	0	0	0%	23:50:17
17	news.fcku.it	1783	0	1774	0	0	0	0%	22:56:17
18	news.redatomik.org	0	0	0	0	0	16070	0%	23:50:04
TOTAL: 18		264736	2968	225889	1512	1	17772	1%	429:26:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.6 MB	0.0 KB	6.6 MB	0.1 KB/s	12.4 KB	23:59:54
2	news.freedyn.net	6.6 MB	45.2 KB	6.6 MB	0.1 KB/s	12.2 KB	23:50:04
3	news.samoylyk.net	6.5 MB	21.2 KB	6.5 MB	0.1 KB/s	12.6 KB	23:51:25
4	fu-berlin.de	6.4 MB	0.0 KB	6.4 MB	0.1 KB/s	13.7 KB	23:54:35
5	usenet.pasdenom.info	1.4 MB	7.9 MB	9.3 MB	0.1 KB/s	6.3 KB	23:59:54
6	news.bbs.nz	709.0 KB	20.4 KB	729.4 KB	0.0 KB/s	2.9 KB	23:52:08
7	erje	570.2 KB	653.2 KB	1.2 MB	0.0 KB/s	4.1 KB	23:55:26
8	newsfeed.xs4all.nl	41.7 KB	26.4 KB	68.1 KB	0.0 KB/s	3.1 KB	23:56:52
9	eternal-september	30.8 KB	0.0 KB	30.8 KB	0.0 KB/s	2.6 KB	23:59:54
10	aioe	21.5 KB	0.0 KB	21.5 KB	0.0 KB/s	1.8 KB	23:50:04
11	weretis.net	21.3 KB	0.0 KB	21.3 KB	0.0 KB/s	1.9 KB	23:50:04
12	neva.ru	20.8 KB	316.1 KB	336.9 KB	0.0 KB/s	3.0 KB	23:59:54
13	news.mixmin.net	20.5 KB	0.0 KB	20.5 KB	0.0 KB/s	1.9 KB	23:59:54
14	xmission	19.1 KB	8.9 KB	28.1 KB	0.0 KB/s	2.3 KB	23:59:34
15	news.swapon.de	19.1 KB	0.0 KB	19.1 KB	0.0 KB/s	1.9 KB	23:50:04
16	news.uzoreto.com	16.1 KB	290.7 KB	306.8 KB	0.0 KB/s	2.8 KB	23:50:17
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:56:17
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:04
TOTAL: 18		28.9 MB	9.2 MB	38.1 MB	0.0 KB/s	8.7 KB	429:26:24

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-185-188-189.dhcp.mdsn.wi.charter.com	40	13	23.9 KB	12	10	9	08:37:18
2	a131033.upc-a.chello.nl	76	11	16.8 KB	6	0	0	23:32:12
3	109.239.71.208	6	8	20.6 KB	2	0	0	01:03:35
4	challenger.nielsenmedia.com	5	3	6.0 KB	2	0	0	01:41:08
TOTAL: 4		127	35	67.3 KB	22	10	9	39:24:32

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.mdsn.wi.charter.com	40	13	23.9 KB	12	10	9	08:37:18
2	*.upc-a.chello.nl	76	11	16.8 KB	6	0	0	23:32:12
3	unresolved	8	8	20.6 KB	2	0	0	01:03:39
4	*.nielsenmedia.com	5	3	6.0 KB	2	0	0	01:41:08
5	*.ph.ph.cox.net	2	0	0.0 KB	0	0	0	02:00:16
6	*.dhcp.chtrptr.net	4	0	0.0 KB	0	0	0	02:29:56
TOTAL: 6		135	35	67.3 KB	22	10	9	39:24:32

NNRP auth users [Top 20]:

User	Conn
ohlandl	9
ctomczyk	6
TOTAL: 2	15

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	5.623	1.120	0.000	23:32:12
68-185-188-189.dhcp.mdsn.wi.charter.com	3.519	0.604	0.128	08:37:18
172-221-041-102.dhcp.chtrptr.net	1.205	3.703	0.000	02:29:56
ip72-222-200-117.ph.ph.cox.net	0.466	0.078	0.000	02:00:16
challenger.nielsenmedia.com	0.475	0.062	0.000	01:41:08
109.239.71.208	0.478	0.116	0.016	01:03:35
106.75.3.52	0.072	0.008	0.000	00:00:02
5.87.221.4	0.082	0.000	0.000	00:00:01
TOTAL: 8	11.920	5.691	0.144	39:24:32

Curious NNRP server explorers [Top 20]:

System	Conn
172-221-041-102.dhcp.chtrptr.net	4
ip72-222-200-117.ph.ph.cox.net	2
106.75.3.52	1
5.87.221.4	1
TOTAL: 4	8

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-185-188-189.dhcp.mdsn.wi.charter.com	5	0
ip72-222-200-117.ph.ph.cox.net	4	0
challenger.nielsenmedia.com	3	0
109.239.71.208	2	0
TOTAL: 4	14	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	24
2	comp.lang.javascript	8
3	comp.lang.awk	3
TOTAL: 3		35

Daily Usenet report for csiph.com

Jun 19 04:15:00 -- Jun 20 04:15:00