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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21682	49.2%	5.5 MB	65.1%
innd	18502	42.0%	2.3 MB	27.5%
innfeed	3301	7.5%	575.4 KB	6.7%
nnrpd	468	1.1%	53.5 KB	0.6%
nocem	80	0.2%	8.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	44034	100.0%	8.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	305636	56.8%
Negative hits	210764	39.2%
Do not exist	20983	3.9%
Cache misses	427	0.1%
TOTAL: 4	537810	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.817	0.0%	171	0.000	4.778	27.083
article cleanup	00:00:00.119	0.0%	20151	0.000	0.006	0.029
article logging	00:00:00.391	0.0%	20577	0.000	0.019	0.333
article parse	00:00:01.856	0.0%	88301	0.000	0.021	0.208
article write	00:00:25.078	0.0%	16392	0.162	1.530	69.590
artlog/artcncl	00:00:00.002	0.0%	130	0.000	0.015	0.500
artlog/artparse	00:00:00.017	0.0%	1011	0.000	0.017	0.250
data move	00:00:00.147	0.0%	529394	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.089	0.0%	167	0.000	0.533	8.800
hishave/artcncl	00:00:00.082	0.0%	171	0.000	0.480	7.400
hishave/artparse	00:00:00.002	0.0%	1011	0.000	0.002	0.111
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:12.445	0.0%	541037	0.002	0.023	0.585
history sync	00:00:01.019	0.0%	338	0.000	3.015	69.500
history write	00:00:16.803	0.0%	20149	0.317	0.834	19.337
hiswrite/artcncl	00:00:00.006	0.0%	4	0.000	1.500	2.000
hiswrite/artparse	00:00:01.035	0.0%	1008	0.000	1.027	10.000
idle	23:56:33.488	99.7%	537522	81.051	160.353	611.588
nntp read	00:00:02.386	0.0%	538775	0.001	0.004	0.060
overview write	00:01:52.959	0.1%	16392	0.125	6.891	705.374
perl filter	00:00:33.428	0.0%	20146	1.248	1.659	2.830
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.283	0.0%	32858	0.000	0.009	0.037
TOTAL: 24:00:35.339	24:00:02.452	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.040	0.0%	16541	0.000	0.002	0.017
article prepare	00:00:00.004	0.0%	14240	0.000	0.000	0.013
article read	00:00:00.583	0.0%	1260	0.000	0.463	15.455
backlog stats	00:00:00.208	0.0%	357543	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.362	0.0%	273581	0.001	0.005	0.011
data write	00:00:01.661	0.0%	260728	0.002	0.006	0.014
idle	23:53:41.406	100.0%	357543	144.484	240.590	822.186
status file	00:00:00.513	0.0%	254	0.000	2.020	9.697
TOTAL: 23:53:52.567	23:53:45.777	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	16:40:59.349	100.0%	355	167.000	169181.265	600073.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.001	0.0%	809	0.000	0.001	0.067
readart	00:00:00.289	0.0%	23	0.000	12.565	51.000
TOTAL: 16:41:18.690	16:40:59.639	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1440	78892	3238	75272	382	4%	118:50:52
2	feeder.eternal-september.org	3	19189	2184	16892	113	11%	26:55:57
3	csiph-out.news.weretis.net	4	33641	1714	31783	144	5%	49:19:48
4	news.freedyn.net	3	20448	1599	17601	1248	7%	24:09:02
5	news-out.aioe.org	3	16052	1586	14453	13	9%	24:08:10
6	csiph-out.news.xs4all.nl	864	18832	1490	16149	1193	7%	71:13:08
7	newsfeeds.xmission.com	2	15114	1288	13824	2	8%	22:37:13
8	news-out.mixmin.net	1	17043	1092	15636	315	6%	23:59:42
9	newsfeed.neva.ru	146	19979	921	18223	835	4%	71:27:59
10	newsfeed.fu-berlin.de	14	18691	906	17627	158	4%	32:16:50
11	csiph-out.feed.uzoreto.com	864	26555	337	25841	377	1%	71:16:12
12	news.fcku.it	7	2150	279	1868	3	12%	23:02:02
13	nntp.pasdenom.info	2	11747	44	11693	10	0%	23:59:51
14	news.swapon.de	8	1388	34	1348	6	2%	23:15:08
15	news.samoylyk.net	2	16161	12	16124	25	0%	24:54:34
16	localhost	39	6	6	0	0	100%	00:00:05
17	news.bbs.nz	1	16384	2	16382	0	0%	23:59:53
18	xanadu-bbs.net	19	569	0	569	0	0%	24:05:20
TOTAL: 18		3422	332841	16732	311285	4824	5%	679:31:46

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	13.7 MB	0.0 KB	9.7 MB	23.4 MB	58%	6.6 KB
2	feeder.eternal-september.org	5.8 MB	0.0 KB	1.0 MB	6.8 MB	85%	3.0 KB
3	csiph-out.news.weretis.net	5.5 MB	0.0 KB	3.8 MB	9.3 MB	59%	5.1 KB
4	csiph-out.news.xs4all.nl	4.7 MB	0.0 KB	11.2 MB	15.9 MB	29%	6.1 KB
5	news.freedyn.net	4.7 MB	0.0 KB	66.5 MB	71.1 MB	6%	25.6 KB
6	newsfeeds.xmission.com	4.0 MB	0.0 KB	109.2 KB	4.1 MB	97%	3.3 KB
7	news-out.aioe.org	3.9 MB	0.0 KB	27.2 KB	3.9 MB	99%	2.5 KB
8	news-out.mixmin.net	3.1 MB	0.0 KB	638.1 KB	3.8 MB	83%	2.7 KB
9	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	618.9 KB	2.9 MB	79%	2.8 KB
10	newsfeed.neva.ru	2.0 MB	39.8 KB	2.7 MB	4.7 MB	43%	2.8 KB
11	csiph-out.feed.uzoreto.com	1.2 MB	0.0 KB	7.9 MB	9.2 MB	13%	13.2 KB
12	news.fcku.it	488.2 KB	0.0 KB	2.9 KB	491.0 KB	99%	1.7 KB
13	nntp.pasdenom.info	102.3 KB	0.0 KB	20.4 KB	122.7 KB	83%	2.3 KB
14	news.swapon.de	83.6 KB	0.0 KB	3.5 MB	3.6 MB	2%	91.1 KB
15	news.samoylyk.net	41.3 KB	0.0 KB	2.3 MB	2.4 MB	1%	65.1 KB
16	localhost	10.7 KB	0.0 KB	0.0 KB	10.7 KB	100%	1.8 KB
17	news.bbs.nz	2.2 KB	0.0 KB	0.0 KB	2.2 KB	100%	1.1 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		51.7 MB	39.8 KB	109.9 MB	161.6 MB	31%	7.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 3 04:15:00 - 04:59:59	298	1.8%	0.11	1.1 MB	2.2%	0.43
Sep 3 05:00:00 - 05:59:59	471	2.9%	0.13	1.9 MB	3.8%	0.55
Sep 3 06:00:00 - 06:59:59	563	3.4%	0.16	1.8 MB	3.6%	0.52
Sep 3 07:00:00 - 07:59:59	647	3.9%	0.18	2.2 MB	4.3%	0.62
Sep 3 08:00:00 - 08:59:59	741	4.5%	0.21	2.3 MB	4.6%	0.66
Sep 3 09:00:00 - 09:59:59	830	5.1%	0.23	2.3 MB	4.6%	0.66
Sep 3 10:00:00 - 10:59:59	729	4.5%	0.20	2.3 MB	4.6%	0.66
Sep 3 11:00:00 - 11:59:59	790	4.8%	0.22	2.5 MB	4.9%	0.70
Sep 3 12:00:00 - 12:59:59	841	5.1%	0.23	2.4 MB	4.7%	0.68
Sep 3 13:00:00 - 13:59:59	837	5.1%	0.23	2.2 MB	4.4%	0.63
Sep 3 14:00:00 - 14:59:59	832	5.1%	0.23	2.5 MB	5.0%	0.72
Sep 3 15:00:00 - 15:59:59	887	5.4%	0.25	2.6 MB	5.1%	0.73
Sep 3 16:00:00 - 16:59:59	983	6.0%	0.27	2.7 MB	5.3%	0.77
Sep 3 17:00:00 - 17:59:59	828	5.1%	0.23	2.5 MB	4.9%	0.71
Sep 3 18:00:00 - 18:59:59	894	5.5%	0.25	2.9 MB	5.8%	0.83
Sep 3 19:00:00 - 19:59:59	922	5.6%	0.26	2.8 MB	5.4%	0.78
Sep 3 20:00:00 - 20:59:59	828	5.1%	0.23	2.5 MB	4.9%	0.70
Sep 3 21:00:00 - 21:59:59	679	4.1%	0.19	2.0 MB	3.9%	0.57
Sep 3 22:00:00 - 22:59:59	662	4.0%	0.18	2.3 MB	4.6%	0.66
Sep 3 23:00:00 - 23:59:59	539	3.3%	0.15	1.5 MB	2.9%	0.42
Sep 4 00:00:00 - 00:59:59	402	2.5%	0.11	1.2 MB	2.3%	0.33
Sep 4 01:00:00 - 01:59:59	436	2.7%	0.12	1.3 MB	2.6%	0.37
Sep 4 02:00:00 - 02:59:59	357	2.2%	0.10	1.5 MB	2.9%	0.42
Sep 4 03:00:00 - 03:59:59	299	1.8%	0.08	1.1 MB	2.2%	0.31
Sep 4 04:00:00 - 04:15:00	87	0.5%	0.10	250.1 KB	0.5%	0.28
TOTAL: 24:00:00	16382	100.0%	0.19	50.6 MB	100.0%	0.60

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.freedyn.net	1231	42	0	1189
2	csiph-out.news.xs4all.nl	1193	36	0	1157
3	newsfeed.neva.ru	836	198	2	636
4	newsfeed.fu-berlin.de	486	20	0	466
5	csiph-out.feeder.erje.net	395	83	0	312
6	csiph-out.feed.uzoreto.com	379	12	0	367
7	news-out.mixmin.net	314	0	0	314
8	csiph-out.news.weretis.net	163	68	0	95
9	feeder.eternal-september.org	103	32	0	71
10	news.samoylyk.net	25	0	0	25
11	news-out.aioe.org	17	11	0	6
12	news.swapon.de	10	0	0	10
13	nntp.pasdenom.info	10	0	0	10
14	newsfeeds.xmission.com	5	0	0	5
15	news.fcku.it	4	3	0	1
TOTAL: 15		5171	505	2	4664

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	190
alt.bbs.synchronet	63
it-alt.sport.calcio.juventus	31
alt.survival	24
mozilla.support.seamonkey	19
mozilla.support.thunderbird	16
alt.windows7.general	16
alt.binaries.pictures.purebeauty	15
oesterreich.tratsch	7
mozilla.dev.ports.os2	7
spline.eisfair	7
alt.binaries.ebook	6
mozilla.support.firefox	5
mozilla.dev.security.policy	4
alt.forsale.seattle	4
alt.politics.usa	4
maine.forsale	3
at.jobs	3
eagle.support.eng	3
alt.christian.bible	3
TOTAL: 74	505

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2729
EMP (phn path)	170
EMP (phn nph)	106
EMP (phl)	99
Too many newsgroups	43
Binary Payload	15
Binary: misplaced rar	15
User-issued cancel	13
Scoring filter (9)	13
HTML Multipart	8
User-issued spam cancel	7
Binary: misplaced par2	5
Scoring filter (8)	3
Too many newsgroups (meow)	2
Too many newsgroups (low_xpost)	2
Binary: misplaced com	1
Scoring filter (10)	1
HTML Image Tags	1
TOTAL: 18	3233

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	54	0	57	57
TOTAL: 1	54	20	57	57

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.news.xs4all.nl	1
	csiph-out.feeder.erje.net	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	3
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	news.freedyn.net	544
	csiph-out.feeder.erje.net	168
	csiph-out.news.xs4all.nl	115
	csiph-out.feed.uzoreto.com	85
	csiph-out.news.weretis.net	49
	news.samoylyk.net	25
	feeder.eternal-september.org	6
	news.swapon.de	5
	newsfeeds.xmission.com	4
	newsfeed.fu-berlin.de	2
	TOTAL: 11	1004
