Daily Usenet report

Feb 9 03:00:02 -- Feb 10 03:00:01

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
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
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 17 / 17 lines (100.0%)
Feb 9 04:05:24 andromeda controlchan[18019]: Unknown "cmsg" control by oxidea2.bbs@bbs.cs.nthu.edu.tw
Feb 9 05:48:32 andromeda controlchan[18019]: Unknown "cmsg" control by oligacat.bbs@bbs.cs.nctu.edu.tw
Feb 9 12:43:09 andromeda controlchan[18019]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Feb 9 15:40:02 andromeda controlchan[18019]: Unknown "cmsg" control by sangost.bbs@bbs.cm.nctu.edu.tw
Feb 9 16:03:44 andromeda controlchan[18019]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Feb 9 16:04:01 andromeda controlchan[18019]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Feb 9 16:04:15 andromeda controlchan[18019]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Feb 9 16:04:33 andromeda controlchan[18019]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Feb 9 17:49:21 andromeda controlchan[18019]: Unknown "cmsg" control by JayBruce.bbs@bbs.cs.nctu.edu.tw
Feb 9 17:49:57 andromeda controlchan[18019]: Unknown "cmsg" control by grayyoung.bbs@bbs.cs.nctu.edu.tw
Feb 9 19:31:32 andromeda controlchan[18019]: Unknown "cmsg" control by racy.bbs@bbs.cs.nctu.edu.tw
Feb 9 20:00:00 andromeda controlchan[18019]: Unknown "cmsg" control by racy.bbs@bbs.cs.nctu.edu.tw
Feb 9 23:00:48 andromeda innd: buffindexed: overview data is too large 28876
Feb 9 23:00:48 andromeda innd: buffindexed: overview data is too large 28876
Feb 9 23:00:48 andromeda innd: buffindexed: overview data is too large 28875
Feb 9 23:00:48 andromeda innd: buffindexed: overview data is too large 28876
Feb 9 23:00:48 andromeda innd: buffindexed: overview data is too large 28876

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	952766	96.5%	85.6 MB	95.6%
nnrpd	17936	1.8%	1.8 MB	2.0%
innd	14491	1.5%	1.8 MB	2.0%
cnfsstat	2288	0.2%	396.4 KB	0.4%
controlchan	12	0.0%	1.3 KB	0.0%

TOTAL: 5	987493	100.0%	89.5 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	905427	91.1%
Negative hits	82805	8.3%
Positive hits	4705	0.5%
Cache misses	1141	0.1%

TOTAL: 4	994078	100.0%

INND timer:

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

article cancel	00:00:14.577	0.0%	5845	0.000	2.494	1304.000
article cleanup	00:00:11.761	0.0%	904829	0.000	0.013	0.052
article logging	00:01:24.406	0.1%	947120	0.000	0.089	8.348
article parse	00:04:20.333	0.3%	38197412	0.000	0.007	0.079
article write	00:48:58.386	3.4%	853104	0.341	3.444	18.739
artlog/artcncl	00:00:01.388	0.0%	5804	0.000	0.239	1304.000
artlog/artparse	00:00:00.000	0.0%	66	0.000	0.000	0.000
data move	00:01:23.961	0.1%	41474047	0.000	0.002	0.017
hisgrep/artcncl	00:00:09.244	0.0%	3682	0.000	2.511	494.000
hishave/artcncl	00:00:02.408	0.0%	5845	0.000	0.412	12.795
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:06:02.049	0.4%	989267	0.000	0.366	8.287
history sync	00:00:00.368	0.0%	284	0.000	1.296	3.000
history write	00:12:57.972	0.9%	904103	0.000	0.860	14.431
hiswrite/artcncl	00:00:01.478	0.0%	2163	0.000	0.683	10.000
idle	17:17:07.384	72.0%	37148896	0.000	1.675	8.205
nntp read	00:04:53.152	0.3%	38040840	0.002	0.008	0.082
overview write	05:13:54.822	21.8%	853104	1.795	22.078	168288.333
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.001	0.0%	12	0.000	0.083	0.500

TOTAL: 24:00:16.052	23:51:43.690	99.4%	-	-	-	-

nnrpd timer:

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

hisgrep	00:00:55.789	0.2%	46167	0.000	1.208	0.000
idle	08:36:31.753	96.4%	278937	0.000	111.107	169142.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:03:25.232	0.6%	712216	0.000	0.288	0.000
readart	00:04:55.041	0.9%	93284	0.000	3.163	0.000

