Daily Usenet report

Sep 30 03:00:01 -- Oct 1 03:00:01

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 / 44 lines (11.4%)
Sep 30 07:00:50 perseus controlchan[16499]: Unknown "cmsg" control by sux0116.bbs@bbs.cs.nctu.edu.tw
Sep 30 07:13:04 perseus controlchan[16499]: Unknown "cmsg" control by lyric.bbs@kulu.twbbs.org
Sep 30 09:20:53 perseus controlchan[16499]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Sep 30 11:15:44 perseus controlchan[16499]: Unknown "cmsg" control by fcsholy.bbs@bbs.cs.nctu.edu.tw
Sep 30 11:35:45 perseus controlchan[16499]: Unknown "cmsg" control by godmusicli.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	559087	90.3%	51.9 MB	90.1%
innd	39300	6.3%	3.6 MB	6.3%
nnrpd	18725	3.0%	1.7 MB	2.9%
cnfsstat	2304	0.4%	394.7 KB	0.7%
controlchan	45	0.0%	4.0 KB	0.0%

TOTAL: 5	619461	100.0%	57.6 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	531525	89.8%
Negative hits	57593	9.7%
Positive hits	2625	0.4%
Cache misses	484	0.1%

TOTAL: 4	592227	100.0%

INND timer:

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

article cancel	00:00:15.150	0.0%	5056	0.000	2.996	822.000
article cleanup	00:00:04.806	0.0%	529853	0.000	0.009	0.032
article logging	00:01:25.244	0.1%	553899	0.000	0.154	16.061
article parse	00:02:24.852	0.2%	35431151	0.001	0.004	0.010
article write	00:38:59.360	2.7%	450448	0.146	5.193	25.832
artlog/artcncl	00:00:01.138	0.0%	4863	0.000	0.234	540.500
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:00:37.825	0.0%	37313586	0.000	0.001	0.002
hisgrep/artcncl	00:00:13.303	0.0%	3060	0.000	4.347	1644.000
hishave/artcncl	00:00:00.306	0.0%	5056	0.000	0.061	9.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:10:51.169	0.8%	587600	0.000	1.108	18.940
history sync	00:00:00.312	0.0%	362	0.000	0.862	49.000
history write	00:23:06.785	1.6%	450448	0.010	3.079	35.719
hiswrite/artcncl	00:00:00.374	0.0%	1996	0.000	0.187	55.000
idle	21:19:19.367	88.9%	35299202	0.729	2.175	51.513
nntp read	00:02:51.836	0.2%	35473810	0.000	0.005	0.011
overview write	01:14:43.680	5.2%	450448	0.873	9.954	103.093
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%	44	0.000	0.000	0.000

TOTAL: 23:59:09.532	23:54:55.507	99.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:01:31.467	0.1%	23707	0.000	3.858	19.280
idle	16:00:24.976	92.0%	54317	8.000	1060.901	201126.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:51:03.627	4.9%	162830	0.000	18.815	24983.625
readart	00:07:14.823	0.7%	47910	0.000	9.076	64.688

TOTAL: 17:23:51.249	17:00:14.893	97.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

news@news.belwue.de	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	1256	528749	450262	11	78476	85%	441:45:12

TOTAL: 1		1256	528749	450262	11	78476	85%	441:45:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	40.1 GB	165.7 KB	40.1 GB	99%	79.5 KB	441:45:12

TOTAL: 1		40.1 GB	165.7 KB	40.1 GB	99%	79.5 KB	441:45:12

Incoming articles:

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

