Daily Usenet report

Sep 19 03:00:04 -- Sep 20 03:00:03

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 / 143 lines (3.5%)
Sep 19 03:47:35 andromeda controlchan[12217]: Unknown "cmsg" control by imok.bbs@bbs.cs.nthu.edu.tw
Sep 19 05:30:11 andromeda controlchan[12217]: Unknown "cmsg" control by yumialce.bbs@bbs.wretch.cc
Sep 19 05:30:12 andromeda controlchan[12217]: Unknown "cmsg" control by yumialce.bbs@bbs.wretch.cc
Sep 19 05:30:13 andromeda controlchan[12217]: Unknown "cmsg" control by yumialce.bbs@bbs.wretch.cc
Sep 19 08:20:11 andromeda controlchan[12217]: Unknown "cmsg" control by guess2.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2361630	97.8%	208.4 MB	97.2%
innd	31229	1.3%	3.7 MB	1.7%
nnrpd	20144	0.8%	2.0 MB	0.9%
cnfsstat	2304	0.1%	401.1 KB	0.2%
controlchan	141	0.0%	15.1 KB	0.0%
expireover	2	0.0%	0.2 KB	0.0%

TOTAL: 6	2415450	100.0%	214.4 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2339925	98.0%
Negative hits	39360	1.6%
Positive hits	6552	0.3%
Cache misses	1183	0.0%

TOTAL: 4	2387020	100.0%

INND timer:

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

article cancel	00:01:21.756	0.1%	24065	0.000	3.397	1621.000
article cleanup	00:00:36.752	0.0%	2321682	0.008	0.016	0.028
article logging	00:01:42.705	0.1%	2338119	0.006	0.044	4.835
article parse	00:22:50.319	1.6%	167040987	0.006	0.008	0.026
article write	10:08:22.771	42.3%	2293877	3.458	15.913	23.840
artlog/artcncl	00:00:00.246	0.0%	23261	0.000	0.011	1.000
artlog/artparse	00:00:00.001	0.0%	52	0.000	0.019	1.000
data move	00:06:04.267	0.4%	177219534	0.002	0.002	0.003
hisgrep/artcncl	00:01:17.499	0.1%	7494	0.000	10.341	1621.000
hishave/artcncl	00:00:00.651	0.0%	24065	0.000	0.027	18.478
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:09:37.980	0.7%	2364951	0.002	0.244	6.617
history sync	00:00:00.304	0.0%	290	0.000	1.048	3.000
history write	01:03:27.948	4.4%	2293877	0.038	1.660	13.869
hiswrite/artcncl	00:00:02.626	0.0%	16571	0.000	0.158	756.000
idle	06:56:36.232	28.9%	156365243	0.120	0.160	0.628
nntp read	00:25:46.306	1.8%	165422423	0.007	0.009	0.021
overview write	04:07:42.336	17.2%	2293877	1.345	6.479	88.770
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%	130	0.000	0.015	0.500

TOTAL: 23:59:55.415	23:25:30.701	97.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:12:38.703	1.5%	17562	0.000	43.201	175.714
idle	12:09:47.251	88.5%	164365	0.000	266.403	200005.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:19:13.138	2.3%	461701	0.000	2.498	6717.565
readart	00:12:12.219	1.5%	38653	0.000	18.943	265.000

TOTAL: 13:44:13.430	12:53:51.311	93.9%	-	-	-	-

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	322	2295929	2269674	4	26251	98%	470:11:52

TOTAL: 1		322	2295929	2269674	4	26251	98%	470:11:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	419.2 GB	36.5 MB	419.3 GB	99%	191.5 KB	470:11:52

TOTAL: 1		419.2 GB	36.5 MB	419.3 GB	99%	191.5 KB	470:11:52

Incoming articles:

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

