Daily Usenet report

Oct 21 03:00:02 -- Oct 22 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
Miscellaneous innd statistics
NNRP readership statistics
NNRP readership statistics (by domain)
NNRP total resource statistics
Curious NNRP server explorers
NNRP gethostbyaddr failures
NNRP client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 5 / 41 lines (12.2%)
Oct 21 05:51:19 perseus controlchan[17196]: Unknown "cmsg" control by MsAmie.bbs@bbs.cs.nctu.edu.tw
Oct 21 06:31:22 perseus controlchan[17196]: Unknown "cmsg" control by vivilee.bbs@bbs.cs.nctu.edu.tw
Oct 21 08:15:57 perseus controlchan[17196]: Unknown "cmsg" control by gordonliu.bbs@bbs.cs.nctu.edu.tw
Oct 21 09:36:08 perseus controlchan[17196]: Unknown "cmsg" control by sux0116.bbs@bbs.cs.nctu.edu.tw
Oct 21 11:05:56 perseus controlchan[17196]: Unknown "cmsg" control by Keroro.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	634377	95.4%	57.5 MB	94.3%
nnrpd	18220	2.7%	1.8 MB	2.9%
innd	9907	1.5%	1.3 MB	2.1%
cnfsstat	2304	0.3%	397.1 KB	0.6%
controlchan	44	0.0%	4.7 KB	0.0%

TOTAL: 5	664852	100.0%	60.9 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	615824	93.3%
Negative hits	41365	6.3%
Positive hits	2293	0.3%
Cache misses	701	0.1%

TOTAL: 4	660183	100.0%

INND timer:

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

article cancel	00:00:15.098	0.0%	4126	0.000	3.659	1695.000
article cleanup	00:00:05.550	0.0%	614924	0.000	0.009	0.041
article logging	00:01:48.059	0.1%	630401	0.000	0.171	17.404
article parse	00:02:16.981	0.2%	32636904	0.002	0.004	0.008
article write	00:54:51.502	3.8%	555243	0.289	5.928	29.608
artlog/artcncl	00:00:00.104	0.0%	4032	0.000	0.026	13.667
artlog/artparse	00:00:00.001	0.0%	5	0.000	0.200	1.000
data move	00:00:36.274	0.0%	34912267	0.000	0.001	0.002
hisgrep/artcncl	00:00:10.570	0.0%	2960	0.000	3.571	1598.000
hishave/artcncl	00:00:01.151	0.0%	4126	0.000	0.279	837.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:11:52.661	0.8%	656328	0.000	1.086	26.465
history sync	00:00:00.260	0.0%	338	0.000	0.769	2.000
history write	00:28:12.052	2.0%	555243	0.010	3.047	49.577
hiswrite/artcncl	00:00:03.242	0.0%	1166	0.000	2.780	858.000
idle	20:46:27.296	86.6%	32413214	0.741	2.307	9.816
nntp read	00:02:42.436	0.2%	32655617	0.002	0.005	0.009
overview write	01:26:20.959	6.0%	555243	0.505	9.331	63.972
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%	43	0.000	0.000	0.000

TOTAL: 24:00:06.229	23:55:44.196	99.7%	-	-	-	-

nnrpd timer:

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

idle	01:11:38.091	85.6%	6587	7.000	652.511	200250.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:07:33.332	9.0%	19189	0.000	23.625	35657.667
readart	00:00:03.048	0.1%	38	0.000	80.211	129.300

TOTAL: 01:23:42.956	01:19:14.471	94.7%	-	-	-	-

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

newgroup@usenet.pl	1	1	0	0	2	2
nl-admin@nic.surfnet.nl	0	0	1	0	1	1

TOTAL	1	1	1	0	3	3

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	947	572627	521775	1	50851	91%	450:37:02

TOTAL: 1		947	572627	521775	1	50851	91%	450:37:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	44.3 GB	134.9 KB	44.3 GB	99%	81.1 KB	450:37:02

TOTAL: 1		44.3 GB	134.9 KB	44.3 GB	99%	81.1 KB	450:37:02

Incoming articles:

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

