Daily Usenet report

Sep 18 03:00:02 -- Sep 19 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 / 176 lines (2.8%)
Sep 18 05:50:21 perseus controlchan[28453]: Unknown "cmsg" control by okwap.bbs@bbs.wretch.cc
Sep 18 05:50:21 perseus controlchan[28453]: Unknown "cmsg" control by aceson.bbs@bbs.wretch.cc
Sep 18 05:50:21 perseus controlchan[28453]: Unknown "cmsg" control by shinehsnu.bbs@bbs.wretch.cc
Sep 18 05:50:21 perseus controlchan[28453]: Unknown "cmsg" control by Byrd.bbs@bbs.wretch.cc
Sep 18 05:50:21 perseus controlchan[28453]: Unknown "cmsg" control by oxidea2.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2292304	97.7%	202.6 MB	97.2%
innd	31380	1.3%	3.6 MB	1.7%
nnrpd	19823	0.8%	1.9 MB	0.9%
cnfsstat	2304	0.1%	397.6 KB	0.2%
controlchan	180	0.0%	18.4 KB	0.0%
expireover	1	0.0%	0.2 KB	0.0%

TOTAL: 6	2345992	100.0%	208.5 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2279705	98.0%
Negative hits	41816	1.8%
Positive hits	2912	0.1%
Cache misses	1238	0.1%

TOTAL: 4	2325671	100.0%

INND timer:

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

article cancel	00:01:31.400	0.1%	21715	0.000	4.209	1585.000
article cleanup	00:00:25.398	0.0%	2258236	0.002	0.011	0.022
article logging	00:02:22.957	0.2%	2270209	0.004	0.063	4.085
article parse	00:19:25.240	1.3%	160692114	0.005	0.007	0.023
article write	10:27:34.619	43.6%	2233859	4.534	16.856	88.459
artlog/artcncl	00:00:00.203	0.0%	21139	0.000	0.010	0.500
artlog/artparse	00:00:00.000	0.0%	46	0.000	0.000	0.000
data move	00:03:44.486	0.3%	170250849	0.001	0.001	0.002
hisgrep/artcncl	00:00:54.807	0.1%	3753	0.000	14.604	1585.000
hishave/artcncl	00:00:07.357	0.0%	21715	0.000	0.339	43.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:17:42.723	1.2%	2304610	0.001	0.461	12.274
history sync	00:00:00.305	0.0%	290	0.000	1.052	3.000
history write	00:55:40.709	3.9%	2233859	0.027	1.495	21.635
hiswrite/artcncl	00:00:28.887	0.0%	17962	0.000	1.608	51.156
idle	06:22:18.126	26.6%	150244352	0.127	0.153	0.617
nntp read	00:21:09.072	1.5%	158944884	0.006	0.008	0.019
overview write	04:45:17.076	19.8%	2233859	1.263	7.663	93.808
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.002	0.0%	170	0.000	0.012	1.000

TOTAL: 23:59:25.455	23:38:43.367	98.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:27:35.883	1.3%	36698	0.000	45.122	79.347
idle	33:37:56.959	93.4%	147142	0.000	822.858	205599.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:24:14.908	1.1%	747396	0.000	1.947	867.680
readart	00:36:18.422	1.7%	83804	0.000	25.994	186.000

TOTAL: 36:00:44.817	35:06:06.172	97.5%	-	-	-	-

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

control-microsoft@trigofacile.com	0	3	0	0	0	3
nyyssit@isoallo.fi	1	0	1	0	0	2

TOTAL	1	3	1	0	0	5

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	322	2344624	2316822	12	27790	98%	495:35:06

TOTAL: 1		322	2344624	2316822	12	27790	98%	495:35:06

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	416.0 GB	22.1 MB	416.0 GB	99%	186.0 KB	495:35:06

TOTAL: 1		416.0 GB	22.1 MB	416.0 GB	99%	186.0 KB	495:35:06

Incoming articles:

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

