Daily Usenet report

Oct 26 03:00:02 -- Oct 27 03:00:04

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
Supposedly-moderated groups with unmoderated postings
Miscellaneous innd statistics
NNRP readership statistics
NNRP readership statistics (by domain)
NNRP total resource statistics
Curious NNRP server explorers
NNRP no permission clients
NNRP gethostbyaddr failures
NNRP client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 5 / 20 lines (25.0%)
Oct 26 05:56:59 perseus controlchan[437]: Unknown "cmsg" control by skys1036.bbs@bbs.cs.nthu.edu.tw
Oct 26 07:51:03 perseus controlchan[437]: Unknown "cmsg" control by carrot11xc24.bbs@bbs.cs.nctu.edu.tw
Oct 26 08:16:00 perseus controlchan[437]: Unknown "cmsg" control by grassboy.bbs@bbs.cs.nctu.edu.tw
Oct 26 10:06:10 perseus controlchan[437]: Unknown "cmsg" control by vivilee.bbs@bbs.cs.nctu.edu.tw
Oct 26 10:06:10 perseus controlchan[437]: Unknown "cmsg" control by vivilee.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	581147	95.0%	52.9 MB	93.9%
nnrpd	18227	3.0%	1.8 MB	3.1%
innd	10261	1.7%	1.3 MB	2.3%
cnfsstat	2304	0.4%	398.0 KB	0.7%
controlchan	20	0.0%	2.0 KB	0.0%

TOTAL: 5	611959	100.0%	56.3 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	570728	92.3%
Negative hits	44606	7.2%
Positive hits	1507	0.2%
Cache misses	1260	0.2%

TOTAL: 4	618101	100.0%

INND timer:

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

article cancel	00:00:28.194	0.0%	6634	0.000	4.250	1391.000
article cleanup	00:00:05.478	0.0%	567165	0.000	0.010	0.034
article logging	00:01:02.023	0.1%	574750	0.000	0.108	21.853
article parse	00:02:54.867	0.2%	42192319	0.001	0.004	0.008
article write	00:56:32.671	3.9%	518967	0.214	6.537	32.019
artlog/artcncl	00:00:00.067	0.0%	6501	0.000	0.010	1.000
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:00:44.756	0.1%	44595121	0.000	0.001	0.003
hisgrep/artcncl	00:00:15.612	0.0%	2744	0.000	5.690	1391.000
hishave/artcncl	00:00:04.651	0.0%	6634	0.000	0.701	15.312
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:13:32.475	0.9%	611777	0.000	1.328	36.582
history sync	00:00:00.446	0.0%	358	0.000	1.246	98.000
history write	00:23:56.310	1.7%	518967	0.005	2.768	25.711
hiswrite/artcncl	00:00:07.822	0.0%	3890	0.000	2.011	29.000
idle	20:55:54.969	87.2%	41956951	0.751	1.796	25.212
nntp read	00:03:28.046	0.2%	42217962	0.001	0.005	0.010
overview write	01:16:14.618	5.3%	518967	0.219	8.815	116.848
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%	20	0.000	0.000	0.000

TOTAL: 24:00:16.106	23:55:23.005	99.7%	-	-	-	-

nnrpd timer:

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

idle	02:10:02.819	95.2%	6617	0.000	1179.208	201014.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:02:22.957	1.7%	135555	0.000	1.055	1565.733
readart	00:00:01.857	0.0%	74	0.000	25.095	25.458

TOTAL: 02:16:33.243	02:12:27.633	97.0%	-	-	-	-

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	1096	526826	481648	0	45178	91%	435:05:40

TOTAL: 1		1096	526826	481648	0	45178	91%	435:05:40

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	60.1 GB	74.5 KB	60.1 GB	99%	119.7 KB	435:05:40

TOTAL: 1		60.1 GB	74.5 KB	60.1 GB	99%	119.7 KB	435:05:40

Incoming articles:

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

