Daily Usenet report for feeder.visyn.net

May 1 04:15:06 -- May 2 04:15:03

Log entries by program
History cache
INND timer
INNfeed timer
nnrpd timer
Control commands to INND
Control Channel
Incoming Feeds (INN)
Incoming Volume (INN)
Incoming articles
CNFS buffer status
Sites sending bad articles
Unwanted newsgroups
Unwanted distributions
Supposedly-moderated groups with unmoderated postings
INND perl filter
Too many incoming connections (innd)
Miscellaneous innd statistics
Outgoing Feeds (innfeed) by Articles
Outgoing Feeds (innfeed) by Volume
NNRP total resource statistics
NNRP no permission clients

Program name	Lines	%Lines	Size	%Size

inn	189300	76.4%	33.4 MB	84.0%
innd	53443	21.6%	5.7 MB	14.2%
cnfsstat	3024	1.2%	510.6 KB	1.3%
innfeed	1963	0.8%	206.8 KB	0.5%
controlchan	23	0.0%	2.9 KB	0.0%
nnrpd	16	0.0%	1.5 KB	0.0%

TOTAL: 6	247769	100.0%	39.8 MB	100.0%

History cache:

Reason	Count	%Count

Positive hits	976080	69.5%
Negative hits	278813	19.8%
Do not exist	142989	10.2%
Cache misses	7343	0.5%

TOTAL: 4	1405225	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)

article cancel	00:00:00.920	0.0%	1105	0.000	0.833	18.000
article cleanup	00:00:01.772	0.0%	179481	0.000	0.010	0.028
article logging	00:00:04.962	0.0%	180021	0.000	0.028	0.483
article parse	00:00:20.219	0.0%	2045975	0.004	0.010	0.057
article write	00:08:06.578	0.6%	94548	1.146	5.146	29.613
artlog/artcncl	00:00:00.006	0.0%	969	0.000	0.006	1.000
artlog/artparse	00:00:00.877	0.0%	7935	0.000	0.111	2.846
data move	00:00:04.414	0.0%	3096480	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.016	0.0%	943	0.000	0.017	0.500
hishave/artcncl	00:00:00.890	0.0%	1105	0.000	0.805	18.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:47.003	0.1%	1405676	0.001	0.033	3.343
history sync	00:00:00.149	0.0%	347	0.000	0.429	113.000
history write	00:01:10.018	0.1%	142799	0.000	0.490	4.353
hiswrite/artcncl	00:00:00.003	0.0%	162	0.000	0.019	0.333
idle	23:36:39.813	98.7%	3047667	4.977	27.890	128.898
nntp read	00:00:12.708	0.0%	3093500	0.001	0.004	0.011
overview write	00:04:20.735	0.3%	94548	0.518	2.758	40.887
perl filter	00:02:41.492	0.2%	134058	0.692	1.205	1.945
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.287	0.0%	188312	0.000	0.007	0.018

TOTAL: 23:55:59.274	23:54:33.862	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)

article new	00:00:00.315	0.0%	81625	0.004	0.004	0.004
article prepare	00:00:00.116	0.0%	92324	0.001	0.001	0.001
article read	00:00:15.915	0.0%	18729	0.581	0.850	1.054
backlog stats	00:00:02.018	0.0%	1491197	0.001	0.001	0.001
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:04.273	0.0%	1017538	0.004	0.004	0.005
data write	00:00:05.124	0.0%	957817	0.005	0.005	0.006
idle	20:26:22.203	99.9%	1491197	40.425	49.344	63.454
status file	00:00:00.115	0.0%	170	0.541	0.676	0.781

TOTAL: 20:27:17.458	20:26:50.079	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)

idle	00:00:00.000	0.0%	0	0.000	0.000	0.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.000	0.0%	2	0.000	0.000	0.000

TOTAL: 00:00:02.299	00:00:00.000	0.0%	-	-	-	-

Control commands to INND:

Command	Number

