Daily Usenet report

Sep 24 03:00:02 -- Sep 25 03:00:05

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
Control Channel
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 / 11 lines (45.5%)
Sep 24 14:38:14 andromeda controlchan[17396]: Unknown "cmsg" control by zan.bbs@bbs.cs.nctu.edu.tw
Sep 24 15:10:11 andromeda controlchan[17396]: Unknown "cmsg" control by kyyy.bbs@bbs.wretch.cc
Sep 24 18:30:22 andromeda controlchan[17396]: Unknown "cmsg" control by brookert.bbs@bbs.wretch.cc
Sep 24 19:40:14 andromeda controlchan[17396]: Unknown "cmsg" control by cara0215.bbs@bbs.wretch.cc
Sep 24 20:01:06 andromeda controlchan[17396]: Unknown "cmsg" control by Chenyu.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2309399	98.0%	203.5 MB	97.4%
innd	24395	1.0%	3.0 MB	1.4%
nnrpd	20098	0.9%	2.0 MB	1.0%
cnfsstat	2304	0.1%	404.0 KB	0.2%
controlchan	15	0.0%	2.1 KB	0.0%

TOTAL: 5	2356211	100.0%	208.9 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2293216	97.8%
Negative hits	38968	1.7%
Positive hits	7372	0.3%
Cache misses	5874	0.3%

TOTAL: 4	2345430	100.0%

INND timer:

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

article cancel	00:06:10.682	0.4%	25750	0.000	14.395	1516.000
article cleanup	00:00:36.754	0.0%	2274850	0.007	0.016	0.032
article logging	00:02:10.543	0.2%	2282654	0.008	0.057	4.057
article parse	00:23:05.328	1.6%	168525141	0.006	0.008	0.017
article write	09:49:49.847	41.0%	2248218	4.552	15.741	23.374
artlog/artcncl	00:00:00.472	0.0%	25512	0.000	0.019	2.191
artlog/artparse	00:00:00.003	0.0%	97	0.000	0.031	1.000
data move	00:06:06.721	0.4%	178554837	0.002	0.002	0.003
hisgrep/artcncl	00:05:53.228	0.4%	12706	0.000	27.800	1546.000
hishave/artcncl	00:00:01.613	0.0%	25750	0.000	0.063	7.477
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:11:13.012	0.8%	2321105	0.002	0.290	7.433
history sync	00:00:00.255	0.0%	289	0.000	0.882	3.000
history write	00:49:13.368	3.4%	2248218	0.028	1.314	13.316
hiswrite/artcncl	00:00:11.079	0.0%	13044	0.000	0.849	17.087
idle	06:48:41.625	28.4%	157888192	0.119	0.155	0.529
nntp read	00:26:02.391	1.8%	166921830	0.007	0.009	0.019
overview write	04:39:37.946	19.4%	2248218	1.283	7.463	110.859
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%	14	0.000	0.000	0.000

TOTAL: 23:59:22.551	23:28:54.867	97.9%	-	-	-	-

nnrpd timer:

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

hisgrep	00:23:23.845	1.5%	119366	0.000	11.761	66.203
idle	20:54:11.238	81.3%	334262	0.000	225.127	200313.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:22:02.999	5.3%	1248532	0.000	3.943	5587.815
readart	01:21:38.834	5.3%	258615	0.000	18.943	340.333

TOTAL: 25:42:12.777	24:01:16.916	93.5%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

fff@alteferians.org	1	0	0	0	0	1
gcn@news.nic.it	1	1	0	0	0	2
linux-admin@bofh.it	0	0	1	0	0	1

TOTAL	2	1	1	0	0	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	332	2332118	2303731	1	28386	98%	498:15:42

TOTAL: 1		332	2332118	2303731	1	28386	98%	498:15:42

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	423.8 GB	4.6 MB	423.8 GB	99%	190.6 KB	498:15:42

TOTAL: 1		423.8 GB	4.6 MB	423.8 GB	99%	190.6 KB	498:15:42

Incoming articles:

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

