Daily Usenet report

Aug 23 03:00:02 -- Aug 24 03:00:02

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
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 / 30 lines (16.7%)
Aug 23 05:20:11 perseus controlchan[31859]: Unknown "cmsg" control by Abow.bbs@bbs.wretch.cc
Aug 23 06:10:12 perseus controlchan[31859]: Unknown "cmsg" control by winble.bbs@bbs.wretch.cc
Aug 23 07:11:59 perseus controlchan[31859]: Unknown "cmsg" control by macaufat.bbs@bbs.cs.nthu.edu.tw
Aug 23 09:40:10 perseus controlchan[31859]: Unknown "cmsg" control by whitesun.bbs@bbs.wretch.cc
Aug 23 09:40:11 perseus controlchan[31859]: Unknown "cmsg" control by gemilay.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2176328	98.2%	192.5 MB	97.6%
nnrpd	21593	1.0%	2.2 MB	1.1%
innd	14891	0.7%	2.1 MB	1.1%
cnfsstat	2304	0.1%	401.1 KB	0.2%
controlchan	30	0.0%	3.6 KB	0.0%

TOTAL: 5	2215146	100.0%	197.2 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2151058	97.4%
Negative hits	37106	1.7%
Positive hits	15598	0.7%
Cache misses	4036	0.2%

TOTAL: 4	2207798	100.0%

INND timer:

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

article cancel	00:03:53.146	0.3%	25277	0.000	9.224	797.000
article cleanup	00:00:24.425	0.0%	2141373	0.004	0.011	0.023
article logging	00:02:00.442	0.1%	2152369	0.004	0.056	2.982
article parse	00:19:01.128	1.3%	170062477	0.005	0.007	0.017
article write	09:26:34.178	39.3%	2116194	4.062	16.064	28.498
artlog/artcncl	00:00:00.383	0.0%	24956	0.000	0.015	1.000
artlog/artparse	00:00:00.000	0.0%	19	0.000	0.000	0.000
data move	00:03:48.652	0.3%	179875452	0.001	0.001	0.002
hisgrep/artcncl	00:03:46.489	0.3%	18122	0.000	12.498	796.500
hishave/artcncl	00:00:01.516	0.0%	25277	0.000	0.060	239.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:20:19.607	1.4%	2184729	0.001	0.558	10.559
history sync	00:00:00.314	0.0%	290	0.000	1.083	3.000
history write	00:51:08.862	3.6%	2116194	0.020	1.450	12.390
hiswrite/artcncl	00:00:04.548	0.0%	7155	0.000	0.636	838.000
idle	07:42:22.011	32.1%	160774398	0.128	0.173	0.698
nntp read	00:21:07.536	1.5%	168648082	0.005	0.008	0.016
overview write	04:27:23.376	18.6%	2116194	1.088	7.581	87.813
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%	30	0.000	0.000	0.000

TOTAL: 24:00:37.962	23:41:56.613	98.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	10:29:23.044	94.8%	8718	0.000	4331.618	200187.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:16:40.450	2.5%	141552	0.000	7.068	3343.316
readart	00:00:06.515	0.0%	60	0.000	108.583	156.360

TOTAL: 11:04:03.850	10:46:10.009	97.3%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	323	2185290	2157143	14	28133	98%	479:11:48

TOTAL: 1		323	2185290	2157143	14	28133	98%	479:11:48

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	407.5 GB	11.0 MB	407.5 GB	99%	195.5 KB	479:11:48

TOTAL: 1		407.5 GB	11.0 MB	407.5 GB	99%	195.5 KB	479:11:48

Incoming articles:

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

