Daily Usenet report

Oct 31 03:00:01 -- Nov 1 03:00:02

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
Supposedly-moderated groups with unmoderated postings
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 / 19 lines (26.3%)
Oct 31 04:11:57 perseus controlchan[28409]: Unknown "cmsg" control by vaakaa.bbs@bbs.cs.nctu.edu.tw
Oct 31 05:16:53 perseus controlchan[28409]: Unknown "cmsg" control by kumokay.bbs@bbs.cs.nctu.edu.tw
Oct 31 07:36:07 perseus controlchan[28409]: Unknown "cmsg" control by fantasyff.bbs@bbs.cs.nctu.edu.tw
Oct 31 08:07:38 perseus controlchan[28409]: skipping newgroup alt.tv.supernatural y kev@evilcabal.org (would be created)
Oct 31 08:16:10 perseus controlchan[28409]: Unknown "cmsg" control by mrpopcorn.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	644865	95.5%	59.0 MB	94.5%
nnrpd	18200	2.7%	1.8 MB	2.8%
innd	9535	1.4%	1.3 MB	2.0%
cnfsstat	2304	0.3%	396.8 KB	0.6%
controlchan	22	0.0%	2.5 KB	0.0%

TOTAL: 5	674926	100.0%	62.5 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	628181	94.0%
Negative hits	37191	5.6%
Positive hits	2417	0.4%
Cache misses	770	0.1%

TOTAL: 4	668559	100.0%

INND timer:

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

article cancel	00:00:22.786	0.0%	4551	0.000	5.007	109.667
article cleanup	00:00:05.948	0.0%	627189	0.000	0.009	0.029
article logging	00:01:54.182	0.1%	640267	0.000	0.178	18.663
article parse	00:03:08.769	0.2%	45218625	0.001	0.004	0.009
article write	01:03:53.062	4.4%	577907	0.260	6.633	37.833
artlog/artcncl	00:00:02.708	0.0%	4523	0.000	0.599	51.231
artlog/artparse	00:00:00.000	0.0%	6	0.000	0.000	0.000
data move	00:00:48.475	0.1%	47826759	0.000	0.001	0.004
hisgrep/artcncl	00:00:10.707	0.0%	3110	0.000	3.443	125.000
hishave/artcncl	00:00:05.492	0.0%	4551	0.000	1.207	30.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:12:24.158	0.9%	664434	0.000	1.120	24.254
history sync	00:00:00.247	0.0%	327	0.000	0.755	11.000
history write	00:31:08.785	2.2%	577907	0.004	3.234	41.042
hiswrite/artcncl	00:00:03.846	0.0%	1441	0.000	2.669	153.000
idle	20:32:24.012	85.6%	44923239	0.831	1.646	25.173
nntp read	00:03:43.926	0.3%	45225906	0.001	0.005	0.011
overview write	01:24:17.195	5.9%	577907	0.682	8.751	71.884
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%	19	0.000	0.000	0.000

TOTAL: 24:00:06.381	23:54:34.298	99.6%	-	-	-	-

nnrpd timer:

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

idle	01:09:56.764	92.2%	6559	7.000	639.848	201465.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:01:10.265	1.5%	19096	0.000	3.680	653.314
readart	00:00:00.981	0.0%	33	0.000	29.727	30.500

TOTAL: 01:15:53.220	01:11:08.010	93.7%	-	-	-	-

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

hamstermumke@xs4all.nl	0	1	0	0	0	1
kev@evilcabal.org	1	0	0	0	0	1
news@news.belwue.de	0	0	1	0	0	1

TOTAL	1	1	1	0	0	3

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	891	630162	580910	6	49246	92%	442:36:38

TOTAL: 1		891	630162	580910	6	49246	92%	442:36:38

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	62.4 GB	209.4 KB	62.4 GB	99%	103.8 KB	442:36:38

TOTAL: 1		62.4 GB	209.4 KB	62.4 GB	99%	103.8 KB	442:36:38

Incoming articles:

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