Sep 24 03:00:02 - 03:59:59	95024	4.2%	26.41	18.4 GB	4.3%	5352.24
Sep 24 04:00:00 - 04:59:59	89387	4.0%	24.83	17.7 GB	4.2%	5169.29
Sep 24 05:00:00 - 05:59:59	89218	4.0%	24.78	17.0 GB	4.0%	4943.23
Sep 24 06:00:00 - 06:59:59	90164	4.0%	25.05	17.5 GB	4.1%	5088.88
Sep 24 07:00:00 - 07:59:59	82946	3.7%	23.04	15.3 GB	3.6%	4464.78
Sep 24 08:00:00 - 08:59:59	90205	4.0%	25.06	17.8 GB	4.2%	5181.21
Sep 24 09:00:00 - 09:59:59	81650	3.6%	22.68	16.7 GB	3.9%	4852.68
Sep 24 10:00:00 - 10:59:59	87977	3.9%	24.44	16.6 GB	3.9%	4821.64
Sep 24 11:00:00 - 11:59:59	92650	4.1%	25.74	16.8 GB	4.0%	4899.17
Sep 24 12:00:00 - 12:59:59	97650	4.3%	27.12	18.8 GB	4.5%	5486.24
Sep 24 13:00:00 - 13:59:59	98913	4.4%	27.48	19.4 GB	4.6%	5639.57
Sep 24 14:00:00 - 14:59:59	97901	4.4%	27.19	18.8 GB	4.4%	5465.09
Sep 24 15:00:00 - 15:59:59	95289	4.2%	26.47	18.2 GB	4.3%	5312.23
Sep 24 16:00:00 - 16:59:59	96206	4.3%	26.72	17.8 GB	4.2%	5179.16
Sep 24 17:00:00 - 17:59:59	102896	4.6%	28.58	18.8 GB	4.4%	5461.41
Sep 24 18:00:00 - 18:59:59	99633	4.4%	27.68	18.9 GB	4.5%	5504.31
Sep 24 19:00:00 - 19:59:59	100677	4.5%	27.97	17.9 GB	4.2%	5220.24
Sep 24 20:00:00 - 20:59:59	100881	4.5%	28.02	17.0 GB	4.0%	4959.19
Sep 24 21:00:00 - 21:59:59	98270	4.4%	27.30	17.6 GB	4.2%	5116.41
Sep 24 22:00:00 - 22:59:59	101784	4.5%	28.27	18.8 GB	4.4%	5464.74
Sep 24 23:00:00 - 23:59:59	94188	4.2%	26.16	17.5 GB	4.1%	5094.20
Sep 25 00:00:00 - 00:59:59	87356	3.9%	24.27	16.0 GB	3.8%	4668.50
Sep 25 01:00:00 - 01:59:59	89772	4.0%	24.94	16.4 GB	3.9%	4762.93
Sep 25 02:00:00 - 02:59:59	88585	3.9%	24.61	17.1 GB	4.1%	4986.77
Sep 25 03:00:00 - 03:00:05	110	0.0%	22.00	17.6 MB	0.0%	3609.21

TOTAL: 24:00:03	2249332	100.0%	26.03	422.6 GB	100.0%	5128.83

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	40.8 GB	29.6%	71	819.86	2.04
02	BIN	137.8 GB	52.7 GB	38.3%	71	827.60	2.02
03	SMALL	13.0 GB	2.8 GB	21.3%	4	4.88	32.42
04	BIN	80.1 GB	27.2 GB	33.9%	45	430.04	2.26
05	BIN	80.1 GB	76.3 GB	95.2%	61	431.94	2.25
06	SMALL	13.0 GB	2.7 GB	20.4%	4	4.88	32.43
07	BIN	80.1 GB	23.6 GB	29.5%	45	428.84	2.27
08	BIN	80.1 GB	74.3 GB	92.8%	61	430.68	2.26
09	SMALL	13.0 GB	2.7 GB	20.9%	4	4.87	32.49
10	BIN	80.1 GB	21.4 GB	26.7%	45	428.38	2.27
11	BIN	80.1 GB	1.1 GB	1.4%	62	432.92	2.25
12	SMALL	13.0 GB	2.7 GB	20.9%	4	4.86	32.54
13	BIN	80.1 GB	21.0 GB	26.2%	45	427.98	2.27
14	BIN	80.1 GB	74.2 GB	92.6%	61	430.65	2.26

