Daily Usenet report

Aug 20 03:00:01 -- Aug 21 03:00:07

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
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 / 14 lines (35.7%)
Aug 20 05:50:23 perseus controlchan[16196]: Unknown "cmsg" control by alankao.bbs@bbs.cs.nctu.edu.tw
Aug 20 07:35:23 perseus controlchan[16196]: Unknown "cmsg" control by lovy.bbs@bbs.cs.nctu.edu.tw
Aug 20 08:25:23 perseus controlchan[16196]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Aug 20 11:35:21 perseus controlchan[16196]: Unknown "cmsg" control by smallpooh.bbs@bbs.cs.nctu.edu.tw
Aug 20 11:40:24 perseus controlchan[16196]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	629108	93.9%	57.1 MB	93.0%
nnrpd	21686	3.2%	2.0 MB	3.2%
innd	16726	2.5%	1.9 MB	3.1%
cnfsstat	2304	0.3%	397.7 KB	0.6%
controlchan	14	0.0%	1.4 KB	0.0%

TOTAL: 5	669838	100.0%	61.3 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	576405	92.9%
Negative hits	40552	6.5%
Positive hits	2884	0.5%
Cache misses	702	0.1%

TOTAL: 4	620543	100.0%

INND timer:

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

article cancel	00:00:11.661	0.0%	4076	0.000	2.861	831.000
article cleanup	00:00:05.349	0.0%	576326	0.000	0.009	0.036
article logging	00:01:52.680	0.1%	625149	0.000	0.180	17.088
article parse	00:02:16.280	0.2%	32517214	0.001	0.004	0.009
article write	00:47:57.978	3.3%	516512	0.165	5.572	28.590
artlog/artcncl	00:00:00.030	0.0%	4051	0.000	0.007	1.000
artlog/artparse	00:00:00.000	0.0%	20	0.000	0.000	0.000
data move	00:00:36.114	0.0%	34660122	0.000	0.001	0.003
hisgrep/artcncl	00:00:10.085	0.0%	3502	0.000	2.880	935.000
hishave/artcncl	00:00:00.418	0.0%	4076	0.000	0.103	30.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:11:24.097	0.8%	616905	0.000	1.109	20.177
history sync	00:00:00.244	0.0%	332	0.000	0.735	12.000
history write	00:29:38.518	2.1%	516512	0.010	3.443	37.292
hiswrite/artcncl	00:00:01.093	0.0%	574	0.000	1.904	788.000
idle	20:56:24.178	87.2%	32307387	0.844	2.333	26.390
nntp read	00:02:41.896	0.2%	32537180	0.001	0.005	0.011
overview write	01:23:11.371	5.8%	516512	0.704	9.664	46.015
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%	14	0.000	0.000	0.000

TOTAL: 24:00:49.222	23:56:31.992	99.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:02:25.420	0.3%	15423	0.000	9.429	26.088
idle	11:46:59.082	91.4%	37478	0.000	1131.840	201576.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:40:48.235	5.3%	166318	0.000	14.720	1545.361
readart	00:05:40.458	0.7%	31109	0.000	10.944	668.000

TOTAL: 12:53:17.577	12:35:53.195	97.7%	-	-	-	-

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	908	562339	504891	8	57440	89%	434:33:59

TOTAL: 1		908	562339	504891	8	57440	89%	434:33:59

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	42.5 GB	538.0 KB	42.5 GB	99%	79.3 KB	434:33:59

TOTAL: 1		42.5 GB	538.0 KB	42.5 GB	99%	79.3 KB	434:33:59

Incoming articles:

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

