Daily Usenet report

Aug 5 03:00:04 -- Aug 6 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
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 / 15 lines (33.3%)
Aug 5 03:14:45 perseus expireover[2931]: OVDB: expiregroup: recounting alt.binaries.multimedia
Aug 5 03:18:36 perseus expireover[2931]: OVDB: expiregroup: recounting alt.binaries.pictures.erotica
Aug 5 03:29:32 perseus controlchan[8264]: skipping rmgroup moderator@dana.de(pgpverify failed) in <rmgroup-de.soc.netzkultur.misc-2007-08-04@dana.de>
Aug 5 03:29:32 perseus controlchan[8264]: skipping rmgroup moderator@dana.de(pgpverify failed) in <rmgroup-de.soc.netzkultur.umgangsformen-2007-08-04@dana.de>
Aug 5 04:33:18 perseus expireover[2931]: OVDB: expiregroup: recounting alt.binaries.pictures.celebrities

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2191535	98.3%	193.0 MB	97.7%
nnrpd	20226	0.9%	2.1 MB	1.0%
innd	15177	0.7%	2.1 MB	1.1%
cnfsstat	2304	0.1%	400.4 KB	0.2%
expireover	12	0.0%	1.2 KB	0.0%
controlchan	4	0.0%	0.6 KB	0.0%

TOTAL: 6	2229258	100.0%	197.6 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2185221	97.7%
Negative hits	43138	1.9%
Positive hits	6753	0.3%
Cache misses	1018	0.0%

TOTAL: 4	2236130	100.0%

INND timer:

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

article cancel	00:01:05.546	0.1%	18976	0.000	3.454	1662.000
article cleanup	00:00:24.684	0.0%	2168353	0.002	0.011	0.023
article logging	00:02:04.407	0.1%	2173711	0.001	0.057	7.494
article parse	00:19:28.158	1.4%	167292414	0.005	0.007	0.025
article write	09:57:24.586	41.5%	2142694	2.344	16.729	29.478
artlog/artcncl	00:00:00.193	0.0%	18457	0.000	0.010	1.000
artlog/artparse	00:00:00.000	0.0%	76	0.000	0.000	0.000
data move	00:03:48.971	0.3%	176940567	0.001	0.001	0.003
hisgrep/artcncl	00:00:51.327	0.1%	7409	0.000	6.928	1662.000
hishave/artcncl	00:00:08.844	0.0%	18976	0.000	0.466	196.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:27:12.642	1.9%	2220208	0.000	0.735	16.991
history sync	00:00:00.293	0.0%	290	0.000	1.010	2.000
history write	00:51:17.835	3.6%	2142694	0.021	1.436	11.886
hiswrite/artcncl	00:00:05.060	0.0%	11567	0.000	0.437	174.600
idle	06:41:11.537	27.9%	157135397	0.127	0.153	0.382
nntp read	00:21:25.134	1.5%	165608083	0.005	0.008	0.021
overview write	04:52:49.510	20.3%	2142694	1.363	8.200	311.391
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%	5	0.000	0.000	0.000

TOTAL: 24:00:17.399	23:39:18.727	98.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:24:51.314	1.1%	24256	0.000	61.482	61.482
idle	37:03:43.762	95.4%	55630	0.000	2398.414	200270.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:23:22.672	1.0%	289524	0.000	4.845	5873.814
readart	00:28:22.599	1.2%	49883	0.000	34.132	129.316

TOTAL: 38:51:41.471	38:20:20.347	98.7%	-	-	-	-

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

deburr001@yahoo.com	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	346	2154232	2129720	115	24397	98%	491:56:34

TOTAL: 1		346	2154232	2129720	115	24397	98%	491:56:34

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	416.9 GB	5.8 MB	416.9 GB	99%	202.9 KB	491:56:34

TOTAL: 1		416.9 GB	5.8 MB	416.9 GB	99%	202.9 KB	491:56:34

Incoming articles:

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

