Daily Usenet report

Sep 14 03:00:02 -- Sep 15 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 / 35 lines (14.3%)
Sep 14 04:26:50 perseus controlchan[16499]: Unknown "cmsg" control by beyond.bbs@bbs.cs.nctu.edu.tw
Sep 14 04:46:47 perseus controlchan[16499]: Unknown "cmsg" control by beyond.bbs@bbs.cs.nctu.edu.tw
Sep 14 05:00:45 perseus controlchan[16499]: Unknown "cmsg" control by caroline.bbs@kulu.twbbs.org
Sep 14 06:36:49 perseus controlchan[16499]: Unknown "cmsg" control by feelhappying.bbs@bbs.cs.nctu.edu.tw
Sep 14 08:31:53 perseus controlchan[16499]: Unknown "cmsg" control by jessicawinds.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	572999	87.7%	54.3 MB	88.3%
innd	59748	9.1%	5.2 MB	8.4%
nnrpd	18324	2.8%	1.6 MB	2.7%
cnfsstat	2288	0.4%	391.1 KB	0.6%
controlchan	34	0.0%	3.2 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%

TOTAL: 6	653394	100.0%	61.5 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	545596	92.0%
Negative hits	44533	7.5%
Positive hits	1852	0.3%
Cache misses	749	0.1%

TOTAL: 4	592730	100.0%

INND timer:

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

article cancel	00:00:18.153	0.0%	4661	0.000	3.895	568.667
article cleanup	00:00:05.168	0.0%	543962	0.000	0.010	0.035
article logging	00:01:17.394	0.1%	568452	0.000	0.136	12.369
article parse	00:02:22.793	0.2%	34744125	0.000	0.004	0.009
article write	00:40:51.299	2.8%	466736	0.197	5.252	35.144
artlog/artcncl	00:00:01.074	0.0%	4375	0.000	0.245	10.453
artlog/artparse	00:00:00.000	0.0%	8	0.000	0.000	0.000
data move	00:00:37.068	0.0%	36756700	0.000	0.001	0.003
hisgrep/artcncl	00:00:11.922	0.0%	2481	0.000	4.805	568.667
hishave/artcncl	00:00:00.946	0.0%	4661	0.000	0.203	18.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:09:30.422	0.7%	588546	0.000	0.969	21.833
history sync	00:00:00.507	0.0%	355	0.000	1.428	151.000
history write	00:26:26.223	1.8%	466736	0.004	3.399	42.189
hiswrite/artcncl	00:00:04.178	0.0%	2180	0.000	1.917	21.000
idle	21:19:12.580	88.9%	34576658	0.822	2.220	78.941
nntp read	00:02:51.233	0.2%	34771057	0.000	0.005	0.013
overview write	01:11:28.092	5.0%	466736	0.551	9.187	78.666
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%	34	0.000	0.029	1.000

TOTAL: 23:59:30.222	23:55:19.053	99.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:02:14.754	0.4%	13284	0.000	10.144	24.625
idle	09:47:07.235	96.1%	33050	7.000	1065.877	200941.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:04:06.191	0.7%	98612	0.000	2.497	2712.292
readart	00:05:15.583	0.9%	26710	0.000	11.815	14.609

TOTAL: 10:10:58.302	09:58:43.763	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	1278	624867	539984	8	84875	86%	429:00:54

TOTAL: 1		1278	624867	539984	8	84875	86%	429:00:54

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	42.9 GB	336.5 KB	42.9 GB	99%	72.0 KB	429:00:54

TOTAL: 1		42.9 GB	336.5 KB	42.9 GB	99%	72.0 KB	429:00:54

Incoming articles:

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

