Daily Usenet report

Dec 14 03:00:02 -- Dec 15 03:00:01

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
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 31 / 31 lines (100.0%)
Dec 14 06:35:57 andromeda controlchan[23909]: Unknown "cmsg" control by daka.bbs@bbs.cs.nctu.edu.tw
Dec 14 06:45:35 andromeda controlchan[23909]: Unknown "cmsg" control by StUnion.bbs@bbs.cs.nctu.edu.tw
Dec 14 06:45:35 andromeda controlchan[23909]: Unknown "cmsg" control by StUnion.bbs@bbs.cs.nctu.edu.tw
Dec 14 07:26:07 andromeda controlchan[23909]: Unknown "cmsg" control by stella1243.bbs@bbs.cs.nctu.edu.tw
Dec 14 07:26:08 andromeda controlchan[23909]: Unknown "cmsg" control by nctugraduate.bbs@bbs.cs.nctu.edu.tw
Dec 14 10:05:33 andromeda controlchan[23909]: Unknown "cmsg" control by fishau3.bbs@bbs.cs.nctu.edu.tw
Dec 14 11:25:56 andromeda controlchan[23909]: Unknown "cmsg" control by lacandy31.bbs@bbs.cs.nctu.edu.tw
Dec 14 11:25:56 andromeda controlchan[23909]: Unknown "cmsg" control by funnye826.bbs@bbs.cs.nctu.edu.tw
Dec 14 12:36:14 andromeda controlchan[23909]: Unknown "cmsg" control by lacandy31.bbs@bbs.cs.nctu.edu.tw
Dec 14 15:05:56 andromeda controlchan[23909]: Unknown "cmsg" control by clairecherry.bbs@bbs.cs.nctu.edu.tw
Dec 14 15:35:55 andromeda controlchan[23909]: Unknown "cmsg" control by MBACamp.bbs@bbs.cs.nctu.edu.tw
Dec 14 15:35:55 andromeda controlchan[23909]: Unknown "cmsg" control by MBACamp.bbs@bbs.cs.nctu.edu.tw
Dec 14 15:35:55 andromeda controlchan[23909]: Unknown "cmsg" control by MBACamp.bbs@bbs.cs.nctu.edu.tw
Dec 14 15:35:55 andromeda controlchan[23909]: Unknown "cmsg" control by MBACamp.bbs@bbs.cs.nctu.edu.tw
Dec 14 16:55:49 andromeda controlchan[23909]: Unknown "cmsg" control by oh2011.bbs@bbs.cs.nctu.edu.tw
Dec 14 16:55:49 andromeda controlchan[23909]: Unknown "cmsg" control by oh2011.bbs@bbs.cs.nctu.edu.tw
Dec 14 16:55:49 andromeda controlchan[23909]: Unknown "cmsg" control by oh2011.bbs@bbs.cs.nctu.edu.tw
Dec 14 16:55:49 andromeda controlchan[23909]: Unknown "cmsg" control by oh2011.bbs@bbs.cs.nctu.edu.tw
Dec 14 17:36:01 andromeda controlchan[23909]: Unknown "cmsg" control by silvain0313.bbs@bbs.cs.nctu.edu.tw
Dec 14 17:45:51 andromeda controlchan[23909]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Dec 14 17:55:50 andromeda controlchan[23909]: Unknown "cmsg" control by cindy.bbs@bbs.cs.nctu.edu.tw
Dec 14 18:36:01 andromeda controlchan[23909]: Unknown "cmsg" control by namida.bbs@bbs.cs.nctu.edu.tw
Dec 14 19:26:04 andromeda controlchan[23909]: Unknown "cmsg" control by dennisieur.bbs@bbs.cs.nctu.edu.tw
Dec 14 19:26:05 andromeda controlchan[23909]: Unknown "cmsg" control by dennisieur.bbs@bbs.cs.nctu.edu.tw
Dec 14 19:26:05 andromeda controlchan[23909]: Unknown "cmsg" control by dennisieur.bbs@bbs.cs.nctu.edu.tw
Dec 14 19:36:18 andromeda controlchan[23909]: Unknown "cmsg" control by HMmeichu.bbs@bbs.cs.nctu.edu.tw
Dec 14 19:36:18 andromeda controlchan[23909]: Unknown "cmsg" control by HMmeichu.bbs@bbs.cs.nctu.edu.tw
Dec 14 19:36:18 andromeda controlchan[23909]: Unknown "cmsg" control by HMmeichu.bbs@bbs.cs.nctu.edu.tw
Dec 14 19:36:18 andromeda controlchan[23909]: Unknown "cmsg" control by HMmeichu.bbs@bbs.cs.nctu.edu.tw
Dec 15 00:01:04 andromeda pgpverify[15929]: pgpverify: verification failed
Dec 15 00:01:04 andromeda controlchan[23909]: skipping checkgroups newgroups-request@fido7.ru(pgpverify failed) in <1292360460.17119@fido7.ru>

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	406447	92.8%	35.3 MB	91.0%
nnrpd	18019	4.1%	1.8 MB	4.5%
innd	11127	2.5%	1.3 MB	3.5%
cnfsstat	2304	0.5%	400.4 KB	1.0%
controlchan	30	0.0%	3.0 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%