Aug 23 03:00:02 - 03:59:59	92861	4.4%	25.81	18.0 GB	4.4%	5245.67
Aug 23 04:00:00 - 04:59:59	86812	4.1%	24.11	17.8 GB	4.4%	5191.89
Aug 23 05:00:00 - 05:59:59	87910	4.2%	24.42	17.3 GB	4.2%	5032.26
Aug 23 06:00:00 - 06:59:59	91253	4.3%	25.35	18.1 GB	4.4%	5265.49
Aug 23 07:00:00 - 07:59:59	75835	3.6%	21.07	14.8 GB	3.6%	4309.52
Aug 23 08:00:00 - 08:59:59	87217	4.1%	24.23	17.6 GB	4.3%	5120.19
Aug 23 09:00:00 - 09:59:59	83117	3.9%	23.09	16.6 GB	4.1%	4844.89
Aug 23 10:00:00 - 10:59:59	89584	4.2%	24.88	15.9 GB	3.9%	4632.67
Aug 23 11:00:00 - 11:59:59	79571	3.8%	22.10	15.8 GB	3.9%	4610.90
Aug 23 12:00:00 - 12:59:59	92232	4.4%	25.62	18.0 GB	4.4%	5242.06
Aug 23 13:00:00 - 13:59:59	95714	4.5%	26.59	19.5 GB	4.8%	5675.18
Aug 23 14:00:00 - 14:59:59	89809	4.2%	24.95	17.3 GB	4.2%	5031.76
Aug 23 15:00:00 - 15:59:59	91609	4.3%	25.45	16.8 GB	4.1%	4902.00
Aug 23 16:00:00 - 16:59:59	94179	4.5%	26.16	17.2 GB	4.2%	4996.28
Aug 23 17:00:00 - 17:59:59	87724	4.1%	24.37	17.5 GB	4.3%	5100.70
Aug 23 18:00:00 - 18:59:59	89033	4.2%	24.73	17.7 GB	4.4%	5162.35
Aug 23 19:00:00 - 19:59:59	88665	4.2%	24.63	17.3 GB	4.3%	5047.34
Aug 23 20:00:00 - 20:59:59	91636	4.3%	25.45	17.1 GB	4.2%	4971.42
Aug 23 21:00:00 - 21:59:59	86572	4.1%	24.05	16.8 GB	4.1%	4899.34
Aug 23 22:00:00 - 22:59:59	90658	4.3%	25.18	17.6 GB	4.3%	5113.51
Aug 23 23:00:00 - 23:59:59	89509	4.2%	24.86	16.3 GB	4.0%	4753.10
Aug 24 00:00:00 - 00:59:59	80455	3.8%	22.35	14.6 GB	3.6%	4238.39
Aug 24 01:00:00 - 01:59:59	84344	4.0%	23.43	14.8 GB	3.6%	4304.73
Aug 24 02:00:00 - 02:59:59	88825	4.2%	24.67	16.9 GB	4.2%	4932.91
Aug 24 03:00:00 - 03:00:02	86	0.0%	43.00	18.3 MB	0.0%	9364.08

TOTAL: 24:00:00	2115210	100.0%	24.48	407.3 GB	100.0%	4942.78

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	103.9 GB	75.4%	68	824.88	2.03
02	BIN	137.8 GB	123.0 GB	89.3%	68	817.76	2.05
03	SMALL	13.0 GB	3.0 GB	23.4%	4	4.68	33.83
04	BIN	80.1 GB	73.5 GB	91.7%	39	414.17	2.35
05	BIN	80.1 GB	67.8 GB	84.7%	59	414.62	2.34
06	SMALL	13.0 GB	3.0 GB	23.1%	4	4.65	34.04
07	BIN	80.1 GB	69.5 GB	86.8%	39	413.58	2.35
08	BIN	80.1 GB	64.6 GB	80.7%	59	414.43	2.35
09	SMALL	13.0 GB	2.8 GB	21.4%	4	4.60	34.43
10	BIN	80.1 GB	66.7 GB	83.3%	39	413.01	2.35
11	BIN	80.1 GB	68.6 GB	85.7%	59	415.38	2.34
12	SMALL	13.0 GB	3.0 GB	22.8%	4	4.64	34.06
13	BIN	80.1 GB	66.5 GB	83.0%	39	413.06	2.35
14	BIN	80.1 GB	61.1 GB	76.3%	59	414.91	2.34

