Daily Usenet report

Jul 10 03:00:09 -- Jul 11 03:00:04

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
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 / 85 lines (5.9%)
Jul 10 03:16:01 perseus expireover[26534]: OVDB: expiregroup: recounting alt.binaries.multimedia
Jul 10 03:27:34 perseus expireover[26534]: OVDB: expiregroup: recounting alt.fan.rush-limbaugh
Jul 10 03:37:05 perseus expireover[26534]: OVDB: expiregroup: recounting aus.politics
Jul 10 03:45:31 perseus expireover[26534]: OVDB: expiregroup: recounting misc.test
Jul 10 04:13:32 perseus expireover[26534]: OVDB: expiregroup: recounting talk.politics.misc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2134908	98.0%	188.4 MB	97.4%
nnrpd	24782	1.1%	2.5 MB	1.3%
innd	15294	0.7%	2.2 MB	1.1%
cnfsstat	2304	0.1%	399.4 KB	0.2%
expireover	85	0.0%	10.7 KB	0.0%

TOTAL: 5	2177373	100.0%	193.4 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2127349	97.7%
Negative hits	44838	2.1%
Cache misses	2115	0.1%
Positive hits	2082	0.1%

TOTAL: 4	2176384	100.0%

INND timer:

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

article cancel	00:01:27.028	0.1%	4768	0.000	18.253	1624.000
article cleanup	00:00:23.766	0.0%	2124306	0.000	0.011	0.021
article logging	00:02:00.786	0.1%	2129938	0.003	0.057	4.048
article parse	00:18:23.603	1.3%	157480791	0.005	0.007	0.017
article write	09:48:08.104	40.8%	2099788	3.481	16.806	406.515
artlog/artcncl	00:00:00.074	0.0%	4761	0.000	0.016	1.000
artlog/artparse	00:00:00.001	0.0%	33	0.000	0.030	1.000
data move	00:03:35.601	0.2%	166814062	0.001	0.001	0.002
hisgrep/artcncl	00:01:18.965	0.1%	3658	0.000	21.587	1624.000
hishave/artcncl	00:00:07.838	0.0%	4768	0.000	1.644	29.891
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:24:27.284	1.7%	2173272	0.000	0.675	10.844
history sync	00:00:00.290	0.0%	288	0.000	1.007	10.000
history write	00:54:45.097	3.8%	2099788	0.021	1.564	15.401
hiswrite/artcncl	00:00:00.043	0.0%	1110	0.000	0.039	3.000
idle	06:52:53.463	28.7%	147912643	0.128	0.167	0.960
nntp read	00:20:12.071	1.4%	155936316	0.006	0.008	0.016
overview write	04:53:23.192	20.4%	2099788	1.010	8.383	597.943
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%	0	0.000	0.000	0.000

TOTAL: 23:59:50.663	23:41:07.206	98.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:09:20.790	1.1%	16240	0.000	34.531	64.782
idle	12:53:18.853	91.0%	44321	0.000	1046.882	200683.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:30:52.090	3.6%	203222	0.000	9.114	1096.934
readart	00:14:15.544	1.7%	33926	0.000	25.218	731.500

TOTAL: 14:09:44.906	13:47:47.277	97.4%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	390	2128427	2104970	277	23180	98%	465:27:33

TOTAL: 1		390	2128427	2104970	277	23180	98%	465:27:33

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	394.2 GB	14.1 MB	394.2 GB	99%	194.2 KB	465:27:33

TOTAL: 1		394.2 GB	14.1 MB	394.2 GB	99%	194.2 KB	465:27:33

Incoming articles:

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

