Daily Usenet report

Oct 29 03:00:04 -- Oct 30 03:00:04

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
Newsgroups created
Control Channel
Incoming Feeds (INN)
Incoming Volume (INN)
Incoming articles
CNFS buffer status
Sites sending bad articles
Unwanted newsgroups
Miscellaneous innd statistics
NNRP readership statistics
NNRP readership statistics (by domain)
NNRP total resource statistics
Curious NNRP server explorers
NNRP no permission clients
NNRP gethostbyaddr failures
NNRP client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 5 / 58 lines (8.6%)
Oct 29 04:00:34 perseus controlchan[29156]: Unknown "cmsg" control by maxell.bbs@bbs.wretch.cc
Oct 29 04:00:35 perseus controlchan[29156]: Unknown "cmsg" control by yauer.bbs@bbs.wretch.cc
Oct 29 05:40:23 perseus controlchan[29156]: Unknown "cmsg" control by purplesky.bbs@bbs.wretch.cc
Oct 29 06:30:28 perseus controlchan[29156]: Unknown "cmsg" control by gogogohuang.bbs@bbs.wretch.cc
Oct 29 06:30:31 perseus controlchan[29156]: Unknown "cmsg" control by gogogohuang.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2256758	98.3%	197.9 MB	97.7%
nnrpd	19569	0.9%	2.0 MB	1.0%
innd	16066	0.7%	2.3 MB	1.1%
cnfsstat	2304	0.1%	399.8 KB	0.2%
controlchan	74	0.0%	8.0 KB	0.0%

TOTAL: 5	2294771	100.0%	202.5 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2234195	97.3%
Negative hits	44401	1.9%
Positive hits	15452	0.7%
Cache misses	2394	0.1%

TOTAL: 4	2296442	100.0%

INND timer:

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

article cancel	00:01:24.082	0.1%	20339	0.000	4.134	831.500
article cleanup	00:00:25.402	0.0%	2229116	0.004	0.011	0.021
article logging	00:02:37.131	0.2%	2236502	0.004	0.070	4.930
article parse	00:19:41.520	1.4%	167565331	0.005	0.007	0.149
article write	10:23:41.970	43.3%	2197919	2.936	17.026	30.586
artlog/artcncl	00:00:01.583	0.0%	20172	0.000	0.078	585.000
artlog/artparse	00:00:00.003	0.0%	67	0.000	0.045	1.000
data move	00:03:50.917	0.3%	177338247	0.001	0.001	0.008
hisgrep/artcncl	00:01:21.064	0.1%	16777	0.000	4.832	1663.000
hishave/artcncl	00:00:00.905	0.0%	20339	0.000	0.044	50.688
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:12:02.076	0.8%	2276978	0.000	0.317	7.971
history sync	00:00:00.308	0.0%	293	0.000	1.051	3.000
history write	00:54:33.945	3.8%	2197919	0.032	1.490	13.655
hiswrite/artcncl	00:00:00.363	0.0%	3562	0.000	0.102	15.000
idle	06:58:17.917	29.0%	157355887	0.048	0.159	0.498
nntp read	00:21:40.968	1.5%	165931760	0.006	0.008	0.094
overview write	04:19:48.686	18.0%	2197919	0.837	7.092	251.874
perl filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.000	0.0%	63	0.000	0.000	0.000

TOTAL: 24:00:00.333	23:39:28.840	98.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:39:04.000	3.0%	141411	0.000	16.576	70.235
idle	15:37:57.396	71.1%	291601	0.000	192.995	200133.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	02:09:34.031	9.8%	1106247	0.000	7.027	170924.444
readart	02:04:52.534	9.5%	297045	0.000	25.224	306.000

TOTAL: 22:00:03.922	20:31:27.961	93.3%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Newsgroups created:

Group	Mode

comp.file-sharing.bittorrent	y
comp.internet.services.blog.livejournal	y
comp.internet.services.google	y
comp.internet.services.social.myspace	y
comp.internet.services.video.youtube	y
misc.phone.mobile	y
misc.phone.mobile.iphone	y
rec.arts.tv.news.oreilly-factor	y

TOTAL	8

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

group-admin@isc.org	8	0	0	0	8	8