Including strange strings
	newsfeed.fu-berlin.de	351
	csiph-out.news.weretis.net	20
	csiph-out.feeder.erje.net	17
	csiph-out.news.xs4all.nl	12
	news-out.mixmin.net	10
	news-out.aioe.org	5
	news.swapon.de	4
	csiph-out.feed.uzoreto.com	2
	newsfeeds.xmission.com	1
	news.fcku.it	1
	TOTAL: 11	424
TOTAL: 4		1476

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	20069	966	15483	0	54	4%	23:58:43
2	news.freedyn.net	15020	447	14208	40	0	2%	23:59:48
3	news.samoylyk.net	17120	434	15935	1	0	2%	23:59:49
4	fu-berlin.de	15420	395	15025	0	0	2%	23:59:45
5	news.bbs.nz	30964	274	15674	2	0	0%	23:59:55
6	usenet.pasdenom.info	17120	133	15764	438	0	0%	23:59:55
7	newsfeed.xs4all.nl	15473	43	14456	9	65	0%	23:59:55
8	erje	15618	33	12932	70	7	0%	23:59:55
9	aioe	14406	30	13693	1	0	0%	23:59:46
10	neva.ru	15147	18	14665	153	0	0%	23:59:55
11	news.uzoreto.com	15884	10	15559	27	0	0%	23:59:55
12	eternal-september	14238	8	13746	0	0	0%	23:59:51
13	news.mixmin.net	15242	7	14784	0	0	0%	23:59:55
14	xmission	17900	7	14653	1	0	0%	23:59:48
15	weretis.net	15389	7	14260	0	0	0%	23:59:55
16	news.swapon.de	1525	6	1494	0	0	0%	23:45:09
17	news.fcku.it	1703	0	1690	0	0	0%	22:53:27
18	news.redatomik.org	0	0	0	0	15952	0%	23:59:55
TOTAL: 18		258238	2818	224021	742	16078	1%	430:35:21

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.0 MB	0.0 KB	7.0 MB	0.1 KB/s	7.4 KB	23:58:43
2	news.freedyn.net	5.2 MB	91.3 KB	5.3 MB	0.1 KB/s	11.1 KB	23:59:48
3	news.samoylyk.net	5.2 MB	3.3 KB	5.2 MB	0.1 KB/s	12.2 KB	23:59:49
4	fu-berlin.de	5.1 MB	0.0 KB	5.1 MB	0.1 KB/s	13.2 KB	23:59:45
5	news.bbs.nz	761.7 KB	5.7 KB	767.3 KB	0.0 KB/s	2.8 KB	23:59:55
6	usenet.pasdenom.info	297.9 KB	5.2 MB	5.5 MB	0.1 KB/s	9.9 KB	23:59:55
7	newsfeed.xs4all.nl	190.4 KB	40.0 KB	230.4 KB	0.0 KB/s	4.4 KB	23:59:55
8	erje	82.9 KB	260.9 KB	343.7 KB	0.0 KB/s	3.3 KB	23:59:55
9	aioe	75.0 KB	1.5 KB	76.5 KB	0.0 KB/s	2.5 KB	23:59:46
10	neva.ru	40.4 KB	406.9 KB	447.3 KB	0.0 KB/s	2.6 KB	23:59:55
11	news.uzoreto.com	20.2 KB	111.3 KB	131.5 KB	0.0 KB/s	3.6 KB	23:59:55
12	eternal-september	13.6 KB	0.0 KB	13.6 KB	0.0 KB/s	1.7 KB	23:59:51
13	news.mixmin.net	12.0 KB	0.0 KB	12.0 KB	0.0 KB/s	1.7 KB	23:59:55
14	xmission	12.0 KB	1.2 KB	13.3 KB	0.0 KB/s	1.7 KB	23:59:48
15	weretis.net	12.0 KB	0.0 KB	12.0 KB	0.0 KB/s	1.7 KB	23:59:55
16	news.swapon.de	10.7 KB	0.0 KB	10.7 KB	0.0 KB/s	1.8 KB	23:45:09
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:53:27
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:55
TOTAL: 18		23.9 MB	6.1 MB	30.1 MB	0.0 KB/s	8.6 KB	430:35:21

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-190-164-204.dhcp.eucl.wi.charter.com	16	10	20.0 KB	9	6	6	04:54:00
2	a131033.upc-a.chello.nl	32	9	18.7 KB	5	0	0	09:05:07
3	208-71-239-109.cust.centrio.cz	4	4	14.2 KB	1	0	0	01:41:42
TOTAL: 3		52	23	52.9 KB	15	6	6	16:41:17

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.eucl.wi.charter.com	16	10	20.0 KB	9	6	6	04:54:00
2	*.upc-a.chello.nl	32	9	18.7 KB	5	0	0	09:05:07
3	*.cust.centrio.cz	4	4	14.2 KB	1	0	0	01:41:42
4	unresolved	16	0	0.0 KB	0	0	0	00:00:19
5	*.ph.ph.cox.net	2	0	0.0 KB	0	0	0	01:00:06
TOTAL: 5		70	23	52.9 KB	15	6	6	16:41:17

