Daily Usenet report

Sep 10 03:00:02 -- Sep 11 03:00:06

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
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 / 82 lines (6.1%)
Sep 10 06:00:13 perseus controlchan[28453]: Unknown "cmsg" control by FMD.bbs@bbs.wretch.cc
Sep 10 06:10:20 perseus controlchan[28453]: Unknown "cmsg" control by Zeit.bbs@bbs.wretch.cc
Sep 10 06:22:19 perseus controlchan[28453]: Unknown "cmsg" control by yhchang.bbs@kulu.twbbs.org
Sep 10 06:40:21 perseus controlchan[28453]: Unknown "cmsg" control by richard168.bbs@bbs.wretch.cc
Sep 10 06:40:21 perseus controlchan[28453]: Unknown "cmsg" control by dragon0147.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2052772	97.7%	181.8 MB	97.2%
innd	24947	1.2%	2.9 MB	1.6%
nnrpd	20314	1.0%	2.0 MB	1.1%
cnfsstat	2304	0.1%	399.2 KB	0.2%
controlchan	83	0.0%	8.7 KB	0.0%
expireover	1	0.0%	0.2 KB	0.0%

TOTAL: 6	2100421	100.0%	187.1 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2042080	98.1%
Negative hits	35854	1.7%
Positive hits	1972	0.1%
Cache misses	1146	0.1%

TOTAL: 4	2081052	100.0%

INND timer:

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

article cancel	00:01:25.065	0.1%	13037	0.000	6.525	1574.000
article cleanup	00:00:23.034	0.0%	2027354	0.003	0.011	0.024
article logging	00:02:55.698	0.2%	2040544	0.003	0.086	4.416
article parse	00:17:19.234	1.2%	161044661	0.004	0.006	0.020
article write	08:58:26.314	37.4%	2000250	4.679	16.151	24.936
artlog/artcncl	00:00:00.277	0.0%	12773	0.000	0.022	8.364
artlog/artparse	00:00:00.000	0.0%	21	0.000	0.000	0.000
data move	00:03:32.223	0.2%	170500936	0.001	0.001	0.003
hisgrep/artcncl	00:01:14.738	0.1%	2988	0.000	25.013	2052.000
hishave/artcncl	00:00:03.197	0.0%	13037	0.000	0.245	139.833
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:20:57.848	1.5%	2068991	0.000	0.608	8.214
history sync	00:00:00.295	0.0%	291	0.000	1.014	3.000
history write	00:52:15.727	3.6%	2000250	0.024	1.568	12.192
hiswrite/artcncl	00:00:06.771	0.0%	10049	0.000	0.674	17.040
idle	08:41:06.342	36.2%	153042472	0.127	0.204	0.811
nntp read	00:19:18.082	1.3%	159839500	0.005	0.007	0.019
overview write	04:00:04.698	16.7%	2000250	0.841	7.201	110.795
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%	81	0.000	0.012	0.333

TOTAL: 24:00:26.435	23:39:09.544	98.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:32:25.648	2.1%	35660	0.000	54.561	80.215
idle	23:03:04.611	88.9%	114069	0.000	727.495	201350.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:58:57.979	3.8%	360753	0.000	9.807	11378.323
readart	00:38:24.919	2.5%	75436	0.000	30.555	619.000

TOTAL: 25:56:06.996	25:12:53.157	97.2%	-	-	-	-

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

news@news.cs.nctu.edu.tw	1	0	0	0	0	1
newsmaster@carnet.hr	0	1	0	0	0	1

TOTAL	1	1	0	0	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	328	2008284	1982597	4	25683	98%	471:59:31

TOTAL: 1		328	2008284	1982597	4	25683	98%	471:59:31

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	369.9 GB	1.5 MB	369.9 GB	99%	193.2 KB	471:59:31

TOTAL: 1		369.9 GB	1.5 MB	369.9 GB	99%	193.2 KB	471:59:31

Incoming articles:

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