Sep 19 03:00:04 - 03:59:59	98189	4.3%	27.31	17.9 GB	4.3%	5227.74
Sep 19 04:00:00 - 04:59:59	96684	4.2%	26.86	18.4 GB	4.4%	5352.75
Sep 19 05:00:00 - 05:59:59	91353	4.0%	25.38	17.9 GB	4.3%	5211.94
Sep 19 06:00:00 - 06:59:59	89063	3.9%	24.74	17.1 GB	4.1%	4992.03
Sep 19 07:00:00 - 07:59:59	87056	3.8%	24.18	16.6 GB	4.0%	4843.80
Sep 19 08:00:00 - 08:59:59	94893	4.1%	26.36	18.9 GB	4.5%	5513.86
Sep 19 09:00:00 - 09:59:59	85889	3.7%	23.86	16.5 GB	3.9%	4793.71
Sep 19 10:00:00 - 10:59:59	89647	3.9%	24.90	16.2 GB	3.8%	4713.12
Sep 19 11:00:00 - 11:59:59	95504	4.2%	26.53	17.9 GB	4.3%	5212.94
Sep 19 12:00:00 - 12:59:59	100252	4.4%	27.85	19.4 GB	4.6%	5652.56
Sep 19 13:00:00 - 13:59:59	101508	4.4%	28.20	19.3 GB	4.6%	5613.67
Sep 19 14:00:00 - 14:59:59	99918	4.4%	27.75	18.9 GB	4.5%	5497.10
Sep 19 15:00:00 - 15:59:59	95597	4.2%	26.55	17.8 GB	4.2%	5171.49
Sep 19 16:00:00 - 16:59:59	106190	4.6%	29.50	17.8 GB	4.2%	5193.53
Sep 19 17:00:00 - 17:59:59	102045	4.4%	28.35	17.9 GB	4.3%	5209.24
Sep 19 18:00:00 - 18:59:59	100824	4.4%	28.01	17.6 GB	4.2%	5133.13
Sep 19 19:00:00 - 19:59:59	99979	4.4%	27.77	17.4 GB	4.1%	5067.24
Sep 19 20:00:00 - 20:59:59	97892	4.3%	27.19	17.7 GB	4.2%	5154.34
Sep 19 21:00:00 - 21:59:59	97992	4.3%	27.22	17.7 GB	4.2%	5150.44
Sep 19 22:00:00 - 22:59:59	98260	4.3%	27.29	17.3 GB	4.1%	5031.26
Sep 19 23:00:00 - 23:59:59	95116	4.1%	26.42	16.9 GB	4.0%	4912.18
Sep 20 00:00:00 - 00:59:59	84200	3.7%	23.39	14.6 GB	3.5%	4238.69
Sep 20 01:00:00 - 01:59:59	93080	4.1%	25.86	15.9 GB	3.8%	4635.90
Sep 20 02:00:00 - 02:59:59	92877	4.0%	25.80	16.9 GB	4.0%	4934.50
Sep 20 03:00:00 - 03:00:03	82	0.0%	27.33	13.6 MB	0.0%	4652.80

TOTAL: 23:59:59	2294090	100.0%	26.55	420.4 GB	100.0%	5102.36

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	96.1 GB	69.7%	68	844.78	1.98
02	BIN	137.8 GB	106.2 GB	77.1%	68	840.41	1.99
03	SMALL	13.0 GB	763.6 MB	5.7%	4	6.41	24.66
04	BIN	80.1 GB	8.2 GB	10.3%	43	427.20	2.28
05	BIN	80.1 GB	56.2 GB	70.2%	59	429.43	2.26
06	SMALL	13.0 GB	648.6 MB	4.9%	4	6.40	24.74
07	BIN	80.1 GB	5.1 GB	6.4%	43	426.16	2.28
08	BIN	80.1 GB	54.8 GB	68.4%	59	427.37	2.27
09	SMALL	13.0 GB	722.5 MB	5.4%	4	6.41	24.68
10	BIN	80.1 GB	3.2 GB	4.0%	43	424.98	2.29
11	BIN	80.1 GB	60.9 GB	76.0%	59	430.18	2.26
12	SMALL	13.0 GB	715.6 MB	5.4%	4	6.38	24.80
13	BIN	80.1 GB	2.9 GB	3.6%	43	425.10	2.29
14	BIN	80.1 GB	54.6 GB	68.2%	59	427.87	2.27

TOTAL: 14	-	968.5 GB	451.0 GB	46.6%	560	367.55	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	44227	27556	0	239	0	0	0	0	16432
2	?	52	0	0	0	0	0	0	0	52

TOTAL: 2		44279	27556	0	239	0	0	0	0	16484

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pictures.amateur.butts	1225
es.binarios.hd	679
alt.binaries.erotica.freckles	386
alt.binaries.pictures.erotica.asian.female	381
ccu.bbs.talk.market	273
pedo.japanese.fetish.lolita	265
alt.binarieds	238
alt.binaries.jerry	161
alt.binaries.pictures.black.erotica.females	146
alt.binaries.xdp	146
alt.binaries.nonnude	137
alt.binaries.pictures.black.erotica	135
cakewalk.coffeehouse	133
alt.binaries.pictures.eroctica.torture	111
rss.MoreOver-BayArea	110
cakewalk.audio	107
rss.fark	103
hr.rec.glazba.binaries.albumi	102
rss.MoreOver-MovieBusiness	102
alt.binaries.amateur.gangbang	99

TOTAL: 4478	27556

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	36
	TOTAL: 1	36
Including strange strings
	192.168.33.37	16431
	TOTAL: 1	16431

TOTAL: 2		16467

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	3	17514	1.3 GB	6	0	0	05:43:36
2	ts1-a21.saratov.dial.rol.ru	20	22	1.5 MB	0	0	0	00:19:04
3	news.pcs-net.net	7	20	4.3 MB	18	0	0	00:59:22
4	ts1-b213.saratov.dial.rol.ru	1	9	19.6 KB	1	0	0	00:39:44
5	xkis.kis.ru	1	5	8.5 KB	2	0	0	00:00:36
6	ts2-a199.syktyvkar.dial.rol.ru	1	4	158.3 KB	1	0	0	00:00:42

