Daily Usenet report for feeder.visyn.net

Aug 12 04:15:05 -- Aug 13 04:15:04

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
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	241535	81.4%	46.1 MB	88.2%
innd	49828	16.8%	5.4 MB	10.3%
cnfsstat	3024	1.0%	510.5 KB	1.0%
innfeed	2158	0.7%	276.2 KB	0.5%
nnrpd	48	0.0%	4.8 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%

TOTAL: 6	296594	100.0%	52.3 MB	100.0%

History cache:

Reason	Count	%Count

Positive hits	1412185	72.7%
Negative hits	342454	17.6%
Do not exist	185756	9.6%
Cache misses	2602	0.1%

TOTAL: 4	1942997	100.0%

INND timer:

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

article cancel	00:00:02.975	0.0%	1483	0.000	2.006	24.556
article cleanup	00:00:03.976	0.0%	238618	0.002	0.017	0.031
article logging	00:00:07.925	0.0%	239370	0.004	0.033	0.446
article parse	00:00:43.565	0.1%	2361272	0.013	0.018	0.029
article write	00:08:05.382	0.6%	127273	0.170	3.814	17.020
artlog/artcncl	00:00:00.149	0.0%	1362	0.000	0.109	22.000
artlog/artparse	00:00:00.002	0.0%	452	0.000	0.004	0.167
data move	00:00:08.165	0.0%	3714217	0.001	0.002	0.004
hisgrep/artcncl	00:00:00.104	0.0%	1148	0.000	0.091	3.600
hishave/artcncl	00:00:02.688	0.0%	1483	0.000	1.813	24.556
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:40.878	0.0%	1946403	0.003	0.021	0.926
history sync	00:00:00.112	0.0%	358	0.000	0.313	42.000
history write	00:01:03.471	0.1%	185721	0.032	0.342	8.286
hiswrite/artcncl	00:00:00.015	0.0%	335	0.000	0.045	1.000
idle	23:30:07.433	97.8%	3763725	1.052	22.480	81.262
nntp read	00:00:26.287	0.0%	3837434	0.004	0.007	0.009
overview write	00:06:57.879	0.5%	127273	1.069	3.283	41.338
perl filter	00:09:32.489	0.7%	185679	1.425	3.083	14.250
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:02.429	0.0%	253181	0.002	0.010	0.023

TOTAL: 24:01:07.129	23:58:05.924	99.8%	-	-	-	-

INNfeed timer:

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

article new	00:00:00.772	0.0%	126964	0.004	0.006	0.008
article prepare	00:00:00.370	0.0%	206194	0.001	0.002	0.003
article read	00:00:24.597	0.0%	37786	0.284	0.651	1.175
backlog stats	00:00:04.975	0.0%	2583137	0.002	0.002	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:12.312	0.0%	1752281	0.007	0.007	0.009
data write	00:00:14.253	0.0%	1668973	0.008	0.009	0.011
idle	22:55:06.398	99.8%	2583137	23.804	31.940	49.873
status file	00:00:00.747	0.0%	207	1.000	3.609	31.700

TOTAL: 22:57:13.367	22:56:04.424	99.9%	-	-	-	-

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%	6	0.000	0.000	0.000

TOTAL: 00:00:03.784	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

ctjacobs@zhaum.xs4all.nl	0	0	1	0	0	1

TOTAL	0	0	1	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	feeders.news-service.com	575	331725	43403	260139	28183	13%	47:35:00
2	visyn-out.feeder.erje.net	720	142998	36775	52029	54194	25%	47:34:24
3	newsfeed01.sul.t-online.de	32	96822	17930	65389	13503	18%	25:05:20
4	news-out.mixmin.net	2	127578	6766	116250	4562	5%	25:19:17
5	news-out.aioe.org	1	103958	6502	95891	1565	6%	21:44:16
6	border-2.ams.xsnews.nl	1440	148782	6257	136788	5737	4%	23:45:29
7	newsfeeder.dynfx.net	7	85852	4637	78969	2246	5%	24:36:36
8	feeds.phibee-telecom.net	3	140924	2869	135298	2757	2%	25:36:50
9	news.visyn.net	5	84098	2277	81364	457	2%	24:32:02
10	news.svengo.de	1	113158	2007	110997	154	1%	24:23:32
11	news.telesweet.net	26	121511	768	120294	449	0%	25:13:47
12	just2write2.myftp.org	11	105920	97	105771	52	0%	22:44:22
13	localhost	1	0	0	0	0	0%	00:00:00