TOTAL: 14	-	968.5 GB	777.2 GB	80.2%	544	356.71	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	36146	23668	0	1503	0	0	0	0	10975
2	?	19	0	0	0	0	0	0	0	19

TOTAL: 2		36165	23668	0	1503	0	0	0	0	10994

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pictures.erotica.feti	501
yu.comp.software	487
alt.binaries.sounds.mp3.industrial-noise	473
proxad.free.adsl	422
alt.sci.physics	419
alt.binaries.jerry	351
alt.binaries.pictures.erotica.asian.female	339
alt.binaries.pictures.eroctica.rape	245
alt.binaries.pictures.eroctica.torture	238
alt.binaries.pictures.erotic.unusual.object.penetrat	229
alt.binaries.games.0-day	201
alt.binaries.totally.fetish.photo	170
alt.binaries.fetish	160
alt.binaries.multimedia.bisexual	160
alt.binaries.game	147
alt.binaries.pictures.fetish.urine	123
mailing.database.pgsql-general	118
rss.fark	111
macromedia.labs.flex2.general_discussion_prerelease	110
alt.binaries.picturea.erotica	103

TOTAL: 2523	23668

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	9
	TOTAL: 1	9
Including strange strings
	192.168.33.37	10975
	TOTAL: 1	10975

TOTAL: 2		10984

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	ts27-a201.moscow.dial.rol.ru	1	25	1.3 MB	5	0	0	00:08:04
2	ts18-b219.moscow.dial.rol.ru	2	14	962.2 KB	8	0	0	00:22:04
3	194.154.66.51	3	14	1.4 MB	9	0	0	00:02:08
4	ts2-a158.syktyvkar.dial.rol.ru	2	3	342.5 KB	1	0	0	00:01:57
5	ts2-b16.syktyvkar.dial.rol.ru	1	2	195.3 KB	1	0	0	00:00:46
6	ts2-b20.syktyvkar.dial.rol.ru	1	2	217.4 KB	1	0	0	00:00:52

TOTAL: 6		10	60	4.4 MB	25	0	2	11:03:05

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.moscow.dial.rol.ru	25	39	2.3 MB	13	0	0	00:31:39
2	unresolved	62	14	1.4 MB	9	0	0	09:34:49
3	*.syktyvkar.dial.rol.ru	5	7	755.2 KB	3	0	0	00:05:46
4	*.omsk.dial.rol.ru	6	0	0.0 KB	0	0	0	00:11:46
5	*.sovintel.net	18	0	0.0 KB	0	0	0	00:00:23
6	*.ulan-ude.dial.rol.ru	16	0	0.0 KB	0	0	0	00:00:53
7	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:05
8	*.nnovgorod.dial.rol.ru	6	0	0.0 KB	0	0	0	00:00:03
9	*.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00
10	*.nsk.dial.rol.ru	39	0	0.0 KB	0	0	0	00:00:31
11	*.tyumen.dial.rol.ru	2	0	0.0 KB	0	0	0	00:02:00
12	*.sovam.com	1	0	0.0 KB	0	0	0	00:00:00
13	*.bytecity.ru	3	0	0.0 KB	0	0	0	00:00:02
14	*.tony.pp.ru	103	0	0.0 KB	0	0	0	00:04:14
15	*.rol.ru	5844	0	0.0 KB	0	0	0	00:21:24
16	*.nn.ru	30	0	0.0 KB	0	0	0	00:00:17
17	*.komi.com	1	0	0.0 KB	0	0	0	00:06:10

TOTAL: 17		6163	60	4.4 MB	25	0	1	11:01:22

NNRP total resource statistics [Top 20]:

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

