Daily Usenet report

May 2 03:00:02 -- May 3 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
Supposedly-moderated groups with unmoderated postings
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 21 / 21 lines (100.0%)
May 2 03:35:33 andromeda controlchan[1414]: Unknown "cmsg" control by moja.bbs@bbs.cs.nctu.edu.tw
May 2 03:45:38 andromeda controlchan[1414]: Unknown "cmsg" control by moja.bbs@bbs.cs.nctu.edu.tw
May 2 06:14:21 andromeda controlchan[1414]: Unknown "cmsg" control by liou888.bbs@bbs.cs.nctu.edu.tw
May 2 08:14:22 andromeda controlchan[1414]: Unknown "cmsg" control by JayBruce.bbs@bbs.cs.nctu.edu.tw
May 2 08:14:23 andromeda controlchan[1414]: Unknown "cmsg" control by JayBruce.bbs@bbs.cs.nctu.edu.tw
May 2 12:43:13 andromeda controlchan[1414]: Unknown "cmsg" control by engineer.bbs@bbs.cs.nctu.edu.tw
May 2 14:23:12 andromeda controlchan[1414]: Unknown "cmsg" control by theut2001.bbs@bbs.cs.nctu.edu.tw
May 2 14:23:13 andromeda controlchan[1414]: Unknown "cmsg" control by sisleylotte.bbs@bbs.cs.nctu.edu.tw
May 2 14:23:13 andromeda controlchan[1414]: Unknown "cmsg" control by sisleylotte.bbs@bbs.cs.nctu.edu.tw
May 2 18:13:09 andromeda controlchan[1414]: Unknown "cmsg" control by liou888.bbs@bbs.cs.nctu.edu.tw
May 2 18:13:10 andromeda controlchan[1414]: Unknown "cmsg" control by liou888.bbs@bbs.cs.nctu.edu.tw
May 2 18:23:20 andromeda controlchan[1414]: Unknown "cmsg" control by liou888.bbs@bbs.cs.nctu.edu.tw
May 2 18:23:22 andromeda controlchan[1414]: Unknown "cmsg" control by HSNUemmy.bbs@bbs.cs.nctu.edu.tw
May 2 18:43:19 andromeda controlchan[1414]: Unknown "cmsg" control by oga.bbs@bbs.cs.nctu.edu.tw
May 2 18:43:20 andromeda controlchan[1414]: Unknown "cmsg" control by tanoshii.bbs@bbs.cs.nctu.edu.tw
May 2 18:43:24 andromeda controlchan[1414]: Unknown "cmsg" control by oga.bbs@bbs.cs.nctu.edu.tw
May 2 19:23:13 andromeda controlchan[1414]: Unknown "cmsg" control by userm.bbs@bbs.cs.nctu.edu.tw
May 2 19:54:12 andromeda controlchan[1414]: Unknown "cmsg" control by clover04.bbs@bbs.cs.nctu.edu.tw
May 3 00:08:03 andromeda controlchan[1414]: skipping newgroup alt.comp.cygwin y markhobley@hotpop.donottypethisbit.com (would be created)
May 3 00:38:48 andromeda controlchan[1414]: Unknown "cmsg" control by ilanman.bbs@bbs.cs.nctu.edu.tw
May 3 00:39:37 andromeda controlchan[1414]: Unknown "cmsg" control by SepHiRoS.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	467962	93.7%	42.0 MB	92.2%
nnrpd	18159	3.6%	1.8 MB	3.9%
innd	11228	2.2%	1.4 MB	3.0%
cnfsstat	2304	0.5%	401.1 KB	0.9%
controlchan	24	0.0%	2.5 KB	0.0%

TOTAL: 5	499677	100.0%	45.6 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	464779	95.0%
Negative hits	21930	4.5%
Positive hits	1506	0.3%
Cache misses	885	0.2%

TOTAL: 4	489100	100.0%

INND timer:

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

article cancel	00:00:10.497	0.0%	8619	0.000	1.218	133.000
article cleanup	00:00:06.031	0.0%	458775	0.000	0.013	0.062
article logging	00:00:36.988	0.0%	459456	0.000	0.081	7.281
article parse	00:03:01.583	0.2%	34871053	0.002	0.005	0.089
article write	00:23:00.375	1.6%	418923	0.355	3.295	15.993
artlog/artcncl	00:00:00.986	0.0%	8592	0.000	0.115	20.884
artlog/artparse	00:00:00.001	0.0%	20	0.000	0.050	0.100
data move	00:01:05.704	0.1%	36826270	0.000	0.002	0.009
hisgrep/artcncl	00:00:05.704	0.0%	2258	0.000	2.526	110.200
hishave/artcncl	00:00:01.379	0.0%	8619	0.000	0.160	22.800
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:06:08.122	0.4%	480758	0.000	0.766	9.781
history sync	00:00:00.408	0.0%	357	0.000	1.143	5.000
history write	00:07:56.161	0.6%	458682	0.000	1.038	24.753
hiswrite/artcncl	00:00:02.354	0.0%	6361	0.000	0.370	12.865
idle	21:48:06.843	90.8%	34790655	0.000	2.256	26.087
nntp read	00:03:36.150	0.3%	34876736	0.002	0.006	0.084
overview write	01:19:17.494	5.5%	418923	1.348	11.356	13060.083
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%	23	0.000	0.000	0.000

