Daily Usenet report

Sep 30 03:00:05 -- Oct 1 03:00:04

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
Newsgroups removed
Control Channel
Incoming Feeds (INN)
Incoming Volume (INN)
Incoming articles
CNFS buffer status
Sites sending bad articles
Unwanted newsgroups
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 / 62 lines (8.1%)
Sep 30 03:00:18 perseus controlchan[16839]: Unknown "cmsg" control by alexndy.bbs@bbs.cm.nctu.edu.tw
Sep 30 03:00:18 perseus controlchan[16839]: Unknown "cmsg" control by alexndy.bbs@bbs.cm.nctu.edu.tw
Sep 30 03:00:18 perseus controlchan[16839]: Unknown "cmsg" control by alexndy.bbs@bbs.cm.nctu.edu.tw
Sep 30 03:00:18 perseus controlchan[16839]: Unknown "cmsg" control by alexndy.bbs@bbs.cm.nctu.edu.tw
Sep 30 03:00:20 perseus controlchan[16839]: Unknown "cmsg" control by alexndy.bbs@bbs.cm.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2122752	96.7%	184.6 MB	96.3%
innd	47483	2.2%	4.8 MB	2.5%
nnrpd	21837	1.0%	2.0 MB	1.0%
cnfsstat	2304	0.1%	395.9 KB	0.2%
controlchan	65	0.0%	6.5 KB	0.0%

TOTAL: 5	2194441	100.0%	191.7 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2118489	97.9%
Negative hits	43069	2.0%
Positive hits	2468	0.1%
Cache misses	953	0.0%

TOTAL: 4	2164979	100.0%

INND timer:

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

article cancel	00:00:53.522	0.1%	12504	0.000	4.280	1697.000
article cleanup	00:00:24.302	0.0%	2100700	0.003	0.012	0.024
article logging	00:02:38.681	0.2%	2110055	0.004	0.075	4.550
article parse	00:18:46.490	1.3%	159480116	0.005	0.007	0.022
article write	09:06:11.198	37.9%	2080737	3.294	15.750	48.695
artlog/artcncl	00:00:00.130	0.0%	12327	0.000	0.011	13.000
artlog/artparse	00:00:00.001	0.0%	97	0.000	0.010	1.000
data move	00:03:40.391	0.3%	168968343	0.001	0.001	0.002
hisgrep/artcncl	00:00:48.649	0.1%	3324	0.000	14.636	1697.000
hishave/artcncl	00:00:04.390	0.0%	12504	0.000	0.351	204.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:20:42.189	1.4%	2153890	0.001	0.577	11.294
history sync	00:00:00.307	0.0%	292	0.000	1.051	3.000
history write	00:52:16.890	3.6%	2080737	0.028	1.508	13.158
hiswrite/artcncl	00:00:00.292	0.0%	9180	0.000	0.032	24.000
idle	06:59:22.661	29.1%	149759588	0.127	0.168	0.568
nntp read	00:20:37.603	1.4%	157958165	0.005	0.008	0.019
overview write	05:31:32.779	23.0%	2080737	1.910	9.560	95.690
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%	61	0.000	0.016	1.000

TOTAL: 23:59:44.732	23:38:00.476	98.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:38:37.991	2.3%	40815	0.000	56.793	72.258
idle	24:15:26.894	86.6%	209118	0.000	417.596	127877.200
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:17:34.122	4.6%	794495	0.000	5.858	92479.882
readart	00:44:17.621	2.6%	82464	0.000	32.228	201.000

TOTAL: 27:59:57.694	26:55:56.628	96.2%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Newsgroups removed:

Group

comp.unix.bsd.bsdi.announce

TOTAL: 1

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK

group-admin@isc.org	0	1	0	0	1	1
news@news.belwue.de	0	0	1	0	0	1

TOTAL	0	1	1	0	1	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	381	2119586	2098238	8	21340	98%	490:29:02

