Daily Usenet report

Sep 21 03:00:03 -- Sep 22 03:00:02

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
Newsgroups created
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 no permission clients
NNRP gethostbyaddr failures
NNRP client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 5 / 66 lines (7.6%)
Sep 21 03:00:17 perseus controlchan[10815]: Unknown "cmsg" control by Uras.bbs@bbs.wretch.cc
Sep 21 03:30:21 perseus controlchan[10815]: Unknown "cmsg" control by chen720802.bbs@bbs.wretch.cc
Sep 21 05:50:22 perseus controlchan[16839]: Unknown "cmsg" control by ryanko.bbs@bbs.wretch.cc
Sep 21 06:00:18 perseus controlchan[16839]: Unknown "cmsg" control by oxidea2.bbs@bbs.wretch.cc
Sep 21 06:00:18 perseus controlchan[16839]: Unknown "cmsg" control by kenyon128029.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2296389	98.3%	202.7 MB	97.7%
nnrpd	20592	0.9%	2.1 MB	1.0%
innd	15964	0.7%	2.2 MB	1.1%
cnfsstat	2304	0.1%	400.9 KB	0.2%
controlchan	69	0.0%	7.9 KB	0.0%
expireover	1	0.0%	0.1 KB	0.0%

TOTAL: 6	2335319	100.0%	207.5 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2288944	97.2%
Negative hits	51415	2.2%
Positive hits	13589	0.6%
Cache misses	1859	0.1%

TOTAL: 4	2355807	100.0%

INND timer:

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

article cancel	00:01:53.641	0.1%	23065	0.000	4.927	1631.000
article cleanup	00:00:25.819	0.0%	2262890	0.003	0.011	0.023
article logging	00:01:57.707	0.1%	2273825	0.004	0.052	4.488
article parse	00:19:54.503	1.4%	163834422	0.005	0.007	0.019
article write	10:28:27.319	43.6%	2232240	3.573	16.892	7867.837
artlog/artcncl	00:00:01.351	0.0%	22673	0.000	0.060	8.593
artlog/artparse	00:00:00.001	0.0%	29	0.000	0.034	1.000
data move	00:03:49.835	0.3%	173421717	0.000	0.001	0.002
hisgrep/artcncl	00:01:37.902	0.1%	13284	0.000	7.370	1631.000
hishave/artcncl	00:00:08.207	0.0%	23065	0.000	0.356	24.571
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:17:35.804	1.2%	2333065	0.001	0.453	8.647
history sync	00:00:00.295	0.0%	291	0.000	1.014	3.000
history write	00:52:31.517	3.6%	2232240	0.029	1.412	13.003
hiswrite/artcncl	00:00:06.026	0.0%	9781	0.000	0.616	138.444
idle	06:19:03.591	26.3%	153155998	0.127	0.148	22.430
nntp read	00:21:40.662	1.5%	162025587	0.006	0.008	0.018
overview write	04:50:40.430	20.2%	2232240	1.523	7.813	87.327
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%	62	0.000	0.016	1.000

TOTAL: 24:00:04.784	23:39:54.611	98.6%	-	-	-	-

nnrpd timer:

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

hisgrep	00:15:33.935	1.0%	89126	0.000	10.479	260.200
idle	23:18:49.305	85.5%	287186	0.000	292.247	200018.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:09:12.010	4.2%	867898	0.000	4.784	5984.107
readart	00:49:41.254	3.0%	182253	0.000	16.358	177.204

TOTAL: 27:15:18.773	25:33:16.504	93.8%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Newsgroups created:

Group	Mode

sci.finance.abstracts	m

TOTAL	1

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

control@cn-bbs.org	0	0	1	0	0	1
nl-admin@nic.surfnet.nl	0	0	1	0	1	1
sitting@this.computer	1	0	0	0	0	0

TOTAL	1	0	2	0	1	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	374	2261392	2231234	248	29910	98%	487:31:33