TOTAL: 24:00:24.477	23:53:16.780	99.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:00:36.826	0.0%	21803	0.000	1.689	0.000
idle	25:06:08.485	99.4%	50095	0.857	1803.942	200141.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:01:50.830	0.1%	149695	0.000	0.740	0.000
readart	00:03:28.816	0.2%	48751	0.000	4.283	0.000

TOTAL: 25:15:51.670	25:12:04.957	99.8%	-	-	-	-

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

hun-mnt@news.sztaki.hu	0	0	1	0	0	1
markhobley@hotpop.donottypethisbit.com	1	0	0	0	0	1
moderator@dana.de	0	0	1	0	1	1

TOTAL	1	0	2	0	1	3

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	1553	451667	409945	40	41682	90%	267:36:01

TOTAL: 1		1553	451667	409945	40	41682	90%	267:36:01

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	44.6 GB	961.5 KB	44.6 GB	99%	103.5 KB	267:36:01

TOTAL: 1		44.6 GB	961.5 KB	44.6 GB	99%	103.5 KB	267:36:01

Incoming articles:

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

May 2 03:00:02 - 03:59:59	16993	4.1%	4.72	1.9 GB	4.2%	557.63
May 2 04:00:00 - 04:59:59	16324	3.9%	4.53	1.9 GB	4.2%	545.65
May 2 05:00:00 - 05:59:59	20009	4.8%	5.56	2.1 GB	4.6%	600.23
May 2 06:00:00 - 06:59:59	14478	3.5%	4.02	1.9 GB	4.2%	552.02
May 2 07:00:00 - 07:59:59	18350	4.4%	5.10	2.3 GB	5.1%	672.67
May 2 08:00:00 - 08:59:59	15828	3.8%	4.40	2.1 GB	4.6%	603.73
May 2 09:00:00 - 09:59:59	15377	3.7%	4.27	1.9 GB	4.2%	549.40
May 2 10:00:00 - 10:59:59	15687	3.7%	4.36	2.0 GB	4.5%	585.19
May 2 11:00:00 - 11:59:59	17400	4.2%	4.83	2.2 GB	5.0%	650.76
May 2 12:00:00 - 12:59:59	17035	4.1%	4.73	1.9 GB	4.2%	557.46
May 2 13:00:00 - 13:59:59	14384	3.4%	4.00	1.5 GB	3.3%	433.96
May 2 14:00:00 - 14:59:59	16151	3.9%	4.49	2.0 GB	4.4%	572.67
May 2 15:00:00 - 15:59:59	17031	4.1%	4.73	2.1 GB	4.6%	609.08
May 2 16:00:00 - 16:59:59	18406	4.4%	5.11	2.1 GB	4.8%	624.49
May 2 17:00:00 - 17:59:59	17357	4.1%	4.82	2.0 GB	4.4%	576.19
May 2 18:00:00 - 18:59:59	18220	4.4%	5.06	2.0 GB	4.5%	585.63
May 2 19:00:00 - 19:59:59	17076	4.1%	4.74	1.8 GB	4.1%	533.03
May 2 20:00:00 - 20:59:59	19744	4.7%	5.48	1.7 GB	3.8%	502.40
May 2 21:00:00 - 21:59:59	18828	4.5%	5.23	1.8 GB	4.0%	519.36
May 2 22:00:00 - 22:59:59	17281	4.1%	4.80	1.9 GB	4.2%	554.49
May 2 23:00:00 - 23:59:59	17048	4.1%	4.74	1.5 GB	3.2%	425.61
May 3 00:00:00 - 00:59:59	16865	4.0%	4.68	1.0 GB	2.3%	300.62
May 3 01:00:00 - 01:59:59	22468	5.4%	6.24	1.5 GB	3.3%	428.71
May 3 02:00:00 - 02:59:59	20480	4.9%	5.69	2.1 GB	4.6%	598.09
May 3 03:00:00 - 03:00:02	13	0.0%	6.50	1.3 MB	0.0%	666.33

