Daily Usenet report

Dec 13 03:00:01 -- Dec 14 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 client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 16 / 16 lines (100.0%)
Dec 13 04:12:41 andromeda controlchan[26740]: Unknown "cmsg" control by VNNICK.bbs@bbs.cs.nctu.edu.tw
Dec 13 04:13:52 andromeda controlchan[26740]: Unknown "cmsg" control by VNNICK.bbs@bbs.cs.nctu.edu.tw
Dec 13 04:14:36 andromeda controlchan[26740]: Unknown "cmsg" control by VNNICK.bbs@bbs.cs.nctu.edu.tw
Dec 13 07:24:18 andromeda controlchan[26740]: Unknown "cmsg" control by markcupcup.bbs@bbs.cs.nctu.edu.tw
Dec 13 12:00:55 andromeda controlchan[26740]: Unknown "cmsg" control by scsc17.bbs@bbs.math.nctu.edu.tw
Dec 13 12:10:49 andromeda controlchan[26740]: Unknown "cmsg" control by scsc17.bbs@bbs.math.nctu.edu.tw
Dec 13 14:48:06 andromeda controlchan[26740]: Unknown "cmsg" control by idle1001.bbs@bbs.cs.nctu.edu.tw
Dec 13 15:13:07 andromeda controlchan[26740]: Unknown "cmsg" control by allanlai.bbs@bbs.cs.nctu.edu.tw
Dec 13 20:24:55 andromeda innd: buffindexed: overview data is too large 8553
Dec 13 20:27:28 andromeda innd: buffindexed: overview data is too large 8626
Dec 13 20:29:58 andromeda innd: buffindexed: overview data is too large 21588
Dec 13 20:35:17 andromeda innd: buffindexed: overview data is too large 72039
Dec 13 20:35:17 andromeda innd: buffindexed: overview data is too large 72038
Dec 13 20:35:17 andromeda innd: buffindexed: overview data is too large 72039
Dec 13 22:45:32 andromeda innd: buffindexed: overview data is too large 21673
Dec 13 23:43:25 andromeda controlchan[26740]: Unknown "cmsg" control by mathmagician.bbs@bbs.math.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	718468	95.7%	63.6 MB	94.5%
nnrpd	18341	2.4%	1.8 MB	2.7%
innd	11995	1.6%	1.5 MB	2.2%
cnfsstat	2304	0.3%	401.7 KB	0.6%
controlchan	9	0.0%	0.8 KB	0.0%

TOTAL: 5	751117	100.0%	67.4 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	659358	96.3%
Negative hits	21410	3.1%
Positive hits	2944	0.4%
Cache misses	939	0.1%

TOTAL: 4	684651	100.0%

INND timer:

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

article cancel	00:00:07.241	0.0%	7592	0.000	0.954	366.667
article cleanup	00:00:07.780	0.0%	656085	0.000	0.012	0.035
article logging	00:01:00.437	0.1%	711039	0.000	0.085	8.966
article parse	00:01:54.164	0.1%	21451931	0.003	0.005	0.037
article write	00:26:11.939	1.8%	606069	0.277	2.594	12.092
artlog/artcncl	00:00:00.068	0.0%	7293	0.000	0.009	1.000
artlog/artparse	00:00:00.000	0.0%	20	0.000	0.000	0.000
data move	00:00:44.898	0.1%	23909927	0.000	0.002	0.007
hisgrep/artcncl	00:00:04.790	0.0%	3836	0.000	1.249	540.500
hishave/artcncl	00:00:00.376	0.0%	7592	0.000	0.050	9.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:06:10.307	0.4%	677513	0.000	0.547	7.726
history sync	00:00:00.371	0.0%	317	0.000	1.170	2.000
history write	00:12:05.125	0.8%	656039	0.011	1.105	12.338
hiswrite/artcncl	00:00:01.830	0.0%	3756	0.000	0.487	432.000
idle	21:50:07.486	91.0%	21364061	0.000	3.679	9.454
nntp read	00:02:08.113	0.1%	21459666	0.003	0.006	0.035
overview write	01:14:26.965	5.2%	606069	1.371	7.370	35848.000
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%	9	0.000	0.000	0.000

TOTAL: 23:59:59.521	23:55:11.890	99.7%	-	-	-	-

nnrpd timer:

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

idle	00:46:03.915	92.0%	6992	1.750	395.297	201951.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:03:25.459	6.8%	74044	0.000	2.775	0.000
readart	00:00:02.545	0.1%	243	0.000	10.473	0.000

TOTAL: 00:50:03.955	00:49:31.919	98.9%	-	-	-	-

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	1678	686955	634441	2	52512	92%	320:30:08