TOTAL	8	0	0	0	8	8

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	344	2233859	2201779	370	31710	98%	469:55:09

TOTAL: 1		344	2233859	2201779	370	31710	98%	469:55:09

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	420.1 GB	145.3 MB	420.3 GB	99%	197.3 KB	469:55:09

TOTAL: 1		420.1 GB	145.3 MB	420.3 GB	99%	197.3 KB	469:55:09

Incoming articles:

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

Oct 29 03:00:04 - 03:59:59	90695	4.1%	25.22	18.3 GB	4.4%	5339.73
Oct 29 04:00:00 - 04:59:59	88939	4.0%	24.71	17.8 GB	4.3%	5199.04
Oct 29 05:00:00 - 05:59:59	87384	4.0%	24.27	16.8 GB	4.0%	4879.07
Oct 29 06:00:00 - 06:59:59	81658	3.7%	22.68	15.5 GB	3.7%	4521.04
Oct 29 07:00:00 - 07:59:59	90352	4.1%	25.10	16.8 GB	4.0%	4903.81
Oct 29 08:00:00 - 08:59:59	92900	4.2%	25.81	14.9 GB	3.5%	4330.81
Oct 29 09:00:00 - 09:59:59	90003	4.1%	25.00	17.5 GB	4.2%	5098.25
Oct 29 10:00:00 - 10:59:59	80423	3.7%	22.34	16.1 GB	3.8%	4694.15
Oct 29 11:00:00 - 11:59:59	88022	4.0%	24.45	17.9 GB	4.3%	5203.71
Oct 29 12:00:00 - 12:59:59	87464	4.0%	24.30	17.2 GB	4.1%	5016.52
Oct 29 13:00:00 - 13:59:59	87342	4.0%	24.26	16.6 GB	4.0%	4830.12
Oct 29 14:00:00 - 14:59:59	88854	4.0%	24.68	16.5 GB	3.9%	4792.65
Oct 29 15:00:00 - 15:59:59	89579	4.1%	24.88	16.3 GB	3.9%	4736.89
Oct 29 16:00:00 - 16:59:59	90244	4.1%	25.07	16.6 GB	4.0%	4826.48
Oct 29 17:00:00 - 17:59:59	91675	4.2%	25.47	17.7 GB	4.2%	5159.18
Oct 29 18:00:00 - 18:59:59	97841	4.5%	27.18	18.6 GB	4.4%	5428.33
Oct 29 19:00:00 - 19:59:59	94369	4.3%	26.21	18.1 GB	4.3%	5259.38
Oct 29 20:00:00 - 20:59:59	96586	4.4%	26.83	18.7 GB	4.5%	5432.40
Oct 29 21:00:00 - 21:59:59	98068	4.5%	27.24	19.2 GB	4.6%	5585.98
Oct 29 22:00:00 - 22:59:59	100500	4.6%	27.92	18.9 GB	4.5%	5497.72
Oct 29 23:00:00 - 23:59:59	99123	4.5%	27.53	18.5 GB	4.4%	5400.56
Oct 30 00:00:00 - 00:59:59	95576	4.3%	26.55	17.3 GB	4.1%	5032.13
Oct 30 01:00:00 - 01:59:59	97673	4.4%	27.13	19.1 GB	4.6%	5573.52
Oct 30 02:00:00 - 02:59:59	92579	4.2%	25.72	18.2 GB	4.3%	5306.28
Oct 30 03:00:00 - 03:00:04	86	0.0%	21.50	16.4 MB	0.0%	4202.14

TOTAL: 24:00:00	2197935	100.0%	25.44	419.0 GB	100.0%	5085.27

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	16.6 GB	12.1%	102	810.90	2.06
02	BIN	137.8 GB	60.6 GB	44.0%	102	809.15	2.07
03	SMALL	13.0 GB	8.5 GB	65.2%	6	5.65	28.01
04	BIN	80.1 GB	53.7 GB	67.0%	68	425.70	2.28
05	BIN	80.1 GB	60.0 GB	75.0%	88	427.24	2.28
06	SMALL	13.0 GB	8.5 GB	65.0%	6	5.65	28.01
07	BIN	80.1 GB	43.8 GB	54.7%	68	424.75	2.29
08	BIN	80.1 GB	51.4 GB	64.2%	88	426.58	2.28
09	SMALL	13.0 GB	8.1 GB	62.1%	6	5.60	28.23
10	BIN	80.1 GB	36.5 GB	45.6%	68	424.42	2.29
11	BIN	80.1 GB	65.0 GB	81.1%	88	427.73	2.27
12	SMALL	13.0 GB	8.4 GB	64.5%	6	5.66	27.96
13	BIN	80.1 GB	34.7 GB	43.3%	68	424.06	2.29
14	BIN	80.1 GB	48.1 GB	60.1%	88	426.46	2.28