Sep 10 03:00:02 - 03:59:59	89047	4.5%	24.75	16.9 GB	4.6%	4913.14
Sep 10 04:00:00 - 04:59:59	88137	4.4%	24.48	16.7 GB	4.5%	4858.99
Sep 10 05:00:00 - 05:59:59	85081	4.3%	23.63	16.9 GB	4.6%	4935.68
Sep 10 06:00:00 - 06:59:59	80805	4.0%	22.45	16.1 GB	4.4%	4685.84
Sep 10 07:00:00 - 07:59:59	86771	4.3%	24.10	17.0 GB	4.6%	4961.78
Sep 10 08:00:00 - 08:59:59	83825	4.2%	23.28	16.6 GB	4.5%	4841.70
Sep 10 09:00:00 - 09:59:59	85012	4.3%	23.61	17.0 GB	4.6%	4956.70
Sep 10 10:00:00 - 10:59:59	85028	4.3%	23.62	16.1 GB	4.4%	4697.84
Sep 10 11:00:00 - 11:59:59	92132	4.6%	25.59	17.9 GB	4.8%	5219.95
Sep 10 12:00:00 - 12:59:59	94522	4.7%	26.26	18.3 GB	4.9%	5323.76
Sep 10 13:00:00 - 13:59:59	81659	4.1%	22.68	15.1 GB	4.1%	4400.01
Sep 10 14:00:00 - 14:59:59	76683	3.8%	21.30	13.9 GB	3.8%	4060.57
Sep 10 15:00:00 - 15:59:59	78799	3.9%	21.89	14.6 GB	3.9%	4241.85
Sep 10 16:00:00 - 16:59:59	81880	4.1%	22.74	14.1 GB	3.8%	4106.40
Sep 10 17:00:00 - 17:59:59	76838	3.8%	21.34	13.1 GB	3.6%	3829.55
Sep 10 18:00:00 - 18:59:59	73706	3.7%	20.47	13.1 GB	3.5%	3802.10
Sep 10 19:00:00 - 19:59:59	78556	3.9%	21.82	13.2 GB	3.6%	3832.93
Sep 10 20:00:00 - 20:59:59	77704	3.9%	21.58	13.6 GB	3.7%	3962.55
Sep 10 21:00:00 - 21:59:59	75551	3.8%	20.99	13.0 GB	3.5%	3800.49
Sep 10 22:00:00 - 22:59:59	77966	3.9%	21.66	13.1 GB	3.5%	3804.83
Sep 10 23:00:00 - 23:59:59	81277	4.1%	22.58	14.2 GB	3.8%	4130.87
Sep 11 00:00:00 - 00:59:59	86801	4.3%	24.11	15.3 GB	4.1%	4459.69
Sep 11 01:00:00 - 01:59:59	90306	4.5%	25.09	16.4 GB	4.4%	4764.91
Sep 11 02:00:00 - 02:59:59	91545	4.6%	25.43	17.5 GB	4.7%	5094.25
Sep 11 03:00:00 - 03:00:06	72	0.0%	12.00	11.8 MB	0.0%	2021.57

TOTAL: 24:00:04	1999703	100.0%	23.14	369.7 GB	100.0%	4486.75

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	92.6 GB	67.2%	77	746.09	2.24
02	BIN	137.8 GB	116.5 GB	84.5%	77	749.78	2.23
03	SMALL	13.0 GB	11.1 GB	84.8%	4	5.09	31.06
04	BIN	80.1 GB	48.0 GB	59.9%	47	375.10	2.59
05	BIN	80.1 GB	44.3 GB	55.3%	67	376.25	2.58
06	SMALL	13.0 GB	11.0 GB	84.6%	4	5.10	31.01
07	BIN	80.1 GB	42.8 GB	53.4%	47	374.90	2.59
08	BIN	80.1 GB	40.2 GB	50.2%	67	375.70	2.59
09	SMALL	13.0 GB	10.8 GB	82.8%	4	5.07	31.19
10	BIN	80.1 GB	39.1 GB	48.8%	47	374.95	2.59
11	BIN	80.1 GB	46.4 GB	57.9%	67	376.65	2.58
12	SMALL	13.0 GB	11.0 GB	84.3%	4	5.08	31.16
13	BIN	80.1 GB	38.6 GB	48.2%	47	374.69	2.59
14	BIN	80.1 GB	36.8 GB	46.0%	67	375.83	2.59

