Daily Usenet report

Sep 20 03:00:09 -- Sep 21 03:00:03

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
Newsgroups removed
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 / 96 lines (5.2%)
Sep 20 04:10:21 perseus controlchan[28453]: Unknown "cmsg" control by Uras.bbs@bbs.wretch.cc
Sep 20 05:30:20 perseus controlchan[28453]: Unknown "cmsg" control by photocopy.bbs@bbs.wretch.cc
Sep 20 06:00:19 perseus controlchan[28453]: Unknown "cmsg" control by darkdh.bbs@bbs.wretch.cc
Sep 20 06:00:19 perseus controlchan[28453]: Unknown "cmsg" control by darkdh.bbs@bbs.wretch.cc
Sep 20 06:20:21 perseus controlchan[28453]: Unknown "cmsg" control by j8902.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2294701	98.3%	201.6 MB	97.6%
nnrpd	19806	0.8%	2.0 MB	1.0%
innd	18621	0.8%	2.5 MB	1.2%
cnfsstat	2304	0.1%	400.2 KB	0.2%
controlchan	99	0.0%	10.9 KB	0.0%

TOTAL: 5	2335531	100.0%	206.5 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2285894	97.8%
Negative hits	47761	2.0%
Positive hits	3459	0.1%
Cache misses	1056	0.0%

TOTAL: 4	2338170	100.0%

INND timer:

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

article cancel	00:01:34.112	0.1%	21907	0.000	4.296	1028.667
article cleanup	00:00:25.308	0.0%	2259890	0.000	0.011	0.021
article logging	00:02:12.703	0.2%	2273766	0.004	0.058	3.615
article parse	00:19:19.747	1.3%	160310462	0.005	0.007	0.095
article write	10:24:28.880	43.4%	2234533	4.216	16.768	4551.623
artlog/artcncl	00:00:10.067	0.0%	21134	0.000	0.476	36.629
artlog/artparse	00:00:00.000	0.0%	23	0.000	0.000	0.000
data move	00:03:44.061	0.3%	169776489	0.000	0.001	0.002
hisgrep/artcncl	00:01:05.757	0.1%	4254	0.000	15.458	1028.667
hishave/artcncl	00:00:03.438	0.0%	21907	0.000	0.157	89.889
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:23:09.732	1.6%	2317979	0.001	0.600	14.757
history sync	00:00:00.286	0.0%	289	0.000	0.990	3.000
history write	00:52:18.890	3.6%	2234533	0.029	1.405	11.175
hiswrite/artcncl	00:00:14.715	0.0%	17653	0.000	0.834	98.000
idle	06:13:33.440	25.9%	149773787	0.128	0.150	2051.400
nntp read	00:21:05.517	1.5%	158509025	0.006	0.008	0.102
overview write	04:56:13.068	20.6%	2234533	0.657	7.954	93.165
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%	92	0.000	0.011	0.250

TOTAL: 24:00:04.953	23:39:39.722	98.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:09:38.661	0.8%	17295	0.000	33.458	453.400
idle	17:01:03.462	87.5%	142313	0.000	430.484	200229.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:14:08.674	6.4%	641128	0.000	6.939	31963.284
readart	00:11:39.319	1.0%	37719	0.000	18.540	199.500

TOTAL: 19:26:24.008	18:36:30.116	95.7%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Newsgroups removed:

Group

sci.finance.abstracts

TOTAL: 1

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

group-admin@isc.org	0	1	0	0	1	1
newsmaster@carnet.hr	0	0	1	0	0	1

TOTAL	0	1	1	0	1	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	328	2298844	2271611	13	27220	98%	476:03:26

TOTAL: 1		328	2298844	2271611	13	27220	98%	476:03:26

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	413.5 GB	2.6 MB	413.5 GB	99%	188.6 KB	476:03:26

TOTAL: 1		413.5 GB	2.6 MB	413.5 GB	99%	188.6 KB	476:03:26

Incoming articles:

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

