Daily Usenet report

Sep 14 03:00:03 -- Sep 15 03:00:02

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 / 126 lines (4.0%)
Sep 14 04:20:12 perseus controlchan[28453]: Unknown "cmsg" control by freestyle1.bbs@bbs.wretch.cc
Sep 14 05:10:22 perseus controlchan[28453]: Unknown "cmsg" control by gohometc.bbs@bbs.wretch.cc
Sep 14 06:23:13 perseus controlchan[28453]: Unknown "cmsg" control by leetzuwen.bbs@bbs.cs.nctu.edu.tw
Sep 14 06:50:15 perseus controlchan[28453]: Unknown "cmsg" control by Tsairong.bbs@bbs.wretch.cc
Sep 14 06:50:16 perseus controlchan[28453]: Unknown "cmsg" control by Tsairong.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2301219	97.6%	203.5 MB	97.1%
innd	33351	1.4%	3.7 MB	1.8%
nnrpd	21095	0.9%	2.0 MB	1.0%
cnfsstat	2304	0.1%	397.9 KB	0.2%
controlchan	132	0.0%	13.4 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%

TOTAL: 6	2358102	100.0%	209.6 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2289893	98.1%
Negative hits	41072	1.8%
Positive hits	2429	0.1%
Cache misses	1951	0.1%

TOTAL: 4	2335345	100.0%

INND timer:

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

article cancel	00:02:51.782	0.2%	23495	0.000	7.311	1825.000
article cleanup	00:00:25.725	0.0%	2267280	0.005	0.011	0.022
article logging	00:02:45.439	0.2%	2278328	0.003	0.073	5.115
article parse	00:19:40.964	1.4%	166776467	0.005	0.007	0.029
article write	10:27:53.925	43.6%	2236565	4.510	16.845	66.226
artlog/artcncl	00:00:01.089	0.0%	22646	0.000	0.048	16.000
artlog/artparse	00:00:00.001	0.0%	56	0.000	0.018	0.500
data move	00:03:50.041	0.3%	176610988	0.001	0.001	0.003
hisgrep/artcncl	00:02:18.603	0.2%	4286	0.000	32.339	1825.000
hishave/artcncl	00:00:24.770	0.0%	23495	0.000	1.054	226.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:25:26.904	1.8%	2314104	0.001	0.660	19.440
history sync	00:00:00.298	0.0%	289	0.000	1.031	3.000
history write	00:53:55.635	3.7%	2236565	0.025	1.447	11.093
hiswrite/artcncl	00:00:07.167	0.0%	19209	0.000	0.373	408.500
idle	06:38:25.847	27.7%	156361189	0.128	0.153	0.746
nntp read	00:21:34.377	1.5%	165038895	0.006	0.008	0.023
overview write	04:19:00.851	18.0%	2236565	1.288	6.949	122.077
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%	123	0.000	0.016	0.125

TOTAL: 23:59:40.600	23:38:43.420	98.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:16:27.505	0.6%	31461	0.000	31.388	1021.000
idle	39:02:35.659	89.2%	122963	0.000	1143.073	201310.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	03:14:06.192	7.4%	689579	0.000	16.889	10046.642
readart	00:28:04.441	1.1%	66120	0.000	25.476	753.000

TOTAL: 43:47:29.046	43:01:13.797	98.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

control-microsoft@trigofacile.com	6	0	0	0	0	6
jfellison@yahoo.com	1	0	0	0	0	1

TOTAL	7	0	0	0	0	7

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	324	2293183	2260441	0	32742	98%	489:17:12

TOTAL: 1		324	2293183	2260441	0	32742	98%	489:17:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	416.2 GB	3.5 MB	416.2 GB	99%	190.3 KB	489:17:12

TOTAL: 1		416.2 GB	3.5 MB	416.2 GB	99%	190.3 KB	489:17:12

Incoming articles:

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

