Daily Usenet report

Mar 28 03:00:01 -- Mar 29 03:00:02

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
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
NNRP client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 32 / 32 lines (100.0%)
Mar 28 03:15:52 andromeda controlchan[10993]: Unknown "cmsg" control by moja.bbs@bbs.cs.nctu.edu.tw
Mar 28 04:24:12 andromeda controlchan[10993]: Unknown "cmsg" control by superlight66.bbs@bbs.cs.nctu.edu.tw
Mar 28 06:08:36 andromeda controlchan[10993]: Unknown "cmsg" control by msei.bbs@Star.leobbs.net
Mar 28 06:13:10 andromeda controlchan[10993]: Unknown "cmsg" control by mei78120.bbs@bbs.cs.nctu.edu.tw
Mar 28 07:02:41 andromeda innd: buffindexed: overview data is too large 28814
Mar 28 07:02:41 andromeda innd: buffindexed: overview data is too large 28814
Mar 28 07:02:41 andromeda innd: buffindexed: overview data is too large 28814
Mar 28 07:02:41 andromeda innd: buffindexed: overview data is too large 28814
Mar 28 07:33:11 andromeda controlchan[10993]: Unknown "cmsg" control by mixcookie.bbs@bbs.cs.nctu.edu.tw
Mar 28 09:23:09 andromeda controlchan[10993]: Unknown "cmsg" control by homeof305.bbs@bbs.cs.nctu.edu.tw
Mar 28 09:53:09 andromeda controlchan[10993]: Unknown "cmsg" control by iceburg.bbs@bbs.cs.nctu.edu.tw
Mar 28 10:03:09 andromeda controlchan[10993]: Unknown "cmsg" control by homeof305.bbs@bbs.cs.nctu.edu.tw
Mar 28 10:23:09 andromeda controlchan[10993]: Unknown "cmsg" control by jullialinn.bbs@bbs.cs.nctu.edu.tw
Mar 28 10:55:38 andromeda controlchan[10993]: Unknown "cmsg" control by mocarr.bbs@bbs.csie.fju.edu.tw
Mar 28 10:56:42 andromeda innd: buffindexed: overview data is too large 28623
Mar 28 11:40:00 andromeda innd: buffindexed: overview data is too large 22144
Mar 28 11:40:00 andromeda innd: buffindexed: overview data is too large 22143
Mar 28 12:03:05 andromeda controlchan[10993]: Unknown "cmsg" control by Davidrunner.bbs@bbs.cs.nctu.edu.tw
Mar 28 13:23:09 andromeda controlchan[10993]: Unknown "cmsg" control by ywc.bbs@bbs.cs.nctu.edu.tw
Mar 28 13:33:14 andromeda controlchan[10993]: Unknown "cmsg" control by Zozfee.bbs@bbs.cs.nctu.edu.tw
Mar 28 15:00:24 andromeda innd: buffindexed: overview data is too large 22086
Mar 28 15:00:24 andromeda innd: buffindexed: overview data is too large 22086
Mar 28 15:00:24 andromeda innd: buffindexed: overview data is too large 22085
Mar 28 15:00:24 andromeda innd: buffindexed: overview data is too large 22085
Mar 28 15:00:24 andromeda innd: buffindexed: overview data is too large 22086
Mar 28 15:53:09 andromeda controlchan[10993]: Unknown "cmsg" control by npcforen.bbs@bbs.cs.nctu.edu.tw
Mar 28 16:13:07 andromeda controlchan[10993]: Unknown "cmsg" control by fefe.bbs@bbs.cs.nctu.edu.tw
Mar 28 16:24:13 andromeda controlchan[10993]: Unknown "cmsg" control by shanpin.bbs@bbs.cs.nctu.edu.tw
Mar 28 17:23:59 andromeda controlchan[10993]: Unknown "cmsg" control by kickerw.bbs@bbs.cs.nctu.edu.tw
Mar 28 18:53:11 andromeda controlchan[10993]: Unknown "cmsg" control by waiwai0624.bbs@bbs.cs.nctu.edu.tw
Mar 28 20:53:39 andromeda controlchan[10993]: Unknown "cmsg" control by goodtoyou.bbs@bbs.cs.nctu.edu.tw
Mar 28 21:23:56 andromeda controlchan[10993]: Unknown "cmsg" control by truea56a.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	431053	93.3%	37.7 MB	91.6%
nnrpd	17379	3.8%	1.7 MB	4.1%
innd	11128	2.4%	1.4 MB	3.3%
cnfsstat	2208	0.5%	384.6 KB	0.9%
controlchan	20	0.0%	2.2 KB	0.0%

