Daily Usenet report

Jan 27 03:00:05 -- Jan 28 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
INND misc events
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 5 / 32 lines (15.6%)
Jan 27 06:10:20 andromeda controlchan[30296]: Unknown "cmsg" control by wabbler.bbs@bbs.wretch.cc
Jan 27 06:41:08 andromeda controlchan[30296]: Unknown "cmsg" control by forever3.bbs@bbs.wretch.cc
Jan 27 07:10:21 andromeda controlchan[30296]: Unknown "cmsg" control by kiddd.bbs@bbs.wretch.cc
Jan 27 07:46:12 andromeda controlchan[30296]: Unknown "cmsg" control by Jer.bbs@kulu.twbbs.org
Jan 27 07:55:13 andromeda innd: buffindexed: overview data is too large 41615

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2147226	98.1%	191.0 MB	97.4%
nnrpd	23758	1.1%	2.3 MB	1.2%
innd	15722	0.7%	2.3 MB	1.2%
cnfsstat	2304	0.1%	405.3 KB	0.2%
controlchan	15	0.0%	1.7 KB	0.0%

TOTAL: 5	2189025	100.0%	196.0 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2136175	98.0%
Negative hits	39791	1.8%
Positive hits	3112	0.1%
Cache misses	1297	0.1%

TOTAL: 4	2180375	100.0%

INND timer:

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

article cancel	00:01:39.930	0.1%	11627	0.000	8.595	1274.000
article cleanup	00:00:31.365	0.0%	2124891	0.002	0.015	0.027
article logging	00:02:35.976	0.2%	2136241	0.004	0.073	4.000
article parse	00:20:47.303	1.4%	153951618	0.006	0.008	0.054
article write	09:05:30.100	37.9%	2092521	3.074	15.641	31.450
artlog/artcncl	00:00:03.553	0.0%	11187	0.000	0.318	50.525
artlog/artparse	00:00:00.000	0.0%	59	0.000	0.000	0.000
data move	00:05:26.363	0.4%	163902563	0.001	0.002	0.009
hisgrep/artcncl	00:01:27.149	0.1%	4130	0.000	21.101	1274.000
hishave/artcncl	00:00:02.690	0.0%	11627	0.000	0.231	876.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:21:32.636	1.5%	2170417	0.001	0.596	15.770
history sync	00:00:00.405	0.0%	291	0.000	1.392	3.000
history write	00:52:01.017	3.6%	2124461	0.030	1.469	18.571
hiswrite/artcncl	00:00:04.907	0.0%	7497	0.000	0.655	231.333
idle	07:36:14.137	31.7%	144783400	0.038	0.189	0.660
nntp read	00:23:09.557	1.6%	152742252	0.007	0.009	0.060
overview write	04:37:46.273	19.3%	2092521	2.890	7.965	628.982
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%	15	0.000	0.067	1.000

TOTAL: 24:00:04.875	23:28:53.362	97.8%	-	-	-	-

nnrpd timer:

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

hisgrep	00:07:28.363	0.9%	52501	0.000	8.540	51.024
idle	12:30:57.957	89.1%	111923	0.000	402.580	160895.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:26:08.786	3.1%	336537	0.000	4.662	9382.455
readart	00:32:26.234	3.8%	107324	0.000	18.134	106.250

TOTAL: 14:02:42.894	13:37:01.340	97.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	413	2152662	2105885	37	46740	97%	472:04:42

TOTAL: 1		413	2152662	2105885	37	46740	97%	472:04:42

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	384.4 GB	3.5 MB	384.4 GB	99%	187.3 KB	472:04:42

TOTAL: 1		384.4 GB	3.5 MB	384.4 GB	99%	187.3 KB	472:04:42

Incoming articles:

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