Sep 14 03:00:03 - 03:59:59	100238	4.5%	27.87	18.6 GB	4.4%	5414.71
Sep 14 04:00:00 - 04:59:59	92469	4.1%	25.69	17.4 GB	4.2%	5058.83
Sep 14 05:00:00 - 05:59:59	87214	3.9%	24.23	16.6 GB	4.0%	4831.26
Sep 14 06:00:00 - 06:59:59	80375	3.6%	22.33	15.3 GB	3.7%	4456.18
Sep 14 07:00:00 - 07:59:59	87199	3.9%	24.22	16.9 GB	4.0%	4909.41
Sep 14 08:00:00 - 08:59:59	88751	4.0%	24.65	17.2 GB	4.1%	5004.12
Sep 14 09:00:00 - 09:59:59	87652	3.9%	24.35	17.0 GB	4.1%	4962.51
Sep 14 10:00:00 - 10:59:59	84865	3.8%	23.57	16.1 GB	3.8%	4681.37
Sep 14 11:00:00 - 11:59:59	91820	4.1%	25.51	16.9 GB	4.0%	4920.84
Sep 14 12:00:00 - 12:59:59	95431	4.3%	26.51	18.4 GB	4.4%	5373.50
Sep 14 13:00:00 - 13:59:59	100868	4.5%	28.02	18.4 GB	4.4%	5371.23
Sep 14 14:00:00 - 14:59:59	98693	4.4%	27.41	18.7 GB	4.5%	5436.31
Sep 14 15:00:00 - 15:59:59	94409	4.2%	26.22	18.3 GB	4.4%	5328.60
Sep 14 16:00:00 - 16:59:59	96251	4.3%	26.74	18.1 GB	4.3%	5259.10
Sep 14 17:00:00 - 17:59:59	95308	4.3%	26.47	18.2 GB	4.4%	5299.88
Sep 14 18:00:00 - 18:59:59	98274	4.4%	27.30	17.1 GB	4.1%	4989.99
Sep 14 19:00:00 - 19:59:59	95106	4.3%	26.42	17.0 GB	4.1%	4939.97
Sep 14 20:00:00 - 20:59:59	100061	4.5%	27.79	17.9 GB	4.3%	5210.99
Sep 14 21:00:00 - 21:59:59	99387	4.4%	27.61	18.3 GB	4.4%	5319.30
Sep 14 22:00:00 - 22:59:59	95527	4.3%	26.54	18.2 GB	4.4%	5313.29
Sep 14 23:00:00 - 23:59:59	93389	4.2%	25.94	17.3 GB	4.1%	5031.29
Sep 15 00:00:00 - 00:59:59	87670	3.9%	24.35	16.2 GB	3.9%	4719.94
Sep 15 01:00:00 - 01:59:59	88889	4.0%	24.69	16.0 GB	3.8%	4673.58
Sep 15 02:00:00 - 02:59:59	96901	4.3%	26.92	18.3 GB	4.4%	5327.02
Sep 15 03:00:00 - 03:00:02	54	0.0%	27.00	11.8 MB	0.0%	6052.44

TOTAL: 23:59:59	2236801	100.0%	25.89	418.3 GB	100.0%	5076.40

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	91.1 GB	66.1%	79	813.68	2.06
02	BIN	137.8 GB	116.6 GB	84.6%	79	818.79	2.04
03	SMALL	13.0 GB	12.8 GB	98.5%	4	5.41	29.23
04	BIN	80.1 GB	25.1 GB	31.3%	49	424.34	2.29
05	BIN	80.1 GB	22.2 GB	27.8%	69	427.98	2.27
06	SMALL	13.0 GB	12.8 GB	98.2%	4	5.39	29.35
07	BIN	80.1 GB	19.5 GB	24.4%	49	423.87	2.29
08	BIN	80.1 GB	17.9 GB	22.3%	69	427.12	2.28
09	SMALL	13.0 GB	12.6 GB	96.3%	4	5.38	29.41
10	BIN	80.1 GB	15.5 GB	19.3%	49	423.17	2.30
11	BIN	80.1 GB	24.5 GB	30.6%	69	428.46	2.27
12	SMALL	13.0 GB	12.8 GB	97.9%	4	5.37	29.45
13	BIN	80.1 GB	14.9 GB	18.6%	49	422.60	2.30
14	BIN	80.1 GB	14.4 GB	18.0%	69	426.62	2.28

TOTAL: 14	-	968.5 GB	412.6 GB	42.6%	646	364.01	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	41760	30558	0	151	0	0	0	0	11051
2	?	56	0	0	0	0	0	0	0	56

TOTAL: 2		41816	30558	0	151	0	0	0	0	11107

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.oz	2801
alt.binaries.pictures.erotica.asian.female	1274
alt.binaries.pictures.amateur.butts	711
alt.binaries.pictures.erotica.feti	497
alt.binaries.pictures.eroctica.rape	494
alt.binaries.pictures.eroctica.torture	483
alt.binaries.pictures.erotic.unusual.object.penetrat	472
alt.binaries.pictures.bdcompany	424
alt.binaries.amateur.gangbang	424
alt.binaries.erotica.freckles	368
alt.binaries.cd.highspeed	283
alt.binaries.erotica.erotica.bisexuals	265
alt.binaries.pictures.erotica.fetish.urine	252
alt.binaries.pictures.fetish.urine	238
adobe.indesign.windows	224
allt.sex.fetish	213
alt.binaries.pictures.senior-citizens	206
corel.PaintShopProPhotoX2	203
alt.binaries.pictures.black.erotica	202
alt.binaries.pictures.black.erotica.females	202

TOTAL: 2684	30558

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	18
	TOTAL: 1	18
Including strange strings
	192.168.33.37	11051
	TOTAL: 1	11051

TOTAL: 2		11069

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	6	30685	1.2 GB	18	0	0	21:12:50
2	ts1-b224.saratov.dial.rol.ru	233	895	40.0 MB	0	0	0	08:24:53
3	ts16-a205.moscow.dial.rol.ru	5	16	652.4 KB	8	0	0	00:20:47
4	ts1-a168.saratov.dial.rol.ru	1	13	27.7 KB	1	0	0	01:26:54
5	194.154.66.183	4	5	190.2 KB	15	0	0	00:13:24
6	ts1-a35.saratov.dial.rol.ru	1	1	2.4 KB	1	0	0	01:40:14

