Daily Usenet report

Oct 10 03:00:02 -- Oct 11 03:00:16

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
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 / 11 lines (45.5%)
Oct 10 05:01:56 perseus controlchan[31034]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nthu.edu.tw
Oct 10 06:25:50 perseus controlchan[31034]: Unknown "cmsg" control by JayBruce.bbs@bbs.cs.nctu.edu.tw
Oct 10 06:45:55 perseus controlchan[31034]: Unknown "cmsg" control by zoevera.bbs@bbs.cs.nctu.edu.tw
Oct 10 08:23:21 perseus controlchan[31034]: Unknown "cmsg" control by bineapple.bbs@bbs.cs.nctu.edu.tw
Oct 10 08:38:22 perseus controlchan[31034]: Unknown "cmsg" control by shweiting.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	773650	96.3%	70.2 MB	95.4%
nnrpd	18174	2.3%	1.8 MB	2.4%
innd	9077	1.1%	1.3 MB	1.7%
cnfsstat	2304	0.3%	399.5 KB	0.5%
controlchan	12	0.0%	1.2 KB	0.0%

TOTAL: 5	803217	100.0%	73.6 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	747461	94.0%
Negative hits	44537	5.6%
Positive hits	2504	0.3%
Cache misses	516	0.1%

TOTAL: 4	795018	100.0%

INND timer:

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

article cancel	00:00:27.420	0.0%	6251	0.000	4.386	1700.000
article cleanup	00:00:06.751	0.0%	744678	0.000	0.009	0.026
article logging	00:02:18.128	0.2%	767137	0.000	0.180	17.253
article parse	00:02:38.234	0.2%	36720997	0.002	0.004	0.011
article write	01:13:57.736	5.1%	678145	0.304	6.544	27.621
artlog/artcncl	00:00:11.211	0.0%	6185	0.000	1.813	1693.750
artlog/artparse	00:00:00.001	0.0%	2	0.000	0.500	1.000
data move	00:00:41.885	0.0%	39565781	0.000	0.001	0.003
hisgrep/artcncl	00:00:13.789	0.0%	2933	0.000	4.701	938.000
hishave/artcncl	00:00:01.038	0.0%	6251	0.000	0.166	36.217
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:09:43.657	0.7%	789253	0.000	0.740	16.463
history sync	00:00:00.283	0.0%	310	0.000	0.913	54.000
history write	00:38:31.746	2.7%	678145	0.009	3.409	31.283
hiswrite/artcncl	00:00:01.345	0.0%	3318	0.000	0.405	145.000
idle	20:02:49.523	83.5%	36349469	0.770	1.985	9.548
nntp read	00:03:05.992	0.2%	36720542	0.002	0.005	0.016
overview write	01:40:19.094	7.0%	678145	0.366	8.876	45.824
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%	12	0.000	0.000	0.000

TOTAL: 23:59:43.149	23:55:07.833	99.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:01:35.228	0.3%	8418	0.000	11.312	13.448
idle	07:47:41.893	95.6%	23337	0.000	1202.464	200309.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:05:43.127	1.2%	69507	0.000	4.937	2620.739
readart	00:03:56.985	0.8%	17008	0.000	13.934	52.217

TOTAL: 08:09:25.425	07:58:57.233	97.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

newsmaster@carnet.hr	0	0	1	0	0	1

TOTAL	0	0	1	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	639	733747	666250	4	67493	90%	463:22:10

TOTAL: 1		639	733747	666250	4	67493	90%	463:22:10

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	51.3 GB	1.9 MB	51.3 GB	99%	73.3 KB	463:22:10

TOTAL: 1		51.3 GB	1.9 MB	51.3 GB	99%	73.3 KB	463:22:10

Incoming articles:

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