TOTAL: 14	-	968.5 GB	423.5 GB	43.7%	583	367.84	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	34457	26114	0	538	0	0	0	0	7805
2	?	97	0	0	0	0	0	0	0	97

TOTAL: 2		34554	26114	0	538	0	0	0	0	7902

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.dvd.italian	751
alt.pedophilia	608
alt.binaries.pictures.katie	581
alt.binaries.hotrod	538
alt.binaries.pictures.erotica.asian.female	515
alt.binaries.erotica.freckles	444
alt.binaries.wallpaper	439
alt.binaries.amateur.gangbang	282
allt.sex.fetish	263
alt.binaries.multimedia.anal.fisting	196
alt.binaries.fisting	195
alt.binaries.pictures.erotica.homosexual	194
hr.rec.glazba.glazbala.gitare	177
alt.binaries.multimedia.transsexuals	173
alt.binaries.multimedia.erotica.transexuals	157
alt.binaries.erotica.kinky.teens	144
alt.binaries.nonnude	141
alt.binaires.pictures.erotica.amatuer.female	140
alt.binaires.erotica	134
alt.binaires.erotica.teen	133

TOTAL: 1857	26114

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	27
	TOTAL: 1	27
Including strange strings
	192.168.33.37	7805
	TOTAL: 1	7805

TOTAL: 2		7832

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	15	119365	10.0 GB	48	0	0	12:58:55
2	ts1-a213.saratov.dial.rol.ru	1	61	159.9 KB	1	0	0	01:51:25
3	ts18-a143.moscow.dial.rol.ru	2	24	1.6 MB	1	0	0	00:12:37
4	ts2-a57.ufa.dial.rol.ru	1	12	1.5 MB	19	0	0	00:13:45
5	ts28-b59.moscow.dial.rol.ru	1	4	249.2 KB	1	0	0	00:13:08
6	ts2-a133.ufa.dial.rol.ru	1	3	668.1 KB	10	0	0	00:13:38
7	ts31-b21.moscow.dial.rol.ru	1	2	155.7 KB	1	0	0	00:01:35

TOTAL: 7		22	119471	10.0 GB	81	0	0	25:41:38

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	15	119365	10.0 GB	48	0	0	12:58:55
2	*.saratov.dial.rol.ru	1	61	159.9 KB	1	0	0	01:51:25
3	*.moscow.dial.rol.ru	24	30	2.0 MB	3	0	0	00:39:17
4	*.ufa.dial.rol.ru	2	15	2.1 MB	29	0	0	00:27:24
5	*.volgograd.dial.rol.ru	1	0	0.0 KB	0	0	0	00:04:47
6	*.cc.gldn.net	1	0	0.0 KB	0	0	0	00:10:00
7	*.krasnoyarsk.dial.rol.ru	6	0	0.0 KB	0	0	0	00:20:06
8	*.omsk.dial.rol.ru	2	0	0.0 KB	0	0	0	00:10:01
9	*.sovintel.net	15	0	0.0 KB	0	0	0	00:00:20
10	unresolved	47	0	0.0 KB	0	0	0	07:36:06
11	*.tony.pp.ru	69	0	0.0 KB	0	0	0	00:44:33
12	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:26
13	*.voronezh.dial.rol.ru	2	0	0.0 KB	0	0	0	00:00:36
14	*.pcs-net.net	1	0	0.0 KB	0	0	0	00:00:05
15	*.rol.ru	5816	0	0.0 KB	0	0	0	00:18:31
16	*.nn.ru	42	0	0.0 KB	0	0	0	00:00:21
17	*.nnovgorod.dial.rol.ru	1	0	0.0 KB	0	0	0	00:10:03
18	*.nsk.dial.rol.ru	40	0	0.0 KB	0	0	0	00:00:54
19	*.komi.com	1	0	0.0 KB	0	0	0	00:05:09