Jul 10 03:00:09 - 03:59:59	84993	4.0%	23.67	15.6 GB	4.0%	4558.14
Jul 10 04:00:00 - 04:59:59	87821	4.2%	24.39	17.2 GB	4.4%	5016.83
Jul 10 05:00:00 - 05:59:59	86439	4.1%	24.01	17.2 GB	4.4%	4998.51
Jul 10 06:00:00 - 06:59:59	83262	4.0%	23.13	16.3 GB	4.1%	4736.78
Jul 10 07:00:00 - 07:59:59	86900	4.1%	24.14	17.4 GB	4.4%	5071.67
Jul 10 08:00:00 - 08:59:59	77650	3.7%	21.57	15.5 GB	3.9%	4507.75
Jul 10 09:00:00 - 09:59:59	79035	3.8%	21.95	15.5 GB	3.9%	4509.29
Jul 10 10:00:00 - 10:59:59	88961	4.2%	24.71	17.5 GB	4.5%	5106.47
Jul 10 11:00:00 - 11:59:59	78045	3.7%	21.68	14.9 GB	3.8%	4346.45
Jul 10 12:00:00 - 12:59:59	75675	3.6%	21.02	14.2 GB	3.6%	4138.09
Jul 10 13:00:00 - 13:59:59	92747	4.4%	25.76	17.2 GB	4.4%	5019.46
Jul 10 14:00:00 - 14:59:59	92539	4.4%	25.71	17.9 GB	4.6%	5217.96
Jul 10 15:00:00 - 15:59:59	86555	4.1%	24.04	15.9 GB	4.1%	4637.45
Jul 10 16:00:00 - 16:59:59	85292	4.1%	23.69	15.6 GB	4.0%	4538.59
Jul 10 17:00:00 - 17:59:59	85883	4.1%	23.86	15.6 GB	4.0%	4541.92
Jul 10 18:00:00 - 18:59:59	83823	4.0%	23.28	15.5 GB	4.0%	4528.77
Jul 10 19:00:00 - 19:59:59	86808	4.1%	24.11	16.1 GB	4.1%	4702.25
Jul 10 20:00:00 - 20:59:59	89253	4.3%	24.79	16.5 GB	4.2%	4802.04
Jul 10 21:00:00 - 21:59:59	96076	4.6%	26.69	17.1 GB	4.3%	4970.42
Jul 10 22:00:00 - 22:59:59	99239	4.7%	27.57	17.5 GB	4.4%	5088.88
Jul 10 23:00:00 - 23:59:59	89755	4.3%	24.93	16.0 GB	4.1%	4670.35
Jul 11 00:00:00 - 00:59:59	92670	4.4%	25.74	16.0 GB	4.1%	4667.83
Jul 11 01:00:00 - 01:59:59	96276	4.6%	26.74	17.0 GB	4.3%	4951.02
Jul 11 02:00:00 - 02:59:59	94144	4.5%	26.15	17.3 GB	4.4%	5048.71
Jul 11 03:00:00 - 03:00:04	123	0.0%	30.75	22.6 MB	0.0%	5788.19

TOTAL: 23:59:55	2099964	100.0%	24.31	392.7 GB	100.0%	4765.72

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	76.8 GB	55.7%	47	766.06	2.18
02	BIN	137.8 GB	81.6 GB	59.2%	47	789.23	2.12
03	SMALL	13.0 GB	388.7 MB	2.9%	3	5.95	26.60
04	BIN	80.1 GB	53.0 GB	66.2%	21	398.50	2.44
05	BIN	80.1 GB	40.6 GB	50.7%	41	400.94	2.42
06	SMALL	13.0 GB	374.9 MB	2.8%	3	5.94	26.64
07	BIN	80.1 GB	52.3 GB	65.4%	21	397.53	2.45
08	BIN	80.1 GB	39.9 GB	49.8%	41	400.09	2.43
09	SMALL	13.0 GB	265.6 MB	2.0%	3	5.86	27.02
10	BIN	80.1 GB	51.9 GB	64.8%	21	397.01	2.45
11	BIN	80.1 GB	38.7 GB	48.4%	41	400.76	2.43
12	SMALL	13.0 GB	365.3 MB	2.7%	3	5.97	26.52
13	BIN	80.1 GB	52.7 GB	65.8%	21	397.27	2.45
14	BIN	80.1 GB	36.5 GB	45.6%	41	399.43	2.43

TOTAL: 14	-	968.5 GB	525.4 GB	54.2%	354	342.90	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	30151	24227	0	290	0	0	0	0	5634
2	?	33	0	0	0	0	0	0	0	33

TOTAL: 2		30184	24227	0	290	0	0	0	0	5667

Unwanted newsgroups [Top 20]:

Newsgroup	Count

