Daily Usenet report

Jul 7 03:00:05 -- Jul 8 03:00:03

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 gethostbyaddr failures
NNRP client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 5 / 265 lines (1.9%)
Jul 7 03:16:06 perseus expireover[14918]: OVDB: expiregroup: recounting alt.binaries.multimedia
Jul 7 03:22:33 perseus expireover[14918]: OVDB: expiregroup: recounting alt.binaries.pictures.erotica
Jul 7 03:24:33 perseus expireover[14918]: OVDB: expiregroup: recounting alt.conspiracy
Jul 7 03:27:35 perseus expireover[14918]: OVDB: expiregroup: recounting alt.fan.tolkien
Jul 7 03:28:20 perseus expireover[14918]: OVDB: expiregroup: recounting alt.gothic

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2152291	98.0%	189.3 MB	97.4%
nnrpd	25166	1.1%	2.5 MB	1.3%
innd	15332	0.7%	2.2 MB	1.1%
cnfsstat	2304	0.1%	400.4 KB	0.2%
expireover	260	0.0%	31.1 KB	0.0%
controlchan	12	0.0%	2.0 KB	0.0%

TOTAL: 6	2195365	100.0%	194.4 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2149729	97.7%
Negative hits	43680	2.0%
Cache misses	4170	0.2%
Positive hits	2294	0.1%

TOTAL: 4	2199873	100.0%

INND timer:

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

article cancel	00:01:06.939	0.1%	6385	0.000	10.484	1351.000
article cleanup	00:00:24.618	0.0%	2139948	0.000	0.012	0.022
article logging	00:02:01.710	0.1%	2146277	0.003	0.057	2.848
article parse	00:19:40.739	1.4%	170653935	0.005	0.007	0.019
article write	09:44:12.224	40.6%	2120163	3.601	16.533	1627.134
artlog/artcncl	00:00:02.179	0.0%	6360	0.000	0.343	383.333
artlog/artparse	00:00:00.001	0.0%	22	0.000	0.045	1.000
data move	00:03:52.745	0.3%	180444770	0.001	0.001	0.002
hisgrep/artcncl	00:00:54.803	0.1%	3691	0.000	14.848	1351.000
hishave/artcncl	00:00:02.736	0.0%	6385	0.000	0.429	200.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:25:11.957	1.7%	2194492	0.000	0.689	11.156
history sync	00:00:02.001	0.0%	290	0.000	6.900	1722.000
history write	00:55:23.980	3.8%	2120163	0.029	1.568	13.752
hiswrite/artcncl	00:00:04.594	0.0%	2694	0.000	1.705	54.312
idle	06:49:33.911	28.4%	160442468	0.127	0.153	5.254
nntp read	00:21:46.840	1.5%	168985635	0.006	0.008	0.016
overview write	04:54:41.454	20.5%	2120163	1.061	8.340	397.001
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%	7	0.000	0.000	0.000

TOTAL: 24:00:17.927	23:39:03.431	98.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:30:46.083	1.8%	29552	0.000	62.469	66.153
idle	26:26:29.764	91.2%	70359	0.000	1352.915	200157.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:04:53.160	3.7%	460686	0.000	8.451	6699.585
readart	00:26:18.958	1.5%	58329	0.000	27.070	734.000

TOTAL: 28:59:26.603	28:28:27.965	98.2%	-	-	-	-

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

defence@alt-comp-config.at	4	0	0	0	0	4
hamstermumke@xs4all.nl	0	1	0	0	0	1
sverige-control@news4all.se	1	0	1	0	0	2

TOTAL	5	1	1	0	0	7

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	369	2126414	2105087	513	20814	98%	483:00:15

TOTAL: 1		369	2126414	2105087	513	20814	98%	483:00:15

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	418.0 GB	16.1 MB	418.0 GB	99%	206.2 KB	483:00:15

TOTAL: 1		418.0 GB	16.1 MB	418.0 GB	99%	206.2 KB	483:00:15

Incoming articles:

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