TOTAL: 1		374	2261392	2231234	248	29910	98%	487:31:33

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	420.3 GB	6.7 MB	420.3 GB	99%	194.9 KB	487:31:33

TOTAL: 1		420.3 GB	6.7 MB	420.3 GB	99%	194.9 KB	487:31:33

Incoming articles:

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

Sep 21 03:00:03 - 03:59:59	93573	4.2%	26.01	17.9 GB	4.3%	5224.03
Sep 21 04:00:00 - 04:59:59	88285	4.0%	24.52	16.8 GB	4.0%	4903.17
Sep 21 05:00:00 - 05:59:59	83930	3.8%	23.31	16.5 GB	3.9%	4813.68
Sep 21 06:00:00 - 06:59:59	80110	3.6%	22.25	16.0 GB	3.8%	4646.82
Sep 21 07:00:00 - 07:59:59	85737	3.8%	23.82	16.1 GB	3.8%	4689.46
Sep 21 08:00:00 - 08:59:59	89681	4.0%	24.91	17.8 GB	4.3%	5193.38
Sep 21 09:00:00 - 09:59:59	78621	3.5%	21.84	15.6 GB	3.7%	4532.04
Sep 21 10:00:00 - 10:59:59	83455	3.7%	23.18	16.7 GB	4.0%	4865.75
Sep 21 11:00:00 - 11:59:59	77364	3.5%	21.49	15.1 GB	3.6%	4392.10
Sep 21 12:00:00 - 12:59:59	97982	4.4%	27.22	18.0 GB	4.3%	5235.33
Sep 21 13:00:00 - 13:59:59	99380	4.5%	27.61	18.2 GB	4.3%	5289.43
Sep 21 14:00:00 - 14:59:59	95635	4.3%	26.57	18.7 GB	4.4%	5432.79
Sep 21 15:00:00 - 15:59:59	101348	4.5%	28.15	18.4 GB	4.4%	5362.56
Sep 21 16:00:00 - 16:59:59	102757	4.6%	28.54	18.3 GB	4.4%	5331.46
Sep 21 17:00:00 - 17:59:59	101872	4.6%	28.30	18.3 GB	4.4%	5340.87
Sep 21 18:00:00 - 18:59:59	102256	4.6%	28.40	18.7 GB	4.5%	5458.19
Sep 21 19:00:00 - 19:59:59	103185	4.6%	28.66	19.1 GB	4.5%	5549.76
Sep 21 20:00:00 - 20:59:59	97338	4.4%	27.04	18.3 GB	4.4%	5337.78
Sep 21 21:00:00 - 21:59:59	98803	4.4%	27.45	18.1 GB	4.3%	5275.93
Sep 21 22:00:00 - 22:59:59	96690	4.3%	26.86	17.9 GB	4.3%	5212.93
Sep 21 23:00:00 - 23:59:59	99649	4.5%	27.68	18.4 GB	4.4%	5371.45
Sep 22 00:00:00 - 00:59:59	91854	4.1%	25.52	16.9 GB	4.0%	4912.79
Sep 22 01:00:00 - 01:59:59	93490	4.2%	25.97	16.9 GB	4.0%	4911.86
Sep 22 02:00:00 - 02:59:59	88971	4.0%	24.71	16.5 GB	3.9%	4817.10
Sep 22 03:00:00 - 03:00:02	140	0.0%	70.00	24.3 MB	0.0%	12432.29

