Daily Usenet report

Oct 12 03:00:09 -- Oct 13 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 / 89 lines (5.6%)
Oct 12 05:55:56 perseus controlchan[26149]: Unknown "cmsg" control by j8902.bbs@bbs.wretch.cc
Oct 12 05:57:29 perseus controlchan[26149]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Oct 12 05:58:54 perseus controlchan[26149]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Oct 12 06:00:14 perseus controlchan[26149]: Unknown "cmsg" control by maxell.bbs@bbs.wretch.cc
Oct 12 06:03:47 perseus controlchan[26149]: Unknown "cmsg" control by anor94216.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2421747	98.4%	210.9 MB	97.8%
nnrpd	20218	0.8%	2.1 MB	1.0%
innd	16575	0.7%	2.3 MB	1.1%
cnfsstat	2304	0.1%	401.0 KB	0.2%
controlchan	97	0.0%	11.6 KB	0.0%
expireover	1	0.0%	0.2 KB	0.0%

TOTAL: 6	2460942	100.0%	215.7 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2332156	94.9%
Positive hits	79206	3.2%
Negative hits	40869	1.7%
Cache misses	5169	0.2%

TOTAL: 4	2457400	100.0%

INND timer:

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

article cancel	00:01:03.772	0.1%	85509	0.000	0.746	1624.000
article cleanup	00:00:25.963	0.0%	2323931	0.003	0.011	0.023
article logging	00:02:00.745	0.1%	2402506	0.003	0.050	5.108
article parse	00:19:36.270	1.4%	166532137	0.005	0.007	0.025
article write	10:34:57.380	44.1%	2296044	2.869	16.593	36.839
artlog/artcncl	00:00:01.895	0.0%	19416	0.000	0.098	5.458
artlog/artparse	00:00:00.000	0.0%	74	0.000	0.000	0.000
data move	00:03:50.229	0.3%	176239392	0.001	0.001	0.003
hisgrep/artcncl	00:00:57.671	0.1%	84535	0.000	0.682	1624.000
hishave/artcncl	00:00:02.054	0.0%	85509	0.000	0.024	37.455
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:09:31.564	0.7%	2373767	0.001	0.241	6.789
history sync	00:00:00.304	0.0%	291	0.000	1.045	8.000
history write	00:48:35.831	3.4%	2296044	0.028	1.270	14.634
hiswrite/artcncl	00:00:01.844	0.0%	974	0.000	1.893	835.000
idle	06:40:00.288	27.8%	156090846	0.128	0.154	0.383
nntp read	00:21:29.671	1.5%	164765443	0.006	0.008	0.021
overview write	04:35:23.538	19.1%	2296044	1.099	7.197	123.197
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.001	0.0%	90	0.000	0.011	1.000

TOTAL: 23:59:30.629	23:37:59.020	98.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:07:15.453	0.6%	30996	0.000	14.049	39.218
idle	18:01:03.741	87.7%	73626	0.000	880.990	295836.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:28:02.572	7.1%	392259	0.000	13.467	5259.615
readart	00:18:42.986	1.5%	63809	0.000	17.599	606.000

TOTAL: 20:32:44.043	19:55:04.752	96.9%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Newsgroups created:

Group	Mode

comp.internet.services.wiki	y
rec.arts.tv.comedy.the-office	y
rec.media.players.portable	y
rec.media.players.portable.ipod	y

TOTAL	4

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

fwbrown@bellsouth.net	1	0	0	0	0	1
group-admin@isc.org	4	0	0	0	4	4

TOTAL	5	0	0	0	4	5

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	319	2380601	2351588	3	29010	98%	483:03:13

TOTAL: 1		319	2380601	2351588	3	29010	98%	483:03:13

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	414.4 GB	5.2 MB	414.4 GB	99%	182.5 KB	483:03:13

TOTAL: 1		414.4 GB	5.2 MB	414.4 GB	99%	182.5 KB	483:03:13

Incoming articles:

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

