Daily Usenet report

Oct 12 03:00:04 -- Oct 13 03:00:02

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
Newsgroups created
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 / 90 lines (5.6%)
Oct 12 05:55:43 andromeda controlchan[23158]: Unknown "cmsg" control by j8902.bbs@bbs.wretch.cc
Oct 12 05:57:16 andromeda controlchan[23158]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Oct 12 05:58:42 andromeda controlchan[23158]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Oct 12 06:00:02 andromeda controlchan[23158]: Unknown "cmsg" control by maxell.bbs@bbs.wretch.cc
Oct 12 06:03:35 andromeda controlchan[23158]: Unknown "cmsg" control by anor94216.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2433013	98.4%	211.9 MB	97.7%
nnrpd	20204	0.8%	2.1 MB	1.0%
innd	16780	0.7%	2.4 MB	1.1%
cnfsstat	2304	0.1%	405.4 KB	0.2%
controlchan	96	0.0%	11.7 KB	0.0%
expireover	2	0.0%	0.2 KB	0.0%

TOTAL: 6	2472399	100.0%	216.7 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2339059	94.9%
Positive hits	79309	3.2%
Negative hits	41146	1.7%
Cache misses	5163	0.2%

TOTAL: 4	2464677	100.0%

INND timer:

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

article cancel	00:01:23.532	0.1%	84989	0.000	0.983	739.333
article cleanup	00:00:37.072	0.0%	2334671	0.007	0.016	0.029
article logging	00:02:08.797	0.1%	2413009	0.006	0.053	4.296
article parse	00:22:55.825	1.6%	168210329	0.006	0.008	0.027
article write	09:55:37.684	41.4%	2306548	4.215	15.494	26.224
artlog/artcncl	00:00:00.345	0.0%	19128	0.000	0.018	6.957
artlog/artparse	00:00:00.002	0.0%	73	0.000	0.027	1.000
data move	00:06:03.207	0.4%	178208315	0.002	0.002	0.005
hisgrep/artcncl	00:01:17.546	0.1%	84046	0.000	0.923	530.000
hishave/artcncl	00:00:04.873	0.0%	84989	0.000	0.057	238.667
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:20:27.646	1.4%	2379913	0.001	0.516	10.357
history sync	00:00:00.476	0.0%	290	0.000	1.641	62.000
history write	01:04:54.789	4.5%	2306548	0.041	1.689	11.337
hiswrite/artcncl	00:00:00.188	0.0%	943	0.000	0.199	26.000
idle	06:46:13.023	28.2%	157511665	0.120	0.155	0.970
nntp read	00:25:51.119	1.8%	166554123	0.007	0.009	0.028
overview write	04:17:14.008	17.9%	2306548	0.847	6.691	2483.307
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%	89	0.000	0.022	1.000

TOTAL: 23:59:28.418	23:24:50.134	97.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:17:39.510	1.9%	23617	0.000	44.862	64.924
idle	13:22:51.681	85.0%	166071	0.000	290.067	202338.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:51:31.597	5.5%	503427	0.000	6.141	8810.500
readart	00:15:34.393	1.6%	48610	0.000	19.222	486.357

TOTAL: 15:44:57.265	14:47:37.181	93.9%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Newsgroups created:

Group	Mode

comp.internet.services.wiki	y
rec.arts.tv.comedy.the-office	y
rec.media.players.portable	y
rec.media.players.portable.ipod	y

TOTAL	4

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

group-admin@isc.org	4	0	0	0	4	4

TOTAL	4	0	0	0	4	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	365	2369923	2342672	48	27203	98%	472:57:24

TOTAL: 1		365	2369923	2342672	48	27203	98%	472:57:24

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	420.4 GB	9.9 MB	420.4 GB	99%	186.0 KB	472:57:24

TOTAL: 1		420.4 GB	9.9 MB	420.4 GB	99%	186.0 KB	472:57:24

Incoming articles:

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

