Daily Usenet report

Oct 10 03:00:02 -- Oct 11 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
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 / 11 lines (45.5%)
Oct 10 04:59:16 andromeda controlchan[22077]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nthu.edu.tw
Oct 10 06:23:06 andromeda controlchan[22077]: Unknown "cmsg" control by JayBruce.bbs@bbs.cs.nctu.edu.tw
Oct 10 06:43:11 andromeda controlchan[22077]: Unknown "cmsg" control by zoevera.bbs@bbs.cs.nctu.edu.tw
Oct 10 08:20:36 andromeda controlchan[22077]: Unknown "cmsg" control by bineapple.bbs@bbs.cs.nctu.edu.tw
Oct 10 08:35:39 andromeda controlchan[22077]: Unknown "cmsg" control by shweiting.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	774180	94.0%	70.2 MB	93.0%
innd	29240	3.5%	3.1 MB	4.1%
nnrpd	18296	2.2%	1.8 MB	2.4%
cnfsstat	2304	0.3%	402.1 KB	0.5%
controlchan	12	0.0%	1.3 KB	0.0%

TOTAL: 5	824032	100.0%	75.5 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	748220	91.1%
Negative hits	70008	8.5%
Positive hits	2757	0.3%
Cache misses	613	0.1%

TOTAL: 4	821598	100.0%

INND timer:

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

article cancel	00:02:07.507	0.1%	6252	0.000	20.395	1894.000
article cleanup	00:00:09.336	0.0%	745596	0.000	0.013	1.429
article logging	00:01:03.610	0.1%	768053	0.000	0.083	23.470
article parse	00:03:06.599	0.2%	25464051	0.000	0.007	0.145
article write	00:47:03.839	3.3%	679065	0.466	4.158	80.657
artlog/artcncl	00:00:01.127	0.0%	6187	0.000	0.182	873.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:57.365	0.1%	27924200	0.000	0.002	185.333
hisgrep/artcncl	00:00:20.993	0.0%	2812	0.000	7.466	407.500
hishave/artcncl	00:00:43.192	0.0%	6252	0.000	6.909	702.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:54:14.588	7.9%	816075	0.779	8.399	262.110
history sync	00:00:01.792	0.0%	291	0.000	6.158	83.000
history write	02:59:09.115	12.4%	745383	2.167	14.421	473.695
hiswrite/artcncl	00:00:58.892	0.1%	3440	0.000	17.120	1616.250
idle	14:55:11.594	62.2%	24698187	0.000	2.175	61151.000
nntp read	00:03:24.675	0.2%	25360108	0.000	0.008	77.786
overview write	03:04:43.094	12.8%	679065	2.157	16.321	6986.909
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.014	0.0%	12	0.000	1.167	14.000

TOTAL: 24:00:17.706	23:53:17.332	99.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:29:01.769	3.2%	33299	0.000	52.307	160.918
idle	13:43:54.079	90.2%	148275	0.000	333.395	201126.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:16:01.610	1.8%	374099	0.000	2.570	3416.636
readart	00:15:15.237	1.7%	67733	0.000	13.512	192.111

TOTAL: 15:12:57.203	14:44:12.695	96.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	583	667119	605120	345	61654	90%	483:07:52
2	localhost	0	0	0	0	0	0%	00:01:53

TOTAL: 2		583	667119	605120	345	61654	90%	483:09:45

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	51.3 GB	5.7 MB	51.3 GB	99%	80.7 KB	483:07:52
2	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0	00:01:53

TOTAL: 2		51.3 GB	5.7 MB	51.3 GB	99%	80.7 KB	483:09:45

Incoming articles:

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

