Daily Usenet report

Sep 5 03:00:06 -- Sep 6 03:00:09

Log entries by program
History cache
INND 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
INND misc events
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 / 69 lines (7.2%)
Sep 5 03:20:11 perseus controlchan[28453]: Unknown "cmsg" control by ukailin.bbs@bbs.wretch.cc
Sep 5 05:00:31 perseus controlchan[28453]: Unknown "cmsg" control by jjosh.bbs@bbs.wretch.cc
Sep 5 06:00:19 perseus controlchan[28453]: Unknown "cmsg" control by darkdh.bbs@bbs.wretch.cc
Sep 5 06:00:19 perseus controlchan[28453]: Unknown "cmsg" control by gohometc.bbs@bbs.wretch.cc
Sep 5 06:00:19 perseus controlchan[28453]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2290570	97.9%	201.9 MB	97.3%
innd	25575	1.1%	3.1 MB	1.5%
nnrpd	20653	0.9%	2.0 MB	1.0%
cnfsstat	2304	0.1%	398.4 KB	0.2%
controlchan	73	0.0%	8.0 KB	0.0%
expireover	1	0.0%	0.1 KB	0.0%

TOTAL: 6	2339176	100.0%	207.4 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2281524	97.6%
Negative hits	50995	2.2%
Positive hits	2771	0.1%
Cache misses	2510	0.1%

TOTAL: 4	2337800	100.0%

INND timer:

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

article cancel	00:02:02.170	0.1%	16314	0.000	7.489	1676.000
article cleanup	00:00:25.455	0.0%	2258713	0.003	0.011	0.021
article logging	00:02:25.646	0.2%	2275647	0.004	0.064	4.843
article parse	00:19:43.741	1.4%	162132613	0.005	0.007	0.033
article write	10:46:51.881	44.9%	2232569	4.070	17.384	340.331
artlog/artcncl	00:00:03.145	0.0%	15513	0.000	0.203	71.000
artlog/artparse	00:00:00.000	0.0%	31	0.000	0.000	0.000
data move	00:03:46.469	0.3%	171604379	0.001	0.001	0.003
hisgrep/artcncl	00:01:53.433	0.1%	4999	0.000	22.691	1676.000
hishave/artcncl	00:00:03.639	0.0%	16314	0.000	0.223	171.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:22:17.210	1.5%	2323581	0.001	0.575	12.956
history sync	00:00:00.356	0.0%	290	0.000	1.228	46.000
history write	00:57:22.418	4.0%	2232569	0.035	1.542	12.808
hiswrite/artcncl	00:00:01.856	0.0%	11315	0.000	0.164	24.000
idle	06:05:21.014	25.4%	151335042	0.127	0.145	0.754
nntp read	00:21:32.574	1.5%	160273793	0.005	0.008	0.029
overview write	04:36:07.553	19.2%	2232569	1.602	7.421	109.060
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%	68	0.000	0.000	0.000

TOTAL: 24:00:28.691	23:39:58.560	98.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:13:38.000	1.0%	37036	0.000	22.087	60.229
idle	21:19:56.318	91.8%	83917	0.000	915.146	200291.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:31:16.523	2.2%	408210	0.000	4.597	5811.000
readart	00:25:15.036	1.8%	77454	0.000	19.560	481.000

TOTAL: 23:13:41.713	22:30:05.877	96.9%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

Neo@whatisthematrix.real	0	0	1	0	0	0
fff@alteferians.org	1	0	0	0	0	1
hamstermumke@xs4all.nl	0	1	0	0	0	1
turbinius.cardinales-ofm@gmx.de	2	0	0	0	0	2

TOTAL	3	1	1	0	0	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	333	2239591	2214316	113	25162	98%	473:17:48

TOTAL: 1		333	2239591	2214316	113	25162	98%	473:17:48

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	418.2 GB	4.7 MB	418.2 GB	99%	195.8 KB	473:17:48

TOTAL: 1		418.2 GB	4.7 MB	418.2 GB	99%	195.8 KB	473:17:48

Incoming articles:

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

