Daily Usenet report

Oct 28 03:00:06 -- Oct 29 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
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 / 53 lines (9.4%)
Oct 28 05:00:28 perseus controlchan[29156]: Unknown "cmsg" control by protoss666.bbs@bbs.wretch.cc
Oct 28 05:10:21 perseus controlchan[29156]: Unknown "cmsg" control by momojaja.bbs@bbs.wretch.cc
Oct 28 05:10:21 perseus controlchan[29156]: Unknown "cmsg" control by momojaja.bbs@bbs.wretch.cc
Oct 28 06:30:26 perseus controlchan[29156]: Unknown "cmsg" control by coldwufish.bbs@bbs.wretch.cc
Oct 28 06:50:21 perseus controlchan[29156]: Unknown "cmsg" control by protoss666.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2188661	97.1%	191.0 MB	96.5%
nnrpd	46569	2.1%	4.2 MB	2.1%
innd	16239	0.7%	2.2 MB	1.1%
cnfsstat	2304	0.1%	399.9 KB	0.2%
controlchan	53	0.0%	6.0 KB	0.0%

TOTAL: 5	2253826	100.0%	197.9 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2182772	98.1%
Negative hits	39189	1.8%
Positive hits	1843	0.1%
Cache misses	516	0.0%

TOTAL: 4	2224320	100.0%

INND timer:

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

article cancel	00:00:51.597	0.1%	2781	0.000	18.553	878.000
article cleanup	00:00:24.872	0.0%	2182439	0.004	0.011	0.021
article logging	00:02:34.502	0.2%	2186651	0.003	0.071	4.636
article parse	00:19:41.927	1.4%	170922263	0.005	0.007	0.021
article write	10:02:11.170	41.8%	2154814	4.863	16.768	101.443
artlog/artcncl	00:00:00.069	0.0%	2763	0.000	0.025	12.667
artlog/artparse	00:00:00.001	0.0%	85	0.000	0.012	1.000
data move	00:03:52.961	0.3%	181004039	0.001	0.001	0.002
hisgrep/artcncl	00:00:48.022	0.1%	2221	0.000	21.622	953.000
hishave/artcncl	00:00:01.720	0.0%	2781	0.000	0.618	104.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:31:05.015	2.2%	2222969	0.000	0.839	24.862
history sync	00:00:00.287	0.0%	290	0.000	0.990	3.000
history write	00:56:56.599	4.0%	2154814	0.030	1.586	12.722
hiswrite/artcncl	00:00:01.760	0.0%	560	0.000	3.143	806.000
idle	07:11:36.625	30.0%	160932833	0.128	0.161	0.640
nntp read	00:21:43.611	1.5%	169381118	0.006	0.008	0.017
overview write	04:06:50.451	17.1%	2154814	1.212	6.873	90.012
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.001	0.0%	52	0.000	0.019	1.000

TOTAL: 24:00:35.681	23:38:41.190	98.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:35:29.977	3.2%	95384	0.000	22.331	72.118
idle	13:26:45.969	73.1%	198534	0.000	243.817	201065.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:32:19.696	8.4%	726087	0.000	7.630	56698.207
readart	01:38:08.521	8.9%	198718	0.000	29.633	557.000

TOTAL: 18:23:35.594	17:12:44.163	93.6%	-	-	-	-

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	383	2142075	2114345	0	27730	98%	468:23:02

TOTAL: 1		383	2142075	2114345	0	27730	98%	468:23:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	417.4 GB	669.0 KB	417.4 GB	99%	204.3 KB	468:23:02

TOTAL: 1		417.4 GB	669.0 KB	417.4 GB	99%	204.3 KB	468:23:02

Incoming articles:

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

