Daily Usenet report

Jul 7 03:00:02 -- Jul 8 03:00:06

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 / 244 lines (2.0%)
Jul 7 03:15:53 andromeda expireover[27835]: OVDB: expiregroup: recounting alt.binaries.multimedia
Jul 7 03:21:27 andromeda expireover[27835]: OVDB: expiregroup: recounting alt.binaries.pictures.erotica
Jul 7 03:26:26 andromeda expireover[27835]: OVDB: expiregroup: recounting alt.fan.tolkien
Jul 7 03:38:21 andromeda expireover[27835]: OVDB: expiregroup: recounting comp.lang.idl
Jul 7 03:38:36 andromeda expireover[27835]: OVDB: expiregroup: recounting comp.lang.prolog

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2184490	98.1%	192.1 MB	97.4%
nnrpd	24686	1.1%	2.6 MB	1.3%
innd	15733	0.7%	2.2 MB	1.1%
cnfsstat	2288	0.1%	397.2 KB	0.2%
expireover	239	0.0%	29.4 KB	0.0%
controlchan	12	0.0%	2.0 KB	0.0%

TOTAL: 6	2227448	100.0%	197.3 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2175854	97.8%
Negative hits	42247	1.9%
Cache misses	4155	0.2%
Positive hits	2430	0.1%

TOTAL: 4	2224686	100.0%

INND timer:

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

article cancel	00:01:29.797	0.1%	6384	0.000	14.066	1652.000
article cleanup	00:00:35.125	0.0%	2170930	0.005	0.016	0.028
article logging	00:02:37.474	0.2%	2177300	0.007	0.072	3.761
article parse	00:23:32.756	1.6%	181293594	0.006	0.008	0.023
article write	09:05:00.678	37.9%	2150930	4.143	15.203	27.761
artlog/artcncl	00:00:01.090	0.0%	6359	0.000	0.171	8.118
artlog/artparse	00:00:00.002	0.0%	22	0.000	0.091	1.000
data move	00:06:26.204	0.4%	191747256	0.002	0.002	0.004
hisgrep/artcncl	00:01:22.667	0.1%	3684	0.000	22.439	1652.000
hishave/artcncl	00:00:01.469	0.0%	6384	0.000	0.230	31.240
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:21:20.011	1.5%	2219713	0.000	0.577	8.520
history sync	00:00:00.289	0.0%	290	0.000	0.997	3.000
history write	00:51:32.062	3.6%	2150930	0.036	1.438	12.467
hiswrite/artcncl	00:00:04.473	0.0%	2700	0.000	1.657	7.500
idle	07:40:15.294	32.0%	171149740	0.121	0.161	0.597
nntp read	00:26:44.606	1.9%	179807135	0.007	0.009	0.021
overview write	04:21:21.994	18.2%	2150930	1.272	7.291	1149.032
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: 23:59:38.260	23:22:25.991	97.4%	-	-	-	-

nnrpd timer:

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

hisgrep	00:08:42.704	0.5%	28250	0.000	18.503	392.500
idle	28:52:41.789	93.7%	67769	0.000	1534.061	201421.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:02:33.945	3.4%	487081	0.000	7.707	6514.552
readart	00:16:41.037	0.9%	57018	0.000	17.557	223.750

TOTAL: 30:49:42.388	30:20:39.475	98.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

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	438	2164491	2143137	666	20688	99%	483:52:31

TOTAL: 1		438	2164491	2143137	666	20688	99%	483:52:31

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	426.9 GB	16.3 MB	427.0 GB	99%	206.9 KB	483:52:31

TOTAL: 1		426.9 GB	16.3 MB	427.0 GB	99%	206.9 KB	483:52:31

Incoming articles:

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