Sep 30 03:00:01 - 03:59:59	18509	4.1%	5.14	2.0 GB	4.9%	573.42
Sep 30 04:00:00 - 04:59:59	20083	4.5%	5.58	2.3 GB	5.8%	677.62
Sep 30 05:00:00 - 05:59:59	14284	3.2%	3.97	1.6 GB	3.9%	456.71
Sep 30 06:00:00 - 06:59:59	13159	2.9%	3.66	1.5 GB	3.8%	438.82
Sep 30 07:00:00 - 07:59:59	15285	3.4%	4.25	1.5 GB	3.8%	439.45
Sep 30 08:00:00 - 08:59:59	12289	2.7%	3.41	1.4 GB	3.5%	410.93
Sep 30 09:00:00 - 09:59:59	12108	2.7%	3.36	1.4 GB	3.4%	402.60
Sep 30 10:00:00 - 10:59:59	19431	4.3%	5.40	1.6 GB	4.0%	462.34
Sep 30 11:00:00 - 11:59:59	17866	4.0%	4.96	1.6 GB	4.0%	465.72
Sep 30 12:00:00 - 12:59:59	21741	4.8%	6.04	2.0 GB	4.9%	571.54
Sep 30 13:00:00 - 13:59:59	20950	4.6%	5.82	1.6 GB	3.9%	458.62
Sep 30 14:00:00 - 14:59:59	23176	5.1%	6.44	1.9 GB	4.8%	563.63
Sep 30 15:00:00 - 15:59:59	19227	4.3%	5.34	1.4 GB	3.6%	417.46
Sep 30 16:00:00 - 16:59:59	20999	4.7%	5.83	1.6 GB	3.9%	454.07
Sep 30 17:00:00 - 17:59:59	20602	4.6%	5.72	1.5 GB	3.7%	436.77
Sep 30 18:00:00 - 18:59:59	17619	3.9%	4.89	1.3 GB	3.3%	384.80
Sep 30 19:00:00 - 19:59:59	21490	4.8%	5.97	1.4 GB	3.6%	416.28
Sep 30 20:00:00 - 20:59:59	20745	4.6%	5.76	1.6 GB	4.1%	476.45
Sep 30 21:00:00 - 21:59:59	20446	4.5%	5.68	2.1 GB	5.4%	625.85
Sep 30 22:00:00 - 22:59:59	21148	4.7%	5.87	2.1 GB	5.3%	615.97
Sep 30 23:00:00 - 23:59:59	20608	4.6%	5.72	1.8 GB	4.5%	520.92
Oct 1 00:00:00 - 00:59:59	15578	3.5%	4.33	1.0 GB	2.5%	293.31
Oct 1 01:00:00 - 01:59:59	23661	5.2%	6.57	1.7 GB	4.2%	490.44
Oct 1 02:00:00 - 02:59:59	19686	4.4%	5.47	2.1 GB	5.3%	622.63
Oct 1 03:00:00 - 03:00:01	7	0.0%	7.00	810.8 KB	0.0%	810.83

TOTAL: 24:00:00	450697	100.0%	5.22	40.1 GB	100.0%	486.52

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	4.2 GB	3.1%	216	80.05	20.89
02	BIN	137.8 GB	96.0 GB	69.7%	216	79.01	21.17
03	SMALL	13.0 GB	7.4 GB	57.0%	18	3.87	40.92
04	BIN	80.1 GB	57.7 GB	72.0%	166	39.77	24.44
05	BIN	80.1 GB	3.0 GB	3.8%	187	39.70	24.49
06	SMALL	13.0 GB	7.4 GB	56.7%	18	3.89	40.70
07	BIN	80.1 GB	36.5 GB	45.5%	166	39.83	24.40
08	BIN	80.1 GB	64.7 GB	80.8%	186	39.45	24.64
09	SMALL	13.0 GB	6.4 GB	48.9%	18	3.90	40.56
10	BIN	80.1 GB	21.0 GB	26.2%	166	39.68	24.50
11	BIN	80.1 GB	24.3 GB	30.3%	187	39.67	24.50
12	SMALL	13.0 GB	7.2 GB	55.2%	18	3.89	40.66
13	BIN	80.1 GB	18.3 GB	22.8%	166	39.81	24.41
14	BIN	80.1 GB	66.1 GB	82.5%	186	39.57	24.57

TOTAL: 14	-	968.5 GB	420.2 GB	43.4%	1914	35.15	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	103524	62857	0	38	0	0	0	0	40629
2	?	3	0	0	0	0	0	0	0	3

TOTAL: 2		103527	62857	0	38	0	0	0	0	40632

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	28587
alt.binaries.movies.dutch	1291
microsoft.public.test	1148
alt.binaries.wmvhd	1132
alt.binaries.pictures.amateur.butts	987
alt.binaries.amazing	706
alt.binaries.blu-ray	601
bih.rec.kladjenje.binaries	589
alt.binaries.dvdrs.pw	530
alt.binaries.matrix	483
telekabel.tratsch	408
alt.binaries.nospam.female.short-hair	319
alt.binaries.movie	299
alt.binaries.pictures.comics.repost	241
macromedia.flex.general_discussion	195
alt.binaries.pictures.erotica.teen.male.masturbation	175
alt.binaries.pictures.senior-citizens	170
alt.binaires.pictures.erotica.male	164
mozilla.feedback.firefox	157
alt.alt.sex	143

TOTAL: 3192	62857

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	24051
	TOTAL: 1	24051

TOTAL: 1		24051

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	7	23707	1.4 GB	21	0	0	14:04:44
2	ts18-a133.moscow.dial.rol.ru	1	84	4.5 MB	8	0	0	00:35:04
3	195.218.244.87	3	29	2.3 MB	2	0	0	00:04:05
4	194.186.188.96	34	19	223.7 KB	3	0	0	00:13:12
5	ts18-a46.moscow.dial.rol.ru	1	3	137.6 KB	6	0	0	00:31:22
6	ts27-a221.moscow.dial.rol.ru	1	2	22.8 KB	1	0	0	00:00:53