L	1
flush	1
flushlogs	2
go	2
logmode	2
mode	4
name	2
pause	2
paused	2
reserve	2

TOTAL: 10	20

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

moderator@dana.de	0	0	1	0	0	1
news@news2.open-news-network.org	0	0	1	0	0	1
us-control@lists.killfile.org	0	0	1	0	0	1
wkronert@sunstroke.sdsu.edu	0	0	1	0	1	1

TOTAL	0	0	4	0	1	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	feeders.news-service.com	851	238031	26631	188828	22572	11%	64:28:41
2	newsfeed01.sul.t-online.de	26	59990	21350	33566	5074	35%	24:34:24
3	visyn-out.feeder.erje.net	574	98994	19717	44226	35051	19%	47:37:57
4	news-out.aioe.org	3	164929	9931	150690	4308	6%	38:19:06
5	border-2.ams.xsnews.nl	1441	126324	6248	100605	19471	4%	23:56:31
6	visyn-out.news.weretis.net	1	101037	3726	95302	2009	3%	25:18:28
7	news.visyn.net	4	62494	2645	58985	864	4%	24:18:04
8	news-out.mixmin.net	1	96352	1524	93407	1421	1%	25:13:33
9	news.telesweet.net	1	100840	395	100189	256	0%	25:12:14
10	just2write2.myftp.org	7	81879	351	81234	294	0%	17:26:21
11	localhost	1	0	0	0	0	0%	00:00:00
12	feeds.phibee-telecom.net	7	2	0	2	0	0%	00:45:24

TOTAL: 12		2917	1130872	92518	947034	91320	8%	317:10:43

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	visyn-out.news.weretis.net	115.3 MB	1.0 MB	116.3 MB	99%	20.8 KB	25:18:28
2	feeders.news-service.com	112.3 MB	5.8 MB	118.0 MB	95%	2.5 KB	64:28:41
3	newsfeed01.sul.t-online.de	70.0 MB	4.1 MB	74.1 MB	94%	2.9 KB	24:34:24
4	border-2.ams.xsnews.nl	37.1 MB	538.0 KB	37.7 MB	98%	1.5 KB	23:56:31
5	visyn-out.feeder.erje.net	36.3 MB	42.5 MB	78.8 MB	46%	1.5 KB	47:37:57
6	news-out.aioe.org	23.1 MB	2.5 MB	25.6 MB	90%	1.8 KB	38:19:06
7	news.visyn.net	14.3 MB	1.1 MB	15.4 MB	92%	4.5 KB	24:18:04
8	just2write2.myftp.org	13.8 MB	60.3 KB	13.9 MB	99%	22.1 KB	17:26:21
9	news-out.mixmin.net	4.9 MB	1.0 MB	6.0 MB	83%	2.1 KB	25:13:33
10	news.telesweet.net	4.1 MB	136.2 KB	4.3 MB	96%	6.7 KB	25:12:14
11	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0	00:00:00
12	feeds.phibee-telecom.net	0.0 KB	0.0 KB	0.0 KB	0%	0	00:45:24

TOTAL: 12		431.3 MB	58.8 MB	490.1 MB	88%	2.7 KB	317:10:43

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec

May 1 04:15:06 - 04:59:59	2288	2.4%	0.85	18.9 MB	4.0%	7.19
May 1 05:00:00 - 05:59:59	2725	2.9%	0.76	20.6 MB	4.3%	5.85
May 1 06:00:00 - 06:59:59	2296	2.4%	0.64	13.0 MB	2.7%	3.70
May 1 07:00:00 - 07:59:59	2444	2.6%	0.68	8.7 MB	1.8%	2.47
May 1 08:00:00 - 08:59:59	2801	3.0%	0.78	10.2 MB	2.1%	2.90
May 1 09:00:00 - 09:59:59	2743	2.9%	0.76	10.0 MB	2.1%	2.85
May 1 10:00:00 - 10:59:59	3461	3.7%	0.96	11.5 MB	2.4%	3.28
May 1 11:00:00 - 11:59:59	3775	4.0%	1.05	22.4 MB	4.7%	6.39
May 1 12:00:00 - 12:59:59	3495	3.7%	0.97	23.0 MB	4.9%	6.55
May 1 13:00:00 - 13:59:59	3778	4.0%	1.05	12.0 MB	2.5%	3.42
May 1 14:00:00 - 14:59:59	4046	4.3%	1.12	18.9 MB	4.0%	5.36
May 1 15:00:00 - 15:59:59	4501	4.8%	1.25	20.2 MB	4.3%	5.74
May 1 16:00:00 - 16:59:59	5034	5.3%	1.40	27.5 MB	5.8%	7.83
May 1 17:00:00 - 17:59:59	5819	6.1%	1.62	47.8 MB	10.1%	13.59
May 1 18:00:00 - 18:59:59	4681	4.9%	1.30	21.7 MB	4.6%	6.19
May 1 19:00:00 - 19:59:59	5922	6.3%	1.65	30.5 MB	6.4%	8.68
May 1 20:00:00 - 20:59:59	4776	5.0%	1.33	16.3 MB	3.4%	4.64
May 1 21:00:00 - 21:59:59	4835	5.1%	1.34	21.7 MB	4.6%	6.17
May 1 22:00:00 - 22:59:59	5528	5.8%	1.54	22.8 MB	4.8%	6.48
May 1 23:00:00 - 23:59:59	5042	5.3%	1.40	29.4 MB	6.2%	8.36
May 2 00:00:00 - 00:59:59	4152	4.4%	1.15	18.9 MB	4.0%	5.38
May 2 01:00:00 - 01:59:59	3219	3.4%	0.89	13.5 MB	2.8%	3.84
May 2 02:00:00 - 02:59:59	2965	3.1%	0.82	15.1 MB	3.2%	4.29
May 2 03:00:00 - 03:59:59	3514	3.7%	0.98	16.5 MB	3.5%	4.71
May 2 04:00:00 - 04:15:03	895	0.9%	0.99	3.1 MB	0.7%	3.53

TOTAL: 23:59:57	94735	100.0%	1.10	474.3 MB	100.0%	5.62

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

BIG81	BIG8	512.0 MB	448.2 MB	87.5%	15	0.19	32.74
BIG82	BIG8	512.0 MB	429.1 MB	83.8%	15	0.19	32.66
BIG83	BIG8	512.0 MB	469.2 MB	91.6%	15	0.18	32.81
BIG84	BIG8	512.0 MB	455.1 MB	88.9%	15	0.19	32.10
BIG85	BIG8	512.0 MB	428.4 MB	83.7%	15	0.18	32.83
BIG86	BIG8	512.0 MB	427.8 MB	83.6%	15	0.19	32.15
DE1	DE	512.0 MB	421.3 MB	82.3%	2	0.02	253.64
DE2	DE	512.0 MB	415.7 MB	81.2%	2	0.02	264.09
DE3	DE	512.0 MB	434.2 MB	84.8%	2	0.02	276.58
DE4	DE	512.0 MB	446.7 MB	87.2%	2	0.02	258.17
DE5	DE	512.0 MB	446.0 MB	87.1%	2	0.02	269.57
DE6	DE	512.0 MB	421.2 MB	82.3%	2	0.03	236.20
FTN1	FTN	512.0 MB	14.3 MB	2.8%	0	0.02	355.56
FTN2	FTN	512.0 MB	14.3 MB	2.8%	0	0.02	355.85
FTN3	FTN	512.0 MB	12.3 MB	2.4%	0	0.02	355.56
INTL1	INTL	512.0 MB	54.5 MB	10.6%	179	0.83	7.32
INTL2	INTL	512.0 MB	483.3 MB	94.4%	178	0.80	7.56
INTL3	INTL	512.0 MB	212.8 MB	41.6%	179	0.80	7.56
INTL4	INTL	512.0 MB	106.3 MB	20.8%	179	0.79	7.66
INTL5	INTL	512.0 MB	122.6 MB	23.9%	179	0.82	7.41
INTL6	INTL	512.0 MB	231.7 MB	45.3%	179	0.79	7.70