TOTAL: 1		1678	686955	634441	2	52512	92%	320:30:08

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	29.3 GB	1.4 MB	29.3 GB	99%	44.7 KB	320:30:08

TOTAL: 1		29.3 GB	1.4 MB	29.3 GB	99%	44.7 KB	320:30:08

Incoming articles:

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

Dec 13 03:00:01 - 03:59:59	24123	4.0%	6.70	1.3 GB	4.6%	384.71
Dec 13 04:00:00 - 04:59:59	23242	3.8%	6.46	1.1 GB	3.9%	329.36
Dec 13 05:00:00 - 05:59:59	23603	3.9%	6.56	1.1 GB	4.0%	333.02
Dec 13 06:00:00 - 06:59:59	21572	3.6%	5.99	985.0 MB	3.3%	280.17
Dec 13 07:00:00 - 07:59:59	19846	3.3%	5.51	953.7 MB	3.2%	271.27
Dec 13 08:00:00 - 08:59:59	20572	3.4%	5.71	936.5 MB	3.2%	266.37
Dec 13 09:00:00 - 09:59:59	20211	3.3%	5.61	971.6 MB	3.3%	276.37
Dec 13 10:00:00 - 10:59:59	20006	3.3%	5.56	930.8 MB	3.1%	264.77
Dec 13 11:00:00 - 11:59:59	19630	3.2%	5.45	837.2 MB	2.8%	238.14
Dec 13 12:00:00 - 12:59:59	20904	3.4%	5.81	855.3 MB	2.9%	243.29
Dec 13 13:00:00 - 13:59:59	19819	3.3%	5.51	826.1 MB	2.8%	234.97
Dec 13 14:00:00 - 14:59:59	23550	3.9%	6.54	1.2 GB	4.0%	336.00
Dec 13 15:00:00 - 15:59:59	26964	4.4%	7.49	1.4 GB	4.7%	396.11
Dec 13 16:00:00 - 16:59:59	28772	4.7%	7.99	1.2 GB	4.3%	360.74
Dec 13 17:00:00 - 17:59:59	30306	5.0%	8.42	1.1 GB	3.7%	312.49
Dec 13 18:00:00 - 18:59:59	25942	4.3%	7.21	1.2 GB	4.1%	345.18
Dec 13 19:00:00 - 19:59:59	29027	4.8%	8.06	1.7 GB	5.7%	482.01
Dec 13 20:00:00 - 20:59:59	31851	5.3%	8.85	1.8 GB	6.1%	511.43
Dec 13 21:00:00 - 21:59:59	30168	5.0%	8.38	1.7 GB	5.9%	494.15
Dec 13 22:00:00 - 22:59:59	25735	4.2%	7.15	1.6 GB	5.6%	473.60
Dec 13 23:00:00 - 23:59:59	29239	4.8%	8.12	1.5 GB	5.1%	432.43
Dec 14 00:00:00 - 00:59:59	30855	5.1%	8.57	1.2 GB	4.1%	342.45
Dec 14 01:00:00 - 01:59:59	32215	5.3%	8.95	1.2 GB	4.3%	359.20
Dec 14 02:00:00 - 02:59:59	27971	4.6%	7.77	1.6 GB	5.4%	455.60
Dec 14 03:00:00 - 03:00:02	28	0.0%	14.00	1.4 MB	0.0%	725.54

TOTAL: 24:00:01	606151	100.0%	7.02	28.9 GB	100.0%	351.00

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	13.4 GB	9.7%	195	53.88	31.04
02	BIN	137.8 GB	52.4 GB	38.0%	195	53.65	31.18
03	SMALL	13.0 GB	12.9 GB	98.6%	18	7.82	20.24
04	BIN	80.1 GB	67.3 GB	84.0%	151	26.99	36.02
05	BIN	80.1 GB	52.4 GB	65.4%	168	26.90	36.13
06	SMALL	13.0 GB	12.3 GB	94.0%	18	7.84	20.17
07	BIN	80.1 GB	55.8 GB	69.6%	151	27.00	36.00
08	BIN	80.1 GB	34.7 GB	43.4%	168	26.95	36.07
09	SMALL	13.0 GB	12.3 GB	94.7%	18	7.86	20.14
10	BIN	80.1 GB	49.6 GB	61.9%	151	27.07	35.91
11	BIN	80.1 GB	59.3 GB	74.0%	168	26.99	36.02
12	BIN	13.0 GB	2.4 GB	18.2%	570	27.18	5.82
13	BIN	80.1 GB	12.2 GB	15.3%	93	26.98	36.02
14	SMALL	80.1 GB	14.9 GB	18.6%	2	7.86	123.60

