Daily Usenet report

Nov 30 03:00:02 -- Dec 1 03:00:03

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
Newsgroups removed
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 / 10 lines (50.0%)
Nov 30 13:36:53 perseus controlchan[2945]: skipping newgroup alt.fr.fan.jl y henry.gale@no-log.invalid (would be created)
Nov 30 16:20:47 perseus controlchan[2945]: Unknown "cmsg" control by starfield.bbs@bbs.wretch.cc
Nov 30 16:50:38 perseus controlchan[2945]: Unknown "cmsg" control by DSES.bbs@bbs.wretch.cc
Nov 30 18:20:41 perseus controlchan[2945]: Unknown "cmsg" control by ysean.bbs@bbs.wretch.cc
Nov 30 19:21:16 perseus controlchan[2945]: Unknown "cmsg" control by foro.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2070829	98.1%	182.7 MB	97.5%
nnrpd	20003	0.9%	2.0 MB	1.1%
innd	17416	0.8%	2.3 MB	1.2%
cnfsstat	2304	0.1%	399.9 KB	0.2%
controlchan	20	0.0%	2.3 KB	0.0%

TOTAL: 5	2110572	100.0%	187.4 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2050364	97.5%
Negative hits	43377	2.1%
Positive hits	6321	0.3%
Cache misses	2705	0.1%

TOTAL: 4	2102767	100.0%

INND timer:

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

article cancel	00:03:13.479	0.2%	20078	0.000	9.636	1181.000
article cleanup	00:00:22.681	0.0%	2042224	0.000	0.011	0.023
article logging	00:02:00.983	0.1%	2051744	0.003	0.059	4.141
article parse	00:17:11.100	1.2%	159462240	0.005	0.006	0.121
article write	09:10:55.058	38.2%	1996575	3.137	16.556	7034.632
artlog/artcncl	00:00:03.294	0.0%	19817	0.000	0.166	133.905
artlog/artparse	00:00:00.000	0.0%	57	0.000	0.000	0.000
data move	00:03:29.738	0.2%	168943134	0.000	0.001	0.009
hisgrep/artcncl	00:02:54.726	0.2%	7978	0.000	21.901	1181.000
hishave/artcncl	00:00:09.874	0.0%	20078	0.000	0.492	146.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:16:45.020	1.2%	2084173	0.000	0.482	11.895
history sync	00:00:00.609	0.0%	291	0.000	2.093	323.000
history write	01:04:26.017	4.5%	1996575	0.000	1.936	32.994
hiswrite/artcncl	00:00:05.450	0.0%	12100	0.000	0.450	966.000
idle	08:28:08.812	35.3%	151431429	0.000	0.201	725.500
nntp read	00:19:09.038	1.3%	158303900	0.005	0.007	0.121
overview write	03:52:58.963	16.2%	1996575	1.037	7.001	185.903
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%	15	0.000	0.000	0.000

TOTAL: 24:00:40.323	23:41:54.842	98.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:02:20.146	0.5%	7330	0.000	19.120	19.120
idle	07:16:38.445	86.7%	22854	0.000	1146.340	200635.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:36:24.069	7.2%	176543	0.000	12.371	2260.269
readart	00:08:58.504	1.8%	16124	0.000	33.398	705.333

TOTAL: 08:23:50.262	08:04:21.164	96.1%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Newsgroups removed:

Group

comp.file-sharing.bittorrent
misc.phone.mobile
misc.phone.mobile.iphone
rec.arts.tv.news.oreilly-factor

TOTAL: 4

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

henry.gale@no-log.invalid	1	0	0	0	0	1
it-alt@x-privat.org	3	0	1	0	0	4
news@news.belwue.de	0	0	1	0	0	1

TOTAL	4	0	2	0	0	6

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	340	2000083	1959275	14	40794	97%	467:35:15

TOTAL: 1		340	2000083	1959275	14	40794	97%	467:35:15

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	369.5 GB	995.8 KB	369.5 GB	99%	193.7 KB	467:35:15

TOTAL: 1		369.5 GB	995.8 KB	369.5 GB	99%	193.7 KB	467:35:15