Sep 20 03:00:09 - 03:59:59	92412	4.1%	25.73	17.0 GB	4.1%	4960.61
Sep 20 04:00:00 - 04:59:59	91072	4.1%	25.30	16.8 GB	4.1%	4907.11
Sep 20 05:00:00 - 05:59:59	85168	3.8%	23.66	16.3 GB	4.0%	4757.01
Sep 20 06:00:00 - 06:59:59	85122	3.8%	23.64	16.2 GB	3.9%	4730.82
Sep 20 07:00:00 - 07:59:59	83846	3.8%	23.29	15.5 GB	3.8%	4516.27
Sep 20 08:00:00 - 08:59:59	93095	4.2%	25.86	17.5 GB	4.2%	5091.51
Sep 20 09:00:00 - 09:59:59	83163	3.7%	23.10	15.3 GB	3.7%	4466.91
Sep 20 10:00:00 - 10:59:59	88249	3.9%	24.51	17.0 GB	4.1%	4953.50
Sep 20 11:00:00 - 11:59:59	84167	3.8%	23.38	15.4 GB	3.7%	4488.13
Sep 20 12:00:00 - 12:59:59	98373	4.4%	27.33	17.5 GB	4.2%	5087.96
Sep 20 13:00:00 - 13:59:59	98675	4.4%	27.41	18.4 GB	4.5%	5349.53
Sep 20 14:00:00 - 14:59:59	98015	4.4%	27.23	18.7 GB	4.6%	5456.05
Sep 20 15:00:00 - 15:59:59	100171	4.5%	27.83	18.8 GB	4.6%	5469.47
Sep 20 16:00:00 - 16:59:59	102471	4.6%	28.46	17.7 GB	4.3%	5159.91
Sep 20 17:00:00 - 17:59:59	103658	4.6%	28.79	17.4 GB	4.2%	5067.75
Sep 20 18:00:00 - 18:59:59	99690	4.5%	27.69	18.6 GB	4.5%	5409.13
Sep 20 19:00:00 - 19:59:59	100247	4.5%	27.85	18.0 GB	4.4%	5237.31
Sep 20 20:00:00 - 20:59:59	99510	4.5%	27.64	18.4 GB	4.5%	5364.22
Sep 20 21:00:00 - 21:59:59	97145	4.3%	26.98	17.9 GB	4.3%	5212.21
Sep 20 22:00:00 - 22:59:59	94174	4.2%	26.16	17.4 GB	4.2%	5080.08
Sep 20 23:00:00 - 23:59:59	91559	4.1%	25.43	17.5 GB	4.3%	5109.51
Sep 21 00:00:00 - 00:59:59	87751	3.9%	24.38	15.4 GB	3.7%	4487.27
Sep 21 01:00:00 - 01:59:59	88707	4.0%	24.64	15.8 GB	3.8%	4602.39
Sep 21 02:00:00 - 02:59:59	87804	3.9%	24.39	16.8 GB	4.1%	4896.91
Sep 21 03:00:00 - 03:00:03	65	0.0%	21.67	13.4 MB	0.0%	4560.75

TOTAL: 23:59:54	2234309	100.0%	25.86	411.5 GB	100.0%	4994.22

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	100.0 GB	72.6%	82	805.92	2.08
02	BIN	137.8 GB	128.7 GB	93.4%	82	834.48	2.00
03	SMALL	13.0 GB	2.5 GB	19.0%	5	5.76	27.47
04	BIN	80.1 GB	76.7 GB	95.7%	51	418.14	2.32
05	BIN	80.1 GB	75.3 GB	94.0%	71	420.67	2.31
06	SMALL	13.0 GB	2.5 GB	18.8%	5	5.84	27.07
07	BIN	80.1 GB	70.2 GB	87.6%	51	416.10	2.34
08	BIN	80.1 GB	70.3 GB	87.7%	71	419.25	2.32
09	SMALL	13.0 GB	2.2 GB	16.8%	5	5.68	27.87
10	BIN	80.1 GB	65.7 GB	82.0%	51	415.54	2.34
11	BIN	80.1 GB	77.9 GB	97.3%	71	420.98	2.31
12	SMALL	13.0 GB	2.4 GB	18.5%	5	5.77	27.40
13	BIN	80.1 GB	64.9 GB	81.0%	51	415.28	2.34
14	BIN	80.1 GB	66.7 GB	83.3%	71	418.66	2.32

TOTAL: 14	-	968.5 GB	805.9 GB	83.2%	672	359.07	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	39235	25110	0	249	0	0	0	0	13876
2	?	23	0	0	0	0	0	0	0	23

TOTAL: 2		39258	25110	0	249	0	0	0	0	13899

Unwanted newsgroups [Top 20]:

Newsgroup	Count

es.binarios.hd	1959
alt.binaries.	1574
alt.binaries.pictures.amateur.butts	1131
alt.binaries.pictures.erotica.asian.female	509
alt.binaries.jerry	385
ccu.bbs.talk.market	231
pedo.japanese.fetish.lolita	214
alt.binaries.erotica.freckles	177
alt.binaries.matrix	167
alt.binaries.pictures.bdcompany	163
alt.binaires.pictures.erotica.male	157
alt.binaries.pictures.erotica.teen.male.masturbation	155
cakewalk.coffeehouse	143
alt.binaries.nonnude	133
alt.bianaries.pictures.erotica.sensualamateurs	127
alt.binaries.lanfer	125
alt.binaries.pictures.erotica.voyeurism.hidden-cam	116
alt.prowling-for-gay-sex	115
rss.fark	113
alt.binaries.erotica.movies.anal.bestpart	111

TOTAL: 2298	25110

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

TOTAL: 2		13903

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	4	17252	790.3 MB	12	0	0	07:18:08
2	ts1-b206.saratov.dial.rol.ru	9	34	6.2 MB	0	0	0	01:18:17
3	ts1-b230.saratov.dial.rol.ru	1	9	20.1 KB	1	0	0	01:29:18

