Daily Usenet report

Sep 22 03:00:04 -- Sep 23 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 gethostbyaddr failures
NNRP client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 5 / 82 lines (6.1%)
Sep 22 04:05:49 perseus controlchan[16499]: Unknown "cmsg" control by slst8421.bbs@bbs.cs.nctu.edu.tw
Sep 22 04:15:43 perseus controlchan[16499]: Unknown "cmsg" control by zoevera.bbs@bbs.cs.nctu.edu.tw
Sep 22 04:45:40 perseus controlchan[16499]: Unknown "cmsg" control by hxgmj.bbs@bbs.cs.nctu.edu.tw
Sep 22 04:50:44 perseus controlchan[16499]: Unknown "cmsg" control by lhf7587.bbs@bbs.cs.nctu.edu.tw
Sep 22 04:50:44 perseus controlchan[16499]: Unknown "cmsg" control by lhf7587.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	676330	91.2%	63.2 MB	91.2%
innd	44436	6.0%	4.1 MB	5.9%
nnrpd	18252	2.5%	1.6 MB	2.4%
cnfsstat	2304	0.3%	395.3 KB	0.6%
controlchan	82	0.0%	7.4 KB	0.0%

TOTAL: 5	741404	100.0%	69.3 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	636072	93.3%
Negative hits	41123	6.0%
Positive hits	3649	0.5%
Cache misses	971	0.1%

TOTAL: 4	681815	100.0%

INND timer:

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

article cancel	00:00:32.096	0.0%	8692	0.000	3.693	1254.000
article cleanup	00:00:05.994	0.0%	632181	0.000	0.009	0.033
article logging	00:01:32.262	0.1%	667506	0.000	0.138	17.669
article parse	00:03:03.583	0.2%	43796220	0.001	0.004	0.010
article write	00:56:09.557	3.9%	557141	0.241	6.048	375.699
artlog/artcncl	00:00:01.336	0.0%	8570	0.000	0.156	1254.000
artlog/artparse	00:00:00.000	0.0%	4	0.000	0.000	0.000
data move	00:00:47.123	0.1%	46235017	0.000	0.001	0.002
hisgrep/artcncl	00:00:09.987	0.0%	4566	0.000	2.187	447.000
hishave/artcncl	00:00:05.845	0.0%	8692	0.000	0.672	38.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:11:41.272	0.8%	673334	0.000	1.041	16.871
history sync	00:00:00.211	0.0%	316	0.000	0.668	2.000
history write	00:29:50.093	2.1%	557141	0.006	3.213	41.204
hiswrite/artcncl	00:00:14.871	0.0%	4126	0.000	3.604	808.000
idle	20:36:51.325	85.9%	43523971	0.557	1.705	27.580
nntp read	00:03:39.240	0.3%	43810016	0.001	0.005	0.009
overview write	01:29:14.840	6.2%	557141	0.704	9.611	52.839
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%	78	0.000	0.013	1.000

TOTAL: 23:59:16.597	23:53:59.636	99.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:01:39.355	0.2%	24807	0.000	4.005	22.100
idle	14:28:32.696	94.7%	56351	0.000	924.787	200033.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:17:49.252	1.9%	284603	0.000	3.757	1956.299
readart	00:08:36.751	0.9%	49993	0.000	10.336	43.700

TOTAL: 15:17:00.025	14:56:38.054	97.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	856	602439	531536	1	70902	88%	450:23:20

TOTAL: 1		856	602439	531536	1	70902	88%	450:23:20

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	57.7 GB	2.2 MB	57.7 GB	99%	100.4 KB	450:23:20

TOTAL: 1		57.7 GB	2.2 MB	57.7 GB	99%	100.4 KB	450:23:20

Incoming articles:

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

