Daily Usenet report

Oct 18 03:00:01 -- Oct 19 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
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 client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 5 / 27 lines (18.5%)
Oct 18 06:31:06 andromeda expireover[17948]: buffindexed: ovgroupmmap ovbuff is null(ovindex is 13623, ovblock is 859386680
Oct 18 06:31:06 andromeda expireover[17948]: buffindexed: could not open overview for 'alt.binaries.music.classical'
Oct 18 09:23:13 andromeda controlchan[1289]: Unknown "cmsg" control by sofamm.bbs@bbs.cs.nctu.edu.tw
Oct 18 09:48:09 andromeda controlchan[1289]: Unknown "cmsg" control by JayBruce.bbs@bbs.cs.nctu.edu.tw
Oct 18 11:18:06 andromeda controlchan[1289]: Unknown "cmsg" control by isoguava.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	746762	95.7%	67.2 MB	94.6%
nnrpd	18968	2.4%	1.9 MB	2.7%
innd	12376	1.6%	1.6 MB	2.2%
cnfsstat	2304	0.3%	400.9 KB	0.6%
controlchan	27	0.0%	3.1 KB	0.0%
expireover	2	0.0%	0.3 KB	0.0%

TOTAL: 6	780439	100.0%	71.0 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	729972	95.2%
Negative hits	32217	4.2%
Positive hits	2803	0.4%
Cache misses	1935	0.3%

TOTAL: 4	766927	100.0%

INND timer:

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

article cancel	00:00:20.354	0.0%	9037	0.000	2.252	841.000
article cleanup	00:00:08.773	0.0%	726185	0.000	0.012	0.038
article logging	00:01:16.580	0.1%	737713	0.000	0.104	15.957
article parse	00:03:24.712	0.2%	38033044	0.002	0.005	0.094
article write	00:37:57.991	2.6%	674531	0.227	3.377	15.671
artlog/artcncl	00:00:04.316	0.0%	8941	0.000	0.483	74.105
artlog/artparse	00:00:00.000	0.0%	7	0.000	0.000	0.000
data move	00:01:13.286	0.1%	40971520	0.000	0.002	0.007
hisgrep/artcncl	00:00:06.541	0.0%	4588	0.000	1.426	764.000
hishave/artcncl	00:00:04.001	0.0%	9037	0.000	0.443	186.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:11:01.993	0.8%	758491	0.000	0.873	25.493
history sync	00:00:00.552	0.0%	318	0.000	1.736	6.000
history write	00:24:35.700	1.7%	726095	0.009	2.032	28.738
hiswrite/artcncl	00:00:04.230	0.0%	4449	0.000	0.951	841.000
idle	20:47:08.017	86.6%	37832509	0.000	1.978	16.063
nntp read	00:03:56.883	0.3%	38035879	0.003	0.006	0.114
overview write	01:40:46.867	7.0%	674531	1.166	8.965	1998.031
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%	23	0.000	0.000	0.000

TOTAL: 24:00:01.337	23:52:10.796	99.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:00:02.266	0.0%	99	0.000	22.889	460.000
idle	03:36:21.175	86.9%	32370	4.000	401.025	201621.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:29:45.271	11.9%	323322	0.000	5.522	4824.364
readart	00:00:09.114	0.1%	401	0.000	22.728	46.000

TOTAL: 04:09:02.375	04:06:17.826	98.9%	-	-	-	-

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

alteferians@alteferians.org	1	0	0	0	0	1
michiel@nospam.invalid	1	0	0	0	0	1

TOTAL	2	0	0	0	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	1556	747105	697618	61	49426	93%	356:06:08

TOTAL: 1		1556	747105	697618	61	49426	93%	356:06:08

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	55.0 GB	1.2 MB	55.0 GB	99%	77.3 KB	356:06:08

TOTAL: 1		55.0 GB	1.2 MB	55.0 GB	99%	77.3 KB	356:06:08

Incoming articles:

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

Oct 18 03:00:01 - 03:59:59	19741	2.9%	5.49	2.0 GB	3.6%	570.57
Oct 18 04:00:00 - 04:59:59	27485	4.1%	7.63	1.7 GB	3.1%	496.07
Oct 18 05:00:00 - 05:59:59	27246	4.0%	7.57	2.2 GB	4.1%	645.06
Oct 18 06:00:00 - 06:59:59	21359	3.2%	5.93	2.9 GB	5.3%	836.03
Oct 18 07:00:00 - 07:59:59	22090	3.3%	6.14	2.7 GB	5.0%	792.23
Oct 18 08:00:00 - 08:59:59	18853	2.8%	5.24	2.3 GB	4.2%	667.02
Oct 18 09:00:00 - 09:59:59	15724	2.3%	4.37	2.0 GB	3.6%	576.61
Oct 18 10:00:00 - 10:59:59	18293	2.7%	5.08	2.4 GB	4.4%	699.42
Oct 18 11:00:00 - 11:59:59	23886	3.5%	6.63	2.5 GB	4.5%	720.47
Oct 18 12:00:00 - 12:59:59	26507	3.9%	7.36	2.4 GB	4.4%	701.84
Oct 18 13:00:00 - 13:59:59	29136	4.3%	8.09	2.9 GB	5.3%	831.81
Oct 18 14:00:00 - 14:59:59	30259	4.5%	8.41	2.8 GB	5.1%	813.58
Oct 18 15:00:00 - 15:59:59	26037	3.9%	7.23	2.8 GB	5.1%	809.93
Oct 18 16:00:00 - 16:59:59	23211	3.4%	6.45	1.1 GB	2.0%	324.31
Oct 18 17:00:00 - 17:59:59	25575	3.8%	7.10	2.7 GB	5.0%	797.92
Oct 18 18:00:00 - 18:59:59	29016	4.3%	8.06	3.1 GB	5.8%	916.61
Oct 18 19:00:00 - 19:59:59	31734	4.7%	8.81	2.7 GB	5.0%	792.56
Oct 18 20:00:00 - 20:59:59	42336	6.3%	11.76	1.3 GB	2.4%	385.10
Oct 18 21:00:00 - 21:59:59	45838	6.8%	12.73	1.5 GB	2.8%	447.57
Oct 18 22:00:00 - 22:59:59	43285	6.4%	12.02	1.7 GB	3.2%	501.32
Oct 18 23:00:00 - 23:59:59	31811	4.7%	8.84	2.0 GB	3.8%	595.20
Oct 19 00:00:00 - 00:59:59	29199	4.3%	8.11	1.4 GB	2.5%	401.69
Oct 19 01:00:00 - 01:59:59	35126	5.2%	9.76	1.8 GB	3.4%	534.75
Oct 19 02:00:00 - 02:59:59	30883	4.6%	8.58	3.4 GB	6.2%	985.57
Oct 19 03:00:00 - 03:00:02	7	0.0%	3.50	89.1 KB	0.0%	44.53

TOTAL: 24:00:01	674637	100.0%	7.81	54.4 GB	100.0%	660.12

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	51.7 GB	37.5%	192	106.19	15.75
02	BIN	137.8 GB	91.6 GB	66.5%	192	106.70	15.68
03	SMALL	13.0 GB	13.0 GB	99.7%	16	6.51	24.31
04	BIN	80.1 GB	40.2 GB	50.2%	149	53.47	18.18
05	BIN	80.1 GB	25.7 GB	32.1%	166	53.24	18.26
06	SMALL	13.0 GB	12.4 GB	94.8%	16	6.48	24.40
07	BIN	80.1 GB	28.4 GB	35.4%	149	53.40	18.20
08	BIN	80.1 GB	7.9 GB	9.8%	166	53.38	18.21
09	SMALL	13.0 GB	12.4 GB	95.4%	16	6.49	24.38
10	BIN	80.1 GB	22.2 GB	27.7%	149	53.28	18.24
11	BIN	80.1 GB	32.5 GB	40.6%	166	53.23	18.26
12	BIN	13.0 GB	10.4 GB	80.1%	555	53.71	2.95
13	BIN	80.1 GB	65.0 GB	81.1%	90	53.43	18.19
14	SMALL	80.1 GB	69.0 GB	86.2%	1	6.46	150.49

TOTAL: 14	-	968.5 GB	482.4 GB	49.8%	2023	47.60	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	63167	51549	0	90	0	0	0	0	11528
2	?	7	0	0	0	0	0	0	0	7

TOTAL: 2		63174	51549	0	90	0	0	0	0	11535

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	4894
alt.binaries.amazing	1614
alt.binaries.game	1458
microsoft.public.test	1140
alt.binaries.pictures.amateur.butts	1075
alt.binaries.dvdrs.pw	764
alt.binaries.pictures.blonde	607
alt.binaries.erotica.kinky.teens	543
alt.binaries.nospam.female.short-hair	311
alt.binaires.erotica.teen	290
alt.binaires.pictures.erotica.amatuer.female	285
alt.binaries.erotica.early-teens	278
alt.binaries.picture.ls-series	242
alt.binaires.pictures.erotica.teens	238
alt.binaries.pictures.erotica.teen.male.masturbation	223
alt.binaries.pictures.erotica.amatuer	222
alt.binaires.erotica	220
alt.binaries.pictures.erotica.young.female	219
alt.binaries.pictures.erotica.early-teen	216
alt.binaries.pictures.erotica.breast.natural	211

TOTAL: 3055	51549

INND misc events:

Events	Count

CCreader	2

TOTAL: 1	2

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	11528
	TOTAL: 1	11528

TOTAL: 1		11528

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	dyn-176-197.fttb.kis.ru	145	118	2.2 MB	6	0	0	00:13:47
2	195.218.244.87	2	117	6.4 MB	1	0	0	00:20:05
3	ts18-a165.moscow.dial.rol.ru	3	81	3.6 MB	5	0	0	01:04:43
4	194.186.147.175	6	44	2.0 MB	4	0	0	00:23:29
5	dyn-138-121.fttb.kis.ru	21	5	165.7 KB	7	0	0	00:03:25
6	dyn-138-160.fttb.kis.ru	2	2	158.8 KB	2	0	0	00:03:29
7	net1-x-ring.tony.pp.ru	59	1	4.6 KB	6	0	0	00:04:59

TOTAL: 7		238	368	14.6 MB	31	0	2	04:09:02

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	unresolved	8	161	8.4 MB	5	0	0	00:43:34
2	*.fttb.kis.ru	177	125	2.5 MB	15	0	0	00:20:50
3	*.moscow.dial.rol.ru	15	81	3.6 MB	5	0	0	01:12:26
4	*.tony.pp.ru	59	1	4.6 KB	6	0	0	00:04:59
5	*.sovintel.net	13	0	0.0 KB	0	0	0	00:00:07
6	*.sarov.dial.rol.ru	13	0	0.0 KB	0	0	0	01:33:46
7	*.rol.ru	5760	0	0.0 KB	0	0	0	00:13:16
8	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00

TOTAL: 8		6046	368	14.6 MB	31	0	1	04:09:02

NNRP total resource statistics [Top 20]:

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

ts18-a165.moscow.dial.rol.ru	0.100	0.240	0.000	01:04:43
194.186.147.175	0.152	0.376	0.000	00:23:29
ts2-a37.sarov.dial.rol.ru	0.012	0.008	0.000	00:22:15
ts2-a25.sarov.dial.rol.ru	0.000	0.004	0.000	00:20:08
ts2-a184.sarov.dial.rol.ru	0.000	0.008	0.000	00:20:07
195.218.244.87	0.020	0.076	0.000	00:20:05
dyn-176-197.fttb.kis.ru	0.524	0.836	0.000	00:13:47
ts2-a134.sarov.dial.rol.ru	0.008	0.000	0.000	00:10:08
ts2-a110.sarov.dial.rol.ru	0.000	0.004	0.000	00:10:04
ts2-a69.sarov.dial.rol.ru	0.008	0.004	0.000	00:10:00
ts18-a93.moscow.dial.rol.ru	0.068	0.140	0.000	00:07:43
balancer-b.rol.ru	3.740	3.452	0.000	00:06:56
balancer-a.rol.ru	3.572	3.776	0.000	00:06:19
net1-x-ring.tony.pp.ru	20.412	19.896	0.000	00:04:59
dyn-138-160.fttb.kis.ru	0.128	0.212	0.000	00:03:29
dyn-138-121.fttb.kis.ru	0.060	0.104	0.000	00:03:25
ts2-a60.sarov.dial.rol.ru	0.000	0.000	0.000	00:01:01
dyn-166-195.fttb.kis.ru	0.032	0.008	0.000	00:00:08
fw-nat.sovintel.net	0.080	0.048	0.000	00:00:07
cornholio.migtel.ru	0.004	0.000	0.000	00:00:00

TOTAL: 21	28.920	29.196	0.000	04:09:02

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2880
balancer-a.rol.ru	2880
fw-nat.sovintel.net	13
ts18-a93.moscow.dial.rol.ru	12
dyn-166-195.fttb.kis.ru	9
ts2-a37.sarov.dial.rol.ru	5
ts2-a184.sarov.dial.rol.ru	2
ts2-a25.sarov.dial.rol.ru	2
web02.tr155m.lavtech.ru	1
ts2-a134.sarov.dial.rol.ru	1
ts2-a69.sarov.dial.rol.ru	1
ts2-a60.sarov.dial.rol.ru	1
ts2-a110.sarov.dial.rol.ru	1

TOTAL: 13	5808

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	1

TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a184.sarov.dial.rol.ru	2	0
ts2-a37.sarov.dial.rol.ru	2	0
ts18-a165.moscow.dial.rol.ru	2	0
ts2-a25.sarov.dial.rol.ru	2	0
dyn-138-121.fttb.kis.ru	1	0
ts2-a134.sarov.dial.rol.ru	1	0
195.218.244.87	1	0
194.186.147.175	1	0
ts2-a69.sarov.dial.rol.ru	1	0
ts2-a110.sarov.dial.rol.ru	1	0

TOTAL: 10	14	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	268	99.6%
2	fido7	1	0.4%

TOTAL: 2		269	100.0%

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

Newsgroup		Count

1	alt.binaries.erotica.pornstars	117
2	alt.binaries.pictures.lolita	73
3	alt.binaries.nospam.female.bodyhair.pubes	35
4	alt.binaries.erotic.children	15
5	alt.binaries.nospam.female.bodyhair	9
6	alt.binaries.erotica.pregnant	4
7	alt.binaries.pictures.child.erotica.for.peter-j-ross	4
8	alt.bainaries.pictures.erotica.child.male	2
9	alt.bainaries.pictures.child.erotica.female	2
10	alt.binaries.pictures.eroctica.teen.fuck	2
11	alt.bainaries.pictures.erotica.children	2
12	alt.binaries.pictures.erotica.amateur.lolita	1
13	alt.sex.children.dowap	1
14	alt.binaries.pictures.erotica.incest	1
15	fido7.ru.unix.sco	1

TOTAL: 15		269