TOTAL: 13		2824	1603326	130288	1359179	113859	8%	338:10:55

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	feeders.news-service.com	1.0 GB	5.0 MB	1.0 GB	99%	15.1 KB	47:35:00
2	newsfeed01.sul.t-online.de	84.7 MB	9.8 MB	94.5 MB	89%	3.1 KB	25:05:20
3	visyn-out.feeder.erje.net	74.1 MB	47.9 MB	122.0 MB	60%	1.4 KB	47:34:24
4	news-out.mixmin.net	40.4 MB	4.5 MB	44.8 MB	90%	4.1 KB	25:19:17
5	news.telesweet.net	35.0 MB	506.7 KB	35.5 MB	98%	29.8 KB	25:13:47
6	border-2.ams.xsnews.nl	30.7 MB	1.3 MB	32.0 MB	95%	2.7 KB	23:45:29
7	news-out.aioe.org	15.7 MB	1.9 MB	17.6 MB	89%	2.2 KB	21:44:16
8	newsfeeder.dynfx.net	15.3 MB	1.7 MB	17.0 MB	90%	2.5 KB	24:36:36
9	news.visyn.net	12.8 MB	655.8 KB	13.4 MB	95%	5.0 KB	24:32:02
10	feeds.phibee-telecom.net	11.4 MB	1.5 MB	12.9 MB	88%	2.4 KB	25:36:50
11	news.svengo.de	5.1 MB	59.7 KB	5.2 MB	98%	2.5 KB	24:23:32
12	just2write2.myftp.org	1.9 MB	48.4 KB	1.9 MB	97%	13.2 KB	22:44:22
13	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0	00:00:00

TOTAL: 13		1.3 GB	74.9 MB	1.4 GB	94%	6.1 KB	338:10:55

Incoming articles:

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

Aug 12 04:15:05 - 04:59:59	2514	2.0%	0.93	9.6 MB	0.7%	3.66
Aug 12 05:00:00 - 05:59:59	3654	2.9%	1.01	58.9 MB	4.3%	16.75
Aug 12 06:00:00 - 06:59:59	2915	2.3%	0.81	19.0 MB	1.4%	5.40
Aug 12 07:00:00 - 07:59:59	3387	2.7%	0.94	31.7 MB	2.3%	9.01
Aug 12 08:00:00 - 08:59:59	3326	2.6%	0.92	15.9 MB	1.2%	4.51
Aug 12 09:00:00 - 09:59:59	3859	3.0%	1.07	19.0 MB	1.4%	5.39
Aug 12 10:00:00 - 10:59:59	4837	3.8%	1.34	37.9 MB	2.8%	10.78
Aug 12 11:00:00 - 11:59:59	5257	4.1%	1.46	38.2 MB	2.8%	10.87
Aug 12 12:00:00 - 12:59:59	4915	3.9%	1.37	41.7 MB	3.1%	11.85
Aug 12 13:00:00 - 13:59:59	5054	4.0%	1.40	28.4 MB	2.1%	8.09
Aug 12 14:00:00 - 14:59:59	5792	4.6%	1.61	27.1 MB	2.0%	7.72
Aug 12 15:00:00 - 15:59:59	7242	5.7%	2.01	316.6 MB	23.2%	90.06
Aug 12 16:00:00 - 16:59:59	6733	5.3%	1.87	96.3 MB	7.1%	27.38
Aug 12 17:00:00 - 17:59:59	7099	5.6%	1.97	37.2 MB	2.7%	10.57
Aug 12 18:00:00 - 18:59:59	6544	5.1%	1.82	64.3 MB	4.7%	18.29
Aug 12 19:00:00 - 19:59:59	6928	5.4%	1.92	41.1 MB	3.0%	11.70
Aug 12 20:00:00 - 20:59:59	7071	5.6%	1.96	61.9 MB	4.5%	17.61
Aug 12 21:00:00 - 21:59:59	7761	6.1%	2.16	132.5 MB	9.7%	37.69
Aug 12 22:00:00 - 22:59:59	6863	5.4%	1.91	38.3 MB	2.8%	10.89
Aug 12 23:00:00 - 23:59:59	6349	5.0%	1.76	26.1 MB	1.9%	7.42
Aug 13 00:00:00 - 00:59:59	5533	4.4%	1.54	95.6 MB	7.0%	27.20
Aug 13 01:00:00 - 01:59:59	4304	3.4%	1.20	30.3 MB	2.2%	8.61
Aug 13 02:00:00 - 02:59:59	4146	3.3%	1.15	32.5 MB	2.4%	9.23
Aug 13 03:00:00 - 03:59:59	3930	3.1%	1.09	50.2 MB	3.7%	14.28
Aug 13 04:00:00 - 04:15:04	1124	0.9%	1.24	14.2 MB	1.0%	16.09