Oct 10 03:00:02 - 03:59:59	27953	4.1%	7.77	2.4 GB	4.6%	704.33
Oct 10 04:00:00 - 04:59:59	30026	4.4%	8.34	2.7 GB	5.2%	789.38
Oct 10 05:00:00 - 05:59:59	26490	3.9%	7.36	2.3 GB	4.5%	679.17
Oct 10 06:00:00 - 06:59:59	22078	3.3%	6.13	2.8 GB	5.4%	811.88
Oct 10 07:00:00 - 07:59:59	21515	3.2%	5.98	2.7 GB	5.2%	794.70
Oct 10 08:00:00 - 08:59:59	22349	3.3%	6.21	2.6 GB	5.0%	756.73
Oct 10 09:00:00 - 09:59:59	21871	3.2%	6.08	2.4 GB	4.6%	691.75
Oct 10 10:00:00 - 10:59:59	26974	4.0%	7.49	2.9 GB	5.6%	855.19
Oct 10 11:00:00 - 11:59:59	14279	2.1%	3.97	1.1 GB	2.2%	326.09
Oct 10 12:00:00 - 12:59:59	31037	4.6%	8.62	2.6 GB	4.9%	746.03
Oct 10 13:00:00 - 13:59:59	32502	4.8%	9.03	2.8 GB	5.5%	825.96
Oct 10 14:00:00 - 14:59:59	28263	4.2%	7.85	2.8 GB	5.4%	811.60
Oct 10 15:00:00 - 15:59:59	32742	4.8%	9.10	2.7 GB	5.1%	776.73
Oct 10 16:00:00 - 16:59:59	35953	5.3%	9.99	2.3 GB	4.3%	657.96
Oct 10 17:00:00 - 17:59:59	35586	5.2%	9.88	1.5 GB	2.9%	444.09
Oct 10 18:00:00 - 18:59:59	28043	4.1%	7.79	1.5 GB	2.8%	424.46
Oct 10 19:00:00 - 19:59:59	28072	4.1%	7.80	2.1 GB	4.0%	613.32
Oct 10 20:00:00 - 20:59:59	34283	5.0%	9.52	1.6 GB	3.1%	467.59
Oct 10 21:00:00 - 21:59:59	33300	4.9%	9.25	1.3 GB	2.4%	365.13
Oct 10 22:00:00 - 22:59:59	26366	3.9%	7.32	1.5 GB	2.8%	431.32
Oct 10 23:00:00 - 23:59:59	26252	3.9%	7.29	2.4 GB	4.6%	689.45
Oct 11 00:00:00 - 00:59:59	25520	3.8%	7.09	1.2 GB	2.3%	351.21
Oct 11 01:00:00 - 01:59:59	36319	5.3%	10.09	1.6 GB	3.1%	471.22
Oct 11 02:00:00 - 02:59:59	31296	4.6%	8.69	2.3 GB	4.4%	659.66
Oct 11 03:00:00 - 03:00:01	8	0.0%	8.00	207.2 KB	0.0%	207.21

TOTAL: 23:59:59	679077	100.0%	7.86	52.0 GB	100.0%	631.03

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	9.4 GB	6.8%	192	105.34	15.88
02	BIN	137.8 GB	49.3 GB	35.8%	192	105.11	15.91
03	SMALL	13.0 GB	10.5 GB	80.7%	16	6.89	22.98
04	BIN	80.1 GB	19.0 GB	23.7%	149	52.46	18.53
05	BIN	80.1 GB	4.6 GB	5.7%	166	52.43	18.54
06	SMALL	13.0 GB	9.9 GB	75.7%	16	6.81	23.24
07	BIN	80.1 GB	7.2 GB	9.0%	149	52.49	18.52
08	BIN	80.1 GB	66.7 GB	83.3%	165	52.89	18.38
09	SMALL	13.0 GB	10.0 GB	76.4%	16	6.83	23.15
10	BIN	80.1 GB	1.0 GB	1.3%	149	53.00	18.34
11	BIN	80.1 GB	11.3 GB	14.2%	166	52.50	18.51
12	BIN	13.0 GB	2.3 GB	17.7%	554	52.69	3.00
13	BIN	80.1 GB	43.8 GB	54.7%	90	52.51	18.51
14	SMALL	80.1 GB	66.5 GB	83.1%	1	6.87	141.52

