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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20363	48.8%	5.2 MB	65.0%
innd	17610	42.2%	2.2 MB	27.5%
innfeed	3336	8.0%	571.8 KB	6.9%
nnrpd	366	0.9%	40.5 KB	0.5%
nocem	58	0.1%	6.2 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	41734	100.0%	8.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	295490	57.6%
Negative hits	197472	38.5%
Do not exist	19725	3.8%
Cache misses	346	0.1%
TOTAL: 4	513033	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.629	0.0%	133	0.000	4.729	23.667
article cleanup	00:00:00.111	0.0%	18904	0.000	0.006	0.107
article logging	00:00:00.395	0.0%	19349	0.000	0.020	0.370
article parse	00:00:03.102	0.0%	78472	0.000	0.040	0.276
article write	00:00:33.852	0.0%	16019	0.145	2.113	33.107
artlog/artcncl	00:00:00.001	0.0%	111	0.000	0.009	0.333
artlog/artparse	00:00:00.009	0.0%	908	0.000	0.010	0.167
data move	00:00:00.133	0.0%	501246	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.077	0.0%	133	0.000	0.579	5.333
hishave/artcncl	00:00:00.029	0.0%	133	0.000	0.218	2.667
hishave/artparse	00:00:00.003	0.0%	906	0.000	0.003	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:40.162	0.0%	514467	0.001	0.078	0.494
history sync	00:00:01.089	0.0%	360	0.000	3.025	19.000
history write	00:00:46.135	0.1%	18906	0.048	2.440	14.838
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:02.360	0.0%	906	0.000	2.605	18.000
idle	23:56:23.877	99.7%	501486	96.461	171.857	515.621
nntp read	00:00:02.260	0.0%	506310	0.001	0.004	0.047
overview write	00:01:15.182	0.1%	16019	0.141	4.693	224.864
perl filter	00:00:32.432	0.0%	18904	1.242	1.716	3.379
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.263	0.0%	32090	0.000	0.008	0.030
TOTAL: 24:00:53.662	24:00:22.101	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.041	0.0%	17282	0.000	0.002	0.016
article prepare	00:00:00.000	0.0%	13832	0.000	0.000	0.000
article read	00:00:00.256	0.0%	1005	0.000	0.255	48.000
backlog stats	00:00:00.177	0.0%	350963	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.352	0.0%	269329	0.001	0.005	0.013
data write	00:00:01.643	0.0%	256508	0.002	0.006	0.012
idle	23:54:15.926	100.0%	350963	75.651	245.199	730.180
status file	00:00:00.274	0.0%	274	0.000	1.000	6.500
TOTAL: 23:54:28.203	23:54:19.669	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	14:04:37.845	99.9%	301	0.000	168364.934	600070.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.004	0.0%	659	0.000	0.006	0.111
readart	00:00:00.185	0.0%	6	0.000	30.833	46.000
TOTAL: 14:05:04.956	14:04:38.034	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	32054	3601	28238	215	11%	47:53:59
2	feeder.eternal-september.org	3	17501	1987	15423	91	11%	24:31:18
3	newsfeeds.xmission.com	2	15779	1925	13849	5	12%	25:31:01
4	news-out.aioe.org	1	15447	1416	13992	39	9%	23:59:57
5	csiph-out.feeder.erje.net	1441	77334	1296	75680	358	1%	118:43:42
6	news-out.mixmin.net	3	16493	1165	15089	239	7%	24:08:48
7	news.freedyn.net	3	18833	1156	16554	1123	6%	24:08:59
8	newsfeed.fu-berlin.de	12	14742	989	13510	243	6%	24:12:41
9	newsfeed.neva.ru	143	18765	989	17260	516	5%	72:23:17
10	csiph-out.news.xs4all.nl	861	17569	891	16157	521	5%	71:27:03
11	csiph-out.feed.uzoreto.com	864	24815	234	24184	397	0%	71:21:13
12	news.fcku.it	14	1663	195	1458	10	11%	22:52:21
13	news.swapon.de	2	1593	37	1554	2	2%	24:09:17
14	nntp.pasdenom.info	10	10922	15	10897	10	0%	23:35:53
15	news.samoylyk.net	2	15218	13	15205	0	0%	23:59:39
16	news.bbs.nz	2	15885	3	15882	0	0%	23:59:50
17	localhost	33	0	0	0	0	0%	00:00:01
18	xanadu-bbs.net	12	632	0	632	0	0%	22:55:58
TOTAL: 18		3412	315245	15912	295564	3769	5%	669:54:57

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	11.5 MB	5.8 MB	17.3 MB	66%	4.6 KB
2	csiph-out.feeder.erje.net	9.7 MB	12.0 MB	21.7 MB	44%	13.4 KB
3	feeder.eternal-september.org	5.7 MB	428.6 KB	6.1 MB	93%	3.0 KB
4	newsfeeds.xmission.com	5.3 MB	234.9 KB	5.5 MB	95%	2.9 KB
5	news-out.mixmin.net	3.3 MB	659.9 KB	3.9 MB	83%	2.9 KB
6	news-out.aioe.org	3.2 MB	68.0 KB	3.3 MB	97%	2.3 KB
7	news.freedyn.net	3.2 MB	52.9 MB	56.0 MB	5%	25.2 KB
8	newsfeed.neva.ru	2.5 MB	1.6 MB	4.1 MB	61%	2.8 KB
9	newsfeed.fu-berlin.de	2.4 MB	642.9 KB	3.1 MB	79%	2.5 KB
10	csiph-out.news.xs4all.nl	2.1 MB	6.2 MB	8.3 MB	25%	6.1 KB
11	csiph-out.feed.uzoreto.com	771.3 KB	11.3 MB	12.0 MB	6%	19.5 KB
12	news.fcku.it	344.5 KB	13.2 KB	357.7 KB	96%	1.7 KB
13	news.swapon.de	99.9 KB	950.3 KB	1.0 MB	9%	26.9 KB
14	news.samoylyk.net	40.0 KB	0.0 KB	40.0 KB	100%	3.1 KB
15	nntp.pasdenom.info	38.4 KB	16.6 KB	55.0 KB	69%	2.2 KB
16	news.bbs.nz	4.1 KB	0.0 KB	4.1 KB	100%	1.4 KB
17	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		50.2 MB	92.7 MB	142.9 MB	35%	7.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 7 04:15:00 - 04:59:59	248	1.5%	0.09	827.5 KB	1.6%	0.31
Aug 7 05:00:00 - 05:59:59	411	2.6%	0.11	1.4 MB	2.8%	0.40
Aug 7 06:00:00 - 06:59:59	583	3.6%	0.16	2.4 MB	4.7%	0.68
Aug 7 07:00:00 - 07:59:59	629	3.9%	0.17	1.9 MB	3.7%	0.53
Aug 7 08:00:00 - 08:59:59	757	4.7%	0.21	3.0 MB	6.0%	0.86
Aug 7 09:00:00 - 09:59:59	690	4.3%	0.19	1.8 MB	3.5%	0.51
Aug 7 10:00:00 - 10:59:59	726	4.5%	0.20	2.2 MB	4.4%	0.63
Aug 7 11:00:00 - 11:59:59	731	4.6%	0.20	2.1 MB	4.1%	0.59
Aug 7 12:00:00 - 12:59:59	706	4.4%	0.20	1.9 MB	3.8%	0.55
Aug 7 13:00:00 - 13:59:59	743	4.6%	0.21	1.9 MB	3.9%	0.55
Aug 7 14:00:00 - 14:59:59	933	5.8%	0.26	3.4 MB	6.7%	0.96
Aug 7 15:00:00 - 15:59:59	1038	6.5%	0.29	3.0 MB	6.0%	0.87
Aug 7 16:00:00 - 16:59:59	892	5.6%	0.25	2.6 MB	5.2%	0.75
Aug 7 17:00:00 - 17:59:59	957	6.0%	0.27	3.3 MB	6.6%	0.95
Aug 7 18:00:00 - 18:59:59	792	4.9%	0.22	2.5 MB	5.0%	0.72
Aug 7 19:00:00 - 19:59:59	811	5.1%	0.23	2.2 MB	4.3%	0.62
Aug 7 20:00:00 - 20:59:59	833	5.2%	0.23	2.5 MB	5.0%	0.71
Aug 7 21:00:00 - 21:59:59	718	4.5%	0.20	2.1 MB	4.2%	0.61
Aug 7 22:00:00 - 22:59:59	625	3.9%	0.17	2.4 MB	4.7%	0.67
Aug 7 23:00:00 - 23:59:59	474	3.0%	0.13	1.3 MB	2.6%	0.37
Aug 8 00:00:00 - 00:59:59	462	2.9%	0.13	1.5 MB	2.9%	0.42
Aug 8 01:00:00 - 01:59:59	371	2.3%	0.10	1.2 MB	2.3%	0.33
Aug 8 02:00:00 - 02:59:59	395	2.5%	0.11	1.6 MB	3.1%	0.44
Aug 8 03:00:00 - 03:59:59	406	2.5%	0.11	1.2 MB	2.3%	0.33
Aug 8 04:00:00 - 04:15:00	85	0.5%	0.09	272.6 KB	0.5%	0.30
TOTAL: 24:00:00	16016	100.0%	0.19	50.5 MB	100.0%	0.60