TOTAL: 23:59:59	127137	100.0%	1.47	1.3 GB	100.0%	16.17

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

BIG81	BIG8	512.0 MB	498.4 MB	97.3%	7	0.22	28.14
BIG82	BIG8	512.0 MB	477.2 MB	93.2%	7	0.19	31.34
BIG83	BIG8	512.0 MB	504.2 MB	98.5%	7	0.21	29.18
BIG84	BIG8	512.0 MB	492.9 MB	96.3%	7	0.20	29.74
BIG85	BIG8	512.0 MB	476.2 MB	93.0%	7	0.22	27.85
BIG86	BIG8	512.0 MB	476.4 MB	93.0%	7	0.20	29.81
DE1	DE	512.0 MB	286.0 MB	55.9%	1	0.05	112.80
DE2	DE	512.0 MB	281.4 MB	55.0%	1	0.07	87.90
DE3	DE	512.0 MB	296.6 MB	57.9%	1	0.04	138.75
DE4	DE	512.0 MB	305.9 MB	59.8%	1	0.07	82.59
DE5	DE	512.0 MB	303.6 MB	59.3%	1	0.05	130.78
DE6	DE	512.0 MB	290.2 MB	56.7%	1	0.04	147.59
FTN1	FTN	512.0 MB	6.6 MB	1.3%	0	0.02	355.56
FTN2	FTN	512.0 MB	6.8 MB	1.3%	0	0.00	0.00
FTN3	FTN	512.0 MB	5.0 MB	1.0%	0	0.00	0.00
INTL1	INTL	512.0 MB	292.2 MB	57.1%	45	2.47	2.46
INTL2	INTL	512.0 MB	202.0 MB	39.4%	45	2.62	2.32
INTL3	INTL	512.0 MB	272.8 MB	53.3%	45	2.50	2.43
INTL4	INTL	512.0 MB	296.1 MB	57.8%	45	2.52	2.40
INTL5	INTL	512.0 MB	280.3 MB	54.7%	45	2.66	2.28
INTL6	INTL	512.0 MB	249.0 MB	48.6%	45	2.57	2.36