TOTAL: 5	461788	100.0%	41.1 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	426176	94.5%
Negative hits	22074	4.9%
Positive hits	2242	0.5%
Cache misses	581	0.1%

TOTAL: 4	451073	100.0%

INND timer:

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

article cancel	00:00:06.502	0.0%	4199	0.000	1.548	473.000
article cleanup	00:00:05.545	0.0%	425182	0.000	0.013	0.042
article logging	00:00:42.893	0.1%	427014	0.000	0.100	12.765
article parse	00:02:20.576	0.2%	26765398	0.001	0.005	0.066
article write	00:21:44.208	1.6%	405121	0.368	3.219	50.667
artlog/artcncl	00:00:00.305	0.0%	4130	0.000	0.074	81.667
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:51.629	0.1%	28467675	0.000	0.002	0.012
hisgrep/artcncl	00:00:02.546	0.0%	2609	0.000	0.976	121.667
hishave/artcncl	00:00:01.710	0.0%	4199	0.000	0.407	473.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:08:22.919	0.6%	447319	0.000	1.124	21.749
history sync	00:00:00.539	0.0%	361	0.000	1.493	3.000
history write	00:12:00.968	0.9%	424996	0.009	1.696	29.851
hiswrite/artcncl	00:00:01.897	0.0%	1590	0.000	1.193	595.000
idle	20:32:37.126	89.3%	26681379	0.067	2.772	44.992
nntp read	00:02:44.572	0.2%	26767479	0.002	0.006	0.095
overview write	01:32:49.670	6.7%	405121	1.526	13.748	11976.083
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: 23:00:17.365	22:54:33.605	99.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:01:01.720	0.1%	45224	0.000	1.365	0.000
idle	15:05:26.979	97.8%	96709	7.000	561.757	64859.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:11:04.573	1.2%	350357	0.000	1.897	0.000
readart	00:03:19.217	0.4%	90827	0.000	2.193	0.000

TOTAL: 15:25:20.986	15:20:52.489	99.5%	-	-	-	-

Control commands to INND:

Command	Number

flush	138
flushlogs	1
paused	2

TOTAL: 3	141

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	1443	439453	418846	29	20578	95%	268:30:24

TOTAL: 1		1443	439453	418846	29	20578	95%	268:30:24

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	38.6 GB	3.0 MB	38.6 GB	99%	92.1 KB	268:30:24

TOTAL: 1		38.6 GB	3.0 MB	38.6 GB	99%	92.1 KB	268:30:24

Incoming articles:

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