TOTAL: 14	-	968.5 GB	504.0 GB	52.0%	852	364.47	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	38583	30473	0	699	0	0	0	0	7411
2	?	67	0	0	0	0	0	0	0	67

TOTAL: 2		38650	30473	0	699	0	0	0	0	7478

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.	4555
microsoft.public.test	1203
cuhk.society.bhall	348
alt.binaries.pictures.erotica.asian.female	274
alt.binaries.pictures.erotica.exhibionism	202
alt.biniaries.erotica	201
alt.binaries.pictures.erotica.nipples	198
pedo.japanese.fetish.lolita	176
alt.binaries.pictures.erotica.voyerism	176
alt.binaries.pictures.erotica.voyeurism.hidden-cam	176
alt.binaries.sandra.model	169
alt.binaries.pictures.erotica.erotica.gaymen	160
alt.binaries.pictures.erotica.breasts.sm	157
alt.binaries.pictures.erotica.erotic	154
stu.virus	150
alt.binaries.pictures.erotica.breast.large	149
alt.binaries.pictures.erotica.goo-shot	142
alt.binaries.erotic.female	140
alt.binaires.pictures.erotica.amatuer.female	138
alt.binaries.erotica.pictures.tasteless	137

TOTAL: 2239	30473

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	7386
	TOTAL: 1	7386

TOTAL: 1		7386

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	20	141396	14.7 GB	57	0	0	16:32:09
2	ts1-a47.saratov.dial.rol.ru	4	468	1011.4 KB	3	0	0	00:50:07
3	news.lek.ru	2	78	6.4 MB	3	0	0	00:09:51
4	news.pcs-net.net	11	55	8.9 MB	6	0	0	01:43:52
5	ts3-b166.voronezh.dial.rol.ru	17	43	877.0 KB	11	0	0	00:22:22
6	ts2-a93.syktyvkar.dial.rol.ru	1	25	589.9 KB	1	0	0	00:03:00
7	ts30-a175.moscow.dial.rol.ru	12	24	1.5 MB	4	0	0	01:21:17
8	ts2-b109.syktyvkar.dial.rol.ru	1	23	614.2 KB	1	0	0	00:03:11
9	ts2-b160.syktyvkar.dial.rol.ru	1	19	560.9 KB	1	0	0	00:02:29
10	ts2-a240.syktyvkar.dial.rol.ru	2	19	627.9 KB	2	0	0	00:04:32
11	ts2-b47.syktyvkar.dial.rol.ru	3	3	427.9 KB	1	0	0	00:13:43

TOTAL: 11		74	142153	14.7 GB	90	0	0	21:59:24

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	20	141396	14.7 GB	57	0	0	16:32:09
2	*.saratov.dial.rol.ru	4	468	1011.4 KB	3	0	0	00:50:07
3	*.syktyvkar.dial.rol.ru	8	89	2.8 MB	6	0	0	00:26:57
4	*.lek.ru	2	78	6.4 MB	3	0	0	00:09:51
5	*.pcs-net.net	11	55	8.9 MB	6	0	0	01:43:52
6	*.voronezh.dial.rol.ru	17	43	877.0 KB	11	0	0	00:22:22
7	*.moscow.dial.rol.ru	25	24	1.5 MB	4	0	0	01:21:38
8	*.sovintel.net	21	0	0.0 KB	0	0	0	00:00:50
9	*.nsk.dial.rol.ru	13	0	0.0 KB	0	0	0	00:00:14
10	*.bytecity.ru	3	0	0.0 KB	0	0	0	00:00:00
11	unresolved	2	0	0.0 KB	0	0	0	00:04:24
12	*.tony.pp.ru	85	0	0.0 KB	0	0	0	00:04:05
13	*.rol.ru	5787	0	0.0 KB	0	0	0	00:20:57
14	*.nn.ru	35	0	0.0 KB	0	0	0	00:00:19

