Daily Usenet report

Sep 28 03:00:02 -- Sep 29 03:00:05

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 gethostbyaddr failures
NNRP client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 5 / 89 lines (5.6%)
Sep 28 05:00:50 andromeda controlchan[17396]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Sep 28 05:00:54 andromeda controlchan[17396]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Sep 28 05:01:02 andromeda controlchan[17396]: Unknown "cmsg" control by ether.bbs@bbs.wretch.cc
Sep 28 05:01:18 andromeda controlchan[17396]: Unknown "cmsg" control by yauer.bbs@bbs.wretch.cc
Sep 28 05:01:19 andromeda controlchan[17396]: Unknown "cmsg" control by NSR500.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2258758	96.7%	197.7 MB	96.2%
innd	53786	2.3%	5.4 MB	2.6%
nnrpd	20468	0.9%	1.9 MB	0.9%
cnfsstat	2304	0.1%	401.0 KB	0.2%
controlchan	90	0.0%	9.7 KB	0.0%
expireover	2	0.0%	0.2 KB	0.0%

TOTAL: 6	2335408	100.0%	205.5 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2238361	97.3%
Negative hits	41991	1.8%
Cache misses	9579	0.4%
Positive hits	9491	0.4%

TOTAL: 4	2299422	100.0%

INND timer:

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

article cancel	00:03:35.053	0.2%	26382	0.000	8.152	797.000
article cleanup	00:00:35.683	0.0%	2222568	0.006	0.016	0.028
article logging	00:02:03.871	0.1%	2233019	0.006	0.055	5.053
article parse	00:22:17.489	1.5%	160755928	0.006	0.008	0.019
article write	09:24:24.221	39.2%	2196615	4.593	15.417	25.708
artlog/artcncl	00:00:00.288	0.0%	26191	0.000	0.011	4.750
artlog/artparse	00:00:00.001	0.0%	115	0.000	0.009	1.000
data move	00:05:49.006	0.4%	170527768	0.002	0.002	0.003
hisgrep/artcncl	00:03:27.661	0.2%	18719	0.000	11.094	838.000
hishave/artcncl	00:00:01.597	0.0%	26382	0.000	0.061	7.600
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:13:36.071	0.9%	2274118	0.001	0.359	7.207
history sync	00:00:00.742	0.0%	292	0.000	2.541	419.000
history write	00:45:14.797	3.1%	2196615	0.038	1.236	12.226
hiswrite/artcncl	00:00:05.033	0.0%	7663	0.000	0.657	23.000
idle	06:40:49.549	27.8%	150298980	0.120	0.160	1.396
nntp read	00:25:03.885	1.7%	159183781	0.007	0.009	0.018
overview write	05:19:36.778	22.2%	2196615	1.179	8.730	244.255
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.002	0.0%	87	0.000	0.023	0.500

TOTAL: 24:00:17.823	23:26:41.727	97.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:22:57.369	1.2%	69646	0.000	19.777	754.000
idle	24:37:12.610	75.6%	151584	0.000	584.710	200530.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	05:49:50.569	17.9%	515000	0.000	40.758	13267.952
readart	00:38:44.411	2.0%	141978	0.000	16.372	392.000

TOTAL: 32:34:59.946	31:28:44.959	96.6%	-	-	-	-

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

fff@alteferians.org	2	0	0	0	0	2
hamstermumke@xs4all.nl	0	1	0	0	0	1

TOTAL	2	1	0	0	0	3

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	369	2234339	2207530	69	26740	98%	474:29:21

TOTAL: 1		369	2234339	2207530	69	26740	98%	474:29:21

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	412.8 GB	13.2 MB	412.8 GB	99%	193.8 KB	474:29:21

TOTAL: 1		412.8 GB	13.2 MB	412.8 GB	99%	193.8 KB	474:29:21

Incoming articles:

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

