Daily Usenet report for feeder.visyn.net

Jun 14 04:15:05 -- Jun 15 04:15:03

Log entries by program
History cache
INND timer
INNfeed timer
nnrpd timer
Control commands to INND
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	204325	80.6%	37.3 MB	87.1%
innd	44270	17.5%	4.8 MB	11.2%
cnfsstat	3024	1.2%	505.8 KB	1.2%
innfeed	1961	0.8%	227.2 KB	0.5%
nnrpd	72	0.0%	7.0 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%

TOTAL: 6	253653	100.0%	42.8 MB	100.0%

History cache:

Reason	Count	%Count

Positive hits	980952	69.6%
Negative hits	268250	19.0%
Do not exist	159113	11.3%
Cache misses	1636	0.1%

TOTAL: 4	1409951	100.0%

INND timer:

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

article cancel	00:00:00.207	0.0%	1824	0.000	0.113	12.600
article cleanup	00:00:03.378	0.0%	201725	0.005	0.017	0.033
article logging	00:00:07.783	0.0%	202674	0.002	0.038	0.574
article parse	00:00:14.997	0.0%	719344	0.013	0.021	0.030
article write	00:07:19.372	0.5%	105345	1.023	4.171	21.946
artlog/artcncl	00:00:00.016	0.0%	1637	0.000	0.010	1.000
artlog/artparse	00:00:00.004	0.0%	280	0.000	0.014	0.048
data move	00:00:04.035	0.0%	1697689	0.001	0.002	0.005
hisgrep/artcncl	00:00:00.027	0.0%	1306	0.000	0.021	1.000
hishave/artcncl	00:00:00.133	0.0%	1824	0.000	0.073	12.600
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:36.286	0.0%	1413978	0.003	0.026	2.007
history sync	00:00:00.350	0.0%	372	0.000	0.941	158.000
history write	00:01:27.344	0.1%	158977	0.024	0.549	5.561
hiswrite/artcncl	00:00:00.011	0.0%	518	0.000	0.021	1.000
idle	23:38:14.920	98.4%	1764269	15.800	48.232	98.312
nntp read	00:00:10.979	0.0%	1808789	0.003	0.006	0.010
overview write	00:04:34.852	0.3%	105345	0.585	2.609	28.620
perl filter	00:06:18.127	0.4%	158958	1.406	2.379	4.166
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:02.292	0.0%	209961	0.002	0.011	0.022

TOTAL: 24:01:14.382	23:59:15.113	99.9%	-	-	-	-

INNfeed timer:

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

article new	00:00:00.638	0.0%	115357	0.005	0.006	0.006
article prepare	00:00:00.421	0.0%	210002	0.002	0.002	0.002
article read	00:00:34.838	0.0%	46124	0.309	0.755	0.882
backlog stats	00:00:03.755	0.0%	1952057	0.002	0.002	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:10.121	0.0%	1399512	0.007	0.007	0.008
data write	00:00:12.575	0.0%	1310503	0.008	0.010	0.015
idle	24:35:05.523	99.9%	1952057	37.142	45.340	62.627
status file	00:00:00.531	0.0%	203	0.949	2.616	9.050

TOTAL: 24:37:02.519	24:36:08.402	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%	9	0.000	0.000	0.000

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	visyn-out.feeder.erje.net	720	127027	44640	40463	41924	35%	47:34:13
2	newsfeed01.sul.t-online.de	39	77765	21939	42245	13581	28%	26:02:35
3	border-2.ams.xsnews.nl	1440	137633	10739	105242	21652	7%	23:46:39
4	newsfeeder.dynfx.net	10	104051	8183	92436	3432	7%	25:12:06
5	news-out.aioe.org	3	140396	7202	125574	7620	5%	25:55:58
6	news-out.mixmin.net	2	103117	5017	93461	4639	4%	23:53:49
7	news.svengo.de	1	102517	3876	97732	909	3%	23:28:44
8	feeds.phibee-telecom.net	4	119179	3434	110507	5238	2%	24:18:31
9	news.visyn.net	3	58990	1533	57091	366	2%	24:02:54
10	news.telesweet.net	15	107308	415	106509	384	0%	24:22:58
11	just2write2.myftp.org	6	135453	359	134903	191	0%	25:29:00
12	localhost	1	0	0	0	0	0%	00:00:00

