Daily Usenet report

Nov 1 03:00:05 -- Nov 2 03:00:03

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
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 / 69 lines (7.2%)
Nov 1 04:48:27 perseus controlchan[7622]: Unknown "cmsg" control by tanoshii.bbs@bbs.cs.nctu.edu.tw
Nov 1 04:50:29 perseus controlchan[7622]: Unknown "cmsg" control by numberseven.bbs@bbs.wretch.cc
Nov 1 04:50:30 perseus controlchan[7622]: Unknown "cmsg" control by idfha.bbs@bbs.wretch.cc
Nov 1 06:14:25 perseus controlchan[7622]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nthu.edu.tw
Nov 1 07:00:42 perseus controlchan[7622]: Unknown "cmsg" control by px0214.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2248680	98.3%	197.1 MB	97.7%
nnrpd	20989	0.9%	2.1 MB	1.0%
innd	15544	0.7%	2.2 MB	1.1%
cnfsstat	2304	0.1%	400.7 KB	0.2%
controlchan	73	0.0%	7.8 KB	0.0%

TOTAL: 5	2287590	100.0%	201.9 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2218466	97.2%
Negative hits	45976	2.0%
Cache misses	14027	0.6%
Positive hits	3395	0.1%

TOTAL: 4	2281864	100.0%

INND timer:

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

article cancel	00:03:33.318	0.2%	18975	0.000	11.242	1640.000
article cleanup	00:00:24.789	0.0%	2212184	0.003	0.011	0.025
article logging	00:02:29.459	0.2%	2229551	0.003	0.067	3.705
article parse	00:18:28.488	1.3%	152894082	0.005	0.007	0.022
article write	10:49:49.556	45.1%	2175305	5.733	17.924	65.921
artlog/artcncl	00:00:01.169	0.0%	18939	0.000	0.062	2.680
artlog/artparse	00:00:00.003	0.0%	69	0.000	0.043	1.000
data move	00:03:33.853	0.2%	162084811	0.001	0.001	0.003
hisgrep/artcncl	00:01:39.933	0.1%	17226	0.000	5.801	1679.000
hishave/artcncl	00:01:51.922	0.1%	18975	0.000	5.898	765.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:28:06.260	2.0%	2264771	0.001	0.745	19.928
history sync	00:00:00.292	0.0%	292	0.000	1.000	3.000
history write	00:55:00.042	3.8%	2175305	0.027	1.517	14.080
hiswrite/artcncl	00:00:00.163	0.0%	1749	0.000	0.093	15.000
idle	06:21:14.196	26.5%	142965317	0.125	0.160	0.505
nntp read	00:20:06.438	1.4%	151242919	0.005	0.008	0.019
overview write	04:16:38.731	17.8%	2175305	1.499	7.079	97.039
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.002	0.0%	68	0.000	0.029	1.000

TOTAL: 23:59:53.278	23:42:58.614	98.8%	-	-	-	-

nnrpd timer:

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

hisgrep	00:10:40.302	0.8%	43326	0.000	14.779	59.987
idle	18:17:48.203	86.7%	94733	0.000	695.304	200247.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:23:47.565	6.6%	444620	0.000	11.308	57872.483
readart	00:31:23.500	2.5%	89612	0.000	21.018	839.000

TOTAL: 21:06:41.468	20:23:39.570	96.6%	-	-	-	-

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

control-microsoft@trigofacile.com	0	0	1	0	0	1
news@news2.open-news-network.org	0	0	1	0	0	1
sfnet@hopeatilhi.cs.tut.fi	0	1	0	0	0	1
wkronert@sunstroke.sdsu.edu	0	0	1	0	0	1

TOTAL	0	1	3	0	0	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	313	2237753	2196946	0	40807	98%	491:02:45

TOTAL: 1		313	2237753	2196946	0	40807	98%	491:02:45

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	393.0 GB	3.9 MB	393.0 GB	99%	184.2 KB	491:02:45

TOTAL: 1		393.0 GB	3.9 MB	393.0 GB	99%	184.2 KB	491:02:45

Incoming articles:

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

