Daily Usenet report

Sep 12 03:00:01 -- Sep 13 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 / 22 lines (22.7%)
Sep 12 03:55:45 perseus controlchan[16499]: Unknown "cmsg" control by chuinhooi.bbs@bbs.cs.nctu.edu.tw
Sep 12 04:16:06 perseus controlchan[16499]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Sep 12 04:26:29 perseus controlchan[16499]: Unknown "cmsg" control by JayBruce.bbs@bbs.cs.nctu.edu.tw
Sep 12 04:26:34 perseus controlchan[16499]: Unknown "cmsg" control by JayBruce.bbs@bbs.cs.nctu.edu.tw
Sep 12 06:22:31 perseus controlchan[16499]: Unknown "cmsg" control by ken.bbs@bbs.cm.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	676843	90.3%	63.0 MB	90.5%
innd	51201	6.8%	4.6 MB	6.5%
nnrpd	19058	2.5%	1.7 MB	2.4%
cnfsstat	2304	0.3%	394.6 KB	0.6%
controlchan	23	0.0%	2.1 KB	0.0%

TOTAL: 5	749429	100.0%	69.7 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	628009	92.5%
Negative hits	45963	6.8%
Positive hits	3824	0.6%
Cache misses	767	0.1%

TOTAL: 4	678563	100.0%

INND timer:

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

article cancel	00:00:20.233	0.0%	7027	0.000	2.879	1811.000
article cleanup	00:00:05.899	0.0%	625951	0.000	0.009	0.029
article logging	00:02:24.699	0.2%	669731	0.000	0.216	17.614
article parse	00:02:27.899	0.2%	35625135	0.002	0.004	0.010
article write	00:49:28.755	3.4%	537535	0.254	5.523	31.896
artlog/artcncl	00:00:00.060	0.0%	6658	0.000	0.009	1.000
artlog/artparse	00:00:00.000	0.0%	10	0.000	0.000	0.000
data move	00:00:38.559	0.0%	37860358	0.000	0.001	0.002
hisgrep/artcncl	00:00:11.944	0.0%	4527	0.000	2.638	508.000
hishave/artcncl	00:00:03.320	0.0%	7027	0.000	0.472	44.450
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:10:36.480	0.7%	671988	0.000	0.947	18.582
history sync	00:00:00.232	0.0%	321	0.000	0.723	2.000
history write	00:29:17.702	2.0%	537535	0.011	3.270	34.406
hiswrite/artcncl	00:00:04.870	0.0%	2500	0.000	1.948	1811.000
idle	20:50:54.109	86.9%	35393643	0.964	2.121	21.843
nntp read	00:02:57.029	0.2%	35644770	0.002	0.005	0.011
overview write	01:25:08.980	5.9%	537535	0.899	9.504	50.107
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%	23	0.000	0.000	0.000

TOTAL: 23:59:12.757	23:54:40.770	99.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:00:24.617	0.1%	16585	0.000	1.484	6.318
idle	12:12:37.507	96.5%	39727	0.000	1106.489	200235.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:04:48.717	0.6%	118797	0.000	2.430	1616.726
readart	00:05:01.799	0.7%	33428	0.000	9.028	35.588

TOTAL: 12:39:24.881	12:22:52.640	97.8%	-	-	-	-

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

us-control@lists.killfile.org	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	846	610189	522839	4	87346	85%	439:51:12

TOTAL: 1		846	610189	522839	4	87346	85%	439:51:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	42.9 GB	335.2 KB	42.9 GB	99%	73.7 KB	439:51:12

TOTAL: 1		42.9 GB	335.2 KB	42.9 GB	99%	73.7 KB	439:51:12

Incoming articles:

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