Sep 18 03:00:02 - 03:59:59	94367	4.2%	26.23	17.9 GB	4.3%	5210.10
Sep 18 04:00:00 - 04:59:59	90322	4.0%	25.09	17.3 GB	4.2%	5028.77
Sep 18 05:00:00 - 05:59:59	88611	4.0%	24.61	17.1 GB	4.1%	4985.87
Sep 18 06:00:00 - 06:59:59	84320	3.8%	23.42	15.8 GB	3.8%	4587.84
Sep 18 07:00:00 - 07:59:59	86906	3.9%	24.14	16.3 GB	3.9%	4744.83
Sep 18 08:00:00 - 08:59:59	89112	4.0%	24.75	16.5 GB	4.0%	4820.20
Sep 18 09:00:00 - 09:59:59	80915	3.6%	22.48	15.7 GB	3.8%	4574.17
Sep 18 10:00:00 - 10:59:59	84573	3.8%	23.49	15.9 GB	3.8%	4628.85
Sep 18 11:00:00 - 11:59:59	88813	4.0%	24.67	17.0 GB	4.1%	4964.47
Sep 18 12:00:00 - 12:59:59	95934	4.3%	26.65	18.4 GB	4.4%	5358.41
Sep 18 13:00:00 - 13:59:59	101659	4.5%	28.24	17.9 GB	4.3%	5215.30
Sep 18 14:00:00 - 14:59:59	104254	4.7%	28.96	17.6 GB	4.2%	5120.25
Sep 18 15:00:00 - 15:59:59	96987	4.3%	26.94	18.5 GB	4.5%	5378.92
Sep 18 16:00:00 - 16:59:59	88429	4.0%	24.56	16.7 GB	4.0%	4871.04
Sep 18 17:00:00 - 17:59:59	93606	4.2%	26.00	18.0 GB	4.3%	5232.86
Sep 18 18:00:00 - 18:59:59	100739	4.5%	27.98	18.7 GB	4.5%	5433.38
Sep 18 19:00:00 - 19:59:59	101254	4.5%	28.13	18.7 GB	4.5%	5445.74
Sep 18 20:00:00 - 20:59:59	97375	4.4%	27.05	18.1 GB	4.4%	5279.79
Sep 18 21:00:00 - 21:59:59	99180	4.4%	27.55	17.8 GB	4.3%	5195.26
Sep 18 22:00:00 - 22:59:59	96980	4.3%	26.94	18.1 GB	4.4%	5259.11
Sep 18 23:00:00 - 23:59:59	97713	4.4%	27.14	17.3 GB	4.2%	5042.89
Sep 19 00:00:00 - 00:59:59	88496	4.0%	24.58	15.8 GB	3.8%	4614.45
Sep 19 01:00:00 - 01:59:59	93023	4.2%	25.84	16.5 GB	4.0%	4801.57
Sep 19 02:00:00 - 02:59:59	91080	4.1%	25.30	16.5 GB	4.0%	4817.62
Sep 19 03:00:00 - 03:00:05	95	0.0%	19.00	15.8 MB	0.0%	3232.70

TOTAL: 24:00:03	2234743	100.0%	25.86	414.1 GB	100.0%	5025.38

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	100.6 GB	73.0%	81	819.01	2.04
02	BIN	137.8 GB	128.3 GB	93.1%	81	835.97	2.00
03	SMALL	13.0 GB	1.5 GB	11.3%	5	5.35	29.57
04	BIN	80.1 GB	7.9 GB	9.9%	51	420.98	2.31
05	BIN	80.1 GB	6.1 GB	7.6%	71	423.84	2.29
06	SMALL	13.0 GB	1.4 GB	11.1%	5	5.34	29.63
07	BIN	80.1 GB	1.8 GB	2.2%	51	419.69	2.32
08	BIN	80.1 GB	1.3 GB	1.6%	71	422.75	2.30
09	SMALL	13.0 GB	1.2 GB	9.1%	5	5.30	29.87
10	BIN	80.1 GB	77.5 GB	96.7%	50	418.96	2.32
11	BIN	80.1 GB	8.6 GB	10.8%	71	425.21	2.29
12	SMALL	13.0 GB	1.4 GB	10.8%	5	5.34	29.63
13	BIN	80.1 GB	76.7 GB	95.8%	50	417.73	2.33
14	BIN	80.1 GB	77.8 GB	97.2%	70	422.15	2.30