TOTAL: 6		250	31615	1.3 GB	43	0	2	46:21:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	6	30685	1.2 GB	18	0	0	21:12:50
2	*.saratov.dial.rol.ru	235	909	40.1 MB	2	0	0	11:32:03
3	*.moscow.dial.rol.ru	22	16	652.4 KB	8	0	0	00:34:32
4	unresolved	78	5	190.2 KB	15	0	0	11:58:56
5	*.angarsk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:41
6	*.sovintel.net	23	0	0.0 KB	0	0	0	00:00:47
7	*.cis.ru	1	0	0.0 KB	0	0	0	00:11:49
8	*.spb.dial.rol.ru	4	0	0.0 KB	0	0	0	00:00:27
9	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:02
10	*.pcs-net.net	1	0	0.0 KB	0	0	0	00:00:00
11	*.nsk.dial.rol.ru	19	0	0.0 KB	0	0	0	00:00:12
12	*.sarov.dial.rol.ru	18	0	0.0 KB	0	0	0	00:08:22
13	*.tony.pp.ru	113	0	0.0 KB	0	0	0	00:17:20
14	*.rol.ru	5825	0	0.0 KB	0	0	0	00:21:01
15	*.nn.ru	105	0	0.0 KB	0	0	0	00:00:25
16	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:01

TOTAL: 16		6453	31615	1.3 GB	43	0	1	46:21:39

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	21.344	187.228	0.000	21:12:50
194.154.66.131	0.096	0.104	0.000	11:45:31
ts1-b224.saratov.dial.rol.ru	0.468	0.836	0.000	08:24:53
ts1-a35.saratov.dial.rol.ru	0.132	0.204	0.000	01:40:14
ts1-a168.saratov.dial.rol.ru	0.188	0.420	0.000	01:26:54
ts16-a205.moscow.dial.rol.ru	0.024	0.036	0.000	00:20:47
net1-x-ring.tony.pp.ru	14.308	135.545	0.000	00:17:20
194.154.66.183	0.028	0.028	0.000	00:13:24
sword.cis.ru	0.112	0.100	0.000	00:11:49
ts28-a73.moscow.dial.rol.ru	0.140	0.136	0.000	00:11:33
balancer-b.rol.ru	3.684	3.504	0.000	00:10:32
balancer-a.rol.ru	3.780	3.672	0.000	00:10:29
ts2-a143.sarov.dial.rol.ru	0.008	0.012	0.000	00:07:21
?	0.008	0.036	0.000	00:02:04
ts24-b134.moscow.dial.rol.ru	0.028	0.020	0.000	00:01:01
ts2-a220.sarov.dial.rol.ru	0.012	0.024	0.000	00:01:00
ts24-b251.moscow.dial.rol.ru	0.008	0.008	0.000	00:00:57
fw-nat.sovintel.net	0.184	0.104	0.000	00:00:47
ts2-a208.angarsk.dial.rol.ru	0.016	0.008	0.000	00:00:41
ts5-b46.spb.dial.rol.ru	0.004	0.012	0.000	00:00:27

TOTAL: 32	44.872	332.413	0.000	46:21:40

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2914
balancer-a.rol.ru	2911
net1-x-ring.tony.pp.ru	113
gray.nn.ru	105
194.154.66.131	72
fw-nat.sovintel.net	23
ts2-a131.nsk.dial.rol.ru	19
ts24-b134.moscow.dial.rol.ru	10
ts2-a220.sarov.dial.rol.ru	10
ts2-a143.sarov.dial.rol.ru	8
ts5-b46.spb.dial.rol.ru	4
ts24-b251.moscow.dial.rol.ru	4
194.186.71.137	2
ts23-a210.moscow.dial.rol.ru	2
sword.cis.ru	1
news.lek.ru	1
ts2-a208.angarsk.dial.rol.ru	1
news.pcs-net.net	1
cappa.tr155m.lavtech.ru	1
ts28-a73.moscow.dial.rol.ru	1

TOTAL: 20	6203

NNRP no permission clients:

System	Conn

89.109.34.190	2
89-109-50-29.dynamic.mts-nn.ru	1
83.167.116.18	1
cornholio.migtel.ru	1
82.200.241.63	1

TOTAL: 5	6

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	34

TOTAL: 1	34

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	10	0
sword.cis.ru	1	0
194.154.66.183	1	0
ts1-a168.saratov.dial.rol.ru	1	0
ts16-a205.moscow.dial.rol.ru	1	0

TOTAL: 5	14	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	30569	100.0%
2	fido7	14	0.0%

TOTAL: 2		30583	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	24089
2	alt.binaries.pictures.artpics	3917
3	alt.binaries.pictures.bras	2542
4	fido7.ru.linux	14
5	alt.binaries.erotica.pregnant	12
6	alt.binaries.pictures.erotica.pinups	4
7	alt.binaries.pictures.lolita	2
8	alt.binaries.erotica.uncut	1
9	alt.binaries.nospam.incest	1
10	alt.binaries.erotica.pregnant-movies	1

TOTAL: 10		30583