Daily Usenet report

Aug 11 03:00:05 -- Aug 12 03:00:02

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 / 20 lines (25.0%)
Aug 11 03:43:29 perseus controlchan[31374]: Broken headers in article <cancel.2677.4%Knk.7623$vK2.7430@en-nntp-03.dc1.easynews.com>
Aug 11 03:43:32 perseus controlchan[31374]: Broken headers in article <cancel.bbca.6%Knk.7624$vK2.5279@en-nntp-03.dc1.easynews.com>
Aug 11 05:30:18 perseus controlchan[31374]: Unknown "cmsg" control by yauer.bbs@bbs.cs.nctu.edu.tw
Aug 11 05:30:18 perseus controlchan[31374]: Unknown "cmsg" control by yauer.bbs@bbs.cs.nctu.edu.tw
Aug 11 06:26:49 perseus controlchan[31374]: Broken headers in article <cancel.1db5.coNnk.11748$vK2.4262@en-nntp-03.dc1.easynews.com.mirrorpost.tw.bbs.campus.nctu>

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	701828	87.0%	66.0 MB	88.0%
innd	82732	10.3%	6.9 MB	9.2%
nnrpd	19778	2.5%	1.7 MB	2.3%
cnfsstat	2304	0.3%	394.5 KB	0.5%
controlchan	20	0.0%	1.7 KB	0.0%

TOTAL: 5	806662	100.0%	75.1 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	651723	93.1%
Negative hits	40592	5.8%
Positive hits	6745	1.0%
Cache misses	777	0.1%

TOTAL: 4	699837	100.0%

INND timer:

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

article cancel	00:00:35.664	0.0%	10171	0.000	3.506	785.000
article cleanup	00:00:06.075	0.0%	649612	0.000	0.009	0.029
article logging	00:01:57.264	0.1%	692228	0.000	0.169	15.615
article parse	00:02:27.561	0.2%	35062557	0.001	0.004	0.008
article write	00:56:59.289	4.0%	569869	0.297	6.000	27.087
artlog/artcncl	00:00:03.484	0.0%	9721	0.000	0.358	160.048
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:00:38.870	0.0%	37469757	0.000	0.001	0.002
hisgrep/artcncl	00:00:20.464	0.0%	7325	0.000	2.794	785.000
hishave/artcncl	00:00:05.332	0.0%	10171	0.000	0.524	99.222
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:10:10.159	0.7%	690232	0.000	0.884	18.253
history sync	00:00:00.227	0.0%	309	0.000	0.735	10.000
history write	00:31:02.801	2.2%	569869	0.006	3.269	59.994
hiswrite/artcncl	00:00:06.310	0.0%	2846	0.000	2.217	489.000
idle	20:36:41.997	85.9%	34792254	0.647	2.133	13.731
nntp read	00:02:56.550	0.2%	35072504	0.001	0.005	0.013
overview write	01:31:53.914	6.4%	569869	1.068	9.676	60.494
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%	22	0.000	0.000	0.000

TOTAL: 24:00:15.122	23:56:05.961	99.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:02:10.704	0.3%	17418	0.000	7.504	24.365
idle	13:31:01.904	96.1%	41497	0.000	1172.661	200228.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:07:42.339	0.9%	240707	0.000	1.921	1734.632
readart	00:06:24.361	0.8%	35371	0.000	10.867	836.000

TOTAL: 14:04:03.566	13:47:19.308	98.0%	-	-	-	-

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	810	653772	571570	23	82179	87%	457:31:42

TOTAL: 1		810	653772	571570	23	82179	87%	457:31:42

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	44.3 GB	754.4 KB	44.3 GB	99%	71.1 KB	457:31:42

TOTAL: 1		44.3 GB	754.4 KB	44.3 GB	99%	71.1 KB	457:31:42

Incoming articles:

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