Oct 12 03:00:09 - 03:59:59	113668	5.0%	31.65	16.0 GB	3.8%	4684.48
Oct 12 04:00:00 - 04:59:59	89898	3.9%	24.97	17.3 GB	4.1%	5033.36
Oct 12 05:00:00 - 05:59:59	89159	3.9%	24.77	17.0 GB	4.0%	4942.54
Oct 12 06:00:00 - 06:59:59	84917	3.7%	23.59	15.4 GB	3.7%	4490.28
Oct 12 07:00:00 - 07:59:59	89109	3.9%	24.75	16.1 GB	3.8%	4689.02
Oct 12 08:00:00 - 08:59:59	90971	4.0%	25.27	17.0 GB	4.1%	4959.21
Oct 12 09:00:00 - 09:59:59	84900	3.7%	23.58	16.1 GB	3.8%	4692.05
Oct 12 10:00:00 - 10:59:59	84911	3.7%	23.59	16.3 GB	3.9%	4740.76
Oct 12 11:00:00 - 11:59:59	89150	3.9%	24.76	16.7 GB	4.0%	4867.65
Oct 12 12:00:00 - 12:59:59	97458	4.2%	27.07	18.6 GB	4.4%	5407.30
Oct 12 13:00:00 - 13:59:59	101747	4.4%	28.26	18.2 GB	4.3%	5303.32
Oct 12 14:00:00 - 14:59:59	103877	4.5%	28.85	18.8 GB	4.5%	5468.06
Oct 12 15:00:00 - 15:59:59	97553	4.2%	27.10	17.0 GB	4.1%	4946.09
Oct 12 16:00:00 - 16:59:59	100169	4.4%	27.82	17.1 GB	4.1%	4975.89
Oct 12 17:00:00 - 17:59:59	95821	4.2%	26.62	17.5 GB	4.2%	5091.70
Oct 12 18:00:00 - 18:59:59	100422	4.4%	27.89	18.1 GB	4.3%	5269.18
Oct 12 19:00:00 - 19:59:59	96414	4.2%	26.78	18.5 GB	4.4%	5402.51
Oct 12 20:00:00 - 20:59:59	99708	4.3%	27.70	18.6 GB	4.4%	5430.63
Oct 12 21:00:00 - 21:59:59	101678	4.4%	28.24	19.2 GB	4.6%	5578.92
Oct 12 22:00:00 - 22:59:59	99858	4.3%	27.74	18.2 GB	4.3%	5305.57
Oct 12 23:00:00 - 23:59:59	102678	4.5%	28.52	18.6 GB	4.4%	5420.25
Oct 13 00:00:00 - 00:59:59	89601	3.9%	24.89	16.6 GB	4.0%	4831.99
Oct 13 01:00:00 - 01:59:59	96319	4.2%	26.76	17.9 GB	4.3%	5213.47
Oct 13 02:00:00 - 02:59:59	96159	4.2%	26.71	18.4 GB	4.4%	5360.41
Oct 13 03:00:00 - 03:00:04	113	0.0%	28.25	21.9 MB	0.0%	5603.25

TOTAL: 23:59:55	2296258	100.0%	26.58	419.2 GB	100.0%	5087.76

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	81.9 GB	59.4%	93	829.45	2.02
02	BIN	137.8 GB	119.5 GB	86.7%	93	850.82	1.97
03	SMALL	13.0 GB	12.7 GB	97.5%	5	5.25	30.13
04	BIN	80.1 GB	25.8 GB	32.2%	61	426.68	2.28
05	BIN	80.1 GB	29.3 GB	36.6%	81	429.30	2.26
06	SMALL	13.0 GB	12.7 GB	97.2%	5	5.22	30.32
07	BIN	80.1 GB	17.5 GB	21.8%	61	424.88	2.29
08	BIN	80.1 GB	22.1 GB	27.6%	81	428.41	2.27
09	SMALL	13.0 GB	12.3 GB	94.7%	5	5.20	30.45
10	BIN	80.1 GB	11.1 GB	13.9%	61	424.45	2.29
11	BIN	80.1 GB	33.0 GB	41.3%	81	429.67	2.26
12	SMALL	13.0 GB	12.6 GB	96.8%	5	5.22	30.32
13	BIN	80.1 GB	9.7 GB	12.1%	61	424.29	2.29
14	BIN	80.1 GB	18.5 GB	23.1%	81	427.12	2.28