TOTAL: 08:55:54.420	08:45:47.815	98.1%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	2124	915009	860511	1442	53056	94%	396:21:55

TOTAL: 1		2124	915009	860511	1442	53056	94%	396:21:55

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	79.7 GB	25.2 MB	79.8 GB	99%	91.6 KB	396:21:55

TOTAL: 1		79.7 GB	25.2 MB	79.8 GB	99%	91.6 KB	396:21:55

Incoming articles:

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

Feb 9 03:00:02 - 03:59:59	42676	5.0%	11.86	6.6 GB	8.6%	1926.04
Feb 9 04:00:00 - 04:59:59	41814	4.9%	11.62	6.0 GB	7.8%	1733.92
Feb 9 05:00:00 - 05:59:59	66099	7.7%	18.36	10.0 GB	13.1%	2923.74
Feb 9 06:00:00 - 06:59:59	29806	3.5%	8.28	2.9 GB	3.8%	844.47
Feb 9 07:00:00 - 07:59:59	15583	1.8%	4.33	797.8 MB	1.0%	226.92
Feb 9 08:00:00 - 08:59:59	18064	2.1%	5.02	1.0 GB	1.3%	296.56
Feb 9 09:00:00 - 09:59:59	19591	2.3%	5.44	1.1 GB	1.5%	330.94
Feb 9 10:00:00 - 10:59:59	19547	2.3%	5.43	1.0 GB	1.4%	304.52
Feb 9 11:00:00 - 11:59:59	20872	2.4%	5.80	1.0 GB	1.3%	292.14
Feb 9 12:00:00 - 12:59:59	22725	2.7%	6.31	967.5 MB	1.2%	275.21
Feb 9 13:00:00 - 13:59:59	27219	3.2%	7.56	1.2 GB	1.6%	346.85
Feb 9 14:00:00 - 14:59:59	28398	3.3%	7.89	1.5 GB	1.9%	430.59
Feb 9 15:00:00 - 15:59:59	30792	3.6%	8.55	1.3 GB	1.8%	391.27
Feb 9 16:00:00 - 16:59:59	34749	4.1%	9.65	1.4 GB	1.8%	405.21
Feb 9 17:00:00 - 17:59:59	31988	3.8%	8.89	1.3 GB	1.7%	383.15
Feb 9 18:00:00 - 18:59:59	29353	3.4%	8.15	1.3 GB	1.7%	368.78
Feb 9 19:00:00 - 19:59:59	42143	4.9%	11.71	3.8 GB	5.0%	1111.90
Feb 9 20:00:00 - 20:59:59	50053	5.9%	13.90	5.7 GB	7.4%	1654.10
Feb 9 21:00:00 - 21:59:59	64799	7.6%	18.00	9.6 GB	12.6%	2797.85
Feb 9 22:00:00 - 22:59:59	62876	7.4%	17.47	8.3 GB	10.9%	2428.38
Feb 9 23:00:00 - 23:59:59	31615	3.7%	8.78	1.2 GB	1.5%	344.60
Feb 10 00:00:00 - 00:59:59	33189	3.9%	9.22	1.7 GB	2.2%	493.64
Feb 10 01:00:00 - 01:59:59	60923	7.1%	16.92	5.3 GB	7.0%	1552.75
Feb 10 02:00:00 - 02:59:59	28013	3.3%	7.78	1.4 GB	1.8%	401.67
Feb 10 03:00:00 - 03:00:01	13	0.0%	13.00	170.2 KB	0.0%	170.24

TOTAL: 23:59:59	852900	100.0%	9.87	76.4 GB	100.0%	927.68

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	109.5 GB	79.4%	197	151.47	11.04
02	BIN	137.8 GB	9.6 GB	7.0%	198	151.54	11.04
03	SMALL	13.0 GB	6.5 GB	50.0%	21	8.43	18.77
04	BIN	80.1 GB	12.6 GB	15.7%	154	76.24	12.75
05	BIN	80.1 GB	77.2 GB	96.4%	170	75.96	12.80
06	SMALL	13.0 GB	5.9 GB	45.6%	21	8.44	18.75
07	BIN	80.1 GB	1.1 GB	1.4%	154	76.20	12.76
08	BIN	80.1 GB	60.1 GB	75.0%	170	76.11	12.77
09	SMALL	13.0 GB	6.0 GB	46.3%	21	8.51	18.60
10	BIN	80.1 GB	75.0 GB	93.7%	153	75.98	12.79
11	BIN	80.1 GB	4.3 GB	5.4%	171	76.25	12.75
12	BIN	13.0 GB	5.5 GB	42.0%	584	76.41	2.07
13	BIN	80.1 GB	37.8 GB	47.2%	95	76.53	12.70
14	SMALL	80.1 GB	47.7 GB	59.5%	2	8.45	114.98