TOTAL: 23:59:59	2232106	100.0%	25.83	419.2 GB	100.0%	5087.69

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	32.3 GB	23.5%	83	827.53	2.02
02	BIN	137.8 GB	61.4 GB	44.6%	83	832.75	2.01
03	SMALL	13.0 GB	2.9 GB	22.3%	5	5.30	29.84
04	BIN	80.1 GB	31.7 GB	39.6%	52	425.98	2.28
05	BIN	80.1 GB	30.5 GB	38.1%	72	428.74	2.27
06	SMALL	13.0 GB	2.9 GB	22.2%	5	5.28	29.97
07	BIN	80.1 GB	25.1 GB	31.4%	52	425.09	2.29
08	BIN	80.1 GB	25.4 GB	31.8%	72	427.97	2.27
09	SMALL	13.0 GB	2.6 GB	20.1%	5	5.24	30.20
10	BIN	80.1 GB	20.5 GB	25.6%	52	423.52	2.30
11	BIN	80.1 GB	33.3 GB	41.6%	72	430.14	2.26
12	SMALL	13.0 GB	2.8 GB	21.8%	5	5.25	30.14
13	BIN	80.1 GB	19.6 GB	24.5%	52	422.72	2.30
14	BIN	80.1 GB	21.9 GB	27.3%	72	428.20	2.27

TOTAL: 14	-	968.5 GB	313.1 GB	32.3%	682	365.69	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	41581	28732	0	1916	0	0	0	0	10933
2	?	29	0	0	0	0	0	0	0	29

TOTAL: 2		41610	28732	0	1916	0	0	0	0	10962

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.	4777
alt.binaries.anime.highspeed	1895
alt.binaries.jerry	920
alt.binaries.pictures.amateur.butts	602
alt.binaries.pictures.erotica.asian.female	410
alt.binaries.erotica.freckles	403
alt.binaries.matrix	220
alt.sci.physics	147
yu.comp.software	141
alt.binaries.nonnude	140
lada.soft	138
pictures.erotica.lesbians	128
ccu.bbs.talk.market	128
alt.prowling-for-gay-sex	123
pedo.japanese.fetish.lolita	114
talk.politics	107
alt.binaries.pictures.bdcompany	106
gmane.comp.telephony.pbx.asterisk.user	105
alt.binaries.pictures.fetish.urine	104
cakewalk.coffeehouse	103

TOTAL: 3589	28732

INND misc events:

Events	Count

CCreader	1

TOTAL: 1	1

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	18
	TOTAL: 1	18
Including strange strings
	192.168.33.37	10933
	TOTAL: 1	10933

TOTAL: 2		10951

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	24	88995	3.1 GB	69	0	0	13:15:13
2	news.pcs-net.net	8	174	36.4 MB	8	0	0	01:38:56
3	ts1-a180.saratov.dial.rol.ru	5	110	6.6 MB	0	0	0	01:23:03
4	ts1-a90.saratov.dial.rol.ru	1	5	12.0 KB	1	0	0	01:55:01
5	ts1-b154.krasnoyarsk.dial.rol.ru	3	4	5.0 KB	1	0	0	00:00:06
6	ts2-a154.syktyvkar.dial.rol.ru	9	3	258.6 KB	2	0	0	00:02:52

TOTAL: 6		50	89291	3.2 GB	81	0	0	27:14:21

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	24	88995	3.1 GB	69	0	0	13:15:13
2	*.pcs-net.net	8	174	36.4 MB	8	0	0	01:38:56
3	*.saratov.dial.rol.ru	6	115	6.6 MB	1	0	0	03:18:04
4	*.krasnoyarsk.dial.rol.ru	3	4	5.0 KB	1	0	0	00:00:06
5	*.syktyvkar.dial.rol.ru	9	3	258.6 KB	2	0	0	00:02:52
6	*.sovintel.net	12	0	0.0 KB	0	0	0	00:00:19
7	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:02
8	*.nsk.dial.rol.ru	38	0	0.0 KB	0	0	0	00:02:38
9	*.kis.ru	1	0	0.0 KB	0	0	0	00:00:07
10	*.moscow.dial.rol.ru	10	0	0.0 KB	0	0	0	00:17:43
11	unresolved	48	0	0.0 KB	0	0	0	07:37:37
12	*.tony.pp.ru	71	0	0.0 KB	0	0	0	00:35:48
13	*.rol.ru	5816	0	0.0 KB	0	0	0	00:20:30
14	*.nn.ru	70	0	0.0 KB	0	0	0	00:00:28