Nov 1 03:00:05 - 03:59:59	90508	4.2%	25.18	15.8 GB	4.0%	4599.23
Nov 1 04:00:00 - 04:59:59	82220	3.8%	22.84	14.5 GB	3.7%	4232.66
Nov 1 05:00:00 - 05:59:59	85555	3.9%	23.77	15.5 GB	3.9%	4515.73
Nov 1 06:00:00 - 06:59:59	82981	3.8%	23.05	14.6 GB	3.7%	4250.69
Nov 1 07:00:00 - 07:59:59	92717	4.3%	25.75	14.3 GB	3.6%	4160.59
Nov 1 08:00:00 - 08:59:59	88601	4.1%	24.61	15.0 GB	3.8%	4354.92
Nov 1 09:00:00 - 09:59:59	84708	3.9%	23.53	16.7 GB	4.2%	4867.28
Nov 1 10:00:00 - 10:59:59	87990	4.0%	24.44	17.0 GB	4.3%	4956.63
Nov 1 11:00:00 - 11:59:59	97302	4.5%	27.03	15.7 GB	4.0%	4584.57
Nov 1 12:00:00 - 12:59:59	96123	4.4%	26.70	18.4 GB	4.7%	5365.93
Nov 1 13:00:00 - 13:59:59	96969	4.5%	26.94	18.5 GB	4.7%	5380.27
Nov 1 14:00:00 - 14:59:59	96317	4.4%	26.75	18.4 GB	4.7%	5353.04
Nov 1 15:00:00 - 15:59:59	95554	4.4%	26.54	18.4 GB	4.7%	5366.40
Nov 1 16:00:00 - 16:59:59	95225	4.4%	26.45	18.2 GB	4.6%	5301.04
Nov 1 17:00:00 - 17:59:59	96911	4.5%	26.92	18.5 GB	4.7%	5402.75
Nov 1 18:00:00 - 18:59:59	97859	4.5%	27.18	18.3 GB	4.6%	5333.07
Nov 1 19:00:00 - 19:59:59	92445	4.2%	25.68	17.3 GB	4.4%	5044.92
Nov 1 20:00:00 - 20:59:59	92781	4.3%	25.77	17.3 GB	4.4%	5026.88
Nov 1 21:00:00 - 21:59:59	93354	4.3%	25.93	18.1 GB	4.6%	5262.65
Nov 1 22:00:00 - 22:59:59	90635	4.2%	25.18	17.3 GB	4.4%	5050.99
Nov 1 23:00:00 - 23:59:59	82366	3.8%	22.88	13.9 GB	3.5%	4056.89
Nov 2 00:00:00 - 00:59:59	86368	4.0%	23.99	13.0 GB	3.3%	3780.07
Nov 2 01:00:00 - 01:59:59	83952	3.9%	23.32	14.1 GB	3.6%	4114.43
Nov 2 02:00:00 - 02:59:59	85910	3.9%	23.86	14.9 GB	3.8%	4353.48
Nov 2 03:00:00 - 03:00:03	82	0.0%	27.33	16.4 MB	0.0%	5583.67

TOTAL: 23:59:58	2175433	100.0%	25.18	393.8 GB	100.0%	4779.83

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	79.0 GB	57.3%	103	786.83	2.13
02	BIN	137.8 GB	124.1 GB	90.1%	103	785.63	2.13
03	SMALL	13.0 GB	10.3 GB	79.3%	6	7.54	20.98
04	BIN	80.1 GB	73.9 GB	92.2%	69	399.70	2.43
05	BIN	80.1 GB	606.0 MB	0.7%	90	402.01	2.42
06	SMALL	13.0 GB	10.3 GB	79.0%	6	7.53	21.01
07	BIN	80.1 GB	63.7 GB	79.6%	69	397.95	2.44
08	BIN	80.1 GB	71.9 GB	89.7%	89	401.27	2.42
09	SMALL	13.0 GB	9.9 GB	76.1%	6	7.47	21.19
10	BIN	80.1 GB	56.2 GB	70.2%	69	397.92	2.44
11	BIN	80.1 GB	5.8 GB	7.3%	90	403.02	2.41
12	SMALL	13.0 GB	10.2 GB	78.5%	6	7.53	21.01
13	BIN	80.1 GB	54.3 GB	67.7%	69	396.74	2.45
14	BIN	80.1 GB	68.4 GB	85.5%	89	400.90	2.42

