Daily Usenet report

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

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 / 86 lines (5.8%)
Sep 6 04:30:21 perseus controlchan[28453]: Unknown "cmsg" control by yauer.bbs@bbs.wretch.cc
Sep 6 05:30:15 perseus controlchan[28453]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Sep 6 05:30:33 perseus controlchan[28453]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Sep 6 06:30:16 perseus controlchan[28453]: Unknown "cmsg" control by yoyolalawind.bbs@bbs.wretch.cc
Sep 6 06:30:16 perseus controlchan[28453]: Unknown "cmsg" control by yoyolalawind.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2326002	97.7%	205.2 MB	97.2%
innd	30964	1.3%	3.6 MB	1.7%
nnrpd	20311	0.9%	1.9 MB	0.9%
cnfsstat	2304	0.1%	397.5 KB	0.2%
controlchan	88	0.0%	9.1 KB	0.0%

TOTAL: 5	2379669	100.0%	211.1 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2322613	97.6%
Negative hits	52457	2.2%
Positive hits	3337	0.1%
Cache misses	1104	0.0%

TOTAL: 4	2379511	100.0%

INND timer:

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

article cancel	00:01:27.594	0.1%	16516	0.000	5.304	1039.000
article cleanup	00:00:26.092	0.0%	2292264	0.003	0.011	0.022
article logging	00:02:09.821	0.2%	2309537	0.003	0.056	6.318
article parse	00:20:17.668	1.4%	165639535	0.005	0.007	0.016
article write	10:58:14.403	45.7%	2271380	2.491	17.388	33.970
artlog/artcncl	00:00:01.767	0.0%	16146	0.000	0.109	13.149
artlog/artparse	00:00:00.000	0.0%	33	0.000	0.000	0.000
data move	00:03:52.974	0.3%	175238523	0.001	0.001	0.002
hisgrep/artcncl	00:01:21.485	0.1%	4206	0.000	19.374	1039.000
hishave/artcncl	00:00:02.215	0.0%	16516	0.000	0.134	151.200
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:12:31.306	0.9%	2365444	0.001	0.318	7.814
history sync	00:00:00.332	0.0%	290	0.000	1.145	25.000
history write	00:53:58.315	3.7%	2271380	0.030	1.426	12.879
hiswrite/artcncl	00:00:02.037	0.0%	12310	0.000	0.165	642.000
idle	05:58:26.224	24.9%	154373456	0.128	0.139	1.987
nntp read	00:22:06.482	1.5%	163654351	0.006	0.008	0.015
overview write	04:43:37.458	19.7%	2271380	1.284	7.492	75.501
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%	85	0.000	0.000	0.000

TOTAL: 23:59:47.390	23:38:36.173	98.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:07:43.656	0.6%	30150	0.000	15.378	52.996
idle	19:24:10.189	91.7%	73123	0.000	955.242	201372.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:39:54.401	3.1%	484957	0.000	4.937	18064.000
readart	00:20:36.604	1.6%	62361	0.000	19.830	457.333

TOTAL: 21:09:39.990	20:32:24.850	97.1%	-	-	-	-

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	1	0	0	0	0	1
nyyssit@isoallo.fi	0	1	0	0	0	1

TOTAL	1	1	0	0	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	322	2318186	2296172	4	22010	99%	491:21:26

TOTAL: 1		322	2318186	2296172	4	22010	99%	491:21:26

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	437.3 GB	4.9 MB	437.3 GB	99%	197.8 KB	491:21:26

TOTAL: 1		437.3 GB	4.9 MB	437.3 GB	99%	197.8 KB	491:21:26

Incoming articles:

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