Sites sending bad articles:

Server		Total	Group	Other
1	news.freedyn.net	1119	9	1110
2	newsfeed.fu-berlin.de	656	40	616
3	csiph-out.news.xs4all.nl	529	25	504
4	newsfeed.neva.ru	520	87	433
5	csiph-out.feed.uzoreto.com	402	25	377
6	csiph-out.feeder.erje.net	359	52	307
7	news-out.mixmin.net	243	6	237
8	csiph-out.news.weretis.net	234	111	123
9	feeder.eternal-september.org	103	33	70
10	news-out.aioe.org	40	35	5
11	news.fcku.it	10	10	0
12	nntp.pasdenom.info	10	0	10
13	news.swapon.de	6	0	6
14	newsfeeds.xmission.com	5	1	4
15	news.samoylyk.net	1	0	1
TOTAL: 15		4237	434	3803

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it-alt.sport.calcio.juventus	62
alt.computer.workshop	56
lada.talk	34
lada.auto	21
mozilla.support.seamonkey	19
alt.binaries.pictures.purebeauty	14
mozilla.support.firefox	13
alt.windows7.general	13
mozilla.general	12
oesterreich.tratsch	11
spline.eisfair	11
lada.photo	10
alt.bbs.synchronet	10
alt.politics.usa	9
lada.commerce	6
zz.unity.chat	5
mozilla.dev.platform	5
mozilla.test	5
alt.philosophy	4
alt.english.usage	4
TOTAL: 88	434

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1897
EMP (phn path)	252
EMP (phn nph)	99
Too many newsgroups	67
EMP (phl)	56
User-issued cancel	20
HTML Multipart	16
Binary: misplaced rar	11
Binary Payload	8
Scoring filter (10)	7
User-issued spam cancel	5
Scoring filter (8)	4
Scoring filter (13)	2
Scoring filter (9)	2
Binary: misplaced bin	1
Too many newsgroups (meow)	1
TOTAL: 16	2448

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	32	0	34	34
TOTAL: 1	32	20	34	34

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	news.freedyn.net	420
	csiph-out.feeder.erje.net	217
	csiph-out.feed.uzoreto.com	133
	csiph-out.news.xs4all.nl	66
	csiph-out.news.weretis.net	58
	news-out.mixmin.net	4
	newsfeeds.xmission.com	4
	feeder.eternal-september.org	3
	news.swapon.de	2
	newsfeed.fu-berlin.de	1
	TOTAL: 10	908