Jul 7 03:00:05 - 03:59:59	83467	3.9%	23.22	16.4 GB	3.9%	4789.97
Jul 7 04:00:00 - 04:59:59	88974	4.2%	24.71	17.7 GB	4.2%	5160.54
Jul 7 05:00:00 - 05:59:59	86995	4.1%	24.17	17.7 GB	4.2%	5144.11
Jul 7 06:00:00 - 06:59:59	85089	4.0%	23.64	17.2 GB	4.1%	5019.46
Jul 7 07:00:00 - 07:59:59	86959	4.1%	24.16	17.9 GB	4.2%	5222.01
Jul 7 08:00:00 - 08:59:59	77662	3.7%	21.57	16.2 GB	3.8%	4713.63
Jul 7 09:00:00 - 09:59:59	78886	3.7%	21.91	16.3 GB	3.9%	4760.50
Jul 7 10:00:00 - 10:59:59	87726	4.1%	24.37	18.8 GB	4.5%	5483.77
Jul 7 11:00:00 - 11:59:59	78696	3.7%	21.86	15.9 GB	3.8%	4634.50
Jul 7 12:00:00 - 12:59:59	79885	3.8%	22.19	16.4 GB	3.9%	4765.74
Jul 7 13:00:00 - 13:59:59	90346	4.3%	25.10	18.4 GB	4.4%	5359.40
Jul 7 14:00:00 - 14:59:59	92353	4.4%	25.65	18.8 GB	4.5%	5481.69
Jul 7 15:00:00 - 15:59:59	91281	4.3%	25.36	17.9 GB	4.2%	5200.79
Jul 7 16:00:00 - 16:59:59	93779	4.4%	26.05	17.6 GB	4.2%	5127.98
Jul 7 17:00:00 - 17:59:59	89793	4.2%	24.94	17.0 GB	4.0%	4940.14
Jul 7 18:00:00 - 18:59:59	86834	4.1%	24.12	17.3 GB	4.1%	5041.26
Jul 7 19:00:00 - 19:59:59	89023	4.2%	24.73	17.0 GB	4.0%	4953.92
Jul 7 20:00:00 - 20:59:59	91360	4.3%	25.38	17.4 GB	4.1%	5072.60
Jul 7 21:00:00 - 21:59:59	90526	4.3%	25.15	17.6 GB	4.2%	5118.59
Jul 7 22:00:00 - 22:59:59	91908	4.3%	25.53	18.4 GB	4.4%	5370.20
Jul 7 23:00:00 - 23:59:59	96344	4.5%	26.76	18.9 GB	4.5%	5510.95
Jul 8 00:00:00 - 00:59:59	91483	4.3%	25.41	17.6 GB	4.2%	5134.21
Jul 8 01:00:00 - 01:59:59	91849	4.3%	25.51	18.1 GB	4.3%	5283.34
Jul 8 02:00:00 - 02:59:59	98482	4.6%	27.36	19.6 GB	4.6%	5701.02
Jul 8 03:00:00 - 03:00:03	98	0.0%	32.67	19.1 MB	0.0%	6510.13

TOTAL: 23:59:58	2119798	100.0%	24.54	422.2 GB	100.0%	5124.66

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	12.4 GB	9.0%	46	848.03	1.97
02	BIN	137.8 GB	16.0 GB	11.6%	46	850.51	1.97
03	SMALL	13.0 GB	11.7 GB	89.7%	2	3.40	46.52
04	BIN	80.1 GB	31.8 GB	39.8%	20	429.64	2.26
05	BIN	80.1 GB	18.8 GB	23.5%	40	431.96	2.25
06	SMALL	13.0 GB	11.7 GB	89.6%	2	3.38	46.84
07	BIN	80.1 GB	31.4 GB	39.2%	20	428.91	2.27
08	BIN	80.1 GB	18.3 GB	22.8%	40	430.69	2.26
09	SMALL	13.0 GB	11.6 GB	88.9%	2	3.36	47.15
10	BIN	80.1 GB	31.2 GB	38.9%	20	428.46	2.27
11	BIN	80.1 GB	16.8 GB	21.0%	40	431.92	2.25
12	SMALL	13.0 GB	11.7 GB	89.6%	2	3.40	46.51
13	BIN	80.1 GB	32.0 GB	40.0%	20	428.19	2.27
14	BIN	80.1 GB	15.0 GB	18.7%	40	430.62	2.26