TOTAL: 14		6033	142153	14.7 GB	90	0	0	21:59:15

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	68.160	633.634	0.000	16:32:09
news.pcs-net.net	0.172	0.168	0.000	01:43:52
ts30-a175.moscow.dial.rol.ru	0.024	0.056	0.000	01:21:17
ts1-a47.saratov.dial.rol.ru	0.040	0.092	0.000	00:50:07
ts3-b166.voronezh.dial.rol.ru	0.036	0.036	0.000	00:22:22
ts2-b47.syktyvkar.dial.rol.ru	0.024	0.036	0.000	00:13:43
balancer-a.rol.ru	3.528	3.732	0.000	00:11:02
balancer-b.rol.ru	3.604	3.564	0.000	00:09:55
news.lek.ru	0.148	0.140	0.000	00:09:51
ts2-a240.syktyvkar.dial.rol.ru	0.000	0.016	0.000	00:04:32
194.154.66.183	0.028	0.012	0.000	00:04:24
net1-x-ring.tony.pp.ru	0.120	0.172	0.000	00:04:05
ts2-b109.syktyvkar.dial.rol.ru	0.000	0.008	0.000	00:03:11
ts2-a93.syktyvkar.dial.rol.ru	0.004	0.004	0.000	00:03:00
ts2-b160.syktyvkar.dial.rol.ru	0.012	0.004	0.000	00:02:29
?	0.028	0.020	0.000	00:01:22
fw-nat.sovintel.net	0.344	0.160	0.000	00:00:50
gray.nn.ru	0.056	0.064	0.000	00:00:19
ts2-a80.nsk.dial.rol.ru	0.028	0.012	0.000	00:00:14
ts16-b247.moscow.dial.rol.ru	0.000	0.000	0.000	00:00:10

TOTAL: 30	76.464	642.138	0.000	21:59:24

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2904
balancer-a.rol.ru	2883
net1-x-ring.tony.pp.ru	85
gray.nn.ru	35
fw-nat.sovintel.net	21
ts2-a80.nsk.dial.rol.ru	13
ts23-b236.moscow.dial.rol.ru	5
ts27-a253.moscow.dial.rol.ru	4
ts27-b204.moscow.dial.rol.ru	3
news.bytecity.ru	3
194.154.66.183	2
ts16-b247.moscow.dial.rol.ru	1

TOTAL: 12	5959

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	83
echo472.server4you.de	3
81.25.174.19	2
83.220.64.28	2
245-167.79-83.cust.bluewin.ch	1
ppp85-140-210-169.pppoe.mtu-net.ru	1

TOTAL: 6	92

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	22

TOTAL: 1	22

NNRP client timeouts [Top 20]:

System	Conn	Peer

news.pcs-net.net	6	0
ts2-b47.syktyvkar.dial.rol.ru	1	0
ts3-b166.voronezh.dial.rol.ru	1	0
ts2-a240.syktyvkar.dial.rol.ru	1	0

TOTAL: 4	9	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	142275	99.7%
2	fido7	468	0.3%
3	japan2nd	15	0.0%
4	hr	9	0.0%

TOTAL: 4		142767	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	121232
2	alt.binaries.pictures.artpics	12221
3	alt.binaries.pictures.bras	8557
4	fido7.ru.linux	328
5	fido7.ru.unix	140
6	alt.binaries.nospam.female.bodyhair	89
7	alt.binaries.pictures.vladmodels	48
8	alt.binaries.picture.erotica.lesbians	34
9	alt.binaries.pictures.erotica.bisexuals	25
10	alt.penthouse.sex.femdom	24
11	alt.binaries.pictures.erotic.asian.porn	19
12	alt.christnet.sex.fetish.fat.furry	16
13	japan2nd.binaries.pictures.erotica.lolita	15
14	hr.talk.razno	9
15	alt.binaries.pictures.sandra	7
16	alt.christnet.sex.fetish.fat.furry.asian.watersports	2
17	alt.christnet.sex.fetish.fat	1

TOTAL: 17		142767