Daily Usenet report

Sep 27 03:00:04 -- Sep 28 03:00:04

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 / 84 lines (6.0%)
Sep 27 05:10:28 perseus controlchan[16839]: Unknown "cmsg" control by Lendlice.bbs@bbs.wretch.cc
Sep 27 05:20:19 perseus controlchan[16839]: Unknown "cmsg" control by elina.bbs@bbs.wretch.cc
Sep 27 05:20:20 perseus controlchan[16839]: Unknown "cmsg" control by elina.bbs@bbs.wretch.cc
Sep 27 06:50:39 perseus controlchan[16839]: Unknown "cmsg" control by sweetpibo.bbs@bbs.wretch.cc
Sep 27 07:30:37 perseus controlchan[16839]: Unknown "cmsg" control by jamchin.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2566925	97.7%	230.3 MB	97.3%
innd	35377	1.3%	3.9 MB	1.6%
nnrpd	21536	0.8%	2.0 MB	0.9%
cnfsstat	2304	0.1%	397.7 KB	0.2%
controlchan	85	0.0%	8.9 KB	0.0%

TOTAL: 5	2626227	100.0%	236.7 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2408174	92.4%
Cache misses	120183	4.6%
Negative hits	47012	1.8%
Positive hits	32147	1.2%

TOTAL: 4	2607516	100.0%

INND timer:

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

article cancel	00:06:24.172	0.4%	159411	0.000	2.410	1560.000
article cleanup	00:00:26.559	0.0%	2392847	0.003	0.011	0.024
article logging	00:02:39.269	0.2%	2406998	0.003	0.066	5.387
article parse	00:18:21.690	1.3%	143566046	0.005	0.008	0.055
article write	10:48:23.310	45.0%	2362706	4.465	16.466	29.665
artlog/artcncl	00:00:06.772	0.0%	159269	0.000	0.043	2.624
artlog/artparse	00:00:00.000	0.0%	81	0.000	0.000	0.000
data move	00:03:26.674	0.2%	151970490	0.001	0.001	0.004
hisgrep/artcncl	00:03:24.219	0.2%	152635	0.000	1.338	1560.000
hishave/artcncl	00:02:50.598	0.2%	159411	0.000	1.070	9.658
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:17:50.262	1.2%	2449643	0.001	0.437	8.557
history sync	00:00:00.295	0.0%	290	0.000	1.017	2.000
history write	00:53:28.097	3.7%	2362706	0.024	1.358	12.820
hiswrite/artcncl	00:00:01.425	0.0%	6776	0.000	0.210	26.000
idle	05:27:54.653	22.8%	133173178	0.125	0.148	1.577
nntp read	00:19:46.833	1.4%	141715679	0.006	0.008	0.052
overview write	05:19:52.789	22.2%	2362706	1.811	8.123	95.635
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.001	0.0%	84	0.000	0.012	0.500

TOTAL: 23:59:44.924	23:44:57.618	99.0%	-	-	-	-

nnrpd timer:

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

hisgrep	00:30:27.260	2.3%	67139	0.000	27.216	62.844
idle	18:36:47.340	84.0%	244286	0.000	274.299	200814.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:42:17.456	3.2%	749215	0.000	3.387	14185.409
readart	00:40:08.482	3.0%	138099	0.000	17.440	409.000

TOTAL: 22:08:46.280	20:29:40.538	92.5%	-	-	-	-

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

gvoltagg@verizon.net	1	0	0	0	0	1

TOTAL	1	0	0	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	324	2381928	2352238	2	29688	98%	472:40:02

TOTAL: 1		324	2381928	2352238	2	29688	98%	472:40:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	389.3 GB	1.9 MB	389.3 GB	99%	171.4 KB	472:40:02

TOTAL: 1		389.3 GB	1.9 MB	389.3 GB	99%	171.4 KB	472:40:02

Incoming articles:

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