TOTAL: 24:00:00	418833	100.0%	4.85	45.1 GB	100.0%	547.46

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	85.3 GB	61.9%	200	90.57	18.47
02	BIN	137.8 GB	122.5 GB	88.9%	200	89.68	18.65
03	SMALL	13.0 GB	1.1 GB	8.5%	29	2.58	61.40
04	BIN	80.1 GB	47.0 GB	58.7%	156	45.39	21.42
05	BIN	80.1 GB	31.3 GB	39.1%	173	45.34	21.44
06	SMALL	13.0 GB	503.7 MB	3.8%	29	2.60	60.95
07	BIN	80.1 GB	35.6 GB	44.4%	156	45.42	21.40
08	BIN	80.1 GB	14.3 GB	17.8%	173	45.30	21.46
09	SMALL	13.0 GB	611.1 MB	4.6%	29	2.60	60.85
10	BIN	80.1 GB	29.3 GB	36.6%	156	45.23	21.49
11	BIN	80.1 GB	38.5 GB	48.1%	173	45.41	21.41
12	BIN	13.0 GB	4.6 GB	35.0%	599	45.19	3.50
13	BIN	80.1 GB	72.1 GB	90.1%	97	45.42	21.40
14	SMALL	80.1 GB	66.4 GB	82.9%	3	2.60	374.33

TOTAL: 14	-	968.5 GB	549.2 GB	56.7%	2173	39.55	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	40537	39742	0	93	1	0	0	0	701

TOTAL: 1		40537	39742	0	93	1	0	0	0	701

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	18298
alt.binaries.pictures.comics.complete	1342
microsoft.public.test	1152
alt.binaries.boys	1017
alt.binaries.pcgame	894
alt.binaries.kleverig	830
alt.binaries.pictures.katie	654
alt.binaries.jimmy	537
alt.binaries.erotica.vintage	471
alt.binaries.movie	362
alt.binaries.fetish	226
alt.binaries.ibm-pc.german	216
alt.binaries.ibm-pc.old	204
alt.binaries.german.underground	201
alt.binaries.pictures.kate	200
alt.binaries.x264	191
alt.binaries.ibm.pc.warez	188
alt.binaries.german.whatever	176
alt.binaries.high.speed	174
alt.binaries.ibm-pc	169

TOTAL: 1289	39742

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count

de.alt.fan.tabak	1

TOTAL: 1	1

INND misc events:

Events	Count

CCreader	4

TOTAL: 1	4

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	681
	TOTAL: 1	681

TOTAL: 1		681

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	3	21803	1.1 GB	21	0	0	24:48:09
2	rol22.rol.kis.ru	1	4	47.3 KB	2	0	0	00:00:28

TOTAL: 2		4	21807	1.1 GB	23	0	2	25:15:52

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	3	21803	1.1 GB	21	0	0	24:48:09
2	*.rol.kis.ru	1	4	47.3 KB	2	0	0	00:00:28
3	*.sovintel.net	13	0	0.0 KB	0	0	0	00:00:01
4	*.sarov.dial.rol.ru	1	0	0.0 KB	0	0	0	00:10:00
5	unresolved	2	0	0.0 KB	0	0	0	00:00:12
6	*.tony.pp.ru	71	0	0.0 KB	0	0	0	00:02:26
7	*.rol.ru	5760	0	0.0 KB	0	0	0	00:14:32
8	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00

TOTAL: 8		5852	21807	1.1 GB	23	0	1	25:15:51

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	20.744	28.075	0.000	24:48:09
ts2-a111.sarov.dial.rol.ru	0.020	0.004	0.000	00:10:00
balancer-a.rol.ru	3.296	3.256	0.000	00:07:21
balancer-b.rol.ru	3.036	3.240	0.000	00:07:10
net1-x-ring.tony.pp.ru	0.096	0.152	0.000	00:02:26
rol22.rol.kis.ru	0.004	0.004	0.000	00:00:28
195.218.244.87	0.024	0.040	0.000	00:00:12
fw-nat.sovintel.net	0.064	0.028	0.000	00:00:01
cornholio.migtel.ru	0.012	0.032	0.000	00:00:00
web02.tr155m.lavtech.ru	0.004	0.000	0.000	00:00:00
82-208-107-38.dialup.mts-nn.ru	0.004	0.000	0.000	00:00:00

TOTAL: 11	27.304	34.831	0.000	25:15:52

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2880
balancer-a.rol.ru	2880
net1-x-ring.tony.pp.ru	71
fw-nat.sovintel.net	13
195.218.244.87	2
ts2-a111.sarov.dial.rol.ru	1
web02.tr155m.lavtech.ru	1

TOTAL: 7	5848

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	21
82-208-107-38.dialup.mts-nn.ru	1

TOTAL: 2	22

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a111.sarov.dial.rol.ru	1	0

TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	21788	99.9%
2	hr	24	0.1%
3	lada	4	0.0%

TOTAL: 3		21816	100.0%

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

Newsgroup		Count

1	alt.mag.playboy	10950
2	alt.binaries.pictures.bras	5514
3	alt.binaries.full.post.verified.playboy	3143
4	alt.binaries.multimedia.erotic.playboy	1225
5	alt.binaries.pictures.girls	956
6	hr.alt.seks.binaries.playboy	24
7	lada.music	4

TOTAL: 7		21816