TOTAL: 14	-	968.5 GB	270.3 GB	27.9%	340	369.23	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	26112	17517	0	2264	0	0	0	0	6331
2	?	22	0	0	0	0	0	0	0	22

TOTAL: 2		26134	17517	0	2264	0	0	0	0	6353

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pictures.erotica.asian.female	1404
alt.binaries.dvd.gaycinema	1194
alt.binaries.warez.ibm-pc.game.german	258
alt.binaries.atuworld	173
alt.binaries.playboy	170
rss.MoreOver-JobMarketNews	152
alt.prowling-for-gay-sex	150
a.b.bloaf	144
rss.MoreOver-RetainSector	128
alt.binaries.artistic.russian.youth	123
stu.virus	107
a.b.misc	107
alt.binaries.pictures.fetish.urine	101
oecher.talk	98
corel.PaintShopPro_Photography	93
rss.MoreOver-ConsumerElectronics	89
alt.binaries.pictures.black.erotica.females	89
hfx.forsale	88
a.b.warez.pocketpc.movies	86
php.qa	82

TOTAL: 2045	17517

INND misc events:

Events	Count

CCreader	1

TOTAL: 1	1

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	18
	TOTAL: 1	18
Including strange strings
	192.168.33.37	6331
	TOTAL: 1	6331

TOTAL: 2		6349

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	3	28532	1.4 GB	24	0	0	10:32:19
2	erato.sovam.com	2	61	869.5 KB	2	0	0	00:01:25
3	ts18-a87.moscow.dial.rol.ru	8	42	100.4 KB	1	0	0	00:11:10
4	ts24-b146.moscow.dial.rol.ru	5	20	1.6 MB	25	0	0	00:39:29
5	ts2-a55.voronezh.dial.rol.ru	4	6	36.4 KB	5	0	0	00:06:13
6	ts27-b169.moscow.dial.rol.ru	2	2	274.2 KB	3	0	0	00:40:46
7	rol18.rol.kis.ru	1	1	2.9 KB	3	0	0	00:00:14

TOTAL: 7		25	28664	1.4 GB	63	0	0	31:57:32

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	5	28593	1.4 GB	26	0	0	10:33:45
2	*.moscow.dial.rol.ru	77	64	2.0 MB	29	0	0	01:34:37
3	*.voronezh.dial.rol.ru	7	6	36.4 KB	5	0	0	00:08:51
4	*.rol.kis.ru	1	1	2.9 KB	3	0	0	00:00:14
5	*.ufa.dial.rol.ru	1	0	0.0 KB	0	0	0	00:08:22
6	*.bytecity.ru	2	0	0.0 KB	0	0	0	00:00:02
7	*.krasnoyarsk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:03:39
8	*.omsk.dial.rol.ru	2	0	0.0 KB	0	0	0	00:10:01
9	*.sovintel.net	14	0	0.0 KB	0	0	0	00:00:17
10	unresolved	86	0	0.0 KB	0	0	0	18:41:23
11	*.spb.dial.rol.ru	3	0	0.0 KB	0	0	0	00:00:06
12	*.tony.pp.ru	65	0	0.0 KB	0	0	0	00:01:13
13	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:03
14	*.syktyvkar.dial.rol.ru	5	0	0.0 KB	0	0	0	00:00:14
15	*.211.124.120.adsl-spb.net.rol.ru	149	0	0.0 KB	0	0	0	00:04:43
16	*.saratov.dial.rol.ru	2	0	0.0 KB	0	0	0	00:07:28
17	*.khabarovsk.dial.rol.ru	13	0	0.0 KB	0	0	0	00:00:17
18	*.pcs-net.net	1	0	0.0 KB	0	0	0	00:00:01
19	*.rol.ru	5812	0	0.0 KB	0	0	0	00:18:34
20	*.nsk.dial.rol.ru	19	0	0.0 KB	0	0	0	00:00:42

TOTAL: 20		6266	28664	1.4 GB	63	0	0	31:57:27

NNRP total resource statistics [Top 20]:

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

