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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19749	47.5%	5.1 MB	63.8%
innd	17943	43.2%	2.2 MB	28.3%
innfeed	3409	8.2%	599.6 KB	7.4%
nnrpd	426	1.0%	45.8 KB	0.6%
nocem	36	0.1%	3.3 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	41564	100.0%	7.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	286562	57.7%
Negative hits	190115	38.3%
Do not exist	19175	3.9%
Cache misses	665	0.1%
TOTAL: 4	496517	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.471	0.0%	87	0.000	5.414	22.778
article cleanup	00:00:00.134	0.0%	18448	0.000	0.007	0.041
article logging	00:00:00.383	0.0%	18804	0.000	0.020	0.276
article parse	00:00:02.948	0.0%	74972	0.000	0.039	0.796
article write	00:00:22.788	0.0%	15455	0.103	1.474	48.083
artlog/artcncl	00:00:00.000	0.0%	59	0.000	0.000	0.000
artlog/artparse	00:00:00.007	0.0%	908	0.000	0.008	0.200
data move	00:00:00.162	0.0%	479220	0.000	0.000	0.018
hisgrep/artcncl	00:00:00.015	0.0%	86	0.000	0.174	1.000
hishave/artcncl	00:00:00.068	0.0%	87	0.000	0.782	7.000
hishave/artparse	00:00:00.003	0.0%	907	0.000	0.003	0.100
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:18.284	0.0%	499650	0.001	0.037	0.396
history sync	00:00:00.729	0.0%	373	0.000	1.954	13.000
history write	00:00:26.920	0.0%	18447	0.216	1.459	16.077
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:02.254	0.0%	907	0.000	2.485	39.300
idle	23:55:15.767	99.6%	485882	100.414	177.236	607.773
nntp read	00:00:02.065	0.0%	487546	0.001	0.004	0.011
overview write	00:03:21.638	0.2%	15455	0.173	13.047	835.928
perl filter	00:00:30.345	0.0%	18445	1.233	1.645	4.155
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.251	0.0%	30942	0.000	0.008	0.030
TOTAL: 24:00:59.587	24:00:25.232	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.049	0.0%	17506	0.000	0.003	0.051
article prepare	00:00:00.001	0.0%	17044	0.000	0.000	0.007
article read	00:00:04.004	0.0%	1648	0.000	2.430	150.167
backlog stats	00:00:00.201	0.0%	338403	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.305	0.0%	259049	0.001	0.005	0.010
data write	00:00:01.569	0.0%	243862	0.001	0.006	0.025
idle	23:54:34.626	100.0%	338403	141.409	254.355	830.593
status file	00:00:00.659	0.0%	308	0.000	2.140	11.400
TOTAL: 23:54:49.863	23:54:42.414	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	16:00:41.219	100.0%	328	2414.667	175735.424	600076.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.007	0.0%	743	0.000	0.009	0.167
readart	00:00:00.308	0.0%	18	0.000	17.111	62.000
TOTAL: 16:00:56.025	16:00:41.534	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	31260	3185	27880	195	10%	49:15:59
2	feeder.eternal-september.org	2	17506	2080	15338	88	11%	25:16:59
3	csiph-out.news.xs4all.nl	864	17200	1682	14215	1303	9%	71:12:45
4	csiph-out.feeder.erje.net	1440	74004	1503	72090	411	2%	118:42:18
5	news-out.aioe.org	2	15316	1417	13870	29	9%	24:09:58
6	newsfeeds.xmission.com	2	16092	1296	14788	8	8%	25:36:45
7	news-out.mixmin.net	3	15967	1102	14704	161	6%	24:08:56
8	news.freedyn.net	3	18648	1012	16676	960	5%	21:49:58
9	newsfeed.neva.ru	148	22286	931	21007	348	4%	71:06:01
10	newsfeed.fu-berlin.de	15	14402	809	13477	116	5%	25:23:46
11	news.fcku.it	12	2144	326	1802	16	15%	21:56:28
12	csiph-out.feed.uzoreto.com	864	23470	152	23082	236	0%	71:21:17
13	nntp.pasdenom.info	2	10877	52	10811	14	0%	23:58:17
14	news.swapon.de	10	1296	28	1267	1	2%	23:10:59
15	news.bbs.nz	2	15495	12	15482	1	0%	23:59:44
16	localhost	36	5	5	0	0	100%	00:00:05
17	news.samoylyk.net	1	14933	4	14929	0	0%	23:30:25
18	xanadu-bbs.net	37	389	0	389	0	0%	20:32:44
TOTAL: 18		3447	311290	15596	291807	3887	5%	665:13:24

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	9.6 MB	0.0 KB	5.5 MB	15.1 MB	63%	4.6 KB
2	csiph-out.feeder.erje.net	9.5 MB	15.3 KB	11.5 MB	21.0 MB	45%	11.2 KB
3	feeder.eternal-september.org	5.2 MB	0.0 KB	448.4 KB	5.6 MB	92%	2.6 KB
4	csiph-out.news.xs4all.nl	4.4 MB	0.0 KB	13.2 MB	17.6 MB	25%	6.0 KB
5	newsfeeds.xmission.com	3.7 MB	2.6 KB	248.9 KB	4.0 MB	93%	3.1 KB
6	news-out.aioe.org	3.2 MB	0.0 KB	51.0 KB	3.3 MB	98%	2.3 KB
7	news-out.mixmin.net	3.0 MB	1.6 KB	467.9 KB	3.4 MB	86%	2.8 KB
8	news.freedyn.net	2.6 MB	0.0 KB	53.2 MB	55.8 MB	4%	29.0 KB
9	newsfeed.neva.ru	2.1 MB	0.0 KB	1.2 MB	3.3 MB	63%	2.7 KB
10	newsfeed.fu-berlin.de	1.9 MB	0.0 KB	373.7 KB	2.3 MB	83%	2.5 KB
11	csiph-out.feed.uzoreto.com	528.0 KB	0.0 KB	4.4 MB	4.9 MB	10%	12.9 KB
12	news.fcku.it	514.9 KB	0.0 KB	146.1 KB	661.1 KB	77%	1.9 KB
13	nntp.pasdenom.info	127.1 KB	0.0 KB	21.3 KB	148.4 KB	85%	2.2 KB
14	news.swapon.de	60.6 KB	0.0 KB	24.5 KB	85.1 KB	71%	2.9 KB
15	news.bbs.nz	34.7 KB	2.4 KB	2.4 KB	39.5 KB	87%	3.0 KB
16	news.samoylyk.net	14.7 KB	0.0 KB	0.0 KB	14.7 KB	100%	3.7 KB
17	localhost	5.8 KB	0.0 KB	0.0 KB	5.8 KB	100%	1.2 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		46.3 MB	21.9 KB	90.6 MB	137.0 MB	33%	7.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 20 04:15:00 - 04:59:59	286	1.9%	0.11	1.1 MB	2.3%	0.40
Sep 20 05:00:00 - 05:59:59	375	2.4%	0.10	1.7 MB	3.7%	0.49
Sep 20 06:00:00 - 06:59:59	476	3.1%	0.13	1.6 MB	3.4%	0.45
Sep 20 07:00:00 - 07:59:59	772	5.0%	0.21	2.4 MB	5.3%	0.69
Sep 20 08:00:00 - 08:59:59	759	4.9%	0.21	1.8 MB	4.0%	0.53
Sep 20 09:00:00 - 09:59:59	688	4.5%	0.19	1.7 MB	3.6%	0.48
Sep 20 10:00:00 - 10:59:59	687	4.5%	0.19	2.2 MB	4.7%	0.62
Sep 20 11:00:00 - 11:59:59	706	4.6%	0.20	1.6 MB	3.5%	0.46
Sep 20 12:00:00 - 12:59:59	827	5.4%	0.23	1.9 MB	4.2%	0.55
Sep 20 13:00:00 - 13:59:59	762	4.9%	0.21	1.9 MB	4.1%	0.54
Sep 20 14:00:00 - 14:59:59	981	6.4%	0.27	2.7 MB	6.0%	0.78
Sep 20 15:00:00 - 15:59:59	725	4.7%	0.20	2.0 MB	4.4%	0.58
Sep 20 16:00:00 - 16:59:59	884	5.7%	0.25	3.5 MB	7.5%	0.99
Sep 20 17:00:00 - 17:59:59	918	5.9%	0.26	2.7 MB	6.0%	0.78
Sep 20 18:00:00 - 18:59:59	843	5.5%	0.23	2.7 MB	5.8%	0.76
Sep 20 19:00:00 - 19:59:59	844	5.5%	0.23	2.4 MB	5.2%	0.68
Sep 20 20:00:00 - 20:59:59	805	5.2%	0.22	2.2 MB	4.9%	0.64
Sep 20 21:00:00 - 21:59:59	633	4.1%	0.18	1.8 MB	3.8%	0.50
Sep 20 22:00:00 - 22:59:59	634	4.1%	0.18	2.2 MB	4.7%	0.61
Sep 20 23:00:00 - 23:59:59	499	3.2%	0.14	1.6 MB	3.4%	0.44
Sep 21 00:00:00 - 00:59:59	329	2.1%	0.09	892.5 KB	1.9%	0.25
Sep 21 01:00:00 - 01:59:59	348	2.3%	0.10	961.0 KB	2.0%	0.27
Sep 21 02:00:00 - 02:59:59	307	2.0%	0.09	1.2 MB	2.5%	0.33
Sep 21 03:00:00 - 03:59:59	257	1.7%	0.07	959.8 KB	2.0%	0.27
Sep 21 04:00:00 - 04:15:00	92	0.6%	0.10	388.5 KB	0.8%	0.43
TOTAL: 24:00:00	15437	100.0%	0.18	46.0 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.news.xs4all.nl	1352	33	0	1	1318
2	news.freedyn.net	982	24	0	0	958
3	csiph-out.feeder.erje.net	411	71	1	0	339
4	newsfeed.fu-berlin.de	386	11	0	0	375
5	newsfeed.neva.ru	353	56	0	0	297
6	csiph-out.feed.uzoreto.com	237	8	0	0	229
7	csiph-out.news.weretis.net	202	70	0	0	132
8	news-out.mixmin.net	177	0	1	0	176
9	feeder.eternal-september.org	79	23	0	0	56
10	news-out.aioe.org	33	5	0	0	28
11	nntp.pasdenom.info	16	0	0	0	16
12	news.fcku.it	15	2	0	0	13
13	newsfeeds.xmission.com	5	1	0	0	4
14	news.swapon.de	5	0	0	0	5
TOTAL: 14		4253	304	2	1	3946

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	40
alt.binaries.pictures.purebeauty	28
alt.bbs.synchronet	27
alt.slack.goathead	20
mozilla.general	19
alt.survival	13
it-alt.sport.calcio.juventus	10
mozilla.dev.security.policy	10
mozilla.support.firefox	9
lada.auto	9
alt.philosophy	6
mozilla.support.thunderbird	6
oesterreich.tratsch	5
alt.windows7.general	5
spline.fli4l	5
mozilla.test	4
cakewalk.audio	4
mozilla.support.seamonkey	3
alt.binaries.nospam.breasts	3
at.jobs	3
TOTAL: 74	304

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
uk.radio.amateur.moderated	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2250
EMP (phl)	106
EMP (phn path)	102
EMP (phn nph)	99
Binary Payload	34
HTML Multipart	17
Too many newsgroups	14
User-issued cancel	13
Binary: misplaced rar	12
User-issued spam cancel	11
Scoring filter (14)	8
Scoring filter (12)	5
Scoring filter (10)	5
EMP (fsl)	4
Scoring filter (13)	2
Scoring filter (9)	1
Scoring filter (8)	1
HTML post	1
Scoring filter (15)	1
TOTAL: 19	2686

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	27	0	27	27
TOTAL: 1	27	5	27	27

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	425
	csiph-out.feeder.erje.net	200
	csiph-out.news.xs4all.nl	142
	csiph-out.news.weretis.net	72
	csiph-out.feed.uzoreto.com	52
	newsfeeds.xmission.com	4
	news-out.mixmin.net	4
	feeder.eternal-september.org	2
	news.fcku.it	1
	TOTAL: 9	902
