Daily Usenet report

Feb 19 03:00:02 -- Feb 20 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 client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 5 / 34 lines (14.7%)
Feb 19 05:18:11 perseus controlchan[23926]: Unknown "cmsg" control by moja.bbs@bbs.cs.nctu.edu.tw
Feb 19 05:58:29 perseus controlchan[23926]: Unknown "cmsg" control by johnsono21.bbs@bbs.cs.nctu.edu.tw
Feb 19 08:03:35 perseus controlchan[23926]: Unknown "cmsg" control by hababy.bbs@bbs.cs.nctu.edu.tw
Feb 19 08:36:37 perseus controlchan[23926]: Unknown "cmsg" control by 7h0t8wuj8iayq53@jetable.org
Feb 19 08:46:38 perseus controlchan[23926]: Unknown "cmsg" control by peja2.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	646743	95.2%	57.7 MB	94.1%
nnrpd	17979	2.6%	1.7 MB	2.8%
innd	12575	1.9%	1.5 MB	2.5%
cnfsstat	2304	0.3%	396.0 KB	0.6%
controlchan	28	0.0%	3.0 KB	0.0%
rnews	2	0.0%	0.2 KB	0.0%

TOTAL: 6	679631	100.0%	61.3 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	622253	88.0%
Negative hits	79983	11.3%
Positive hits	3866	0.5%
Cache misses	866	0.1%

TOTAL: 4	706968	100.0%

INND timer:

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

article cancel	00:00:09.812	0.0%	4212	0.000	2.330	428.250
article cleanup	00:00:05.703	0.0%	621941	0.000	0.009	0.045
article logging	00:01:46.353	0.1%	642156	0.000	0.166	11.223
article parse	00:02:45.789	0.2%	33793739	0.002	0.005	0.078
article write	01:19:04.529	5.5%	582149	0.329	8.150	328.435
artlog/artcncl	00:00:00.727	0.0%	4169	0.000	0.174	83.625
artlog/artparse	00:00:00.000	0.0%	22	0.000	0.000	0.000
data move	00:00:41.075	0.0%	36130944	0.000	0.001	0.015
hisgrep/artcncl	00:00:04.629	0.0%	3314	0.000	1.397	571.000
hishave/artcncl	00:00:01.492	0.0%	4212	0.000	0.354	33.133
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:07:34.820	0.5%	702880	0.000	0.647	22.212
history sync	00:00:00.291	0.0%	309	0.000	0.942	17.000
history write	00:20:31.378	1.4%	582149	0.000	2.115	38.959
hiswrite/artcncl	00:00:02.928	0.0%	898	0.000	3.261	81.400
idle	17:32:35.196	73.1%	33257676	0.015	1.899	60002.000
nntp read	00:03:08.808	0.2%	33757042	0.001	0.006	0.084
overview write	04:26:07.754	18.5%	582149	1.891	27.429	17923.750
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%	28	0.000	0.036	0.500

TOTAL: 23:59:11.936	23:54:41.285	99.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:00:33.540	0.1%	26025	0.000	1.289	0.000
idle	11:24:23.598	97.1%	58439	0.000	702.675	202187.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:03:19.665	0.5%	228457	0.000	0.874	0.000
readart	00:09:01.565	1.3%	52388	0.000	10.338	0.000

TOTAL: 11:44:32.954	11:37:18.368	99.0%	-	-	-	-

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

news@news.purdue.edu	0	1	0	0	0	1

TOTAL	0	1	0	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	1637	566548	529251	873	36424	93%	422:57:34

TOTAL: 1		1637	566548	529251	873	36424	93%	422:57:34

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	56.4 GB	4.6 MB	56.4 GB	99%	104.5 KB	422:57:34

TOTAL: 1		56.4 GB	4.6 MB	56.4 GB	99%	104.5 KB	422:57:34

Incoming articles:

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

