Daily Usenet report

May 27 03:00:02 -- May 28 03:00:03

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 / 67 lines (7.5%)
May 27 04:04:01 andromeda controlchan[24435]: Unknown "cmsg" control by iriss.bbs@bbs.wretch.cc
May 27 04:04:01 andromeda controlchan[24435]: Unknown "cmsg" control by iriss.bbs@bbs.wretch.cc
May 27 05:13:55 andromeda controlchan[24435]: Unknown "cmsg" control by wolffox.bbs@bbs.wretch.cc
May 27 05:23:17 andromeda controlchan[24435]: Unknown "cmsg" control by Azurewind.bbs@bbs.cs.nctu.edu.tw
May 27 06:33:57 andromeda controlchan[24435]: Unknown "cmsg" control by STUmovie.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2016105	98.0%	179.8 MB	97.4%
innd	19193	0.9%	2.6 MB	1.4%
nnrpd	19132	0.9%	1.9 MB	1.0%
cnfsstat	2304	0.1%	399.9 KB	0.2%
controlchan	67	0.0%	7.3 KB	0.0%

TOTAL: 5	2056801	100.0%	184.7 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2017769	97.1%
Negative hits	57534	2.8%
Positive hits	2064	0.1%
Cache misses	615	0.0%

TOTAL: 4	2077982	100.0%

INND timer:

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

article cancel	00:00:55.601	0.1%	5783	0.000	9.615	1116.000
article cleanup	00:00:31.057	0.0%	1995554	0.000	0.016	0.027
article logging	00:03:39.126	0.3%	2011208	0.000	0.109	11.997
article parse	00:19:34.637	1.4%	101644869	0.002	0.012	0.150
article write	06:29:00.100	27.0%	1966133	0.541	11.871	84.974
artlog/artcncl	00:00:00.389	0.0%	5655	0.000	0.069	264.000
artlog/artparse	00:00:00.000	0.0%	16	0.000	0.000	0.000
data move	00:04:11.066	0.3%	109184625	0.001	0.002	0.010
hisgrep/artcncl	00:00:44.113	0.1%	2180	0.000	20.235	832.000
hishave/artcncl	00:00:00.085	0.0%	5783	0.000	0.015	16.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:04:23.925	0.3%	2074390	0.000	0.127	9.015
history sync	00:00:02.006	0.0%	289	0.000	6.941	579.500
history write	02:21:46.563	9.8%	1992646	0.030	4.269	37.830
hiswrite/artcncl	00:00:08.326	0.0%	3603	0.000	2.311	829.000
idle	04:20:06.356	18.1%	90211677	0.000	0.173	30229.000
nntp read	00:20:47.134	1.4%	100084015	0.003	0.012	0.122
overview write	09:34:00.490	39.8%	1966133	3.047	17.517	1403.919
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.007	0.0%	63	0.000	0.111	5.000

TOTAL: 24:00:38.385	23:39:50.981	98.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:09:07.527	0.9%	76297	0.000	7.176	45.126
idle	15:51:15.156	91.7%	310338	0.000	183.913	150517.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:11:42.468	1.1%	838142	0.000	0.838	105.719
readart	00:32:34.078	3.1%	154129	0.000	12.678	136.670

TOTAL: 17:17:44.287	16:44:39.229	96.8%	-	-	-	-

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	487	1953099	1924117	145	28837	98%	473:50:51

TOTAL: 1		487	1953099	1924117	145	28837	98%	473:50:51

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	374.5 GB	8.6 MB	374.5 GB	99%	201.1 KB	473:50:51

TOTAL: 1		374.5 GB	8.6 MB	374.5 GB	99%	201.1 KB	473:50:51

Incoming articles:

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

