Daily Usenet report

Oct 30 03:00:04 -- Oct 31 03:00:03

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
Newsgroups created
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 / 39 lines (12.8%)
Oct 30 05:40:26 perseus controlchan[13641]: Unknown "cmsg" control by maimaiwu.bbs@bbs.wretch.cc
Oct 30 05:40:26 perseus controlchan[13641]: Unknown "cmsg" control by meegi.bbs@bbs.wretch.cc
Oct 30 05:40:26 perseus controlchan[13641]: Unknown "cmsg" control by meegi.bbs@bbs.wretch.cc
Oct 30 05:50:29 perseus controlchan[13641]: Unknown "cmsg" control by Oxygen.bbs@bbs.wretch.cc
Oct 30 05:50:29 perseus controlchan[13641]: Unknown "cmsg" control by Oxygen.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2288749	98.4%	200.4 MB	97.7%
nnrpd	19445	0.8%	2.0 MB	1.0%
innd	15948	0.7%	2.2 MB	1.1%
cnfsstat	2304	0.1%	400.5 KB	0.2%
controlchan	56	0.0%	5.9 KB	0.0%
expireover	1	0.0%	0.1 KB	0.0%

TOTAL: 6	2326503	100.0%	205.1 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2284904	97.5%
Negative hits	49923	2.1%
Positive hits	6686	0.3%
Cache misses	2336	0.1%

TOTAL: 4	2343849	100.0%

INND timer:

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

article cancel	00:00:55.648	0.1%	9892	0.000	5.626	795.000
article cleanup	00:00:25.223	0.0%	2266056	0.003	0.011	0.021
article logging	00:02:20.017	0.2%	2278020	0.004	0.061	3.833
article parse	00:19:57.528	1.4%	163145559	0.005	0.007	0.023
article write	11:02:27.374	46.0%	2237876	2.591	17.761	1583.883
artlog/artcncl	00:00:00.101	0.0%	9707	0.000	0.010	1.000
artlog/artparse	00:00:00.001	0.0%	78	0.000	0.013	1.000
data move	00:03:48.316	0.3%	172704149	0.001	0.001	0.003
hisgrep/artcncl	00:00:49.283	0.1%	8718	0.000	5.653	795.000
hishave/artcncl	00:00:04.202	0.0%	9892	0.000	0.425	181.800
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:22:11.961	1.5%	2334334	0.000	0.571	10.760
history sync	00:00:00.310	0.0%	290	0.000	1.069	3.000
history write	00:56:41.387	3.9%	2237876	0.028	1.520	12.974
hiswrite/artcncl	00:00:01.982	0.0%	1174	0.000	1.688	321.000
idle	06:04:54.216	25.4%	152300781	0.128	0.144	6.377
nntp read	00:21:45.978	1.5%	161311765	0.006	0.008	0.017
overview write	04:21:05.628	18.1%	2237876	0.957	7.000	131.114
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%	41	0.000	0.000	0.000

TOTAL: 23:59:12.840	23:37:29.155	98.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:54:06.161	4.6%	145789	0.000	22.266	71.001
idle	14:08:36.878	72.4%	299131	0.000	170.216	200385.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:09:48.072	6.0%	1136363	0.000	3.686	119405.154
readart	01:39:45.306	8.5%	318129	0.000	18.814	440.000

TOTAL: 19:31:28.954	17:52:16.417	91.5%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Newsgroups created:

Group	Mode

comp.file-sharing.bittorrent	y
misc.phone.mobile	y
misc.phone.mobile.iphone	y
rec.arts.tv.news.oreilly-factor	y

TOTAL	4

Newsgroups removed:

Group

comp.file-sharing.bittorrent
comp.internet.services.blog.livejournal
comp.internet.services.google
comp.internet.services.social.myspace
comp.internet.services.video.youtube
comp.unix.bsd.bsdi.announce
misc.phone.mobile
misc.phone.mobile.iphone
rec.arts.tv.news.oreilly-factor

