Daily Usenet report

Aug 24 03:00:02 -- Aug 25 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 1 / 1 lines (100.0%)
Aug 24 06:11:23 perseus controlchan[16196]: Unknown "cmsg" control by skiing.bbs@bbs.cis.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	620812	93.7%	57.3 MB	92.9%
innd	20251	3.1%	2.2 MB	3.5%
nnrpd	19510	2.9%	1.8 MB	2.9%
cnfsstat	2304	0.3%	397.6 KB	0.6%
controlchan	1	0.0%	0.1 KB	0.0%

TOTAL: 5	662878	100.0%	61.6 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	587588	92.7%
Negative hits	43528	6.9%
Positive hits	1886	0.3%
Cache misses	603	0.1%

TOTAL: 4	633605	100.0%

INND timer:

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

article cancel	00:00:08.762	0.0%	3920	0.000	2.235	799.000
article cleanup	00:00:05.653	0.0%	586332	0.000	0.010	0.036
article logging	00:01:35.718	0.1%	616694	0.000	0.155	17.820
article parse	00:02:58.510	0.2%	42481938	0.000	0.004	0.017
article write	00:54:38.094	3.8%	518621	0.150	6.321	41.579
artlog/artcncl	00:00:00.243	0.0%	3915	0.000	0.062	2.194
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:00:46.562	0.1%	44960256	0.000	0.001	0.006
hisgrep/artcncl	00:00:04.892	0.0%	2446	0.000	2.000	455.000
hishave/artcncl	00:00:02.058	0.0%	3920	0.000	0.525	793.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:11:29.769	0.8%	629882	0.000	1.095	20.624
history sync	00:00:00.274	0.0%	338	0.000	0.811	14.000
history write	00:28:36.944	2.0%	518621	0.011	3.311	32.004
hiswrite/artcncl	00:00:01.544	0.0%	1474	0.000	1.047	662.000
idle	20:48:55.275	86.8%	42228438	0.790	1.775	146.064
nntp read	00:03:33.211	0.2%	42501437	0.000	0.005	0.019
overview write	01:20:57.741	5.6%	518621	0.820	9.367	51.966
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%	1	0.000	0.000	0.000

TOTAL: 23:59:22.253	23:53:55.250	99.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:03:19.354	0.3%	23845	0.000	8.360	27.380
idle	18:14:06.201	96.6%	54427	0.000	1206.133	201014.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:05:15.993	0.5%	162884	0.000	1.940	237.727
readart	00:08:39.760	0.8%	48478	0.000	10.722	87.533

TOTAL: 18:52:55.877	18:31:21.308	98.1%	-	-	-	-

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	940	522957	460366	0	62591	88%	429:52:29

TOTAL: 1		940	522957	460366	0	62591	88%	429:52:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	56.9 GB	151.5 KB	56.9 GB	99%	114.1 KB	429:52:29

TOTAL: 1		56.9 GB	151.5 KB	56.9 GB	99%	114.1 KB	429:52:29

Incoming articles:

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

