Daily Usenet report

Oct 14 03:00:02 -- Oct 15 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
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 / 32 lines (15.6%)
Oct 14 06:39:25 andromeda controlchan[1638]: Unknown "cmsg" control by sux0116.bbs@bbs.cs.nctu.edu.tw
Oct 14 06:39:25 andromeda controlchan[1638]: Unknown "cmsg" control by sux0116.bbs@bbs.cs.nctu.edu.tw
Oct 14 07:29:20 andromeda controlchan[1638]: Unknown "cmsg" control by linhuayi.bbs@bbs.cs.nctu.edu.tw
Oct 14 07:54:21 andromeda controlchan[1638]: Unknown "cmsg" control by matt.bbs@bbs.cs.nctu.edu.tw
Oct 14 08:54:37 andromeda controlchan[1638]: skipping newgroup alt.binaries.multimedia.erotica.stag-films y JTStevens@GMail.com (would be created)

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	632004	92.9%	57.4 MB	91.9%
innd	27344	4.0%	2.9 MB	4.6%
nnrpd	18526	2.7%	1.8 MB	2.9%
cnfsstat	2288	0.3%	394.5 KB	0.6%
controlchan	44	0.0%	4.8 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%

TOTAL: 6	680207	100.0%	62.4 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	621513	91.6%
Negative hits	52586	7.8%
Positive hits	2990	0.4%
Cache misses	1096	0.2%

TOTAL: 4	678185	100.0%

INND timer:

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

article cancel	00:01:27.107	0.1%	6262	0.000	13.910	4306.000
article cleanup	00:00:08.240	0.0%	617296	0.000	0.013	0.719
article logging	00:00:47.411	0.1%	625891	0.000	0.076	15.192
article parse	00:03:16.295	0.2%	28968799	0.000	0.007	11.320
article write	00:39:13.202	2.7%	559889	0.425	4.203	34.599
artlog/artcncl	00:00:05.754	0.0%	6104	0.000	0.943	4259.000
artlog/artparse	00:00:00.000	0.0%	7	0.000	0.000	0.000
data move	00:01:06.723	0.1%	31206507	0.000	0.002	7.265
hisgrep/artcncl	00:00:23.965	0.0%	3151	0.000	7.606	2653.000
hishave/artcncl	00:00:26.609	0.0%	6262	0.000	4.249	767.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:27:13.637	6.1%	672154	0.000	7.786	72.147
history sync	00:00:01.937	0.0%	331	0.000	5.852	252.000
history write	02:07:43.307	8.9%	616679	0.067	12.427	120.394
hiswrite/artcncl	00:00:27.312	0.0%	3111	0.000	8.779	863.000
idle	16:41:09.962	69.5%	28359281	0.000	2.118	60005.000
nntp read	00:03:42.933	0.3%	28915187	0.000	0.008	2.431
overview write	02:37:02.326	10.9%	559889	2.430	16.829	9088.429
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.009	0.0%	42	0.000	0.214	4.000

TOTAL: 23:59:58.865	23:44:16.729	98.9%	-	-	-	-

nnrpd timer:

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

hisgrep	00:12:32.807	0.8%	17787	0.000	42.323	42.780
idle	22:52:26.821	82.7%	127324	0.000	646.750	200169.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:08:06.569	0.5%	297394	0.000	1.636	4992.333
readart	00:11:37.300	0.7%	36096	0.000	19.318	279.424

TOTAL: 27:39:05.949	23:24:43.497	84.7%	-	-	-	-

Control commands to INND:

Command	Number

flush	143
flushlogs	1
paused	4

TOTAL: 3	148

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

JTStevens@GMail.com	1	0	0	0	0	1
control-microsoft@trigofacile.com	0	8	0	0	0	8
hamstermumke@xs4all.nl	0	1	0	0	0	1
news@news.cs.nctu.edu.tw	2	1	0	0	0	3

TOTAL	3	10	0	0	0	13

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	721	683673	621099	319	62255	90%	489:10:23
2	localhost	0	0	0	0	0	0%	00:00:14

TOTAL: 2		721	683673	621099	319	62255	90%	489:10:37

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	54.6 GB	11.3 MB	54.6 GB	99%	83.8 KB	489:10:23
2	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0	00:00:14

TOTAL: 2		54.6 GB	11.3 MB	54.6 GB	99%	83.8 KB	489:10:37

Incoming articles:

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