Sep 12 03:00:01 - 03:59:59	20536	3.8%	5.71	1.9 GB	4.4%	553.15
Sep 12 04:00:00 - 04:59:59	23630	4.4%	6.56	2.3 GB	5.3%	665.06
Sep 12 05:00:00 - 05:59:59	22510	4.2%	6.25	2.3 GB	5.2%	656.72
Sep 12 06:00:00 - 06:59:59	21745	4.0%	6.04	1.7 GB	4.0%	494.96
Sep 12 07:00:00 - 07:59:59	23020	4.3%	6.39	1.8 GB	4.2%	532.08
Sep 12 08:00:00 - 08:59:59	20313	3.8%	5.64	1.9 GB	4.4%	550.16
Sep 12 09:00:00 - 09:59:59	22111	4.1%	6.14	2.3 GB	5.5%	683.83
Sep 12 10:00:00 - 10:59:59	22627	4.2%	6.29	2.3 GB	5.4%	673.94
Sep 12 11:00:00 - 11:59:59	20509	3.8%	5.70	1.8 GB	4.3%	536.65
Sep 12 12:00:00 - 12:59:59	21237	3.9%	5.90	2.0 GB	4.6%	570.97
Sep 12 13:00:00 - 13:59:59	22168	4.1%	6.16	2.0 GB	4.5%	569.15
Sep 12 14:00:00 - 14:59:59	21870	4.1%	6.08	2.2 GB	5.2%	648.06
Sep 12 15:00:00 - 15:59:59	21723	4.0%	6.03	2.3 GB	5.4%	679.72
Sep 12 16:00:00 - 16:59:59	23612	4.4%	6.56	2.1 GB	5.0%	626.08
Sep 12 17:00:00 - 17:59:59	24316	4.5%	6.75	2.4 GB	5.5%	691.85
Sep 12 18:00:00 - 18:59:59	20687	3.8%	5.75	1.5 GB	3.6%	449.07
Sep 12 19:00:00 - 19:59:59	18799	3.5%	5.22	908.4 MB	2.1%	258.40
Sep 12 20:00:00 - 20:59:59	23626	4.4%	6.56	1.4 GB	3.3%	413.73
Sep 12 21:00:00 - 21:59:59	23665	4.4%	6.57	1.8 GB	4.1%	513.80
Sep 12 22:00:00 - 22:59:59	21596	4.0%	6.00	1.2 GB	2.9%	357.69
Sep 12 23:00:00 - 23:59:59	21509	4.0%	5.97	1.3 GB	3.1%	385.75
Sep 13 00:00:00 - 00:59:59	22976	4.3%	6.38	696.4 MB	1.6%	198.08
Sep 13 01:00:00 - 01:59:59	28766	5.3%	7.99	923.4 MB	2.1%	262.65
Sep 13 02:00:00 - 02:59:59	24327	4.5%	6.76	1.9 GB	4.4%	557.54
Sep 13 03:00:00 - 03:00:01	14	0.0%	14.00	1.4 MB	0.0%	1385.33

TOTAL: 24:00:00	537892	100.0%	6.23	43.0 GB	100.0%	522.05

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	136.7 GB	99.2%	214	82.55	20.26
02	BIN	137.8 GB	91.2 GB	66.2%	215	82.99	20.15
03	SMALL	13.0 GB	1.4 GB	11.0%	18	6.05	26.14
04	BIN	80.1 GB	66.3 GB	82.8%	165	42.27	23.00
05	BIN	80.1 GB	11.9 GB	14.9%	186	42.04	23.12
06	SMALL	13.0 GB	1.4 GB	10.6%	18	6.01	26.32
07	BIN	80.1 GB	45.0 GB	56.1%	165	42.10	23.09
08	BIN	80.1 GB	73.3 GB	91.6%	185	42.50	22.87
09	SMALL	13.0 GB	379.1 MB	2.8%	18	6.09	25.99
10	BIN	80.1 GB	29.5 GB	36.8%	165	42.14	23.07
11	BIN	80.1 GB	33.1 GB	41.3%	186	41.97	23.16
12	SMALL	13.0 GB	1.2 GB	9.1%	18	5.98	26.47
13	BIN	80.1 GB	26.8 GB	33.4%	165	42.19	23.04
14	BIN	80.1 GB	74.7 GB	93.3%	185	42.21	23.03

TOTAL: 14	-	968.5 GB	592.8 GB	61.2%	1903	37.74	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	132283	70360	0	64	0	0	0	0	61859
2	?	10	0	0	0	0	0	0	0	10