Sep 5 03:00:06 - 03:59:59	91342	4.1%	25.42	17.2 GB	4.1%	5005.47
Sep 5 04:00:00 - 04:59:59	88129	3.9%	24.48	17.5 GB	4.2%	5100.53
Sep 5 05:00:00 - 05:59:59	85272	3.8%	23.69	17.1 GB	4.1%	4988.24
Sep 5 06:00:00 - 06:59:59	76295	3.4%	21.19	15.2 GB	3.6%	4417.21
Sep 5 07:00:00 - 07:59:59	82870	3.7%	23.02	16.6 GB	3.9%	4834.81
Sep 5 08:00:00 - 08:59:59	87949	3.9%	24.43	17.6 GB	4.2%	5118.23
Sep 5 09:00:00 - 09:59:59	81913	3.7%	22.75	15.8 GB	3.7%	4591.19
Sep 5 10:00:00 - 10:59:59	81840	3.7%	22.73	15.5 GB	3.7%	4516.99
Sep 5 11:00:00 - 11:59:59	86531	3.9%	24.04	16.4 GB	3.9%	4771.13
Sep 5 12:00:00 - 12:59:59	94186	4.2%	26.16	18.2 GB	4.3%	5291.23
Sep 5 13:00:00 - 13:59:59	94850	4.2%	26.35	18.4 GB	4.4%	5355.24
Sep 5 14:00:00 - 14:59:59	89323	4.0%	24.81	17.2 GB	4.1%	5005.71
Sep 5 15:00:00 - 15:59:59	94974	4.3%	26.38	17.9 GB	4.3%	5209.41
Sep 5 16:00:00 - 16:59:59	95856	4.3%	26.63	17.3 GB	4.1%	5026.24
Sep 5 17:00:00 - 17:59:59	103038	4.6%	28.62	17.7 GB	4.2%	5162.57
Sep 5 18:00:00 - 18:59:59	101527	4.5%	28.20	17.9 GB	4.3%	5225.14
Sep 5 19:00:00 - 19:59:59	97776	4.4%	27.16	17.6 GB	4.2%	5132.78
Sep 5 20:00:00 - 20:59:59	98723	4.4%	27.42	18.5 GB	4.4%	5386.55
Sep 5 21:00:00 - 21:59:59	100120	4.5%	27.81	18.4 GB	4.4%	5369.76
Sep 5 22:00:00 - 22:59:59	99003	4.4%	27.50	19.0 GB	4.5%	5548.00
Sep 5 23:00:00 - 23:59:59	99376	4.5%	27.60	18.6 GB	4.4%	5422.40
Sep 6 00:00:00 - 00:59:59	99288	4.4%	27.58	18.6 GB	4.4%	5412.04
Sep 6 01:00:00 - 01:59:59	100472	4.5%	27.91	18.0 GB	4.3%	5233.38
Sep 6 02:00:00 - 02:59:59	101175	4.5%	28.10	18.5 GB	4.4%	5375.41
Sep 6 03:00:00 - 03:00:09	118	0.0%	13.11	17.5 MB	0.0%	1995.05

TOTAL: 24:00:03	2231946	100.0%	25.83	420.6 GB	100.0%	5103.84

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	30.2 GB	21.9%	75	849.55	1.97
02	BIN	137.8 GB	52.5 GB	38.1%	75	851.90	1.96
03	SMALL	13.0 GB	9.0 GB	68.7%	4	5.01	31.61
04	BIN	80.1 GB	38.9 GB	48.6%	45	427.51	2.27
05	BIN	80.1 GB	34.3 GB	42.9%	65	430.18	2.26
06	SMALL	13.0 GB	8.9 GB	68.4%	4	5.01	31.56
07	BIN	80.1 GB	34.1 GB	42.6%	45	425.39	2.29
08	BIN	80.1 GB	30.7 GB	38.3%	65	429.51	2.26
09	SMALL	13.0 GB	8.7 GB	66.6%	4	4.97	31.83
10	BIN	80.1 GB	30.8 GB	38.5%	45	424.60	2.29
11	BIN	80.1 GB	36.2 GB	45.2%	65	430.98	2.26
12	SMALL	13.0 GB	8.9 GB	68.1%	4	4.96	31.87
13	BIN	80.1 GB	30.3 GB	37.9%	45	423.75	2.29
14	BIN	80.1 GB	27.3 GB	34.1%	65	428.78	2.27

TOTAL: 14	-	968.5 GB	380.8 GB	39.3%	606	368.02	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	43084	25922	0	231	0	0	0	0	16931
2	?	31	0	0	0	0	0	0	0	31

TOTAL: 2		43115	25922	0	231	0	0	0	0	16962

Unwanted newsgroups [Top 20]:

Newsgroup	Count

es.binarios.hd	1817
alt.binaries.jerry	529
alt.binaries.pictures.amateur.butts	474
pedo.japanese.fetish.lolita	444
alt.binaries.easeynews.pervert	425
alt.binaries.pictures.erotica.asian.female	265
alt.binaries.wa	248
alt.binaries.pictures.bdcompany	191
alt.binaries.pictures.erotica.group.sex	184
alt.binaries.sandra.model	163
cakewalk.coffeehouse	162
alt.binaries.pictures.amateuralt.binaries.pictures.erotica.fetish	151
yu.comp.software	113
pictures.erotica.lesbians	108
tmnet.communities	105
alt.binaries.pictures.erotica.amateur.digicam	104
lucky.freebsd.questions	103
alt.binaries.pictures.erotica.femaleejaculation	93
corel.PaintShopProPhotoXI	93
macromedia.labs.flex2.general_discussion_prerelease	93

TOTAL: 2840	25922

INND misc events:

Events	Count

CCreader	1

TOTAL: 1	1

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	27
	TOTAL: 1	27
Including strange strings
	192.168.33.37	16931
	TOTAL: 1	16931