Sep 6 03:00:09 - 03:59:59	95260	4.2%	26.53	18.9 GB	4.4%	5512.83
Sep 6 04:00:00 - 04:59:59	90653	4.0%	25.18	17.7 GB	4.1%	5167.03
Sep 6 05:00:00 - 05:59:59	87866	3.9%	24.41	17.4 GB	4.0%	5058.08
Sep 6 06:00:00 - 06:59:59	80207	3.5%	22.28	15.8 GB	3.6%	4590.01
Sep 6 07:00:00 - 07:59:59	85683	3.8%	23.80	17.2 GB	4.0%	5003.43
Sep 6 08:00:00 - 08:59:59	88882	3.9%	24.69	18.0 GB	4.2%	5246.07
Sep 6 09:00:00 - 09:59:59	83472	3.7%	23.19	16.5 GB	3.8%	4803.81
Sep 6 10:00:00 - 10:59:59	86520	3.8%	24.03	17.0 GB	3.9%	4949.61
Sep 6 11:00:00 - 11:59:59	90577	4.0%	25.16	17.1 GB	4.0%	4992.81
Sep 6 12:00:00 - 12:59:59	94923	4.2%	26.37	18.8 GB	4.3%	5477.24
Sep 6 13:00:00 - 13:59:59	96918	4.3%	26.92	18.5 GB	4.3%	5390.03
Sep 6 14:00:00 - 14:59:59	96587	4.3%	26.83	19.1 GB	4.4%	5557.97
Sep 6 15:00:00 - 15:59:59	95601	4.2%	26.56	18.8 GB	4.3%	5462.86
Sep 6 16:00:00 - 16:59:59	98975	4.4%	27.49	18.5 GB	4.3%	5390.84
Sep 6 17:00:00 - 17:59:59	101855	4.5%	28.29	18.4 GB	4.2%	5347.35
Sep 6 18:00:00 - 18:59:59	100449	4.4%	27.90	18.5 GB	4.3%	5391.74
Sep 6 19:00:00 - 19:59:59	101169	4.5%	28.10	18.3 GB	4.2%	5328.60
Sep 6 20:00:00 - 20:59:59	99920	4.4%	27.76	18.0 GB	4.2%	5254.96
Sep 6 21:00:00 - 21:59:59	101026	4.4%	28.06	18.2 GB	4.2%	5307.30
Sep 6 22:00:00 - 22:59:59	99838	4.4%	27.73	18.8 GB	4.3%	5467.98
Sep 6 23:00:00 - 23:59:59	99304	4.4%	27.58	18.8 GB	4.3%	5463.28
Sep 7 00:00:00 - 00:59:59	97639	4.3%	27.12	18.2 GB	4.2%	5305.81
Sep 7 01:00:00 - 01:59:59	100309	4.4%	27.86	18.0 GB	4.1%	5230.23
Sep 7 02:00:00 - 02:59:59	97887	4.3%	27.19	18.9 GB	4.4%	5497.37
Sep 7 03:00:00 - 03:00:06	151	0.0%	25.17	29.9 MB	0.0%	5097.63

TOTAL: 23:59:57	2271671	100.0%	26.29	433.2 GB	100.0%	5258.18

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	102.6 GB	74.4%	75	857.61	1.95
02	BIN	137.8 GB	125.4 GB	91.0%	75	851.31	1.96
03	SMALL	13.0 GB	9.3 GB	71.7%	4	4.78	33.12
04	BIN	80.1 GB	75.2 GB	93.9%	45	440.24	2.21
05	BIN	80.1 GB	70.9 GB	88.6%	65	443.67	2.19
06	SMALL	13.0 GB	9.3 GB	71.4%	4	4.76	33.22
07	BIN	80.1 GB	70.3 GB	87.8%	45	438.85	2.21
08	BIN	80.1 GB	67.1 GB	83.8%	65	442.14	2.20
09	SMALL	13.0 GB	9.1 GB	69.6%	4	4.78	33.11
10	BIN	80.1 GB	66.9 GB	83.5%	45	437.10	2.22
11	BIN	80.1 GB	72.9 GB	91.0%	65	444.37	2.19
12	SMALL	13.0 GB	9.3 GB	71.1%	4	4.78	33.13
13	BIN	80.1 GB	66.3 GB	82.8%	45	436.88	2.22
14	BIN	80.1 GB	63.8 GB	79.6%	65	441.93	2.20

TOTAL: 14	-	968.5 GB	818.3 GB	84.5%	606	377.85	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	38152	20630	0	239	0	0	0	0	17283
2	?	33	0	0	0	0	0	0	0	33

TOTAL: 2		38185	20630	0	239	0	0	0	0	17316

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pictures.amateur.butts	619
alt.binaries.easeynews.pervert	538
alt.binaries.pictures.katie	466
yu.comp.software	387
alt.binaries.totally.fetish.photo	309
alt.binaries.jerry	296
alt.binaries.pictures.erotica.asian.female	272
alt.binaries.fetish	236
alt.binaries.multimedia.bisexual	232
pedo.japanese.fetish.lolita	217
alt.binaries.uhq	171
corel.PaintShopProPhotoX2	129
rss.MoreOver-EntertainmentMovie	123
alt.binaries.pictures.black.erotica.females	119
alt.binaries.pictures.black.erotica	114
alt.binaries.erotica.bondage.male	107
ccu.bbs.talk.market	99
alt.binaries.pictures.fetish.urine	94
lucky.freebsd.questions	93
alt.sex.telephone.alt.sex.wanted	87

TOTAL: 1837	20630

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

TOTAL: 2		17284

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	7	30138	937.3 MB	21	0	0	12:50:51
2	ts24-a71.moscow.dial.rol.ru	2	11	1.4 MB	12	0	0	00:29:39
3	ts2-a237.angarsk.dial.rol.ru	3	7	1.4 MB	0	0	0	00:25:28
4	194.154.66.183	1	6	690.6 KB	15	0	0	00:01:38
5	rol253.rol.kis.ru	9	1	10.1 KB	1	0	0	00:11:48