TOTAL: 9

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

group-admin@isc.org	4	1	0	0	5	5

TOTAL	4	1	0	0	5	5

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	349	2260708	2234245	121	26342	98%	474:11:56

TOTAL: 1		349	2260708	2234245	121	26342	98%	474:11:56

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	428.3 GB	4.1 MB	428.3 GB	99%	198.7 KB	474:11:56

TOTAL: 1		428.3 GB	4.1 MB	428.3 GB	99%	198.7 KB	474:11:56

Incoming articles:

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

Oct 30 03:00:04 - 03:59:59	88075	3.9%	24.49	17.4 GB	4.1%	5085.20
Oct 30 04:00:00 - 04:59:59	85877	3.8%	23.85	17.3 GB	4.1%	5048.03
Oct 30 05:00:00 - 05:59:59	83639	3.7%	23.23	16.6 GB	3.9%	4836.41
Oct 30 06:00:00 - 06:59:59	78274	3.5%	21.74	15.5 GB	3.6%	4517.21
Oct 30 07:00:00 - 07:59:59	85660	3.8%	23.79	16.7 GB	3.9%	4877.18
Oct 30 08:00:00 - 08:59:59	85492	3.8%	23.75	17.2 GB	4.0%	5011.27
Oct 30 09:00:00 - 09:59:59	85062	3.8%	23.63	17.3 GB	4.1%	5042.53
Oct 30 10:00:00 - 10:59:59	84489	3.8%	23.47	16.9 GB	4.0%	4918.04
Oct 30 11:00:00 - 11:59:59	87625	3.9%	24.34	15.7 GB	3.7%	4572.61
Oct 30 12:00:00 - 12:59:59	103301	4.6%	28.69	18.7 GB	4.4%	5436.99
Oct 30 13:00:00 - 13:59:59	99011	4.4%	27.50	19.2 GB	4.5%	5600.35
Oct 30 14:00:00 - 14:59:59	97120	4.3%	26.98	18.9 GB	4.4%	5511.04
Oct 30 15:00:00 - 15:59:59	98897	4.4%	27.47	18.5 GB	4.3%	5388.40
Oct 30 16:00:00 - 16:59:59	99263	4.4%	27.57	18.9 GB	4.5%	5517.17
Oct 30 17:00:00 - 17:59:59	101396	4.5%	28.17	18.7 GB	4.4%	5438.68
Oct 30 18:00:00 - 18:59:59	99644	4.5%	27.68	18.7 GB	4.4%	5432.26
Oct 30 19:00:00 - 19:59:59	101985	4.6%	28.33	18.5 GB	4.3%	5378.51
Oct 30 20:00:00 - 20:59:59	100337	4.5%	27.87	18.6 GB	4.4%	5429.02
Oct 30 21:00:00 - 21:59:59	98265	4.4%	27.30	18.8 GB	4.4%	5469.02
Oct 30 22:00:00 - 22:59:59	99679	4.5%	27.69	18.6 GB	4.4%	5423.14
Oct 30 23:00:00 - 23:59:59	99210	4.4%	27.56	18.3 GB	4.3%	5322.66
Oct 31 00:00:00 - 00:59:59	100258	4.5%	27.85	17.0 GB	4.0%	4965.56
Oct 31 01:00:00 - 01:59:59	87630	3.9%	24.34	16.3 GB	3.8%	4749.63
Oct 31 02:00:00 - 02:59:59	88504	4.0%	24.58	16.9 GB	4.0%	4914.62
Oct 31 03:00:00 - 03:00:03	85	0.0%	28.33	17.9 MB	0.0%	6111.19