Oct 31 03:00:01 - 03:59:59	20670	3.6%	5.74	2.5 GB	3.9%	723.00
Oct 31 04:00:00 - 04:59:59	22448	3.9%	6.24	3.2 GB	4.9%	920.18
Oct 31 05:00:00 - 05:59:59	21211	3.7%	5.89	3.3 GB	5.2%	971.14
Oct 31 06:00:00 - 06:59:59	21812	3.8%	6.06	2.4 GB	3.7%	696.54
Oct 31 07:00:00 - 07:59:59	16435	2.8%	4.57	1.8 GB	2.8%	516.45
Oct 31 08:00:00 - 08:59:59	17811	3.1%	4.95	2.3 GB	3.5%	659.30
Oct 31 09:00:00 - 09:59:59	20720	3.6%	5.76	2.8 GB	4.3%	805.33
Oct 31 10:00:00 - 10:59:59	19772	3.4%	5.49	2.7 GB	4.2%	783.32
Oct 31 11:00:00 - 11:59:59	21612	3.7%	6.00	2.7 GB	4.2%	779.22
Oct 31 12:00:00 - 12:59:59	22727	3.9%	6.31	3.1 GB	4.9%	903.03
Oct 31 13:00:00 - 13:59:59	25123	4.3%	6.98	3.2 GB	5.0%	929.90
Oct 31 14:00:00 - 14:59:59	28666	5.0%	7.96	3.3 GB	5.2%	962.17
Oct 31 15:00:00 - 15:59:59	27950	4.8%	7.76	3.0 GB	4.7%	870.41
Oct 31 16:00:00 - 16:59:59	27514	4.8%	7.64	3.2 GB	5.0%	922.90
Oct 31 17:00:00 - 17:59:59	25469	4.4%	7.07	2.6 GB	4.1%	764.38
Oct 31 18:00:00 - 18:59:59	25931	4.5%	7.20	2.5 GB	3.9%	721.57
Oct 31 19:00:00 - 19:59:59	32984	5.7%	9.16	2.8 GB	4.3%	807.12
Oct 31 20:00:00 - 20:59:59	28173	4.9%	7.83	2.8 GB	4.4%	824.68
Oct 31 21:00:00 - 21:59:59	23416	4.1%	6.50	2.3 GB	3.6%	672.67
Oct 31 22:00:00 - 22:59:59	22131	3.8%	6.15	1.7 GB	2.7%	496.27
Oct 31 23:00:00 - 23:59:59	23170	4.0%	6.44	2.3 GB	3.6%	673.63
Nov 1 00:00:00 - 00:59:59	27334	4.7%	7.59	1.4 GB	2.3%	419.97
Nov 1 01:00:00 - 01:59:59	26956	4.7%	7.49	2.7 GB	4.2%	784.77
Nov 1 02:00:00 - 02:59:59	27907	4.8%	7.75	3.4 GB	5.3%	985.76
Nov 1 03:00:00 - 03:00:02	34	0.0%	17.00	3.6 MB	0.0%	1822.88

TOTAL: 24:00:01	577976	100.0%	6.69	63.8 GB	100.0%	774.76

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	11.0 GB	8.0%	218	127.14	13.16
02	BIN	137.8 GB	101.8 GB	73.8%	218	126.53	13.22
03	SMALL	13.0 GB	5.8 GB	44.8%	19	4.19	37.79
04	BIN	80.1 GB	38.5 GB	48.1%	168	64.11	15.16
05	BIN	80.1 GB	63.4 GB	79.1%	188	63.94	15.20
06	SMALL	13.0 GB	5.8 GB	44.6%	19	4.23	37.36
07	BIN	80.1 GB	17.3 GB	21.6%	168	64.32	15.11
08	BIN	80.1 GB	45.4 GB	56.7%	188	64.20	15.14
09	SMALL	13.0 GB	4.8 GB	36.6%	19	4.21	37.61
10	BIN	80.1 GB	1.9 GB	2.4%	168	64.30	15.12
11	BIN	80.1 GB	4.6 GB	5.8%	189	63.89	15.21
12	SMALL	13.0 GB	5.6 GB	43.0%	19	4.17	37.94
13	BIN	80.1 GB	79.2 GB	98.9%	167	64.14	15.15
14	BIN	80.1 GB	46.8 GB	58.4%	188	64.00	15.19

TOTAL: 14	-	968.5 GB	431.9 GB	44.6%	1936	56.03	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	62361	49177	0	72	32	0	0	0	13080
2	?	6	0	0	0	0	0	0	0	6