TOTAL: 2		16958

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	9	37023	1.2 GB	24	0	0	12:08:20
2	ts23-b198.moscow.dial.rol.ru	4	64	3.3 MB	69	0	0	01:00:10
3	ts23-b144.moscow.dial.rol.ru	1	6	402.2 KB	2	0	0	00:02:38
4	ts2-a35.volgograd.dial.rol.ru	8	2	4.8 KB	4	0	0	00:14:40

TOTAL: 4		22	37095	1.2 GB	99	0	2	24:10:36

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	9	37023	1.2 GB	24	0	0	12:08:20
2	*.moscow.dial.rol.ru	12	70	3.7 MB	71	0	0	01:02:54
3	*.volgograd.dial.rol.ru	8	2	4.8 KB	4	0	0	00:14:40
4	*.omsk.dial.rol.ru	2	0	0.0 KB	0	0	0	00:10:01
5	*.sovintel.net	15	0	0.0 KB	0	0	0	00:00:36
6	*.cis.ru	1	0	0.0 KB	0	0	0	00:10:56
7	*.nsk.dial.rol.ru	19	0	0.0 KB	0	0	0	00:00:24
8	*.barnaul.dial.rol.ru	2	0	0.0 KB	0	0	0	00:02:00
9	unresolved	48	0	0.0 KB	0	0	0	09:46:24
10	*.tony.pp.ru	63	0	0.0 KB	0	0	0	00:02:51
11	*.rol.ru	5834	0	0.0 KB	0	0	0	00:20:40
12	*.nn.ru	173	0	0.0 KB	0	0	0	00:00:53
13	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:03
14	*.komi.com	1	0	0.0 KB	0	0	0	00:05:09

TOTAL: 14		6188	37095	1.2 GB	99	0	1	24:09:04

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	27.492	244.020	0.000	12:08:20
194.154.66.131	0.072	0.120	0.000	07:39:53
195.46.175.120	27.266	7.424	0.000	01:56:30
ts23-b198.moscow.dial.rol.ru	0.132	0.332	0.000	01:00:10
ts2-a35.volgograd.dial.rol.ru	0.036	0.028	0.000	00:14:40
sword.cis.ru	0.104	0.092	0.000	00:10:56
balancer-b.rol.ru	3.692	3.596	0.000	00:10:40
ts1-a166.omsk.dial.rol.ru	0.016	0.008	0.000	00:10:01
194.186.71.137	0.008	0.016	0.000	00:10:00
balancer-a.rol.ru	3.732	3.520	0.000	00:09:59
main.komi.com	0.068	0.032	0.000	00:05:09
?	0.036	0.040	0.000	00:03:06
net1-x-ring.tony.pp.ru	0.080	0.104	0.000	00:02:51
ts23-b144.moscow.dial.rol.ru	0.000	0.008	0.000	00:02:38
ts1-a204.barnaul.dial.rol.ru	0.012	0.016	0.000	00:02:00
82.140.73.76	0.196	0.204	0.000	00:01:17
gray.nn.ru	0.276	0.252	0.000	00:00:53
fw-nat.sovintel.net	0.088	0.060	0.000	00:00:36
ts2-b238.nsk.dial.rol.ru	0.020	0.024	0.000	00:00:24
87.245.178.164	0.048	0.072	0.000	00:00:09

TOTAL: 29	63.402	259.984	0.000	24:10:36

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2918
balancer-a.rol.ru	2916
gray.nn.ru	173
net1-x-ring.tony.pp.ru	63
194.154.66.131	46
ts2-b238.nsk.dial.rol.ru	19
fw-nat.sovintel.net	15
ts24-b199.moscow.dial.rol.ru	5
ts1-a166.omsk.dial.rol.ru	2
ts23-a120.moscow.dial.rol.ru	2
ts1-a204.barnaul.dial.rol.ru	2
195.46.175.120	1
main.komi.com	1
sword.cis.ru	1
194.186.71.137	1
cappa.tr155m.lavtech.ru	1

TOTAL: 16	6166

NNRP no permission clients:

System	Conn

82.140.73.76	140
87.245.178.164	42
ppp142-38.dialup.mtu-net.ru	5
host-213-145-66-217.spbmts.ru	2
195.28.36.242	1
90.189.227.221	1
84.42.53.227	1
78-106-22-126.broadband.corbina.ru	1

TOTAL: 8	193

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	53

TOTAL: 1	53

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	2	0
ts1-a166.omsk.dial.rol.ru	1	0
195.46.175.120	1	0
sword.cis.ru	1	0
194.186.71.137	1	0
ts2-a35.volgograd.dial.rol.ru	1	0

TOTAL: 6	7	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	38405	100.0%
2	chile	1	0.0%

TOTAL: 2		38406	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	26142
2	alt.binaries.pictures.artpics	7256
3	alt.binaries.pictures.bras	4936
4	alt.binaries.pictures.youth-and-beauty	36
5	alt.binaries.pictures.erotica.mclt	11
6	alt.binaries.models.petite	8
7	alt.binaries.pictures.kid	6
8	alt.binaries.pictures.lolita	6
9	alt.binaries.aoi	3
10	chile.soc.legal	1
11	alt.binaries.video.ticklish-guys	1

TOTAL: 11		38406