Jan 27 03:00:05 - 03:59:59	87066	4.2%	24.22	17.1 GB	4.4%	4999.14
Jan 27 04:00:00 - 04:59:59	83177	4.0%	23.10	16.5 GB	4.3%	4819.00
Jan 27 05:00:00 - 05:59:59	67439	3.2%	18.73	13.1 GB	3.4%	3810.34
Jan 27 06:00:00 - 06:59:59	68330	3.3%	18.98	13.8 GB	3.6%	4027.72
Jan 27 07:00:00 - 07:59:59	85578	4.1%	23.77	17.1 GB	4.4%	4975.22
Jan 27 08:00:00 - 08:59:59	92102	4.4%	25.58	18.3 GB	4.7%	5324.16
Jan 27 09:00:00 - 09:59:59	88321	4.2%	24.53	17.7 GB	4.6%	5149.27
Jan 27 10:00:00 - 10:59:59	92056	4.4%	25.57	18.9 GB	4.9%	5499.16
Jan 27 11:00:00 - 11:59:59	88907	4.2%	24.70	17.5 GB	4.5%	5097.54
Jan 27 12:00:00 - 12:59:59	88925	4.3%	24.70	17.3 GB	4.5%	5036.32
Jan 27 13:00:00 - 13:59:59	96078	4.6%	26.69	18.2 GB	4.7%	5297.27
Jan 27 14:00:00 - 14:59:59	93730	4.5%	26.04	16.9 GB	4.4%	4927.46
Jan 27 15:00:00 - 15:59:59	93817	4.5%	26.06	15.8 GB	4.1%	4590.82
Jan 27 16:00:00 - 16:59:59	91457	4.4%	25.40	15.7 GB	4.1%	4574.78
Jan 27 17:00:00 - 17:59:59	90409	4.3%	25.11	15.7 GB	4.0%	4561.44
Jan 27 18:00:00 - 18:59:59	89606	4.3%	24.89	15.9 GB	4.1%	4619.42
Jan 27 19:00:00 - 19:59:59	85699	4.1%	23.81	15.3 GB	4.0%	4459.12
Jan 27 20:00:00 - 20:59:59	82539	3.9%	22.93	14.3 GB	3.7%	4163.96
Jan 27 21:00:00 - 21:59:59	87389	4.2%	24.27	14.9 GB	3.8%	4333.88
Jan 27 22:00:00 - 22:59:59	88592	4.2%	24.61	15.3 GB	4.0%	4469.49
Jan 27 23:00:00 - 23:59:59	88270	4.2%	24.52	15.1 GB	3.9%	4412.51
Jan 28 00:00:00 - 00:59:59	84494	4.0%	23.47	14.7 GB	3.8%	4274.59
Jan 28 01:00:00 - 01:59:59	89135	4.3%	24.76	16.3 GB	4.2%	4739.93
Jan 28 02:00:00 - 02:59:59	89085	4.3%	24.75	15.8 GB	4.1%	4613.90
Jan 28 03:00:00 - 03:00:02	61	0.0%	30.50	10.0 MB	0.0%	5135.41

TOTAL: 23:59:57	2092262	100.0%	24.22	387.2 GB	100.0%	4699.01

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	34.4 GB	24.9%	120	754.54	2.22
02	BIN	137.8 GB	58.5 GB	42.4%	120	772.97	2.16
03	SMALL	13.0 GB	6.5 GB	50.1%	8	4.90	32.28
04	BIN	80.1 GB	36.6 GB	45.7%	87	394.05	2.47
05	BIN	80.1 GB	12.2 GB	15.2%	104	394.50	2.46
06	SMALL	13.0 GB	6.1 GB	47.2%	8	4.90	32.32
07	BIN	80.1 GB	30.1 GB	37.6%	87	393.51	2.47
08	BIN	80.1 GB	3.9 GB	4.8%	104	393.48	2.47
09	SMALL	13.0 GB	6.2 GB	47.9%	8	4.87	32.49
10	BIN	80.1 GB	26.2 GB	32.7%	87	393.35	2.47
11	BIN	80.1 GB	18.6 GB	23.3%	104	394.84	2.46
12	BIN	13.0 GB	4.0 GB	31.0%	175	393.18	0.40
13	BIN	80.1 GB	50.5 GB	63.1%	28	393.86	2.47
14	SMALL	80.1 GB	38.5 GB	48.1%	0	4.90	198.26

TOTAL: 14	-	968.5 GB	332.5 GB	34.3%	1040	338.52	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	43719	31938	0	256	0	0	0	0	11525
2	?	59	0	0	0	0	0	0	0	59

TOTAL: 2		43778	31938	0	256	0	0	0	0	11584

Unwanted newsgroups [Top 20]:

Newsgroup	Count

microsoft.public.test	1392
alt.binaries.pictures.amateur.butts	987
alt.binaries.pictures.erotica.asian.female	508
alt.binaries.usenet-world.com	404
alt.binaries.the-portal	345
cn.bbs.soc.railway	312
alt.binaries.pictures.maxwell	278
alt.binaries.picture.erotica.amature	214
alt.binaries.erotica.kinky.teens	206
alt.binaries.pictures.erotica.breast.large	203
alt.binaries.pictures.erotica.voyerism	195
alt.binaries.pictures.erotica.erotic	193
alt.binaries.picturea.erotica	190
alt.binaries.pictures.erotica.commercial-website	187
alt.binaries.pictuers.erotica.female	186
alt.binaries.pictures.erotica.female.ejaculation	186
alt.binaries.pictures.erotica.early-teen	185
alt.binaries.erotica.tasteless	185
alt.binaries.pictures.erotica.breast.saggy	183
alt.binaries.pictures.erotica.breats	182

TOTAL: 2288	31938

INND misc events:

Events	Count

CCreader	1

TOTAL: 1	1

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	11351
	TOTAL: 1	11351

