Daily Usenet report

Oct 4 03:00:03 -- Oct 5 03:00:02

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 / 17 lines (29.4%)
Oct 4 05:21:19 perseus controlchan[31034]: Unknown "cmsg" control by zoevera.bbs@bbs.cs.nctu.edu.tw
Oct 4 13:01:08 perseus controlchan[31034]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Oct 4 13:25:45 perseus controlchan[31034]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Oct 4 15:00:57 perseus controlchan[31034]: Unknown "cmsg" control by sux0116.bbs@bbs.cs.nctu.edu.tw
Oct 4 15:40:47 perseus controlchan[31034]: Unknown "cmsg" control by advanding100.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	634640	95.3%	58.1 MB	94.3%
nnrpd	18309	2.7%	1.8 MB	2.9%
innd	10534	1.6%	1.4 MB	2.2%
cnfsstat	2304	0.3%	397.8 KB	0.6%
controlchan	20	0.0%	2.5 KB	0.0%

TOTAL: 5	665807	100.0%	61.6 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	619276	91.4%
Negative hits	54965	8.1%
Positive hits	2284	0.3%
Cache misses	656	0.1%

TOTAL: 4	677181	100.0%

INND timer:

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

article cancel	00:00:10.303	0.0%	5403	0.000	1.907	876.000
article cleanup	00:00:05.710	0.0%	617071	0.000	0.009	0.036
article logging	00:02:51.183	0.2%	629340	0.000	0.272	25.344
article parse	00:02:55.177	0.2%	42386144	0.002	0.004	0.011
article write	01:03:07.938	4.4%	556342	0.358	6.809	32.955
artlog/artcncl	00:00:00.063	0.0%	5330	0.000	0.012	4.000
artlog/artparse	00:00:00.000	0.0%	4	0.000	0.000	0.000
data move	00:00:45.270	0.1%	44897933	0.000	0.001	0.003
hisgrep/artcncl	00:00:09.585	0.0%	2930	0.000	3.271	876.000
hishave/artcncl	00:00:00.262	0.0%	5403	0.000	0.048	14.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:09:18.045	0.6%	672116	0.000	0.830	14.736
history sync	00:00:00.243	0.0%	344	0.000	0.706	2.000
history write	00:27:43.159	1.9%	556342	0.008	2.989	49.110
hiswrite/artcncl	00:00:00.366	0.0%	2473	0.000	0.148	16.000
idle	20:54:20.825	87.1%	42165759	0.601	1.785	27.230
nntp read	00:03:27.577	0.2%	42414145	0.002	0.005	0.015
overview write	01:09:46.300	4.8%	556342	0.368	7.525	68.590
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%	18	0.000	0.000	0.000

TOTAL: 24:00:07.936	23:54:42.006	99.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:00:33.920	0.1%	11559	0.000	2.935	8.575
idle	08:00:58.799	93.9%	29743	8.000	970.272	200423.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:14:46.999	2.9%	204835	0.000	4.330	4110.364
readart	00:03:53.416	0.8%	23336	0.000	10.002	54.417

TOTAL: 08:32:13.666	08:20:13.134	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

admin@openwatcom.news-admin.org	0	0	1	0	0	1
hamstermumke@xs4all.nl	0	2	0	0	0	2

TOTAL	0	2	1	0	0	3

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	1178	629732	570761	1	58970	90%	444:12:55

TOTAL: 1		1178	629732	570761	1	58970	90%	444:12:55

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	56.8 GB	236.9 KB	56.8 GB	99%	94.5 KB	444:12:55

TOTAL: 1		56.8 GB	236.9 KB	56.8 GB	99%	94.5 KB	444:12:55

Incoming articles:

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