TOTAL: 6		47	23844	1.5 GB	41	0	0	17:23:51

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	7	23707	1.4 GB	21	0	0	14:04:44
2	*.moscow.dial.rol.ru	3	89	4.7 MB	15	0	0	01:07:20
3	unresolved	39	48	2.5 MB	5	0	0	00:18:21
4	*.sovintel.net	20	0	0.0 KB	0	0	0	00:00:23
5	*.net.rol.ru	1	0	0.0 KB	0	0	0	00:03:06
6	*.rol.kis.ru	1	0	0.0 KB	0	0	0	00:08:50
7	*.sarov.dial.rol.ru	11	0	0.0 KB	0	0	0	01:21:35
8	*.tony.pp.ru	70	0	0.0 KB	0	0	0	00:02:25
9	*.rol.ru	5761	0	0.0 KB	0	0	0	00:16:31

TOTAL: 9		5913	23844	1.5 GB	41	0	0	17:23:50

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	16.972	190.762	0.000	14:04:44
ts2-a155.sarov.dial.rol.ru	0.012	0.020	0.000	00:40:02
ts18-a133.moscow.dial.rol.ru	0.016	0.036	0.000	00:35:04
ts18-a46.moscow.dial.rol.ru	0.012	0.012	0.000	00:31:22
194.186.188.96	0.032	0.036	0.000	00:13:12
ts2-a252.sarov.dial.rol.ru	0.016	0.000	0.000	00:10:12
ts2-a93.sarov.dial.rol.ru	0.004	0.012	0.000	00:10:07
ts2-a144.sarov.dial.rol.ru	0.000	0.004	0.000	00:10:04
ts2-a13.sarov.dial.rol.ru	0.004	0.004	0.000	00:10:03
balancer-b.rol.ru	3.396	3.348	0.000	00:09:13
rol34.rol.kis.ru	0.012	0.004	0.000	00:08:50
balancer-a.rol.ru	3.692	3.192	0.000	00:07:18
195.218.244.87	0.020	0.036	0.000	00:04:05
modul-gw000.net.rol.ru	0.000	0.000	0.000	00:03:06
net1-x-ring.tony.pp.ru	0.088	0.116	0.000	00:02:25
212.46.202.113	0.004	0.004	0.000	00:01:02
ts2-a133.sarov.dial.rol.ru	0.000	0.004	0.000	00:01:01
ts27-a221.moscow.dial.rol.ru	0.004	0.016	0.000	00:00:53
?	0.000	0.012	0.000	00:00:30
fw-nat.sovintel.net	0.144	0.056	0.000	00:00:23

TOTAL: 24	24.604	197.938	0.000	17:23:51

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2881
balancer-b.rol.ru	2880
net1-x-ring.tony.pp.ru	70
fw-nat.sovintel.net	20
ts2-a155.sarov.dial.rol.ru	4
ts2-a252.sarov.dial.rol.ru	2
212.46.202.113	2
ts2-a93.sarov.dial.rol.ru	1
ts2-a243.sarov.dial.rol.ru	1
rol34.rol.kis.ru	1
ts2-a13.sarov.dial.rol.ru	1
modul-gw000.net.rol.ru	1
ts2-a133.sarov.dial.rol.ru	1
ts2-a144.sarov.dial.rol.ru	1

TOTAL: 14	5866

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	54
ppp92-100-71-54.pppoe.avangarddsl.ru	4
80.251.115.148	1

TOTAL: 3	59

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	6

TOTAL: 1	6

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a155.sarov.dial.rol.ru	4	0
ts2-a93.sarov.dial.rol.ru	1	0
ts2-a252.sarov.dial.rol.ru	1	0
ts2-a13.sarov.dial.rol.ru	1	0
ts2-a144.sarov.dial.rol.ru	1	0

TOTAL: 5	8	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	23824	99.9%
2	france	18	0.1%
3	0	2	0.0%

TOTAL: 3		23844	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	11417
2	alt.binaries.pictures.bras	9399
3	alt.binaries.pictures.artpics	2891
4	alt.binaries.pictures.erotica.incest	47
5	alt.binaries.erotica.pornstars	29
6	alt.binaries.erotica.pregnant	25
7	france.midi-pyrenees.toulouse	16
8	alt.binaries.pictures.lolita	10
9	alt.binaries.pictures.erotica.amateur.lolita	5
10	france.midi-pyrenees	2
11	0.test	2
12	alt.binaries.pictures.fine-art.d	1

TOTAL: 12		23844