Daily Usenet report

Jun 3 03:00:02 -- Jun 4 03:00:01

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
Newsgroups removed
Control Channel
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 client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 28 / 28 lines (100.0%)
Jun 3 03:03:56 andromeda controlchan[24930]: Unknown "cmsg" control by markcupcup.bbs@bbs.cs.nctu.edu.tw
Jun 3 05:03:42 andromeda controlchan[24930]: Unknown "cmsg" control by jenjye01.bbs@bbs.cs.nctu.edu.tw
Jun 3 07:23:05 andromeda controlchan[24930]: Unknown "cmsg" control by hsiaoyu.bbs@bbs.cs.nctu.edu.tw
Jun 3 07:53:06 andromeda controlchan[24930]: Unknown "cmsg" control by JayBruce.bbs@bbs.cs.nctu.edu.tw
Jun 3 08:13:10 andromeda controlchan[24930]: Unknown "cmsg" control by ckmarkhsu.bbs@bbs.cs.nctu.edu.tw
Jun 3 09:33:05 andromeda controlchan[24930]: Unknown "cmsg" control by kuroboy.bbs@bbs.cs.nctu.edu.tw
Jun 3 10:33:06 andromeda controlchan[24930]: Unknown "cmsg" control by newname.bbs@bbs.cs.nctu.edu.tw
Jun 3 10:33:07 andromeda controlchan[24930]: Unknown "cmsg" control by newname.bbs@bbs.cs.nctu.edu.tw
Jun 3 11:03:10 andromeda controlchan[24930]: Unknown "cmsg" control by pebuch.bbs@bbs.cs.nctu.edu.tw
Jun 3 11:03:12 andromeda controlchan[24930]: Unknown "cmsg" control by pebuch.bbs@bbs.cs.nctu.edu.tw
Jun 3 11:03:13 andromeda controlchan[24930]: Unknown "cmsg" control by pebuch.bbs@bbs.cs.nctu.edu.tw
Jun 3 12:43:06 andromeda controlchan[24930]: Unknown "cmsg" control by alphabeta.bbs@bbs.cs.nctu.edu.tw
Jun 3 14:53:05 andromeda controlchan[24930]: Unknown "cmsg" control by sada.bbs@bbs.cs.nctu.edu.tw
Jun 3 15:03:34 andromeda controlchan[24930]: Unknown "cmsg" control by windchild123.bbs@bbs.cs.nctu.edu.tw
Jun 3 15:03:49 andromeda controlchan[24930]: Unknown "cmsg" control by windchild123.bbs@bbs.cs.nctu.edu.tw
Jun 3 16:03:16 andromeda controlchan[24930]: Unknown "cmsg" control by ashiao.bbs@bbs.cs.nctu.edu.tw
Jun 3 16:13:05 andromeda controlchan[24930]: Unknown "cmsg" control by metsuan.bbs@bbs.cs.nctu.edu.tw
Jun 3 17:33:05 andromeda controlchan[24930]: Unknown "cmsg" control by starcraft031.bbs@bbs.cs.nctu.edu.tw
Jun 3 17:43:12 andromeda controlchan[24930]: Unknown "cmsg" control by goah1942.bbs@bbs.cs.nctu.edu.tw
Jun 3 18:13:13 andromeda controlchan[24930]: Unknown "cmsg" control by jsyuvicky.bbs@moca.csie.chu.edu.tw
Jun 3 18:53:37 andromeda controlchan[24930]: Unknown "cmsg" control by mindyu1.bbs@bbs.cs.nctu.edu.tw
Jun 3 19:26:42 andromeda controlchan[24930]: Unknown "cmsg" control by aoi.bbs@bbs.cs.nctu.edu.tw
Jun 3 19:39:27 andromeda controlchan[24930]: Unknown "cmsg" control by maii.bbs@bbs.cs.nctu.edu.tw
Jun 3 20:46:22 andromeda controlchan[24930]: Unknown "cmsg" control by jkgh.bbs@bbs.cs.nctu.edu.tw
Jun 3 20:59:36 andromeda controlchan[24930]: Unknown "cmsg" control by allen77513.bbs@bbs.cs.nctu.edu.tw
Jun 3 21:14:48 andromeda controlchan[24930]: Unknown "cmsg" control by convince.bbs@bbs.cs.nctu.edu.tw
Jun 3 21:21:32 andromeda controlchan[24930]: Unknown "cmsg" control by ken55.bbs@ECEsky.twbbs.org
Jun 3 21:37:36 andromeda controlchan[24930]: Unknown "cmsg" control by mokia2424.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	569067	94.5%	51.1 MB	93.2%
nnrpd	18067	3.0%	1.8 MB	3.3%
innd	12585	2.1%	1.5 MB	2.8%
cnfsstat	2304	0.4%	402.8 KB	0.7%
controlchan	32	0.0%	3.7 KB	0.0%

TOTAL: 5	602055	100.0%	54.9 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	563795	94.9%
Negative hits	26156	4.4%
Positive hits	3613	0.6%
Cache misses	567	0.1%

TOTAL: 4	594131	100.0%

INND timer:

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

