Daily Usenet report

Jul 13 03:00:02 -- Jul 14 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
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
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 24 / 24 lines (100.0%)
Jul 13 05:01:35 andromeda nnrpd[11680]: SM could not find token type or method was not initialized (0)
Jul 13 07:33:28 andromeda controlchan[20796]: Unknown "cmsg" control by xfantasy.bbs@bbs.cs.nctu.edu.tw
Jul 13 08:43:27 andromeda controlchan[20796]: Unknown "cmsg" control by markcupcup.bbs@bbs.cs.nctu.edu.tw
Jul 13 08:43:28 andromeda controlchan[20796]: Unknown "cmsg" control by markcupcup.bbs@bbs.cs.nctu.edu.tw
Jul 13 09:28:21 andromeda nnrpd[17048]: SM could not find token type or method was not initialized (0)
Jul 13 10:23:27 andromeda controlchan[20796]: Unknown "cmsg" control by ccajb.bbs@bbs.cs.nctu.edu.tw
Jul 13 10:23:27 andromeda controlchan[20796]: Unknown "cmsg" control by ccajb.bbs@bbs.cs.nctu.edu.tw
Jul 13 10:43:30 andromeda controlchan[20796]: Unknown "cmsg" control by sentital.bbs@bbs.cs.nctu.edu.tw
Jul 13 10:43:30 andromeda controlchan[20796]: Unknown "cmsg" control by sentital.bbs@bbs.cs.nctu.edu.tw
Jul 13 11:23:31 andromeda controlchan[20796]: Unknown "cmsg" control by ccajb.bbs@bbs.cs.nctu.edu.tw
Jul 13 13:53:24 andromeda nnrpd[21791]: SM could not find token type or method was not initialized (0)
Jul 13 14:33:28 andromeda controlchan[20796]: Unknown "cmsg" control by www123.bbs@bbs.cs.nctu.edu.tw
Jul 13 15:08:02 andromeda controlchan[20796]: skipping newgroup alt.comp.lang.lua y markhobley@hotpop.donottypethisbit.com (would be created)
Jul 13 15:23:33 andromeda controlchan[20796]: Unknown "cmsg" control by mei78120.bbs@bbs.cs.nctu.edu.tw
Jul 13 16:13:29 andromeda controlchan[20796]: Unknown "cmsg" control by zeromic.bbs@bbs.cs.nctu.edu.tw
Jul 13 17:23:29 andromeda controlchan[20796]: Unknown "cmsg" control by azwxyz.bbs@bbs.cs.nctu.edu.tw
Jul 13 17:53:26 andromeda controlchan[20796]: Unknown "cmsg" control by Lundy.bbs@bbs.cs.nctu.edu.tw
Jul 13 19:23:27 andromeda controlchan[20796]: Unknown "cmsg" control by riddle216.bbs@bbs.cs.nctu.edu.tw
Jul 13 20:13:29 andromeda controlchan[20796]: Unknown "cmsg" control by FOREVER3.bbs@bbs.cs.nctu.edu.tw
Jul 13 20:13:29 andromeda controlchan[20796]: Unknown "cmsg" control by FOREVER3.bbs@bbs.cs.nctu.edu.tw
Jul 13 20:33:27 andromeda controlchan[20796]: Unknown "cmsg" control by yucandy77.bbs@bbs.cs.nctu.edu.tw
Jul 13 22:13:34 andromeda controlchan[20796]: Unknown "cmsg" control by abcd123.bbs@bbs.cs.nctu.edu.tw
Jul 13 22:23:29 andromeda controlchan[20796]: Unknown "cmsg" control by sada.bbs@bbs.cs.nctu.edu.tw
Jul 13 22:33:28 andromeda controlchan[20796]: Unknown "cmsg" control by breeze11.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	475811	93.9%	42.4 MB	92.4%
nnrpd	17900	3.5%	1.8 MB	3.8%
innd	10610	2.1%	1.3 MB	2.9%
cnfsstat	2304	0.5%	401.6 KB	0.9%
controlchan	22	0.0%	2.5 KB	0.0%

TOTAL: 5	506647	100.0%	45.8 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	468267	94.4%
Negative hits	24664	5.0%
Positive hits	2846	0.6%
Cache misses	328	0.1%

TOTAL: 4	496105	100.0%

INND timer:

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