Feb 19 03:00:02 - 03:59:59	20643	3.5%	5.74	2.7 GB	4.9%	798.52
Feb 19 04:00:00 - 04:59:59	20767	3.6%	5.77	2.8 GB	5.0%	826.83
Feb 19 05:00:00 - 05:59:59	19370	3.3%	5.38	2.7 GB	4.8%	791.99
Feb 19 06:00:00 - 06:59:59	17364	3.0%	4.82	2.5 GB	4.5%	733.16
Feb 19 07:00:00 - 07:59:59	20518	3.5%	5.70	3.2 GB	5.6%	919.98
Feb 19 08:00:00 - 08:59:59	18481	3.2%	5.13	3.1 GB	5.5%	896.96
Feb 19 09:00:00 - 09:59:59	19186	3.3%	5.33	2.6 GB	4.7%	764.28
Feb 19 10:00:00 - 10:59:59	20617	3.5%	5.73	1.8 GB	3.3%	537.59
Feb 19 11:00:00 - 11:59:59	22587	3.9%	6.27	2.1 GB	3.8%	621.24
Feb 19 12:00:00 - 12:59:59	18228	3.1%	5.06	1.7 GB	2.9%	483.90
Feb 19 13:00:00 - 13:59:59	20467	3.5%	5.69	2.2 GB	4.0%	651.54
Feb 19 14:00:00 - 14:59:59	19151	3.3%	5.32	1.8 GB	3.1%	512.02
Feb 19 15:00:00 - 15:59:59	27183	4.7%	7.55	2.0 GB	3.5%	570.02
Feb 19 16:00:00 - 16:59:59	27647	4.7%	7.68	2.3 GB	4.0%	659.55
Feb 19 17:00:00 - 17:59:59	25382	4.4%	7.05	2.4 GB	4.2%	695.29
Feb 19 18:00:00 - 18:59:59	29895	5.1%	8.30	2.1 GB	3.7%	608.66
Feb 19 19:00:00 - 19:59:59	31207	5.4%	8.67	2.3 GB	4.1%	666.70
Feb 19 20:00:00 - 20:59:59	32068	5.5%	8.91	2.5 GB	4.4%	726.25
Feb 19 21:00:00 - 21:59:59	32625	5.6%	9.06	2.7 GB	4.7%	772.94
Feb 19 22:00:00 - 22:59:59	31133	5.3%	8.65	2.2 GB	4.0%	653.61
Feb 19 23:00:00 - 23:59:59	26308	4.5%	7.31	2.2 GB	4.0%	652.13
Feb 20 00:00:00 - 00:59:59	23590	4.0%	6.55	1.8 GB	3.3%	538.53
Feb 20 01:00:00 - 01:59:59	30000	5.2%	8.33	1.7 GB	3.0%	499.78
Feb 20 02:00:00 - 02:59:59	28076	4.8%	7.80	2.8 GB	5.0%	827.39
Feb 20 03:00:00 - 03:00:02	19	0.0%	9.50	1.1 MB	0.0%	558.79

TOTAL: 24:00:00	582512	100.0%	6.74	56.3 GB	100.0%	683.70

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	42.7 GB	31.0%	223	112.01	14.93
02	BIN	137.8 GB	132.0 GB	95.8%	223	111.66	14.98
03	SMALL	13.0 GB	2.1 GB	16.0%	24	5.23	30.27
04	BIN	80.1 GB	77.9 GB	97.3%	172	55.85	17.41
05	BIN	80.1 GB	22.0 GB	27.5%	193	55.66	17.46
06	SMALL	13.0 GB	2.0 GB	15.6%	24	5.23	30.23
07	BIN	80.1 GB	57.5 GB	71.8%	172	56.26	17.28
08	BIN	80.1 GB	4.8 GB	6.0%	193	56.19	17.30
09	SMALL	13.0 GB	1019.7 MB	7.6%	24	5.24	30.20
10	BIN	80.1 GB	42.2 GB	52.6%	172	56.19	17.30
11	BIN	80.1 GB	43.9 GB	54.8%	193	56.07	17.34
12	SMALL	13.0 GB	1.8 GB	14.1%	24	5.25	30.12
13	BIN	80.1 GB	39.4 GB	49.2%	172	55.95	17.37
14	BIN	80.1 GB	6.1 GB	7.6%	193	55.82	17.41