TOTAL: 14	-	968.5 GB	311.5 GB	32.2%	2021	47.06	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	88915	66251	0	215	0	0	0	0	22449
2	?	2	0	0	0	0	0	0	0	2

TOTAL: 2		88917	66251	0	215	0	0	0	0	22451

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pictures.amateur.butts	3347
alt.binaries.dvdrs.pw	3255
alt.binaries.boys	3223
alt.binaries.pwp	3215
microsoft.public.test	1144
alt.binaries.wmvhd	915
alt.binaries.movie	796
alt.binaries.pictures.blonde	666
alt.binaries.pictures.erotica.early-teen	484
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	370
easynews.alt.binaries.games.movies.apps	355
alt.binaries.erotica.early-teens	354
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: 4356	66251

INND misc events:

Events	Count

CCreader	3

TOTAL: 1	3

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	22449
	TOTAL: 1	22449

TOTAL: 1		22449

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	5	33299	1.1 GB	14	0	0	12:09:03
2	194.186.147.151	5	54	2.8 MB	4	0	0	00:09:53

TOTAL: 2		10	33353	1.1 GB	18	0	2	15:12:33

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	5	33299	1.1 GB	14	0	0	12:09:03
2	unresolved	5	54	2.8 MB	4	0	0	00:09:53
3	*.net.rol.ru	9	0	0.0 KB	0	0	0	01:28:58
4	*.sarov.dial.rol.ru	5	0	0.0 KB	0	0	0	00:31:25
5	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00
6	*.moscow.dial.rol.ru	1	0	0.0 KB	0	0	0	00:03:09
7	*.tony.pp.ru	73	0	0.0 KB	0	0	0	00:15:21
8	*.rol.ru	5783	0	0.0 KB	0	0	0	00:22:07

TOTAL: 8		5882	33353	1.1 GB	18	0	1	15:12:33

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	14.772	26.572	0.000	12:09:03
modul-gw000.net.rol.ru	0.008	0.020	0.000	01:28:58
ts2-a138.sarov.dial.rol.ru	0.008	0.004	0.000	00:20:02
net1-x-ring.tony.pp.ru	60.980	61.068	0.000	00:15:21
?	0.024	5.892	0.000	00:12:33
balancer-b.rol.ru	3.464	3.804	0.000	00:11:24
balancer-a.rol.ru	3.476	4.044	0.000	00:10:42
ts2-a108.sarov.dial.rol.ru	0.000	0.000	0.000	00:10:03
194.186.147.151	0.044	0.180	0.000	00:09:53
ts27-a42.moscow.dial.rol.ru	0.000	0.008	0.000	00:03:09
ts2-a35.sarov.dial.rol.ru	0.004	0.000	0.000	00:01:19
cornholio.migtel.ru	0.000	0.008	0.000	00:00:00
web02.tr155m.lavtech.ru	0.000	0.000	0.000	00:00:00

TOTAL: 13	82.780	101.600	0.000	15:12:33

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2892
balancer-b.rol.ru	2891
net1-x-ring.tony.pp.ru	73
modul-gw000.net.rol.ru	9
ts2-a138.sarov.dial.rol.ru	2
ts2-a35.sarov.dial.rol.ru	2
ts27-a42.moscow.dial.rol.ru	1
ts2-a108.sarov.dial.rol.ru	1
web02.tr155m.lavtech.ru	1

TOTAL: 9	5872

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	2

TOTAL: 1	2

NNRP client timeouts [Top 20]:

System	Conn	Peer

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

TOTAL: 3	4	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	33353	100.0%

TOTAL: 1		33353	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	16736
2	alt.binaries.pictures.bras	12389
3	alt.binaries.pictures.artpics	4174
4	alt.binaries.nospam.female.bodyhair.pubes	54

TOTAL: 4		33353