TOTAL: 19		6087	119471	10.0 GB	81	0	0	25:40:46

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	67.608	653.315	0.000	12:58:55
194.154.66.131	0.060	0.120	0.000	07:09:17
ts1-a213.saratov.dial.rol.ru	0.112	0.192	0.000	01:51:25
net1-x-ring.tony.pp.ru	47.988	501.718	0.000	00:44:33
195.46.181.242	0.064	0.084	0.000	00:26:48
ts2-a39.krasnoyarsk.dial.rol.ru	0.028	0.012	0.000	00:20:06
ts2-a57.ufa.dial.rol.ru	0.052	0.120	0.000	00:13:45
ts2-a133.ufa.dial.rol.ru	0.000	0.016	0.000	00:13:38
ts28-b59.moscow.dial.rol.ru	0.000	0.016	0.000	00:13:08
ts18-a143.moscow.dial.rol.ru	0.004	0.056	0.000	00:12:37
ts16-a26.moscow.dial.rol.ru	0.004	0.008	0.000	00:10:05
ts3-a173.nnovgorod.dial.rol.ru	0.004	0.004	0.000	00:10:03
ts3-a160.omsk.dial.rol.ru	0.016	0.000	0.000	00:10:01
nat-ie.cc.gldn.net	0.012	0.008	0.000	00:10:00
balancer-b.rol.ru	3.784	4.076	0.000	00:09:33
balancer-a.rol.ru	3.844	4.148	0.000	00:08:57
main.komi.com	0.052	0.120	0.000	00:05:09
ts2-a106.volgograd.dial.rol.ru	0.008	0.016	0.000	00:04:47
?	0.024	0.044	0.000	00:01:41
ts31-b21.moscow.dial.rol.ru	0.004	0.000	0.000	00:01:35

TOTAL: 33	124.512	1165.125	0.000	25:41:38

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2914
balancer-b.rol.ru	2902
net1-x-ring.tony.pp.ru	69
194.154.66.131	45
gray.nn.ru	42
ts2-a126.nsk.dial.rol.ru	20
ts2-a20.nsk.dial.rol.ru	20
fw-nat.sovintel.net	15
ts27-b89.moscow.dial.rol.ru	10
ts2-a39.krasnoyarsk.dial.rol.ru	6
ts24-b82.moscow.dial.rol.ru	6
ts23-a244.moscow.dial.rol.ru	3
195.46.181.242	2
ts3-a160.omsk.dial.rol.ru	2
main.komi.com	1
news.pcs-net.net	1
ts2-a106.volgograd.dial.rol.ru	1
ts3-a173.nnovgorod.dial.rol.ru	1
news.lek.ru	1
nat-ie.cc.gldn.net	1

TOTAL: 23	6065

NNRP no permission clients:

System	Conn

82.140.73.76	151
cornholio.migtel.ru	50

TOTAL: 2	201

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	30

TOTAL: 1	30

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	3	0
ts2-a39.krasnoyarsk.dial.rol.ru	2	0
ts1-a213.saratov.dial.rol.ru	1	0
ts3-a173.nnovgorod.dial.rol.ru	1	0
nat-ie.cc.gldn.net	1	0
ts3-a160.omsk.dial.rol.ru	1	0
ts28-b59.moscow.dial.rol.ru	1	0
ts16-a26.moscow.dial.rol.ru	1	0

TOTAL: 8	11	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	118374	99.9%
2	fido7	61	0.1%

TOTAL: 2		118435	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	102712
2	alt.binaries.pictures.artpics	8937
3	alt.binaries.pictures.bras	6680
4	fido7.ru.linux	61
5	alt.binaries.pictures.erotic.lesbians	24
6	alt.binaries.pictures.erotica.lolita	7
7	alt.binaries.multimedia.erotica.teen.female	6
8	alt.binaries.pictures.eotica.pre-teens	4
9	alt.binaries.pictures.erotica.13-17	3
10	alt.binaries.adolescents	1

TOTAL: 10		118435