Sep 28 03:00:02 - 03:59:59	102424	4.7%	28.47	18.1 GB	4.4%	5288.42
Sep 28 04:00:00 - 04:59:59	93300	4.2%	25.92	17.1 GB	4.2%	4982.05
Sep 28 05:00:00 - 05:59:59	88284	4.0%	24.52	17.3 GB	4.2%	5039.69
Sep 28 06:00:00 - 06:59:59	91115	4.1%	25.31	17.7 GB	4.3%	5156.56
Sep 28 07:00:00 - 07:59:59	73683	3.4%	20.47	13.4 GB	3.3%	3891.96
Sep 28 08:00:00 - 08:59:59	90966	4.1%	25.27	17.6 GB	4.3%	5122.84
Sep 28 09:00:00 - 09:59:59	81797	3.7%	22.72	16.1 GB	3.9%	4702.94
Sep 28 10:00:00 - 10:59:59	84700	3.9%	23.53	15.5 GB	3.8%	4519.84
Sep 28 11:00:00 - 11:59:59	85960	3.9%	23.88	17.2 GB	4.2%	5023.87
Sep 28 12:00:00 - 12:59:59	93378	4.3%	25.94	17.1 GB	4.2%	4984.21
Sep 28 13:00:00 - 13:59:59	99206	4.5%	27.56	18.0 GB	4.4%	5252.60
Sep 28 14:00:00 - 14:59:59	96652	4.4%	26.85	17.9 GB	4.4%	5215.91
Sep 28 15:00:00 - 15:59:59	86596	3.9%	24.05	16.6 GB	4.1%	4840.28
Sep 28 16:00:00 - 16:59:59	93733	4.3%	26.04	17.0 GB	4.1%	4938.82
Sep 28 17:00:00 - 17:59:59	95457	4.3%	26.52	18.0 GB	4.4%	5249.42
Sep 28 18:00:00 - 18:59:59	97506	4.4%	27.09	17.6 GB	4.3%	5129.67
Sep 28 19:00:00 - 19:59:59	96266	4.4%	26.74	17.6 GB	4.3%	5112.57
Sep 28 20:00:00 - 20:59:59	93581	4.3%	25.99	17.7 GB	4.3%	5159.77
Sep 28 21:00:00 - 21:59:59	99348	4.5%	27.60	18.4 GB	4.5%	5362.21
Sep 28 22:00:00 - 22:59:59	94936	4.3%	26.37	17.8 GB	4.3%	5179.47
Sep 28 23:00:00 - 23:59:59	92467	4.2%	25.69	17.5 GB	4.3%	5090.48
Sep 29 00:00:00 - 00:59:59	85516	3.9%	23.75	15.4 GB	3.8%	4482.28
Sep 29 01:00:00 - 01:59:59	89901	4.1%	24.97	16.1 GB	3.9%	4699.79
Sep 29 02:00:00 - 02:59:59	89214	4.1%	24.78	17.2 GB	4.2%	5012.31
Sep 29 03:00:00 - 03:00:05	73	0.0%	14.60	10.0 MB	0.0%	2042.60

TOTAL: 24:00:03	2196059	100.0%	25.42	410.1 GB	100.0%	4976.40

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	33.6 GB	24.4%	73	811.36	2.06
02	BIN	137.8 GB	47.0 GB	34.1%	73	814.39	2.05
03	SMALL	13.0 GB	4.8 GB	37.0%	4	5.19	30.48
04	BIN	80.1 GB	1.5 GB	1.8%	47	416.55	2.33
05	BIN	80.1 GB	51.2 GB	63.9%	63	418.23	2.32
06	SMALL	13.0 GB	4.7 GB	36.1%	4	5.18	30.53
07	BIN	80.1 GB	77.6 GB	96.9%	46	415.18	2.34
08	BIN	80.1 GB	48.9 GB	61.0%	63	417.75	2.33
09	SMALL	13.0 GB	4.8 GB	36.6%	4	5.17	30.60
10	BIN	80.1 GB	75.0 GB	93.6%	46	414.13	2.35
11	BIN	80.1 GB	56.4 GB	70.4%	63	418.96	2.32
12	SMALL	13.0 GB	4.8 GB	36.6%	4	5.22	30.32
13	BIN	80.1 GB	74.5 GB	93.0%	46	414.15	2.35
14	BIN	80.1 GB	48.8 GB	60.9%	63	417.44	2.33