Mar 28 03:00:01 - 03:59:59	13439	3.3%	3.73	942.6 MB	2.4%	268.19
Mar 28 04:00:00 - 04:59:59	15645	3.9%	4.35	1.5 GB	4.0%	442.57
Mar 28 05:00:00 - 05:59:59	16701	4.1%	4.64	2.0 GB	5.1%	574.28
Mar 28 06:00:00 - 06:59:59	15748	3.9%	4.37	2.0 GB	5.3%	591.96
Mar 28 07:00:00 - 07:59:59	12644	3.1%	3.51	1.8 GB	4.7%	521.21
Mar 28 08:00:00 - 08:59:59	13293	3.3%	3.69	1.9 GB	5.0%	560.53
Mar 28 09:00:00 - 09:59:59	14605	3.6%	4.06	2.2 GB	5.6%	627.49
Mar 28 10:00:00 - 10:59:59	19823	4.9%	5.51	2.5 GB	6.5%	730.10
Mar 28 11:00:00 - 11:59:59	22741	5.6%	6.32	2.5 GB	6.5%	732.03
Mar 28 12:00:00 - 12:59:59	22398	5.5%	6.22	2.2 GB	5.7%	634.41
Mar 28 13:00:00 - 13:59:59	16842	4.2%	4.68	1.6 GB	4.1%	457.76
Mar 28 14:00:00 - 14:59:59	17168	4.2%	4.77	1.6 GB	4.1%	455.70
Mar 28 15:00:00 - 15:59:59	18864	4.7%	5.24	1.7 GB	4.4%	495.27
Mar 28 16:00:00 - 16:59:59	20769	5.1%	5.77	2.1 GB	5.6%	621.07
Mar 28 17:00:00 - 17:59:59	23394	5.8%	6.50	2.2 GB	5.8%	645.81
Mar 28 18:00:00 - 18:59:59	16495	4.1%	4.58	1.5 GB	3.8%	428.27
Mar 28 19:00:00 - 19:59:59	25000	6.2%	6.94	2.2 GB	5.8%	643.84
Mar 28 20:00:00 - 20:59:59	28836	7.1%	8.01	2.2 GB	5.6%	631.54
Mar 28 21:00:00 - 21:59:59	21603	5.3%	6.00	1.4 GB	3.8%	421.05
Mar 28 22:00:00 - 22:59:59	11495	2.8%	3.19	633.4 MB	1.6%	180.17
Mar 28 23:00:00 - 23:59:59	13088	3.2%	3.64	740.6 MB	1.9%	210.65
Mar 29 00:00:00 - 00:59:59	13385	3.3%	3.72	606.0 MB	1.5%	172.37
Mar 29 01:00:00 - 01:59:59	11046	2.7%	3.07	488.8 MB	1.2%	139.03
Mar 29 02:00:00 - 02:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Mar 29 03:00:00 - 03:00:02	11	0.0%	5.50	85.8 KB	0.0%	42.91

TOTAL: 24:00:01	405033	100.0%	4.69	38.4 GB	100.0%	466.05

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	70.0 GB	50.8%	199	79.98	20.91
02	BIN	137.8 GB	107.5 GB	78.0%	199	79.59	21.02
03	SMALL	13.0 GB	10.8 GB	82.6%	27	4.15	38.12
04	BIN	80.1 GB	50.4 GB	63.0%	155	39.79	24.43
05	BIN	80.1 GB	34.8 GB	43.5%	172	39.48	24.62
06	SMALL	13.0 GB	10.2 GB	77.9%	27	4.15	38.08
07	BIN	80.1 GB	39.1 GB	48.8%	155	39.57	24.56
08	BIN	80.1 GB	17.9 GB	22.3%	172	40.04	24.28
09	SMALL	13.0 GB	10.3 GB	78.7%	27	4.17	37.93
10	BIN	80.1 GB	32.9 GB	41.1%	155	39.74	24.46
11	BIN	80.1 GB	42.0 GB	52.4%	172	39.43	24.65
12	BIN	13.0 GB	6.2 GB	47.3%	593	39.80	3.98
13	BIN	80.1 GB	75.8 GB	94.6%	96	39.88	24.37
14	SMALL	80.1 GB	50.0 GB	62.5%	3	4.15	234.12

TOTAL: 14	-	968.5 GB	557.8 GB	57.6%	2152	35.28	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	21890	19859	0	186	12	0	0	0	1833
2	?	1	0	0	0	0	0	0	0	1

TOTAL: 2		21891	19859	0	186	12	0	0	0	1834

Unwanted newsgroups [Top 20]:

Newsgroup	Count