Aug 20 03:00:01 - 03:59:59	18764	3.6%	5.21	1.7 GB	3.8%	487.68
Aug 20 04:00:00 - 04:59:59	22123	4.3%	6.15	2.2 GB	5.1%	654.86
Aug 20 05:00:00 - 05:59:59	21192	4.1%	5.89	2.1 GB	4.8%	612.34
Aug 20 06:00:00 - 06:59:59	22318	4.3%	6.20	2.0 GB	4.6%	594.67
Aug 20 07:00:00 - 07:59:59	20995	4.1%	5.83	2.2 GB	5.0%	643.36
Aug 20 08:00:00 - 08:59:59	20734	4.0%	5.76	2.6 GB	5.8%	744.30
Aug 20 09:00:00 - 09:59:59	22118	4.3%	6.14	2.7 GB	6.1%	783.45
Aug 20 10:00:00 - 10:59:59	18754	3.6%	5.21	2.1 GB	4.7%	608.77
Aug 20 11:00:00 - 11:59:59	16548	3.2%	4.60	1.5 GB	3.4%	434.09
Aug 20 12:00:00 - 12:59:59	16626	3.2%	4.62	1.4 GB	3.2%	414.07
Aug 20 13:00:00 - 13:59:59	15240	3.0%	4.23	695.5 MB	1.5%	197.84
Aug 20 14:00:00 - 14:59:59	14190	2.7%	3.94	793.1 MB	1.8%	225.60
Aug 20 15:00:00 - 15:59:59	18166	3.5%	5.05	1.6 GB	3.6%	455.49
Aug 20 16:00:00 - 16:59:59	21764	4.2%	6.05	1.6 GB	3.7%	477.67
Aug 20 17:00:00 - 17:59:59	21678	4.2%	6.02	1.6 GB	3.7%	471.68
Aug 20 18:00:00 - 18:59:59	24361	4.7%	6.77	2.3 GB	5.2%	670.20
Aug 20 19:00:00 - 19:59:59	25466	4.9%	7.07	2.3 GB	5.3%	676.68
Aug 20 20:00:00 - 20:59:59	22801	4.4%	6.33	1.8 GB	4.0%	516.80
Aug 20 21:00:00 - 21:59:59	25506	4.9%	7.08	2.6 GB	6.0%	765.89
Aug 20 22:00:00 - 22:59:59	26864	5.2%	7.46	2.5 GB	5.6%	716.89
Aug 20 23:00:00 - 23:59:59	24787	4.8%	6.89	1.9 GB	4.2%	544.46
Aug 21 00:00:00 - 00:59:59	21697	4.2%	6.03	1.0 GB	2.3%	298.60
Aug 21 01:00:00 - 01:59:59	29891	5.8%	8.30	1.1 GB	2.4%	308.78
Aug 21 02:00:00 - 02:59:59	23776	4.6%	6.60	1.8 GB	4.0%	510.85
Aug 21 03:00:00 - 03:00:07	53	0.0%	7.57	7.4 MB	0.0%	1077.16

TOTAL: 24:00:06	516412	100.0%	5.98	44.0 GB	100.0%	534.00

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	95.6 GB	69.3%	213	87.26	19.17
02	BIN	137.8 GB	51.0 GB	37.0%	214	86.62	19.31
03	SMALL	13.0 GB	4.1 GB	31.1%	17	4.66	33.95
04	BIN	80.1 GB	57.0 GB	71.2%	164	43.42	22.39
05	BIN	80.1 GB	3.1 GB	3.8%	185	43.74	22.22
06	SMALL	13.0 GB	4.0 GB	30.9%	17	4.65	33.99
07	BIN	80.1 GB	35.6 GB	44.5%	164	43.75	22.22
08	BIN	80.1 GB	64.2 GB	80.1%	184	43.73	22.23
09	SMALL	13.0 GB	3.0 GB	22.9%	17	4.65	34.00
10	BIN	80.1 GB	20.0 GB	25.0%	164	43.45	22.37
11	BIN	80.1 GB	24.2 GB	30.2%	185	43.29	22.45
12	SMALL	13.0 GB	3.8 GB	29.2%	17	4.64	34.09
13	BIN	80.1 GB	17.2 GB	21.5%	164	43.47	22.36
14	BIN	80.1 GB	65.5 GB	81.8%	184	43.57	22.31

TOTAL: 14	-	968.5 GB	448.3 GB	46.3%	1889	38.64	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	108632	55378	0	76	0	0	0	0	53178
2	?	12	0	0	0	0	0	0	0	12

TOTAL: 2		108644	55378	0	76	0	0	0	0	53190

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.dvdrs.pw	8455
alt.binaries.movies.dutch.repost	2158
alt.binaries.pictures.amateur.butts	2004
alt.binaries.pwp	1791
microsoft.public.test	1164
alt.binaries.sandra.model	711
alt.binaries.wmvhd	641
alt.binaries.movie	514
it.eventi.pechino2008	395
alt.binaries.pcgames.fullcdsonly	346
pictures.erotica.lesbians	277
alt.binaries.pictures.black.erotica	252
alt.binaries.pictures.black.erotica.females	231
alt.binaries.pictures.erotica.erotic	216
alt.binaries.pictures.erotica.dicks	211
alt.binaries.pictures.erotica.erotica.gaymen	210
alt.binaries.picture.ls-series	207
alt.binaries.pictures.erotica.exhibitionismw	199
alt.binaries.pictures.asian	197
alt.binaries.pictures.erotica.exhibionism	196