Jul 7 03:00:02 - 03:59:59	87770	4.1%	24.39	17.3 GB	4.0%	5051.36
Jul 7 04:00:00 - 04:59:59	90135	4.2%	25.04	18.0 GB	4.2%	5240.32
Jul 7 05:00:00 - 05:59:59	90678	4.2%	25.19	18.4 GB	4.3%	5368.55
Jul 7 06:00:00 - 06:59:59	89604	4.2%	24.89	18.2 GB	4.3%	5314.80
Jul 7 07:00:00 - 07:59:59	91311	4.2%	25.36	18.9 GB	4.4%	5503.96
Jul 7 08:00:00 - 08:59:59	67602	3.1%	18.78	13.9 GB	3.2%	4049.95
Jul 7 09:00:00 - 09:59:59	84468	3.9%	23.46	17.6 GB	4.1%	5129.33
Jul 7 10:00:00 - 10:59:59	89724	4.2%	24.92	19.3 GB	4.5%	5616.28
Jul 7 11:00:00 - 11:59:59	83263	3.9%	23.13	16.9 GB	3.9%	4937.04
Jul 7 12:00:00 - 12:59:59	92802	4.3%	25.78	19.3 GB	4.5%	5615.02
Jul 7 13:00:00 - 13:59:59	94828	4.4%	26.34	19.4 GB	4.5%	5656.00
Jul 7 14:00:00 - 14:59:59	86699	4.0%	24.08	17.6 GB	4.1%	5111.93
Jul 7 15:00:00 - 15:59:59	91246	4.2%	25.35	17.8 GB	4.2%	5198.63
Jul 7 16:00:00 - 16:59:59	93871	4.4%	26.08	17.6 GB	4.1%	5133.66
Jul 7 17:00:00 - 17:59:59	89743	4.2%	24.93	16.9 GB	3.9%	4936.83
Jul 7 18:00:00 - 18:59:59	86854	4.0%	24.13	17.3 GB	4.0%	5042.30
Jul 7 19:00:00 - 19:59:59	88957	4.1%	24.71	17.0 GB	4.0%	4949.85
Jul 7 20:00:00 - 20:59:59	91467	4.3%	25.41	17.4 GB	4.1%	5079.40
Jul 7 21:00:00 - 21:59:59	90498	4.2%	25.14	17.6 GB	4.1%	5116.87
Jul 7 22:00:00 - 22:59:59	91917	4.3%	25.53	18.4 GB	4.3%	5370.44
Jul 7 23:00:00 - 23:59:59	96494	4.5%	26.80	19.0 GB	4.4%	5519.81
Jul 8 00:00:00 - 00:59:59	91329	4.2%	25.37	17.6 GB	4.1%	5125.30
Jul 8 01:00:00 - 01:59:59	92010	4.3%	25.56	18.2 GB	4.2%	5294.39
Jul 8 02:00:00 - 02:59:59	98269	4.6%	27.30	19.5 GB	4.5%	5686.69
Jul 8 03:00:00 - 03:00:06	190	0.0%	31.67	29.0 MB	0.0%	4946.66

TOTAL: 24:00:04	2151729	100.0%	24.90	429.3 GB	100.0%	5210.35

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	78.5 GB	57.0%	42	860.35	1.94
02	BIN	137.8 GB	77.0 GB	55.8%	42	870.10	1.92
03	SMALL	13.0 GB	6.5 GB	49.8%	2	3.37	46.93
04	BIN	80.1 GB	48.8 GB	60.9%	20	436.79	2.23
05	BIN	80.1 GB	12.2 GB	15.2%	37	438.10	2.22
06	SMALL	13.0 GB	6.4 GB	49.2%	2	3.36	47.13
07	BIN	80.1 GB	48.3 GB	60.3%	20	436.11	2.23
08	BIN	80.1 GB	13.2 GB	16.5%	37	437.72	2.22
09	SMALL	13.0 GB	6.5 GB	49.5%	2	3.43	46.15
10	BIN	80.1 GB	48.1 GB	60.1%	20	435.89	2.23
11	BIN	80.1 GB	12.8 GB	16.0%	37	438.62	2.22
12	SMALL	13.0 GB	6.4 GB	49.5%	2	3.38	46.85
13	BIN	80.1 GB	49.1 GB	61.3%	20	436.16	2.23
14	BIN	80.1 GB	11.7 GB	14.6%	37	437.80	2.22