bellsouth.net.test	2503
microsoft.public.test	1029
alt.binaries.pwp	903
alt.binaries.pcgame	823
alt.binaries.dvdrs.pw	720
alt.binaries.uhq	494
alt.binaries.dvd-r	364
szaf.newsticker	268
mozilla.feedback.firefox	171
alt.sex.alt.sex.erotica.marketplace	165
alt.binaries.matrix	145
alt.prowling-for-gay-sex	121
alt.binaries.ls	112
alt.sex.telephonet	111
alt.sex.telephone.alt.sex	105
alt.binaries.fetish	105
alt.sex.telephone.alt	104
alt.sex.marketplace.erotica	104
alt.sex.telephone.alt.sex.services	104
alt.sex.market	103

TOTAL: 1842	19859

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

Groups	Count

de.alt.fan.tabak	12

TOTAL: 1	12

INND misc events:

Events	Count

CCreader	5

TOTAL: 1	5

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	1832
	TOTAL: 1	1832

TOTAL: 1		1832

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	2	45223	1.5 GB	14	0	0	14:36:05
2	ts11-b209.moscow.dial.rol.ru	6	22	1.1 MB	15	0	0	00:22:26

TOTAL: 2		8	45245	1.5 GB	29	0	0	15:25:20

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	2	45223	1.5 GB	14	0	0	14:36:05
2	*.moscow.dial.rol.ru	6	22	1.1 MB	15	0	0	00:22:26
3	*.fttb.kis.ru	2	0	0.0 KB	0	0	0	00:07:07
4	*.sovintel.net	17	0	0.0 KB	0	0	0	00:00:05
5	unresolved	1	0	0.0 KB	0	0	0	00:02:27
6	*.tony.pp.ru	64	0	0.0 KB	0	0	0	00:02:14
7	*.rol.ru	5520	0	0.0 KB	0	0	0	00:14:46

TOTAL: 7		5612	45245	1.5 GB	29	0	0	15:25:14

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	15.841	26.794	0.000	14:36:05
ts11-b209.moscow.dial.rol.ru	0.620	0.372	0.000	00:22:26
balancer-b.rol.ru	3.268	3.112	0.000	00:08:34
balancer-a.rol.ru	2.908	3.604	0.000	00:06:11
dyn-184-113.fttb.kis.ru	0.068	0.088	0.000	00:05:59
195.218.244.87	0.012	0.000	0.000	00:02:27
net1-x-ring.tony.pp.ru	0.112	0.092	0.000	00:02:14
dyn-166-165.fttb.kis.ru	0.008	0.024	0.000	00:01:08
fw-nat.sovintel.net	0.096	0.044	0.000	00:00:05
ts1-a170.spb.dial.rol.ru	0.008	0.012	0.000	00:00:05
fttb-195.222.171.240.ranetka.ru	0.004	0.004	0.000	00:00:00
dyn-72-142.fttb.kis.ru	0.004	0.008	0.000	00:00:00

TOTAL: 12	22.949	34.154	0.000	15:25:20

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2760
balancer-a.rol.ru	2760
net1-x-ring.tony.pp.ru	64
fw-nat.sovintel.net	17
195.218.244.87	1
dyn-166-165.fttb.kis.ru	1
dyn-184-113.fttb.kis.ru	1

TOTAL: 7	5604

NNRP no permission clients:

System	Conn

ts1-a170.spb.dial.rol.ru	8
fttb-195.222.171.240.ranetka.ru	2
dyn-72-142.fttb.kis.ru	1

TOTAL: 3	11

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts11-b209.moscow.dial.rol.ru	1	0

TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	45244	100.0%

TOTAL: 1		45244	100.0%

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

Newsgroup		Count

1	alt.mag.playboy	38154
2	alt.binaries.pictures.bras	4062
3	alt.binaries.full.post.verified.playboy	1585
4	alt.binaries.pictures.girls	807
5	alt.binaries.multimedia.erotic.playboy	615
6	alt.binaries.southern-charms.pictures	21

TOTAL: 6		45244