TOTAL: 6	437928	100.0%	38.8 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	401866	92.6%
Negative hits	28641	6.6%
Positive hits	3019	0.7%
Cache misses	297	0.1%

TOTAL: 4	433823	100.0%

INND timer:

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

article cancel	00:00:05.280	0.0%	2755	0.000	1.917	465.000
article cleanup	00:00:05.336	0.0%	402341	0.000	0.013	0.059
article logging	00:00:28.332	0.0%	403606	0.000	0.070	10.276
article parse	00:02:04.378	0.1%	23204793	0.001	0.005	0.093
article write	00:16:31.762	1.1%	391633	0.194	2.532	39.778
artlog/artcncl	00:00:00.045	0.0%	2709	0.000	0.017	1.375
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:45.902	0.1%	24744659	0.000	0.002	0.017
hisgrep/artcncl	00:00:03.482	0.0%	2544	0.000	1.369	73.619
hishave/artcncl	00:00:01.202	0.0%	2755	0.000	0.436	65.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:03:49.468	0.3%	431315	0.000	0.532	9.693
history sync	00:00:00.466	0.0%	441	0.000	1.057	2.000
history write	00:08:31.327	0.6%	401874	0.000	1.272	17.448
hiswrite/artcncl	00:00:00.517	0.0%	211	0.000	2.450	465.000
idle	21:25:53.525	89.3%	23085054	0.000	3.342	42.058
nntp read	00:02:27.863	0.2%	23196048	0.000	0.006	0.116
overview write	01:54:12.015	7.9%	391633	1.159	17.496	10323.375
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%	27	0.000	0.000	0.000

TOTAL: 23:59:57.707	23:55:00.900	99.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:00:20.740	0.1%	33978	0.000	0.610	0.000
idle	10:35:35.444	98.7%	73919	0.857	515.909	123271.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:28.462	0.1%	221702	0.000	0.128	0.000
readart	00:05:46.195	0.9%	68160	0.000	5.079	0.000

TOTAL: 10:43:49.242	10:42:10.841	99.7%	-	-	-	-

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	1345	392288	381621	307	10360	97%	250:59:03

TOTAL: 1		1345	392288	381621	307	10360	97%	250:59:03

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	33.5 GB	7.1 MB	33.5 GB	99%	89.6 KB	250:59:03

TOTAL: 1		33.5 GB	7.1 MB	33.5 GB	99%	89.6 KB	250:59:03

Incoming articles:

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

Dec 14 03:00:02 - 03:59:59	17626	4.5%	4.90	2.1 GB	6.1%	619.17
Dec 14 04:00:00 - 04:59:59	18780	4.8%	5.22	2.4 GB	6.8%	689.58
Dec 14 05:00:00 - 05:59:59	12930	3.3%	3.59	1.5 GB	4.2%	422.68
Dec 14 06:00:00 - 06:59:59	15085	3.9%	4.19	1.2 GB	3.4%	343.45
Dec 14 07:00:00 - 07:59:59	15869	4.1%	4.41	1.8 GB	5.3%	535.07
Dec 14 08:00:00 - 08:59:59	12814	3.3%	3.56	1.0 GB	3.0%	301.60
Dec 14 09:00:00 - 09:59:59	22338	5.7%	6.21	3.5 GB	10.2%	1029.05
Dec 14 10:00:00 - 10:59:59	18017	4.6%	5.00	2.3 GB	6.7%	677.26
Dec 14 11:00:00 - 11:59:59	15251	3.9%	4.24	1.8 GB	5.2%	528.82
Dec 14 12:00:00 - 12:59:59	14207	3.6%	3.95	1.8 GB	5.1%	518.19
Dec 14 13:00:00 - 13:59:59	12112	3.1%	3.36	929.0 MB	2.6%	264.26
Dec 14 14:00:00 - 14:59:59	13764	3.5%	3.82	830.7 MB	2.3%	236.28
Dec 14 15:00:00 - 15:59:59	11786	3.0%	3.27	376.8 MB	1.1%	107.17
Dec 14 16:00:00 - 16:59:59	12396	3.2%	3.44	344.6 MB	1.0%	98.01
Dec 14 17:00:00 - 17:59:59	12987	3.3%	3.61	344.2 MB	1.0%	97.91
Dec 14 18:00:00 - 18:59:59	13653	3.5%	3.79	357.6 MB	1.0%	101.73
Dec 14 19:00:00 - 19:59:59	12900	3.3%	3.58	385.1 MB	1.1%	109.54
Dec 14 20:00:00 - 20:59:59	13258	3.4%	3.68	452.2 MB	1.3%	128.63
Dec 14 21:00:00 - 21:59:59	16381	4.2%	4.55	1.8 GB	5.1%	512.95
Dec 14 22:00:00 - 22:59:59	18760	4.8%	5.21	1.7 GB	4.7%	481.11
Dec 14 23:00:00 - 23:59:59	20747	5.3%	5.76	1.7 GB	4.9%	498.56
Dec 15 00:00:00 - 00:59:59	20485	5.2%	5.69	1.6 GB	4.5%	455.32
Dec 15 01:00:00 - 01:59:59	21328	5.4%	5.92	1.6 GB	4.5%	452.39
Dec 15 02:00:00 - 02:59:59	28250	7.2%	7.85	3.2 GB	9.1%	925.72
Dec 15 03:00:00 - 03:00:01	16	0.0%	16.00	948.1 KB	0.0%	948.12

