Daily Usenet report

Apr 10 03:00:03 -- Apr 11 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
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 client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 5 / 88 lines (5.7%)
Apr 10 05:52:30 andromeda controlchan[25481]: Unknown "cmsg" control by doono329.bbs@bbs.wretch.cc
Apr 10 06:12:29 andromeda controlchan[25481]: Unknown "cmsg" control by wingtofly.bbs@bbs.wretch.cc
Apr 10 08:12:29 andromeda controlchan[25481]: Unknown "cmsg" control by felicias.bbs@bbs.wretch.cc
Apr 10 08:12:29 andromeda controlchan[25481]: Unknown "cmsg" control by felicias.bbs@bbs.wretch.cc
Apr 10 08:12:29 andromeda controlchan[25481]: Unknown "cmsg" control by felicias.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2124279	98.1%	192.1 MB	97.5%
nnrpd	19072	0.9%	1.9 MB	1.0%
innd	18766	0.9%	2.5 MB	1.3%
cnfsstat	2304	0.1%	399.4 KB	0.2%
controlchan	72	0.0%	7.7 KB	0.0%

TOTAL: 5	2164493	100.0%	197.0 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2106620	96.4%
Negative hits	67056	3.1%
Positive hits	9555	0.4%
Cache misses	1210	0.1%

TOTAL: 4	2184441	100.0%

INND timer:

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

article cancel	00:02:28.236	0.2%	12978	0.000	11.422	1576.333
article cleanup	00:00:31.741	0.0%	2098763	0.000	0.015	0.048
article logging	00:02:27.613	0.2%	2110786	0.000	0.070	9.048
article parse	00:19:18.390	1.3%	101052040	0.007	0.011	0.154
article write	07:23:21.840	30.8%	2052883	2.642	12.958	24206.316
artlog/artcncl	00:00:05.071	0.0%	12753	0.000	0.398	1576.333
artlog/artparse	00:00:00.000	0.0%	36	0.000	0.000	0.000
data move	00:04:07.952	0.3%	108747788	0.000	0.002	0.011
hisgrep/artcncl	00:01:46.950	0.1%	8601	0.000	12.435	403.400
hishave/artcncl	00:00:07.839	0.0%	12978	0.000	0.604	124.667
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:14:42.832	1.0%	2173081	0.000	0.406	7.970
history sync	00:00:00.515	0.0%	286	0.000	1.801	6.000
history write	01:22:34.047	5.7%	2093773	0.041	2.366	30.683
hiswrite/artcncl	00:00:28.132	0.0%	4377	0.000	6.427	766.000
idle	04:03:39.416	16.9%	89726587	0.000	0.163	60003.000
nntp read	00:20:22.318	1.4%	99490116	0.008	0.012	0.088
overview write	09:45:09.219	40.6%	2052883	8.681	17.102	1436.432
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%	65	0.000	0.000	0.000

TOTAL: 23:59:42.561	23:41:12.111	98.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:09:03.157	1.0%	128695	0.000	4.220	827.000
idle	12:42:43.303	86.7%	354388	0.000	129.133	200063.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:11:50.251	1.3%	1092131	0.000	0.650	507.288
readart	00:56:00.282	6.4%	261675	0.000	12.841	219.712

TOTAL: 14:39:26.584	13:59:36.993	95.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

newsgroups@news.uwaterloo.ca	0	2	0	0	0	2

TOTAL	0	2	0	0	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	495	2092719	2043903	339	48477	97%	477:49:44

TOTAL: 1		495	2092719	2043903	339	48477	97%	477:49:44

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	378.3 GB	18.2 MB	378.3 GB	99%	189.6 KB	477:49:44

TOTAL: 1		378.3 GB	18.2 MB	378.3 GB	99%	189.6 KB	477:49:44

Incoming articles:

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