Sep 22 03:00:04 - 03:59:59	22647	4.1%	6.30	3.0 GB	5.2%	876.69
Sep 22 04:00:00 - 04:59:59	21156	3.8%	5.88	2.8 GB	4.8%	814.23
Sep 22 05:00:00 - 05:59:59	21797	3.9%	6.05	3.2 GB	5.5%	918.97
Sep 22 06:00:00 - 06:59:59	22449	4.0%	6.24	3.0 GB	5.2%	881.05
Sep 22 07:00:00 - 07:59:59	20895	3.7%	5.80	2.9 GB	5.1%	858.40
Sep 22 08:00:00 - 08:59:59	21893	3.9%	6.08	3.1 GB	5.3%	890.14
Sep 22 09:00:00 - 09:59:59	20934	3.8%	5.82	3.2 GB	5.6%	934.80
Sep 22 10:00:00 - 10:59:59	22746	4.1%	6.32	2.8 GB	4.9%	824.41
Sep 22 11:00:00 - 11:59:59	25504	4.6%	7.08	2.1 GB	3.6%	604.02
Sep 22 12:00:00 - 12:59:59	23734	4.3%	6.59	2.7 GB	4.6%	781.01
Sep 22 13:00:00 - 13:59:59	22710	4.1%	6.31	1.8 GB	3.0%	511.82
Sep 22 14:00:00 - 14:59:59	20862	3.7%	5.79	1.6 GB	2.7%	461.27
Sep 22 15:00:00 - 15:59:59	25063	4.5%	6.96	2.7 GB	4.6%	778.84
Sep 22 16:00:00 - 16:59:59	29128	5.2%	8.09	1.8 GB	3.2%	533.03
Sep 22 17:00:00 - 17:59:59	22278	4.0%	6.19	2.0 GB	3.4%	574.56
Sep 22 18:00:00 - 18:59:59	24816	4.5%	6.89	2.2 GB	3.8%	645.52
Sep 22 19:00:00 - 19:59:59	25754	4.6%	7.15	2.2 GB	3.8%	638.36
Sep 22 20:00:00 - 20:59:59	23314	4.2%	6.48	2.6 GB	4.5%	761.33
Sep 22 21:00:00 - 21:59:59	22221	4.0%	6.17	2.4 GB	4.1%	694.17
Sep 22 22:00:00 - 22:59:59	24465	4.4%	6.80	2.5 GB	4.3%	715.01
Sep 22 23:00:00 - 23:59:59	23592	4.2%	6.55	1.9 GB	3.2%	543.54
Sep 23 00:00:00 - 00:59:59	18408	3.3%	5.11	1.1 GB	1.9%	322.87
Sep 23 01:00:00 - 01:59:59	26751	4.8%	7.43	1.9 GB	3.2%	545.72
Sep 23 02:00:00 - 02:59:59	24229	4.3%	6.73	2.4 GB	4.2%	707.31
Sep 23 03:00:00 - 03:00:02	18	0.0%	9.00	2.4 MB	0.0%	1252.24

TOTAL: 23:59:58	557364	100.0%	6.45	57.7 GB	100.0%	700.72

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	79.7 GB	57.8%	215	114.69	14.58
02	BIN	137.8 GB	33.8 GB	24.5%	216	114.94	14.55
03	SMALL	13.0 GB	4.9 GB	37.8%	18	4.15	38.10
04	BIN	80.1 GB	26.6 GB	33.2%	166	57.49	16.91
05	BIN	80.1 GB	52.1 GB	65.0%	186	57.44	16.92
06	SMALL	13.0 GB	4.9 GB	37.5%	18	4.15	38.10
07	BIN	80.1 GB	5.3 GB	6.6%	166	57.92	16.78
08	BIN	80.1 GB	33.6 GB	41.9%	186	57.17	17.00
09	SMALL	13.0 GB	3.9 GB	29.7%	18	4.18	37.84
10	BIN	80.1 GB	70.0 GB	87.3%	165	57.76	16.83
11	BIN	80.1 GB	73.3 GB	91.5%	186	57.38	16.94
12	SMALL	13.0 GB	4.7 GB	35.9%	18	4.17	37.97
13	BIN	80.1 GB	67.2 GB	83.9%	165	57.78	16.82
14	BIN	80.1 GB	34.9 GB	43.6%	186	57.49	16.91

TOTAL: 14	-	968.5 GB	494.8 GB	51.1%	1909	50.51	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	110392	56612	0	54	0	0	0	0	53726
2	?	4	0	0	0	0	0	0	0	4