TOTAL: 1		381	2119586	2098238	8	21340	98%	490:29:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	401.0 GB	4.8 MB	401.0 GB	99%	198.4 KB	490:29:02

TOTAL: 1		401.0 GB	4.8 MB	401.0 GB	99%	198.4 KB	490:29:02

Incoming articles:

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

Sep 30 03:00:05 - 03:59:59	88112	4.2%	24.51	17.8 GB	4.4%	5190.53
Sep 30 04:00:00 - 04:59:59	83371	4.0%	23.16	17.0 GB	4.3%	4962.09
Sep 30 05:00:00 - 05:59:59	82375	4.0%	22.88	16.6 GB	4.2%	4847.44
Sep 30 06:00:00 - 06:59:59	85231	4.1%	23.68	16.5 GB	4.1%	4813.12
Sep 30 07:00:00 - 07:59:59	74167	3.6%	20.60	14.6 GB	3.6%	4245.60
Sep 30 08:00:00 - 08:59:59	86924	4.2%	24.15	17.9 GB	4.5%	5206.22
Sep 30 09:00:00 - 09:59:59	76908	3.7%	21.36	15.9 GB	4.0%	4633.98
Sep 30 10:00:00 - 10:59:59	81701	3.9%	22.69	16.7 GB	4.2%	4878.67
Sep 30 11:00:00 - 11:59:59	83021	4.0%	23.06	16.9 GB	4.2%	4935.33
Sep 30 12:00:00 - 12:59:59	87615	4.2%	24.34	17.5 GB	4.4%	5100.74
Sep 30 13:00:00 - 13:59:59	91443	4.4%	25.40	18.3 GB	4.6%	5331.82
Sep 30 14:00:00 - 14:59:59	96553	4.6%	26.82	18.2 GB	4.5%	5302.90
Sep 30 15:00:00 - 15:59:59	97373	4.7%	27.05	18.5 GB	4.6%	5396.12
Sep 30 16:00:00 - 16:59:59	91045	4.4%	25.29	16.4 GB	4.1%	4773.26
Sep 30 17:00:00 - 17:59:59	89684	4.3%	24.91	16.9 GB	4.2%	4925.89
Sep 30 18:00:00 - 18:59:59	89442	4.3%	24.84	16.9 GB	4.2%	4909.91
Sep 30 19:00:00 - 19:59:59	88414	4.2%	24.56	16.7 GB	4.2%	4872.78
Sep 30 20:00:00 - 20:59:59	84715	4.1%	23.53	15.6 GB	3.9%	4556.41
Sep 30 21:00:00 - 21:59:59	89971	4.3%	24.99	16.2 GB	4.1%	4725.00
Sep 30 22:00:00 - 22:59:59	92175	4.4%	25.60	17.1 GB	4.3%	4987.75
Sep 30 23:00:00 - 23:59:59	90432	4.3%	25.12	16.7 GB	4.2%	4874.59
Oct 1 00:00:00 - 00:59:59	82612	4.0%	22.95	14.9 GB	3.7%	4337.67
Oct 1 01:00:00 - 01:59:59	82294	4.0%	22.86	14.7 GB	3.7%	4295.43
Oct 1 02:00:00 - 02:59:59	85372	4.1%	23.71	15.6 GB	3.9%	4556.36
Oct 1 03:00:00 - 03:00:04	73	0.0%	18.25	13.8 MB	0.0%	3542.62