Oct 4 03:00:03 - 03:59:59	29757	5.3%	8.27	1.7 GB	2.9%	486.06
Oct 4 04:00:00 - 04:59:59	26871	4.8%	7.46	1.9 GB	3.3%	557.38
Oct 4 05:00:00 - 05:59:59	24220	4.4%	6.73	2.1 GB	3.6%	597.39
Oct 4 06:00:00 - 06:59:59	18008	3.2%	5.00	1.8 GB	3.1%	515.02
Oct 4 07:00:00 - 07:59:59	18550	3.3%	5.15	1.9 GB	3.4%	566.22
Oct 4 08:00:00 - 08:59:59	17768	3.2%	4.94	2.4 GB	4.1%	687.46
Oct 4 09:00:00 - 09:59:59	17741	3.2%	4.93	2.6 GB	4.5%	747.65
Oct 4 10:00:00 - 10:59:59	17834	3.2%	4.95	2.6 GB	4.6%	771.12
Oct 4 11:00:00 - 11:59:59	18131	3.3%	5.04	2.3 GB	3.9%	657.70
Oct 4 12:00:00 - 12:59:59	16655	3.0%	4.63	1.8 GB	3.1%	520.37
Oct 4 13:00:00 - 13:59:59	17743	3.2%	4.93	2.3 GB	4.0%	659.25
Oct 4 14:00:00 - 14:59:59	20493	3.7%	5.69	2.6 GB	4.6%	770.19
Oct 4 15:00:00 - 15:59:59	21111	3.8%	5.86	3.0 GB	5.2%	866.58
Oct 4 16:00:00 - 16:59:59	23419	4.2%	6.51	3.1 GB	5.4%	893.06
Oct 4 17:00:00 - 17:59:59	23252	4.2%	6.46	2.9 GB	5.0%	837.94
Oct 4 18:00:00 - 18:59:59	22937	4.1%	6.37	2.8 GB	4.9%	818.31
Oct 4 19:00:00 - 19:59:59	30544	5.5%	8.48	2.7 GB	4.7%	784.91
Oct 4 20:00:00 - 20:59:59	31623	5.7%	8.78	3.1 GB	5.4%	899.67
Oct 4 21:00:00 - 21:59:59	29789	5.4%	8.27	2.9 GB	5.0%	834.64
Oct 4 22:00:00 - 22:59:59	31319	5.6%	8.70	2.0 GB	3.4%	569.40
Oct 4 23:00:00 - 23:59:59	27968	5.0%	7.77	2.8 GB	4.8%	801.33
Oct 5 00:00:00 - 00:59:59	22336	4.0%	6.20	1.4 GB	2.5%	415.42
Oct 5 01:00:00 - 01:59:59	22309	4.0%	6.20	2.2 GB	3.9%	651.94
Oct 5 02:00:00 - 02:59:59	25869	4.7%	7.19	2.7 GB	4.7%	776.11
Oct 5 03:00:00 - 03:00:02	51	0.0%	25.50	7.6 MB	0.0%	3909.61

TOTAL: 23:59:59	556298	100.0%	6.44	57.3 GB	100.0%	695.30

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	40.2 GB	29.2%	216	115.37	14.50
02	BIN	137.8 GB	131.9 GB	95.7%	216	114.59	14.60
03	SMALL	13.0 GB	8.6 GB	65.8%	18	3.71	42.63
04	BIN	80.1 GB	75.7 GB	94.5%	166	57.36	16.95
05	BIN	80.1 GB	20.9 GB	26.2%	187	57.16	17.00
06	SMALL	13.0 GB	8.5 GB	65.4%	18	3.76	42.05
07	BIN	80.1 GB	54.4 GB	68.0%	166	57.48	16.91
08	BIN	80.1 GB	2.6 GB	3.2%	187	57.35	16.95
09	SMALL	13.0 GB	7.5 GB	57.6%	18	3.73	42.38
10	BIN	80.1 GB	39.1 GB	48.8%	166	57.68	16.85
11	BIN	80.1 GB	42.2 GB	52.7%	187	57.31	16.96
12	SMALL	13.0 GB	8.3 GB	63.9%	18	3.65	43.34
13	BIN	80.1 GB	36.3 GB	45.3%	166	57.46	16.92
14	BIN	80.1 GB	4.0 GB	4.9%	187	57.42	16.93

TOTAL: 14	-	968.5 GB	480.3 GB	49.6%	1916	50.29	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	73009	60726	0	12	0	0	0	0	12271
2	?	4	0	0	0	0	0	0	0	4

