Daily Usenet report

Jan 4 03:00:02 -- Jan 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 / 27 lines (18.5%)
Jan 4 04:50:46 perseus controlchan[24499]: Unknown "cmsg" control by v62585.bbs@bbs.wretch.cc
Jan 4 05:50:50 perseus controlchan[24499]: Unknown "cmsg" control by oxidea2.bbs@bbs.wretch.cc
Jan 4 05:50:53 perseus controlchan[24499]: Unknown "cmsg" control by maxell.bbs@bbs.wretch.cc
Jan 4 08:30:48 perseus controlchan[24499]: Unknown "cmsg" control by foro.bbs@bbs.wretch.cc
Jan 4 09:09:31 perseus controlchan[24499]: Unknown "cmsg" control by Gen.bbs@bbs.cis.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	978717	96.5%	88.0 MB	95.7%
nnrpd	21538	2.1%	2.1 MB	2.3%
innd	11121	1.1%	1.5 MB	1.6%
cnfsstat	2304	0.2%	399.3 KB	0.4%
controlchan	30	0.0%	3.8 KB	0.0%

TOTAL: 5	1013710	100.0%	91.9 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	949298	95.7%
Negative hits	39172	3.9%
Positive hits	2759	0.3%
Cache misses	1219	0.1%

TOTAL: 4	992448	100.0%

INND timer:

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

article cancel	00:00:35.067	0.0%	9605	0.000	3.651	812.500
article cleanup	00:00:09.789	0.0%	945288	0.000	0.010	0.039
article logging	00:01:47.376	0.1%	970663	0.000	0.111	13.284
article parse	00:05:33.073	0.4%	57133694	0.001	0.006	0.042
article write	02:24:38.853	10.0%	893005	0.249	9.719	54.141
artlog/artcncl	00:00:03.871	0.0%	9328	0.000	0.415	38.082
artlog/artparse	00:00:00.000	0.0%	13	0.000	0.000	0.000
data move	00:01:12.429	0.1%	60764477	0.000	0.001	0.005
hisgrep/artcncl	00:00:16.779	0.0%	3924	0.000	4.276	812.500
hishave/artcncl	00:00:04.846	0.0%	9605	0.000	0.505	15.636
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:16:38.370	1.2%	984559	0.000	1.014	25.281
history sync	00:00:00.363	0.0%	329	0.000	1.103	11.000
history write	00:50:02.832	3.5%	893005	0.016	3.363	35.988
hiswrite/artcncl	00:00:09.506	0.0%	5681	0.000	1.673	96.000
idle	17:40:45.415	73.6%	54952711	0.126	1.158	32.136
nntp read	00:06:17.150	0.4%	56810882	0.001	0.007	0.035
overview write	02:25:08.084	10.1%	893005	0.925	9.751	165.158
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%	28	0.000	0.000	0.000

TOTAL: 24:00:22.686	23:53:23.803	99.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:19:38.511	0.8%	191735	0.000	6.147	46.671
idle	34:06:18.185	87.8%	392814	0.000	312.561	202186.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:55:52.875	5.0%	1464390	0.000	4.748	6627.833
readart	00:41:34.307	1.8%	391378	0.000	6.373	202.500

TOTAL: 38:51:09.334	37:03:23.878	95.4%	-	-	-	-

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
deadletter@box.com	1	0	0	0	0	1
hamstermumke@xs4all.nl	0	1	0	0	0	1

TOTAL	1	1	1	0	0	3

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	657	1059978	1002472	1	57505	94%	489:52:54

TOTAL: 1		657	1059978	1002472	1	57505	94%	489:52:54

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	125.3 GB	945.3 KB	125.3 GB	99%	124.0 KB	489:52:54

TOTAL: 1		125.3 GB	945.3 KB	125.3 GB	99%	124.0 KB	489:52:54

Incoming articles:

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