article cancel	00:00:09.077	0.0%	11086	0.000	0.819	616.000
article cleanup	00:00:07.232	0.0%	557250	0.000	0.013	1.000
article logging	00:01:14.255	0.1%	557900	0.000	0.133	8.801
article parse	00:03:25.830	0.2%	39477414	0.000	0.005	0.086
article write	00:26:39.085	1.9%	504103	0.000	3.172	19.579
artlog/artcncl	00:00:04.378	0.0%	11059	0.000	0.396	249.875
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:01:14.426	0.1%	41708914	0.000	0.002	0.013
hisgrep/artcncl	00:00:01.838	0.0%	4059	0.000	0.453	616.000
hishave/artcncl	00:00:00.184	0.0%	11086	0.000	0.017	2.200
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:03:35.441	0.2%	583514	0.000	0.369	6.775
history sync	00:00:00.354	0.0%	343	0.000	1.032	2.000
history write	00:09:30.861	0.7%	557171	0.000	1.025	10.441
hiswrite/artcncl	00:00:02.580	0.0%	7027	0.000	0.367	7.000
idle	21:23:30.090	89.1%	39358257	0.000	1.957	36.647
nntp read	00:04:04.699	0.3%	39480044	0.000	0.006	0.042
overview write	01:37:50.785	6.8%	504103	2.045	11.646	76138.000
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%	31	0.000	0.000	0.000

TOTAL: 23:59:44.163	23:51:31.115	99.4%	-	-	-	-

nnrpd timer:

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

hisgrep	00:00:34.162	0.1%	10260	0.000	3.330	0.000
idle	10:13:51.697	95.8%	26961	8.000	1366.110	85752.286
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:21:11.501	3.3%	80295	0.000	15.835	0.000
readart	00:02:16.378	0.4%	20724	0.000	6.581	0.000

TOTAL: 10:40:27.377	10:37:53.738	99.6%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Newsgroups removed:

Group

de.talk.jugend

TOTAL: 1

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

control-microsoft@trigofacile.com	1	0	1	0	0	2
moderator@dana.de	0	1	0	0	1	1

TOTAL	1	1	1	0	1	3

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	1757	486178	438132	42	48004	90%	300:44:18

TOTAL: 1		1757	486178	438132	42	48004	90%	300:44:18

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	50.0 GB	2.4 MB	50.0 GB	99%	107.8 KB	300:44:18

TOTAL: 1		50.0 GB	2.4 MB	50.0 GB	99%	107.8 KB	300:44:18

Incoming articles:

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

Jun 3 03:00:02 - 03:59:59	21667	4.3%	6.02	2.3 GB	4.5%	661.80
Jun 3 04:00:00 - 04:59:59	19243	3.8%	5.35	2.1 GB	4.3%	626.10
Jun 3 05:00:00 - 05:59:59	19000	3.8%	5.28	2.2 GB	4.3%	634.19
Jun 3 06:00:00 - 06:59:59	19441	3.9%	5.40	2.3 GB	4.5%	665.44
Jun 3 07:00:00 - 07:59:59	18003	3.6%	5.00	2.2 GB	4.5%	654.60
Jun 3 08:00:00 - 08:59:59	17217	3.4%	4.78	2.3 GB	4.5%	662.37
Jun 3 09:00:00 - 09:59:59	18403	3.6%	5.11	2.2 GB	4.5%	653.88
Jun 3 10:00:00 - 10:59:59	19596	3.9%	5.44	2.2 GB	4.4%	646.97
Jun 3 11:00:00 - 11:59:59	18988	3.8%	5.27	2.0 GB	4.0%	587.79
Jun 3 12:00:00 - 12:59:59	18472	3.7%	5.13	2.2 GB	4.3%	637.13
Jun 3 13:00:00 - 13:59:59	21468	4.3%	5.96	2.5 GB	5.0%	730.74
Jun 3 14:00:00 - 14:59:59	19958	4.0%	5.54	2.6 GB	5.2%	758.14
Jun 3 15:00:00 - 15:59:59	20223	4.0%	5.62	2.4 GB	4.7%	691.41
Jun 3 16:00:00 - 16:59:59	20674	4.1%	5.74	2.3 GB	4.7%	682.29
Jun 3 17:00:00 - 17:59:59	21002	4.2%	5.83	1.9 GB	3.9%	566.41
Jun 3 18:00:00 - 18:59:59	22233	4.4%	6.18	1.9 GB	3.7%	547.17
Jun 3 19:00:00 - 19:59:59	23307	4.6%	6.47	1.3 GB	2.6%	375.60
Jun 3 20:00:00 - 20:59:59	20825	4.1%	5.78	1.9 GB	3.8%	555.32
Jun 3 21:00:00 - 21:59:59	21134	4.2%	5.87	2.2 GB	4.4%	645.19
Jun 3 22:00:00 - 22:59:59	26540	5.3%	7.37	2.2 GB	4.3%	634.67
Jun 3 23:00:00 - 23:59:59	24558	4.9%	6.82	2.2 GB	4.4%	639.03
Jun 4 00:00:00 - 00:59:59	21637	4.3%	6.01	1.0 GB	2.0%	296.60
Jun 4 01:00:00 - 01:59:59	24485	4.9%	6.80	1.7 GB	3.5%	506.18
Jun 4 02:00:00 - 02:59:59	26121	5.2%	7.26	2.1 GB	4.1%	601.68
Jun 4 03:00:00 - 03:00:01	11	0.0%	11.00	1.1 MB	0.0%	1156.79