TOTAL: 14	-	968.5 GB	475.4 GB	49.1%	2002	49.47	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	60044	39263	0	545	0	0	0	0	20236
2	?	17	0	0	0	0	0	0	0	17

TOTAL: 2		60061	39263	0	545	0	0	0	0	20253

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	4568
bellsouth.net.test	2915
alt.binaries.blu-ray	1498
alt.binaries.dvdrs.pw	1368
microsoft.public.test	1159
alt.binaries.southern-charms	539
alt.binaries.insiderz	406
alt.binaries.matrix	386
mozilla.support.firefox	364
alt.binaries.mp3.audiobooks.francais	294
cakewalk.coffeehouse	251
alt.binaries.pictures.black.erotica	228
alt.binaries.pictures.erotica.amateur.black	205
alt.binaries.pictures.black.erotica.females	205
adobe.photoshop.macintosh	185
ntu-kpi.misc.politics	182
alt.binaries.fetish	182
tin.it.sport.calcio	169
mozilla.support.seamonkey	167
alt.binaries.pictures.latina	138

TOTAL: 4200	39263

INND misc events:

Events	Count

CCreader	11

TOTAL: 1	11

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad newsgroups received
	SERVER	3
	TOTAL: 1	3
Including strange strings
	192.168.33.37	20231
	TOTAL: 1	20231

TOTAL: 2		20234

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	9	26025	1.0 GB	48	0	0	10:52:52

TOTAL: 1		9	26025	1.0 GB	48	0	2	11:44:33

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	9	26025	1.0 GB	48	0	0	10:52:52
2	*.sovintel.net	10	0	0.0 KB	0	0	0	00:00:04
3	*.fttb.kis.ru	2	0	0.0 KB	0	0	0	00:12:52
4	unresolved	1	0	0.0 KB	0	0	0	00:01:58
5	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00
6	*.rol.kis.ru	2	0	0.0 KB	0	0	0	00:10:52
7	*.tony.pp.ru	72	0	0.0 KB	0	0	0	00:08:24
8	*.rol.ru	5764	0	0.0 KB	0	0	0	00:17:28

TOTAL: 8		5861	26025	1.0 GB	48	0	1	11:44:33

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	43.264	48.312	0.000	10:52:52
dyn-185-104.fttb.kis.ru	0.100	0.080	0.000	00:12:52
rol79.rol.kis.ru	0.008	0.000	0.000	00:10:52
balancer-b.rol.ru	3.244	3.272	0.000	00:09:37
net1-x-ring.tony.pp.ru	0.096	0.128	0.000	00:08:24
balancer-a.rol.ru	3.260	3.104	0.000	00:07:50
195.218.244.87	0.004	0.004	0.000	00:01:58
fw-nat.sovintel.net	0.076	0.024	0.000	00:00:04
web02.tr155m.lavtech.ru	0.000	0.004	0.000	00:00:00

TOTAL: 9	50.052	54.928	0.000	11:44:33

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2883
balancer-b.rol.ru	2881
net1-x-ring.tony.pp.ru	72
fw-nat.sovintel.net	10
rol79.rol.kis.ru	2
dyn-185-104.fttb.kis.ru	2
web02.tr155m.lavtech.ru	1
195.218.244.87	1

TOTAL: 8	5852

NNRP client timeouts [Top 20]:

System	Conn	Peer

rol79.rol.kis.ru	1	0
dyn-185-104.fttb.kis.ru	1	0

TOTAL: 2	2	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	27950	99.6%
2	hr	126	0.4%

TOTAL: 2		28076	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.bras	18391
2	alt.binaries.full.post.verified.playboy	5250
3	alt.mag.playboy	2427
4	alt.binaries.multimedia.erotic.playboy	1882
5	hr.alt.seks.binaries.playboy	126

TOTAL: 5		28076