TOTAL: 3		14	17295	796.5 MB	13	0	2	19:25:33

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	4	17252	790.3 MB	12	0	0	07:18:08
2	*.saratov.dial.rol.ru	11	43	6.2 MB	1	0	0	02:52:44
3	*.angarsk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:10:02
4	*.sovintel.net	12	0	0.0 KB	0	0	0	00:00:26
5	*.spb.dial.rol.ru	3	0	0.0 KB	0	0	0	00:00:06
6	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:25
7	*.pcs-net.net	1	0	0.0 KB	0	0	0	00:00:00
8	*.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00
9	*.nsk.dial.rol.ru	38	0	0.0 KB	0	0	0	00:01:08
10	*.kis.ru	1	0	0.0 KB	0	0	0	00:00:47
11	*.moscow.dial.rol.ru	9	0	0.0 KB	0	0	0	00:00:40
12	*.cc.gldn.net	1	0	0.0 KB	0	0	0	00:10:01
13	unresolved	48	0	0.0 KB	0	0	0	07:52:02
14	*.tony.pp.ru	76	0	0.0 KB	0	0	0	00:33:38
15	*.syktyvkar.dial.rol.ru	3	0	0.0 KB	0	0	0	00:01:23
16	*.rol.ru	5822	0	0.0 KB	0	0	0	00:19:59
17	*.nn.ru	32	0	0.0 KB	0	0	0	00:00:19

TOTAL: 17		6064	17295	796.5 MB	13	0	1	19:24:23

NNRP total resource statistics [Top 20]:

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

194.154.66.131	0.064	0.112	0.000	07:52:02
keyhole.sovam.com	13.284	123.312	0.000	07:18:08
ts1-b230.saratov.dial.rol.ru	0.140	0.348	0.000	01:29:18
ts1-b206.saratov.dial.rol.ru	0.036	0.108	0.000	01:18:17
net1-x-ring.tony.pp.ru	37.820	349.290	0.000	00:33:38
ts2-a219.angarsk.dial.rol.ru	0.024	0.016	0.000	00:10:02
balancer-a.rol.ru	3.688	3.804	0.000	00:10:02
nat-ie.cc.gldn.net	0.008	0.000	0.000	00:10:01
balancer-b.rol.ru	3.676	3.844	0.000	00:09:57
ts1-b246.saratov.dial.rol.ru	0.036	0.060	0.000	00:05:09
?	0.008	0.036	0.000	00:02:26
ts2-b11.syktyvkar.dial.rol.ru	0.008	0.036	0.000	00:01:23
82.140.73.76	0.192	0.212	0.000	00:01:02
ts2-b135.nsk.dial.rol.ru	0.012	0.064	0.000	00:00:49
al.kis.ru	0.092	0.108	0.000	00:00:47
ts27-a33.moscow.dial.rol.ru	0.024	0.008	0.000	00:00:31
fw-nat.sovintel.net	0.096	0.060	0.000	00:00:26
news.lek.ru	0.076	0.072	0.000	00:00:25
gray.nn.ru	0.080	0.060	0.000	00:00:19
ts2-a167.nsk.dial.rol.ru	0.012	0.012	0.000	00:00:18

TOTAL: 30	59.468	481.634	0.000	19:25:33

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2912
balancer-a.rol.ru	2910
net1-x-ring.tony.pp.ru	76
194.154.66.131	48
gray.nn.ru	32
ts2-a167.nsk.dial.rol.ru	19
ts2-b135.nsk.dial.rol.ru	19
fw-nat.sovintel.net	12
ts24-a178.moscow.dial.rol.ru	5
ts27-a33.moscow.dial.rol.ru	3
ts2-b11.syktyvkar.dial.rol.ru	3
ts12-a137.spb.dial.rol.ru	3
ts30-b191.moscow.dial.rol.ru	1
al.kis.ru	1
ts1-b246.saratov.dial.rol.ru	1
news.lek.ru	1
news.pcs-net.net	1
ts2-a219.angarsk.dial.rol.ru	1
nat-ie.cc.gldn.net	1
ns1.lavtech.ru	1

TOTAL: 20	6050

NNRP no permission clients:

System	Conn

82.140.73.76	125
cornholio.migtel.ru	13
host-212-145-66-217.spbmts.ru	2
213.24.104.228	1
213.24.104.199	1
m9x.olven.ru	1

TOTAL: 6	143

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	47

TOTAL: 1	47

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	4	0
ts2-a219.angarsk.dial.rol.ru	1	0
nat-ie.cc.gldn.net	1	0

TOTAL: 3	6	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	17252	99.9%
2	fido7	9	0.1%

TOTAL: 2		17261	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	12220
2	alt.binaries.pictures.bras	2585
3	alt.binaries.pictures.artpics	2447
4	fido7.ru.linux	9

TOTAL: 4		17261