Oct 26 03:00:02 - 03:59:59	15587	3.0%	4.33	566.6 MB	0.9%	161.25
Oct 26 04:00:00 - 04:59:59	22753	4.4%	6.32	3.3 GB	5.6%	963.51
Oct 26 05:00:00 - 05:59:59	19160	3.7%	5.32	3.2 GB	5.4%	926.93
Oct 26 06:00:00 - 06:59:59	18336	3.5%	5.09	2.8 GB	4.8%	827.73
Oct 26 07:00:00 - 07:59:59	18506	3.6%	5.14	2.5 GB	4.2%	716.87
Oct 26 08:00:00 - 08:59:59	17255	3.3%	4.79	2.3 GB	3.9%	664.49
Oct 26 09:00:00 - 09:59:59	17059	3.3%	4.74	2.5 GB	4.3%	736.68
Oct 26 10:00:00 - 10:59:59	17330	3.3%	4.81	2.2 GB	3.7%	632.09
Oct 26 11:00:00 - 11:59:59	21450	4.1%	5.96	2.3 GB	3.8%	656.13
Oct 26 12:00:00 - 12:59:59	18501	3.6%	5.14	2.0 GB	3.4%	585.69
Oct 26 13:00:00 - 13:59:59	21754	4.2%	6.04	2.9 GB	4.9%	835.32
Oct 26 14:00:00 - 14:59:59	22890	4.4%	6.36	3.0 GB	5.1%	881.59
Oct 26 15:00:00 - 15:59:59	26191	5.0%	7.28	3.1 GB	5.2%	901.70
Oct 26 16:00:00 - 16:59:59	26731	5.2%	7.43	3.2 GB	5.5%	937.85
Oct 26 17:00:00 - 17:59:59	26878	5.2%	7.47	2.7 GB	4.5%	779.85
Oct 26 18:00:00 - 18:59:59	23438	4.5%	6.51	2.6 GB	4.5%	767.65
Oct 26 19:00:00 - 19:59:59	29505	5.7%	8.20	2.8 GB	4.7%	805.70
Oct 26 20:00:00 - 20:59:59	26631	5.1%	7.40	2.5 GB	4.3%	734.02
Oct 26 21:00:00 - 21:59:59	26277	5.1%	7.30	2.8 GB	4.7%	804.93
Oct 26 22:00:00 - 22:59:59	24749	4.8%	6.87	2.8 GB	4.7%	803.52
Oct 26 23:00:00 - 23:59:59	25299	4.9%	7.03	2.6 GB	4.4%	757.12
Oct 27 00:00:00 - 00:59:59	16204	3.1%	4.50	1.0 GB	1.8%	301.92
Oct 27 01:00:00 - 01:59:59	14000	2.7%	3.89	835.5 MB	1.4%	237.66
Oct 27 02:00:00 - 02:59:59	22330	4.3%	6.20	2.7 GB	4.5%	781.48
Oct 27 03:00:00 - 03:00:04	40	0.0%	10.00	4.9 MB	0.0%	1251.92

TOTAL: 24:00:02	518854	100.0%	6.01	59.1 GB	100.0%	716.77

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	101.1 GB	73.4%	217	118.97	14.06
02	BIN	137.8 GB	54.3 GB	39.4%	218	118.69	14.09
03	SMALL	13.0 GB	4.4 GB	33.5%	19	3.32	47.73
04	BIN	80.1 GB	14.7 GB	18.3%	168	59.32	16.39
05	BIN	80.1 GB	39.6 GB	49.4%	188	59.32	16.39
06	SMALL	13.0 GB	4.3 GB	33.3%	19	3.33	47.47
07	BIN	80.1 GB	73.5 GB	91.8%	167	59.32	16.39
08	BIN	80.1 GB	21.6 GB	26.9%	188	59.42	16.36
09	SMALL	13.0 GB	3.3 GB	25.4%	19	3.32	47.66
10	BIN	80.1 GB	58.2 GB	72.7%	167	59.47	16.34
11	BIN	80.1 GB	61.0 GB	76.2%	188	59.30	16.39
12	SMALL	13.0 GB	4.1 GB	31.8%	19	3.33	47.48
13	BIN	80.1 GB	55.4 GB	69.2%	167	59.27	16.40
14	BIN	80.1 GB	23.0 GB	28.7%	188	59.40	16.37

TOTAL: 14	-	968.5 GB	518.5 GB	53.5%	1932	51.84	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	55789	48160	0	23	20	0	0	0	7586
2	?	3	0	0	0	0	0	0	0	3