Sep 27 03:00:04 - 03:59:59	92902	3.9%	25.83	16.9 GB	4.3%	4937.52
Sep 27 04:00:00 - 04:59:59	86201	3.6%	23.94	16.5 GB	4.2%	4801.44
Sep 27 05:00:00 - 05:59:59	92557	3.9%	25.71	14.7 GB	3.8%	4277.25
Sep 27 06:00:00 - 06:59:59	103429	4.4%	28.73	13.7 GB	3.5%	4003.98
Sep 27 07:00:00 - 07:59:59	96875	4.1%	26.91	12.2 GB	3.1%	3554.77
Sep 27 08:00:00 - 08:59:59	105748	4.5%	29.37	14.6 GB	3.7%	4243.15
Sep 27 09:00:00 - 09:59:59	90047	3.8%	25.01	14.4 GB	3.7%	4182.35
Sep 27 10:00:00 - 10:59:59	81217	3.4%	22.56	16.3 GB	4.2%	4754.41
Sep 27 11:00:00 - 11:59:59	97375	4.1%	27.05	15.5 GB	4.0%	4516.49
Sep 27 12:00:00 - 12:59:59	121879	5.2%	33.86	11.8 GB	3.0%	3427.98
Sep 27 13:00:00 - 13:59:59	112178	4.7%	31.16	14.8 GB	3.8%	4323.58
Sep 27 14:00:00 - 14:59:59	118352	5.0%	32.88	15.5 GB	4.0%	4520.24
Sep 27 15:00:00 - 15:59:59	105079	4.4%	29.19	16.2 GB	4.2%	4729.15
Sep 27 16:00:00 - 16:59:59	95661	4.0%	26.57	18.0 GB	4.6%	5249.10
Sep 27 17:00:00 - 17:59:59	96487	4.1%	26.80	17.6 GB	4.5%	5124.12
Sep 27 18:00:00 - 18:59:59	97804	4.1%	27.17	18.4 GB	4.7%	5352.04
Sep 27 19:00:00 - 19:59:59	98566	4.2%	27.38	18.4 GB	4.7%	5370.57
Sep 27 20:00:00 - 20:59:59	97167	4.1%	26.99	18.0 GB	4.6%	5252.04
Sep 27 21:00:00 - 21:59:59	99823	4.2%	27.73	17.9 GB	4.6%	5203.84
Sep 27 22:00:00 - 22:59:59	99262	4.2%	27.57	18.4 GB	4.7%	5357.35
Sep 27 23:00:00 - 23:59:59	94704	4.0%	26.31	18.3 GB	4.7%	5315.84
Sep 28 00:00:00 - 00:59:59	87842	3.7%	24.40	16.1 GB	4.1%	4684.97
Sep 28 01:00:00 - 01:59:59	93911	4.0%	26.09	16.6 GB	4.3%	4823.93
Sep 28 02:00:00 - 02:59:59	98095	4.2%	27.25	18.6 GB	4.8%	5411.40
Sep 28 03:00:00 - 03:00:04	111	0.0%	27.75	22.0 MB	0.0%	5629.96

TOTAL: 24:00:00	2363272	100.0%	27.35	389.4 GB	100.0%	4725.76

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	27.0 GB	19.6%	86	756.91	2.21
02	BIN	137.8 GB	58.6 GB	42.5%	86	751.55	2.23
03	SMALL	13.0 GB	5.7 GB	43.4%	5	6.89	22.98
04	BIN	80.1 GB	75.9 GB	94.7%	54	394.57	2.46
05	BIN	80.1 GB	76.2 GB	95.1%	74	397.28	2.45
06	SMALL	13.0 GB	5.6 GB	43.2%	5	6.86	23.08
07	BIN	80.1 GB	68.8 GB	85.8%	54	393.32	2.47
08	BIN	80.1 GB	70.4 GB	87.9%	74	395.94	2.45
09	SMALL	13.0 GB	5.3 GB	41.0%	5	6.83	23.16
10	BIN	80.1 GB	63.5 GB	79.3%	54	392.24	2.48
11	BIN	80.1 GB	79.2 GB	98.9%	74	397.62	2.44
12	SMALL	13.0 GB	5.6 GB	42.8%	5	6.87	23.04
13	BIN	80.1 GB	62.5 GB	78.0%	54	392.49	2.48
14	BIN	80.1 GB	66.9 GB	83.5%	74	395.90	2.46

TOTAL: 14	-	968.5 GB	671.0 GB	69.3%	704	338.90	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	44290	30037	0	86	0	0	0	0	14167
2	?	81	0	0	0	0	0	0	0	81

TOTAL: 2		44371	30037	0	86	0	0	0	0	14248

Unwanted newsgroups [Top 20]:

Newsgroup	Count

.usa	1290
alt.binaries.hotrod	684
alt.binaries.	577
alt.binaries.pictures.amateur.butts	387
alt.binaries.amateur.gangbang	364
alt.binaries.pictures.erotica.asian.female	325
alt.binaries.dvd.gaycinema	321
alt.binaries.pictuers.erotica.female	201
alt.binaries.pictures.erotica.latinal	196
pedo.japanese.fetish.lolita	195
alt.binaries.multimedia.bisexual	190
alt.binaries.fetish	190
alt.binaries.pictures.erotica.highheels	182
alt.binaries.totally.fetish.photo	182
alt.binaries.jerry	181
alt.binaries.pictures.erotica.goo-shot	178
alt.binaries.pictures.erotica.nipples	176
alt.binaries.sound.mp3.rap-hiphop	171
ccu.bbs.talk.market	169
allt.sex.fetish	167

TOTAL: 1922	30037

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	14150
	TOTAL: 1	14150

TOTAL: 1		14150

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	18	67124	2.0 GB	54	0	0	10:25:31
2	ts3-b142.voronezh.dial.rol.ru	2	1229	3.5 MB	1	0	0	00:42:54
3	212.46.236.20	2	7	975.1 KB	11	0	0	00:35:49
4	ts1-b223.saratov.dial.rol.ru	1	6	15.4 KB	1	0	0	00:40:02
5	ts2-b122.syktyvkar.dial.rol.ru	10	4	1.1 MB	4	0	0	00:22:25
6	ts32-a94.moscow.dial.rol.ru	1	2	166.1 KB	1	0	0	00:03:37