TOTAL: 2		132293	70360	0	64	0	0	0	0	61869

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.dvdrs.pw	10540
alt.binaries.pwp	5524
bih.rec.photo.binaries	3806
alt.binaries.pictures.amateur.butts	2182
alt.binaries.game	1824
microsoft.public.test	1149
alt.binaries.chakotay	522
alt.binaries.pictures.blonde	515
alt.binaries.pictures.erotica.group.sex	421
adobe.indesign.macintosh	404
alt.binaries.pictures.senior-citizens	290
alt.binaries.smoking.videos	233
alt.binaires.erotica.teen	228
alt.binaries.usenet-world.com	215
alt.binaries.pictures.eroctica.butts	212
alt.binaries.pictures.black.erotica	208
alt.binaries.pictures.black.erotica.females	208
alt.binaries.pictures.latina	189
alt.binaries.pictures.erotica.amateur.digicam	182
alt.binaries.picturea.erotica	178

TOTAL: 3264	70360

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	43816
	TOTAL: 1	43816

TOTAL: 1		43816

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	5	16585	934.0 MB	15	0	0	11:08:17
2	195.218.244.87	2	17	978.2 KB	1	0	0	00:04:54
3	ts18-a71.moscow.dial.rol.ru	4	3	137.3 KB	6	0	0	00:14:37

TOTAL: 3		11	16605	935.1 MB	22	0	0	12:39:25

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	5	16585	934.0 MB	15	0	0	11:08:17
2	unresolved	5	17	978.2 KB	1	0	0	00:09:03
3	*.moscow.dial.rol.ru	4	3	137.3 KB	6	0	0	00:14:37
4	*.sovintel.net	11	0	0.0 KB	0	0	0	00:00:11
5	*.sarov.dial.rol.ru	6	0	0.0 KB	0	0	0	00:41:18
6	*.tony.pp.ru	72	0	0.0 KB	0	0	0	00:08:37
7	*.rol.ru	5765	0	0.0 KB	0	0	0	00:15:52

TOTAL: 7		5868	16605	935.1 MB	22	0	0	12:39:18

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	12.580	131.050	0.000	11:08:17
ts18-a71.moscow.dial.rol.ru	0.016	0.020	0.000	00:14:37
ts2-a38.sarov.dial.rol.ru	0.004	0.000	0.000	00:10:00
ts2-a224.sarov.dial.rol.ru	0.004	0.000	0.000	00:10:00
ts2-a53.sarov.dial.rol.ru	0.000	0.004	0.000	00:10:00
ts2-a174.sarov.dial.rol.ru	0.000	0.000	0.000	00:10:00
net1-x-ring.tony.pp.ru	0.124	0.096	0.000	00:08:37
balancer-a.rol.ru	3.384	3.288	0.000	00:08:02
balancer-b.rol.ru	3.392	3.360	0.000	00:07:50
195.218.244.87	0.008	0.020	0.000	00:04:54
212.46.235.34	0.004	0.000	0.000	00:04:08
?	0.000	0.008	0.000	00:01:19
ts2-a52.sarov.dial.rol.ru	0.012	0.008	0.000	00:01:15
fw-nat.sovintel.net	0.072	0.056	0.000	00:00:11
cornholio.migtel.ru	0.248	0.260	0.000	00:00:06
91.185.55.228	0.000	0.008	0.000	00:00:00
84.42.60.13	0.000	0.000	0.000	00:00:00

TOTAL: 17	19.848	138.178	0.000	12:39:25

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2883
balancer-b.rol.ru	2882
net1-x-ring.tony.pp.ru	72
fw-nat.sovintel.net	11
212.46.235.34	3
ts2-a52.sarov.dial.rol.ru	2
ts2-a174.sarov.dial.rol.ru	1
ts2-a53.sarov.dial.rol.ru	1
ts2-a224.sarov.dial.rol.ru	1
ts2-a38.sarov.dial.rol.ru	1

TOTAL: 10	5857

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	208
91.185.55.228	2
84.42.60.13	1

TOTAL: 3	211

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	13

TOTAL: 1	13

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a174.sarov.dial.rol.ru	1	0
ts2-a53.sarov.dial.rol.ru	1	0
ts2-a224.sarov.dial.rol.ru	1	0
ts2-a38.sarov.dial.rol.ru	1	0

TOTAL: 4	4	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	16605	100.0%

TOTAL: 1		16605	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	10021
2	alt.binaries.pictures.bras	5488
3	alt.binaries.pictures.artpics	1076
4	alt.binaries.erotica.pornstars	17
5	alt.sex.erotica.teen	2
6	alt.binaries.erotica.pregnant	1

TOTAL: 6		16605