Jan 4 03:00:02 - 03:59:59	91659	10.3%	25.47	16.9 GB	14.6%	4931.34
Jan 4 04:00:00 - 04:59:59	80209	9.0%	22.28	14.3 GB	12.3%	4150.98
Jan 4 05:00:00 - 05:59:59	82424	9.2%	22.90	15.3 GB	13.2%	4451.52
Jan 4 06:00:00 - 06:59:59	76225	8.5%	21.17	14.2 GB	12.3%	4141.05
Jan 4 07:00:00 - 07:59:59	48538	5.4%	13.48	8.9 GB	7.7%	2600.90
Jan 4 08:00:00 - 08:59:59	39449	4.4%	10.96	6.2 GB	5.3%	1797.00
Jan 4 09:00:00 - 09:59:59	23754	2.7%	6.60	3.5 GB	3.0%	1027.01
Jan 4 10:00:00 - 10:59:59	28458	3.2%	7.91	4.3 GB	3.7%	1262.08
Jan 4 11:00:00 - 11:59:59	25621	2.9%	7.12	2.8 GB	2.4%	802.28
Jan 4 12:00:00 - 12:59:59	22920	2.6%	6.37	2.7 GB	2.4%	799.36
Jan 4 13:00:00 - 13:59:59	24180	2.7%	6.72	2.5 GB	2.2%	725.50
Jan 4 14:00:00 - 14:59:59	19963	2.2%	5.55	1.2 GB	1.0%	350.51
Jan 4 15:00:00 - 15:59:59	24909	2.8%	6.92	2.4 GB	2.0%	687.39
Jan 4 16:00:00 - 16:59:59	28536	3.2%	7.93	2.1 GB	1.8%	600.10
Jan 4 17:00:00 - 17:59:59	27066	3.0%	7.52	2.1 GB	1.8%	618.62
Jan 4 18:00:00 - 18:59:59	27893	3.1%	7.75	2.1 GB	1.8%	611.30
Jan 4 19:00:00 - 19:59:59	28369	3.2%	7.88	1.7 GB	1.5%	508.19
Jan 4 20:00:00 - 20:59:59	27116	3.0%	7.53	2.1 GB	1.8%	603.60
Jan 4 21:00:00 - 21:59:59	25215	2.8%	7.00	1.8 GB	1.6%	536.10
Jan 4 22:00:00 - 22:59:59	23427	2.6%	6.51	1.8 GB	1.6%	527.91
Jan 4 23:00:00 - 23:59:59	28347	3.2%	7.87	2.0 GB	1.7%	573.54
Jan 5 00:00:00 - 00:59:59	26931	3.0%	7.48	1.3 GB	1.1%	373.55
Jan 5 01:00:00 - 01:59:59	28902	3.2%	8.03	1.8 GB	1.6%	531.20
Jan 5 02:00:00 - 02:59:59	31622	3.5%	8.78	1.7 GB	1.5%	506.13
Jan 5 03:00:00 - 03:00:02	14	0.0%	7.00	380.1 KB	0.0%	190.05

TOTAL: 24:00:00	891747	100.0%	10.32	115.7 GB	100.0%	1404.77

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	63.0 GB	45.7%	133	228.05	7.33
02	BIN	137.8 GB	129.7 GB	94.1%	133	226.97	7.37
03	SMALL	13.0 GB	6.2 GB	47.4%	9	7.44	21.28
04	BIN	80.1 GB	53.0 GB	66.2%	95	116.01	8.38
05	BIN	80.1 GB	70.0 GB	87.5%	115	115.76	8.40
06	SMALL	13.0 GB	6.2 GB	47.3%	9	7.47	21.19
07	BIN	80.1 GB	38.3 GB	47.9%	95	115.35	8.43
08	BIN	80.1 GB	56.3 GB	70.3%	115	115.55	8.41
09	SMALL	13.0 GB	5.5 GB	42.0%	9	7.48	21.16
10	BIN	80.1 GB	26.9 GB	33.6%	95	115.01	8.45
11	BIN	80.1 GB	79.2 GB	98.9%	115	115.95	8.38
12	SMALL	13.0 GB	6.0 GB	46.0%	9	7.47	21.18
13	BIN	80.1 GB	24.0 GB	30.0%	95	115.84	8.39
14	BIN	80.1 GB	53.3 GB	66.6%	115	115.69	8.40

TOTAL: 14	-	968.5 GB	617.8 GB	63.8%	1142	101.03	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	77630	51734	0	54	0	0	0	0	25842
2	?	12	0	0	0	0	0	0	0	12

TOTAL: 2		77642	51734	0	54	0	0	0	0	25854

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.jerry	2785
microsoft.public.test	1411
alt.binaries.pictures.amateur.butts	1362
alt.binaires.erotica.amateur	833
alt.binaries.pictures.erotica.highheels	456
alt.binaries.pictures.erotica.homosexual	390
alt.binaries.pictures.erotica.goo-shot	383
alt.binaries.pictures.erotica.voyeuris	382
alt.biniaries.erotica	375
alt.binaries.pictures.erotica.nipples	366
alt.binaries.pictures.erotica.gay	360
nthu.club.wenfu	348
alt.binaries.pictures.erotica.latinal	343
alt.binaries.erotica.toys	342
alt.binaries.pictures.erotica.amateur.digicam	327
alt.binaries.pictures.erotica.latinos	289
alt.bianries.amateur.female	289
alt.binaries.pictures.erotica.flashers	288
alt.binaries.pictures.erotica.foot-fetish	287
alt.binaries.pictures.erotica.latine	286

TOTAL: 2224	51734

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	25362
	TOTAL: 1	25362

TOTAL: 1		25362

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	44	191735	4.0 GB	132	0	0	23:54:46
2	news.pcs-net.net	27	1209	231.7 MB	202	0	0	12:48:46
3	ts18-a140.moscow.dial.rol.ru	7	11	1.1 MB	16	0	0	00:14:16
4	ts18-a219.moscow.dial.rol.ru	2	3	152.0 KB	1	0	0	00:28:00