TOTAL: 6		34	68372	2.0 GB	72	0	0	22:07:21

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	18	67124	2.0 GB	54	0	0	10:25:31
2	*.voronezh.dial.rol.ru	2	1229	3.5 MB	1	0	0	00:42:54
3	unresolved	60	7	975.1 KB	11	0	0	08:35:10
4	*.saratov.dial.rol.ru	1	6	15.4 KB	1	0	0	00:40:02
5	*.syktyvkar.dial.rol.ru	10	4	1.1 MB	4	0	0	00:22:25
6	*.moscow.dial.rol.ru	10	2	166.1 KB	1	0	0	00:03:48
7	*.omsk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:00
8	*.sovintel.net	12	0	0.0 KB	0	0	0	00:00:27
9	*.spb.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:01
10	*.tony.pp.ru	80	0	0.0 KB	0	0	0	00:38:12
11	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:20
12	*.rol.ru	5836	0	0.0 KB	0	0	0	00:21:41
13	*.nn.ru	129	0	0.0 KB	0	0	0	00:00:49
14	*.nsk.dial.rol.ru	78	0	0.0 KB	0	0	0	00:02:01
15	*.211.93.140.adsl-spb.net.rol.ru	1	0	0.0 KB	0	0	0	00:10:06

TOTAL: 15		6240	68372	2.0 GB	72	0	0	22:05:44

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	61.168	538.240	0.000	10:25:31
194.154.66.131	0.108	0.076	0.000	07:47:04
ts3-b142.voronezh.dial.rol.ru	0.108	0.192	0.000	00:42:54
ts1-b223.saratov.dial.rol.ru	0.028	0.072	0.000	00:40:02
net1-x-ring.tony.pp.ru	42.984	385.982	0.000	00:38:12
212.46.236.20	0.016	0.060	0.000	00:35:49
ts2-b122.syktyvkar.dial.rol.ru	0.024	0.084	0.000	00:22:25
balancer-b.rol.ru	3.916	3.624	0.000	00:11:26
balancer-a.rol.ru	3.828	3.780	0.000	00:10:15
194.186.71.137	0.008	0.004	0.000	00:10:15
81.211.93.140.adsl-spb.net.rol.ru	0.004	0.000	0.000	00:10:06
ts32-a94.moscow.dial.rol.ru	0.004	0.016	0.000	00:03:37
?	0.008	0.056	0.000	00:02:10
212.46.236.27	0.000	0.004	0.000	00:01:37
82.140.73.76	0.204	0.244	0.000	00:01:06
ts2-a99.nsk.dial.rol.ru	0.028	0.044	0.000	00:00:54
gray.nn.ru	0.192	0.264	0.000	00:00:49
fw-nat.sovintel.net	0.080	0.032	0.000	00:00:27
ts2-b169.nsk.dial.rol.ru	0.044	0.020	0.000	00:00:26
ts2-b163.nsk.dial.rol.ru	0.020	0.040	0.000	00:00:25

TOTAL: 33	113.248	933.310	0.000	22:07:21

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2922
balancer-a.rol.ru	2914
gray.nn.ru	129
net1-x-ring.tony.pp.ru	80
194.154.66.131	48
ts2-b163.nsk.dial.rol.ru	20
ts2-a99.nsk.dial.rol.ru	20
ts2-b169.nsk.dial.rol.ru	19
ts2-a239.nsk.dial.rol.ru	19
fw-nat.sovintel.net	12
ts23-b2.moscow.dial.rol.ru	6
212.46.236.27	6
ts23-b18.moscow.dial.rol.ru	3
194.186.71.137	2
212.46.202.56	2
ts2-a80.omsk.dial.rol.ru	1
news.lek.ru	1
ts5-b231.spb.dial.rol.ru	1
81.211.93.140.adsl-spb.net.rol.ru	1

TOTAL: 19	6206

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	228
82.140.73.76	138
ppp0-028.ciscom.ru	8
86.110.172.53	7
dap2.imm.uran.ru	1
195.28.36.242	1
ppp85-141-234-101.pppoe.mtu-net.ru	1

TOTAL: 7	384

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	41

TOTAL: 1	41

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-b122.syktyvkar.dial.rol.ru	3	0
ts3-b142.voronezh.dial.rol.ru	1	0
194.154.66.131	1	0
194.186.71.137	1	0
ts1-b223.saratov.dial.rol.ru	1	0
81.211.93.140.adsl-spb.net.rol.ru	1	0

TOTAL: 6	8	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	67137	98.2%
2	fido7	1235	1.8%

TOTAL: 2		68372	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	50697
2	alt.binaries.pictures.artpics	8222
3	alt.binaries.pictures.bras	8205
4	fido7.ru.military	1229
5	fido7.ru.linux	6
6	alt.binaries.nospam.female.bodyhair	4
7	alt.binaries.pictures.youth-and-beauty	3
8	alt.binaries.aoi	2
9	alt.binaries.pictures.kid	2
10	alt.binaries.erotica.pregnant	2

TOTAL: 10		68372