Daily Usenet report

Sep 4 10:39:37 -- Sep 5 03:00:02

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 / 45 lines (11.1%)
Sep 4 11:10:18 andromeda controlchan[1335]: Unknown "cmsg" control by Liry.bbs@bbs.wretch.cc
Sep 4 12:00:14 andromeda controlchan[1335]: Unknown "cmsg" control by Mauber.bbs@bbs.wretch.cc
Sep 4 12:00:14 andromeda controlchan[1335]: Unknown "cmsg" control by Mauber.bbs@bbs.wretch.cc
Sep 4 12:09:18 andromeda controlchan[1335]: Unknown "cmsg" control by nctucom.bbs@bbs.cis.nctu.edu.tw
Sep 4 12:09:26 andromeda controlchan[1335]: Unknown "cmsg" control by nctucom.bbs@bbs.cis.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	1514453	97.7%	134.0 MB	97.1%
innd	20241	1.3%	2.4 MB	1.7%
nnrpd	13857	0.9%	1.4 MB	1.0%
cnfsstat	1568	0.1%	272.8 KB	0.2%
controlchan	46	0.0%	4.6 KB	0.0%

TOTAL: 5	1550165	100.0%	138.0 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	1489365	98.3%
Negative hits	23404	1.5%
Positive hits	2741	0.2%
Cache misses	372	0.0%

TOTAL: 4	1515882	100.0%

INND timer:

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

article cancel	00:01:34.337	0.2%	18266	0.000	5.165	1093.000
article cleanup	00:00:22.692	0.0%	1473474	0.007	0.015	0.025
article logging	00:01:02.454	0.1%	1497300	0.005	0.042	2.514
article parse	00:14:57.247	1.5%	114479863	0.006	0.008	0.021
article write	06:15:10.728	38.2%	1456674	5.196	15.454	47.278
artlog/artcncl	00:00:00.282	0.0%	17925	0.000	0.016	10.500
artlog/artparse	00:00:00.000	0.0%	25	0.000	0.000	0.000
data move	00:04:02.192	0.4%	121321742	0.001	0.002	0.003
hisgrep/artcncl	00:00:09.898	0.0%	2884	0.000	3.432	1072.000
hishave/artcncl	00:00:28.875	0.0%	18266	0.000	1.581	34.053
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:25:07.411	2.6%	1500205	0.001	1.005	18.233
history sync	00:00:00.233	0.0%	199	0.000	1.171	3.000
history write	00:36:08.786	3.7%	1456674	0.035	1.489	14.808
hiswrite/artcncl	00:00:54.607	0.1%	15382	0.000	3.550	191.500
idle	05:37:27.821	34.4%	108264568	0.119	0.187	0.372
nntp read	00:16:54.226	1.7%	113645377	0.007	0.009	0.019
overview write	02:23:53.531	14.7%	1456674	1.795	5.927	50.637
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%	46	0.000	0.022	1.000

TOTAL: 16:20:53.084	15:58:15.321	97.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:15:37.141	1.8%	56895	0.000	16.471	42.544
idle	12:14:46.175	84.9%	249203	0.000	176.909	300697.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:04:06.787	0.5%	671591	0.000	0.367	61.333
readart	00:24:24.062	2.8%	116805	0.000	12.534	690.000

TOTAL: 14:25:29.177	12:58:54.165	90.0%	-	-	-	-

Control commands to INND:

Command	Number

flush	99
flushlogs	1
paused	2

TOTAL: 3	102

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

admin@openwatcom.news-admin.org	0	0	1	0	0	1

TOTAL	0	0	1	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	232	1457327	1441504	11	15812	98%	323:44:38

TOTAL: 1		232	1457327	1441504	11	15812	98%	323:44:38

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	274.7 GB	4.0 MB	274.7 GB	99%	197.6 KB	323:44:38

TOTAL: 1		274.7 GB	4.0 MB	274.7 GB	99%	197.6 KB	323:44:38

Incoming articles:

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