Oct 28 03:00:06 - 03:59:59	88985	4.1%	24.76	18.3 GB	4.4%	5350.65
Oct 28 04:00:00 - 04:59:59	86352	4.0%	23.99	17.7 GB	4.2%	5159.09
Oct 28 05:00:00 - 05:59:59	85371	4.0%	23.71	17.4 GB	4.1%	5062.18
Oct 28 06:00:00 - 06:59:59	79597	3.7%	22.11	16.1 GB	3.8%	4698.37
Oct 28 07:00:00 - 07:59:59	87229	4.0%	24.23	17.9 GB	4.3%	5219.66
Oct 28 08:00:00 - 08:59:59	80675	3.7%	22.41	16.6 GB	3.9%	4822.14
Oct 28 09:00:00 - 09:59:59	85822	4.0%	23.84	18.4 GB	4.4%	5359.63
Oct 28 10:00:00 - 10:59:59	82550	3.8%	22.93	17.1 GB	4.1%	4971.28
Oct 28 11:00:00 - 11:59:59	90720	4.2%	25.20	18.6 GB	4.4%	5407.22
Oct 28 12:00:00 - 12:59:59	97425	4.5%	27.06	18.8 GB	4.5%	5474.73
Oct 28 13:00:00 - 13:59:59	90475	4.2%	25.13	17.1 GB	4.1%	4994.13
Oct 28 14:00:00 - 14:59:59	91970	4.3%	25.55	17.6 GB	4.2%	5121.32
Oct 28 15:00:00 - 15:59:59	93484	4.3%	25.97	17.9 GB	4.2%	5203.77
Oct 28 16:00:00 - 16:59:59	92315	4.3%	25.64	17.4 GB	4.1%	5058.07
Oct 28 17:00:00 - 17:59:59	95755	4.4%	26.60	17.5 GB	4.2%	5101.14
Oct 28 18:00:00 - 18:59:59	92604	4.3%	25.72	17.4 GB	4.1%	5079.25
Oct 28 19:00:00 - 19:59:59	88933	4.1%	24.70	16.9 GB	4.0%	4929.42
Oct 28 20:00:00 - 20:59:59	89175	4.1%	24.77	17.1 GB	4.1%	4994.54
Oct 28 21:00:00 - 21:59:59	90473	4.2%	25.13	17.6 GB	4.2%	5127.98
Oct 28 22:00:00 - 22:59:59	95141	4.4%	26.43	18.3 GB	4.3%	5327.19
Oct 28 23:00:00 - 23:59:59	91316	4.2%	25.37	17.3 GB	4.1%	5050.22
Oct 29 00:00:00 - 00:59:59	85102	4.0%	23.64	16.3 GB	3.9%	4747.78
Oct 29 01:00:00 - 01:59:59	94545	4.4%	26.26	17.4 GB	4.1%	5061.64
Oct 29 02:00:00 - 02:59:59	97902	4.5%	27.20	18.1 GB	4.3%	5280.61
Oct 29 03:00:00 - 03:00:04	67	0.0%	16.75	13.3 MB	0.0%	3400.29

TOTAL: 23:59:58	2153983	100.0%	24.93	420.9 GB	100.0%	5108.32

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	84.3 GB	61.2%	101	837.29	2.00
02	BIN	137.8 GB	128.0 GB	92.9%	101	839.50	1.99
03	SMALL	13.0 GB	8.0 GB	61.7%	6	4.89	32.34
04	BIN	80.1 GB	18.6 GB	23.2%	68	427.91	2.27
05	BIN	80.1 GB	24.8 GB	31.0%	88	429.68	2.26
06	SMALL	13.0 GB	8.0 GB	61.4%	6	4.92	32.14
07	BIN	80.1 GB	8.8 GB	11.0%	68	427.60	2.27
08	BIN	80.1 GB	16.3 GB	20.3%	88	428.95	2.27
09	SMALL	13.0 GB	7.6 GB	58.6%	6	4.86	32.57
10	BIN	80.1 GB	1.5 GB	1.9%	68	426.83	2.28
11	BIN	80.1 GB	29.7 GB	37.1%	88	430.06	2.26
12	SMALL	13.0 GB	7.9 GB	60.9%	6	4.93	32.12
13	BIN	80.1 GB	79.8 GB	99.6%	67	426.07	2.28
14	BIN	80.1 GB	12.9 GB	16.1%	88	428.79	2.27