TOTAL: 23:59:59	391740	100.0%	4.53	34.8 GB	100.0%	422.27

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	7.2 GB	5.2%	210	66.75	25.06
02	BIN	137.8 GB	42.5 GB	30.8%	210	66.54	25.14
03	SMALL	13.0 GB	6.3 GB	48.5%	41	6.56	24.11
04	BIN	80.1 GB	56.0 GB	69.9%	164	33.04	29.42
05	BIN	80.1 GB	39.8 GB	49.7%	181	33.42	29.09
06	SMALL	13.0 GB	5.7 GB	43.7%	41	6.52	24.26
07	BIN	80.1 GB	44.8 GB	55.9%	164	33.12	29.35
08	BIN	80.1 GB	23.5 GB	29.3%	181	33.45	29.06
09	SMALL	13.0 GB	5.7 GB	44.0%	41	6.55	24.17
10	BIN	80.1 GB	38.6 GB	48.2%	164	33.43	29.08
11	BIN	80.1 GB	46.8 GB	58.5%	181	33.19	29.28
12	BIN	13.0 GB	2.6 GB	20.3%	649	33.42	4.73
13	BIN	80.1 GB	1.2 GB	1.5%	106	33.75	28.80
14	SMALL	80.1 GB	67.9 GB	84.8%	5	6.53	148.89

TOTAL: 14	-	968.5 GB	388.7 GB	40.1%	2338	30.45	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	11999	10241	0	467	0	0	0	0	1291

TOTAL: 1		11999	10241	0	467	0	0	0	0	1291

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.mp3s.mixed	895
alt.binaries.0day.stuffz	364
alt.binaries.multimedia.lost	312
alt.binaries.tv.ger.moviez	244
alt.sex.alt.sex.erotica.marketplace	222
alt.sex.telephone.alt.sex.wanted	206
alt.sex.teen	138
tin.it.sport.calcio	135
alt.fetish	117
alt.binaries.boneless.nl	114
alt.binaries.moviez.ger	106
alt.binaries.multimedia.erotica.stag-films	103
alt.politics.scorched-earth	98
alt.binaries.inner-sanctum	94
alt.sex.panties	93
fa.haskell	91
alt.binaries.insiderz	90
hr.rec.tv.uredjaji	85
hr.ponuda.hardver.komponente	85
alt.binaries.tv.eng.moviez	75

TOTAL: 703	10241

INND misc events:

Events	Count

CCreader	7

TOTAL: 1	7

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	1289
	TOTAL: 1	1289

TOTAL: 1		1289

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	23	33978	276.0 MB	88	0	0	10:23:43

TOTAL: 1		23	33978	276.0 MB	88	0	2	10:43:50

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	23	33978	276.0 MB	88	0	0	10:23:43
2	unresolved	1	0	0.0 KB	0	0	0	00:06:09
3	*.rol.ru	5755	0	0.0 KB	0	0	0	00:13:50
4	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00

TOTAL: 4		5780	33978	276.0 MB	88	0	1	10:43:44

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	2.484	6.328	0.000	10:23:43
balancer-b.rol.ru	3.728	3.856	0.000	00:06:57
balancer-a.rol.ru	4.044	3.672	0.000	00:06:52
194.186.71.137	0.000	0.000	0.000	00:06:09
net1-x-ring.tony.pp.ru	0.232	0.224	0.000	00:00:06
web02.tr155m.lavtech.ru	0.004	0.000	0.000	00:00:00

TOTAL: 6	10.492	14.080	0.000	10:43:50

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2878
balancer-a.rol.ru	2877
web02.tr155m.lavtech.ru	1
194.186.71.137	1

TOTAL: 4	5757

NNRP no permission clients:

System	Conn

net1-x-ring.tony.pp.ru	136

TOTAL: 1	136

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	33979	100.0%

TOTAL: 1		33979	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.scenic	26993
2	alt.binaries.pictures.military	4147
3	alt.binaries.photos.nude-art	2816
4	alt.binaries.photography.people	23

TOTAL: 4		33979