TOTAL: 14	-	968.5 GB	425.4 GB	43.9%	320	375.11	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	26380	17763	0	2244	0	0	0	0	6373
2	?	22	0	0	0	0	0	0	0	22

TOTAL: 2		26402	17763	0	2244	0	0	0	0	6395

Unwanted newsgroups [Top 20]:

Newsgroup	Count

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

TOTAL: 2048	17763

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	28
	TOTAL: 1	28
Including strange strings
	192.168.33.37	6373
	TOTAL: 1	6373

TOTAL: 2		6401

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	3	27313	1.4 GB	24	0	0	13:04:12
2	erato.sovam.com	1	52	873.8 KB	1	0	0	00:01:19
3	ts2-a216.angarsk.dial.rol.ru	3	42	1.0 MB	5	0	0	00:13:52
4	rol18.rol.kis.ru	2	35	110.0 KB	4	0	0	00:08:28
5	ts24-b146.moscow.dial.rol.ru	6	23	2.0 MB	35	0	0	00:50:22
6	194.154.66.78	67	2	58.0 KB	3	0	0	16:27:48

TOTAL: 6		82	27467	1.4 GB	72	0	6	32:26:44

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	4	27365	1.4 GB	25	0	0	13:05:31
2	*.angarsk.dial.rol.ru	3	42	1.0 MB	5	0	0	00:13:52
3	*.rol.kis.ru	2	35	110.0 KB	4	0	0	00:08:28
4	*.moscow.dial.rol.ru	83	23	2.0 MB	35	0	0	00:57:19
5	unresolved	82	2	58.0 KB	3	0	0	16:42:06
6	*.ufa.dial.rol.ru	2	0	0.0 KB	0	0	0	00:11:04
7	*.krasnoyarsk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:03:28
8	*.omsk.dial.rol.ru	2	0	0.0 KB	0	0	0	00:00:01
9	*.sovintel.net	13	0	0.0 KB	0	0	0	00:00:19
10	*.spb.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:02
11	*.saratov.dial.rol.ru	2	0	0.0 KB	0	0	0	00:10:45
12	*.samara.dial.rol.ru	1	0	0.0 KB	0	0	0	00:12:13
13	*.nsk.dial.rol.ru	20	0	0.0 KB	0	0	0	00:00:24
14	*.bytecity.ru	2	0	0.0 KB	0	0	0	00:00:03
15	*.tony.pp.ru	79	0	0.0 KB	0	0	0	00:00:54
16	*.voronezh.dial.rol.ru	6	0	0.0 KB	0	0	2	00:00:18
17	*.syktyvkar.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:02
18	*.211.124.120.adsl-spb.net.rol.ru	138	0	0.0 KB	0	0	0	00:04:14
19	*.khabarovsk.dial.rol.ru	16	0	0.0 KB	0	0	0	00:10:21
20	*.rol.ru	5800	0	0.0 KB	0	0	0	00:18:22
21	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00
22	*.komi.com	1	0	0.0 KB	0	0	0	00:05:19

TOTAL: 22		6260	27467	1.4 GB	72	0	3	32:26:38

NNRP total resource statistics [Top 20]:

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