Incoming articles:

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

Nov 30 03:00:02 - 03:59:59	80553	4.0%	22.39	15.8 GB	4.3%	4618.73
Nov 30 04:00:00 - 04:59:59	79886	4.0%	22.19	15.6 GB	4.2%	4541.81
Nov 30 05:00:00 - 05:59:59	76971	3.9%	21.38	15.1 GB	4.1%	4386.19
Nov 30 06:00:00 - 06:59:59	76041	3.8%	21.12	15.1 GB	4.1%	4397.94
Nov 30 07:00:00 - 07:59:59	82951	4.2%	23.04	16.6 GB	4.5%	4844.89
Nov 30 08:00:00 - 08:59:59	81547	4.1%	22.65	17.6 GB	4.8%	5115.53
Nov 30 09:00:00 - 09:59:59	77529	3.9%	21.54	15.6 GB	4.2%	4541.66
Nov 30 10:00:00 - 10:59:59	68848	3.4%	19.12	13.5 GB	3.7%	3939.38
Nov 30 11:00:00 - 11:59:59	76369	3.8%	21.21	14.7 GB	4.0%	4276.65
Nov 30 12:00:00 - 12:59:59	80664	4.0%	22.41	14.7 GB	4.0%	4292.96
Nov 30 13:00:00 - 13:59:59	83122	4.2%	23.09	15.7 GB	4.3%	4571.32
Nov 30 14:00:00 - 14:59:59	79032	4.0%	21.95	14.9 GB	4.1%	4341.91
Nov 30 15:00:00 - 15:59:59	75690	3.8%	21.02	14.1 GB	3.8%	4114.35
Nov 30 16:00:00 - 16:59:59	85885	4.3%	23.86	14.8 GB	4.0%	4311.57
Nov 30 17:00:00 - 17:59:59	83871	4.2%	23.30	15.4 GB	4.2%	4471.26
Nov 30 18:00:00 - 18:59:59	85539	4.3%	23.76	14.9 GB	4.0%	4325.60
Nov 30 19:00:00 - 19:59:59	94417	4.7%	26.23	15.8 GB	4.3%	4613.49
Nov 30 20:00:00 - 20:59:59	90472	4.5%	25.13	16.5 GB	4.5%	4813.36
Nov 30 21:00:00 - 21:59:59	91453	4.6%	25.40	16.8 GB	4.6%	4880.73
Nov 30 22:00:00 - 22:59:59	86519	4.3%	24.03	15.3 GB	4.2%	4452.42
Nov 30 23:00:00 - 23:59:59	86526	4.3%	24.04	14.5 GB	3.9%	4230.01
Dec 1 00:00:00 - 00:59:59	86521	4.3%	24.03	13.4 GB	3.6%	3893.65
Dec 1 01:00:00 - 01:59:59	95251	4.8%	26.46	15.3 GB	4.2%	4470.33
Dec 1 02:00:00 - 02:59:59	90040	4.5%	25.01	16.1 GB	4.4%	4685.35
Dec 1 03:00:00 - 03:00:03	91	0.0%	30.33	17.9 MB	0.0%	6093.19

TOTAL: 24:00:01	1995788	100.0%	23.10	367.8 GB	100.0%	4463.85

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	33.7 GB	24.4%	117	741.61	2.26
02	BIN	137.8 GB	90.9 GB	66.0%	117	742.97	2.25
03	SMALL	13.0 GB	12.8 GB	98.5%	7	6.19	25.57
04	BIN	80.1 GB	56.3 GB	70.3%	81	373.37	2.60
05	BIN	80.1 GB	69.0 GB	86.2%	101	373.45	2.60
06	SMALL	13.0 GB	12.8 GB	98.2%	7	6.19	25.57
07	BIN	80.1 GB	43.5 GB	54.3%	81	373.40	2.60
08	BIN	80.1 GB	57.7 GB	72.0%	101	373.37	2.60
09	SMALL	13.0 GB	12.2 GB	93.7%	7	6.20	25.52
10	BIN	80.1 GB	33.7 GB	42.1%	81	372.32	2.61
11	BIN	80.1 GB	76.1 GB	95.0%	101	374.40	2.60
12	SMALL	13.0 GB	12.7 GB	97.1%	7	6.20	25.52
13	BIN	80.1 GB	31.2 GB	39.0%	81	372.28	2.61
14	BIN	80.1 GB	54.2 GB	67.7%	101	373.76	2.60