Oct 10 03:00:02 - 03:59:59	28033	4.1%	7.79	2.4 GB	4.6%	700.94
Oct 10 04:00:00 - 04:59:59	29965	4.4%	8.32	2.7 GB	5.2%	781.53
Oct 10 05:00:00 - 05:59:59	26673	3.9%	7.41	2.4 GB	4.5%	688.93
Oct 10 06:00:00 - 06:59:59	23242	3.4%	6.46	3.0 GB	5.7%	859.39
Oct 10 07:00:00 - 07:59:59	20832	3.1%	5.79	2.6 GB	5.0%	760.59
Oct 10 08:00:00 - 08:59:59	22155	3.3%	6.15	2.6 GB	4.9%	749.22
Oct 10 09:00:00 - 09:59:59	21746	3.2%	6.04	2.4 GB	4.6%	691.19
Oct 10 10:00:00 - 10:59:59	26798	3.9%	7.44	2.9 GB	5.6%	842.20
Oct 10 11:00:00 - 11:59:59	24558	3.6%	6.82	2.6 GB	5.0%	753.65
Oct 10 12:00:00 - 12:59:59	20881	3.1%	5.80	1.2 GB	2.3%	344.00
Oct 10 13:00:00 - 13:59:59	32276	4.8%	8.97	2.8 GB	5.3%	806.56
Oct 10 14:00:00 - 14:59:59	28167	4.2%	7.82	2.8 GB	5.4%	824.29
Oct 10 15:00:00 - 15:59:59	32670	4.8%	9.07	2.7 GB	5.1%	775.27
Oct 10 16:00:00 - 16:59:59	35354	5.2%	9.82	2.3 GB	4.4%	666.10
Oct 10 17:00:00 - 17:59:59	36352	5.4%	10.10	1.5 GB	3.0%	448.36
Oct 10 18:00:00 - 18:59:59	28242	4.2%	7.84	1.5 GB	2.8%	431.86
Oct 10 19:00:00 - 19:59:59	27757	4.1%	7.71	2.0 GB	3.9%	590.39
Oct 10 20:00:00 - 20:59:59	34509	5.1%	9.59	1.6 GB	3.2%	477.69
Oct 10 21:00:00 - 21:59:59	33120	4.9%	9.20	1.3 GB	2.5%	377.69
Oct 10 22:00:00 - 22:59:59	26527	3.9%	7.37	1.4 GB	2.7%	416.61
Oct 10 23:00:00 - 23:59:59	26475	3.9%	7.35	2.3 GB	4.5%	679.56
Oct 11 00:00:00 - 00:59:59	24685	3.6%	6.86	1.3 GB	2.4%	370.32
Oct 11 01:00:00 - 01:59:59	36903	5.4%	10.25	1.5 GB	2.9%	447.14
Oct 11 02:00:00 - 02:59:59	30348	4.5%	8.43	2.3 GB	4.5%	677.66
Oct 11 03:00:00 - 03:00:16	207	0.0%	12.94	13.8 MB	0.0%	884.86

TOTAL: 24:00:14	678475	100.0%	7.85	52.1 GB	100.0%	631.76

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	98.5 GB	71.5%	216	101.70	16.45
02	BIN	137.8 GB	52.3 GB	38.0%	217	101.49	16.48
03	SMALL	13.0 GB	11.0 GB	84.2%	18	6.65	23.80
04	BIN	80.1 GB	24.8 GB	30.9%	167	50.92	19.09
05	BIN	80.1 GB	49.9 GB	62.4%	187	50.74	19.16
06	SMALL	13.0 GB	11.0 GB	84.0%	18	6.67	23.71
07	BIN	80.1 GB	3.5 GB	4.4%	167	51.31	18.94
08	BIN	80.1 GB	31.7 GB	39.5%	187	50.73	19.16
09	SMALL	13.0 GB	9.9 GB	76.2%	18	6.65	23.78
10	BIN	80.1 GB	68.2 GB	85.2%	166	51.19	18.99
11	BIN	80.1 GB	71.3 GB	89.0%	187	51.20	18.98
12	SMALL	13.0 GB	10.7 GB	82.4%	18	6.65	23.78
13	BIN	80.1 GB	65.4 GB	81.7%	166	51.01	19.05
14	BIN	80.1 GB	33.0 GB	41.2%	187	51.23	18.97

TOTAL: 14	-	968.5 GB	541.2 GB	55.9%	1919	45.64	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	88987	66436	0	84	0	0	0	0	22467
2	?	2	0	0	0	0	0	0	0	2