TOTAL: 14	-	968.5 GB	436.4 GB	45.1%	849	367.29	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	31831	27451	0	142	0	0	0	0	4238
2	?	85	0	0	0	0	0	0	0	85

TOTAL: 2		31916	27451	0	142	0	0	0	0	4323

Unwanted newsgroups [Top 20]:

Newsgroup	Count

microsoft.public.test	1153
alt.binaries.pictures.erotica.asian.female	508
alt.binaries.game	383
alt.binaries.video	376
alt.binaries.warez.ibm-pc.german.iso	265
alt.binaires.erotica	260
alt.binaires.pictures.erotica.butts	242
alt.binaries.pictures.erotica.breast.natural	229
alt.binaires.erotica.teen	208
alt.binaries.pictures.erotica.bisexual	196
alt.binaries.pictures.erotica.highheels	195
alt.binaries.picutures.erotica.teen.female	192
alt.pictues.binaries.erotica	191
alt.binaries.pictures.erotica.voyeuris	180
alt.binaries.pictures.erotica.voyeurism.hidden-camara	180
alt.binaries.erotic.erotika.young	177
alt.binaries.b4e.erotica	175
alt.binaries.erotica.females.plumpers	163
alt.binaries.	162
erotica.female	162

TOTAL: 1752	27451

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	9
	TOTAL: 1	9
Including strange strings
	192.168.33.37	4211
	TOTAL: 1	4211

TOTAL: 2		4220

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	10	95384	11.7 GB	33	0	0	15:00:41
2	194.154.66.225	4	127	8.6 MB	134	0	0	00:28:20
3	ts30-b101.moscow.dial.rol.ru	6	57	532.7 KB	3	0	0	00:36:07
4	ts30-a58.moscow.dial.rol.ru	10	33	780.2 KB	12	0	0	00:11:00
5	ts16-a238.moscow.dial.rol.ru	1	16	1012.0 KB	6	0	0	00:20:07
6	ts2-b47.syktyvkar.dial.rol.ru	7	8	468.5 KB	2	0	0	00:34:54
7	ts16-a5.moscow.dial.rol.ru	1	2	93.2 KB	1	0	0	00:11:53

TOTAL: 7		39	95627	11.7 GB	191	0	2	18:22:43

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	10	95384	11.7 GB	33	0	0	15:00:41
2	unresolved	11	127	8.6 MB	134	0	0	00:29:09
3	*.moscow.dial.rol.ru	28	108	2.4 MB	22	0	0	01:21:29
4	*.syktyvkar.dial.rol.ru	7	8	468.5 KB	2	0	0	00:34:54
5	*.bytecity.ru	1	0	0.0 KB	0	0	0	00:00:00
6	*.sovintel.net	14	0	0.0 KB	0	0	0	00:00:15
7	*.sarov.dial.rol.ru	3	0	0.0 KB	0	0	0	00:13:29
8	*.spb.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:52
9	*.tony.pp.ru	76	0	0.0 KB	0	0	0	00:09:07
10	*.irkutsk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:01:25
11	*.rol.ru	5804	0	0.0 KB	0	0	0	00:21:49
12	*.nn.ru	22	0	0.0 KB	0	0	0	00:00:11
13	*.nsk.dial.rol.ru	54	0	0.0 KB	0	0	0	00:00:44
14	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00