Including strange strings
	newsfeed.fu-berlin.de	401
	csiph-out.news.weretis.net	18
	news-out.mixmin.net	8
	news-out.aioe.org	5
	news.swapon.de	4
	csiph-out.feed.uzoreto.com	3
	csiph-out.feeder.erje.net	2
	csiph-out.news.xs4all.nl	2
	news.samoylyk.net	1
	newsfeed.neva.ru	1
	TOTAL: 10	445
No colon-space in header
	csiph-out.news.xs4all.nl	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 2	2
TOTAL: 4		1400

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18558	568	15448	0	486	3%	23:59:54
2	news.samoylyk.net	16680	540	15445	1	0	3%	23:57:31
3	news.freedyn.net	15094	538	14265	9	0	3%	23:59:40
4	fu-berlin.de	14857	532	14325	0	0	3%	23:59:53
5	news.bbs.nz	30102	205	15200	6	0	0%	23:50:14
6	usenet.pasdenom.info	54685	190	15206	605	771	0%	23:59:53
7	aioe	13717	32	13282	0	0	0%	23:59:42
8	newsfeed.xs4all.nl	15738	22	14928	7	51	0%	23:56:37
9	news.uzoreto.com	15513	5	15284	44	0	0%	23:50:14
10	neva.ru	14381	4	14186	130	0	0%	23:59:53
11	news.swapon.de	1712	2	1689	0	0	0%	23:49:35
12	xmission	17305	1	13510	0	0	0%	23:59:47
13	eternal-september	13759	1	13367	0	0	0%	23:59:51
14	news.mixmin.net	14453	1	14104	0	0	0%	23:59:53
15	news.redatomik.org	0	0	0	0	15413	0%	23:50:15
16	erje	14792	0	14625	2	0	0%	23:59:45
17	weretis.net	11782	0	11664	0	0	0%	23:57:20
18	news.fcku.it	1353	0	1347	0	0	0%	22:35:52
TOTAL: 18		284481	2641	217875	804	16721	0%	429:45:49

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.3 MB	0.0 KB	7.3 MB	0.1 KB/s	13.2 KB	23:59:54
2	news.freedyn.net	7.2 MB	11.5 KB	7.2 MB	0.1 KB/s	13.6 KB	23:59:40
3	news.samoylyk.net	7.2 MB	1.0 KB	7.2 MB	0.1 KB/s	13.7 KB	23:57:31
4	fu-berlin.de	7.2 MB	0.0 KB	7.2 MB	0.1 KB/s	13.9 KB	23:59:53
5	news.bbs.nz	482.9 KB	23.0 KB	505.9 KB	0.0 KB/s	2.4 KB	23:50:14
6	usenet.pasdenom.info	453.1 KB	7.4 MB	7.8 MB	0.1 KB/s	10.1 KB	23:59:53
7	newsfeed.xs4all.nl	162.9 KB	33.2 KB	196.1 KB	0.0 KB/s	6.8 KB	23:56:37
8	aioe	70.8 KB	0.0 KB	70.8 KB	0.0 KB/s	2.2 KB	23:59:42
9	neva.ru	9.0 KB	296.7 KB	305.7 KB	0.0 KB/s	2.3 KB	23:59:53
10	news.uzoreto.com	8.6 KB	169.2 KB	177.8 KB	0.0 KB/s	3.6 KB	23:50:14
11	news.swapon.de	8.2 KB	0.0 KB	8.2 KB	0.0 KB/s	4.1 KB	23:49:35
12	eternal-september	2.4 KB	0.0 KB	2.4 KB	0.0 KB/s	2.4 KB	23:59:51
13	xmission	2.1 KB	0.0 KB	2.1 KB	0.0 KB/s	2.1 KB	23:59:47
14	news.mixmin.net	1.0 KB	0.0 KB	1.0 KB	0.0 KB/s	1.0 KB	23:59:53
15	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:15
16	erje	0.0 KB	5.3 KB	5.3 KB	0.0 KB/s	2.6 KB	23:59:45
17	weretis.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:20
18	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:35:52
TOTAL: 18		30.1 MB	7.9 MB	38.1 MB	0.0 KB/s	11.3 KB	429:45:49

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	208-71-239-109.cust.centrio.cz	9	5	27.2 KB	4	02:25:45
2	a131033.upc-a.chello.nl	36	1	1.8 KB	1	07:12:30
TOTAL: 2		45	6	29.1 KB	5	14:05:04

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.cust.centrio.cz	9	5	27.2 KB	4	02:25:45
2	*.upc-a.chello.nl	36	1	1.8 KB	1	07:12:30
3	*.ph.ph.cox.net	2	0	0.0 KB	0	02:00:18
4	unresolved	6	0	0.0 KB	0	01:56:27
5	*.nielsenmedia.com	1	0	0.0 KB	0	00:30:02
6	*.us-west-1.compute.amazonaws.com	1	0	0.0 KB	0	00:00:00
TOTAL: 6		55	6	29.1 KB	5	14:05:04