Including strange strings
	newsfeed.fu-berlin.de	280
	csiph-out.news.xs4all.nl	56
	csiph-out.news.weretis.net	5
	news-out.mixmin.net	5
	news.swapon.de	4
	news.freedyn.net	3
	csiph-out.feeder.erje.net	3
	TOTAL: 7	356
TOTAL: 3		1303

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.nz	28171	1022	13889	12	0	3%	23:50:19
2	xanadu-bbs	17332	715	14722	0	0	4%	23:59:51
3	fu-berlin.de	14490	445	14045	0	0	3%	23:59:55
4	news.samoylyk.net	16123	443	14985	2	0	2%	23:59:45
5	news.freedyn.net	14701	348	14003	3	2057	2%	23:55:28
6	erje	16871	336	13468	50	0	1%	23:57:44
7	usenet.pasdenom.info	15976	115	14795	474	15	0%	23:59:55
8	newsfeed.xs4all.nl	13949	40	13107	5	43	0%	23:56:33
9	aioe	13475	29	12992	0	0	0%	23:55:03
10	neva.ru	14640	27	13698	132	0	0%	23:59:51
11	news.mixmin.net	14122	9	13722	0	0	0%	23:59:55
12	xmission	18375	7	13684	0	0	0%	23:59:51
13	weretis.net	12007	7	11734	1	0	0%	23:52:50
14	eternal-september	13344	6	12859	0	0	0%	23:59:55
15	news.uzoreto.com	15073	5	14731	32	0	0%	23:50:11
16	news.swapon.de	1393	5	1346	0	0	0%	23:32:41
17	news.fcku.it	1735	0	1727	0	0	0%	21:29:07
18	news.redatomik.org	0	0	0	0	14936	0%	23:50:11
TOTAL: 18		241777	3559	209507	711	17051	1%	428:09:05

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.7 MB	0.0 KB	6.7 MB	0.1 KB/s	9.6 KB	23:59:51
2	news.samoylyk.net	6.1 MB	2.0 KB	6.1 MB	0.1 KB/s	14.0 KB	23:59:45
3	fu-berlin.de	6.1 MB	0.0 KB	6.1 MB	0.1 KB/s	14.0 KB	23:59:55
4	news.freedyn.net	4.4 MB	3.4 KB	4.4 MB	0.1 KB/s	12.7 KB	23:55:28
5	news.bbs.nz	2.9 MB	54.5 KB	2.9 MB	0.0 KB/s	2.9 KB	23:50:19
6	erje	769.0 KB	204.8 KB	973.8 KB	0.0 KB/s	2.5 KB	23:57:44
7	usenet.pasdenom.info	265.0 KB	6.2 MB	6.4 MB	0.1 KB/s	11.2 KB	23:59:55
8	newsfeed.xs4all.nl	106.9 KB	30.2 KB	137.2 KB	0.0 KB/s	3.0 KB	23:56:33
9	neva.ru	94.1 KB	308.8 KB	402.9 KB	0.0 KB/s	2.5 KB	23:59:51
10	aioe	62.7 KB	0.0 KB	62.7 KB	0.0 KB/s	2.2 KB	23:55:03
11	weretis.net	13.5 KB	1.3 KB	14.9 KB	0.0 KB/s	1.9 KB	23:52:50
12	news.mixmin.net	13.5 KB	0.0 KB	13.5 KB	0.0 KB/s	1.5 KB	23:59:55
13	xmission	10.3 KB	0.0 KB	10.3 KB	0.0 KB/s	1.5 KB	23:59:51
14	eternal-september	8.8 KB	0.0 KB	8.8 KB	0.0 KB/s	1.5 KB	23:59:55
15	news.uzoreto.com	6.0 KB	74.8 KB	80.7 KB	0.0 KB/s	2.2 KB	23:50:11
16	news.swapon.de	5.8 KB	0.0 KB	5.8 KB	0.0 KB/s	1.2 KB	23:32:41
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:29:07
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:11
TOTAL: 18		27.4 MB	6.8 MB	34.3 MB	0.0 KB/s	8.2 KB	428:09:05

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	29	9	14.1 KB	6	0	0	07:21:15
2	71-82-166-98.dhcp.mdsn.wi.charter.com	21	7	9.0 KB	7	5	5	06:09:06
3	208-71-239-109.cust.centrio.cz	1	2	3.7 KB	1	0	0	00:30:19
TOTAL: 3		51	18	26.8 KB	14	5	5	16:00:55

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	29	9	14.1 KB	6	0	0	07:21:15
2	*.dhcp.mdsn.wi.charter.com	21	7	9.0 KB	7	5	5	06:09:06
3	*.cust.centrio.cz	1	2	3.7 KB	1	0	0	00:30:19
4	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:13
TOTAL: 4		55	18	26.8 KB	14	5	5	16:00:55

NNRP auth users [Top 20]:

User	Conn
ohlandl	5
ctomczyk	1
TOTAL: 2	6

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.293	0.425	0.000	07:21:15
71-82-166-98.dhcp.mdsn.wi.charter.com	1.782	0.277	0.012	06:09:06
ip72-222-200-117.ph.ph.cox.net	0.449	0.084	0.000	02:00:13
208-71-239-109.cust.centrio.cz	0.106	0.024	0.003	00:30:19
TOTAL: 4	4.630	0.810	0.015	16:00:55

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	4
TOTAL: 1	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-82-166-98.dhcp.mdsn.wi.charter.com	6	0
ip72-222-200-117.ph.ph.cox.net	4	0
208-71-239-109.cust.centrio.cz	1	0
TOTAL: 3	11	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	16
2	comp.lang.javascript	2
TOTAL: 2		18

Daily Usenet report for csiph.com

Sep 20 04:15:00 -- Sep 21 04:15:00