Aug 11 03:00:05 - 03:59:59	24434	4.3%	6.80	2.2 GB	5.0%	646.64
Aug 11 04:00:00 - 04:59:59	23869	4.2%	6.63	2.3 GB	5.2%	667.45
Aug 11 05:00:00 - 05:59:59	24062	4.2%	6.68	2.1 GB	4.8%	621.34
Aug 11 06:00:00 - 06:59:59	21258	3.7%	5.91	1.8 GB	4.0%	519.33
Aug 11 07:00:00 - 07:59:59	22213	3.9%	6.17	1.6 GB	3.5%	453.89
Aug 11 08:00:00 - 08:59:59	23394	4.1%	6.50	1.9 GB	4.3%	553.34
Aug 11 09:00:00 - 09:59:59	18118	3.2%	5.03	1.3 GB	2.9%	376.24
Aug 11 10:00:00 - 10:59:59	23932	4.2%	6.65	1.8 GB	4.1%	522.24
Aug 11 11:00:00 - 11:59:59	23605	4.1%	6.56	1.9 GB	4.2%	542.36
Aug 11 12:00:00 - 12:59:59	23880	4.2%	6.63	2.0 GB	4.5%	584.10
Aug 11 13:00:00 - 13:59:59	23155	4.1%	6.43	2.0 GB	4.5%	576.72
Aug 11 14:00:00 - 14:59:59	21004	3.7%	5.83	1.7 GB	3.8%	484.98
Aug 11 15:00:00 - 15:59:59	20673	3.6%	5.74	1.6 GB	3.5%	451.64
Aug 11 16:00:00 - 16:59:59	26863	4.7%	7.46	1.9 GB	4.4%	565.59
Aug 11 17:00:00 - 17:59:59	25313	4.4%	7.03	2.0 GB	4.5%	582.42
Aug 11 18:00:00 - 18:59:59	25271	4.4%	7.02	1.7 GB	3.9%	498.79
Aug 11 19:00:00 - 19:59:59	24965	4.4%	6.93	1.9 GB	4.4%	563.28
Aug 11 20:00:00 - 20:59:59	24136	4.2%	6.70	2.0 GB	4.5%	577.81
Aug 11 21:00:00 - 21:59:59	24867	4.4%	6.91	1.9 GB	4.4%	566.71
Aug 11 22:00:00 - 22:59:59	24922	4.4%	6.92	1.9 GB	4.4%	563.32
Aug 11 23:00:00 - 23:59:59	23396	4.1%	6.50	1.8 GB	4.1%	524.71
Aug 12 00:00:00 - 00:59:59	20676	3.6%	5.74	1.2 GB	2.7%	351.08
Aug 12 01:00:00 - 01:59:59	30620	5.4%	8.51	1.8 GB	4.0%	521.21
Aug 12 02:00:00 - 02:59:59	25213	4.4%	7.00	1.9 GB	4.4%	567.41
Aug 12 03:00:00 - 03:00:02	10	0.0%	5.00	1.2 MB	0.0%	629.38

TOTAL: 23:59:57	569849	100.0%	6.60	44.2 GB	100.0%	536.77

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	27.5 GB	20.0%	213	86.62	19.31
02	BIN	137.8 GB	121.3 GB	88.0%	213	86.34	19.37
03	SMALL	13.0 GB	193.2 MB	1.4%	17	5.50	28.76
04	BIN	80.1 GB	23.1 GB	28.8%	164	43.70	22.25
05	BIN	80.1 GB	49.3 GB	61.5%	184	43.08	22.56
06	SMALL	13.0 GB	177.3 MB	1.3%	17	5.50	28.77
07	BIN	80.1 GB	1.6 GB	2.0%	164	43.60	22.30
08	BIN	80.1 GB	30.3 GB	37.9%	184	43.74	22.22
09	SMALL	13.0 GB	12.2 GB	93.2%	16	5.47	28.92
10	BIN	80.1 GB	66.1 GB	82.5%	163	43.69	22.25
11	BIN	80.1 GB	70.4 GB	87.9%	184	43.49	22.35
12	SMALL	13.0 GB	13.0 GB	99.6%	16	5.42	29.21
13	BIN	80.1 GB	63.2 GB	78.9%	163	43.50	22.35
14	BIN	80.1 GB	31.6 GB	39.4%	184	43.61	22.29

TOTAL: 14	-	968.5 GB	509.9 GB	52.6%	1882	38.87	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	122272	55926	0	213	0	0	0	0	66133
2	?	3	0	0	0	0	0	0	0	3

TOTAL: 2		122275	55926	0	213	0	0	0	0	66136

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pictures.amateur.butts	2604
alt.binaries.dvdrs.pw	2123
alt.binaries.blu.ray	1891
alt.binaries.cd.games	1480
microsoft.public.test	1152
alt.binaries.amazing	1129
it.eventi.pechino2008	916
alt.binaries.game	740
alt.binaries.new-age	420
alt.binaries.nospam.female.short-hair	370
pictures.erotica.lesbians	348
alt.binaries.movies.dutch.repost	331
alt.binaries.pictures.erotica.breast.large	309
alt.binaries.pictures.erotica.australian	309
alt.binaires.pictures.erotica.male	303
alt.binaries.pictures.latina	280
a.b.sounds.mp3.complete_cd	276
alt.binaires.pictures.erotica.amatuer.female	251
alt.binaries.pictures.erotica.nipples	250
alt.binaries.pictures.erotica.amateur.digicam	244