Aug 24 03:00:02 - 03:59:59	24581	4.7%	6.83	2.7 GB	4.7%	777.75
Aug 24 04:00:00 - 04:59:59	26963	5.2%	7.49	3.3 GB	5.8%	959.10
Aug 24 05:00:00 - 05:59:59	25400	4.9%	7.06	3.4 GB	5.9%	978.27
Aug 24 06:00:00 - 06:59:59	20612	4.0%	5.73	2.3 GB	4.0%	658.07
Aug 24 07:00:00 - 07:59:59	18500	3.6%	5.14	2.4 GB	4.1%	686.62
Aug 24 08:00:00 - 08:59:59	9568	1.8%	2.66	568.5 MB	1.0%	161.71
Aug 24 09:00:00 - 09:59:59	18929	3.6%	5.26	2.9 GB	5.0%	832.79
Aug 24 10:00:00 - 10:59:59	20740	4.0%	5.76	3.2 GB	5.7%	941.57
Aug 24 11:00:00 - 11:59:59	17822	3.4%	4.95	2.5 GB	4.5%	741.55
Aug 24 12:00:00 - 12:59:59	22005	4.2%	6.11	2.8 GB	4.8%	803.11
Aug 24 13:00:00 - 13:59:59	21701	4.2%	6.03	2.9 GB	5.0%	837.39
Aug 24 14:00:00 - 14:59:59	21138	4.1%	5.87	2.6 GB	4.6%	756.32
Aug 24 15:00:00 - 15:59:59	22207	4.3%	6.17	2.6 GB	4.6%	765.91
Aug 24 16:00:00 - 16:59:59	25373	4.9%	7.05	2.5 GB	4.4%	737.03
Aug 24 17:00:00 - 17:59:59	22581	4.4%	6.27	2.2 GB	3.9%	652.98
Aug 24 18:00:00 - 18:59:59	20992	4.0%	5.83	2.1 GB	3.6%	599.65
Aug 24 19:00:00 - 19:59:59	23624	4.6%	6.56	2.5 GB	4.4%	723.59
Aug 24 20:00:00 - 20:59:59	23935	4.6%	6.65	2.2 GB	3.9%	639.03
Aug 24 21:00:00 - 21:59:59	21877	4.2%	6.08	2.1 GB	3.7%	617.39
Aug 24 22:00:00 - 22:59:59	21754	4.2%	6.04	2.2 GB	3.9%	638.62
Aug 24 23:00:00 - 23:59:59	22315	4.3%	6.20	2.0 GB	3.6%	595.94
Aug 25 00:00:00 - 00:59:59	19406	3.7%	5.39	995.1 MB	1.7%	283.05
Aug 25 01:00:00 - 01:59:59	21311	4.1%	5.92	1.8 GB	3.1%	514.85
Aug 25 02:00:00 - 02:59:59	25427	4.9%	7.06	2.3 GB	4.1%	679.79
Aug 25 03:00:00 - 03:00:02	15	0.0%	7.50	1.9 MB	0.0%	958.72

TOTAL: 24:00:00	518776	100.0%	6.00	56.9 GB	100.0%	690.92

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	130.0 GB	94.3%	213	112.87	14.82
02	BIN	137.8 GB	85.3 GB	61.9%	214	112.44	14.88
03	SMALL	13.0 GB	5.7 GB	43.8%	17	4.20	37.63
04	BIN	80.1 GB	74.2 GB	92.7%	164	56.51	17.20
05	BIN	80.1 GB	20.2 GB	25.3%	185	56.76	17.12
06	SMALL	13.0 GB	5.7 GB	43.5%	17	4.17	37.92
07	BIN	80.1 GB	52.9 GB	66.0%	164	57.10	17.02
08	BIN	80.1 GB	1.3 GB	1.6%	185	57.28	16.97
09	SMALL	13.0 GB	4.6 GB	35.6%	17	4.23	37.40
10	BIN	80.1 GB	37.2 GB	46.5%	164	57.03	17.04
11	BIN	80.1 GB	41.3 GB	51.6%	185	56.78	17.12
12	SMALL	13.0 GB	5.5 GB	41.8%	17	4.20	37.63
13	BIN	80.1 GB	34.4 GB	43.0%	164	56.95	17.07
14	BIN	80.1 GB	2.6 GB	3.2%	185	56.89	17.09

TOTAL: 14	-	968.5 GB	501.0 GB	51.7%	1891	49.88	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	98118	60983	0	43	0	0	0	0	37092
2	?	3	0	0	0	0	0	0	0	3

TOTAL: 2		98121	60983	0	43	0	0	0	0	37095

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.dvdrs.pw	14123
alt.binaries.amazing	2235
alt.binaries.pictures.amateur.butts	1166
microsoft.public.test	1162
it.eventi.pechino2008	1135
alt.binaries.amberbigbutt	879
alt.binaries.sandra.model	658
ibm.software.websphere.everyplace	640
alt.binaries.pictures.blonde	525
alt.binaries.wmvhd	509
alt.binaries.pictures.bdstudio	479
alt.binaries.erotica.urine	367
alt.binaries.pictures.erotica.hand-jobs	358
alt.binaries.redhead.males	338
alt.binaries.usenet-world.com	319
alt.binaries.movie	307
alt.binaires.pictures.erotica.male	305
alt.binaries.erotica.french.movie	302
alt.binaries.pictures.erotica.downblouse	249
alt.binaries.erotica.toys	243