TOTAL: 14	-	968.5 GB	533.5 GB	55.1%	599	357.68	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	36404	25657	0	294	0	0	0	0	10453
2	?	115	0	0	0	0	0	0	0	115

TOTAL: 2		36519	25657	0	294	0	0	0	0	10568

Unwanted newsgroups [Top 20]:

Newsgroup	Count

allt.sex.fetish	759
alt.binaries.hotrod	693
alt.binaries.pictures.erotica.asian.female	553
alt.pictures.erotica.asian	438
alt.binaries.amateur.gangbang	410
alt.binaries.erotica.freckles	390
alt.binaries.pictures.erotica.mature.females	387
alt.binaries.multimedia.erotica.asians	343
alt.binaries.ufo	321
alt.binaries.pictures.amateur.butts	313
alt.binaries.multimedia.erotica.transexuals	299
alt.binaries.pictures.erotica.latinal	281
alt.pedophilia	267
alt.binaries.multimedia.transsexuals	258
pedo.japanese.fetish.lolita	211
de.alt.sex.fetish	209
alt.binaries.multimedia.anal.fisting	204
alt.biniaries.erotica	188
ccu.bbs.talk.market	156
alt.binaries.multimedia.erotica.mature	154

TOTAL: 1958	25657

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	27
	TOTAL: 1	27
Including strange strings
	192.168.33.37	10451
	TOTAL: 1	10451

TOTAL: 2		10478

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	17	69096	2.2 GB	51	0	0	12:52:13
2	ts1-a185.saratov.dial.rol.ru	56	669	53.7 MB	0	0	0	11:04:08
3	news.pcs-net.net	8	348	74.8 MB	26	0	0	02:46:03
4	ts30-b185.moscow.dial.rol.ru	21	158	4.7 MB	75	0	0	01:03:57
5	ts2-a215.ufa.dial.rol.ru	1	6	638.8 KB	26	0	0	00:15:07
6	ts1-a22.saratov.dial.rol.ru	1	3	9.0 KB	1	0	0	00:17:38

TOTAL: 6		104	70280	2.3 GB	179	0	2	36:26:16

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	17	69096	2.2 GB	51	0	0	12:52:13
2	*.saratov.dial.rol.ru	57	672	53.7 MB	1	0	0	11:21:47
3	*.pcs-net.net	8	348	74.8 MB	26	0	0	02:46:03
4	*.moscow.dial.rol.ru	35	158	4.7 MB	75	0	0	01:04:37
5	*.ufa.dial.rol.ru	1	6	638.8 KB	26	0	0	00:15:07
6	*.sovintel.net	16	0	0.0 KB	0	0	0	00:00:18
7	unresolved	47	0	0.0 KB	0	0	0	07:11:21
8	*.nukus.dial.rol.uz	1	0	0.0 KB	0	0	0	00:01:53
9	*.tony.pp.ru	75	0	0.0 KB	0	0	0	00:03:03
10	*.rol.ru	5812	0	0.0 KB	0	0	0	00:19:13
11	*.nsk.net.rol.ru	3	0	0.0 KB	0	0	0	00:24:37
12	*.nn.ru	52	0	0.0 KB	0	0	0	00:00:17
13	*.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00
14	*.nsk.dial.rol.ru	57	0	0.0 KB	0	0	0	00:02:44