TOTAL: 14	-	968.5 GB	418.7 GB	43.2%	774	366.59	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	106229	27578	0	290	0	0	0	0	78361
2	?	74	0	0	0	0	0	0	0	74

TOTAL: 2		106303	27578	0	290	0	0	0	0	78435

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.erotica.freckles	521
alt.binaries.pictures.amateur.butts	469
alt.pedophilia	454
alt.binaries.fetish	260
alt.binaries.pictures.erotica.fetish.urine	247
alt.binaries.multimedia.bisexual	242
alt.binaries.totally.fetish.photo	242
cn.bbs.soc.railway	235
pedo.japanese.fetish.lolita	223
alt.biniaries.erotica	211
alt.binaries.pictures.erotica.asian.female	196
cakewalk.coffeehouse	195
alt.binaries.pictures.erotica.voyeuris	160
alt.binaries.pictures.pictures.erotica	159
alt.binaries.pictures.erotica.voyerism	158
alt.binaries.picutures.erotica	156
alt.binaries.pictures.fetish.urine	152
alt.binaries.pictures.erotica.gay	147
alt.binaries.pictures.erotica.latinos	147
alt.binaries.pictures.erotica.india	146

TOTAL: 2321	27578

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	32
	TOTAL: 1	32
Including strange strings
	192.168.33.37	78350
	TOTAL: 1	78350

TOTAL: 2		78382

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	5	30995	1020.5 MB	18	0	0	13:45:24
2	news.lek.ru	3	131	8.4 MB	4	0	0	00:08:30
3	ts16-a198.moscow.dial.rol.ru	1	96	7.0 MB	1	0	0	01:05:20
4	194.67.5.187	9	62	2.4 MB	9	0	0	01:15:17
5	ts30-b2.moscow.dial.rol.ru	12	39	2.9 MB	6	0	0	00:42:34
6	ts1-a46.krasnodar.dial.rol.ru	22	17	28.2 KB	10	0	0	01:14:22
7	ts2-a190.syktyvkar.dial.rol.ru	5	8	667.2 KB	1	0	0	00:25:33
8	ts2-a19.syktyvkar.dial.rol.ru	1	4	242.8 KB	1	0	0	00:01:07
9	ts2-a138.syktyvkar.dial.rol.ru	2	4	341.8 KB	2	0	0	00:01:33
10	ts1-a53.saratov.dial.rol.ru	1	3	5.8 KB	1	0	0	01:08:47

TOTAL: 10		61	31359	1.0 GB	53	0	2	20:32:00

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	5	30995	1020.5 MB	18	0	0	13:45:24
2	*.moscow.dial.rol.ru	23	135	9.9 MB	7	0	0	01:48:02
3	*.lek.ru	3	131	8.4 MB	4	0	0	00:08:30
4	unresolved	21	62	2.4 MB	9	0	0	01:17:09
5	*.krasnodar.dial.rol.ru	22	17	28.2 KB	10	0	0	01:14:22
6	*.syktyvkar.dial.rol.ru	8	16	1.2 MB	4	0	0	00:28:14
7	*.saratov.dial.rol.ru	1	3	5.8 KB	1	0	0	01:08:47
8	*.sovintel.net	11	0	0.0 KB	0	0	0	00:00:16
9	*.bryansk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:16
10	*.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00
11	*.nsk.dial.rol.ru	20	0	0.0 KB	0	0	0	00:00:33
12	*.dynadsl.kis.ru	3	0	0.0 KB	0	0	0	00:11:19
13	*.bytecity.ru	1	0	0.0 KB	0	0	0	00:00:02
14	*.tony.pp.ru	65	0	0.0 KB	0	0	0	00:02:44
15	*.rol.ru	5810	0	0.0 KB	0	0	0	00:22:27
16	*.nn.ru	60	0	0.0 KB	0	0	0	00:00:22