Oct 14 03:00:02 - 03:59:59	19466	3.5%	5.41	2.3 GB	4.2%	663.99
Oct 14 04:00:00 - 04:59:59	21137	3.8%	5.87	2.5 GB	4.7%	738.52
Oct 14 05:00:00 - 05:59:59	23003	4.1%	6.39	2.8 GB	5.1%	808.67
Oct 14 06:00:00 - 06:59:59	19294	3.4%	5.36	2.5 GB	4.6%	724.16
Oct 14 07:00:00 - 07:59:59	18032	3.2%	5.01	2.2 GB	4.1%	637.88
Oct 14 08:00:00 - 08:59:59	18771	3.4%	5.21	2.7 GB	4.9%	777.92
Oct 14 09:00:00 - 09:59:59	9900	1.8%	2.75	1.3 GB	2.3%	367.16
Oct 14 10:00:00 - 10:59:59	30743	5.5%	8.54	4.4 GB	8.0%	1267.66
Oct 14 11:00:00 - 11:59:59	23328	4.2%	6.48	2.0 GB	3.6%	570.66
Oct 14 12:00:00 - 12:59:59	28273	5.0%	7.85	2.2 GB	4.1%	650.28
Oct 14 13:00:00 - 13:59:59	28585	5.1%	7.94	2.7 GB	4.9%	778.87
Oct 14 14:00:00 - 14:59:59	27416	4.9%	7.62	2.4 GB	4.5%	700.86
Oct 14 15:00:00 - 15:59:59	27541	4.9%	7.65	2.5 GB	4.7%	737.57
Oct 14 16:00:00 - 16:59:59	36562	6.5%	10.16	4.5 GB	8.3%	1309.95
Oct 14 17:00:00 - 17:59:59	30116	5.4%	8.37	2.6 GB	4.9%	769.51
Oct 14 18:00:00 - 18:59:59	28014	5.0%	7.78	2.2 GB	4.2%	654.50
Oct 14 19:00:00 - 19:59:59	29264	5.2%	8.13	2.2 GB	4.2%	655.19
Oct 14 20:00:00 - 20:59:59	24239	4.3%	6.73	2.2 GB	4.0%	629.65
Oct 14 21:00:00 - 21:59:59	25958	4.6%	7.21	2.5 GB	4.6%	718.38
Oct 14 22:00:00 - 22:59:59	24917	4.5%	6.92	2.6 GB	4.9%	770.51
Oct 14 23:00:00 - 23:59:59	18689	3.3%	5.19	866.5 MB	1.6%	246.48
Oct 15 00:00:00 - 00:59:59	13515	2.4%	3.75	369.9 MB	0.7%	105.22
Oct 15 01:00:00 - 01:59:59	17477	3.1%	4.85	621.5 MB	1.1%	176.78
Oct 15 02:00:00 - 02:59:59	15647	2.8%	4.35	1015.0 MB	1.8%	288.70
Oct 15 03:00:00 - 03:00:02	11	0.0%	5.50	772.8 KB	0.0%	386.42

TOTAL: 24:00:00	559898	100.0%	6.48	54.1 GB	100.0%	656.20

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	26.1 GB	18.9%	192	110.61	15.12
02	BIN	137.8 GB	65.9 GB	47.8%	192	110.36	15.16
03	SMALL	13.0 GB	11.4 GB	87.4%	16	4.49	35.23
04	BIN	80.1 GB	27.3 GB	34.1%	149	55.51	17.51
05	BIN	80.1 GB	12.9 GB	16.1%	166	55.14	17.63
06	SMALL	13.0 GB	10.8 GB	82.5%	16	4.45	35.52
07	BIN	80.1 GB	15.5 GB	19.4%	149	55.08	17.65
08	BIN	80.1 GB	75.1 GB	93.7%	165	55.24	17.60
09	SMALL	13.0 GB	10.9 GB	83.2%	16	4.44	35.60
10	BIN	80.1 GB	9.3 GB	11.7%	149	55.30	17.58
11	BIN	80.1 GB	19.7 GB	24.6%	166	55.52	17.51
12	BIN	13.0 GB	10.6 GB	81.6%	554	55.43	2.85
13	BIN	80.1 GB	52.1 GB	65.1%	90	55.41	17.54
14	SMALL	80.1 GB	67.4 GB	84.2%	1	4.47	217.22

TOTAL: 14	-	968.5 GB	415.0 GB	42.9%	2021	48.68	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	65995	56783	0	616	0	0	0	0	8596
2	?	7	0	0	0	0	0	0	0	7

TOTAL: 2		66002	56783	0	616	0	0	0	0	8603

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	4702
alt.binaries.dvdrs.pw	2415
alt.binaries.boys	1799
alt.binaries.game	1176
microsoft.public.test	1137
alt.binaries.pictures.amateur.butts	1061
alt.binaries.erotica.anime	875
alt.binaries.amazing	814
alt.binaries.the-portal	588
alt.binaries.fetish	389
alt.binaries.newstar	372
alt.binaries.picures.erotica.tasteless	367
alt.binaries.pictures.eroctica.rape	328
alt.binaries.erotica.best-teens	322
alt.binaries.erotica.fetishs	321
alt.binaries.pictures.eroctica.torture	317
alt.binaires.pictures.erotica.teens	316
alt.binaries.pictures.erotica.rapefiles	313
alt.binaries.erotica.fettish.alt	304
alt.binaires.erotica.teen	294