Aug 5 03:00:04 - 03:59:59	90732	4.2%	25.23	17.1 GB	4.1%	4976.86
Aug 5 04:00:00 - 04:59:59	91116	4.3%	25.31	18.2 GB	4.4%	5289.86
Aug 5 05:00:00 - 05:59:59	86109	4.0%	23.92	17.5 GB	4.2%	5109.79
Aug 5 06:00:00 - 06:59:59	89224	4.2%	24.78	17.8 GB	4.3%	5173.89
Aug 5 07:00:00 - 07:59:59	76701	3.6%	21.31	15.2 GB	3.6%	4423.71
Aug 5 08:00:00 - 08:59:59	85597	4.0%	23.78	16.9 GB	4.1%	4911.72
Aug 5 09:00:00 - 09:59:59	90245	4.2%	25.07	18.0 GB	4.3%	5241.83
Aug 5 10:00:00 - 10:59:59	75447	3.5%	20.96	15.1 GB	3.6%	4389.55
Aug 5 11:00:00 - 11:59:59	88235	4.1%	24.51	16.9 GB	4.1%	4918.73
Aug 5 12:00:00 - 12:59:59	80503	3.8%	22.36	15.4 GB	3.7%	4474.92
Aug 5 13:00:00 - 13:59:59	90659	4.2%	25.18	17.8 GB	4.3%	5177.23
Aug 5 14:00:00 - 14:59:59	96665	4.5%	26.85	18.0 GB	4.3%	5257.01
Aug 5 15:00:00 - 15:59:59	92692	4.3%	25.75	17.9 GB	4.3%	5205.08
Aug 5 16:00:00 - 16:59:59	88104	4.1%	24.47	16.9 GB	4.1%	4918.30
Aug 5 17:00:00 - 17:59:59	90287	4.2%	25.08	17.6 GB	4.2%	5131.42
Aug 5 18:00:00 - 18:59:59	88586	4.1%	24.61	17.4 GB	4.2%	5069.56
Aug 5 19:00:00 - 19:59:59	88091	4.1%	24.47	17.5 GB	4.2%	5105.23
Aug 5 20:00:00 - 20:59:59	91060	4.3%	25.29	17.6 GB	4.2%	5137.48
Aug 5 21:00:00 - 21:59:59	96932	4.5%	26.93	18.5 GB	4.5%	5396.33
Aug 5 22:00:00 - 22:59:59	95784	4.5%	26.61	18.5 GB	4.4%	5381.92
Aug 5 23:00:00 - 23:59:59	96040	4.5%	26.68	18.6 GB	4.5%	5423.66
Aug 6 00:00:00 - 00:59:59	87278	4.1%	24.24	16.8 GB	4.0%	4903.65
Aug 6 01:00:00 - 01:59:59	86744	4.0%	24.10	16.3 GB	3.9%	4739.88
Aug 6 02:00:00 - 02:59:59	99153	4.6%	27.54	18.9 GB	4.5%	5505.09
Aug 6 03:00:00 - 03:00:03	52	0.0%	17.33	9.1 MB	0.0%	3108.16

TOTAL: 23:59:59	2142036	100.0%	24.79	416.3 GB	100.0%	5052.55

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	71.3 GB	51.8%	60	816.57	2.05
02	BIN	137.8 GB	85.6 GB	62.1%	60	828.00	2.02
03	SMALL	13.0 GB	8.8 GB	67.5%	3	3.78	41.89
04	BIN	80.1 GB	66.1 GB	82.5%	32	423.05	2.30
05	BIN	80.1 GB	58.1 GB	72.6%	52	425.82	2.28
06	SMALL	13.0 GB	8.8 GB	67.3%	3	3.78	41.86
07	BIN	80.1 GB	63.2 GB	78.9%	32	422.46	2.30
08	BIN	80.1 GB	55.6 GB	69.4%	52	423.96	2.29
09	SMALL	13.0 GB	8.6 GB	66.0%	3	3.72	42.59
10	BIN	80.1 GB	61.3 GB	76.6%	32	421.48	2.31
11	BIN	80.1 GB	57.9 GB	72.3%	52	426.34	2.28
12	SMALL	13.0 GB	8.8 GB	67.1%	3	3.72	42.48
13	BIN	80.1 GB	61.6 GB	76.9%	32	421.89	2.30
14	BIN	80.1 GB	52.2 GB	65.2%	52	424.72	2.29