TOTAL: 5		22	30163	940.9 MB	49	0	0	21:08:51

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	7	30138	937.3 MB	21	0	0	12:50:51
2	*.moscow.dial.rol.ru	20	11	1.4 MB	12	0	0	00:57:58
3	*.angarsk.dial.rol.ru	3	7	1.4 MB	0	0	0	00:25:28
4	unresolved	38	6	690.6 KB	15	0	0	06:01:12
5	*.rol.kis.ru	9	1	10.1 KB	1	0	0	00:11:48
6	*.omsk.dial.rol.ru	2	0	0.0 KB	0	0	0	00:07:13
7	*.sovintel.net	16	0	0.0 KB	0	0	0	00:00:28
8	*.vladivostok.dial.rol.ru	2	0	0.0 KB	0	0	0	00:02:40
9	*.spb.dial.rol.ru	2	0	0.0 KB	0	0	0	00:00:01
10	*.tony.pp.ru	72	0	0.0 KB	0	0	0	00:03:31
11	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:02
12	*.pcs-net.net	1	0	0.0 KB	0	0	0	00:00:00
13	*.rol.ru	5834	0	0.0 KB	0	0	0	00:20:37
14	*.nn.ru	39	0	0.0 KB	0	0	0	00:00:18
15	*.nsk.dial.rol.ru	19	0	0.0 KB	0	0	0	00:01:33
16	*.novokuznetzk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:01

TOTAL: 16		6066	30163	940.9 MB	49	0	0	21:06:54

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	23.492	212.134	0.000	12:50:51
194.154.66.131	0.044	0.084	0.000	05:59:34
ts24-a71.moscow.dial.rol.ru	0.004	0.028	0.000	00:29:39
ts2-a237.angarsk.dial.rol.ru	0.008	0.028	0.000	00:25:28
ts18-a79.moscow.dial.rol.ru	0.064	0.048	0.000	00:14:07
rol253.rol.kis.ru	0.072	0.016	0.000	00:11:48
balancer-b.rol.ru	3.740	3.872	0.000	00:10:51
balancer-a.rol.ru	3.536	3.672	0.000	00:09:46
ts27-a172.moscow.dial.rol.ru	0.012	0.000	0.000	00:07:25
ts3-a207.omsk.dial.rol.ru	0.044	0.056	0.000	00:06:55
ts24-a76.moscow.dial.rol.ru	0.060	0.052	0.000	00:06:00
net1-x-ring.tony.pp.ru	0.192	0.248	0.000	00:03:31
?	0.012	0.048	0.000	00:03:05
ts3-a222.vladivostok.dial.rol.ru	0.096	0.116	0.000	00:02:40
194.154.66.183	0.028	0.008	0.000	00:01:38
ts2-a109.nsk.dial.rol.ru	0.012	0.040	0.000	00:01:33
82.140.73.76	0.212	0.300	0.000	00:01:29
ts24-a192.moscow.dial.rol.ru	0.016	0.008	0.000	00:00:43
fw-nat.sovintel.net	0.160	0.056	0.000	00:00:28
gray.nn.ru	0.064	0.120	0.000	00:00:18

TOTAL: 32	32.112	221.150	0.000	21:08:51

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2928
balancer-a.rol.ru	2906
net1-x-ring.tony.pp.ru	72
gray.nn.ru	39
194.154.66.131	37
ts2-a109.nsk.dial.rol.ru	19
fw-nat.sovintel.net	16
ts24-a192.moscow.dial.rol.ru	12
ts24-a45.moscow.dial.rol.ru	3
ts5-b210.spb.dial.rol.ru	2
ts3-a222.vladivostok.dial.rol.ru	2
ts2-a16.novokuznetzk.dial.rol.ru	1
news.pcs-net.net	1
ts18-a79.moscow.dial.rol.ru	1
ts24-a76.moscow.dial.rol.ru	1
ts3-a207.omsk.dial.rol.ru	1
ts3-a134.omsk.dial.rol.ru	1
ts27-a172.moscow.dial.rol.ru	1
news.lek.ru	1

TOTAL: 19	6044

NNRP no permission clients:

System	Conn

82.140.73.76	142
87.245.178.164	48
cornholio.migtel.ru	19
84-089-ppp.vntc.ru	2
62.117.117.5	1
ts2-a23.krasnoyarsk.dial.rol.ru	1
195.28.36.242	1

TOTAL: 7	214

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	48

TOTAL: 1	48

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	3	0
ts18-a79.moscow.dial.rol.ru	1	0
rol253.rol.kis.ru	1	0
ts2-a237.angarsk.dial.rol.ru	1	0

TOTAL: 4	6	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	30156	100.0%

TOTAL: 1		30156	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	21331
2	alt.binaries.pictures.artpics	5333
3	alt.binaries.pictures.bras	3474
4	alt.binaries.pictures.kid	6
5	alt.binaries.models.petite	5
6	alt.binaries.pictures.erotica.pinups	3
7	alt.binaries.pictures.erotica.high-heel	2
8	alt.binaries.pictures.sandra	1
9	alt.sex.masterbation.pictures.female	1

TOTAL: 9		30156