TOTAL: 4		80	192958	4.2 GB	351	0	2	38:50:57

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	44	191735	4.0 GB	132	0	0	23:54:46
2	*.pcs-net.net	27	1209	231.7 MB	202	0	0	12:48:46
3	*.moscow.dial.rol.ru	12	14	1.3 MB	17	0	0	00:52:19
4	*.ufa.dial.rol.ru	1	0	0.0 KB	0	0	0	00:02:02
5	*.angarsk.dial.rol.ru	3	0	0.0 KB	0	0	0	00:35:29
6	*.sovintel.net	27	0	0.0 KB	0	0	0	00:00:27
7	*.nnovgorod.dial.rol.ru	10	0	0.0 KB	0	0	0	00:02:41
8	*.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00
9	*.nsk.dial.rol.ru	26	0	0.0 KB	0	0	0	00:00:17
10	*.sarov.dial.rol.ru	2	0	0.0 KB	0	0	0	00:10:24
11	unresolved	4	0	0.0 KB	0	0	0	00:00:04
12	*.tony.pp.ru	144	0	0.0 KB	0	0	0	00:05:23
13	*.rol.ru	5768	0	0.0 KB	0	0	0	00:17:28
14	*.nn.ru	15	0	0.0 KB	0	0	0	00:00:03

TOTAL: 14		6084	192958	4.2 GB	351	0	1	38:50:39

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	122.264	1224.832	0.000	23:54:46
news.pcs-net.net	0.280	1.316	0.000	12:48:46
ts2-a190.angarsk.dial.rol.ru	0.132	0.112	0.000	00:35:29
ts18-a219.moscow.dial.rol.ru	0.012	0.012	0.000	00:28:00
ts18-a140.moscow.dial.rol.ru	0.032	0.100	0.000	00:14:16
ts2-a99.sarov.dial.rol.ru	0.020	0.004	0.000	00:10:24
ts16-a157.moscow.dial.rol.ru	0.008	0.004	0.000	00:10:01
balancer-b.rol.ru	3.604	3.316	0.000	00:09:14
balancer-a.rol.ru	3.468	3.420	0.000	00:08:14
net1-x-ring.tony.pp.ru	0.204	0.240	0.000	00:05:23
ts4-a11.nnovgorod.dial.rol.ru	0.024	0.016	0.000	00:02:41
ts2-a246.ufa.dial.rol.ru	0.028	0.040	0.000	00:02:02
fw-nat.sovintel.net	0.248	0.100	0.000	00:00:27
?	0.000	0.004	0.000	00:00:23
ts2-a150.nsk.dial.rol.ru	0.052	0.064	0.000	00:00:17
ts9-b7.moscow.dial.rol.ru	0.016	0.008	0.000	00:00:11
212.46.203.123	0.004	0.004	0.000	00:00:04
cornholio.migtel.ru	0.428	0.484	0.000	00:00:04
delta.nn.ru	0.008	0.024	0.000	00:00:03
h11.242.159.dialup.iptcom.net	0.012	0.032	0.000	00:00:00

TOTAL: 29	130.900	1234.180	0.000	38:50:57

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2885
balancer-a.rol.ru	2883
net1-x-ring.tony.pp.ru	144
fw-nat.sovintel.net	27
ts2-a150.nsk.dial.rol.ru	26
delta.nn.ru	14
ts4-a11.nnovgorod.dial.rol.ru	10
212.46.203.123	4
ts2-a190.angarsk.dial.rol.ru	3
ts16-a157.moscow.dial.rol.ru	3
ts2-a99.sarov.dial.rol.ru	2
gray.nn.ru	1
ts9-b7.moscow.dial.rol.ru	1
ts2-a246.ufa.dial.rol.ru	1
ns1.lavtech.ru	1

TOTAL: 15	6005

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	337
p5400-03.54.40.189.90.credit.sable.dial.krasnet.ru	20
h11.242.159.dialup.iptcom.net	18
ts9-b7.moscow.dial.rol.ru	9
dialup-151.136.ranetka.ru	7
85.15.72.74	4
90.188.228.73	3
217.118.92.35	2
79-126-45-85.dynamic.mts-nn.ru	1
217.118.92.45	1

TOTAL: 10	402

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	4

TOTAL: 1	4

NNRP client timeouts [Top 20]:

System	Conn	Peer

news.pcs-net.net	13	0
ts18-a219.moscow.dial.rol.ru	2	0
ts2-a190.angarsk.dial.rol.ru	2	0
ts16-a157.moscow.dial.rol.ru	1	0
ts2-a99.sarov.dial.rol.ru	1	0

TOTAL: 5	19	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	193982	100.0%

TOTAL: 1		193982	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	117114
2	alt.binaries.pictures.bras	46264
3	alt.binaries.pictures.artpics	29381
4	alt.binaries.pictures.vladmodels	843
5	alt.binaries.pictures.sandra	305
6	alt.binaries.pictures.webeweb	48
7	alt.binaries.pictures.wals	13
8	alt.binaries.southern-charms.pictures	11
9	alt.binaries.erotica.pregnant	3

TOTAL: 9		193982