TOTAL: 2		73013	60726	0	12	0	0	0	0	12275

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	8316
alt.binaries.dvdrs.pw	3779
de.alt.sex.fetish	2825
alt.binaries.movies.dutch	1803
alt.binaries.pictures.amateur.butts	1537
microsoft.public.test	1152
alt.binaries.game	1089
alt.binaries.the-portal	882
alt.binaries.nospam.female.short-hair	389
alt.binaires.pictures.erotica.teens	285
alt.binaries.pictures.willeymodels	283
alt.binaries.movie	274
alt.binaires.pictures.erotica.butts	273
alt.binaries.pictures.erotica.young.female	257
alt.binaries.erotica.early-teens	249
alt.binaries.erotic.erotika.young	244
alt.binaries.erotica.best-teens	234
alt.binaires.pictures.erotica.amatuer.female	213
alt.binaries.amberbigbutt	211
alt.binaries.pictures.blonde	206

TOTAL: 2965	60726

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	12271
	TOTAL: 1	12271

TOTAL: 1		12271

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	4	11559	706.5 MB	9	0	0	06:38:21
2	ts18-a214.moscow.dial.rol.ru	1	37	1.7 MB	3	0	0	00:19:51
3	195.218.244.87	3	14	1.1 MB	2	0	0	00:01:29
4	194.186.147.172	3	8	768.5 KB	2	0	0	00:03:47

TOTAL: 4		11	11618	710.1 MB	16	0	0	08:32:13

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	4	11559	706.5 MB	9	0	0	06:38:21
2	*.moscow.dial.rol.ru	1	37	1.7 MB	3	0	0	00:19:51
3	unresolved	6	22	1.9 MB	4	0	0	00:05:17
4	*.sovintel.net	12	0	0.0 KB	0	0	0	00:00:08
5	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:09
6	*.rol.kis.ru	1	0	0.0 KB	0	0	0	00:06:12
7	*.sarov.dial.rol.ru	7	0	0.0 KB	0	0	0	00:51:12
8	*.tony.pp.ru	77	0	0.0 KB	0	0	0	00:12:54
9	*.rol.ru	5764	0	0.0 KB	0	0	0	00:15:45

TOTAL: 9		5873	11618	710.1 MB	16	0	0	08:32:12

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	7.884	79.654	0.000	06:38:21
ts2-a58.sarov.dial.rol.ru	0.008	0.000	0.000	00:30:02
ts18-a214.moscow.dial.rol.ru	0.016	0.024	0.000	00:19:51
net1-x-ring.tony.pp.ru	0.144	0.120	0.000	00:12:54
ts2-a86.sarov.dial.rol.ru	0.000	0.000	0.000	00:10:00
ts2-a67.sarov.dial.rol.ru	0.004	0.000	0.000	00:10:00
balancer-b.rol.ru	3.500	3.184	0.000	00:08:53
balancer-a.rol.ru	3.416	3.252	0.000	00:06:52
rol54.rol.kis.ru	0.024	0.000	0.000	00:06:12
194.186.147.172	0.008	0.032	0.000	00:03:47
?	0.008	0.020	0.000	00:02:18
195.218.244.87	0.008	0.012	0.000	00:01:29
ts2-a152.sarov.dial.rol.ru	0.000	0.000	0.000	00:01:08
news.lek.ru	0.100	0.072	0.000	00:00:09
fw-nat.sovintel.net	0.112	0.044	0.000	00:00:08
216.183.93.234	0.008	0.000	0.000	00:00:00
cornholio.migtel.ru	0.004	0.004	0.000	00:00:00

TOTAL: 17	15.244	86.418	0.000	08:32:13

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2882
balancer-a.rol.ru	2882
net1-x-ring.tony.pp.ru	77
fw-nat.sovintel.net	12
ts2-a58.sarov.dial.rol.ru	3
ts2-a152.sarov.dial.rol.ru	2
news.lek.ru	1
rol54.rol.kis.ru	1
ts2-a67.sarov.dial.rol.ru	1
ts2-a86.sarov.dial.rol.ru	1

TOTAL: 10	5862

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	4
216.183.93.234	2

TOTAL: 2	6

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	20

TOTAL: 1	20

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a58.sarov.dial.rol.ru	3	0
ts2-a67.sarov.dial.rol.ru	1	0
ts2-a86.sarov.dial.rol.ru	1	0

TOTAL: 3	5	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	12042	100.0%

TOTAL: 1		12042	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	5380
2	alt.binaries.pictures.bras	4932
3	alt.binaries.pictures.artpics	1671
4	alt.binaries.pictures.lolita	31
5	alt.binaries.erotica.pornstars	14
6	alt.binaries.nospam.female.bodyhair	8
7	alt.binaries.erotica.pregnant	6

TOTAL: 7		12042