free.binaries.drwho	1171
alt.binaries.pictures.young.and.yummy	940
alt.binaries.pictures.erotica.asian.female	798
alt.binaries.corus	794
alt.binaries.tun	538
alt.binaries.pictures.erotica.cartoons.reposts	285
alt.binaries.easeynews.pervert	262
rss.MoreOver-RetainSector	235
alt.prowling-for-gay-sex	180
php.qa	170
rss.MoreOver-ConsumerElectronics	159
cakewalk.coffeehouse	149
alt.binaries.playboy	148
alt.binaries.dvdnordic.org	148
rss.MoreOver-MovieBusiness	142
alt.binaries.pictures.erotica.bdsm	135
fa.haskell	135
macromedia.flash	132
corel.PaintShopPro_Photography	121
lada.commerce	120

TOTAL: 2165	24227

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	36
	TOTAL: 1	36
Including strange strings
	192.168.33.37	5634
	TOTAL: 1	5634

TOTAL: 2		5670

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	2	16240	613.4 MB	16	0	0	09:53:38
2	ts3-a149.nnovgorod.dial.rol.ru	1	66	126.9 KB	7	0	0	00:11:54
3	ts3-b199.voronezh.dial.rol.ru	1	12	688.2 KB	1	0	0	00:03:56
4	ts2-a54.voronezh.dial.rol.ru	4	10	159.8 KB	4	0	0	00:21:07
5	ts1-a78.krasnoyarsk.dial.rol.ru	6	4	90.2 KB	7	0	0	00:56:25
6	ts9-a34.moscow.dial.rol.ru	3	3	42.2 KB	9	0	0	00:11:22
7	ts3-a63.voronezh.dial.rol.ru	5	2	2.5 KB	8	0	0	00:02:56

TOTAL: 7		22	16337	614.5 MB	52	0	0	14:09:16

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	2	16240	613.4 MB	16	0	0	09:53:38
2	*.nnovgorod.dial.rol.ru	1	66	126.9 KB	7	0	0	00:11:54
3	*.voronezh.dial.rol.ru	10	24	850.6 KB	13	0	0	00:28:00
4	*.krasnoyarsk.dial.rol.ru	7	4	90.2 KB	7	0	0	01:02:15
5	*.moscow.dial.rol.ru	38	3	42.2 KB	9	0	0	00:24:06
6	*.ufa.dial.rol.ru	4	0	0.0 KB	0	0	0	00:10:03
7	*.omsk.dial.rol.ru	3	0	0.0 KB	0	0	0	00:00:02
8	*.sovintel.net	15	0	0.0 KB	0	0	0	00:00:17
9	*.mcb.ru	2	0	0.0 KB	0	0	0	00:10:11
10	*.spb.dial.rol.ru	4	0	0.0 KB	0	0	0	00:00:21
11	*.saratov.dial.rol.ru	2	0	0.0 KB	0	0	0	00:00:15
12	*.nsk.dial.rol.ru	20	0	0.0 KB	0	0	0	00:11:41
13	*.rol.kis.ru	10	0	0.0 KB	0	0	0	00:10:23
14	*.kis.ru	1	0	0.0 KB	0	0	0	00:00:03
15	*.tyumen.dial.rol.ru	3	0	0.0 KB	0	0	0	00:21:32
16	*.bytecity.ru	3	0	0.0 KB	0	0	0	00:00:03
17	unresolved	3	0	0.0 KB	0	0	0	00:27:17
18	*.tony.pp.ru	74	0	0.0 KB	0	0	0	00:06:31
19	*.211.124.120.adsl-spb.net.rol.ru	144	0	0.0 KB	0	0	0	00:03:56
20	*.khabarovsk.dial.rol.ru	7	0	0.0 KB	0	0	0	00:00:08
21	*.rol.ru	5808	0	0.0 KB	0	0	0	00:18:35
22	*.komi.com	1	0	0.0 KB	0	0	0	00:05:20