TOTAL: 2		55792	48160	0	23	20	0	0	0	7589

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	5384
alt.binaries.dvdrs.pw	5030
microsoft.public.test	1153
alt.binaries.boys	825
alt.binaries.sound.audiobooks	690
alt.binaries.nospam.female.short-hair	566
alt.binaries.pictures.ls-models	509
alt.binaries.pictures.comics.repost	328
alt.binaires.pictures.erotica.teens	292
alt.binaires.erotica.teen	261
alt.binaries.amazing	222
alt.binaries.pictures.erotica.early-teen	218
alt.binaires.erotica	210
alt.binaries.images.andmore	208
alt.binaires.pictures.erotica.butts	191
alt.binaries.pictures.erotica.young.female	169
alt.binaries.erotica.early-teens	168
alt.sex.teen	165
alt.binaries.pictures.amateur.butts	157
alt.binaries.pictures.blonde	157

TOTAL: 3154	48160

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

Groups	Count

pl.comp.pecet	20

TOTAL: 1	20

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad newsgroups received
	SERVER	72
	TOTAL: 1	72
Including strange strings
	192.168.33.37	7585
	TOTAL: 1	7585

TOTAL: 2		7657

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	195.218.244.87	2	72	5.9 MB	1	0	0	00:05:48
2	194.186.147.183	2	2	161.1 KB	1	0	0	00:01:22

TOTAL: 2		4	74	6.1 MB	2	0	2	02:16:33

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	unresolved	4	74	6.1 MB	2	0	0	00:07:11
2	*.sovintel.net	18	0	0.0 KB	0	0	0	00:00:22
3	*.rol.kis.ru	2	0	0.0 KB	0	0	0	00:08:28
4	*.reksoft.ru	1	0	0.0 KB	0	0	0	00:03:19
5	*.sarov.dial.rol.ru	13	0	0.0 KB	0	0	0	01:22:10
6	*.tony.pp.ru	68	0	0.0 KB	0	0	0	00:18:46
7	*.rol.ru	5765	0	0.0 KB	0	0	0	00:15:27
8	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:01

TOTAL: 8		5872	74	6.1 MB	2	0	1	02:16:33

NNRP total resource statistics [Top 20]:

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

ts2-a238.sarov.dial.rol.ru	0.004	0.012	0.000	00:50:35
ts2-a212.sarov.dial.rol.ru	0.004	0.000	0.000	00:21:16
net1-x-ring.tony.pp.ru	0.108	0.128	0.000	00:18:46
ts2-a3.sarov.dial.rol.ru	0.000	0.000	0.000	00:10:01
rol73.rol.kis.ru	0.008	0.016	0.000	00:08:28
balancer-a.rol.ru	3.444	3.360	0.000	00:07:56
balancer-b.rol.ru	3.228	3.448	0.000	00:07:31
195.218.244.87	0.012	0.056	0.000	00:05:48
gate.reksoft.ru	0.100	0.084	0.000	00:03:19
194.186.147.183	0.044	0.048	0.000	00:01:22
?	0.000	0.000	0.000	00:00:45
fw-nat.sovintel.net	0.148	0.044	0.000	00:00:22
ts2-a194.sarov.dial.rol.ru	0.004	0.000	0.000	00:00:16
web02.tr155m.lavtech.ru	0.000	0.000	0.000	00:00:01
cornholio.migtel.ru	0.004	0.000	0.000	00:00:00
81.25.54.243	0.000	0.000	0.000	00:00:00

TOTAL: 16	7.108	7.196	0.000	02:16:33

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2883
balancer-a.rol.ru	2882
net1-x-ring.tony.pp.ru	68
fw-nat.sovintel.net	18
ts2-a238.sarov.dial.rol.ru	7
ts2-a212.sarov.dial.rol.ru	4
rol73.rol.kis.ru	2
ts2-a3.sarov.dial.rol.ru	1
gate.reksoft.ru	1
web02.tr155m.lavtech.ru	1
ts2-a194.sarov.dial.rol.ru	1

TOTAL: 11	5868

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	6
81.25.54.243	1

TOTAL: 2	7

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	8

TOTAL: 1	8

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a238.sarov.dial.rol.ru	5	0
ts2-a212.sarov.dial.rol.ru	2	0
ts2-a3.sarov.dial.rol.ru	1	0

TOTAL: 3	8	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	74	100.0%

TOTAL: 1		74	100.0%

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

Newsgroup		Count

1	alt.binaries.erotica.pornstars	72
2	alt.binaries.nospam.female.bodyhair.pubes	2

TOTAL: 2		74