TOTAL: 21	-	10.5 GB	6.2 GB	58.6%	318	1.02	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	visyn-out.feeder.erje.net	54343	13031	11	34335	48	0	0	0	6918
2	feeders.news-service.com	28189	5054	16	3512	113	0	0	0	19494
3	newsfeed01.sul.t-online.de	13701	56	0	7010	1	0	0	0	6634
4	border-2.ams.xsnews.nl	5659	431	2	916	14	0	0	0	4296
5	news-out.mixmin.net	3291	129	0	2279	1	0	0	0	882
6	feeds.phibee-telecom.net	2612	457	0	1197	4	0	0	0	954
7	newsfeeder.dynfx.net	2323	216	0	1199	78	0	0	0	830
8	news-out.aioe.org	1705	50	0	1574	0	0	0	0	81
9	news.visyn.net	481	0	0	427	0	0	0	0	54
10	news.telesweet.net	445	37	0	356	3	0	0	0	49
11	news.svengo.de	135	11	0	33	0	0	0	0	91
12	?	103	0	0	0	0	0	0	0	103
13	just2write2.myftp.org	48	4	0	34	2	0	0	0	8

TOTAL: 13		113035	19476	29	52872	264	0	0	0	40394

Unwanted newsgroups [Top 20]:

Newsgroup	Count

music-gate.info	1535
alt.binaries.pictures.erotica.pregnant	1532
alt.binaries.pictures.erotic.amateur	1099
alt.binaries.amateurvideos	919
alt.binaries.test	728
alt.binaries.picture.erotica.amateur.facials	595
it.eventi.pechino2008	589
finet.binaries.keskustelu	480
alt.binaries.picturea.erotica.amateur	317
alt.fan.biliton	292
adobe.photoshop.lightroom	219
alt.binaries.picturea.erotica.amateur.females	179
alt.binaries.photos.original	123
alt.binaries.pictures.erotic.amateur.female	111
alt.binaries.nospam.breasts	111
alt.sex.fetich.orientals	110
alt.sex.orientals	110
alt.binaries.picture.erotica.facials	105
alt.binaries.pictures.erotica.oral	100
alt.binaries.pictures.erotica.facial	100

TOTAL: 1524	19476

Unwanted distributions [Top 20]:

Distribution	Count

local	29

TOTAL: 1	29

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

Groups	Count

mailing.gcc.gcc-cvs	74
mailing.unix.dovecot	63
mailing.openbsd.source-changes	49
mailing.gcc.gcc	15
mailing.gcc.libstdc++	14
mailing.unix.dovecot-cvs	14
mailing.gcc.libstdc++-cvs	7
mailing.freebsd.cvs-releng7	6
mailing.freebsd.rc	4
mailing.database.mysql-win32	4
hr.alt.hackers	3
perl.beginners	2
pl.irc	2
comp.lang.c++.moderated	1
soc.org.freemasonry	1
soc.culture.jewish.holocaust	1
mailing.database.mysql-announce	1
gnu.emacs.bug	1
pt.soc.sexologia	1
comp.lang.asm.x86	1

TOTAL: 20	264

INND perl filter [Top 20]:

Reason	Count

EMP (phl)	12662
Job spam (jobcircle.com)	7506
EMP (md5)	3854
NNTP Monitor	2888
Scoring filter (11)	2534
Scoring filter (8)	1991
Scoring filter (10)	1193
Scoring filter (9)	1137
EMP (phn)	815
Scoring filter (12)	711
Scoring filter (13)	578
EMP (fsl)	554
PFM bot misc	441
Cancel for rejected article	328
Poison newsgroup	287
Angle-bracket bot	257
Scoring filter (14)	248
Excessive Supersedes (131.177.123.9)	218
HTML post	205
Scoring filter (15)	185

TOTAL: 38	39145

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Article posted in the future
	feeders.news-service.com	36
	visyn-out.feeder.erje.net	6
	TOTAL: 2	42
Bad Message-ID's offered
	feeders.news-service.com	6
	visyn-out.feeder.erje.net	5
	border-2.ams.xsnews.nl	3
	TOTAL: 3	14