TOTAL: 3876	55378

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	48811
	TOTAL: 1	48811

TOTAL: 1		48811

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	5	15423	741.5 MB	15	0	0	09:25:41
2	ts1-a73.saratov.dial.rol.ru	4	1	0.0 KB	2	0	0	00:57:47

TOTAL: 2		9	15424	741.5 MB	17	0	0	12:53:17

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	5	15423	741.5 MB	15	0	0	09:25:41
2	*.saratov.dial.rol.ru	4	1	0.0 KB	2	0	0	00:57:47
3	*.sovintel.net	17	0	0.0 KB	0	0	0	00:00:12
4	*.fttb.kis.ru	4	0	0.0 KB	0	0	0	00:10:34
5	*.sarov.dial.rol.ru	12	0	0.0 KB	0	0	0	02:00:09
6	unresolved	3	0	0.0 KB	0	0	0	00:00:00
7	*.tony.pp.ru	69	0	0.0 KB	0	0	0	00:02:40
8	*.syktyvkar.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:20
9	*.rol.ru	5767	0	0.0 KB	0	0	0	00:14:56
10	*.nn.ru	2	0	0.0 KB	0	0	0	00:00:00

TOTAL: 10		5884	15424	741.5 MB	17	0	0	12:52:48

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	12.644	130.626	0.000	09:25:41
ts1-a73.saratov.dial.rol.ru	0.044	0.060	0.000	00:57:47
ts2-a144.sarov.dial.rol.ru	0.012	0.008	0.000	00:50:02
ts2-a44.sarov.dial.rol.ru	0.004	0.004	0.000	00:30:02
ts2-a206.sarov.dial.rol.ru	0.004	0.008	0.000	00:20:01
dyn-185-245.fttb.kis.ru	0.012	0.004	0.000	00:10:34
ts2-a68.sarov.dial.rol.ru	0.004	0.004	0.000	00:10:01
ts2-a62.sarov.dial.rol.ru	0.008	0.012	0.000	00:10:01
balancer-a.rol.ru	3.504	3.280	0.000	00:07:37
balancer-b.rol.ru	3.376	3.152	0.000	00:07:19
net1-x-ring.tony.pp.ru	0.088	0.108	0.000	00:02:40
cornholio.migtel.ru	1.068	1.064	0.000	00:00:29
?	0.008	0.004	0.000	00:00:24
ts2-a78.syktyvkar.dial.rol.ru	0.016	0.024	0.000	00:00:20
fw-nat.sovintel.net	0.120	0.064	0.000	00:00:12
gray.nn.ru	0.004	0.004	0.000	00:00:00
195.98.59.67	0.004	0.000	0.000	00:00:00

TOTAL: 17	20.920	138.426	0.000	12:53:17

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2884
balancer-a.rol.ru	2883
net1-x-ring.tony.pp.ru	69
fw-nat.sovintel.net	17
ts2-a144.sarov.dial.rol.ru	5
dyn-185-245.fttb.kis.ru	4
195.98.59.67	3
ts2-a44.sarov.dial.rol.ru	3
gray.nn.ru	2
ts2-a206.sarov.dial.rol.ru	2
ts2-a62.sarov.dial.rol.ru	1
ts2-a68.sarov.dial.rol.ru	1
ts2-a78.syktyvkar.dial.rol.ru	1

TOTAL: 13	5875

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	851

TOTAL: 1	851

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	5

TOTAL: 1	5

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a144.sarov.dial.rol.ru	5	0
ts2-a44.sarov.dial.rol.ru	3	0
ts2-a206.sarov.dial.rol.ru	2	0
dyn-185-245.fttb.kis.ru	1	0
ts1-a73.saratov.dial.rol.ru	1	0
ts2-a62.sarov.dial.rol.ru	1	0
ts2-a68.sarov.dial.rol.ru	1	0

TOTAL: 7	14	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	15423	100.0%
2	a	1	0.0%

TOTAL: 2		15424	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.bras	8241
2	alt.binaries.pictures.erotica.vintage	6192
3	alt.binaries.pictures.artpics	990
4	a.b.dvd.music	1

TOTAL: 4		15424