Oct 12 03:00:04 - 03:59:59	116759	5.1%	32.47	16.7 GB	4.0%	4880.47
Oct 12 04:00:00 - 04:59:59	91897	4.0%	25.53	17.7 GB	4.2%	5160.86
Oct 12 05:00:00 - 05:59:59	91361	4.0%	25.38	17.5 GB	4.1%	5089.26
Oct 12 06:00:00 - 06:59:59	86265	3.7%	23.96	15.7 GB	3.7%	4575.40
Oct 12 07:00:00 - 07:59:59	81893	3.5%	22.75	14.6 GB	3.5%	4250.49
Oct 12 08:00:00 - 08:59:59	93638	4.1%	26.01	17.6 GB	4.2%	5123.21
Oct 12 09:00:00 - 09:59:59	86469	3.7%	24.02	16.4 GB	3.9%	4782.06
Oct 12 10:00:00 - 10:59:59	85569	3.7%	23.77	16.4 GB	3.9%	4781.50
Oct 12 11:00:00 - 11:59:59	94514	4.1%	26.25	17.9 GB	4.2%	5199.25
Oct 12 12:00:00 - 12:59:59	97605	4.2%	27.11	18.6 GB	4.4%	5416.20
Oct 12 13:00:00 - 13:59:59	103466	4.5%	28.74	18.6 GB	4.4%	5412.30
Oct 12 14:00:00 - 14:59:59	101456	4.4%	28.18	18.2 GB	4.3%	5315.22
Oct 12 15:00:00 - 15:59:59	97513	4.2%	27.09	17.0 GB	4.0%	4942.23
Oct 12 16:00:00 - 16:59:59	100391	4.4%	27.89	17.1 GB	4.1%	4986.80
Oct 12 17:00:00 - 17:59:59	95565	4.1%	26.55	17.4 GB	4.1%	5081.43
Oct 12 18:00:00 - 18:59:59	100454	4.4%	27.90	18.1 GB	4.3%	5272.69
Oct 12 19:00:00 - 19:59:59	96431	4.2%	26.79	18.6 GB	4.4%	5403.44
Oct 12 20:00:00 - 20:59:59	99876	4.3%	27.74	18.7 GB	4.4%	5436.05
Oct 12 21:00:00 - 21:59:59	101502	4.4%	28.20	19.1 GB	4.5%	5574.34
Oct 12 22:00:00 - 22:59:59	99899	4.3%	27.75	18.2 GB	4.3%	5306.56
Oct 12 23:00:00 - 23:59:59	102696	4.5%	28.53	18.6 GB	4.4%	5422.65
Oct 13 00:00:00 - 00:59:59	89557	3.9%	24.88	16.6 GB	3.9%	4826.49
Oct 13 01:00:00 - 01:59:59	96369	4.2%	26.77	17.9 GB	4.2%	5217.67
Oct 13 02:00:00 - 02:59:59	96131	4.2%	26.70	18.4 GB	4.4%	5357.65
Oct 13 03:00:00 - 03:00:02	77	0.0%	38.50	13.9 MB	0.0%	7129.86

TOTAL: 23:59:58	2307353	100.0%	26.71	421.6 GB	100.0%	5117.32

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	34.8 GB	25.2%	80	831.64	2.01
02	BIN	137.8 GB	51.9 GB	37.6%	80	848.51	1.97
03	SMALL	13.0 GB	11.4 GB	87.7%	4	5.23	30.24
04	BIN	80.1 GB	4.0 GB	5.0%	53	429.01	2.27
05	BIN	80.1 GB	55.8 GB	69.6%	69	430.39	2.26
06	SMALL	13.0 GB	11.3 GB	86.7%	4	5.23	30.26
07	BIN	80.1 GB	79.7 GB	99.5%	52	427.90	2.27
08	BIN	80.1 GB	52.3 GB	65.3%	69	429.14	2.27
09	SMALL	13.0 GB	11.4 GB	87.3%	4	5.27	30.05
10	BIN	80.1 GB	76.3 GB	95.2%	52	426.40	2.28
11	BIN	80.1 GB	61.7 GB	77.0%	69	430.41	2.26
12	SMALL	13.0 GB	11.4 GB	87.3%	4	5.28	29.95
13	BIN	80.1 GB	75.8 GB	94.6%	52	426.65	2.28
14	BIN	80.1 GB	52.7 GB	65.9%	69	429.60	2.26

