Daily Usenet report

Sep 28 03:00:04 -- Sep 29 03:00:05

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
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 / 87 lines (5.7%)
Sep 28 05:01:00 perseus controlchan[16839]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Sep 28 05:01:04 perseus controlchan[16839]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Sep 28 05:01:11 perseus controlchan[16839]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Sep 28 05:01:23 perseus controlchan[16839]: Unknown "cmsg" control by yauer.bbs@bbs.wretch.cc
Sep 28 05:01:28 perseus controlchan[16839]: Unknown "cmsg" control by NSR500.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2234889	96.9%	195.6 MB	96.4%
innd	49826	2.2%	5.0 MB	2.5%
nnrpd	20400	0.9%	1.9 MB	0.9%
cnfsstat	2304	0.1%	396.1 KB	0.2%
controlchan	90	0.0%	9.6 KB	0.0%

TOTAL: 5	2307509	100.0%	202.9 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2214095	97.3%
Negative hits	42960	1.9%
Positive hits	9289	0.4%
Cache misses	9060	0.4%

TOTAL: 4	2275404	100.0%

INND timer:

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

article cancel	00:03:00.404	0.2%	26386	0.000	6.837	1531.000
article cleanup	00:00:25.419	0.0%	2198949	0.002	0.012	0.021
article logging	00:02:44.285	0.2%	2209387	0.004	0.074	4.895
article parse	00:19:04.913	1.3%	154335159	0.005	0.007	0.017
article write	09:51:11.750	41.0%	2173271	4.660	16.322	111.094
artlog/artcncl	00:00:00.437	0.0%	26203	0.000	0.017	15.333
artlog/artparse	00:00:00.003	0.0%	112	0.000	0.027	1.000
data move	00:03:38.071	0.3%	163619749	0.001	0.001	0.002
hisgrep/artcncl	00:02:53.919	0.2%	18138	0.000	9.589	1531.000
hishave/artcncl	00:00:00.911	0.0%	26386	0.000	0.035	136.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:12:24.195	0.9%	2250240	0.000	0.331	8.614
history sync	00:00:00.324	0.0%	289	0.000	1.121	24.000
history write	00:51:32.045	3.6%	2173271	0.031	1.423	12.217
hiswrite/artcncl	00:00:04.927	0.0%	8248	0.000	0.597	79.700
idle	06:12:34.447	25.9%	143939611	0.128	0.155	1.117
nntp read	00:20:42.750	1.4%	152631660	0.006	0.008	0.016
overview write	05:40:06.078	23.6%	2173271	1.787	9.390	114.355
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%	87	0.000	0.000	0.000

TOTAL: 24:00:27.685	23:40:24.878	98.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:27:58.174	1.3%	61675	0.000	27.210	815.000
idle	23:05:24.236	66.3%	214808	0.000	386.970	200184.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	09:08:03.007	26.2%	789515	0.000	41.650	18776.131
readart	00:38:46.411	1.9%	125138	0.000	18.591	440.379

TOTAL: 34:48:39.980	33:20:11.828	95.8%	-	-	-	-

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

fff@alteferians.org	2	0	0	0	0	2
hamstermumke@xs4all.nl	0	1	0	0	0	1

TOTAL	2	1	0	0	0	3

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	337	2192721	2166886	15	25820	98%	476:46:54

TOTAL: 1		337	2192721	2166886	15	25820	98%	476:46:54

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	403.5 GB	22.5 MB	403.5 GB	99%	193.0 KB	476:46:54

TOTAL: 1		403.5 GB	22.5 MB	403.5 GB	99%	193.0 KB	476:46:54

Incoming articles:

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