NNRP auth users [Top 20]:

User	Conn
ohlandl	6
ctomczyk	4
TOTAL: 2	10

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.434	0.465	0.000	09:05:07
68-190-164-204.dhcp.eucl.wi.charter.com	1.381	0.290	0.017	04:54:00
208-71-239-109.cust.centrio.cz	0.291	0.086	0.009	01:41:42
ip72-222-200-117.ph.ph.cox.net	0.219	0.047	0.000	01:00:06
94.163.246.99	0.375	0.096	0.000	00:00:06
5.87.221.55	0.217	0.025	0.000	00:00:03
106.75.106.221	0.072	0.008	0.000	00:00:02
94.161.106.213	0.128	0.025	0.000	00:00:02
5.86.31.99	0.064	0.016	0.000	00:00:01
94.165.150.139	0.061	0.017	0.000	00:00:01
94.162.180.31	0.061	0.017	0.000	00:00:01
5.87.226.113	0.072	0.008	0.000	00:00:01
TOTAL: 12	5.375	1.100	0.026	16:41:17

Curious NNRP server explorers [Top 20]:

System	Conn
94.163.246.99	6
5.87.221.55	3
94.161.106.213	2
ip72-222-200-117.ph.ph.cox.net	2
106.75.106.221	1
94.162.180.31	1
94.165.150.139	1
5.86.31.99	1
5.87.226.113	1
TOTAL: 9	18

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-204.dhcp.eucl.wi.charter.com	4	0
208-71-239-109.cust.centrio.cz	3	0
ip72-222-200-117.ph.ph.cox.net	2	0
TOTAL: 3	9	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	19
2	comp.lang.javascript	4
TOTAL: 2		23

Daily Usenet report for csiph.com

Sep 3 04:15:00 -- Sep 4 04:15:00