194.154.66.78	0.140	0.240	0.000	18:39:01
keyhole.sovam.com	13.212	104.598	0.000	10:32:19
ts27-b169.moscow.dial.rol.ru	0.112	0.092	0.000	00:40:46
ts24-b146.moscow.dial.rol.ru	0.048	0.032	0.000	00:39:29
ts18-a87.moscow.dial.rol.ru	0.032	0.020	0.000	00:11:10
ts3-a180.omsk.dial.rol.ru	0.004	0.004	0.000	00:10:01
balancer-a.rol.ru	3.612	3.596	0.000	00:09:33
balancer-b.rol.ru	3.716	3.700	0.000	00:09:01
ts2-a89.ufa.dial.rol.ru	0.032	0.036	0.000	00:08:22
ts1-b216.saratov.dial.rol.ru	0.004	0.000	0.000	00:07:18
ts2-a55.voronezh.dial.rol.ru	0.020	0.032	0.000	00:06:13
81.211.124.120.adsl-spb.net.rol.ru	0.464	0.488	0.000	00:04:43
ts1-b177.krasnoyarsk.dial.rol.ru	0.056	0.040	0.000	00:03:39
?	0.036	0.052	0.000	00:02:44
ts2-a89.voronezh.dial.rol.ru	0.016	0.004	0.000	00:02:37
213.142.193.69	0.020	0.024	0.000	00:02:21
ts9-a181.moscow.dial.rol.ru	0.228	0.360	0.000	00:02:10
erato.sovam.com	0.000	0.008	0.000	00:01:25
net1-x-ring.tony.pp.ru	0.080	0.128	0.000	00:01:13
ts2-a192.nsk.dial.rol.ru	0.004	0.032	0.000	00:00:42

TOTAL: 42	22.204	113.742	0.000	31:57:32

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2906
balancer-a.rol.ru	2906
81.211.124.120.adsl-spb.net.rol.ru	149
194.154.66.78	71
net1-x-ring.tony.pp.ru	65
ts9-a181.moscow.dial.rol.ru	28
ts2-a192.nsk.dial.rol.ru	19
213.142.193.69	15
fw-nat.sovintel.net	14
ts9-b64.moscow.dial.rol.ru	9
ts2-a82.khabarovsk.dial.rol.ru	7
ts16-a24.moscow.dial.rol.ru	6
ts2-a84.khabarovsk.dial.rol.ru	6
ts18-a135.moscow.dial.rol.ru	6
ts24-a146.moscow.dial.rol.ru	5
ts2-b235.syktyvkar.dial.rol.ru	5
ts16-a205.moscow.dial.rol.ru	5
ts12-a30.spb.dial.rol.ru	3
ts23-b226.moscow.dial.rol.ru	3
ts2-a89.voronezh.dial.rol.ru	3

TOTAL: 28	6241

NNRP no permission clients:

System	Conn

87.245.178.164	25
mx.spice.ru	3
217.118.92.34	1
195.28.36.242	1
81.200.217.110	1
host2-50.radionet.com.ua	1

TOTAL: 6	32

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	49

TOTAL: 1	49

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.78	70	0
ts18-a87.moscow.dial.rol.ru	1	0
ts3-a180.omsk.dial.rol.ru	1	0

TOTAL: 3	72	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	25768	99.8%
2	fido7	43	0.2%
3	ab	6	0.0%

TOTAL: 3		25817	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.bikini.central	7065
2	alt.binaries.pictures.bras	4800
3	alt.binaries.pictures.anime	4514
4	alt.binaries.pictures.animals	2970
5	alt.binaries.pictures.aviation	2922
6	alt.binaries.pictures.artpics	2789
7	alt.binaries.pictures.art.pin-up	400
8	alt.binaries.pictures.automobile	225
9	alt.binaries.pictures.erotica.older-women	61
10	fido7.ru.physics	42
11	alt.binaries.pictures.erotica.mclt	9
12	alt.binaries.pictures.youth-and-beauty	7
13	ab.general	6
14	alt.binaries.aoi	5
15	fido7.su.pol.news	1
16	alt.binaries.models.petite	1

TOTAL: 16		25817