TOTAL: 14	-	968.5 GB	492.1 GB	50.8%	667	361.93	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	36376	23996	0	395	0	0	0	0	11985
2	?	46	0	0	0	0	0	0	0	46

TOTAL: 2		36422	23996	0	395	0	0	0	0	12031

Unwanted newsgroups [Top 20]:

Newsgroup	Count

es.binarios.hd	687
alt.binaries.pictures.bdstudio	540
alt.binaries.pictures.amateur.butts	538
alt.binaries.erotica.freckles	369
alt.binaries.pictures.erotica.asian.female	299
ccu.bbs.talk.market	256
auna.idc	189
cakewalk.coffeehouse	145
alt.binaries.nonnude	136
alt.binaries.pictures.erotica.feti	132
alt.prowling-for-gay-sex	123
alt.binaries.erotica.gaymen.twinks	122
alt.binaries.pictures.black.erotica.females	113
alt.binaries.pictures.black.erotica	107
alt.binaries.erotica.bondage.male	104
alt.binaries.pictures.erotic.unusual.object.penetrat	102
alt.binaries.pictures.fetish.urine	99
alt.binaries.jerry	99
lada.soft	98
rss.fark	94

TOTAL: 3329	23996

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

TOTAL: 2		11994

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	6	36694	3.0 GB	18	0	0	24:19:59
2	ts1-a138.krasnoyarsk.dial.rol.ru	13	16	38.8 KB	1	0	0	00:03:18
3	nat-cc.cc.gldn.net	11	8	24.0 KB	6	0	0	00:39:37
4	dynip.195.98.62.131.dialup.kis.ru	1	1	41.2 KB	1	0	0	00:01:26
5	ts1-a180.saratov.dial.rol.ru	1	1	1.5 KB	1	0	0	01:46:55
6	ts12-a32.spb.dial.rol.ru	3	1	12.0 KB	1	0	0	00:02:04

TOTAL: 6		35	36721	3.0 GB	28	0	0	35:59:46

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	6	36694	3.0 GB	18	0	0	24:19:59
2	*.krasnoyarsk.dial.rol.ru	16	16	38.8 KB	1	0	0	00:04:05
3	*.cc.gldn.net	11	8	24.0 KB	6	0	0	00:39:37
4	*.spb.dial.rol.ru	4	1	12.0 KB	1	0	0	00:02:05
5	*.saratov.dial.rol.ru	1	1	1.5 KB	1	0	0	01:46:55
6	*.195.98.62.131.dialup.kis.ru	1	1	41.2 KB	1	0	0	00:01:26
7	*.sovintel.net	21	0	0.0 KB	0	0	0	00:00:23
8	*.195.98.62.132.dialup.kis.ru	2	0	0.0 KB	0	0	0	00:00:11
9	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:03
10	*.samara.dial.rol.ru	1	0	0.0 KB	0	0	0	00:12:02
11	*.nnovgorod.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:24
12	*.nsk.dial.rol.ru	19	0	0.0 KB	0	0	0	00:01:08
13	*.moscow.dial.rol.ru	10	0	0.0 KB	0	0	0	00:29:33
14	unresolved	45	0	0.0 KB	0	0	0	07:24:45
15	*.tony.pp.ru	99	0	0.0 KB	0	0	0	00:27:38
16	*.syktyvkar.dial.rol.ru	14	0	0.0 KB	0	0	0	00:01:44
17	*.rol.ru	5820	0	0.0 KB	0	0	0	00:19:14
18	*.nn.ru	51	0	0.0 KB	0	0	0	00:00:21
19	*.komi.com	1	0	0.0 KB	0	0	0	00:05:09