Including strange strings
	visyn-out.feeder.erje.net	233
	feeders.news-service.com	153
	newsfeed01.sul.t-online.de	151
	news-out.mixmin.net	77
	newsfeeder.dynfx.net	71
	feeds.phibee-telecom.net	22
	news-out.aioe.org	19
	news.visyn.net	11
	news.svengo.de	9
	news.telesweet.net	6
	TOTAL: 11	755
No colon-space in header
	feeders.news-service.com	214
	border-2.ams.xsnews.nl	104
	?	12
	visyn-out.feeder.erje.net	1
	TOTAL: 4	331

TOTAL: 4		1142

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed

1	news.visyn.net	123116	17627	81868	9964	0	0	14%	22:30:36
2	news.svengo.de	282837	7905	162047	5842	1	2	2%	33:39:40
3	aioe.org	189385	2608	122625	388	0	4312	1%	28:02:12
4	just2write2.myftp.org	158369	2260	104862	1606	0	0	1%	23:02:39
5	feed.xsnews.nl	113690	878	91045	199	0	29	0%	20:13:13
6	t-online.de	112247	775	86556	935	0	0	0%	23:30:14
7	feeds.phibee-telecom.net	147497	625	117589	377	0	1	0%	24:49:26
8	news.mixmin.net	151983	272	108119	348	0	868	0%	22:44:27
9	news-service.com	69073	254	56491	41	0	81	0%	19:12:31
10	feeder.erje.net	111557	234	84674	1031	0	0	0%	25:43:29
11	newsfeeder.dynfx.net	148914	193	110903	90	0	0	0%	22:45:55
12	news.telesweet.net	81388	13	61704	55	0	1	0%	14:23:48

TOTAL: 12		1690056	33644	1188483	20876	1	5294	1%	280:38:10

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed

1	news.visyn.net	526.6 MB	218.0 MB	744.6 MB	9.4 KB/s	27.6 KB	22:30:36
2	feeds.phibee-telecom.net	27.1 MB	41.1 MB	68.2 MB	0.8 KB/s	69.7 KB	24:49:26
3	news.svengo.de	23.5 MB	61.6 MB	85.1 MB	0.7 KB/s	6.3 KB	33:39:40
4	feeder.erje.net	10.2 MB	83.6 MB	93.8 MB	1.0 KB/s	75.9 KB	25:43:29
5	just2write2.myftp.org	9.9 MB	33.1 MB	43.0 MB	0.5 KB/s	11.4 KB	23:02:39
6	aioe.org	7.2 MB	1.6 MB	8.8 MB	0.1 KB/s	3.0 KB	28:02:12
7	t-online.de	4.4 MB	32.6 MB	37.1 MB	0.4 KB/s	22.2 KB	23:30:14
8	feed.xsnews.nl	2.1 MB	46.1 MB	48.2 MB	0.7 KB/s	45.8 KB	20:13:13
9	news.mixmin.net	970.3 KB	2.2 MB	3.1 MB	0.0 KB/s	5.2 KB	22:44:27
10	news-service.com	767.9 KB	59.5 KB	827.4 KB	0.0 KB/s	2.8 KB	19:12:31
11	newsfeeder.dynfx.net	496.0 KB	1.9 MB	2.4 MB	0.0 KB/s	8.7 KB	22:45:55
12	news.telesweet.net	38.2 KB	742.6 KB	780.8 KB	0.0 KB/s	11.5 KB	14:23:48

TOTAL: 12		613.2 MB	522.6 MB	1.1 GB	1.2 KB/s	21.3 KB	280:38:10

NNRP total resource statistics [Top 20]:

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

p4153-ipad11kanazawa.ishikawa.ocn.ne.jp	0.116	0.008	0.000	00:00:02
dslb-084-060-176-171.pools.arcor-ip.net	0.552	0.100	0.000	00:00:01

TOTAL: 2	0.668	0.108	0.000	00:00:03

NNRP no permission clients:

System	Conn

dslb-084-060-176-171.pools.arcor-ip.net	5
p4153-ipad11kanazawa.ishikawa.ocn.ne.jp	1

TOTAL: 2	6