TOTAL: 14		6033	95627	11.7 GB	191	0	1	18:16:32

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	42.392	383.394	0.000	15:00:41
ts30-b101.moscow.dial.rol.ru	0.012	0.040	0.000	00:36:07
ts2-b47.syktyvkar.dial.rol.ru	0.052	0.096	0.000	00:34:54
194.154.66.225	0.212	0.308	0.000	00:28:20
ts16-a238.moscow.dial.rol.ru	0.000	0.020	0.000	00:20:07
ts16-a5.moscow.dial.rol.ru	0.004	0.004	0.000	00:11:53
balancer-a.rol.ru	3.572	3.716	0.000	00:11:38
ts2-a75.sarov.dial.rol.ru	0.252	0.332	0.000	00:11:03
ts30-a58.moscow.dial.rol.ru	0.040	0.048	0.000	00:11:00
balancer-b.rol.ru	3.720	3.616	0.000	00:10:10
net1-x-ring.tony.pp.ru	0.124	0.164	0.000	00:09:07
cornholio.migtel.ru	9.084	9.168	0.000	00:06:03
ts2-a120.sarov.dial.rol.ru	0.008	0.000	0.000	00:02:25
?	0.012	0.040	0.000	00:02:23
ts16-a6.moscow.dial.rol.ru	0.012	0.000	0.000	00:01:58
ts1-b189.irkutsk.dial.rol.ru	0.008	0.000	0.000	00:01:25
ts5-b252.spb.dial.rol.ru	0.012	0.012	0.000	00:00:52
212.46.236.5	0.008	0.012	0.000	00:00:41
ts2-a183.nsk.dial.rol.ru	0.052	0.044	0.000	00:00:19
ts23-b51.moscow.dial.rol.ru	0.004	0.000	0.000	00:00:18

TOTAL: 36	59.836	401.202	0.000	18:22:43

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2920
balancer-a.rol.ru	2884
net1-x-ring.tony.pp.ru	76
ts2-a183.nsk.dial.rol.ru	27
gray.nn.ru	22
ts2-a98.nsk.dial.rol.ru	14
fw-nat.sovintel.net	14
ts2-b149.nsk.dial.rol.ru	13
212.46.236.188	5
ts9-b213.moscow.dial.rol.ru	4
ts16-a6.moscow.dial.rol.ru	3
ts23-b51.moscow.dial.rol.ru	3
ts2-a75.sarov.dial.rol.ru	2
dynip.195.98.62.151.dialup.kis.ru	2
212.46.236.5	2
cappa.tr155m.lavtech.ru	1
ts5-b252.spb.dial.rol.ru	1
news.bytecity.ru	1
ts1-b189.irkutsk.dial.rol.ru	1
ts2-a120.sarov.dial.rol.ru	1

TOTAL: 20	5996

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	6808
dynip.195.98.62.151.dialup.kis.ru	3
83.220.64.111	1
83.220.64.24	1
195.28.36.242	1
212.13.125.180	1
83.220.64.35	1
83.220.64.51	1
83.220.64.46	1

TOTAL: 9	6818

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	37

TOTAL: 1	37

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-b47.syktyvkar.dial.rol.ru	3	0
ts16-a5.moscow.dial.rol.ru	1	0
ts2-a75.sarov.dial.rol.ru	1	0

TOTAL: 3	5	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	94558	99.9%
2	hr	50	0.1%

TOTAL: 2		94608	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	83954
2	alt.binaries.pictures.artpics	5967
3	alt.binaries.pictures.bras	4431
4	hr.rec.humor	49
5	alt.binaries.aoi	37
6	alt.binaries.pictures.erotica.bestiality	34
7	alt.bainaries.pictures.erotica.animals	29
8	alt.binaires.pictures.erotica.teen.female	28
9	alt.binaries.models.petite	25
10	alt.binaries.pictures.erotica.incest	13
11	alt.binaries.pictures.youth-and-beauty	9
12	alt.binaries.nospam.female.bodyhair	7
13	alt.comp.os.windows-xp	6
14	alt.comp.microsoft.windows	6
15	alt.binaries.pictures.erotica.mclt	6
16	alt.binaries.nospam.incest	2
17	alt.binaries.erotica.pregnant	2
18	alt.binaries.pictures.erotica.alt.sex	1
19	hr.soc.povijest	1
20	alt.binaries.nospam.female.bodyhair.pubes	1

TOTAL: 20		94608