TOTAL: 21	-	10.5 GB	6.3 GB	60.4%	1175	0.38	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	visyn-out.feeder.erje.net	35088	1190	7	31433	47	0	0	0	2411
2	feeders.news-service.com	22554	1050	3	4250	87	0	0	0	17164
3	border-2.ams.xsnews.nl	19454	331	16	394	13	0	0	0	18700
4	newsfeed01.sul.t-online.de	5086	37	0	2733	3	0	0	0	2313
5	feeds.phibee-telecom.net	3355	1323	0	1267	7	0	0	0	758
6	news-out.mixmin.net	2554	11	0	2047	0	0	0	0	496
7	news-out.aioe.org	2197	83	0	881	0	0	0	0	1233
8	visyn-out.news.weretis.net	1815	251	0	569	1	0	0	0	994
9	news.visyn.net	873	1	0	754	1	81	0	0	36
10	just2write2.myftp.org	435	70	0	74	3	0	0	0	288
11	news.telesweet.net	141	6	0	56	1	0	0	0	78
12	?	41	0	0	0	0	0	0	0	41

TOTAL: 12		93593	4353	26	44458	163	81	0	0	44512

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.test	717
finet.binaries.keskustelu	505
alt.aaron	176
alt.sex.pre-teens	141
usa.jobs	106
aus.sex.incest	98
free.alt.freedom.japan.loli	97
francom.esoterisme	67
alt.jobs.canada	56
alt.pl.wolnosc	42
alt.att	41
hetnet.hk	40
alt.sex.panties	39
alt.sex.beastiality	39
alt.politics.obama	37
mpc.lists.nanog	35
newsland.discussioni.suggerimenti	35
alt.sex.scat	34
alt.sex.personals	31
alt.sex.stories.cuckold	31

TOTAL: 485	4353

Unwanted distributions [Top 20]:

Distribution	Count

local	26

TOTAL: 1	26

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

Groups	Count

mailing.gcc.gcc	32
mailing.openbsd.source-changes	29
mailing.unix.dovecot	26
mailing.gcc.gcc-cvs	20
mailing.unix.dovecot-cvs	20
mailing.database.mysql-win32	7
mailing.openbsd.ports-changes	6
de.alt.fan.tabak	5
fr.comp.securite	5
mailing.gcc.libstdc++	3
fr.comp.applications.libres	2
sci.bio.evolution	1
bit.listserv.skeptic	1
soc.women.lesbian-and-bi	1
de.comp.lang.iso-c++	1
linux.debian.user	1
hr.alt.hackers	1
rec.arts.movies.reviews	1
visyn.announce	1

TOTAL: 19	163

INND perl filter [Top 20]:

Reason	Count

EMP (md5)	18089
EMP (phl)	5089
NNTP Monitor	3744
Scoring filter (10)	3274
EMP (phn)	955
Scoring filter (9)	816
Scoring filter (8)	729
EMP (fsl)	720
Poison newsgroup	266
Scoring filter (11)	262
PFM bot misc	224
HTML post	192
Scoring filter (12)	177
Scoring filter (13)	141
Scoring filter (15)	141
Scoring filter (14)	73
Scoring filter (16)	43
Adult group ECP	15
Scoring filter (17)	8
Binary in non-binary group	8

TOTAL: 35	34998

Too many incoming connections (innd):

Server	Conn

news-service.com	133

TOTAL: 1	133

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Article posted in the future
	feeders.news-service.com	777
	visyn-out.feeder.erje.net	203
	border-2.ams.xsnews.nl	45
	TOTAL: 3	1025
Bad Message-ID's offered
	feeders.news-service.com	2
	visyn-out.feeder.erje.net	1
	border-2.ams.xsnews.nl	1
	TOTAL: 3	4