TOTAL: 14	-	968.5 GB	589.0 GB	60.8%	626	323.51	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	40276	26973	0	128	0	0	0	0	13175
2	?	21	0	0	0	0	0	0	0	21

TOTAL: 2		40297	26973	0	128	0	0	0	0	13196

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pictures.amateur.butts	1028
alt.binaries.pictures.erotica.asian.female	395
alt.binaires.pictures.erotica.male	182
alt.binaries.picture.erotica.anal	173
alt.binaries.pictures.erotica.bisexual	170
alt.binaries.pictures.erotica.breats	168
corel.PaintShopProPhotoX2	161
alt.binaries.erotica.kinky.teens	158
alt.binaires.pictures.erotica.butts	154
alt.binaries.erotica.strap-on-sex	151
alt.binaires.erotica.teen	149
alt.binaries.pictures.senior-citizens	148
alt.binaries.erotica.freckles	148
alt.binaires.erotica	147
alt.binaries.erotica.amateur.male	143
alt.binaries.pictures.erotica.cum-shots	143
alt.binaries.pictures.erotica.dicks	143
alt.binaries.pictures.erotica.breast.large	142
alt.binaries.erotica.beastiality	141
alt.binaries.erotica.voyerism.hidden-camera	140

TOTAL: 1950	26973

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	16
	TOTAL: 1	16
Including strange strings
	192.168.33.37	13175
	TOTAL: 1	13175

TOTAL: 2		13191

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	5	35654	4.4 GB	15	0	0	14:26:33
2	ts18-a67.moscow.dial.rol.ru	6	105	8.5 MB	5	0	0	01:12:48
3	dynip.195.98.62.141.dialup.kis.ru	4	39	1.5 MB	1	0	0	00:21:36
4	ts2-b172.syktyvkar.dial.rol.ru	3	6	316.8 KB	1	0	0	00:11:32
5	ts2-b134.syktyvkar.dial.rol.ru	3	3	566.8 KB	2	0	0	00:12:35
6	ts24-a155.moscow.dial.rol.ru	1	0	0.0 KB	0	16	0	00:01:06

TOTAL: 6		22	35807	4.4 GB	24	16	0	25:55:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	5	35654	4.4 GB	15	0	0	14:26:33
2	*.moscow.dial.rol.ru	53	105	8.5 MB	5	16	0	01:30:52
3	*.195.98.62.141.dialup.kis.ru	4	39	1.5 MB	1	0	0	00:21:36
4	*.syktyvkar.dial.rol.ru	9	9	883.7 KB	3	0	0	00:35:03
5	*.omsk.dial.rol.ru	10	0	0.0 KB	0	0	0	00:02:26
6	*.sovintel.net	17	0	0.0 KB	0	0	0	00:00:18
7	*.micex.ru	2	0	0.0 KB	0	0	0	00:10:18
8	unresolved	53	0	0.0 KB	0	0	0	08:10:09
9	*.spb.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:01
10	*.tony.pp.ru	78	0	0.0 KB	0	0	0	00:12:34
11	*.rol.ru	5832	0	0.0 KB	0	0	0	00:19:48
12	*.nn.ru	43	0	0.0 KB	0	0	0	00:00:08
13	*.bryansk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:01
14	*.nsk.dial.rol.ru	19	0	0.0 KB	0	0	0	00:00:14