TOTAL: 2		62367	49177	0	72	32	0	0	0	13086

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	6939
alt.binaries.amazing	1865
alt.binaries.boys	1753
alt.binaries.nospam.female.short-hair	1520
microsoft.public.test	1153
alt.binaries.southern-charms	1076
alt.binaries.pictures.amateur.butts	488
alt.binaries.pictures.blonde	423
alt.binaries.newstar	407
alt.binaries.picture.ls-series	389
alt.binaries.amberbigbutt	337
alt.binaires.pictures.erotica.teens	274
alt.binaires.erotica.teen	272
alt.binaires.erotica	271
alt.binaries.pictures.erotica.nipples	255
alt.binaries.pictures.erotica.voyeurism.hidden-cam	254
alt.binaries.erotica.early-teens	251
alt.binaires.pictures.erotica.amatuer.female	251
alt.binaries.erotic.erotika.young	250
alt.binaries.pictures.eroticia.teen.fuck	248

TOTAL: 2062	49177

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count

pl.rec.foto.cyfrowa	32

TOTAL: 1	32

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad newsgroups received
	SERVER	59
	TOTAL: 1	59
Including strange strings
	192.168.33.37	13080
	TOTAL: 1	13080

TOTAL: 2		13139

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	ts18-a156.moscow.dial.rol.ru	1	19	580.1 KB	4	0	0	00:09:57
2	195.218.244.87	2	14	964.7 KB	1	0	0	00:05:14

TOTAL: 2		3	33	1.5 MB	5	0	0	01:15:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.moscow.dial.rol.ru	1	19	580.1 KB	4	0	0	00:09:57
2	unresolved	2	14	964.7 KB	1	0	0	00:05:14
3	*.sovintel.net	17	0	0.0 KB	0	0	0	00:00:16
4	*.rol.kis.ru	1	0	0.0 KB	0	0	0	00:10:00
5	*.sarov.dial.rol.ru	3	0	0.0 KB	0	0	0	00:30:07
6	*.tony.pp.ru	71	0	0.0 KB	0	0	0	00:02:47
7	*.rol.ru	5762	0	0.0 KB	0	0	0	00:16:04

TOTAL: 7		5857	33	1.5 MB	5	0	0	01:15:41

NNRP total resource statistics [Top 20]:

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

ts2-a194.sarov.dial.rol.ru	0.000	0.000	0.000	00:10:04
ts2-a40.sarov.dial.rol.ru	0.004	0.000	0.000	00:10:01
rol69.rol.kis.ru	0.024	0.004	0.000	00:10:00
ts2-a86.sarov.dial.rol.ru	0.000	0.000	0.000	00:10:00
ts18-a156.moscow.dial.rol.ru	0.008	0.012	0.000	00:09:57
balancer-b.rol.ru	3.684	3.180	0.000	00:08:28
balancer-a.rol.ru	3.660	3.348	0.000	00:07:35
195.218.244.87	0.012	0.008	0.000	00:05:14
net1-x-ring.tony.pp.ru	0.140	0.120	0.000	00:02:47
?	0.000	0.000	0.000	00:01:13
fw-nat.sovintel.net	0.124	0.060	0.000	00:00:16
150.162.165.2	0.000	0.000	0.000	00:00:10
168.126.248.238	0.004	0.000	0.000	00:00:00

TOTAL: 13	7.660	6.732	0.000	01:15:53

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2881
balancer-a.rol.ru	2881
net1-x-ring.tony.pp.ru	71
fw-nat.sovintel.net	17
ts2-a40.sarov.dial.rol.ru	1
ts2-a194.sarov.dial.rol.ru	1
ts2-a86.sarov.dial.rol.ru	1
rol69.rol.kis.ru	1

TOTAL: 8	5854

NNRP no permission clients:

System	Conn

168.126.248.238	2
150.162.165.2	1

TOTAL: 2	3

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	13

TOTAL: 1	13

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a40.sarov.dial.rol.ru	1	0
ts2-a194.sarov.dial.rol.ru	1	0
ts2-a86.sarov.dial.rol.ru	1	0
rol69.rol.kis.ru	1	0

TOTAL: 4	4	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	33	100.0%

TOTAL: 1		33	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.lolita	14
2	alt.binaries.erotica.pornstars	14
3	alt.binaries.erotica.pregnant	5

TOTAL: 3		33