TOTAL: 14	-	968.5 GB	667.9 GB	69.0%	468	362.95	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	31003	25395	0	248	0	0	0	0	5360
2	?	76	0	0	0	0	0	0	0	76

TOTAL: 2		31079	25395	0	248	0	0	0	0	5436

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pictures.erotica.asian.female	727
alt.pedophilia	498
alt.binaries.pictures.erotica.cartoons.reposts	311
alt.binaries.pictures.fetish.urine	263
alt.binaries.pictures.pictures.erotica	260
alt.binaries.pictures.erotica.voyeuris	225
alt.binaries.pictures.erotica.gay	223
alt.binaries.pictures.erotica.fetish.urine	221
alt.binaries.pictures.erotica.latinos	210
alt.binaries.picutures.erotica	208
alt.binaries.pictures.erotica.french.nospam	207
alt.binaries.pictures.erotica.xxx-action	207
alt.binaries.pictures.erotica.homosexual	206
alt.binaries.pictures.erotica.hardore	206
alt.binaries.pictures.erotica.foot-fetish	205
alt.binaries.pictures.erotica.transsexual.action	204
alt.binaries.pictures.erotica.transgendered	204
alt.binaries.pictures.erotica.goo-shot	204
alt.binaries.pictures.erotica.transsexual	203
alt.biniaries.erotica	201

TOTAL: 3801	25395

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	5359
	TOTAL: 1	5359

TOTAL: 2		5377

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	1	24256	1.5 GB	7	0	0	27:39:07
2	ts16-a59.moscow.dial.rol.ru	8	20	1.1 MB	6	0	0	00:35:22
3	ts18-b119.moscow.dial.rol.ru	3	10	590.8 KB	4	0	0	00:27:51
4	ts4-a223.nnovgorod.dial.rol.ru	1	1	1.3 KB	22	0	0	00:02:41
5	ts3-a251.nsk.net.rol.ru	4	0	0.0 KB	0	1	0	00:12:13

TOTAL: 5		17	24287	1.5 GB	39	1	2	38:51:00

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	1	24256	1.5 GB	7	0	0	27:39:07
2	*.moscow.dial.rol.ru	46	30	1.7 MB	10	0	0	01:27:38
3	*.nnovgorod.dial.rol.ru	2	1	1.3 KB	22	0	0	00:19:20
4	*.ufa.dial.rol.ru	4	0	0.0 KB	0	0	0	00:02:59
5	*.sovintel.net	14	0	0.0 KB	0	0	0	00:00:22
6	*.spb.dial.rol.ru	4	0	0.0 KB	0	0	0	00:00:10
7	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:49
8	*.saratov.dial.rol.ru	5	0	0.0 KB	0	0	0	00:02:50
9	*.nsk.net.rol.ru	4	0	0.0 KB	0	1	0	00:12:13
10	*.nsk.dial.rol.ru	19	0	0.0 KB	0	0	0	00:00:12
11	*.bytecity.ru	2	0	0.0 KB	0	0	0	00:00:02
12	unresolved	52	0	0.0 KB	0	0	0	08:38:24
13	*.tony.pp.ru	20	0	0.0 KB	0	0	0	00:01:02
14	*.khabarovsk.dial.rol.ru	23	0	0.0 KB	0	0	0	00:02:22
15	*.rol.ru	5808	0	0.0 KB	0	0	0	00:19:47
16	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00