Sep 4 10:39:37 - 10:59:59	27430	1.9%	22.43	4.8 GB	1.8%	4113.30
Sep 4 11:00:00 - 11:59:59	88059	6.0%	24.46	16.1 GB	5.9%	4676.25
Sep 4 12:00:00 - 12:59:59	81095	5.6%	22.53	14.8 GB	5.4%	4299.15
Sep 4 13:00:00 - 13:59:59	92787	6.4%	25.77	18.3 GB	6.7%	5319.91
Sep 4 14:00:00 - 14:59:59	94172	6.5%	26.16	18.7 GB	6.9%	5439.25
Sep 4 15:00:00 - 15:59:59	88794	6.1%	24.66	17.4 GB	6.4%	5070.48
Sep 4 16:00:00 - 16:59:59	83793	5.8%	23.28	15.8 GB	5.8%	4589.72
Sep 4 17:00:00 - 17:59:59	82511	5.7%	22.92	15.8 GB	5.8%	4598.10
Sep 4 18:00:00 - 18:59:59	95396	6.6%	26.50	18.2 GB	6.7%	5302.50
Sep 4 19:00:00 - 19:59:59	98769	6.8%	27.44	18.3 GB	6.7%	5330.19
Sep 4 20:00:00 - 20:59:59	95938	6.6%	26.65	17.1 GB	6.3%	4966.60
Sep 4 21:00:00 - 21:59:59	89858	6.2%	24.96	17.0 GB	6.2%	4944.46
Sep 4 22:00:00 - 22:59:59	88890	6.1%	24.69	16.7 GB	6.1%	4859.53
Sep 4 23:00:00 - 23:59:59	84541	5.8%	23.48	15.4 GB	5.7%	4492.26
Sep 5 00:00:00 - 00:59:59	83692	5.7%	23.25	15.4 GB	5.7%	4483.36
Sep 5 01:00:00 - 01:59:59	90852	6.2%	25.24	15.8 GB	5.8%	4596.18
Sep 5 02:00:00 - 02:59:59	89300	6.1%	24.81	16.5 GB	6.1%	4800.95
Sep 5 03:00:00 - 03:00:02	53	0.0%	26.50	10.2 MB	0.0%	5236.93

TOTAL: 16:20:25	1455930	100.0%	24.75	271.8 GB	100.0%	4845.03

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	79.9 GB	58.0%	65	781.30	2.14
02	BIN	137.8 GB	87.9 GB	63.8%	65	783.33	2.14
03	SMALL	13.0 GB	11.1 GB	85.4%	3	4.53	34.93
04	BIN	80.1 GB	33.4 GB	41.7%	40	407.27	2.39
05	BIN	80.1 GB	248.8 MB	0.3%	57	406.64	2.39
06	SMALL	13.0 GB	11.0 GB	84.5%	3	4.44	35.67
07	BIN	80.1 GB	30.8 GB	38.4%	40	405.77	2.40
08	BIN	80.1 GB	79.5 GB	99.3%	56	406.38	2.39
09	SMALL	13.0 GB	11.1 GB	85.0%	3	4.48	35.33
10	BIN	80.1 GB	29.1 GB	36.4%	40	406.02	2.39
11	BIN	80.1 GB	4.6 GB	5.7%	57	408.05	2.38
12	SMALL	13.0 GB	11.1 GB	85.0%	3	4.46	35.46
13	BIN	80.1 GB	29.0 GB	36.3%	40	406.16	2.39
14	BIN	80.1 GB	79.2 GB	98.9%	56	407.28	2.39

TOTAL: 14	-	968.5 GB	497.9 GB	51.4%	528	348.00	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	40586	16572	0	224	0	0	0	0	23790
2	?	25	0	0	0	0	0	0	0	25

TOTAL: 2		40611	16572	0	224	0	0	0	0	23815

Unwanted newsgroups [Top 20]:

Newsgroup	Count

es.binarios.hd	869
alt.binaries.pictures.erotica.asian.female	769
alt.binaries.jerry	664
alt.binaries.chaka	594
pedo.japanese.fetish.lolita	220
alt.binaries.pictures.erotica.gay	215
alt.binaries.totally.fetish.photo	184
alt.binaries.multimedia.bisexual	171
alt.binaries.anime.highspeed	169
alt.binaries.fetish	162
alt.binaries.pictures.amateur.butts	156
alt.binaries.erotica.amateur.gaymen	99
alt.binaries.erotica.gaymen.twinks	97
mailing.www.php-dev	95
oesterreich.tratsch	84
rss.MoreOver-MovieBusiness	75
mysql.internals.commits	67
list.postfix.users	64
alt.binaries.pictures.fetish.urine	63
hr.rec.oruzje.binaries	62