TOTAL: 14	-	968.5 GB	638.7 GB	65.9%	864	344.11	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	54243	36635	0	200	0	0	0	0	17408
2	?	69	0	0	0	0	0	0	0	69

TOTAL: 2		54312	36635	0	200	0	0	0	0	17477

Unwanted newsgroups [Top 20]:

Newsgroup	Count

microsoft.public.test	1257
alt.binaries.pictures.amateur.butts	1123
alt.binaries.lanfer	477
alt.binaries.multimedia.transsexuals	448
lada.avia	415
alt.binaries.pictures.erotica.transsexual	397
alt.binaries.pictures.eroctica.butts	328
alt.binaries.pictures.senior-citizens	309
alt.binaries.pictures.erotica.asian.female	298
alt.biniaries.erotica	298
alt.binaries.erotica.french.movie	288
alt.binaries.pictures.erotica.breast.large	279
alt.binaries.pictures.erotica.voyerism	267
alt.binaries.erotica.best-teens	244
alt.binaries.erotica.toys	240
alt.binaries.pictures.erotica.breats	233
alt.binaries.music.dvd	232
alt.binaries.erotica.strap-on-sex	223
alt.binaries.erotica.kinky.teens	221
alt.binaries.pictures.erotica.exhibitionismw	209

TOTAL: 2011	36635

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	17366
	TOTAL: 1	17366

TOTAL: 1		17366

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	9	43326	1.6 GB	27	0	0	17:02:50
2	ts30-b169.moscow.dial.rol.ru	13	55	6.6 MB	4	0	0	00:30:27
3	ts18-a159.moscow.dial.rol.ru	3	46	1.9 MB	4	0	0	00:56:07
4	ts1-a93.saratov.dial.rol.ru	2	31	65.4 KB	3	0	0	00:16:35
5	ts30-b55.moscow.dial.rol.ru	4	23	343.5 KB	3	0	0	00:41:37
6	194.154.66.225	2	22	4.0 MB	25	0	0	00:02:36
7	adsl-195.218.206.168.ranetka.ru	7	21	1.2 MB	10	0	0	00:05:42
8	ts2-b212.syktyvkar.dial.rol.ru	1	13	409.3 KB	1	0	0	00:01:46
9	ts2-a137.syktyvkar.dial.rol.ru	2	4	419.5 KB	2	0	0	00:04:32
10	ts2-a3.syktyvkar.dial.rol.ru	1	3	261.6 KB	1	0	0	00:05:58
11	212.46.203.9	2	1	10.9 KB	1	0	0	00:02:03
12	ts2-a188.syktyvkar.dial.rol.ru	1	1	73.3 KB	1	0	0	00:10:11

TOTAL: 12		47	43546	1.6 GB	82	0	0	21:05:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	9	43326	1.6 GB	27	0	0	17:02:50
2	*.moscow.dial.rol.ru	49	124	8.9 MB	11	0	0	02:09:44
3	*.saratov.dial.rol.ru	2	31	65.4 KB	3	0	0	00:16:35
4	unresolved	21	23	4.0 MB	26	0	0	00:33:55
5	*.syktyvkar.dial.rol.ru	5	21	1.1 MB	5	0	0	00:22:29
6	*.218.206.168.ranetka.ru	7	21	1.2 MB	10	0	0	00:05:42
7	*.bytecity.ru	3	0	0.0 KB	0	0	0	00:00:00
8	*.sovintel.net	12	0	0.0 KB	0	0	0	00:00:15
9	*.tony.pp.ru	63	0	0.0 KB	0	0	0	00:03:01
10	*.pcs-net.net	1	0	0.0 KB	0	0	0	00:00:01
11	*.rol.ru	5797	0	0.0 KB	0	0	0	00:21:25
12	*.nn.ru	34	0	0.0 KB	0	0	0	00:00:12
13	*.nsk.dial.rol.ru	12	0	0.0 KB	0	0	0	00:00:36