TOTAL: 2		11369

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	5	52501	3.3 GB	18	0	0	12:22:18
2	ts30-b220.moscow.dial.rol.ru	16	131	480.0 KB	11	0	0	00:12:15
3	ts2-b76.syktyvkar.dial.rol.ru	3	12	611.4 KB	2	0	0	00:04:47
4	ts18-b217.moscow.dial.rol.ru	6	9	1.1 MB	12	0	0	00:33:20
5	ts18-a130.moscow.dial.rol.ru	1	3	75.6 KB	1	0	0	00:10:03
6	195.218.244.87	2	2	188.9 KB	1	0	0	00:08:29

TOTAL: 6		33	52658	3.3 GB	45	0	2	14:01:18

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	5	52501	3.3 GB	18	0	0	12:22:18
2	*.moscow.dial.rol.ru	24	143	1.6 MB	24	0	0	00:55:49
3	*.syktyvkar.dial.rol.ru	22	12	611.4 KB	2	0	0	00:07:16
4	unresolved	2	2	188.9 KB	1	0	0	00:08:29
5	*.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00
6	*.nsk.dial.rol.ru	13	0	0.0 KB	0	0	0	00:00:06
7	*.tony.pp.ru	72	0	0.0 KB	0	0	0	00:03:14
8	*.rol.ru	5769	0	0.0 KB	0	0	0	00:21:35
9	*.nn.ru	5	0	0.0 KB	0	0	0	00:00:04

TOTAL: 9		5913	52658	3.3 GB	45	0	1	13:59:32

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	23.472	45.444	0.000	12:22:18
ts18-b217.moscow.dial.rol.ru	0.184	0.148	0.000	00:33:20
ts30-b220.moscow.dial.rol.ru	0.048	0.056	0.000	00:12:15
balancer-a.rol.ru	3.544	3.816	0.000	00:11:00
balancer-b.rol.ru	3.540	3.932	0.000	00:10:34
ts18-a130.moscow.dial.rol.ru	0.008	0.024	0.000	00:10:03
195.218.244.87	0.012	0.008	0.000	00:08:29
ts2-b76.syktyvkar.dial.rol.ru	0.020	0.068	0.000	00:04:47
net1-x-ring.tony.pp.ru	0.116	0.200	0.000	00:03:14
ts2-b226.syktyvkar.dial.rol.ru	0.072	0.056	0.000	00:02:28
cornholio.migtel.ru	1.980	2.196	0.000	00:01:44
?	0.008	0.012	0.000	00:00:36
ts18-a41.moscow.dial.rol.ru	0.004	0.004	0.000	00:00:09
ts2-a3.nsk.dial.rol.ru	0.004	0.016	0.000	00:00:06
delta.nn.ru	0.000	0.008	0.000	00:00:03
gray.nn.ru	0.004	0.016	0.000	00:00:01
ppp78-37-209-215.pppoe.avangarddsl.ru	0.004	0.004	0.000	00:00:00
89-179-9-221.broadband.corbina.ru	0.000	0.004	0.000	00:00:00
ns1.lavtech.ru	0.000	0.004	0.000	00:00:00

TOTAL: 19	33.020	56.016	0.000	14:01:18

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2885
balancer-b.rol.ru	2884
net1-x-ring.tony.pp.ru	72
ts2-b226.syktyvkar.dial.rol.ru	19
ts2-a3.nsk.dial.rol.ru	13
gray.nn.ru	3
delta.nn.ru	2
ts18-a41.moscow.dial.rol.ru	1
ns1.lavtech.ru	1

TOTAL: 9	5880

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	1336
ppp78-37-209-215.pppoe.avangarddsl.ru	2
89-179-9-221.broadband.corbina.ru	1

TOTAL: 3	1339

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts18-b217.moscow.dial.rol.ru	1	0

TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	50178	99.7%
2	yu	70	0.1%
3	clari	42	0.1%
4	list	13	0.0%
5	hr	6	0.0%

TOTAL: 5		50309	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	38151
2	alt.binaries.pictures.artpics	6035
3	alt.binaries.pictures.bras	5966
4	yu.forum.politika	70
5	clari.web.biz.stocks	21
6	list.linguist	13
7	alt.binaries.nospam.female.bodyhair.pubes	12
8	clari.web.world.europe.russia	7
9	hr.soc.povijest	6
10	alt.binaries.erotics.breasts	6
11	clari.web.world.asia.japan.biz	5
12	clari.web.world.europe.germany	4
13	alt.binaries.erotica.pregnant	3
14	clari.web.world.europe.central	2
15	alt.binaries.pictures.pornstars	2
16	alt.binaries.pictures.anal	1
17	clari.web.world.europe.british_isles.biz	1
18	clari.web.world.asia.japan	1
19	alt.binaries.pictures.erotica.alt.sex.pictures	1
20	alt.binaries.pictures.erotica.beasts	1
21	clari.web.biz.currencies.misc	1

TOTAL: 21		50309