TOTAL: 2847	60983

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	30376
	TOTAL: 1	30376

TOTAL: 1		30376

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	7	23845	1.1 GB	24	0	0	17:03:35
2	195.218.244.87	4	28	2.3 MB	3	0	0	00:06:09

TOTAL: 2		11	23873	1.1 GB	27	0	0	18:52:56

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	7	23845	1.1 GB	24	0	0	17:03:35
2	unresolved	7	28	2.3 MB	3	0	0	00:06:10
3	*.sovintel.net	15	0	0.0 KB	0	0	0	00:00:21
4	*.rol.kis.ru	1	0	0.0 KB	0	0	0	00:00:35
5	*.sarov.dial.rol.ru	12	0	0.0 KB	0	0	0	01:22:32
6	*.tony.pp.ru	75	0	0.0 KB	0	0	0	00:02:39
7	*.syktyvkar.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:21
8	*.rol.ru	5764	0	0.0 KB	0	0	0	00:16:08

TOTAL: 8		5882	23873	1.1 GB	27	0	0	18:52:38

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	20.324	208.416	0.000	17:03:35
ts2-a83.sarov.dial.rol.ru	0.012	0.004	0.000	00:30:04
ts2-a219.sarov.dial.rol.ru	0.020	0.012	0.000	00:21:13
ts2-a121.sarov.dial.rol.ru	0.008	0.004	0.000	00:20:02
ts2-a3.sarov.dial.rol.ru	0.032	0.008	0.000	00:10:08
balancer-b.rol.ru	3.472	3.404	0.000	00:08:20
balancer-a.rol.ru	3.468	3.308	0.000	00:07:47
195.218.244.87	0.020	0.012	0.000	00:06:09
net1-x-ring.tony.pp.ru	0.144	0.120	0.000	00:02:39
ts2-a28.sarov.dial.rol.ru	0.000	0.008	0.000	00:01:03
rol10.rol.kis.ru	0.004	0.004	0.000	00:00:35
ts2-a112.syktyvkar.dial.rol.ru	0.020	0.016	0.000	00:00:21
fw-nat.sovintel.net	0.088	0.052	0.000	00:00:21
cornholio.migtel.ru	0.428	0.356	0.000	00:00:16
?	0.004	0.000	0.000	00:00:15
195.98.59.67	0.008	0.008	0.000	00:00:00
87.245.178.164	0.024	0.036	0.000	00:00:00
afontenayssb-151-1-16-183.w82-121.abo.wanadoo.fr	0.004	0.004	0.000	00:00:00
55.16.65.80.ip.morning.ru	0.004	0.000	0.000	00:00:00
83.170.252.39	0.012	0.004	0.000	00:00:00

TOTAL: 20	28.096	215.776	0.000	18:52:56

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2884
balancer-a.rol.ru	2880
net1-x-ring.tony.pp.ru	75
fw-nat.sovintel.net	15
ts2-a219.sarov.dial.rol.ru	4
ts2-a83.sarov.dial.rol.ru	3
195.98.59.67	3
ts2-a3.sarov.dial.rol.ru	2
ts2-a121.sarov.dial.rol.ru	2
ts2-a28.sarov.dial.rol.ru	1
ts2-a112.syktyvkar.dial.rol.ru	1
rol10.rol.kis.ru	1

TOTAL: 12	5871

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	269
87.245.178.164	24
afontenayssb-151-1-16-183.w82-121.abo.wanadoo.fr	3
83.170.252.39	2
55.16.65.80.ip.morning.ru	1

TOTAL: 5	299

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	3

TOTAL: 1	3

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a83.sarov.dial.rol.ru	3	0
ts2-a121.sarov.dial.rol.ru	2	0
ts2-a219.sarov.dial.rol.ru	2	0
ts2-a3.sarov.dial.rol.ru	1	0

TOTAL: 4	8	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	22253	100.0%

TOTAL: 1		22253	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	11147
2	alt.binaries.pictures.bras	9805
3	alt.binaries.pictures.artpics	1273
4	alt.binaries.erotica.pornstars	28

TOTAL: 4		22253