TOTAL: 13		6015	43546	1.6 GB	82	0	0	20:59:07

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	29.832	266.838	0.000	17:02:50
ts18-a159.moscow.dial.rol.ru	0.052	0.048	0.000	00:56:07
ts30-b55.moscow.dial.rol.ru	0.012	0.020	0.000	00:41:37
ts30-b169.moscow.dial.rol.ru	0.024	0.080	0.000	00:30:27
ts1-a93.saratov.dial.rol.ru	0.012	0.028	0.000	00:16:35
194.186.32.95	0.044	0.052	0.000	00:15:51
212.46.202.230	0.012	0.004	0.000	00:12:41
balancer-a.rol.ru	3.576	3.768	0.000	00:10:56
balancer-b.rol.ru	3.608	3.620	0.000	00:10:28
ts2-a188.syktyvkar.dial.rol.ru	0.000	0.000	0.000	00:10:11
ts2-a3.syktyvkar.dial.rol.ru	0.004	0.008	0.000	00:05:58
adsl-195.218.206.168.ranetka.ru	0.020	0.032	0.000	00:05:42
ts1-a176.kemerovo.dial.rol.ru	0.068	0.060	0.000	00:05:37
ts2-a137.syktyvkar.dial.rol.ru	0.012	0.004	0.000	00:04:32
net1-x-ring.tony.pp.ru	0.108	0.116	0.000	00:03:01
194.154.66.225	0.028	0.020	0.000	00:02:36
?	0.004	0.048	0.000	00:02:15
212.46.203.9	0.008	0.032	0.000	00:02:03
ts2-b212.syktyvkar.dial.rol.ru	0.000	0.004	0.000	00:01:46
cornholio.migtel.ru	0.624	0.644	0.000	00:00:53

TOTAL: 37	38.348	275.694	0.000	21:05:40

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2912
balancer-a.rol.ru	2885
net1-x-ring.tony.pp.ru	63
gray.nn.ru	34
fw-nat.sovintel.net	12
ts2-a69.nsk.dial.rol.ru	12
ts23-a88.moscow.dial.rol.ru	10
212.46.235.187	10
ts30-a15.moscow.dial.rol.ru	10
212.46.235.117	5
ts23-b137.moscow.dial.rol.ru	5
ts23-b175.moscow.dial.rol.ru	3
news.bytecity.ru	3
ts1-a176.kemerovo.dial.rol.ru	1
news.pcs-net.net	1
194.186.32.95	1
ts18-a95.moscow.dial.rol.ru	1
212.46.202.230	1

TOTAL: 18	5969

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	440
216.117.134.180	7
ts1-a176.kemerovo.dial.rol.ru	6
ppp78-36-121-2.pppoe.komi.dslavangard.ru	2
85.113.32.9	1
83.167.116.18	1
83.220.64.58	1

TOTAL: 7	458

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	33

TOTAL: 1	33

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts18-a159.moscow.dial.rol.ru	2	0
ts30-b55.moscow.dial.rol.ru	1	0
194.186.32.95	1	0
adsl-195.218.206.168.ranetka.ru	1	0
ts2-a188.syktyvkar.dial.rol.ru	1	0
212.46.202.230	1	0

TOTAL: 6	7	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	43408	99.9%
2	fido7	31	0.1%
3	hr	15	0.0%

TOTAL: 3		43454	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	34940
2	alt.binaries.pictures.artpics	5394
3	alt.binaries.pictures.bras	2898
4	alt.binaires.pictures.erotica.teen.female	58
5	alt.binaries.erotica.pregnant	37
6	fido7.su.windows	31
7	alt.binaries.models.petite	24
8	alt.binaries.nospam.female.bodyhair.pubes	17
9	hr.rec.humor	15
10	alt.binaries.bisexuals	7
11	alt.binaries.pictures.erotica.alt.sex	7
12	alt.comp.os.windows-xp	6
13	alt.binaries.erotica.voyeurism.hidden-camera	6
14	alt.binaries.erotica.teens	5
15	alt.binaries.nospam.female.bodyhair	4
16	alt.binaries.pictures.erotica.incest	2
17	alt.binaries.multimedia.erotica.cum-swapping	2
18	alt.binaries.picture.erotica.amateur.females	1

TOTAL: 18		43454