TOTAL: 12		2244	1213436	107337	1006163	99936	8%	294:07:27

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	newsfeed01.sul.t-online.de	99.4 MB	9.8 MB	109.3 MB	91%	3.1 KB	26:02:35
2	visyn-out.feeder.erje.net	94.3 MB	28.8 MB	123.1 MB	76%	1.5 KB	47:34:13
3	border-2.ams.xsnews.nl	53.8 MB	4.2 MB	58.0 MB	92%	1.8 KB	23:46:39
4	newsfeeder.dynfx.net	31.8 MB	4.2 MB	36.0 MB	88%	3.2 KB	25:12:06
5	news-out.mixmin.net	24.0 MB	3.7 MB	27.8 MB	86%	2.9 KB	23:53:49
6	news-out.aioe.org	18.5 MB	9.6 MB	28.1 MB	65%	1.9 KB	25:55:58
7	feeds.phibee-telecom.net	14.2 MB	2.3 MB	16.5 MB	85%	2.0 KB	24:18:31
8	news.svengo.de	11.9 MB	147.8 KB	12.0 MB	98%	2.6 KB	23:28:44
9	news.visyn.net	6.9 MB	591.4 KB	7.5 MB	92%	4.0 KB	24:02:54
10	just2write2.myftp.org	6.7 MB	139.3 KB	6.8 MB	98%	12.7 KB	25:29:00
11	news.telesweet.net	5.6 MB	222.1 KB	5.8 MB	96%	7.5 KB	24:22:58
12	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0	00:00:00

TOTAL: 12		367.1 MB	63.8 MB	430.9 MB	85%	2.1 KB	294:07:27

Incoming articles:

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

Jun 14 04:15:05 - 04:59:59	2635	2.5%	0.98	14.8 MB	4.2%	5.64
Jun 14 05:00:00 - 05:59:59	3223	3.1%	0.90	11.4 MB	3.2%	3.25
Jun 14 06:00:00 - 06:59:59	3297	3.1%	0.92	13.5 MB	3.8%	3.84
Jun 14 07:00:00 - 07:59:59	3440	3.3%	0.96	12.8 MB	3.6%	3.64
Jun 14 08:00:00 - 08:59:59	3288	3.1%	0.91	14.2 MB	4.0%	4.03
Jun 14 09:00:00 - 09:59:59	3419	3.3%	0.95	12.6 MB	3.5%	3.60
Jun 14 10:00:00 - 10:59:59	3963	3.8%	1.10	11.3 MB	3.2%	3.21
Jun 14 11:00:00 - 11:59:59	4201	4.0%	1.17	11.6 MB	3.3%	3.30
Jun 14 12:00:00 - 12:59:59	4281	4.1%	1.19	10.7 MB	3.0%	3.05
Jun 14 13:00:00 - 13:59:59	4090	3.9%	1.14	10.4 MB	2.9%	2.95
Jun 14 14:00:00 - 14:59:59	4847	4.6%	1.35	20.9 MB	5.8%	5.94
Jun 14 15:00:00 - 15:59:59	5467	5.2%	1.52	20.2 MB	5.7%	5.75
Jun 14 16:00:00 - 16:59:59	5446	5.2%	1.51	15.0 MB	4.2%	4.27
Jun 14 17:00:00 - 17:59:59	6159	5.9%	1.71	18.8 MB	5.3%	5.35
Jun 14 18:00:00 - 18:59:59	5937	5.6%	1.65	20.7 MB	5.8%	5.90
Jun 14 19:00:00 - 19:59:59	5467	5.2%	1.52	16.8 MB	4.7%	4.79
Jun 14 20:00:00 - 20:59:59	5313	5.1%	1.48	17.1 MB	4.8%	4.86
Jun 14 21:00:00 - 21:59:59	5418	5.2%	1.50	18.1 MB	5.1%	5.15
Jun 14 22:00:00 - 22:59:59	4949	4.7%	1.37	15.3 MB	4.3%	4.36
Jun 14 23:00:00 - 23:59:59	5026	4.8%	1.40	16.1 MB	4.5%	4.58
Jun 15 00:00:00 - 00:59:59	4594	4.4%	1.28	15.9 MB	4.5%	4.53
Jun 15 01:00:00 - 01:59:59	3926	3.7%	1.09	15.3 MB	4.3%	4.35
Jun 15 02:00:00 - 02:59:59	3142	3.0%	0.87	10.6 MB	3.0%	3.02
Jun 15 03:00:00 - 03:59:59	2886	2.7%	0.80	9.9 MB	2.8%	2.82
Jun 15 04:00:00 - 04:15:03	733	0.7%	0.81	2.7 MB	0.7%	3.03

TOTAL: 23:59:58	105147	100.0%	1.22	356.9 MB	100.0%	4.23

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