TOTAL: 3506	55926

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	42559
	TOTAL: 1	42559

TOTAL: 1		42559

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	5	17418	824.7 MB	15	0	0	12:15:51
2	ts2-a46.syktyvkar.dial.rol.ru	8	91	2.6 MB	7	0	0	00:21:10
3	195.218.244.87	2	33	1.7 MB	1	0	0	00:03:00

TOTAL: 3		15	17542	829.0 MB	23	0	0	14:04:03

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	5	17418	824.7 MB	15	0	0	12:15:51
2	*.syktyvkar.dial.rol.ru	8	91	2.6 MB	7	0	0	00:21:10
3	unresolved	3	33	1.7 MB	1	0	0	00:03:01
4	*.sovintel.net	10	0	0.0 KB	0	0	0	00:00:06
5	*.cis.ru	1	0	0.0 KB	0	0	0	00:10:11
6	*.rol.kis.ru	1	0	0.0 KB	0	0	0	00:10:00
7	*.moscow.dial.rol.ru	1	0	0.0 KB	0	0	0	00:10:00
8	*.sarov.dial.rol.ru	7	0	0.0 KB	0	0	0	00:34:08
9	*.tony.pp.ru	71	0	0.0 KB	0	0	0	00:02:38
10	*.rol.ru	5762	0	0.0 KB	0	0	0	00:15:24
11	*.nn.ru	1	0	0.0 KB	0	0	0	00:00:00

TOTAL: 11		5870	17542	829.0 MB	23	0	0	14:03:50

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	12.872	132.802	0.000	12:15:51
ts2-a46.syktyvkar.dial.rol.ru	0.076	0.128	0.000	00:21:10
ts2-a246.sarov.dial.rol.ru	0.004	0.000	0.000	00:20:01
sword.cis.ru	0.096	0.076	0.000	00:10:11
ts18-a81.moscow.dial.rol.ru	0.008	0.000	0.000	00:10:00
rol29.rol.kis.ru	0.000	0.004	0.000	00:10:00
ts2-a39.sarov.dial.rol.ru	0.000	0.000	0.000	00:10:00
balancer-a.rol.ru	3.556	3.404	0.000	00:07:43
balancer-b.rol.ru	3.572	3.276	0.000	00:07:41
195.218.244.87	0.004	0.020	0.000	00:03:00
net1-x-ring.tony.pp.ru	0.128	0.088	0.000	00:02:38
ts2-a166.sarov.dial.rol.ru	0.004	0.000	0.000	00:02:03
ts2-a228.sarov.dial.rol.ru	0.000	0.008	0.000	00:02:02
?	0.008	0.012	0.000	00:01:16
79.111.39.120	0.324	0.268	0.000	00:00:11
fw-nat.sovintel.net	0.064	0.028	0.000	00:00:06
79.111.18.28	0.100	0.096	0.000	00:00:01
cornholio.migtel.ru	0.056	0.028	0.000	00:00:00
195.98.59.67	0.000	0.004	0.000	00:00:00
gray.nn.ru	0.004	0.000	0.000	00:00:00

TOTAL: 21	20.876	140.242	0.000	14:04:03

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2882
balancer-a.rol.ru	2880
net1-x-ring.tony.pp.ru	71
fw-nat.sovintel.net	10
ts2-a246.sarov.dial.rol.ru	2
ts2-a228.sarov.dial.rol.ru	2
ts2-a166.sarov.dial.rol.ru	2
sword.cis.ru	1
rol29.rol.kis.ru	1
gray.nn.ru	1
ts2-a39.sarov.dial.rol.ru	1
195.98.59.67	1
ts18-a81.moscow.dial.rol.ru	1

TOTAL: 13	5855

NNRP no permission clients:

System	Conn

79.111.39.120	207
79.111.18.28	76
cornholio.migtel.ru	33
80.251.115.148	1

TOTAL: 4	317

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	14

TOTAL: 1	14

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a246.sarov.dial.rol.ru	2	0
sword.cis.ru	1	0
rol29.rol.kis.ru	1	0
ts2-a39.sarov.dial.rol.ru	1	0
ts2-a46.syktyvkar.dial.rol.ru	1	0
ts18-a81.moscow.dial.rol.ru	1	0

TOTAL: 6	7	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	17537	100.0%

TOTAL: 1		17537	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.bras	8232
2	alt.binaries.pictures.erotica.vintage	7591
3	alt.binaries.pictures.artpics	1590
4	alt.binaries.nospam.female.bodyhair	71
5	alt.binaries.erotica.pornstars	33
6	alt.binaries.nospam.female.bodyhair.pubes	20

TOTAL: 6		17537