Apr 10 03:00:03 - 03:59:59	82852	4.0%	23.03	16.3 GB	4.3%	4751.96
Apr 10 04:00:00 - 04:59:59	83210	4.1%	23.11	16.5 GB	4.4%	4792.08
Apr 10 05:00:00 - 05:59:59	78293	3.8%	21.75	14.7 GB	3.9%	4278.01
Apr 10 06:00:00 - 06:59:59	82302	4.0%	22.86	15.5 GB	4.1%	4515.95
Apr 10 07:00:00 - 07:59:59	58562	2.9%	16.27	10.7 GB	2.8%	3109.73
Apr 10 08:00:00 - 08:59:59	62884	3.1%	17.47	12.2 GB	3.2%	3563.83
Apr 10 09:00:00 - 09:59:59	69442	3.4%	19.29	13.9 GB	3.7%	4040.97
Apr 10 10:00:00 - 10:59:59	64982	3.2%	18.05	12.4 GB	3.3%	3597.22
Apr 10 11:00:00 - 11:59:59	86368	4.2%	23.99	16.4 GB	4.3%	4788.21
Apr 10 12:00:00 - 12:59:59	92037	4.5%	25.57	16.4 GB	4.3%	4765.16
Apr 10 13:00:00 - 13:59:59	92500	4.5%	25.69	17.1 GB	4.5%	4977.14
Apr 10 14:00:00 - 14:59:59	94062	4.6%	26.13	17.5 GB	4.6%	5091.60
Apr 10 15:00:00 - 15:59:59	95733	4.7%	26.59	17.4 GB	4.6%	5081.96
Apr 10 16:00:00 - 16:59:59	96231	4.7%	26.73	17.4 GB	4.6%	5072.89
Apr 10 17:00:00 - 17:59:59	95599	4.7%	26.56	17.2 GB	4.6%	5020.94
Apr 10 18:00:00 - 18:59:59	94934	4.6%	26.37	17.6 GB	4.7%	5131.89
Apr 10 19:00:00 - 19:59:59	94055	4.6%	26.13	17.6 GB	4.6%	5118.90
Apr 10 20:00:00 - 20:59:59	92363	4.5%	25.66	16.9 GB	4.5%	4912.56
Apr 10 21:00:00 - 21:59:59	91251	4.4%	25.35	16.5 GB	4.4%	4795.24
Apr 10 22:00:00 - 22:59:59	87797	4.3%	24.39	16.0 GB	4.2%	4659.05
Apr 10 23:00:00 - 23:59:59	82348	4.0%	22.87	14.7 GB	3.9%	4281.67
Apr 11 00:00:00 - 00:59:59	81235	4.0%	22.57	14.3 GB	3.8%	4177.65
Apr 11 01:00:00 - 01:59:59	97258	4.7%	27.02	15.8 GB	4.2%	4591.37
Apr 11 02:00:00 - 02:59:59	97184	4.7%	27.00	17.3 GB	4.6%	5041.01
Apr 11 03:00:00 - 03:00:04	89	0.0%	22.25	13.4 MB	0.0%	3427.22

TOTAL: 24:00:01	2053571	100.0%	23.77	378.2 GB	100.0%	4589.81

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	15.0 GB	10.9%	152	756.14	2.21
02	BIN	137.8 GB	46.6 GB	33.8%	152	753.26	2.22
03	SMALL	13.0 GB	5.2 GB	39.7%	11	7.01	22.57
04	BIN	80.1 GB	68.7 GB	85.8%	114	383.54	2.53
05	BIN	80.1 GB	48.6 GB	60.7%	131	385.17	2.52
06	SMALL	13.0 GB	4.7 GB	35.8%	11	6.96	22.72
07	BIN	80.1 GB	60.0 GB	74.9%	114	382.52	2.54
08	BIN	80.1 GB	35.8 GB	44.7%	131	383.76	2.53
09	SMALL	13.0 GB	4.8 GB	36.6%	11	6.97	22.70
10	BIN	80.1 GB	55.1 GB	68.7%	114	382.68	2.54
11	BIN	80.1 GB	55.4 GB	69.2%	131	385.20	2.52
12	BIN	13.0 GB	5.0 GB	38.0%	343	382.73	0.41
13	BIN	80.1 GB	8.0 GB	10.0%	56	384.75	2.53
14	SMALL	80.1 GB	76.2 GB	95.1%	0	6.97	139.48

TOTAL: 14	-	968.5 GB	489.0 GB	50.5%	1471	330.18	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	57917	40898	0	1828	0	0	0	0	15191
2	?	36	0	0	0	0	0	0	0	36

TOTAL: 2		57953	40898	0	1828	0	0	0	0	15227

Unwanted newsgroups [Top 20]:

Newsgroup	Count