TOTAL: 23:59:59	2081023	100.0%	24.09	400.5 GB	100.0%	4860.74

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	94.1 GB	68.3%	87	788.65	2.12
02	BIN	137.8 GB	126.9 GB	92.1%	87	806.80	2.07
03	SMALL	13.0 GB	6.8 GB	52.1%	5	4.14	38.20
04	BIN	80.1 GB	18.3 GB	22.9%	56	407.25	2.39
05	BIN	80.1 GB	19.4 GB	24.2%	76	409.39	2.37
06	SMALL	13.0 GB	6.8 GB	51.9%	5	4.12	38.37
07	BIN	80.1 GB	10.9 GB	13.6%	56	406.24	2.39
08	BIN	80.1 GB	13.2 GB	16.5%	76	408.74	2.38
09	SMALL	13.0 GB	6.5 GB	49.6%	5	4.13	38.32
10	BIN	80.1 GB	5.6 GB	6.9%	56	405.68	2.40
11	BIN	80.1 GB	22.4 GB	28.0%	76	409.71	2.37
12	SMALL	13.0 GB	6.7 GB	51.5%	5	4.13	38.36
13	BIN	80.1 GB	4.4 GB	5.5%	56	405.90	2.39
14	BIN	80.1 GB	9.6 GB	12.0%	76	408.58	2.38

TOTAL: 14	-	968.5 GB	351.5 GB	36.3%	722	349.66	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	29305	19855	0	89	0	0	0	0	9361
2	?	97	0	0	0	0	0	0	0	97

TOTAL: 2		29402	19855	0	89	0	0	0	0	9458

Unwanted newsgroups [Top 20]:

Newsgroup	Count

es.binarios.hd	1479
alt.binaries.hotrod	761
alt.binaries.pictures.amateur.butts	560
de.alt.sex.fetish	294
alt.binaries.dk-custom.dvdr	282
alt.binaries.pictures.erotica.asian.female	238
alt.binaries.nospam.female.short-hair	214
alt.binares.warez	185
telekabel.tratsch	146
alt.binaries.pictures.erotica.amateur.facial	137
alt.binaries.pictures.eroctica.butts	131
ccu.bbs.talk.market	127
alt.prowling-for-gay-sex	112
alt.binaries.pictures.amateur.facials	109
alt.biniaries.erotica	107
it-alt.salute.tumori	105
alt.sex.beastilaity	102
pedo.japanese.fetish.lolita	95
alt.binaries.pictures.erotica.shavers	91
alt.binaries.pictures.fetish.urine	91

TOTAL: 2303	19855

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	9
	TOTAL: 1	9
Including strange strings
	192.168.33.37	9355
	TOTAL: 1	9355

TOTAL: 2		9364

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	4	40781	4.5 GB	15	0	0	14:47:40
2	ts1-a207.saratov.dial.rol.ru	9	25	2.6 MB	0	0	0	00:30:36
3	ts27-b10.moscow.dial.rol.ru	5	11	94.4 KB	1	0	0	00:06:03
4	ts30-a199.moscow.dial.rol.ru	3	9	711.5 KB	3	0	0	00:34:03
5	ts30-b128.moscow.dial.rol.ru	5	5	161.4 KB	3	0	0	00:02:28
6	194.67.5.185	2	1	19.4 KB	1	0	0	00:03:27

TOTAL: 6		28	40832	4.5 GB	23	0	2	27:59:17

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	4	40781	4.5 GB	15	0	0	14:47:40
2	*.saratov.dial.rol.ru	9	25	2.6 MB	0	0	0	00:30:36
3	*.moscow.dial.rol.ru	18	25	967.4 KB	7	0	0	00:54:23
4	unresolved	87	1	19.4 KB	1	0	0	10:23:58
5	*.sovintel.net	13	0	0.0 KB	0	0	0	00:00:14
6	*.cis.ru	1	0	0.0 KB	0	0	0	00:10:38
7	*.spb.dial.rol.ru	2	0	0.0 KB	0	0	0	00:00:03
8	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:19
9	*.nsk.dial.rol.ru	38	0	0.0 KB	0	0	0	00:01:11
10	*.volgograd.dial.rol.ru	2	0	0.0 KB	0	0	0	00:08:03
11	*.sarov.dial.rol.ru	2	0	0.0 KB	0	0	0	00:00:23
12	*.tony.pp.ru	79	0	0.0 KB	0	0	0	00:38:26
13	*.rol.ru	5820	0	0.0 KB	0	0	0	00:19:31
14	*.nn.ru	32	0	0.0 KB	0	0	0	00:00:15
15	*.novokuznetzk.dial.rol.ru	4	0	0.0 KB	0	0	0	00:00:07
16	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00