TOTAL: 14		6117	89291	3.2 GB	81	0	0	27:12:33

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	77.480	689.438	0.000	13:15:13
194.154.66.131	0.112	0.084	0.000	07:27:36
ts1-a90.saratov.dial.rol.ru	0.188	0.332	0.000	01:55:01
news.pcs-net.net	0.032	0.200	0.000	01:38:56
ts1-a180.saratov.dial.rol.ru	0.024	0.084	0.000	01:23:03
net1-x-ring.tony.pp.ru	42.348	379.473	0.000	00:35:48
ts18-a72.moscow.dial.rol.ru	0.056	0.040	0.000	00:17:26
balancer-b.rol.ru	3.628	3.868	0.000	00:10:19
balancer-a.rol.ru	3.748	3.752	0.000	00:10:10
194.186.71.137	0.004	0.008	0.000	00:10:00
ts2-a154.syktyvkar.dial.rol.ru	0.016	0.056	0.000	00:02:52
?	0.024	0.032	0.000	00:02:03
82.140.73.76	0.220	0.220	0.000	00:01:24
ts2-a199.nsk.dial.rol.ru	0.024	0.032	0.000	00:01:22
ts2-b189.nsk.dial.rol.ru	0.020	0.032	0.000	00:01:15
gray.nn.ru	0.108	0.104	0.000	00:00:28
fw-nat.sovintel.net	0.096	0.068	0.000	00:00:19
ts24-a78.moscow.dial.rol.ru	0.020	0.004	0.000	00:00:14
ts23-b73.moscow.dial.rol.ru	0.040	0.024	0.000	00:00:12
cornholio.migtel.ru	0.176	0.168	0.000	00:00:09

TOTAL: 30	128.448	1078.099	0.000	27:14:21

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2910
balancer-b.rol.ru	2906
net1-x-ring.tony.pp.ru	71
gray.nn.ru	70
194.154.66.131	47
ts2-b189.nsk.dial.rol.ru	19
ts2-a199.nsk.dial.rol.ru	19
fw-nat.sovintel.net	12
ts24-a78.moscow.dial.rol.ru	4
ts9-b151.moscow.dial.rol.ru	4
ts18-a72.moscow.dial.rol.ru	2
al.kis.ru	1
194.186.71.137	1
news.lek.ru	1
ts23-b73.moscow.dial.rol.ru	1

TOTAL: 15	6068

NNRP no permission clients:

System	Conn

82.140.73.76	140
cornholio.migtel.ru	116
ts23-b73.moscow.dial.rol.ru	13
host-213-145-66-217.spbmts.ru	6
host-219-145-66-217.spbmts.ru	4
83.149.43.9	3
ppp85-141-65-191.pppoe.mtu-net.ru	2
87.103.138.75	2
87.gprs-nat.mtsnet.ru	1

TOTAL: 9	287

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	37

TOTAL: 1	37

NNRP client timeouts [Top 20]:

System	Conn	Peer

news.pcs-net.net	6	0
194.154.66.131	4	0
194.186.71.137	1	0
ts18-a72.moscow.dial.rol.ru	1	0

TOTAL: 4	12	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	90063	100.0%
2	fido7	5	0.0%
3	ahn	4	0.0%

TOTAL: 3		90072	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	68829
2	alt.binaries.pictures.artpics	14374
3	alt.binaries.pictures.bras	6683
4	alt.binaries.pictures.sandra	166
5	alt.binaries.erotica.pictures.cheerleaders	8
6	fido7.ru.linux	5
7	ahn.config	4
8	alt.binaries.nospam.female.bodyhair	2
9	alt.binaries.nospam.female.bodyhair.pubes	1

TOTAL: 9		90072