microsoft.public.test	1157
alt.binaries.pictures.erotica.highheels	381
alt.binaries.jerry	352
alt.binaries.pictures.erotica.amateur.digicam	347
alt.binaries.picturea.erotica	345
a2000.erotica.binaries	330
alt.binaries.pictures.erotica.goo-shot	326
alt.biniaries.erotica	320
1.binaries.pictures.erotica	318
alt.binaries.picture.erotica.amature	316
alt.binaries.pictures.erotica.bisexual	314
alt.binaries.pictures.erotica.erotic	311
alt.binaries.pictures.erotica.group.sex	310
alt.binaries.erotic.erotika.young	302
alt.binaries.picture.erotica.anal	291
it-alt.community.cibba	290
alt.binaries.erotic.female	277
alt.binaries.erotic.incest	275
alt.binaries.pictures.erotica.breast.large	274
eng.alt.binaries.pictures.erotica	266

TOTAL: 1858	40898

INND misc events:

Events	Count

CCreader	4

TOTAL: 1	4

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	27
	TOTAL: 1	27
Including strange strings
	192.168.33.37	12023
	TOTAL: 1	12023

TOTAL: 2		12050

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	14	128682	2.8 GB	39	0	0	12:07:48
2	news.pcs-net.net	8	222	41.9 MB	17	0	0	01:34:15
3	ts1-a164.spb.dial.rol.ru	1	1	1.5 KB	3	0	0	00:03:06

TOTAL: 3		23	128905	2.9 GB	59	0	0	14:39:04

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	14	128682	2.8 GB	39	0	0	12:07:48
2	*.pcs-net.net	8	222	41.9 MB	17	0	0	01:34:15
3	*.spb.dial.rol.ru	1	1	1.5 KB	3	0	0	00:03:06
4	*.moscow.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:32
5	*.krasnodar.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:27
6	*.sovintel.net	12	0	0.0 KB	0	0	0	00:00:08
7	unresolved	1	0	0.0 KB	0	0	0	00:10:00
8	*.tony.pp.ru	67	0	0.0 KB	0	0	0	00:14:04
9	*.rol.ru	5783	0	0.0 KB	0	0	0	00:23:10
10	*.nn.ru	18	0	0.0 KB	0	0	0	00:00:04

TOTAL: 10		5906	128905	2.9 GB	59	0	0	14:38:54

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	51.724	81.428	0.000	12:07:48
news.pcs-net.net	0.180	0.532	0.000	01:34:15
net1-x-ring.tony.pp.ru	44.944	53.632	0.000	00:14:04
balancer-b.rol.ru	3.556	3.868	0.000	00:11:39
balancer-a.rol.ru	3.596	4.104	0.000	00:11:30
195.218.244.87	0.020	0.004	0.000	00:10:00
?	0.028	0.068	0.000	00:05:15
ts1-a164.spb.dial.rol.ru	0.000	0.004	0.000	00:03:06
ts12-b134.moscow.dial.rol.ru	0.024	0.000	0.000	00:00:32
ts3-a99.krasnodar.dial.rol.ru	0.012	0.008	0.000	00:00:27
cornholio.migtel.ru	0.268	0.272	0.000	00:00:08
fw-nat.sovintel.net	0.056	0.060	0.000	00:00:08
gray.nn.ru	0.020	0.044	0.000	00:00:04
vip10.mgsm.ru	0.004	0.008	0.000	00:00:01

TOTAL: 14	104.432	144.032	0.000	14:39:04

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2892
balancer-b.rol.ru	2891
net1-x-ring.tony.pp.ru	67
gray.nn.ru	18
fw-nat.sovintel.net	12
ts3-a99.krasnodar.dial.rol.ru	1
195.218.244.87	1
ts12-b134.moscow.dial.rol.ru	1

TOTAL: 8	5883

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	164
vip10.mgsm.ru	2

TOTAL: 2	166

NNRP client timeouts [Top 20]:

System	Conn	Peer

news.pcs-net.net	6	0
195.218.244.87	1	0

TOTAL: 2	7	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	130172	100.0%
2	de	1	0.0%

TOTAL: 2		130173	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	85657
2	alt.binaries.pictures.bras	26422
3	alt.binaries.pictures.artpics	17871
4	alt.binaries.pictures.wals	111
5	alt.binaries.pictures.vladmodels	88
6	alt.binaries.pictures.sandra	23
7	de.alt.etc.messer	1

TOTAL: 7		130173