Sep 28 03:00:04 - 03:59:59	97387	4.5%	27.08	17.1 GB	4.2%	4980.71
Sep 28 04:00:00 - 04:59:59	89879	4.1%	24.97	16.4 GB	4.0%	4767.67
Sep 28 05:00:00 - 05:59:59	85191	3.9%	23.66	16.6 GB	4.1%	4846.49
Sep 28 06:00:00 - 06:59:59	88321	4.1%	24.53	17.1 GB	4.2%	4978.94
Sep 28 07:00:00 - 07:59:59	79523	3.7%	22.09	14.6 GB	3.6%	4246.52
Sep 28 08:00:00 - 08:59:59	86609	4.0%	24.06	16.6 GB	4.1%	4845.82
Sep 28 09:00:00 - 09:59:59	78890	3.6%	21.91	15.5 GB	3.8%	4516.79
Sep 28 10:00:00 - 10:59:59	82342	3.8%	22.87	15.0 GB	3.7%	4378.23
Sep 28 11:00:00 - 11:59:59	83078	3.8%	23.08	16.6 GB	4.1%	4837.06
Sep 28 12:00:00 - 12:59:59	90678	4.2%	25.19	16.5 GB	4.1%	4814.27
Sep 28 13:00:00 - 13:59:59	96366	4.4%	26.77	17.5 GB	4.3%	5089.32
Sep 28 14:00:00 - 14:59:59	96690	4.5%	26.86	17.9 GB	4.4%	5217.21
Sep 28 15:00:00 - 15:59:59	89462	4.1%	24.85	17.2 GB	4.3%	5015.34
Sep 28 16:00:00 - 16:59:59	93681	4.3%	26.02	16.9 GB	4.2%	4935.28
Sep 28 17:00:00 - 17:59:59	95501	4.4%	26.53	18.0 GB	4.5%	5252.47
Sep 28 18:00:00 - 18:59:59	97482	4.5%	27.08	17.6 GB	4.3%	5128.01
Sep 28 19:00:00 - 19:59:59	96346	4.4%	26.76	17.6 GB	4.3%	5116.50
Sep 28 20:00:00 - 20:59:59	93443	4.3%	25.96	17.7 GB	4.4%	5152.39
Sep 28 21:00:00 - 21:59:59	98067	4.5%	27.24	18.1 GB	4.5%	5279.88
Sep 28 22:00:00 - 22:59:59	96309	4.4%	26.75	18.1 GB	4.5%	5266.45
Sep 28 23:00:00 - 23:59:59	92467	4.3%	25.69	17.5 GB	4.3%	5091.55
Sep 29 00:00:00 - 00:59:59	85487	3.9%	23.75	15.4 GB	3.8%	4480.45
Sep 29 01:00:00 - 01:59:59	89937	4.1%	24.98	16.1 GB	4.0%	4700.18
Sep 29 02:00:00 - 02:59:59	89210	4.1%	24.78	17.2 GB	4.2%	5012.83
Sep 29 03:00:00 - 03:00:05	131	0.0%	26.20	27.3 MB	0.0%	5599.10

TOTAL: 24:00:01	2172477	100.0%	25.14	405.0 GB	100.0%	4914.63

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	94.6 GB	68.7%	86	803.97	2.08
02	BIN	137.8 GB	126.7 GB	91.9%	86	814.46	2.05
03	SMALL	13.0 GB	6.1 GB	46.7%	5	5.23	30.27
04	BIN	80.1 GB	29.7 GB	37.1%	55	411.32	2.36
05	BIN	80.1 GB	30.3 GB	37.8%	75	414.75	2.34
06	SMALL	13.0 GB	6.1 GB	46.4%	5	5.17	30.58
07	BIN	80.1 GB	22.5 GB	28.1%	55	410.33	2.37
08	BIN	80.1 GB	24.3 GB	30.4%	75	412.87	2.35
09	SMALL	13.0 GB	5.8 GB	44.2%	5	5.15	30.73
10	BIN	80.1 GB	17.2 GB	21.5%	55	409.76	2.37
11	BIN	80.1 GB	33.3 GB	41.6%	75	414.97	2.34
12	SMALL	13.0 GB	6.0 GB	46.1%	5	5.21	30.38
13	BIN	80.1 GB	16.1 GB	20.1%	55	408.87	2.38
14	BIN	80.1 GB	20.8 GB	26.0%	75	412.34	2.36

TOTAL: 14	-	968.5 GB	439.6 GB	45.4%	712	353.59	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	36110	25462	0	209	0	0	0	0	10439
2	?	112	0	0	0	0	0	0	0	112

TOTAL: 2		36222	25462	0	209	0	0	0	0	10551

Unwanted newsgroups [Top 20]:

Newsgroup	Count

allt.sex.fetish	774
alt.binaries.hotrod	674
alt.binaries.pictures.erotica.asian.female	532
alt.pictures.erotica.asian	429
alt.binaries.amateur.gangbang	410
alt.binaries.pictures.erotica.mature.females	387
alt.binaries.erotica.freckles	386
alt.binaries.multimedia.erotica.asians	337
alt.binaries.ufo	323
alt.binaries.pictures.amateur.butts	313
alt.binaries.multimedia.erotica.transexuals	300
alt.binaries.pictures.erotica.latinal	281
alt.pedophilia	267
alt.binaries.multimedia.transsexuals	258
pedo.japanese.fetish.lolita	210
de.alt.sex.fetish	203
alt.binaries.multimedia.anal.fisting	202
alt.binaries.pictures.fetish.urine	178
alt.biniaries.erotica	173
ccu.bbs.talk.market	156

TOTAL: 1958	25462

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	10437
	TOTAL: 1	10437

TOTAL: 2		10464

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	16	61148	2.0 GB	48	0	0	11:03:46
2	ts1-a185.saratov.dial.rol.ru	58	634	73.8 MB	0	0	0	15:14:20
3	news.pcs-net.net	12	275	53.6 MB	27	0	0	03:03:47
4	ts30-b185.moscow.dial.rol.ru	13	153	1.2 MB	12	0	0	00:13:50
5	ts1-b240.saratov.dial.rol.ru	1	48	105.9 KB	1	0	0	00:17:23
6	ts1-b232.saratov.dial.rol.ru	1	1	1.6 KB	1	0	0	00:25:56