TOTAL: 2		110396	56612	0	54	0	0	0	0	53730

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	5115
alt.binaries.dvdrs.pw	2864
alt.binaries.pictures.amateur.butts	1310
alt.binaries.cisco	1301
alt.binaries.movie	1295
microsoft.public.test	1150
alt.binaries.movies.dutch	1138
easynews.alt.binaries.games.apps.movies	367
alt.binaries.private.not.yours	316
alt.binaries.pictures.blonde	267
alt.binaires.erotica.teen	241
alt.sex.teen	237
alt.binaires.erotica	235
alt.binaires.pictures.erotica.amatuer.female	233
alt.binaries.pictures.erotica.amateur.digicam	226
alt.binaires.pictures.erotica.butts	224
alt.binaries.pictures.eroctica.butts	208
alt.binaries.pictures.maxwell	206
alt.binaries.pictures.senior-citizens	190
alt.binaries.pictures.erotica.bisexual	189

TOTAL: 2912	56612

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	35331
	TOTAL: 1	35331

TOTAL: 1		35331

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	8	24807	1.2 GB	24	0	0	13:58:33
2	ts18-a215.moscow.dial.rol.ru	1	70	3.6 MB	10	0	0	00:20:43
3	ts18-a247.moscow.dial.rol.ru	1	42	2.0 MB	4	0	0	00:24:57
4	195.218.244.87	2	13	704.5 KB	1	0	0	00:01:14
5	rol22.rol.kis.ru	1	3	4.4 KB	1	0	0	00:00:40

TOTAL: 5		13	24935	1.2 GB	40	0	0	15:16:59

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	8	24807	1.2 GB	24	0	0	13:58:33
2	*.moscow.dial.rol.ru	2	112	5.6 MB	14	0	0	00:45:40
3	unresolved	6	13	704.5 KB	1	0	0	00:11:16
4	*.rol.kis.ru	1	3	4.4 KB	1	0	0	00:00:40
5	*.sovintel.net	14	0	0.0 KB	0	0	0	00:00:11
6	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:37
7	*.sarov.dial.rol.ru	4	0	0.0 KB	0	0	0	00:02:27
8	*.tony.pp.ru	71	0	0.0 KB	0	0	0	00:02:36
9	*.rol.ru	5764	0	0.0 KB	0	0	0	00:14:26

TOTAL: 9		5871	24935	1.2 GB	40	0	0	15:16:59

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	19.956	214.336	0.000	13:58:33
ts18-a247.moscow.dial.rol.ru	0.004	0.020	0.000	00:24:57
ts18-a215.moscow.dial.rol.ru	0.004	0.016	0.000	00:20:43
194.186.71.137	0.004	0.004	0.000	00:10:00
balancer-b.rol.ru	3.408	3.308	0.000	00:07:28
balancer-a.rol.ru	3.808	3.116	0.000	00:06:57
net1-x-ring.tony.pp.ru	0.120	0.132	0.000	00:02:36
ts2-a102.sarov.dial.rol.ru	0.000	0.004	0.000	00:01:15
195.218.244.87	0.008	0.016	0.000	00:01:14
ts2-a94.sarov.dial.rol.ru	0.004	0.004	0.000	00:01:11
rol22.rol.kis.ru	0.008	0.000	0.000	00:00:40
news.lek.ru	0.132	0.068	0.000	00:00:37
?	0.004	0.008	0.000	00:00:28
fw-nat.sovintel.net	0.116	0.060	0.000	00:00:11
212.46.235.19	0.004	0.004	0.000	00:00:01
83.167.100.251	0.004	0.004	0.000	00:00:00
cornholio.migtel.ru	0.000	0.000	0.000	00:00:00

TOTAL: 17	27.584	221.100	0.000	15:16:59

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2884
balancer-a.rol.ru	2880
net1-x-ring.tony.pp.ru	71
fw-nat.sovintel.net	14
212.46.235.19	3
ts2-a102.sarov.dial.rol.ru	2
ts2-a94.sarov.dial.rol.ru	2
194.186.71.137	1
news.lek.ru	1

TOTAL: 9	5858

NNRP no permission clients:

System	Conn

83.167.100.251	2
cornholio.migtel.ru	1

TOTAL: 2	3

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	5

TOTAL: 1	5

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.186.71.137	1	0

TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	24932	100.0%
2	lada	3	0.0%

TOTAL: 2		24935	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	13683
2	alt.binaries.pictures.bras	8416
3	alt.binaries.pictures.artpics	2708
4	alt.binaries.pictures.lolita	112
5	alt.binaries.erotica.pornstars	13
6	lada.commerce	3

TOTAL: 6		24935