TOTAL: 14	-	968.5 GB	590.3 GB	61.0%	661	368.11	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	106461	27729	0	385	0	0	0	0	78347
2	?	73	0	0	0	0	0	0	0	73

TOTAL: 2		106534	27729	0	385	0	0	0	0	78420

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.erotica.freckles	524
alt.binaries.pictures.amateur.butts	469
alt.pedophilia	454
alt.binaries.fetish	263
alt.binaries.pictures.erotica.fetish.urine	250
alt.binaries.multimedia.bisexual	245
alt.binaries.totally.fetish.photo	243
cn.bbs.soc.railway	235
pedo.japanese.fetish.lolita	223
alt.biniaries.erotica	215
alt.binaries.pictures.erotica.asian.female	196
cakewalk.coffeehouse	195
alt.binaries.pictures.erotica.voyeuris	160
alt.binaries.pictures.pictures.erotica	159
alt.binaries.pictures.fetish.urine	157
alt.binaries.picutures.erotica	156
alt.binaries.pictures.erotica.voyerism	154
alt.binaries.pictures.erotica.highheels	153
alt.binaries.pictures.erotica.gay	150
alt.binaries.pictures.erotica.india	148

TOTAL: 2322	27729

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	41
	TOTAL: 1	41
Including strange strings
	192.168.33.37	78334
	TOTAL: 1	78334

TOTAL: 2		78375

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	6	23617	788.9 MB	15	0	0	11:47:01
2	ts1-a212.saratov.dial.rol.ru	2	81	164.6 KB	2	0	0	00:10:59
3	ts30-b2.moscow.dial.rol.ru	9	47	1.4 MB	6	0	0	00:06:56
4	news.lek.ru	1	30	1.4 MB	1	0	0	00:02:52
5	194.67.5.187	8	21	1.1 MB	7	0	0	00:36:11
6	ts16-a198.moscow.dial.rol.ru	3	17	1.7 MB	1	0	0	00:21:02
7	ts1-a46.krasnodar.dial.rol.ru	20	10	22.5 KB	12	0	0	00:44:18
8	ts2-a190.syktyvkar.dial.rol.ru	5	7	492.1 KB	2	0	0	00:17:54
9	ts2-a19.syktyvkar.dial.rol.ru	1	2	149.6 KB	1	0	0	00:00:39
10	ts2-a138.syktyvkar.dial.rol.ru	3	2	260.7 KB	1	0	0	00:21:11

TOTAL: 10		58	23834	795.5 MB	48	0	0	15:44:22

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	6	23617	788.9 MB	15	0	0	11:47:01
2	*.saratov.dial.rol.ru	2	81	164.6 KB	2	0	0	00:10:59
3	*.moscow.dial.rol.ru	23	64	3.1 MB	7	0	0	00:28:43
4	*.lek.ru	1	30	1.4 MB	1	0	0	00:02:52
5	unresolved	18	21	1.1 MB	7	0	0	00:46:33
6	*.syktyvkar.dial.rol.ru	9	11	902.3 KB	4	0	0	00:39:45
7	*.krasnodar.dial.rol.ru	20	10	22.5 KB	12	0	0	00:44:18
8	*.sovintel.net	16	0	0.0 KB	0	0	0	00:00:26
9	*.pcs-net.net	1	0	0.0 KB	0	0	0	00:00:01
10	*.bryansk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:01:23
11	*.nsk.dial.rol.ru	19	0	0.0 KB	0	0	0	00:00:16
12	*.dynadsl.kis.ru	2	0	0.0 KB	0	0	0	00:00:04
13	*.bytecity.ru	3	0	0.0 KB	0	0	0	00:00:00
14	*.tony.pp.ru	76	0	0.0 KB	0	0	0	00:37:49
15	*.rol.ru	5798	0	0.0 KB	0	0	0	00:20:34
16	*.nn.ru	63	0	0.0 KB	0	0	0	00:00:36