TOTAL: 16		6006	24287	1.5 GB	39	1	1	38:49:18

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	11.773	97.622	0.000	27:39:07
194.154.66.131	0.104	0.144	0.000	08:36:35
ts16-a59.moscow.dial.rol.ru	0.044	0.028	0.000	00:35:22
ts18-b119.moscow.dial.rol.ru	0.016	0.012	0.000	00:27:51
ts3-b111.nnovgorod.dial.rol.ru	0.048	0.052	0.000	00:16:38
ts18-a97.moscow.dial.rol.ru	0.028	0.044	0.000	00:13:08
ts3-a251.nsk.net.rol.ru	0.040	0.020	0.000	00:12:13
ts18-a37.moscow.dial.rol.ru	0.004	0.000	0.000	00:10:15
balancer-b.rol.ru	3.804	3.660	0.000	00:10:09
balancer-a.rol.ru	3.668	3.636	0.000	00:09:38
ts2-a217.ufa.dial.rol.ru	0.004	0.012	0.000	00:02:58
ts4-a223.nnovgorod.dial.rol.ru	0.008	0.000	0.000	00:02:41
ts2-a86.khabarovsk.dial.rol.ru	0.160	0.132	0.000	00:02:22
?	0.032	0.024	0.000	00:01:52
195.46.181.84	0.012	0.004	0.000	00:01:48
ts1-a164.saratov.dial.rol.ru	0.000	0.012	0.000	00:01:32
82.140.73.23	0.156	0.240	0.000	00:01:31
ts1-a121.saratov.dial.rol.ru	0.000	0.008	0.000	00:01:18
net1-x-ring.tony.pp.ru	0.036	0.036	0.000	00:01:02
ts23-b55.moscow.dial.rol.ru	0.004	0.004	0.000	00:00:55

TOTAL: 37	20.417	106.102	0.000	38:51:00

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2905
balancer-a.rol.ru	2903
194.154.66.131	51
ts2-a86.khabarovsk.dial.rol.ru	23
ts18-a97.moscow.dial.rol.ru	20
net1-x-ring.tony.pp.ru	20
ts2-b138.nsk.dial.rol.ru	19
fw-nat.sovintel.net	14
ts23-b55.moscow.dial.rol.ru	5
ts23-b127.moscow.dial.rol.ru	5
ts1-a164.saratov.dial.rol.ru	4
ts5-a176.spb.dial.rol.ru	3
ts27-a62.moscow.dial.rol.ru	3
ts2-a217.ufa.dial.rol.ru	2
ts2-a87.ufa.dial.rol.ru	2
ts18-a37.moscow.dial.rol.ru	2
news.bytecity.ru	2
ts3-b111.nnovgorod.dial.rol.ru	1
news.lek.ru	1
195.46.181.84	1

TOTAL: 23	5989

NNRP no permission clients:

System	Conn

82.140.73.23	143
cornholio.migtel.ru	41
matona.gns.ru	2
host-212-145-66-217.spbmts.ru	1
195.28.36.242	1
62.183.113.106	1
85.236.161.130	1
79.120.1.98	1

TOTAL: 8	191

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	34

TOTAL: 1	34

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	2	0
ts3-a251.nsk.net.rol.ru	1	0
ts3-b111.nnovgorod.dial.rol.ru	1	0
ts18-a97.moscow.dial.rol.ru	1	0
ts16-a59.moscow.dial.rol.ru	1	0
ts18-a37.moscow.dial.rol.ru	1	0

TOTAL: 6	7	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	22015	100.0%
2	talk	1	0.0%

TOTAL: 2		22016	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	12329
2	alt.binaries.erotica.breasts	4936
3	alt.binaries.pictures.erotica.butts	2542
4	alt.binaries.pictures.bras	971
5	alt.binaries.pictures.artpics	652
6	alt.binaries.pictures.bikini.central	555
7	alt.binaries.erotica.pregnant	20
8	alt.binaries.erotica.pregnant-movies	5
9	alt.binaries.pictures.lolita	4
10	talk.general	1
11	alt.binaries.pictures.erotica.alt.sex	1

TOTAL: 11		22016