TOTAL: 14		6127	35807	4.4 GB	24	16	0	25:53:39

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	19.368	171.038	0.000	14:26:33
194.154.66.131	0.072	0.088	0.000	08:09:58
ts18-a67.moscow.dial.rol.ru	0.020	0.092	0.000	01:12:48
dynip.195.98.62.141.dialup.kis.ru	0.016	0.064	0.000	00:21:36
ts24-b143.moscow.dial.rol.ru	0.044	0.016	0.000	00:13:41
ts2-b134.syktyvkar.dial.rol.ru	0.012	0.008	0.000	00:12:35
net1-x-ring.tony.pp.ru	9.512	94.209	0.000	00:12:34
ts2-b172.syktyvkar.dial.rol.ru	0.004	0.012	0.000	00:11:32
ts2-b208.syktyvkar.dial.rol.ru	0.016	0.024	0.000	00:10:55
heap.micex.ru	0.048	0.044	0.000	00:10:18
balancer-a.rol.ru	3.704	3.520	0.000	00:09:54
balancer-b.rol.ru	3.700	3.740	0.000	00:09:53
?	0.028	0.044	0.000	00:03:30
ts2-a17.omsk.dial.rol.ru	0.012	0.012	0.000	00:02:26
ts24-b96.moscow.dial.rol.ru	0.004	0.000	0.000	00:01:21
ts24-a155.moscow.dial.rol.ru	0.000	0.008	0.000	00:01:06
ts27-b245.moscow.dial.rol.ru	0.000	0.000	0.000	00:01:06
82.140.73.76	0.220	0.236	0.000	00:00:51
ts24-b190.moscow.dial.rol.ru	0.004	0.004	0.000	00:00:50
fw-nat.sovintel.net	0.192	0.056	0.000	00:00:18

TOTAL: 37	37.116	273.391	0.000	25:55:28

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2923
balancer-b.rol.ru	2909
net1-x-ring.tony.pp.ru	78
194.154.66.131	51
gray.nn.ru	43
ts24-b143.moscow.dial.rol.ru	20
ts2-a236.nsk.dial.rol.ru	19
fw-nat.sovintel.net	17
ts24-b37.moscow.dial.rol.ru	11
ts2-a17.omsk.dial.rol.ru	10
ts24-b55.moscow.dial.rol.ru	9
ts2-b208.syktyvkar.dial.rol.ru	3
ts23-a94.moscow.dial.rol.ru	3
heap.micex.ru	2
195.46.175.141	1
ts24-b190.moscow.dial.rol.ru	1
ts1-a223.spb.dial.rol.ru	1
194.186.71.137	1
ts24-b10.moscow.dial.rol.ru	1
ts27-b245.moscow.dial.rol.ru	1

TOTAL: 22	6106

NNRP no permission clients:

System	Conn

82.140.73.76	144
cornholio.migtel.ru	9
ts23-b37.moscow.dial.rol.ru	6
ts24-b190.moscow.dial.rol.ru	3
host-214-145-66-217.spbmts.ru	3
89-109-24-130.dynamic.mts-nn.ru	1
91.123.28.136	1
195.28.36.242	1
83.220.64.77	1

TOTAL: 9	169

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	58

TOTAL: 1	58

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	6	0
heap.micex.ru	2	0
ts2-b172.syktyvkar.dial.rol.ru	1	0
ts2-b208.syktyvkar.dial.rol.ru	1	0
ts24-b143.moscow.dial.rol.ru	1	0
ts2-b134.syktyvkar.dial.rol.ru	1	0
dynip.195.98.62.141.dialup.kis.ru	1	0

TOTAL: 7	13	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	35690	100.0%

TOTAL: 1		35690	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	29309
2	alt.binaries.pictures.artpics	3562
3	alt.binaries.pictures.bras	2666
4	alt.binaires.pictures.erotica.teen.female	49
5	alt.binaries.pictures.erotica.amateur.girlfriends	39
6	alt.sex.pantyhose	31
7	alt.binaries.erotica.pre-teen	24
8	alt.binaries.nospam.female.bodyhair	9
9	alt.binaries.erotica.teen.female.nude	1

TOTAL: 9		35690