TOTAL: 22		6162	16337	614.5 MB	52	0	0	14:09:01

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	7.828	67.760	0.000	09:53:38
ts1-a78.krasnoyarsk.dial.rol.ru	0.032	0.072	0.000	00:56:25
ts1-a195.tyumen.dial.rol.ru	0.104	0.128	0.000	00:21:32
ts2-a54.voronezh.dial.rol.ru	0.008	0.008	0.000	00:21:07
194.186.71.137	0.008	0.000	0.000	00:17:16
ts3-a149.nnovgorod.dial.rol.ru	0.004	0.016	0.000	00:11:54
ts2-a111.nsk.dial.rol.ru	0.040	0.028	0.000	00:11:41
ts9-a108.moscow.dial.rol.ru	0.248	0.312	0.000	00:11:30
ts9-a34.moscow.dial.rol.ru	0.020	0.024	0.000	00:11:22
bsd.mcb.ru	0.004	0.008	0.000	00:10:11
rol72.rol.kis.ru	0.012	0.012	0.000	00:10:04
ts2-a47.ufa.dial.rol.ru	0.008	0.004	0.000	00:10:03
194.154.66.11	0.004	0.008	0.000	00:10:01
balancer-a.rol.ru	3.476	3.880	0.000	00:09:27
balancer-b.rol.ru	3.612	3.696	0.000	00:09:08
net1-x-ring.tony.pp.ru	0.128	0.120	0.000	00:06:31
ts2-a110.krasnoyarsk.dial.rol.ru	0.012	0.000	0.000	00:05:49
main.komi.com	0.088	0.044	0.000	00:05:20
ts3-b199.voronezh.dial.rol.ru	0.000	0.004	0.000	00:03:56
81.211.124.120.adsl-spb.net.rol.ru	0.356	0.524	0.000	00:03:56

TOTAL: 43	16.364	77.172	0.000	14:09:16

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2905
balancer-a.rol.ru	2903
81.211.124.120.adsl-spb.net.rol.ru	144
net1-x-ring.tony.pp.ru	74
ts2-a111.nsk.dial.rol.ru	20
ts9-a108.moscow.dial.rol.ru	17
fw-nat.sovintel.net	15
ts18-a188.moscow.dial.rol.ru	14
rol72.rol.kis.ru	7
ts2-a80.khabarovsk.dial.rol.ru	7
ts2-a47.ufa.dial.rol.ru	4
ts24-b215.moscow.dial.rol.ru	3
ts3-a145.omsk.dial.rol.ru	3
ts1-a195.tyumen.dial.rol.ru	3
news.bytecity.ru	3
194.186.71.137	2
ts12-a203.spb.dial.rol.ru	2
bsd.mcb.ru	2
ts12-b111.spb.dial.rol.ru	2
rol70.rol.kis.ru	2

TOTAL: 28	6140

NNRP no permission clients:

System	Conn

87.245.178.164	39
cornholio.migtel.ru	21
host-213-145-66-217.spbmts.ru	2
195.28.36.242	1
host-211-145-66-217.spbmts.ru	1
195.161.25.38	1
ip-217-24-122-2.parma.ru	1

TOTAL: 7	66

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	42

TOTAL: 1	42

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts1-a78.krasnoyarsk.dial.rol.ru	4	0
ts2-a47.ufa.dial.rol.ru	1	0
rol72.rol.kis.ru	1	0
194.186.71.137	1	0
ts2-a111.nsk.dial.rol.ru	1	0
ts2-a54.voronezh.dial.rol.ru	1	0
ts9-a34.moscow.dial.rol.ru	1	0
194.154.66.11	1	0
ts3-a149.nnovgorod.dial.rol.ru	1	0
bsd.mcb.ru	1	0
ts9-a108.moscow.dial.rol.ru	1	0

TOTAL: 11	14	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	15685	99.6%
2	fido7	66	0.4%

TOTAL: 2		15751	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.bras	4066
2	alt.binaries.pictures.aviation	2986
3	alt.binaries.pictures.anime	2462
4	alt.binaries.pictures.artpics	2338
5	alt.binaries.pictures.animals	1836
6	alt.binaries.pictures.bikini.central	1389
7	alt.binaries.pictures.art.pin-up	532
8	fido7.ru.cars.lada	55
9	alt.binaries.pictures.automobile	45
10	alt.christnet.sex.fetish.fat.furry	14
11	fido7.pvt.fidolook	10
12	alt.sex.fat	10
13	alt.bainaries.pictures.erotica.groupsex	2
14	alt.binaries.pictures.barefoot.children	2
15	alt.no-advertising.files.images.sex.preteens	1
16	alt.binaries.pictures.boys.spank	1
17	fido7.ru.cars.talks	1
18	alt.binaries.pictures.bisexuals	1

TOTAL: 18		15751