TOTAL: 14	-	968.5 GB	597.0 GB	61.6%	990	321.54	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	55167	42040	0	1035	0	0	0	0	12092
2	?	57	0	0	0	0	0	0	0	57

TOTAL: 2		55224	42040	0	1035	0	0	0	0	12149

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.game	3266
microsoft.public.test	1165
alt.binaries.pictures.amateur.butts	821
alt.binaries.usenet-world.com	448
alt.binaries.pictures.erotica.asian.female	418
it-alt.community.cibba	377
alt.test.misc	322
alt.binaries.pictures.erotica.erotic	315
alt.binaries.erotica.voyerism.hidden-camera	314
alt.binaries.picture.erotica.anal	311
alt.binaries.pictures.erotica.amateur.digicam	295
alt.binaries.pictures.erotica.breasts.sm	280
alt.binaries.pictures.erotica.brests	276
alt.binaries.picture.erotica.amature	265
alt.binaries.picturea.erotica	261
alt.binaries.pictuers.erotica.female	240
alt.binaries.pictures.erotica.goo-shot	231
alt.binaries.lanfer	224
alt.binaries.erotica.kinky.teens	221
alt.binaries.pictures.erotica.voyeuris	214

TOTAL: 2086	42040

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	9521
	TOTAL: 1	9521

TOTAL: 1		9521

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	2	7330	718.4 MB	3	0	0	04:37:46
2	194.154.66.148	119	830	12.5 MB	44	0	0	01:37:51
3	ts30-b225.moscow.dial.rol.ru	6	71	101.7 KB	2	0	0	00:11:55

TOTAL: 3		127	8231	731.0 MB	49	0	2	08:23:12

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	2	7330	718.4 MB	3	0	0	04:37:46
2	unresolved	146	830	12.5 MB	44	0	0	01:57:12
3	*.moscow.dial.rol.ru	16	71	101.7 KB	2	0	0	00:48:00
4	*.ufa.dial.rol.ru	3	0	0.0 KB	0	0	0	00:00:08
5	*.krasnodar.dial.rol.ru	1	0	0.0 KB	0	0	0	00:10:01
6	*.krasnoyarsk.dial.rol.ru	3	0	0.0 KB	0	0	0	00:02:59
7	*.sovintel.net	13	0	0.0 KB	0	0	0	00:00:19
8	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:02
9	*.nsk.dial.rol.ru	26	0	0.0 KB	0	0	0	00:00:22
10	*.cc.gldn.net	2	0	0.0 KB	0	0	0	00:20:00
11	*.tony.pp.ru	72	0	0.0 KB	0	0	0	00:03:10
12	*.rol.ru	5793	0	0.0 KB	0	0	0	00:20:39
13	*.nn.ru	1	0	0.0 KB	0	0	0	00:00:02
14	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00

TOTAL: 14		6080	8231	731.0 MB	49	0	1	08:22:47

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	3.448	32.382	0.000	04:37:46
194.154.66.148	0.364	0.652	0.000	01:37:51
ts16-a194.moscow.dial.rol.ru	0.068	0.060	0.000	00:23:24
nat-ie.cc.gldn.net	0.004	0.008	0.000	00:20:00
ts18-a254.moscow.dial.rol.ru	0.020	0.008	0.000	00:12:40
ts30-b225.moscow.dial.rol.ru	0.008	0.028	0.000	00:11:55
balancer-a.rol.ru	3.444	3.800	0.000	00:11:18
212.46.236.236	0.032	0.004	0.000	00:10:27
ts1-a15.krasnodar.dial.rol.ru	0.000	0.000	0.000	00:10:01
balancer-b.rol.ru	3.584	3.584	0.000	00:09:20
194.154.66.92	0.044	0.028	0.000	00:08:53
net1-x-ring.tony.pp.ru	0.108	0.168	0.000	00:03:10
ts2-a50.krasnoyarsk.dial.rol.ru	0.028	0.020	0.000	00:02:59
?	0.020	0.028	0.000	00:01:59
fw-nat.sovintel.net	0.192	0.060	0.000	00:00:19
ts2-a133.nsk.dial.rol.ru	0.012	0.020	0.000	00:00:16
cornholio.migtel.ru	0.240	0.208	0.000	00:00:13
ts2-a141.ufa.dial.rol.ru	0.000	0.004	0.000	00:00:08
ts2-b250.nsk.dial.rol.ru	0.020	0.008	0.000	00:00:06
195.46.181.141	0.000	0.016	0.000	00:00:03