May 27 03:00:02 - 03:59:59	80799	4.1%	22.46	16.5 GB	4.3%	4809.54
May 27 04:00:00 - 04:59:59	79319	4.0%	22.03	16.2 GB	4.2%	4719.19
May 27 05:00:00 - 05:59:59	75304	3.8%	20.92	15.1 GB	4.0%	4401.56
May 27 06:00:00 - 06:59:59	81637	4.2%	22.68	16.9 GB	4.4%	4929.99
May 27 07:00:00 - 07:59:59	68342	3.5%	18.98	14.3 GB	3.8%	4171.03
May 27 08:00:00 - 08:59:59	58921	3.0%	16.37	12.1 GB	3.2%	3512.65
May 27 09:00:00 - 09:59:59	72811	3.7%	20.23	15.1 GB	4.0%	4409.92
May 27 10:00:00 - 10:59:59	65730	3.3%	18.26	13.1 GB	3.4%	3816.20
May 27 11:00:00 - 11:59:59	79321	4.0%	22.03	15.5 GB	4.1%	4522.04
May 27 12:00:00 - 12:59:59	75005	3.8%	20.83	14.4 GB	3.8%	4199.62
May 27 13:00:00 - 13:59:59	85289	4.3%	23.69	16.3 GB	4.3%	4743.00
May 27 14:00:00 - 14:59:59	88962	4.5%	24.71	17.8 GB	4.7%	5176.51
May 27 15:00:00 - 15:59:59	90650	4.6%	25.18	17.6 GB	4.6%	5115.55
May 27 16:00:00 - 16:59:59	93823	4.8%	26.06	17.3 GB	4.5%	5035.23
May 27 17:00:00 - 17:59:59	93122	4.7%	25.87	16.9 GB	4.4%	4926.45
May 27 18:00:00 - 18:59:59	88955	4.5%	24.71	17.0 GB	4.4%	4940.34
May 27 19:00:00 - 19:59:59	88730	4.5%	24.65	17.0 GB	4.4%	4937.65
May 27 20:00:00 - 20:59:59	87846	4.5%	24.40	17.1 GB	4.5%	4985.20
May 27 21:00:00 - 21:59:59	87211	4.4%	24.23	16.8 GB	4.4%	4905.66
May 27 22:00:00 - 22:59:59	76201	3.9%	21.17	14.3 GB	3.8%	4170.99
May 27 23:00:00 - 23:59:59	80263	4.1%	22.30	15.3 GB	4.0%	4454.73
May 28 00:00:00 - 00:59:59	81773	4.2%	22.71	15.2 GB	4.0%	4428.19
May 28 01:00:00 - 01:59:59	87552	4.5%	24.32	14.8 GB	3.9%	4307.87
May 28 02:00:00 - 02:59:59	97746	5.0%	27.15	19.0 GB	5.0%	5547.74
May 28 03:00:00 - 03:00:03	73	0.0%	24.33	10.7 MB	0.0%	3657.07

TOTAL: 24:00:01	1965385	100.0%	22.75	381.7 GB	100.0%	4631.91

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	40.1 GB	29.1%	171	765.82	2.18
02	BIN	137.8 GB	77.7 GB	56.4%	171	761.61	2.20
03	SMALL	13.0 GB	9.8 GB	74.8%	12	3.64	43.52
04	BIN	80.1 GB	29.6 GB	36.9%	131	388.45	2.50
05	BIN	80.1 GB	12.9 GB	16.2%	148	389.39	2.50
06	SMALL	13.0 GB	9.2 GB	70.5%	12	3.62	43.66
07	BIN	80.1 GB	18.7 GB	23.3%	131	387.42	2.51
08	BIN	80.1 GB	76.9 GB	96.0%	147	388.58	2.50
09	SMALL	13.0 GB	9.3 GB	71.1%	12	3.64	43.44
10	BIN	80.1 GB	12.7 GB	15.9%	131	387.13	2.51
11	BIN	80.1 GB	19.9 GB	24.8%	148	389.74	2.49
12	BIN	13.0 GB	7.0 GB	53.8%	444	386.95	0.41
13	BIN	80.1 GB	51.2 GB	63.9%	72	388.97	2.50
14	SMALL	80.1 GB	13.7 GB	17.1%	1	3.64	267.19

TOTAL: 14	-	968.5 GB	388.6 GB	40.1%	1731	333.12	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	45049	26495	0	354	0	0	0	0	18200
2	?	16	0	0	0	0	0	0	0	16

TOTAL: 2		45065	26495	0	354	0	0	0	0	18216

Unwanted newsgroups [Top 20]:

Newsgroup	Count