TOTAL: 14	-	968.5 GB	451.8 GB	46.6%	2066	25.38	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	105023	49975	0	46	0	0	0	0	55002
2	?	1	0	0	0	0	0	0	0	1

TOTAL: 2		105024	49975	0	46	0	0	0	0	55003

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pictures.amateur.butts	4906
bellsouth.net.test	2880
alt.binaries.pwp	1712
microsoft.public.test	1149
alt.binaries.nospam.female.short-hair	579
pictures.erotica.lesbians	571
alt.binaires.erotica.teen	567
alt.binaries.dvdrs.pw	548
alt.binaries.pictures.erotica.young.female	523
alt.binaires.pictures.erotica.teens	523
alt.binaries.pictures.erotica.rapefiles	469
alt.binaries.pictures.senior-citizens	450
alt.binaires.erotica	447
alt.binaries.erotica.early-teens	446
alt.binaries.erotic.erotika.young	444
alt.binaries.matrix	429
alt.binaries.pictures.erotica.torture.alt.binaries.pictures.erotica	419
alt.binaries.pictures.erotic.unusual.object.penetrat	406
alt.binaries.alt.binaries.pictures.erotica	376
alt.binaries.b4e.erotica	366

TOTAL: 1487	49975

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	54983
	TOTAL: 1	54983

TOTAL: 1		54983

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	ts18-a102.moscow.dial.rol.ru	12	229	699.5 KB	3	0	0	00:05:47
2	195.218.244.87	2	14	963.7 KB	1	0	0	00:04:07

TOTAL: 2		14	243	1.6 MB	4	0	2	00:50:04

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.moscow.dial.rol.ru	19	229	699.5 KB	3	0	0	00:06:11
2	unresolved	15	14	963.7 KB	1	0	0	00:28:14
3	*.sovam.com	1	0	0.0 KB	0	0	0	00:00:00
4	*.sovintel.net	16	0	0.0 KB	0	0	0	00:00:11
5	*.tony.pp.ru	69	0	0.0 KB	0	0	0	00:02:21
6	*.rol.ru	5760	0	0.0 KB	0	0	0	00:13:05
7	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00

TOTAL: 7		5881	243	1.6 MB	4	0	1	00:50:04

NNRP total resource statistics [Top 20]:

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

195.46.175.106	0.068	0.044	0.000	00:20:34
balancer-b.rol.ru	3.304	3.368	0.000	00:06:41
balancer-a.rol.ru	3.296	3.200	0.000	00:06:23
ts18-a102.moscow.dial.rol.ru	0.096	0.160	0.000	00:05:47
195.218.244.87	0.028	0.032	0.000	00:04:07
82.142.145.84	0.012	0.012	0.000	00:03:31
net1-x-ring.tony.pp.ru	0.104	0.092	0.000	00:02:21
ts18-a114.moscow.dial.rol.ru	0.004	0.012	0.000	00:00:21
fw-nat.sovintel.net	0.088	0.048	0.000	00:00:11
ts18-a218.moscow.dial.rol.ru	0.000	0.000	0.000	00:00:02
cornholio.migtel.ru	0.008	0.008	0.000	00:00:00
89-109-49-139.dynamic.mts-nn.ru	0.000	0.000	0.000	00:00:00
89-109-19-22.dynamic.mts-nn.ru	0.000	0.000	0.000	00:00:00
web02.tr155m.lavtech.ru	0.000	0.004	0.000	00:00:00

TOTAL: 14	7.008	6.980	0.000	00:50:04

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2880
balancer-a.rol.ru	2880
net1-x-ring.tony.pp.ru	69
fw-nat.sovintel.net	16
195.46.175.106	12
ts18-a114.moscow.dial.rol.ru	4
ts18-a218.moscow.dial.rol.ru	3
keyhole.sovam.com	1
82.142.145.84	1
web02.tr155m.lavtech.ru	1

TOTAL: 10	5867

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	5
89-109-49-139.dynamic.mts-nn.ru	2
89-109-19-22.dynamic.mts-nn.ru	1

TOTAL: 3	8

NNRP client timeouts [Top 20]:

System	Conn	Peer

195.46.175.106	1	1

TOTAL: 1	1	1

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	9627	97.7%
2	sci	212	2.2%
3	fido7	17	0.2%

TOTAL: 3		9856	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.bras	9613
2	sci.physics.research	212
3	alt.binaries.erotica.pornstars	14
4	fido7.ru.ufo	10
5	fido7.ru.ufo.talks	7

TOTAL: 5		9856