TOTAL: 23:59:59	2238778	100.0%	25.91	425.3 GB	100.0%	5161.93

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	87.7 GB	63.6%	102	856.90	1.95
02	BIN	137.8 GB	132.1 GB	95.8%	102	867.37	1.93
03	SMALL	13.0 GB	9.1 GB	69.6%	6	6.98	22.66
04	BIN	80.1 GB	9.2 GB	11.5%	69	432.36	2.25
05	BIN	80.1 GB	15.7 GB	19.6%	89	434.08	2.24
06	SMALL	13.0 GB	9.0 GB	69.4%	6	6.95	22.77
07	BIN	80.1 GB	79.3 GB	99.1%	68	430.92	2.26
08	BIN	80.1 GB	7.0 GB	8.8%	89	433.46	2.24
09	SMALL	13.0 GB	8.7 GB	66.5%	6	6.93	22.82
10	BIN	80.1 GB	71.9 GB	89.8%	68	429.80	2.26
11	BIN	80.1 GB	20.8 GB	26.0%	89	435.97	2.23
12	SMALL	13.0 GB	9.0 GB	68.9%	6	6.94	22.79
13	BIN	80.1 GB	70.0 GB	87.4%	68	428.99	2.27
14	BIN	80.1 GB	3.7 GB	4.6%	89	432.98	2.24

TOTAL: 14	-	968.5 GB	533.2 GB	55.1%	857	372.43	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	40186	27998	0	184	0	0	0	0	12004
2	?	78	0	0	0	0	0	0	0	78

TOTAL: 2		40264	27998	0	184	0	0	0	0	12082

Unwanted newsgroups [Top 20]:

Newsgroup	Count

microsoft.public.test	1222
alt.binaries.pictures.amateur.butts	562
alt.binaries.pictures.erotica.asian.female	328
alt.binaries.pictures.erotica.nipples	264
alt.binaries.pictures.erotica.voyeurism.hid	247
alt.binaries.pictures.erotica.female.redheads	192
alt.binaries.pictures.erotica.pictures	192
alt.binaries.pictures.erotica.voyeuris	180
alt.binaries.pictures.erotica.goo-shot	180
alt.binaries.pictures.erotica.breast.saggy	175
alt.binaries.lanfer	174
alt.binaires.erotica	171
alt.binaries.erotica.strap-on-sex	171
cuhk.society.bhall	157
alt.binaries.girlfriends	157
stu.virus	156
alt.binaries.pictures.erotica.highheels	154
alt.binaries.erotica.homemade	153
alt.binaries.pictures.erotica.voyeurism.neighbor	151
alt.biniaries.erotica	146

TOTAL: 1956	27998

INND misc events:

Events	Count

CCreader	1

TOTAL: 1	1

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	11976
	TOTAL: 1	11976

TOTAL: 1		11976

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	24	145789	9.7 GB	75	0	0	16:56:02
2	ts2-a167.syktyvkar.dial.rol.ru	7	11	952.5 KB	6	0	0	00:46:03
3	ts2-a129.syktyvkar.dial.rol.ru	5	5	588.0 KB	3	0	0	01:08:19

TOTAL: 3		36	145805	9.7 GB	84	0	0	19:56:47

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	24	145789	9.7 GB	75	0	0	16:56:02
2	*.syktyvkar.dial.rol.ru	12	16	1.5 MB	9	0	0	01:54:22
3	*.moscow.dial.rol.ru	23	0	0.0 KB	0	0	0	00:00:48
4	*.barnaul.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:00
5	*.bytecity.ru	2	0	0.0 KB	0	0	0	00:00:00
6	*.sovintel.net	17	0	0.0 KB	0	0	0	00:00:42
7	*.cis.ru	1	0	0.0 KB	0	0	0	00:15:10
8	*.sarov.dial.rol.ru	2	0	0.0 KB	0	0	0	00:10:48
9	unresolved	2	0	0.0 KB	0	0	0	00:10:03
10	*.186.49.80.adsl-spb.net.rol.ru	2	0	0.0 KB	0	0	0	00:00:31
11	*.tony.pp.ru	77	0	0.0 KB	0	0	0	00:03:24
12	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:04
13	*.pcs-net.net	1	0	0.0 KB	0	0	0	00:00:01
14	*.rol.ru	5800	0	0.0 KB	0	0	0	00:22:18
15	*.nn.ru	24	0	0.0 KB	0	0	0	00:00:19
16	*.nnovgorod.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:00
17	*.nsk.dial.rol.ru	14	0	0.0 KB	0	0	0	00:00:18