194.154.66.131	0.108	0.116	0.000	09:19:44
ts18-b219.moscow.dial.rol.ru	0.052	0.032	0.000	00:22:04
194.67.5.189	0.008	0.012	0.000	00:12:55
ts2-a102.omsk.dial.rol.ru	0.084	0.112	0.000	00:11:46
balancer-a.rol.ru	3.604	3.612	0.000	00:10:49
balancer-b.rol.ru	3.520	3.704	0.000	00:10:34
ts27-a201.moscow.dial.rol.ru	0.000	0.008	0.000	00:08:04
main.komi.com	0.044	0.036	0.000	00:06:10
net1-x-ring.tony.pp.ru	0.136	0.216	0.000	00:04:14
ts2-a119.syktyvkar.dial.rol.ru	0.060	0.064	0.000	00:02:09
194.154.66.51	0.032	0.020	0.000	00:02:08
ts1-b28.tyumen.dial.rol.ru	0.000	0.000	0.000	00:02:00
ts2-a158.syktyvkar.dial.rol.ru	0.008	0.024	0.000	00:01:57
82.140.73.76	0.244	0.320	0.000	00:01:34
?	0.000	0.016	0.000	00:01:12
ts28-a8.moscow.dial.rol.ru	0.000	0.004	0.000	00:00:54
ts1-a89.ulan-ude.dial.rol.ru	0.088	0.196	0.000	00:00:53
ts2-b20.syktyvkar.dial.rol.ru	0.004	0.004	0.000	00:00:52
ts2-b16.syktyvkar.dial.rol.ru	0.000	0.000	0.000	00:00:46
ts2-a143.nsk.dial.rol.ru	0.028	0.064	0.000	00:00:31

TOTAL: 41	8.624	9.336	0.000	11:03:05

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2927
balancer-b.rol.ru	2917
net1-x-ring.tony.pp.ru	103
194.154.66.131	58
ts2-a143.nsk.dial.rol.ru	39
gray.nn.ru	30
fw-nat.sovintel.net	18
ts1-a89.ulan-ude.dial.rol.ru	16
ts27-b71.moscow.dial.rol.ru	14
ts3-a85.nnovgorod.dial.rol.ru	6
ts2-a102.omsk.dial.rol.ru	6
ts27-a237.moscow.dial.rol.ru	5
news.bytecity.ru	3
ts1-b28.tyumen.dial.rol.ru	2
keyhole.sovam.com	1
main.komi.com	1
news.lek.ru	1
ts28-a8.moscow.dial.rol.ru	1
ts2-a119.syktyvkar.dial.rol.ru	1
ts16-a147.moscow.dial.rol.ru	1

TOTAL: 23	6153

NNRP no permission clients:

System	Conn

82.140.73.76	194
87.245.178.164	30
ppp91-76-7-83.pppoe.mtu-net.ru	5
29-7.kartel.komi.com	4
88.87.82.120	2
81.25.174.19	2
80.92.212.191	2
80.70.236.40	2
cornholio.migtel.ru	2
195.28.36.242	1
83.220.64.26	1
236-040.nat.mns.ru	1

TOTAL: 12	246

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	23

TOTAL: 1	23

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	6	0
ts18-b219.moscow.dial.rol.ru	1	0
ts2-a102.omsk.dial.rol.ru	1	0
194.67.5.189	1	0

TOTAL: 4	9	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	8604	100.0%

TOTAL: 1		8604	100.0%

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

Newsgroup		Count

1	alt.binaries.erotica.breasts	4598
2	alt.binaries.pictures.erotica.wetspot	2150
3	alt.binaries.pictures.bras	868
4	alt.binaries.pictures.artpics	604
5	alt.binaries.pictures.bikini.central	324
6	alt.binaries.pictures.lolita	29
7	alt.binaries.pictures.erotica.alt.sex	12
8	alt.binaries.erotica.pregnant	5
9	alt.binaries.nospam.female.bodyhair	4
10	alt.binaries.picture.erotica.alt.sex	4
11	alt.binaries.nospam.incest	3
12	alt.binaries.nospam.female.bodyhair.pubes	3

TOTAL: 12		8604