Oct 21 03:00:02 - 03:59:59	23995	4.3%	6.67	2.4 GB	5.4%	695.29
Oct 21 04:00:00 - 04:59:59	22476	4.0%	6.24	2.5 GB	5.7%	732.32
Oct 21 05:00:00 - 05:59:59	19790	3.6%	5.50	2.4 GB	5.4%	685.51
Oct 21 06:00:00 - 06:59:59	18633	3.4%	5.18	2.0 GB	4.6%	586.83
Oct 21 07:00:00 - 07:59:59	16169	2.9%	4.49	2.4 GB	5.6%	711.61
Oct 21 08:00:00 - 08:59:59	15911	2.9%	4.42	2.5 GB	5.8%	737.27
Oct 21 09:00:00 - 09:59:59	17014	3.1%	4.73	2.0 GB	4.5%	579.67
Oct 21 10:00:00 - 10:59:59	19685	3.5%	5.47	904.2 MB	2.0%	257.20
Oct 21 11:00:00 - 11:59:59	20573	3.7%	5.71	883.0 MB	2.0%	251.16
Oct 21 12:00:00 - 12:59:59	24214	4.4%	6.73	1.2 GB	2.7%	340.32
Oct 21 13:00:00 - 13:59:59	27879	5.0%	7.74	2.2 GB	4.9%	629.02
Oct 21 14:00:00 - 14:59:59	23517	4.2%	6.53	2.0 GB	4.5%	579.66
Oct 21 15:00:00 - 15:59:59	25139	4.5%	6.98	1.8 GB	4.1%	528.56
Oct 21 16:00:00 - 16:59:59	25017	4.5%	6.95	1.7 GB	4.0%	507.81
Oct 21 17:00:00 - 17:59:59	28999	5.2%	8.06	2.0 GB	4.5%	577.16
Oct 21 18:00:00 - 18:59:59	27857	5.0%	7.74	1.8 GB	4.1%	526.31
Oct 21 19:00:00 - 19:59:59	29640	5.3%	8.23	2.1 GB	4.9%	622.84
Oct 21 20:00:00 - 20:59:59	26111	4.7%	7.25	2.1 GB	4.7%	605.14
Oct 21 21:00:00 - 21:59:59	25903	4.7%	7.20	1.9 GB	4.4%	557.16
Oct 21 22:00:00 - 22:59:59	25434	4.6%	7.07	1.3 GB	3.1%	392.03
Oct 21 23:00:00 - 23:59:59	22696	4.1%	6.30	1021.3 MB	2.3%	290.50
Oct 22 00:00:00 - 00:59:59	20834	3.8%	5.79	855.6 MB	1.9%	243.36
Oct 22 01:00:00 - 01:59:59	27235	4.9%	7.57	1.9 GB	4.3%	545.61
Oct 22 02:00:00 - 02:59:59	20452	3.7%	5.68	2.1 GB	4.9%	625.33
Oct 22 03:00:00 - 03:00:02	7	0.0%	3.50	920.1 KB	0.0%	460.07

TOTAL: 24:00:00	555180	100.0%	6.43	44.0 GB	100.0%	533.65

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	58.7 GB	42.6%	217	87.38	19.14
02	BIN	137.8 GB	12.1 GB	8.8%	218	87.00	19.22
03	SMALL	13.0 GB	2.7 GB	20.7%	19	4.25	37.22
04	BIN	80.1 GB	73.6 GB	91.9%	167	43.75	22.22
05	BIN	80.1 GB	18.5 GB	23.1%	188	43.43	22.38
06	SMALL	13.0 GB	2.7 GB	20.5%	19	4.25	37.22
07	BIN	80.1 GB	52.3 GB	65.3%	167	43.41	22.39
08	BIN	80.1 GB	399.6 MB	0.5%	188	43.68	22.26
09	SMALL	13.0 GB	1.6 GB	12.6%	19	4.25	37.20
10	BIN	80.1 GB	37.0 GB	46.2%	167	43.70	22.24
11	BIN	80.1 GB	39.9 GB	49.9%	188	43.51	22.34
12	SMALL	13.0 GB	2.5 GB	19.0%	19	4.27	37.02
13	BIN	80.1 GB	34.2 GB	42.7%	167	43.71	22.24
14	BIN	80.1 GB	1.8 GB	2.3%	188	43.92	22.13