Huge articles
	feeders.news-service.com	7549
	news.telesweet.net	51
	border-2.ams.xsnews.nl	45
	TOTAL: 3	7645
Including strange strings
	visyn-out.news.weretis.net	183
	newsfeed01.sul.t-online.de	112
	visyn-out.feeder.erje.net	90
	feeders.news-service.com	45
	feeds.phibee-telecom.net	39
	news.visyn.net	35
	news-out.aioe.org	28
	border-2.ams.xsnews.nl	7
	news-out.mixmin.net	3
	TOTAL: 9	542
No colon-space in header
	border-2.ams.xsnews.nl	117
	feeders.news-service.com	66
	?	41
	visyn-out.feeder.erje.net	11
	TOTAL: 4	235

TOTAL: 5		9451

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed

1	news.visyn.net	120156	15632	78451	3976	0	0	13%	25:53:53
2	aioe.org	125080	2637	78678	400	1	274	2%	23:19:26
3	t-online.de	74593	1145	65677	510	0	0	1%	25:10:45
4	just2write2.myftp.org	125765	1129	83310	283	0	1	0%	23:27:51
5	feeds.phibee-telecom.net	93104	879	80089	87	0	0	0%	24:00:00
6	news-service.com	115840	822	90623	5	0	0	0%	33:26:34
7	feed.xsnews.nl	110232	435	87006	21	0	57	0%	23:59:57
8	news.telesweet.net	89156	162	55748	645	0	1450	0%	17:23:01
9	weretis.net	137239	161	98476	8	0	0	0%	25:17:59
10	feeder.erje.net	77680	118	62452	383	0	0	0%	22:24:44
11	news.mixmin.net	112079	56	88736	345	0	179	0%	23:59:12

TOTAL: 11		1180924	23176	869246	6663	1	1961	1%	268:23:22

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed

1	news.visyn.net	75.3 MB	37.5 MB	112.7 MB	1.2 KB/s	5.9 KB	25:53:53
2	t-online.de	11.0 MB	12.3 MB	23.3 MB	0.3 KB/s	14.4 KB	25:10:45
3	just2write2.myftp.org	8.4 MB	2.2 MB	10.6 MB	0.1 KB/s	7.7 KB	23:27:51
4	aioe.org	7.3 MB	1.9 MB	9.2 MB	0.1 KB/s	3.1 KB	23:19:26
5	feeder.erje.net	4.9 MB	26.5 MB	31.4 MB	0.4 KB/s	64.3 KB	22:24:44
6	feeds.phibee-telecom.net	3.3 MB	839.8 KB	4.2 MB	0.0 KB/s	4.4 KB	24:00:00
7	news-service.com	3.1 MB	66.2 KB	3.1 MB	0.0 KB/s	3.9 KB	33:26:34
8	feed.xsnews.nl	1.0 MB	850.3 KB	1.8 MB	0.0 KB/s	4.2 KB	23:59:57
9	weretis.net	890.5 KB	26.6 KB	917.2 KB	0.0 KB/s	5.4 KB	25:17:59
10	news.telesweet.net	828.1 KB	3.8 MB	4.6 MB	0.1 KB/s	5.9 KB	17:23:01
11	news.mixmin.net	305.1 KB	1.2 MB	1.5 MB	0.0 KB/s	3.8 KB	23:59:12

TOTAL: 11		116.3 MB	87.1 MB	203.4 MB	0.2 KB/s	7.0 KB	268:23:22

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed

rrcs-96-11-228-247.central.biz.rr.com	0.064	0.008	0.000	00:00:01
capricornus.n.weretis.net	0.052	0.016	0.000	00:00:00

TOTAL: 2	0.116	0.024	0.000	00:00:02

NNRP no permission clients:

System	Conn

rrcs-96-11-228-247.central.biz.rr.com	1
capricornus.n.weretis.net	1

TOTAL: 2	2