Sep 14 03:00:02 - 03:59:59	25820	5.5%	7.18	2.1 GB	5.0%	612.55
Sep 14 04:00:00 - 04:59:59	23481	5.0%	6.52	2.7 GB	6.4%	794.63
Sep 14 05:00:00 - 05:59:59	22616	4.8%	6.28	2.5 GB	5.9%	731.65
Sep 14 06:00:00 - 06:59:59	19982	4.3%	5.55	2.4 GB	5.7%	702.28
Sep 14 07:00:00 - 07:59:59	19429	4.2%	5.40	2.5 GB	5.9%	730.78
Sep 14 08:00:00 - 08:59:59	12440	2.7%	3.46	1.0 GB	2.4%	298.66
Sep 14 09:00:00 - 09:59:59	14895	3.2%	4.14	2.1 GB	5.0%	617.30
Sep 14 10:00:00 - 10:59:59	13543	2.9%	3.76	1.5 GB	3.5%	428.03
Sep 14 11:00:00 - 11:59:59	16189	3.5%	4.50	2.0 GB	4.7%	576.87
Sep 14 12:00:00 - 12:59:59	19150	4.1%	5.32	2.4 GB	5.6%	695.09
Sep 14 13:00:00 - 13:59:59	20566	4.4%	5.71	2.3 GB	5.4%	659.50
Sep 14 14:00:00 - 14:59:59	18554	4.0%	5.15	2.0 GB	4.8%	595.83
Sep 14 15:00:00 - 15:59:59	17773	3.8%	4.94	1.8 GB	4.3%	532.88
Sep 14 16:00:00 - 16:59:59	20783	4.5%	5.77	2.3 GB	5.5%	674.47
Sep 14 17:00:00 - 17:59:59	19245	4.1%	5.35	2.2 GB	5.1%	630.80
Sep 14 18:00:00 - 18:59:59	21565	4.6%	5.99	1.1 GB	2.6%	322.84
Sep 14 19:00:00 - 19:59:59	18827	4.0%	5.23	662.5 MB	1.5%	188.45
Sep 14 20:00:00 - 20:59:59	19782	4.2%	5.50	391.8 MB	0.9%	111.45
Sep 14 21:00:00 - 21:59:59	18246	3.9%	5.07	914.1 MB	2.1%	260.01
Sep 14 22:00:00 - 22:59:59	21227	4.5%	5.90	1.5 GB	3.5%	434.55
Sep 14 23:00:00 - 23:59:59	20950	4.5%	5.82	1.8 GB	4.3%	533.23
Sep 15 00:00:00 - 00:59:59	18026	3.9%	5.01	925.5 MB	2.1%	263.25
Sep 15 01:00:00 - 01:59:59	23721	5.1%	6.59	1.3 GB	3.1%	377.24
Sep 15 02:00:00 - 02:59:59	20036	4.3%	5.57	1.9 GB	4.5%	548.35
Sep 15 03:00:00 - 03:00:02	5	0.0%	2.50	136.8 KB	0.0%	68.38

TOTAL: 24:00:00	466851	100.0%	5.40	42.3 GB	100.0%	513.35

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	13.7 GB	10.0%	215	82.67	20.23
02	BIN	137.8 GB	105.9 GB	76.9%	215	83.00	20.15
03	SMALL	13.0 GB	2.3 GB	17.8%	18	4.74	33.35
04	BIN	80.1 GB	73.7 GB	92.0%	165	41.94	23.18
05	BIN	80.1 GB	19.3 GB	24.1%	186	41.52	23.41
06	SMALL	13.0 GB	2.3 GB	17.4%	18	4.76	33.26
07	BIN	80.1 GB	52.4 GB	65.4%	165	41.78	23.27
08	BIN	80.1 GB	632.9 MB	0.8%	186	41.82	23.24
09	SMALL	13.0 GB	1.3 GB	9.6%	18	4.76	33.25
10	BIN	80.1 GB	36.9 GB	46.0%	165	41.76	23.28
11	BIN	80.1 GB	40.4 GB	50.5%	186	41.71	23.31
12	SMALL	13.0 GB	2.1 GB	15.9%	18	4.74	33.35
13	BIN	80.1 GB	34.2 GB	42.7%	165	41.87	23.21
14	BIN	80.1 GB	2.0 GB	2.5%	186	41.75	23.28