TOTAL: 19		6124	36721	3.0 GB	28	0	0	35:59:22

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	21.784	191.640	0.000	24:19:59
194.154.66.131	0.072	0.108	0.000	07:24:45
ts1-a180.saratov.dial.rol.ru	0.132	0.220	0.000	01:46:55
nat-cc.cc.gldn.net	0.168	0.156	0.000	00:39:37
net1-x-ring.tony.pp.ru	30.792	279.395	0.000	00:27:38
ts1-b239.samara.dial.rol.ru	3.204	1.028	0.000	00:12:02
ts27-a195.moscow.dial.rol.ru	0.012	0.008	0.000	00:10:17
ts23-a110.moscow.dial.rol.ru	0.012	0.000	0.000	00:10:10
balancer-b.rol.ru	3.656	3.812	0.000	00:09:44
balancer-a.rol.ru	3.696	3.624	0.000	00:09:30
ts18-a139.moscow.dial.rol.ru	0.104	0.076	0.000	00:08:45
main.komi.com	0.080	0.044	0.000	00:05:09
ts1-a138.krasnoyarsk.dial.rol.ru	0.016	0.024	0.000	00:03:18
?	0.052	0.044	0.000	00:02:31
ts12-a32.spb.dial.rol.ru	0.012	0.012	0.000	00:02:04
ts2-b100.syktyvkar.dial.rol.ru	0.052	0.076	0.000	00:01:44
dynip.195.98.62.131.dialup.kis.ru	0.008	0.004	0.000	00:01:26
ts2-a73.nsk.dial.rol.ru	0.056	0.012	0.000	00:01:08
ts1-b88.krasnoyarsk.dial.rol.ru	0.012	0.004	0.000	00:00:46
ts4-a63.nnovgorod.dial.rol.ru	0.000	0.004	0.000	00:00:24

TOTAL: 35	64.320	480.627	0.000	35:59:46

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2912
balancer-a.rol.ru	2908
net1-x-ring.tony.pp.ru	99
gray.nn.ru	51
194.154.66.131	45
fw-nat.sovintel.net	21
ts2-a73.nsk.dial.rol.ru	19
ts2-b100.syktyvkar.dial.rol.ru	14
ts24-a68.moscow.dial.rol.ru	3
ts1-b88.krasnoyarsk.dial.rol.ru	3
ts23-a110.moscow.dial.rol.ru	2
dynip.195.98.62.132.dialup.kis.ru	2
ts18-a139.moscow.dial.rol.ru	2
main.komi.com	1
ts27-a195.moscow.dial.rol.ru	1
news.lek.ru	1
ts24-a90.moscow.dial.rol.ru	1
ts5-b178.spb.dial.rol.ru	1
ts24-a80.moscow.dial.rol.ru	1
ts1-b239.samara.dial.rol.ru	1

TOTAL: 21	6089

NNRP no permission clients:

System	Conn

82.140.73.76	25
83.167.112.102	11
29-7.kartel.komi.com	8
195.28.36.242	1
dsl540098de.pool.t-online.hu	1
83.220.64.120	1
m9x.olven.ru	1

TOTAL: 7	48

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	49

TOTAL: 1	49

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	5	0
nat-cc.cc.gldn.net	2	0
ts27-a195.moscow.dial.rol.ru	1	0
ts23-a110.moscow.dial.rol.ru	1	0
ts1-a180.saratov.dial.rol.ru	1	0
ts1-b239.samara.dial.rol.ru	1	0

TOTAL: 6	11	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	37400	99.9%
2	fido7	17	0.0%
3	0	8	0.0%
4	hr	1	0.0%

TOTAL: 4		37426	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	25614
2	alt.binaries.pictures.bras	7846
3	alt.binaries.pictures.artpics	3939
4	fido7.ru.delphi	16
5	0.test	8
6	alt.binaries.pictures.erotica.orgasm	1
7	fido7.ru.linux	1
8	hr.rec.humor	1

TOTAL: 8		37426