BIG81	BIG8	512.0 MB	507.0 MB	99.0%	5	0.15	41.45
BIG82	BIG8	512.0 MB	497.8 MB	97.2%	5	0.15	40.59
BIG83	BIG8	512.0 MB	511.3 MB	99.9%	5	0.16	38.01
BIG84	BIG8	512.0 MB	511.8 MB	100.0%	5	0.15	40.30
BIG85	BIG8	512.0 MB	502.4 MB	98.1%	5	0.15	39.52
BIG86	BIG8	512.0 MB	499.1 MB	97.5%	5	0.15	39.64
DE1	DE	512.0 MB	104.2 MB	20.3%	1	0.03	203.57
DE2	DE	512.0 MB	95.7 MB	18.7%	1	0.04	145.89
DE3	DE	512.0 MB	103.9 MB	20.3%	1	0.04	172.02
DE4	DE	512.0 MB	104.5 MB	20.4%	1	0.03	209.78
DE5	DE	512.0 MB	105.3 MB	20.6%	1	0.04	143.37
DE6	DE	512.0 MB	100.8 MB	19.7%	1	0.04	171.22
FTN1	FTN	512.0 MB	3.7 MB	0.7%	0	0.02	355.56
FTN2	FTN	512.0 MB	4.2 MB	0.8%	0	0.00	0.00
FTN3	FTN	512.0 MB	3.5 MB	0.7%	0	0.00	0.00
INTL1	INTL	512.0 MB	400.7 MB	78.3%	27	0.62	9.83
INTL2	INTL	512.0 MB	344.2 MB	67.2%	27	0.58	10.42
INTL3	INTL	512.0 MB	371.3 MB	72.5%	27	0.59	10.25
INTL4	INTL	512.0 MB	356.1 MB	69.6%	27	0.60	10.06
INTL5	INTL	512.0 MB	415.9 MB	81.2%	27	0.60	10.15
INTL6	INTL	512.0 MB	402.8 MB	78.7%	27	0.60	10.17

TOTAL: 21	-	10.5 GB	5.8 GB	55.3%	198	0.29	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	visyn-out.feeder.erje.net	42170	13936	6	21074	50	0	0	0	7104
2	border-2.ams.xsnews.nl	21535	2170	3	2953	39	0	0	0	16370
3	newsfeed01.sul.t-online.de	13604	5	0	6456	0	0	0	0	7143
4	feeds.phibee-telecom.net	5270	1613	0	1827	5	0	0	0	1825
5	news-out.mixmin.net	4716	72	0	2579	0	0	0	0	2065
6	news-out.aioe.org	4689	107	0	4295	0	0	0	0	287
7	newsfeeder.dynfx.net	3602	136	0	2881	79	0	0	0	506
8	news.svengo.de	949	77	0	110	0	0	0	0	762
9	news.telesweet.net	395	86	0	160	7	0	0	0	142
10	news.visyn.net	353	0	0	342	0	0	0	0	11
11	just2write2.myftp.org	219	17	0	64	3	0	0	0	135
12	?	36	0	0	0	0	0	0	0	36

TOTAL: 12		97538	18219	9	42741	183	0	0	0	36386

Unwanted newsgroups [Top 20]:

Newsgroup	Count

korea.binaries.music.mp3.high-quality	1450
alt.binaries.pictures.erotica.pregnant	1029
alt.binaries.pictures.erotic.amateur	853
alt.binaries.test	716
alt.binaries.amateurvideos	593
alt.binaries.picture.erotica.amateur.facials	364
finet.binaries.keskustelu	304
alt.binaries.pictures.erotica.erotica.gaymen	280
alt.binaries.pictures.erotic.gaymen	277
x-privat.cazzeggio	276
alt.binaries.gaymen	248
alt.binaries.photos.original	194
alt.sex.magazines.pornographic	181
alt.binaries.pictures.erotica.facial	148
alt.binaries.pictures.erotica.teen.female.oral	146
alt.binaries.picture.erotica.facials	146
alt.binaries.pictures.erotica.oral	144
alt.binaries.pictures.wallpaper	128
alt.binaries.picture.erotica.gaymale	102
alt.binaries.pictures.grotesque	90

TOTAL: 1509	18219

Unwanted distributions [Top 20]:

Distribution	Count

local	9

TOTAL: 1	9

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

Groups	Count

mailing.openbsd.source-changes	85
mailing.openbsd.ports-changes	48
mailing.gcc.gcc-cvs	24
mailing.gcc.gcc	4
alt.sysadmin.recovery	4
fido7.ru.blog.mithgol	3
clari.world.law	3
mailing.database.mysql-win32	3
mailing.unix.dovecot	3
alt.culture.taiwan	2
alt.quotations.inspirational	1
linux.debian.user.italian	1
mailing.gcc.libstdc++-cvs	1
sci.bio.evolution	1

TOTAL: 14	183

INND perl filter [Top 20]:

Reason	Count

EMP (md5)	9104
Job spam (jobcircle.com)	8802
EMP (phl)	8064
NNTP Monitor	2997
Scoring filter (8)	1354
Scoring filter (9)	1215
Scoring filter (10)	660
EMP (phn)	618
Scoring filter (11)	461
Scoring filter (12)	274
PFM bot misc	236
Scoring filter (13)	227
Angle-bracket bot	226
Scoring filter (14)	182
Poison newsgroup	165
HTML post	132
Cancel for rejected article	122
Scoring filter (15)	99
Scoring filter (16)	58
Scoring filter (17)	33