article cancel	00:00:02.972	0.0%	4429	0.000	0.671	154.000
article cleanup	00:00:06.012	0.0%	467199	0.000	0.013	0.051
article logging	00:00:37.466	0.0%	471377	0.000	0.079	11.317
article parse	00:02:45.987	0.2%	31884121	0.000	0.005	0.095
article write	00:21:26.159	1.5%	434160	0.219	2.962	16.575
artlog/artcncl	00:00:00.057	0.0%	4406	0.000	0.013	4.667
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:01:00.039	0.1%	33703021	0.000	0.002	0.014
hisgrep/artcncl	00:00:01.033	0.0%	2962	0.000	0.349	52.000
hishave/artcncl	00:00:01.240	0.0%	4429	0.000	0.280	154.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:04:10.490	0.3%	491954	0.000	0.509	8.428
history sync	00:00:00.431	0.0%	358	0.000	1.204	2.000
history write	00:09:15.061	0.6%	467049	0.007	1.188	19.270
hiswrite/artcncl	00:00:00.590	0.0%	1467	0.000	0.402	14.000
idle	21:28:44.903	89.5%	31795849	0.000	2.432	32.058
nntp read	00:03:18.168	0.2%	31885034	0.002	0.006	0.089
overview write	01:41:55.458	7.1%	434160	1.318	14.086	21557.875
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%	21	0.000	0.000	0.000

TOTAL: 24:00:03.271	23:53:26.066	99.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:00:53.302	0.1%	25659	0.000	2.077	0.000
idle	14:00:11.641	98.2%	57174	0.857	881.723	8236.525
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:07:36.798	0.9%	391935	0.000	1.165	0.000
readart	00:03:18.965	0.4%	51505	0.000	3.863	0.000

TOTAL: 14:15:42.164	14:12:00.706	99.6%	-	-	-	-

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

markhobley@hotpop.donottypethisbit.com	1	0	0	0	0	1

TOTAL	1	0	0	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	1405	464832	431654	63	33115	92%	262:35:01

TOTAL: 1		1405	464832	431654	63	33115	92%	262:35:01

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	43.1 GB	2.4 MB	43.1 GB	99%	97.3 KB	262:35:01

TOTAL: 1		43.1 GB	2.4 MB	43.1 GB	99%	97.3 KB	262:35:01

Incoming articles:

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

Jul 13 03:00:02 - 03:59:59	17909	4.1%	4.98	2.2 GB	5.1%	637.95
Jul 13 04:00:00 - 04:59:59	17329	4.0%	4.81	2.3 GB	5.3%	670.65
Jul 13 05:00:00 - 05:59:59	12792	2.9%	3.55	1.5 GB	3.4%	430.14
Jul 13 06:00:00 - 06:59:59	15073	3.5%	4.19	1.6 GB	3.6%	457.54
Jul 13 07:00:00 - 07:59:59	14908	3.4%	4.14	1.9 GB	4.3%	544.27
Jul 13 08:00:00 - 08:59:59	13452	3.1%	3.74	2.0 GB	4.6%	573.04
Jul 13 09:00:00 - 09:59:59	19636	4.5%	5.45	1.6 GB	3.6%	456.05
Jul 13 10:00:00 - 10:59:59	13719	3.2%	3.81	1.5 GB	3.4%	432.07
Jul 13 11:00:00 - 11:59:59	15468	3.6%	4.30	2.0 GB	4.6%	572.10
Jul 13 12:00:00 - 12:59:59	16480	3.8%	4.58	2.0 GB	4.5%	568.38
Jul 13 13:00:00 - 13:59:59	16740	3.9%	4.65	1.8 GB	4.2%	526.00
Jul 13 14:00:00 - 14:59:59	18501	4.3%	5.14	1.9 GB	4.4%	549.05
Jul 13 15:00:00 - 15:59:59	27387	6.3%	7.61	1.6 GB	3.6%	452.14
Jul 13 16:00:00 - 16:59:59	20134	4.6%	5.59	1.6 GB	3.7%	461.03
Jul 13 17:00:00 - 17:59:59	18678	4.3%	5.19	2.0 GB	4.6%	581.08
Jul 13 18:00:00 - 18:59:59	18793	4.3%	5.22	1.8 GB	4.1%	518.35
Jul 13 19:00:00 - 19:59:59	17910	4.1%	4.97	1.6 GB	3.8%	471.42
Jul 13 20:00:00 - 20:59:59	17166	4.0%	4.77	1.6 GB	3.6%	457.83
Jul 13 21:00:00 - 21:59:59	21010	4.8%	5.84	1.8 GB	4.2%	533.42
Jul 13 22:00:00 - 22:59:59	22275	5.1%	6.19	1.8 GB	4.1%	514.10
Jul 13 23:00:00 - 23:59:59	21593	5.0%	6.00	2.0 GB	4.6%	572.45
Jul 14 00:00:00 - 00:59:59	18495	4.3%	5.14	1.6 GB	3.6%	455.37
Jul 14 01:00:00 - 01:59:59	17760	4.1%	4.93	1.7 GB	3.9%	489.46
Jul 14 02:00:00 - 02:59:59	20983	4.8%	5.83	2.2 GB	5.0%	627.21
Jul 14 03:00:00 - 03:00:02	11	0.0%	5.50	1.4 MB	0.0%	699.08