TOTAL: 1598	16572

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	45
	TOTAL: 1	45
Including strange strings
	192.168.33.37	23790
	TOTAL: 1	23790

TOTAL: 2		23835

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	6	56884	1.9 GB	18	0	0	09:22:14
2	ts4-a47.nnovgorod.dial.rol.ru	3	1	0.9 KB	20	0	0	00:26:02

TOTAL: 2		9	56885	1.9 GB	38	0	0	14:25:10

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	6	56884	1.9 GB	18	0	0	09:22:14
2	*.nnovgorod.dial.rol.ru	3	1	0.9 KB	20	0	0	00:26:02
3	*.moscow.dial.rol.ru	20	0	0.0 KB	0	0	0	00:04:09
4	*.sovintel.net	8	0	0.0 KB	0	0	0	00:00:10
5	*.cis.ru	1	0	0.0 KB	0	0	0	00:10:42
6	unresolved	20	0	0.0 KB	0	0	0	03:00:01
7	*.tony.pp.ru	51	0	0.0 KB	0	0	0	01:08:21
8	*.rol.ru	3943	0	0.0 KB	0	0	0	00:11:19
9	*.nn.ru	97	0	0.0 KB	0	0	0	00:00:12
10	*.nsk.dial.rol.ru	19	0	0.0 KB	0	0	0	00:00:11

TOTAL: 10		4168	56885	1.9 GB	38	0	0	14:24:13

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	27.040	236.289	0.000	09:22:14
194.154.66.131	0.032	0.024	0.000	03:00:01
net1-x-ring.tony.pp.ru	94.248	974.148	0.000	01:08:21
ts4-a47.nnovgorod.dial.rol.ru	0.020	0.008	0.000	00:26:02
sword.cis.ru	0.056	0.092	0.000	00:10:42
balancer-a.rol.ru	2.396	2.688	0.000	00:05:52
balancer-b.rol.ru	2.584	2.720	0.000	00:05:27
ts24-b137.moscow.dial.rol.ru	0.012	0.012	0.000	00:03:51
82.140.73.76	0.160	0.228	0.000	00:00:49
?	0.008	0.004	0.000	00:00:48
gray.nn.ru	0.192	0.160	0.000	00:00:12
ts2-b155.nsk.dial.rol.ru	0.016	0.040	0.000	00:00:11
fw-nat.sovintel.net	0.056	0.048	0.000	00:00:10
ts23-a221.moscow.dial.rol.ru	0.008	0.008	0.000	00:00:08
ts27-a228.moscow.dial.rol.ru	0.016	0.020	0.000	00:00:08
79.120.55.193	0.012	0.004	0.000	00:00:02
cornholio.migtel.ru	0.024	0.020	0.000	00:00:01
ts23-b21.moscow.dial.rol.ru	0.004	0.004	0.000	00:00:01
83.220.64.115	0.000	0.000	0.000	00:00:01
87.245.178.164	0.028	0.020	0.000	00:00:01

TOTAL: 26	126.936	1216.565	0.000	14:25:10

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	1972
balancer-a.rol.ru	1971
gray.nn.ru	97
net1-x-ring.tony.pp.ru	51
194.154.66.131	19
ts2-b155.nsk.dial.rol.ru	19
ts27-a228.moscow.dial.rol.ru	10
fw-nat.sovintel.net	8
ts23-a221.moscow.dial.rol.ru	5
ts24-b137.moscow.dial.rol.ru	3
ts23-b21.moscow.dial.rol.ru	2
sword.cis.ru	1
195.218.208.3	1

TOTAL: 13	4159

NNRP no permission clients:

System	Conn

82.140.73.76	108
87.245.178.164	14
79.120.55.193	12
cornholio.migtel.ru	8
wn2nat51.beelinegprs.ru	5
83.234.230.183	4
77.94.200.216	2
83.220.64.115	1
195.28.36.242	1
ggsn3mail1.beelinegprs.ru	1

TOTAL: 10	156

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	16

TOTAL: 1	16

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	2	0
ts4-a47.nnovgorod.dial.rol.ru	2	0
sword.cis.ru	1	0

TOTAL: 3	5	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	55982	100.0%
2	lada	1	0.0%

TOTAL: 2		55983	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	47886
2	alt.binaries.pictures.bras	4275
3	alt.binaries.pictures.artpics	3821
4	lada.music	1

TOTAL: 4		55983