TOTAL: 35	35139

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Article posted in the future
	visyn-out.feeder.erje.net	14
	border-2.ams.xsnews.nl	3
	TOTAL: 2	17
Including strange strings
	visyn-out.feeder.erje.net	390
	newsfeed01.sul.t-online.de	182
	newsfeeder.dynfx.net	170
	news-out.aioe.org	75
	feeds.phibee-telecom.net	35
	news.svengo.de	27
	border-2.ams.xsnews.nl	23
	news-out.mixmin.net	22
	news.telesweet.net	10
	just2write2.myftp.org	7
	TOTAL: 11	948
No colon-space in header
	border-2.ams.xsnews.nl	218
	?	5
	TOTAL: 2	223

TOTAL: 3		1188

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed

1	news.visyn.net	120524	28373	63854	11621	0	0	23%	24:41:44
2	news.svengo.de	147500	1685	117706	3630	0	42	1%	25:24:12
3	just2write2.myftp.org	117008	999	100400	660	0	0	0%	24:56:34
4	feeds.phibee-telecom.net	144878	808	114287	488	1	55	0%	25:06:08
5	aioe.org	103502	401	66941	31	0	2255	0%	18:19:37
6	t-online.de	75317	382	66001	201	0	19	0%	22:25:38
7	feeder.erje.net	74280	206	67332	85	0	0	0%	25:31:53
8	news.telesweet.net	177315	132	127564	200	0	482	0%	22:44:16
9	feed.xsnews.nl	107103	111	101242	318	0	11	0%	24:00:02
10	news.mixmin.net	118139	101	92559	345	0	305	0%	22:27:10
11	newsfeeder.dynfx.net	129731	88	104056	61	0	0	0%	22:56:36

TOTAL: 11		1315297	33286	1021942	17640	1	3169	2%	258:33:50

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed

1	news.visyn.net	114.0 MB	40.3 MB	154.4 MB	1.8 KB/s	4.0 KB	24:41:44
2	feeder.erje.net	13.5 MB	6.2 MB	19.7 MB	0.2 KB/s	69.3 KB	25:31:53
3	news.svengo.de	7.9 MB	9.9 MB	17.7 MB	0.2 KB/s	3.4 KB	25:24:12
4	just2write2.myftp.org	4.3 MB	3.4 MB	7.8 MB	0.1 KB/s	4.8 KB	24:56:34
5	feeds.phibee-telecom.net	3.8 MB	1.5 MB	5.3 MB	0.1 KB/s	4.2 KB	25:06:08
6	t-online.de	2.0 MB	447.7 KB	2.4 MB	0.0 KB/s	4.2 KB	22:25:38
7	aioe.org	1.2 MB	161.3 KB	1.4 MB	0.0 KB/s	3.2 KB	18:19:37
8	news.telesweet.net	847.3 KB	2.3 MB	3.1 MB	0.0 KB/s	9.6 KB	22:44:16
9	news.mixmin.net	478.2 KB	768.9 KB	1.2 MB	0.0 KB/s	2.8 KB	22:27:10
10	newsfeeder.dynfx.net	436.8 KB	234.5 KB	671.2 KB	0.0 KB/s	4.5 KB	22:56:36
11	feed.xsnews.nl	380.9 KB	1.2 MB	1.6 MB	0.0 KB/s	3.9 KB	24:00:02

TOTAL: 11		148.8 MB	66.4 MB	215.2 MB	0.2 KB/s	4.3 KB	258:33:50

NNRP total resource statistics [Top 20]:

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

m022182.dynamic.ppp.asahi-net.or.jp	0.112	0.016	0.000	00:00:01
ppp1918.hakata16.bbiq.jp	0.124	0.008	0.000	00:00:01
cpc3-asht4-0-0-cust816.asfd.cable.ntl.com	0.600	0.048	0.000	00:00:01
fla1aaa034.szo.mesh.ad.jp	0.116	0.012	0.000	00:00:01
c-67-176-145-124.hsd1.il.comcast.net	0.116	0.020	0.000	00:00:00

TOTAL: 5	1.068	0.104	0.000	00:00:07

NNRP no permission clients:

System	Conn

cpc3-asht4-0-0-cust816.asfd.cable.ntl.com	5
m022182.dynamic.ppp.asahi-net.or.jp	1
c-67-176-145-124.hsd1.il.comcast.net	1
fla1aaa034.szo.mesh.ad.jp	1
ppp1918.hakata16.bbiq.jp	1

TOTAL: 5	9