TOTAL: 3331	56783

INND misc events:

Events	Count

CCreader	1

TOTAL: 1	1

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	8595
	TOTAL: 1	8595

TOTAL: 1		8595

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	2	17787	675.6 MB	5	0	0	21:37:05
2	195.218.244.87	4	98	5.3 MB	3	0	0	00:22:18
3	ts18-a181.moscow.dial.rol.ru	2	21	1.2 MB	5	0	0	00:22:04

TOTAL: 3		8	17906	682.1 MB	13	0	0	27:38:24

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	2	17787	675.6 MB	5	0	0	21:37:05
2	unresolved	4	98	5.3 MB	3	0	0	00:22:18
3	*.moscow.dial.rol.ru	2	21	1.2 MB	5	0	0	00:22:04
4	*.sovintel.net	7	0	0.0 KB	0	0	0	00:00:11
5	*.rol.kis.ru	4	0	0.0 KB	0	0	0	00:06:49
6	*.sarov.dial.rol.ru	4	0	0.0 KB	0	0	0	00:31:13
7	*.tony.pp.ru	74	0	0.0 KB	0	0	0	00:18:26
8	*.rol.ru	5766	0	0.0 KB	0	0	0	01:31:10

TOTAL: 8		5863	17906	682.1 MB	13	0	0	27:38:21

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	4.908	12.389	0.000	21:37:05
?	0.028	72.396	0.000	02:49:02
balancer-b.rol.ru	3.564	3.696	0.000	00:45:56
balancer-a.rol.ru	3.388	3.924	0.000	00:45:13
195.218.244.87	0.064	0.084	0.000	00:22:18
ts18-a181.moscow.dial.rol.ru	0.076	0.228	0.000	00:22:04
net1-x-ring.tony.pp.ru	60.824	59.372	0.000	00:18:26
ts2-a37.sarov.dial.rol.ru	0.004	0.004	0.000	00:10:10
ts2-a64.sarov.dial.rol.ru	0.000	0.000	0.000	00:10:00
ts2-a17.sarov.dial.rol.ru	0.004	0.000	0.000	00:10:00
rol73.rol.kis.ru	0.012	0.024	0.000	00:05:22
rol63.rol.kis.ru	0.016	0.012	0.000	00:01:26
ts2-a93.sarov.dial.rol.ru	0.008	0.000	0.000	00:01:01
fw-nat.sovintel.net	0.048	0.016	0.000	00:00:11
212.46.236.163	0.004	0.004	0.000	00:00:01
80.240.208.34	0.000	0.000	0.000	00:00:00
cornholio.migtel.ru	0.024	0.024	0.000	00:00:00
93-120-128-198.dynamic.mts-nn.ru	0.004	0.004	0.000	00:00:00
79-126-19-76.dynamic.mts-nn.ru	0.004	0.004	0.000	00:00:00
195.16.65.80.ip.morning.ru	0.000	0.004	0.000	00:00:00

TOTAL: 20	72.980	152.185	0.000	27:38:24

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2884
balancer-a.rol.ru	2882
net1-x-ring.tony.pp.ru	74
fw-nat.sovintel.net	7
rol63.rol.kis.ru	2
rol73.rol.kis.ru	2
ts2-a37.sarov.dial.rol.ru	1
ts2-a93.sarov.dial.rol.ru	1
ts2-a64.sarov.dial.rol.ru	1
ts2-a17.sarov.dial.rol.ru	1

TOTAL: 10	5855

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	22
212.46.236.163	3
93-120-128-198.dynamic.mts-nn.ru	1
80.240.208.34	1
79-126-19-76.dynamic.mts-nn.ru	1
195.16.65.80.ip.morning.ru	1

TOTAL: 6	29

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a37.sarov.dial.rol.ru	1	0
195.218.244.87	1	0
ts2-a64.sarov.dial.rol.ru	1	0
ts2-a17.sarov.dial.rol.ru	1	0

TOTAL: 4	4	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	14030	100.0%
2	aus	1	0.0%

TOTAL: 2		14031	100.0%

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

Newsgroup		Count

1	alt.binaries.erotica.breasts	9371
2	alt.binaries.pictures.redheads	2545
3	alt.bainaries.pictures.erotica.redheads	1996
4	alt.binaries.erotica.pornstars	98
5	alt.sex.erotica.teen	7
6	alt.binaries.erotica.pregnant	6
7	alt.binaries.pictures.eroctica.teen.fuck	4
8	alt.binaries.pictures.lolita	3
9	aus.sex.incest	1

TOTAL: 9		14031