TOTAL: 16		6058	23834	795.5 MB	48	0	0	15:43:18

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	19.428	184.366	0.000	11:47:01
ts1-a46.krasnodar.dial.rol.ru	0.072	0.188	0.000	00:44:18
net1-x-ring.tony.pp.ru	41.448	431.980	0.000	00:37:49
194.67.5.187	0.128	0.224	0.000	00:36:11
ts2-a138.syktyvkar.dial.rol.ru	0.012	0.008	0.000	00:21:11
ts16-a198.moscow.dial.rol.ru	0.016	0.024	0.000	00:21:02
ts2-a190.syktyvkar.dial.rol.ru	0.056	0.068	0.000	00:17:54
ts1-a212.saratov.dial.rol.ru	0.008	0.056	0.000	00:10:59
balancer-b.rol.ru	3.844	3.904	0.000	00:10:26
balancer-a.rol.ru	3.820	4.032	0.000	00:10:07
194.186.71.137	0.008	0.000	0.000	00:10:00
ts30-b2.moscow.dial.rol.ru	0.020	0.060	0.000	00:06:56
news.lek.ru	0.000	0.028	0.000	00:02:52
?	0.004	0.032	0.000	00:01:50
ts2-a84.bryansk.dial.rol.ru	0.024	0.008	0.000	00:01:23
82.140.73.76	0.224	0.284	0.000	00:00:59
ts2-a19.syktyvkar.dial.rol.ru	0.004	0.000	0.000	00:00:39
gray.nn.ru	0.132	0.136	0.000	00:00:36
ts18-a239.moscow.dial.rol.ru	0.016	0.020	0.000	00:00:34
fw-nat.sovintel.net	0.112	0.048	0.000	00:00:26

TOTAL: 34	69.512	625.682	0.000	15:44:22

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2915
balancer-a.rol.ru	2883
net1-x-ring.tony.pp.ru	76
gray.nn.ru	63
ts2-b202.nsk.dial.rol.ru	19
fw-nat.sovintel.net	16
ts23-a43.moscow.dial.rol.ru	10
212.46.236.218	9
news.bytecity.ru	3
dyn-19-140.dynadsl.kis.ru	2
194.186.71.137	1
ts18-a239.moscow.dial.rol.ru	1
ts2-a84.bryansk.dial.rol.ru	1
news.pcs-net.net	1

TOTAL: 14	6000

NNRP no permission clients:

System	Conn

82.140.73.76	130
cornholio.migtel.ru	8
pppoe-198.9.110.89-adsl.spbnit.ru	5
82-208-101-228.dialup.mts-nn.ru	2
83.237.145.79	2
host-212-145-66-217.spbmts.ru	1
195.28.36.242	1
83.167.116.18	1
host-219-145-66-217.spbmts.ru	1

TOTAL: 9	151

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	28

TOTAL: 1	28

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a190.syktyvkar.dial.rol.ru	2	0
194.67.5.187	2	0
ts2-a138.syktyvkar.dial.rol.ru	2	0
194.186.71.137	1	0
ts16-a198.moscow.dial.rol.ru	1	0
ts1-a46.krasnodar.dial.rol.ru	1	0

TOTAL: 6	9	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	24230	99.6%
2	fido7	81	0.3%
3	hr	16	0.1%
4	it	1	0.0%
5	comp	1	0.0%

TOTAL: 5		24329	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	18466
2	alt.binaries.pictures.artpics	3048
3	alt.binaries.pictures.bras	2598
4	fido7.su.windows	67
5	alt.binaries.pictures.erotic.asian.porn	30
6	alt.binaires.pictures.erotica.teen.female	27
7	alt.binaries.pictures.erotica	21
8	alt.sex.pantyhose	17
9	fido7.ru.linux	14
10	hr.sci.jezik	13
11	alt.binaries.nospam.female.bodyhair.pubes	9
12	alt.certification.cisco	8
13	alt.sex.binaries.erotica.teen	4
14	hr.rec.film.anime	2
15	alt.binaries.nospam.female.bodyhair	2
16	hr.soc.povijest	1
17	comp.realtime	1
18	it.comp.hardware.cpu	1

TOTAL: 18		24329