TOTAL: 14	-	968.5 GB	387.0 GB	40.0%	1906	37.08	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	101762	45863	0	111	0	0	0	0	55788
2	?	8	0	0	0	0	0	0	0	8

TOTAL: 2		101770	45863	0	111	0	0	0	0	55796

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.dvdrs.pw	8902
alt.binarieds	3637
alt.binaries.pwp	2100
alt.binaries.movies.dutch	1448
microsoft.public.test	1153
alt.binaries.pictures.amateur.butts	1006
bih.misc.grafika.binaries	862
a.b.dvdr	462
adobe.photoshop.macintosh	389
alt.binaries.game	370
alt.binaries.pictures.erotica.torture.alt.binaries	252
alt.binaries.pictures.eroctica.rape	242
alt.binaries.picture.sex.fetish	236
alt.binaries.pictures.eroctica.torture	234
alt.binaries.pictures.katie	221
alt.binaries.tv.german.dokumentation	213
alt.binaries.pictures.blonde	210
alt.binaries.dvd.classic.movies	205
alt.binaries.warez.ibm	203
alt.binaries.pictures.erotica.rapefiles	198

TOTAL: 1812	45863

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	24506
	TOTAL: 1	24506

TOTAL: 1		24506

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	4	13284	802.1 MB	12	0	0	09:13:41
2	194.186.147.188	1	5	147.5 KB	1	0	0	00:00:29
3	ts18-a151.moscow.dial.rol.ru	1	1	37.2 KB	2	0	0	00:15:47

TOTAL: 3		6	13290	802.3 MB	15	0	0	10:10:58

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	4	13284	802.1 MB	12	0	0	09:13:41
2	unresolved	2	5	147.5 KB	1	0	0	00:01:34
3	*.moscow.dial.rol.ru	8	1	37.2 KB	2	0	0	00:17:32
4	*.sarov.dial.rol.ru	3	0	0.0 KB	0	0	0	00:20:14
5	*.tony.pp.ru	80	0	0.0 KB	0	0	0	00:02:52
6	*.rol.ru	5761	0	0.0 KB	0	0	0	00:14:19

TOTAL: 6		5858	13290	802.3 MB	15	0	0	10:10:57

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	10.356	106.420	0.000	09:13:41
ts18-a151.moscow.dial.rol.ru	0.004	0.012	0.000	00:15:47
ts2-a200.sarov.dial.rol.ru	0.008	0.000	0.000	00:10:11
ts2-a164.sarov.dial.rol.ru	0.000	0.000	0.000	00:10:02
balancer-b.rol.ru	3.436	3.252	0.000	00:07:31
balancer-a.rol.ru	3.576	3.280	0.000	00:06:47
net1-x-ring.tony.pp.ru	0.116	0.132	0.000	00:02:52
ts18-a47.moscow.dial.rol.ru	0.008	0.008	0.000	00:01:44
195.218.244.87	0.008	0.004	0.000	00:01:04
?	0.012	0.004	0.000	00:00:43
194.186.147.188	0.004	0.004	0.000	00:00:29
cornholio.migtel.ru	0.096	0.068	0.000	00:00:01

TOTAL: 12	17.624	113.184	0.000	10:10:58

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2881
balancer-a.rol.ru	2880
net1-x-ring.tony.pp.ru	80
ts18-a47.moscow.dial.rol.ru	7
ts2-a200.sarov.dial.rol.ru	2
ts2-a164.sarov.dial.rol.ru	1
195.218.244.87	1

TOTAL: 7	5852

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	50

TOTAL: 1	50

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	7

TOTAL: 1	7

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a200.sarov.dial.rol.ru	1	0
ts18-a151.moscow.dial.rol.ru	1	0
ts2-a164.sarov.dial.rol.ru	1	0

TOTAL: 3	3	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	12307	100.0%

TOTAL: 1		12307	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	8286
2	alt.binaries.pictures.bras	3045
3	alt.binaries.pictures.artpics	970
4	alt.binaries.nospam.female.bodyhair.pubes	5
5	alt.binaries.erotica.pregnant	1

TOTAL: 5		12307