microsoft.public.test	1152
alt.binaries.the-portal	450
alt.binaries.pictures.amateur.butts	418
alt.binaries.pictures.erotica.asian.female	323
alt.binaries.amberbigbutt	261
alt.binaries.erotica.toys	192
alt.binaries.picturea.erotica	182
alt.binaries.picture.erotica.amature	179
alt.binaries.resume	178
alt.binaries.pictues.erotica.fetish	176
alt.binaries.pictures.black.erotica	173
alt.binaries.pictures.erotica.bisexual	173
alt.binaries.pictures.black.erotica.females	172
alt.binaries.pictures.erotica.breast.large	171
alt.binaries.pictuers.erotica.female	170
alt.binaries.pictures.erotica.asian-male	170
alt.binaries.pictures.erotica.breasts.sm	170
alt.binaries.erotica.spam	169
alt.binaries.norge	168
alt.binaries.pictures.erotica.breast.saggy	168

TOTAL: 1944	26495

INND misc events:

Events	Count

CCreader	3

TOTAL: 1	3

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	25
	TOTAL: 1	25
Including strange strings
	192.168.33.37	15654
	TOTAL: 1	15654

TOTAL: 2		15679

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	8	76297	1.5 GB	21	0	0	12:01:27
2	194.154.66.149	1	578	108.2 MB	31	0	0	01:34:15

TOTAL: 2		9	76875	1.6 GB	52	0	0	17:17:12

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	8	76297	1.5 GB	21	0	0	12:01:27
2	unresolved	3	578	108.2 MB	31	0	0	01:35:57
3	*.tony.pp.ru	71	0	0.0 KB	0	0	0	00:22:08
4	*.net.rol.ru	16	0	0.0 KB	0	0	0	02:39:58
5	*.rol.ru	5783	0	0.0 KB	0	0	0	00:22:29
6	*.nn.ru	4	0	0.0 KB	0	0	0	00:00:02
7	*.rol.kis.ru	1	0	0.0 KB	0	0	0	00:07:32

TOTAL: 7		5886	76875	1.6 GB	52	0	0	17:16:43

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	28.688	45.848	0.000	12:01:27
modul-gw000.net.rol.ru	0.032	0.036	0.000	02:39:58
194.154.66.149	0.084	0.856	0.000	01:34:15
net1-x-ring.tony.pp.ru	119.868	124.616	0.000	00:22:08
balancer-b.rol.ru	3.472	4.568	0.000	00:11:43
balancer-a.rol.ru	3.616	4.052	0.000	00:10:46
rol25.rol.kis.ru	0.012	0.004	0.000	00:07:32
?	0.020	0.472	0.000	00:07:08
81.211.82.49	1.004	0.400	0.000	00:01:41
cornholio.migtel.ru	0.244	0.340	0.000	00:00:26
gray.nn.ru	0.008	0.012	0.000	00:00:02
121.241.0.83	0.004	0.004	0.000	00:00:01
195.98.59.67	0.012	0.004	0.000	00:00:00
83.167.116.18	0.000	0.000	0.000	00:00:00
85.113.148.26	0.004	0.004	0.000	00:00:00

TOTAL: 15	157.068	181.216	0.000	17:17:12

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2893
balancer-a.rol.ru	2890
net1-x-ring.tony.pp.ru	71
modul-gw000.net.rol.ru	16
gray.nn.ru	4
81.211.82.49	1
rol25.rol.kis.ru	1
195.98.59.67	1

TOTAL: 8	5877

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	182
121.241.0.83	3
85.113.148.26	1
83.167.116.18	1

TOTAL: 4	187

NNRP client timeouts [Top 20]:

System	Conn	Peer

81.211.82.49	1	0

TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	80132	99.9%
2	japan	42	0.1%
3	japan2nd	3	0.0%

TOTAL: 3		80177	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	53427
2	alt.binaries.pictures.bras	16259
3	alt.binaries.pictures.artpics	9913
4	alt.binaries.nospam.teenfem.no-rules	497
5	alt.japanese.neojapan.lolita	27
6	japan.binaries.pictures.lolita	26
7	japan.binaries.pictures.erotica.lolita	16
8	alt.binaries.pictures.lfix	6
9	japan2nd.binaries.pictures.erotica.lolita	3
10	alt.bainaries.pictures.erotica.child	2
11	alt.binaries.aoi	1

TOTAL: 11		80177