TOTAL: 14	-	968.5 GB	338.2 GB	34.9%	1931	38.61	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	75160	59631	0	33	18	0	0	0	15478
2	?	5	0	0	0	0	0	0	0	5

TOTAL: 2		75165	59631	0	33	18	0	0	0	15483

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	7858
alt.binaries.dvdrs.pw	7309
alt.binaries.pictures.amateur.butts	1699
microsoft.public.test	1161
alt.binaries.pictures.blonde	1157
alt.binaires.pictures.erotica.teens	360
alt.binaries.nospam.female.short-hair	291
alt.binaries.pictures.erotica.group.sex	284
alt.binaries.the-portal	284
alt.binaires.erotica.teen	264
alt.binaries.picture.ls-series	264
alt.binaires.pictures.erotica.amatuer.female	236
alt.binaires.pictures.erotica.butts	228
alt.binaries.erotica.best-teens	223
alt.binaries.pictures.erotica.early-teen	214
alt.binaires.erotica	211
alt.binariers.pictures.erotica.oral	201
alt.binaries.pictures.ls-models	200
alt.binaries.erotica.amateur.females	194
alt.binaries.pictures.erotica.breast.natural	193

TOTAL: 3217	59631

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

Groups	Count

pl.comp.pecet	18

TOTAL: 1	18

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad newsgroups received
	SERVER	236
	TOTAL: 1	236
Including strange strings
	192.168.33.37	15477
	TOTAL: 1	15477

TOTAL: 2		15713

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	194.186.147.135	4	22	557.4 KB	3	0	0	00:09:16
2	195.218.244.87	3	16	835.9 KB	2	0	0	00:01:35

TOTAL: 2		7	38	1.4 MB	5	0	0	01:23:43

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	unresolved	7	38	1.4 MB	5	0	0	00:10:51
2	*.sovintel.net	15	0	0.0 KB	0	0	0	00:00:25
3	*.spb.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:34
4	*.rol.kis.ru	1	0	0.0 KB	0	0	0	00:10:00
5	*.sarov.dial.rol.ru	6	0	0.0 KB	0	0	0	00:42:06
6	*.tony.pp.ru	74	0	0.0 KB	0	0	0	00:02:53
7	*.rol.ru	5761	0	0.0 KB	0	0	0	00:15:55

TOTAL: 7		5865	38	1.4 MB	5	0	0	01:23:43

NNRP total resource statistics [Top 20]:

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

ts2-a28.sarov.dial.rol.ru	0.008	0.020	0.000	00:40:04
rol57.rol.kis.ru	0.008	0.000	0.000	00:10:00
194.186.147.135	0.012	0.028	0.000	00:09:16
balancer-b.rol.ru	3.524	3.372	0.000	00:08:03
balancer-a.rol.ru	3.688	3.180	0.000	00:07:52
net1-x-ring.tony.pp.ru	0.124	0.152	0.000	00:02:53
195.218.244.87	0.000	0.012	0.000	00:01:35
ts2-a221.sarov.dial.rol.ru	0.000	0.000	0.000	00:01:01
ts2-a74.sarov.dial.rol.ru	0.004	0.004	0.000	00:01:00
?	0.004	0.004	0.000	00:00:55
ts1-a228.spb.dial.rol.ru	0.000	0.004	0.000	00:00:34
fw-nat.sovintel.net	0.068	0.064	0.000	00:00:25

TOTAL: 12	7.440	6.840	0.000	01:23:43

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2881
balancer-a.rol.ru	2880
net1-x-ring.tony.pp.ru	74
fw-nat.sovintel.net	15
ts2-a28.sarov.dial.rol.ru	4
ts2-a74.sarov.dial.rol.ru	1
ts2-a221.sarov.dial.rol.ru	1
rol57.rol.kis.ru	1
ts1-a228.spb.dial.rol.ru	1

TOTAL: 9	5858

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	10

TOTAL: 1	10

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a28.sarov.dial.rol.ru	4	0
rol57.rol.kis.ru	1	0

TOTAL: 2	5	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	16752	100.0%

TOTAL: 1		16752	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.breasts	16714
2	alt.binaries.nospam.female.bodyhair	21
3	alt.binaries.erotica.pornstars	16
4	alt.binaries.nospam.female.bodyhair.pubes	1

TOTAL: 4		16752