TOTAL: 17		6004	145805	9.7 GB	84	0	0	19:56:31

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	87.160	765.250	0.000	16:56:02
ts2-a129.syktyvkar.dial.rol.ru	0.036	0.052	0.000	01:08:19
ts2-a167.syktyvkar.dial.rol.ru	0.008	0.020	0.000	00:46:03
sword.cis.ru	0.164	0.056	0.000	00:15:10
balancer-a.rol.ru	3.636	3.748	0.000	00:11:16
balancer-b.rol.ru	3.696	3.820	0.000	00:11:01
ts2-a244.sarov.dial.rol.ru	0.036	0.000	0.000	00:10:48
194.186.71.137	0.024	0.004	0.000	00:10:03
net1-x-ring.tony.pp.ru	0.112	0.204	0.000	00:03:24
?	0.024	0.012	0.000	00:01:33
fw-nat.sovintel.net	0.124	0.056	0.000	00:00:42
194.186.49.80.adsl-spb.net.rol.ru	0.236	0.324	0.000	00:00:31
ts23-b222.moscow.dial.rol.ru	0.016	0.000	0.000	00:00:23
gray.nn.ru	0.032	0.064	0.000	00:00:19
ts2-a172.nsk.dial.rol.ru	0.028	0.028	0.000	00:00:18
ts23-a165.moscow.dial.rol.ru	0.008	0.000	0.000	00:00:10
cornholio.migtel.ru	0.136	0.156	0.000	00:00:10
ts27-b63.moscow.dial.rol.ru	0.012	0.008	0.000	00:00:09
ts23-b87.moscow.dial.rol.ru	0.012	0.012	0.000	00:00:04
news.lek.ru	0.064	0.044	0.000	00:00:04

TOTAL: 35	95.644	773.914	0.000	19:56:47

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2916
balancer-a.rol.ru	2884
net1-x-ring.tony.pp.ru	77
gray.nn.ru	24
fw-nat.sovintel.net	17
ts2-a172.nsk.dial.rol.ru	14
ts27-b63.moscow.dial.rol.ru	8
ts23-b87.moscow.dial.rol.ru	6
ts23-a165.moscow.dial.rol.ru	5
ts23-b222.moscow.dial.rol.ru	4
194.186.71.137	2
ts2-a244.sarov.dial.rol.ru	2
194.186.49.80.adsl-spb.net.rol.ru	2
news.bytecity.ru	2
sword.cis.ru	1
news.pcs-net.net	1
news.lek.ru	1
ts1-a113.barnaul.dial.rol.ru	1
ts4-a198.nnovgorod.dial.rol.ru	1

TOTAL: 19	5968

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	88
83.149.32.87	5
gw-bnat8.vzletka.net	2
gw-bnat5.vzletka.net	1
83.220.64.111	1
83.220.64.15	1
195.28.36.242	1
89.109.60.150	1
gw-bnat7.vzletka.net	1
83.167.116.18	1
ppp78-36-96-49.pppoe.komi.dslavangard.ru	1
77.51.57.203	1

TOTAL: 12	104

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	28

TOTAL: 1	28

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a167.syktyvkar.dial.rol.ru	5	0
ts2-a129.syktyvkar.dial.rol.ru	2	0
sword.cis.ru	1	0
194.186.71.137	1	0
ts2-a244.sarov.dial.rol.ru	1	0

TOTAL: 5	10	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	145189	100.0%

TOTAL: 1		145189	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	121590
2	alt.binaries.pictures.artpics	14441
3	alt.binaries.pictures.bras	9144
4	alt.binaries.nospam.female.bodyhair	11
5	alt.binaries.nospam.female.bodyhair.pubes	3

TOTAL: 5		145189