TOTAL: 2		88989	66436	0	84	0	0	0	0	22469

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pictures.amateur.butts	3344
alt.binaries.dvdrs.pw	3275
alt.binaries.boys	3223
alt.binaries.pwp	3218
microsoft.public.test	1144
alt.binaries.wmvhd	914
alt.binaries.movie	799
alt.binaries.pictures.blonde	666
alt.binaries.pictures.erotica.early-teen	485
alt.binaries.pictures.erotica.teen.male.masturbation	432
alt.binaries.erotica.best-teens	397
alt.binaries.sandra.model	393
alt.binaries.pictures.erotica.young.female	371
alt.binaries.erotica.early-teens	371
easynews.alt.binaries.games.movies.apps	355
alt.sex.teen	341
pictures.erotica.lesbians	322
alt.binaries.images.andmore	320
alt.binaries.nospam.female.short-hair	316
alt.binaires.pictures.erotica.teens	306

TOTAL: 4358	66436

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	22467
	TOTAL: 1	22467

TOTAL: 1		22467

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	2	8418	501.3 MB	6	0	0	05:51:53
2	194.186.147.151	4	38	1.9 MB	4	0	0	00:06:22
3	195.218.244.87	4	11	937.5 KB	2	0	0	00:02:20

TOTAL: 3		10	8467	504.1 MB	12	0	0	08:09:21

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	2	8418	501.3 MB	6	0	0	05:51:53
2	unresolved	8	49	2.8 MB	6	0	0	00:08:43
3	*.net.rol.ru	7	0	0.0 KB	0	0	0	01:09:46
4	*.sarov.dial.rol.ru	7	0	0.0 KB	0	0	0	00:31:56
5	*.novokuznetzk.dial.rol.ru	2	0	0.0 KB	0	0	0	00:06:41
6	*.tony.pp.ru	71	0	0.0 KB	0	0	0	00:02:48
7	*.rol.ru	5768	0	0.0 KB	0	0	0	00:15:56

TOTAL: 7		5865	8467	504.1 MB	12	0	0	08:09:21

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	5.068	51.848	0.000	05:51:53
modul-gw000.net.rol.ru	0.012	0.008	0.000	01:09:46
ts2-a138.sarov.dial.rol.ru	0.008	0.008	0.000	00:20:33
ts2-a108.sarov.dial.rol.ru	0.012	0.008	0.000	00:10:12
balancer-b.rol.ru	3.440	3.124	0.000	00:08:06
balancer-a.rol.ru	3.644	3.156	0.000	00:07:49
ts2-a35.novokuznetzk.dial.rol.ru	0.016	0.004	0.000	00:06:41
194.186.147.151	0.004	0.008	0.000	00:06:22
net1-x-ring.tony.pp.ru	0.088	0.128	0.000	00:02:48
195.218.244.87	0.020	0.016	0.000	00:02:20
?	0.020	0.028	0.000	00:01:34
ts2-a35.sarov.dial.rol.ru	0.008	0.000	0.000	00:01:10
cornholio.migtel.ru	0.004	0.000	0.000	00:00:00

TOTAL: 13	12.344	58.336	0.000	08:09:21

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2884
balancer-a.rol.ru	2884
net1-x-ring.tony.pp.ru	71
modul-gw000.net.rol.ru	7
ts2-a138.sarov.dial.rol.ru	4
ts2-a35.novokuznetzk.dial.rol.ru	2
ts2-a108.sarov.dial.rol.ru	2
ts2-a35.sarov.dial.rol.ru	1

TOTAL: 8	5855

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	3

TOTAL: 1	3

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	15

TOTAL: 1	15

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a138.sarov.dial.rol.ru	2	0
ts2-a108.sarov.dial.rol.ru	1	0

TOTAL: 2	3	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	12334	100.0%

TOTAL: 1		12334	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	5753
2	alt.binaries.pictures.bras	5699
3	alt.binaries.pictures.artpics	833
4	alt.binaries.nospam.female.bodyhair.pubes	38
5	alt.binaries.erotica.pornstars	11

TOTAL: 5		12334