TOTAL: 6		101	62259	2.1 GB	89	0	0	39:34:07

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	16	61148	2.0 GB	48	0	0	11:03:46
2	*.saratov.dial.rol.ru	61	683	73.9 MB	2	0	0	16:14:46
3	*.pcs-net.net	12	275	53.6 MB	27	0	0	03:03:47
4	*.moscow.dial.rol.ru	31	153	1.2 MB	12	0	0	00:58:50
5	*.sovintel.net	11	0	0.0 KB	0	0	0	00:00:16
6	unresolved	46	0	0.0 KB	0	0	0	07:10:00
7	*.tony.pp.ru	69	0	0.0 KB	0	0	0	00:30:52
8	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:03
9	*.rol.ru	5843	0	0.0 KB	0	0	0	00:21:42
10	*.nsk.net.rol.ru	4	0	0.0 KB	0	0	0	00:03:22
11	*.nn.ru	51	0	0.0 KB	0	0	0	00:00:20
12	*.nsk.dial.rol.ru	60	0	0.0 KB	0	0	0	00:02:49

TOTAL: 12		6205	62259	2.1 GB	89	0	0	39:32:51

NNRP total resource statistics [Top 20]:

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

ts1-a185.saratov.dial.rol.ru	0.316	0.932	0.000	15:14:20
keyhole.sovam.com	53.676	471.740	0.000	11:03:46
194.154.66.131	0.076	0.084	0.000	07:09:57
news.pcs-net.net	0.148	0.436	0.000	03:03:47
ts30-b221.moscow.dial.rol.ru	0.068	0.064	0.000	00:44:42
net1-x-ring.tony.pp.ru	34.344	318.527	0.000	00:30:52
ts1-b232.saratov.dial.rol.ru	0.040	0.048	0.000	00:25:56
ts1-b240.saratov.dial.rol.ru	0.028	0.064	0.000	00:17:23
ts1-a22.saratov.dial.rol.ru	0.032	0.064	0.000	00:17:07
ts30-b185.moscow.dial.rol.ru	0.020	0.068	0.000	00:13:50
balancer-b.rol.ru	3.628	3.716	0.000	00:11:11
balancer-a.rol.ru	3.732	3.820	0.000	00:10:30
ts3-a197.nsk.net.rol.ru	0.008	0.012	0.000	00:03:22
?	0.032	0.048	0.000	00:02:11
ts2-a86.nsk.dial.rol.ru	0.032	0.024	0.000	00:01:19
82.140.73.76	0.240	0.220	0.000	00:01:13
ts2-b198.nsk.dial.rol.ru	0.036	0.040	0.000	00:00:55
ts2-a254.nsk.dial.rol.ru	0.036	0.024	0.000	00:00:35
gray.nn.ru	0.104	0.128	0.000	00:00:20
fw-nat.sovintel.net	0.084	0.040	0.000	00:00:16

TOTAL: 32	96.776	800.187	0.000	39:34:07

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2930
balancer-a.rol.ru	2913
net1-x-ring.tony.pp.ru	69
gray.nn.ru	51
194.154.66.131	43
ts2-a254.nsk.dial.rol.ru	21
ts2-a86.nsk.dial.rol.ru	21
ts2-b198.nsk.dial.rol.ru	18
fw-nat.sovintel.net	11
ts23-b136.moscow.dial.rol.ru	6
ts3-a197.nsk.net.rol.ru	4
ts27-b50.moscow.dial.rol.ru	3
ts9-b31.moscow.dial.rol.ru	3
ts30-b221.moscow.dial.rol.ru	3
ts27-b111.moscow.dial.rol.ru	3
212.46.203.164	2
ts1-a22.saratov.dial.rol.ru	1
194.186.71.137	1
news.lek.ru	1

TOTAL: 19	6104

NNRP no permission clients:

System	Conn

82.140.73.76	144
217.65.223.69	5
cornholio.migtel.ru	1
195.28.36.242	1
86.92.237.98	1
wn2nat60.beelinegprs.ru	1

TOTAL: 6	153

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	35

TOTAL: 1	35

NNRP client timeouts [Top 20]:

System	Conn	Peer

news.pcs-net.net	4	0
ts1-a22.saratov.dial.rol.ru	1	0
ts30-b221.moscow.dial.rol.ru	1	0
194.154.66.131	1	0
ts1-b240.saratov.dial.rol.ru	1	0

TOTAL: 5	8	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	61441	99.7%
2	hr	134	0.2%
3	fido7	49	0.1%
4	japan2nd	1	0.0%

TOTAL: 4		61625	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	46658
2	alt.binaries.pictures.artpics	7461
3	alt.binaries.pictures.bras	7029
4	alt.binaries.pictures.sandra	166
5	hr.sci.jezik	115
6	alt.binaries.pictures.vladmodels	109
7	fido7.ru.linux	49
8	alt.binaires.pictures.erotica.teen.female	14
9	hr.rec.humor.best-of-usenet	11
10	hr.rec.film.crtani.binaries	8
11	alt.sex.binaries.erotica.teen	4
12	japan2nd.binaries.pictures.erotica.lolita	1

TOTAL: 12		61625