NNRP auth users [Top 20]:

User	Conn
ctomczyk	8
TOTAL: 1	8

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.445	0.420	0.000	07:12:30
208-71-239-109.cust.centrio.cz	0.912	0.078	0.018	02:25:45
ip72-222-200-117.ph.ph.cox.net	0.445	0.090	0.000	02:00:18
24.178.44.104	0.391	0.100	0.000	01:56:27
challenger.nielsenmedia.com	0.069	0.008	0.000	00:30:02
ec2-13-57-222-46.us-west-1.compute.amazonaws.com	0.076	0.000	0.000	00:00:00
TOTAL: 6	4.338	0.696	0.018	14:05:04

Curious NNRP server explorers [Top 20]:

System	Conn
24.178.44.104	6
ip72-222-200-117.ph.ph.cox.net	2
challenger.nielsenmedia.com	1
ec2-13-57-222-46.us-west-1.compute.amazonaws.com	1
TOTAL: 4	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	4	0
208-71-239-109.cust.centrio.cz	4	1
24.178.44.104	3	0
challenger.nielsenmedia.com	1	0
TOTAL: 4	12	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.lang.javascript	5
2	comp.sys.ibm.ps2.hardware	1
TOTAL: 2		6

Daily Usenet report for csiph.com

Aug 7 04:15:00 -- Aug 8 04:15:00