TOTAL: 14	-	968.5 GB	458.8 GB	47.4%	2111	67.69	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	94033	50984	0	723	0	0	0	0	42326
2	?	29	0	0	0	0	0	0	0	29

TOTAL: 2		94062	50984	0	723	0	0	0	0	42355

Unwanted newsgroups [Top 20]:

Newsgroup	Count

bellsouth.net.test	2879
microsoft.public.test	1153
alt.binaries.pictures.katie	1131
alt.binaries.pictures.bdcompany	911
alt.binaries.pwp	759
alt.binaires.pictures.erotica.teens	524
alt.binaries.matrix	510
alt.binaires.erotica.teen	505
alt.binaries.erotic.erotika.young	488
alt.binaries.picutures.erotica	445
alt.binaires.erotica	418
alt.binaries.erotica.early-teens	412
alt.binaries.picures.erotica.tasteless	408
alt.binaries.erotic.incest	395
alt.binaries.pictures.erotica.group.sex	384
alt.binaries.pictures.erotica.young.female	377
alt.binaries.ls	349
alt.sex.teen	331
mozilla.feedback.companion.ebay	313
alt.binaries.pictures.asian	304

TOTAL: 2220	50984

INND misc events:

Events	Count

CCreader	12

TOTAL: 1	12

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	42286
	TOTAL: 1	42286

TOTAL: 1		42286

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	3	46167	1.0 GB	18	0	0	07:58:57

TOTAL: 1		3	46167	1.0 GB	18	0	0	08:55:54

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	3	46167	1.0 GB	18	0	0	07:58:57
2	*.sovintel.net	11	0	0.0 KB	0	0	0	00:00:03
3	*.dynadsl.kis.ru	1	0	0.0 KB	0	0	0	00:10:43
4	*.tony.pp.ru	76	0	0.0 KB	0	0	0	00:31:48
5	*.rol.ru	5761	0	0.0 KB	0	0	0	00:14:20

TOTAL: 5		5852	46167	1.0 GB	18	0	0	08:55:53

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	20.260	28.919	0.000	07:58:57
net1-x-ring.tony.pp.ru	170.696	200.480	0.000	00:31:48
dyn-22-131.dynadsl.kis.ru	0.040	0.104	0.000	00:10:43
balancer-a.rol.ru	3.516	3.416	0.000	00:07:29
balancer-b.rol.ru	3.432	3.456	0.000	00:06:50
fw-nat.sovintel.net	0.072	0.036	0.000	00:00:03
95-52-156-85.dynamic.komi.dslavangard.ru	0.000	0.000	0.000	00:00:00
ppp85-140-196-239.pppoe.mtu-net.ru	0.004	0.000	0.000	00:00:00
89.163.50.14	0.000	0.004	0.000	00:00:00

TOTAL: 9	198.020	236.415	0.000	08:55:54

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2881
balancer-b.rol.ru	2880
net1-x-ring.tony.pp.ru	76
fw-nat.sovintel.net	11
dyn-22-131.dynadsl.kis.ru	1

TOTAL: 5	5849

NNRP no permission clients:

System	Conn

89.163.50.14	1
ppp85-140-196-239.pppoe.mtu-net.ru	1
95-52-156-85.dynamic.komi.dslavangard.ru	1

TOTAL: 3	3

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	43159	94.7%
2	hr	2404	5.3%

TOTAL: 2		45563	100.0%

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

Newsgroup		Count

1	alt.binaries.multimedia.erotic.playboy	27274
2	alt.binaries.pictures.bras	7140
3	alt.binaries.full.post.verified.playboy	6070
4	alt.mag.playboy	2600
5	hr.alt.seks.binaries.playboy	2404
6	alt.binaries.photos.nude-art.moderated	75

TOTAL: 6		45563