TOTAL: 16		6055	31359	1.0 GB	53	0	1	20:30:26

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	20.556	180.216	0.000	13:45:24
194.67.5.187	0.332	0.600	0.000	01:15:17
ts1-a46.krasnodar.dial.rol.ru	0.136	0.168	0.000	01:14:22
ts1-a53.saratov.dial.rol.ru	0.092	0.128	0.000	01:08:47
ts16-a198.moscow.dial.rol.ru	0.008	0.044	0.000	01:05:20
ts30-b2.moscow.dial.rol.ru	0.020	0.052	0.000	00:42:34
ts2-a190.syktyvkar.dial.rol.ru	0.020	0.012	0.000	00:25:33
balancer-a.rol.ru	3.556	3.696	0.000	00:11:39
dyn-19-140.dynadsl.kis.ru	0.120	0.164	0.000	00:11:19
balancer-b.rol.ru	3.640	3.680	0.000	00:10:47
news.lek.ru	0.080	0.132	0.000	00:08:30
net1-x-ring.tony.pp.ru	0.156	0.112	0.000	00:02:44
?	0.016	0.032	0.000	00:01:51
212.46.202.145	0.000	0.020	0.000	00:01:34
ts2-a138.syktyvkar.dial.rol.ru	0.004	0.008	0.000	00:01:33
82.140.73.76	0.228	0.284	0.000	00:01:25
ts2-a19.syktyvkar.dial.rol.ru	0.008	0.000	0.000	00:01:07
ts2-b202.nsk.dial.rol.ru	0.008	0.032	0.000	00:00:33
gray.nn.ru	0.088	0.136	0.000	00:00:22
212.46.236.218	0.012	0.032	0.000	00:00:17

TOTAL: 33	29.180	189.660	0.000	20:32:00

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2922
balancer-a.rol.ru	2888
net1-x-ring.tony.pp.ru	65
gray.nn.ru	60
ts2-b202.nsk.dial.rol.ru	20
fw-nat.sovintel.net	11
212.46.236.218	11
ts23-a43.moscow.dial.rol.ru	10
dyn-19-140.dynadsl.kis.ru	3
212.46.202.145	1
ts2-a84.bryansk.dial.rol.ru	1
ns1.lavtech.ru	1
news.bytecity.ru	1

TOTAL: 13	5994

NNRP no permission clients:

System	Conn

82.140.73.76	148
cornholio.migtel.ru	5
pppoe-198.9.110.89-adsl.spbnit.ru	5
host-212-145-66-217.spbmts.ru	2
82-208-101-228.dialup.mts-nn.ru	2
83.237.145.79	2
host-219-145-66-217.spbmts.ru	1
83.220.64.40	1
83.220.64.22	1

TOTAL: 9	167

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	32

TOTAL: 1	32

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a190.syktyvkar.dial.rol.ru	2	0
ts30-b2.moscow.dial.rol.ru	2	0
ts1-a46.krasnodar.dial.rol.ru	2	0
ts1-a53.saratov.dial.rol.ru	1	0
dyn-19-140.dynadsl.kis.ru	1	0

TOTAL: 5	8	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	30291	100.0%
2	fido7	3	0.0%
3	microsoft	2	0.0%
4	hr	1	0.0%

TOTAL: 4		30297	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	24333
2	alt.binaries.pictures.bras	3062
3	alt.binaries.pictures.artpics	2538
4	alt.sex.pantyhose	96
5	alt.binaries.picture.erotica.lesbians	96
6	alt.binaries.pictures.erotica	62
7	alt.binaries.pictures.erotica.bisexuals	35
8	alt.sex.binaries.erotica.teen	21
9	alt.binaires.pictures.erotica.teen.female	17
10	alt.binaries.nospam.female.bodyhair	10
11	alt.certification.cisco	9
12	alt.binaries.nospam.female.bodyhair.pubes	6
13	alt.tv.vr5	6
14	fido7.ru.linux	3
15	microsoft.public.cert.exam.mcsa	2
16	hr.rec.humor.best-of-usenet	1

TOTAL: 16		30297