194.154.66.78	0.420	0.676	0.000	16:27:48
keyhole.sovam.com	13.524	126.649	0.000	13:04:12
ts24-b146.moscow.dial.rol.ru	0.800	2.856	0.000	00:50:22
213.142.193.69	0.132	0.248	0.000	00:14:18
ts2-a216.angarsk.dial.rol.ru	0.164	0.272	0.000	00:13:52
ts1-b141.samara.dial.rol.ru	2.156	0.900	0.000	00:12:13
ts2-a89.ufa.dial.rol.ru	0.044	0.056	0.000	00:11:04
ts1-b216.saratov.dial.rol.ru	0.004	0.000	0.000	00:10:35
ts2-a82.khabarovsk.dial.rol.ru	0.004	0.012	0.000	00:10:09
balancer-b.rol.ru	3.736	3.828	0.000	00:09:24
balancer-a.rol.ru	3.636	4.092	0.000	00:08:58
rol18.rol.kis.ru	0.012	0.032	0.000	00:08:28
main.komi.com	0.048	0.100	0.000	00:05:19
ts18-a87.moscow.dial.rol.ru	0.020	0.036	0.000	00:04:19
81.211.124.120.adsl-spb.net.rol.ru	0.484	0.644	0.000	00:04:14
ts1-b177.krasnoyarsk.dial.rol.ru	0.004	0.000	0.000	00:03:28
?	0.016	0.020	0.000	00:01:21
erato.sovam.com	0.016	0.008	0.000	00:01:19
ts9-a181.moscow.dial.rol.ru	0.544	0.900	0.000	00:01:03
ts23-b226.moscow.dial.rol.ru	0.092	0.224	0.000	00:00:55

TOTAL: 44	26.228	141.921	0.000	32:26:44

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2902
balancer-b.rol.ru	2898
81.211.124.120.adsl-spb.net.rol.ru	138
net1-x-ring.tony.pp.ru	79
ts9-a181.moscow.dial.rol.ru	29
ts2-a192.nsk.dial.rol.ru	20
213.142.193.69	15
fw-nat.sovintel.net	13
ts9-b64.moscow.dial.rol.ru	11
ts18-a87.moscow.dial.rol.ru	9
ts2-a82.khabarovsk.dial.rol.ru	8
ts2-a84.khabarovsk.dial.rol.ru	8
ts16-a205.moscow.dial.rol.ru	7
ts16-a24.moscow.dial.rol.ru	6
ts18-a135.moscow.dial.rol.ru	6
ts24-a146.moscow.dial.rol.ru	5
ts23-b226.moscow.dial.rol.ru	3
ts2-a55.voronezh.dial.rol.ru	3
ts2-a89.voronezh.dial.rol.ru	3
ts3-a180.omsk.dial.rol.ru	2

TOTAL: 31	6178

NNRP no permission clients:

System	Conn

87.245.178.164	23
81.200.217.110	3
mx.spice.ru	2
83.220.64.26	1
217.118.92.34	1
83.220.64.34	1

TOTAL: 6	31

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	26

TOTAL: 1	26

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.78	66	0
ts1-b141.samara.dial.rol.ru	1	0
ts2-a89.ufa.dial.rol.ru	1	0
ts2-a82.khabarovsk.dial.rol.ru	1	0
ts2-a216.angarsk.dial.rol.ru	1	0
213.142.193.69	1	0
ts1-b216.saratov.dial.rol.ru	1	0

TOTAL: 7	72	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	27432	99.9%
2	fido7	35	0.1%

TOTAL: 2		27467	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.bras	5063
2	alt.binaries.pictures.anime	5005
3	alt.binaries.pictures.aviation	4449
4	alt.binaries.pictures.bikini.central	4399
5	alt.binaries.pictures.artpics	4269
6	alt.binaries.pictures.animals	3097
7	alt.binaries.pictures.art.pin-up	692
8	alt.binaries.pictures.automobile	339
9	alt.binaries.pictures.erotica.older-women	52
10	fido7.su.pol	27
11	alt.binaries.pictures.bc-series	18
12	alt.binaries.nospam.analfem.repost	15
13	alt.binaries.pictures.youth-and-beauty	12
14	alt.binaries.nospam.analfem	12
15	fido7.su.pol.history	8
16	alt.binaries.pictures.erotica.mclt	4
17	alt.models.petite	3
18	alt.binaries.pictures.erotica.vintage	2
19	alt.bainaries.pictures.lolita.fucking	1

TOTAL: 19		27467