TOTAL: 23:59:59	504206	100.0%	5.84	50.3 GB	100.0%	610.87

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	124.3 GB	90.2%	201	100.90	16.58
02	BIN	137.8 GB	23.5 GB	17.0%	202	100.25	16.68
03	SMALL	13.0 GB	10.3 GB	79.4%	29	3.72	42.58
04	BIN	80.1 GB	55.4 GB	69.2%	157	50.14	19.38
05	BIN	80.1 GB	39.6 GB	49.5%	174	50.03	19.43
06	SMALL	13.0 GB	9.7 GB	74.4%	29	3.74	42.27
07	BIN	80.1 GB	44.0 GB	54.9%	157	50.64	19.19
08	BIN	80.1 GB	22.5 GB	28.1%	174	50.15	19.38
09	SMALL	13.0 GB	9.8 GB	75.3%	29	3.76	42.09
10	BIN	80.1 GB	37.8 GB	47.1%	157	50.51	19.25
11	BIN	80.1 GB	46.7 GB	58.4%	174	50.24	19.35
12	BIN	13.0 GB	1.9 GB	14.2%	606	50.44	3.14
13	BIN	80.1 GB	391.0 MB	0.5%	99	50.72	19.17
14	SMALL	80.1 GB	75.6 GB	94.4%	3	3.77	257.93

TOTAL: 14	-	968.5 GB	501.6 GB	51.8%	2191	44.22	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	53802	53072	0	79	0	0	0	0	651

TOTAL: 1		53802	53072	0	79	0	0	0	0	651

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	15377
alt.binaries.chaka	10776
alt.binaries.pcgame	1700
microsoft.public.test	1160
alt.binaries.nospam.female.short-hair	966
alt.binaries.pictures.erotica.torture.alt.binaries.pictures.erotica	728
newsland.discussioni.suggerimenti	700
alt.binaries.united-forums	530
alt.binaries.pictures.erotica.torture.alt.binaries	377
alt.bin.sex	307
alt.bin.warez.ibm-pc-games	305
alt.bin.warez	277
alt.binaer.erotik	272
alt.binaries.multimedia.drama	241
alt.binaires	239
alt.binaires.holland	234
tin.it.sport.calcio	234
alt.binares.misc	227
alt.binaries.fetish	226
alt.binaires.deutsch	220

TOTAL: 1526	53072

INND misc events:

Events	Count

CCreader	3

TOTAL: 1	3

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad newsgroups received
	SERVER	2
	TOTAL: 1	2
Including strange strings
	192.168.33.37	650
	TOTAL: 1	650

TOTAL: 2		652

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	1	10256	457.6 MB	7	0	0	08:42:11
2	194.186.188.92	1	4	533.4 KB	0	0	0	00:21:13

TOTAL: 2		2	10260	458.1 MB	7	0	0	10:40:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	1	10256	457.6 MB	7	0	0	08:42:11
2	unresolved	1	4	533.4 KB	0	0	0	00:21:13
3	*.sarov.dial.rol.ru	2	0	0.0 KB	0	0	0	00:00:00
4	*.tony.pp.ru	75	0	0.0 KB	0	0	0	00:02:33
5	*.net.rol.ru	8	0	0.0 KB	0	0	0	01:19:59
6	*.rol.ru	5767	0	0.0 KB	0	0	0	00:14:28

TOTAL: 6		5854	10260	458.1 MB	7	0	0	10:40:28

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	7.156	10.865	0.000	08:42:11
modul-gw000.net.rol.ru	0.020	0.012	0.000	01:19:59
194.186.188.92	0.000	0.000	0.000	00:21:13
balancer-b.rol.ru	3.380	3.252	0.000	00:07:53
balancer-a.rol.ru	3.508	3.348	0.000	00:06:35
net1-x-ring.tony.pp.ru	0.148	0.120	0.000	00:02:33
ts2-a17.sarov.dial.rol.ru	0.000	0.000	0.000	00:00:00

TOTAL: 7	14.212	17.597	0.000	10:40:28

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2885
balancer-b.rol.ru	2882
net1-x-ring.tony.pp.ru	75
modul-gw000.net.rol.ru	8
ts2-a17.sarov.dial.rol.ru	2

TOTAL: 5	5852

NNRP client timeouts [Top 20]:

System	Conn	Peer

modul-gw000.net.rol.ru	1	0

TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	10247	99.9%
2	hr	9	0.1%

TOTAL: 2		10256	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.bras	4831
2	alt.mag.playboy	2876
3	alt.binaries.multimedia.erotic.playboy	1131
4	alt.binaries.full.post.verified.playboy	1049
5	alt.binaries.pictures.girls	360
6	hr.alt.seks.binaries.playboy	9

TOTAL: 6		10256