TOTAL: 16		6113	40832	4.5 GB	23	0	1	27:57:46

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	19.156	170.362	0.000	14:47:40
194.154.66.131	0.096	0.104	0.000	10:19:54
net1-x-ring.tony.pp.ru	41.488	381.305	0.000	00:38:26
ts30-a199.moscow.dial.rol.ru	0.008	0.012	0.000	00:34:03
ts1-a207.saratov.dial.rol.ru	0.012	0.052	0.000	00:30:36
ts30-a117.moscow.dial.rol.ru	0.000	0.000	0.000	00:10:39
sword.cis.ru	0.100	0.072	0.000	00:10:38
balancer-b.rol.ru	3.704	3.816	0.000	00:09:51
balancer-a.rol.ru	3.616	3.708	0.000	00:09:39
ts2-a188.volgograd.dial.rol.ru	0.072	0.032	0.000	00:08:03
ts27-b10.moscow.dial.rol.ru	0.020	0.040	0.000	00:06:03
194.67.5.185	0.032	0.072	0.000	00:03:27
ts30-b128.moscow.dial.rol.ru	0.012	0.020	0.000	00:02:28
?	0.020	0.028	0.000	00:01:51
82.140.73.76	0.264	0.236	0.000	00:01:09
ts9-a57.moscow.dial.rol.ru	0.016	0.056	0.000	00:01:08
ts2-a226.nsk.dial.rol.ru	0.020	0.024	0.000	00:00:48
ts2-a83.sarov.dial.rol.ru	0.084	0.088	0.000	00:00:23
ts2-b205.nsk.dial.rol.ru	0.028	0.028	0.000	00:00:22
cornholio.migtel.ru	0.568	0.596	0.000	00:00:20

TOTAL: 37	69.628	560.947	0.000	27:59:17

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2912
balancer-b.rol.ru	2908
net1-x-ring.tony.pp.ru	79
194.154.66.131	63
gray.nn.ru	32
ts2-b205.nsk.dial.rol.ru	20
ts2-a226.nsk.dial.rol.ru	18
fw-nat.sovintel.net	13
212.46.236.141	10
212.46.235.212	5
ts2-a91.novokuznetzk.dial.rol.ru	4
ts9-a57.moscow.dial.rol.ru	4
212.46.203.198	3
ts2-a188.volgograd.dial.rol.ru	2
212.46.202.115	2
ts2-a83.sarov.dial.rol.ru	2
212.46.202.80	2
ts5-b135.spb.dial.rol.ru	2
sword.cis.ru	1
news.lek.ru	1

TOTAL: 22	6085

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	426
82.140.73.76	141
host-212-145-66-217.spbmts.ru	4
host-211-145-66-217.spbmts.ru	2
195.28.36.242	1
ppp91-76-127-154.pppoe.mtu-net.ru	1
83.167.116.18	1
ppp91-77-24-114.pppoe.mtu-net.ru	1

TOTAL: 8	577

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	33

TOTAL: 1	33

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	4	0
sword.cis.ru	1	0
ts30-a117.moscow.dial.rol.ru	1	0

TOTAL: 3	6	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	39987	100.0%
2	japan2nd	3	0.0%
3	hr	2	0.0%

TOTAL: 3		39992	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	36563
2	alt.binaries.pictures.artpics	1808
3	alt.binaries.pictures.bras	1595
4	alt.politics.socialism.libertarian	11
5	alt.sex.binaries.erotica.teen	9
6	japan2nd.binaries.pictures.erotica.lolita	3
7	hr.rec.film.anime	1
8	hr.soc.povijest	1
9	alt.binaries.pictures.erotica.female	1

TOTAL: 9		39992