TOTAL: 24:00:00	434202	100.0%	5.03	43.1 GB	100.0%	522.96

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	18.8 GB	13.6%	204	86.06	19.43
02	BIN	137.8 GB	55.0 GB	39.9%	204	85.71	19.51
03	SMALL	13.0 GB	8.3 GB	64.0%	30	3.18	49.70
04	BIN	80.1 GB	49.2 GB	61.4%	159	42.93	22.64
05	BIN	80.1 GB	33.1 GB	41.3%	176	42.97	22.62
06	SMALL	13.0 GB	7.7 GB	58.9%	30	3.16	50.07
07	BIN	80.1 GB	37.6 GB	47.0%	159	42.79	22.72
08	BIN	80.1 GB	16.2 GB	20.3%	176	43.05	22.58
09	SMALL	13.0 GB	7.8 GB	59.8%	30	3.14	50.41
10	BIN	80.1 GB	31.4 GB	39.2%	159	43.10	22.55
11	BIN	80.1 GB	40.2 GB	50.1%	176	43.16	22.52
12	BIN	13.0 GB	12.3 GB	94.7%	617	43.12	3.67
13	BIN	80.1 GB	74.1 GB	92.6%	100	43.13	22.54
14	SMALL	80.1 GB	6.6 GB	8.2%	4	3.18	305.54

TOTAL: 14	-	968.5 GB	398.4 GB	41.1%	2224	37.76	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	37203	32886	0	150	0	0	0	0	4167

TOTAL: 1		37203	32886	0	150	0	0	0	0	4167

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	4855
alt.binaries.pictures.comics.complete	2836
alt.binaries.blu-ray	1930
alt.binaries.gamecube	1166
microsoft.public.test	1150
alt.binaries.pcgame	1046
newsland.discussioni.suggerimenti	627
alt.pictures.erotic	620
alt.binaries.nospam.female.short-hair	496
alt.binaries.nu	477
alt.binaries.usewarez	439
alt.binaries.kleverig	391
alt.binaries.erotica.fetishs	341
alt.binaries.erotica.kinky.teens	332
alt.binaries.bondagemovies	286
alt.binaries.erotica.multimedia.bondage	256
alt.binaries.warez.ibm-pc.apps	221
hr.soc.grad.split.binaries	213
alt.binaries.celebrities.alist	188
alt.sex.telephone.alt	169

TOTAL: 1290	32886

INND misc events:

Events	Count

CCreader	3

TOTAL: 1	3

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad newsgroups received
	SERVER	10
	TOTAL: 1	10
Including strange strings
	192.168.33.37	4167
	TOTAL: 1	4167

TOTAL: 2		4177

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	2	25549	763.4 MB	21	0	0	13:21:30

TOTAL: 1		2	25766	774.9 MB	33	0	2	14:15:42

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	2	25549	763.4 MB	21	0	0	13:21:30
2	*.cis.ru	2	0	0.0 KB	0	0	0	00:02:05
3	*.sarov.dial.rol.ru	2	0	0.0 KB	0	0	0	00:00:01
4	*.rol.ru	5763	0	0.0 KB	0	0	0	00:12:27
5	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00

TOTAL: 5		5770	25766	774.9 MB	33	0	1	14:15:19

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	21.312	26.991	0.000	13:21:30
194.186.188.92	0.040	0.176	0.000	00:39:14
balancer-b.rol.ru	4.124	3.652	0.000	00:06:26
balancer-a.rol.ru	4.168	3.600	0.000	00:06:00
sword.cis.ru	0.236	0.352	0.000	00:02:05
net1-x-ring.tony.pp.ru	0.208	0.188	0.000	00:00:23
ts2-a13.sarov.dial.rol.ru	0.000	0.000	0.000	00:00:01
82-208-107-30.dialup.mts-nn.ru	0.004	0.004	0.000	00:00:00
web02.tr155m.lavtech.ru	0.004	0.004	0.000	00:00:00

TOTAL: 9	30.096	34.967	0.000	14:15:42

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2882
balancer-b.rol.ru	2881
sword.cis.ru	2
ts2-a13.sarov.dial.rol.ru	2
web02.tr155m.lavtech.ru	1

TOTAL: 5	5768

NNRP no permission clients:

System	Conn

net1-x-ring.tony.pp.ru	135
82-208-107-30.dialup.mts-nn.ru	2

TOTAL: 2	137

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	20992	99.9%
2	hr	16	0.1%

TOTAL: 2		21008	100.0%

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

Newsgroup		Count

1	alt.binaries.full.post.verified.playboy	8500
2	alt.mag.playboy	5958
3	alt.binaries.pictures.bras	3436
4	alt.binaries.multimedia.erotic.playboy	2199
5	alt.binaries.pictures.girls	682
6	alt.binaries.multimedia.adolescents	110
7	alt.binaries.multimedia.erotica.voyeurism	107
8	hr.alt.seks.binaries.playboy	16

TOTAL: 8		21008