TOTAL: 6		33	17574	1.3 GB	28	0	0	13:43:41

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	3	17514	1.3 GB	6	0	0	05:43:36
2	*.saratov.dial.rol.ru	21	31	1.5 MB	1	0	0	00:58:49
3	*.pcs-net.net	7	20	4.3 MB	18	0	0	00:59:22
4	*.kis.ru	1	5	8.5 KB	2	0	0	00:00:36
5	*.syktyvkar.dial.rol.ru	7	4	158.3 KB	1	0	0	00:01:50
6	*.sovintel.net	15	0	0.0 KB	0	0	0	00:00:21
7	*.nsk.dial.rol.ru	19	0	0.0 KB	0	0	0	00:00:15
8	unresolved	28	0	0.0 KB	0	0	0	04:39:43
9	*.ufa.dial.rol.ru	2	0	0.0 KB	0	0	0	00:00:34
10	*.spb.dial.rol.ru	3	0	0.0 KB	0	0	0	00:00:01
11	*.moscow.dial.rol.ru	18	0	0.0 KB	0	0	0	00:01:17
12	*.cc.gldn.net	1	0	0.0 KB	0	0	0	00:10:00
13	*.239.227.211.adsl-spb.net.rol.ru	1	0	0.0 KB	0	0	0	00:00:10
14	*.tony.pp.ru	74	0	0.0 KB	0	0	0	00:44:47
15	*.rol.ru	5807	0	0.0 KB	0	0	0	00:18:20
16	*.nn.ru	26	0	0.0 KB	0	0	0	00:00:11

TOTAL: 16		6033	17574	1.3 GB	28	0	0	13:42:07

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	9.192	84.530	0.000	05:43:36
194.154.66.131	0.068	0.048	0.000	04:39:43
news.pcs-net.net	0.024	0.040	0.000	00:59:22
net1-x-ring.tony.pp.ru	50.912	527.887	0.000	00:44:47
ts1-b213.saratov.dial.rol.ru	0.084	0.128	0.000	00:39:44
ts1-a21.saratov.dial.rol.ru	0.048	0.064	0.000	00:19:04
nat-ie.cc.gldn.net	0.004	0.000	0.000	00:10:00
balancer-b.rol.ru	3.616	3.784	0.000	00:09:48
balancer-a.rol.ru	3.848	3.800	0.000	00:08:32
?	0.036	0.032	0.000	00:02:06
82.140.73.76	0.212	0.272	0.000	00:01:20
ts27-b6.moscow.dial.rol.ru	0.016	0.008	0.000	00:01:12
ts2-b17.syktyvkar.dial.rol.ru	0.012	0.068	0.000	00:01:07
ts2-a199.syktyvkar.dial.rol.ru	0.000	0.004	0.000	00:00:42
xkis.kis.ru	0.096	0.220	0.000	00:00:36
ts2-a125.ufa.dial.rol.ru	0.012	0.020	0.000	00:00:34
fw-nat.sovintel.net	0.088	0.072	0.000	00:00:21
ts2-a104.nsk.dial.rol.ru	0.028	0.024	0.000	00:00:15
gray.nn.ru	0.048	0.048	0.000	00:00:11
195.239.227.211.adsl-spb.net.rol.ru	0.000	0.000	0.000	00:00:10

TOTAL: 30	68.580	621.313	0.000	13:43:41

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2906
balancer-a.rol.ru	2901
net1-x-ring.tony.pp.ru	74
194.154.66.131	28
gray.nn.ru	26
ts2-a104.nsk.dial.rol.ru	19
fw-nat.sovintel.net	15
ts27-b6.moscow.dial.rol.ru	10
ts2-b17.syktyvkar.dial.rol.ru	6
ts27-a136.moscow.dial.rol.ru	5
ts27-b35.moscow.dial.rol.ru	3
ts5-a4.spb.dial.rol.ru	3
ts2-a125.ufa.dial.rol.ru	2
nat-ie.cc.gldn.net	1
195.239.227.211.adsl-spb.net.rol.ru	1

TOTAL: 15	6000

NNRP no permission clients:

System	Conn

82.140.73.76	152
cornholio.migtel.ru	108
217.118.92.44	4
195.28.36.242	1
m9x.olven.ru	1
host-212-145-66-217.spbmts.ru	1
83.167.116.18	1
department21-133.e-tools.ru	1

TOTAL: 8	269

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	36

TOTAL: 1	36

NNRP client timeouts [Top 20]:

System	Conn	Peer

news.pcs-net.net	3	0
194.154.66.131	2	0
ts1-b213.saratov.dial.rol.ru	1	0
nat-ie.cc.gldn.net	1	0

TOTAL: 4	7	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	18955	99.9%
2	fido7	14	0.1%

TOTAL: 2		18969	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	14669
2	alt.binaries.pictures.bras	2493
3	alt.binaries.pictures.artpics	1769
4	alt.binaries.pictures.vladmodels	19
5	fido7.ru.linux	9
6	fido7.ru.cisco	5
7	alt.binaries.nospam.female.bodyhair	4
8	alt.binaries.pictures.sandra	1

TOTAL: 8		18969