TOTAL: 29	11.696	41.158	0.000	08:23:12

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2908
balancer-a.rol.ru	2885
net1-x-ring.tony.pp.ru	72
194.154.66.92	18
fw-nat.sovintel.net	13
ts2-a133.nsk.dial.rol.ru	13
ts2-b250.nsk.dial.rol.ru	13
ts16-a194.moscow.dial.rol.ru	6
212.46.236.236	6
ts18-a254.moscow.dial.rol.ru	4
ts2-a141.ufa.dial.rol.ru	3
ts2-a50.krasnoyarsk.dial.rol.ru	3
195.98.59.67	3
nat-ie.cc.gldn.net	2
news.lek.ru	1
gray.nn.ru	1
ts1-a15.krasnodar.dial.rol.ru	1
cappa.tr155m.lavtech.ru	1

TOTAL: 18	5953

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	154
195.46.181.141	4
85.113.148.26	2
78-106-254-195.broadband.corbina.ru	2
bzq-79-177-164-19.red.bezeqint.net	2
host-211-145-66-217.spbmts.ru	1
78-106-219-231.broadband.corbina.ru	1

TOTAL: 7	166

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	29

TOTAL: 1	29

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.148	4	0
nat-ie.cc.gldn.net	2	0
ts1-a15.krasnodar.dial.rol.ru	1	0
ts18-a254.moscow.dial.rol.ru	1	0
ts16-a194.moscow.dial.rol.ru	1	0
ts30-b225.moscow.dial.rol.ru	1	0
212.46.236.236	1	0

TOTAL: 7	11	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	9966	97.9%
2	hr	71	0.7%
3	comp	62	0.6%
4	sci	49	0.5%
5	alive	18	0.2%
6	france	8	0.1%
7	perl	4	0.0%
8	nctu	2	0.0%
9	fidonet	2	0.0%

TOTAL: 9		10182	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	5414
2	alt.binaries.pictures.bras	2956
3	alt.binaries.pictures.artpics	911
4	alt.binaries.dvd.music	272
5	alt.binaries.appletv.musicvideos	128
6	alt.binaries.sounds.midi.originals	124
7	alt.binaries.pictures.fine-art	99
8	hr.rec.humor	66
9	comp.music.midi	62
10	sci.fractals	49
11	alt.binaries.pictures.fractals	18
12	alt.bainaries.pictures.fine-art.digitized	8
13	france.midi-pyrenees.toulouse	8
14	alt.bainaries.pictures.furniture	7
15	alt.bainaries.pictures.fine-art.graphics	7
16	alive.music.1960s	6
17	alt.binaries.sounds.midi.french	6
18	hr.talk.razno	5
19	perl.midi	4
20	alive.music.jazz	4
21	alive.music.charts	3
22	alt.music.midiweb	3
23	alt.binaries.dvd.music.d	3
24	alive.music	3
25	alt.fr.geo.midi-pyrenees	3
26	nctu.club.midi	2
27	fidonet.midi-net	2
28	alive.music.metal	2
29	alt.sounds.midi.originals	2
30	alt.binaries.sounds.midi.d	2
31	alt.binaries.sounds.midi.classical.sequencing	2
32	alt.binaries.sounds.midi	1

TOTAL: 32		10182