TOTAL: 14		6182	70280	2.3 GB	179	0	1	36:25:06

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	64.328	635.098	0.000	12:52:13
ts1-a185.saratov.dial.rol.ru	0.160	0.756	0.000	11:04:08
194.154.66.131	0.076	0.088	0.000	07:01:17
news.pcs-net.net	0.056	0.392	0.000	02:46:03
ts30-b185.moscow.dial.rol.ru	0.084	0.144	0.000	01:03:57
ts3-a197.nsk.net.rol.ru	0.036	0.112	0.000	00:24:37
ts1-a22.saratov.dial.rol.ru	0.108	0.188	0.000	00:17:38
ts2-a215.ufa.dial.rol.ru	0.096	0.140	0.000	00:15:07
194.186.71.137	0.000	0.004	0.000	00:10:01
balancer-b.rol.ru	3.576	4.096	0.000	00:09:55
balancer-a.rol.ru	3.772	3.908	0.000	00:09:17
net1-x-ring.tony.pp.ru	0.140	0.140	0.000	00:03:03
ts2-a207.nukus.dial.rol.uz	0.120	0.228	0.000	00:01:53
?	0.020	0.044	0.000	00:01:46
ts2-a86.nsk.dial.rol.ru	0.012	0.028	0.000	00:01:08
82.140.73.76	0.224	0.276	0.000	00:01:07
ts2-b198.nsk.dial.rol.ru	0.040	0.044	0.000	00:01:02
ts2-a254.nsk.dial.rol.ru	0.008	0.044	0.000	00:00:33
ts27-b111.moscow.dial.rol.ru	0.004	0.000	0.000	00:00:21
fw-nat.sovintel.net	0.096	0.056	0.000	00:00:18

TOTAL: 30	73.148	645.962	0.000	36:26:16

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2907
balancer-b.rol.ru	2905
net1-x-ring.tony.pp.ru	75
gray.nn.ru	52
194.154.66.131	44
ts2-b198.nsk.dial.rol.ru	21
ts2-a254.nsk.dial.rol.ru	18
ts2-a86.nsk.dial.rol.ru	18
fw-nat.sovintel.net	16
ts9-b31.moscow.dial.rol.ru	4
ts23-b136.moscow.dial.rol.ru	4
ts27-b50.moscow.dial.rol.ru	3
ts3-a197.nsk.net.rol.ru	3
ts27-b111.moscow.dial.rol.ru	3
212.46.203.164	2
ts2-a207.nukus.dial.rol.uz	1
194.186.71.137	1
ns1.lavtech.ru	1

TOTAL: 18	6078

NNRP no permission clients:

System	Conn

82.140.73.76	132
217.65.223.69	7
cornholio.migtel.ru	5
86.92.237.98	1
83.167.116.18	1

TOTAL: 5	146

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	28

TOTAL: 1	28

NNRP client timeouts [Top 20]:

System	Conn	Peer

news.pcs-net.net	2	0
194.154.66.131	2	0
ts3-a197.nsk.net.rol.ru	2	0
ts30-b185.moscow.dial.rol.ru	1	0
194.186.71.137	1	0

TOTAL: 5	8	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	69443	99.8%
2	hr	93	0.1%
3	japan2nd	27	0.0%
4	fido7	3	0.0%

TOTAL: 4		69566	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	51157
2	alt.binaries.pictures.artpics	9250
3	alt.binaries.pictures.bras	8644
4	alt.binaries.pictures.sandra	264
5	alt.binaries.pictures.vladmodels	84
6	hr.soc.povijest	48
7	hr.rec.film.anime	45
8	japan2nd.binaries.pictures.erotica.lolita	27
9	alt.binaires.pictures.erotica.teen.female	22
10	alt.sex.binaries.erotica.teen	16
11	fido7.ru.linux	3
12	alt.binaries.pictures.erotica.young	2
13	alt.binaries.pictures.erotica.lolita	2
14	alt.binaries.pictures.erotica.ll-series	1
15	alt.binaries.pictures.lolita	1

TOTAL: 15		69566