Daily Usenet report

Oct 6 03:00:07 -- Oct 7 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
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 / 107 lines (4.7%)
Oct 6 05:20:10 andromeda controlchan[7215]: Unknown "cmsg" control by juiihung.bbs@bbs.wretch.cc
Oct 6 05:20:11 andromeda controlchan[7215]: Unknown "cmsg" control by juiihung.bbs@bbs.wretch.cc
Oct 6 09:10:18 andromeda controlchan[7215]: Unknown "cmsg" control by exssperion.bbs@bbs.wretch.cc
Oct 6 09:10:18 andromeda controlchan[7215]: Unknown "cmsg" control by Evilspirited.bbs@bbs.wretch.cc
Oct 6 10:50:08 andromeda controlchan[7215]: Unknown "cmsg" control by johannn.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2303285	98.2%	200.0 MB	97.5%
nnrpd	24730	1.1%	2.5 MB	1.2%
innd	16013	0.7%	2.3 MB	1.1%
cnfsstat	2304	0.1%	405.0 KB	0.2%
controlchan	107	0.0%	11.5 KB	0.0%

TOTAL: 5	2346439	100.0%	205.2 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2279307	97.0%
Negative hits	52650	2.2%
Positive hits	15883	0.7%
Cache misses	1407	0.1%

TOTAL: 4	2349247	100.0%

INND timer:

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

article cancel	00:01:28.751	0.1%	22649	0.000	3.919	1342.000
article cleanup	00:00:36.073	0.0%	2271039	0.006	0.016	0.028
article logging	00:02:22.915	0.2%	2281270	0.006	0.063	5.703
article parse	00:23:25.268	1.6%	174686014	0.006	0.008	0.045
article write	09:32:05.212	39.7%	2229262	2.712	15.398	28.534
artlog/artcncl	00:00:01.003	0.0%	22511	0.000	0.045	62.333
artlog/artparse	00:00:00.000	0.0%	110	0.000	0.000	0.000
data move	00:06:13.475	0.4%	184929409	0.002	0.002	0.005
hisgrep/artcncl	00:01:25.142	0.1%	17071	0.000	4.988	1342.000
hishave/artcncl	00:00:00.559	0.0%	22649	0.000	0.025	9.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:13:35.270	0.9%	2328924	0.001	0.350	7.350
history sync	00:00:00.322	0.0%	290	0.000	1.110	3.000
history write	01:10:39.096	4.9%	2229262	0.044	1.902	15.480
hiswrite/artcncl	00:00:01.775	0.0%	5578	0.000	0.318	773.000
idle	07:04:38.978	29.5%	164048943	0.119	0.155	0.345
nntp read	00:26:31.069	1.8%	173105456	0.007	0.009	0.042
overview write	04:21:49.599	18.2%	2229262	1.247	7.047	137.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.003	0.0%	110	0.000	0.027	1.000

TOTAL: 24:00:21.567	23:24:54.510	97.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:22:53.109	2.8%	40293	0.000	34.078	58.862
idle	10:17:25.443	74.9%	173089	0.000	214.025	300609.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	01:25:19.940	10.3%	781183	0.000	6.554	134548.800
readart	00:33:20.797	4.0%	82101	0.000	24.370	286.333

TOTAL: 13:44:31.039	12:38:59.289	92.1%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	349	2231271	2198842	3	32426	98%	482:12:16

TOTAL: 1		349	2231271	2198842	3	32426	98%	482:12:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	426.2 GB	3.7 MB	426.2 GB	99%	200.3 KB	482:12:16

TOTAL: 1		426.2 GB	3.7 MB	426.2 GB	99%	200.3 KB	482:12:16

Incoming articles:

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

Oct 6 03:00:07 - 03:59:59	95572	4.3%	26.60	18.2 GB	4.2%	5315.17
Oct 6 04:00:00 - 04:59:59	87328	3.9%	24.26	17.4 GB	4.1%	5079.56
Oct 6 05:00:00 - 05:59:59	86522	3.9%	24.03	17.6 GB	4.1%	5131.98
Oct 6 06:00:00 - 06:59:59	80203	3.6%	22.28	15.9 GB	3.7%	4630.45
Oct 6 07:00:00 - 07:59:59	87045	3.9%	24.18	17.2 GB	4.0%	5018.98
Oct 6 08:00:00 - 08:59:59	88074	4.0%	24.46	17.6 GB	4.1%	5127.35
Oct 6 09:00:00 - 09:59:59	82122	3.7%	22.81	16.8 GB	3.9%	4888.59
Oct 6 10:00:00 - 10:59:59	85962	3.9%	23.88	18.1 GB	4.2%	5267.03
Oct 6 11:00:00 - 11:59:59	95977	4.3%	26.66	18.9 GB	4.4%	5504.37
Oct 6 12:00:00 - 12:59:59	100500	4.5%	27.92	19.0 GB	4.4%	5542.66
Oct 6 13:00:00 - 13:59:59	96747	4.3%	26.87	19.2 GB	4.5%	5593.12
Oct 6 14:00:00 - 14:59:59	93458	4.2%	25.96	18.9 GB	4.4%	5512.35
Oct 6 15:00:00 - 15:59:59	90873	4.1%	25.24	18.5 GB	4.3%	5399.22
Oct 6 16:00:00 - 16:59:59	87924	3.9%	24.42	17.5 GB	4.1%	5102.55
Oct 6 17:00:00 - 17:59:59	89690	4.0%	24.91	18.0 GB	4.2%	5246.76
Oct 6 18:00:00 - 18:59:59	93005	4.2%	25.83	18.2 GB	4.2%	5303.83
Oct 6 19:00:00 - 19:59:59	93540	4.2%	25.98	18.4 GB	4.3%	5369.25
Oct 6 20:00:00 - 20:59:59	99982	4.5%	27.77	18.3 GB	4.3%	5322.32
Oct 6 21:00:00 - 21:59:59	94649	4.2%	26.29	18.4 GB	4.3%	5354.55
Oct 6 22:00:00 - 22:59:59	98204	4.4%	27.28	18.4 GB	4.3%	5355.65
Oct 6 23:00:00 - 23:59:59	95979	4.3%	26.66	18.4 GB	4.3%	5368.05
Oct 7 00:00:00 - 00:59:59	90422	4.1%	25.12	15.1 GB	3.5%	4410.54
Oct 7 01:00:00 - 01:59:59	114324	5.1%	31.76	16.5 GB	3.9%	4808.31
Oct 7 02:00:00 - 02:59:59	100450	4.5%	27.90	18.0 GB	4.2%	5239.32
Oct 7 03:00:00 - 03:00:02	76	0.0%	38.00	13.9 MB	0.0%	7108.11

TOTAL: 23:59:55	2228628	100.0%	25.80	428.8 GB	100.0%	5203.87

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	33.6 GB	24.4%	77	872.46	1.92
02	BIN	137.8 GB	48.9 GB	35.5%	77	875.73	1.91
03	SMALL	13.0 GB	8.6 GB	65.6%	4	5.05	31.36
04	BIN	80.1 GB	36.7 GB	45.9%	50	435.44	2.23
05	BIN	80.1 GB	7.6 GB	9.5%	67	437.71	2.22
06	SMALL	13.0 GB	8.4 GB	64.6%	4	4.98	31.76
07	BIN	80.1 GB	32.5 GB	40.6%	50	435.67	2.23
08	BIN	80.1 GB	4.7 GB	5.9%	67	436.82	2.23
09	SMALL	13.0 GB	8.5 GB	65.3%	4	5.03	31.48
10	BIN	80.1 GB	29.6 GB	36.9%	50	435.20	2.23
11	BIN	80.1 GB	13.2 GB	16.4%	67	437.99	2.22
12	SMALL	13.0 GB	8.5 GB	65.2%	4	5.04	31.38
13	BIN	80.1 GB	29.0 GB	36.3%	50	434.13	2.24
14	BIN	80.1 GB	4.8 GB	6.0%	67	436.46	2.23

TOTAL: 14	-	968.5 GB	274.6 GB	28.4%	638	376.05	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	52020	41570	0	217	0	0	0	0	10233
2	?	110	0	0	0	0	0	0	0	110

TOTAL: 2		52130	41570	0	217	0	0	0	0	10343

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.sounds.mp3.test	1614
alt.binaries.dvd-r	563
alt.binaries.	561
alt.binaries.pictures.eroctica.rape	559
alt.binaries.pictures.eroctica.torture	537
alt.binaries.pictures.erotica.feti	529
alt.binaries.pictures.erotic.unusual.object.penetrat	523
alt.binaries.easeynews.pervert	493
alt.binaries.pictures.erotica.asian.female	451
korea.binaries.tv	413
alt.binaries.erotica.freckles	381
alt.binaries.nonnude	334
alt.binaries.jerry	328
cuhk.society.hualien	194
alt.binaries.pictures.katie	169
alt.binaries.pictures.amateur.butts	149
stu.virus	138
alt.binaries.pictures.erotica.highheels	137
alt.binaries.game	132
alt.binaries.pictures.erotica.teen.male.twinks	111

TOTAL: 14759	41570

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	10231
	TOTAL: 1	10231

TOTAL: 2		10240

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	8	40271	3.7 GB	21	0	0	09:07:37
2	ts30-b62.moscow.dial.rol.ru	15	57	151.2 KB	2	0	0	00:44:22
3	ts16-a87.moscow.dial.rol.ru	1	38	2.1 MB	12	0	0	01:01:30
4	ts18-a178.moscow.dial.rol.ru	1	32	1.7 MB	6	0	0	00:29:07
5	194.67.5.187	1	18	1.6 MB	3	0	0	00:31:45
6	news.bytecity.ru	6	15	44.6 KB	466	0	0	00:00:37
7	194.67.5.189	1	7	450.7 KB	1	0	0	00:23:40
8	ts2-b81.syktyvkar.dial.rol.ru	2	2	341.7 KB	1	0	0	00:01:50

TOTAL: 8		35	40440	3.7 GB	512	0	2	13:43:48

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	8	40271	3.7 GB	21	0	0	09:07:37
2	*.moscow.dial.rol.ru	23	127	4.0 MB	20	0	0	02:26:44
3	unresolved	11	25	2.0 MB	4	0	0	00:55:53
4	*.bytecity.ru	6	15	44.6 KB	466	0	0	00:00:37
5	*.syktyvkar.dial.rol.ru	2	2	341.7 KB	1	0	0	00:01:50
6	*.irkutsk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:00
7	*.pcs-net.net	3	0	0.0 KB	0	0	0	00:00:22
8	*.tony.pp.ru	73	0	0.0 KB	0	0	0	00:34:51
9	*.voronezh.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:47
10	*.rol.ru	5797	0	0.0 KB	0	0	0	00:20:35
11	*.sovintel.net	9	0	0.0 KB	0	0	0	00:00:08
12	*.lek.ru	2	0	0.0 KB	0	0	0	00:00:03
13	*.nsk.dial.rol.ru	20	0	0.0 KB	0	0	0	00:01:28
14	*.vladivostok.dial.rol.ru	1	0	0.0 KB	0	0	0	00:07:28
15	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00
16	*.spb.dial.rol.ru	2	0	0.0 KB	0	0	0	00:00:01
17	*.nn.ru	54	0	0.0 KB	0	0	0	00:00:30

TOTAL: 17		6014	40440	3.7 GB	512	0	1	13:39:58

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	27.908	272.752	0.000	09:07:37
ts16-a87.moscow.dial.rol.ru	0.020	0.072	0.000	01:01:30
ts30-b62.moscow.dial.rol.ru	0.040	0.064	0.000	00:44:22
net1-x-ring.tony.pp.ru	40.016	420.543	0.000	00:34:51
194.67.5.187	0.000	0.016	0.000	00:31:45
ts18-a178.moscow.dial.rol.ru	0.028	0.056	0.000	00:29:07
194.67.5.189	0.048	0.108	0.000	00:23:40
ts30-b243.moscow.dial.rol.ru	0.028	0.008	0.000	00:11:44
balancer-b.rol.ru	3.704	4.108	0.000	00:10:27
balancer-a.rol.ru	3.652	3.888	0.000	00:10:07
ts3-a20.vladivostok.dial.rol.ru	0.036	0.144	0.000	00:07:28
cornholio.migtel.ru	1.536	1.600	0.000	00:02:37
ts2-b81.syktyvkar.dial.rol.ru	0.000	0.016	0.000	00:01:50
ts2-b167.nsk.dial.rol.ru	0.032	0.052	0.000	00:01:28
?	0.000	0.016	0.000	00:00:53
ts2-a36.voronezh.dial.rol.ru	0.000	0.000	0.000	00:00:47
82.140.73.76	0.108	0.176	0.000	00:00:40
news.bytecity.ru	0.160	0.224	0.000	00:00:37
gray.nn.ru	0.116	0.156	0.000	00:00:30
news.pcs-net.net	0.124	0.228	0.000	00:00:22

TOTAL: 33	77.768	704.459	0.000	13:43:48

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2915
balancer-a.rol.ru	2882
net1-x-ring.tony.pp.ru	73
gray.nn.ru	54
ts2-b167.nsk.dial.rol.ru	20
fw-nat.sovintel.net	9
ts30-b243.moscow.dial.rol.ru	6
212.46.236.125	5
212.46.236.216	4
news.pcs-net.net	3
news.lek.ru	2
ts5-b246.spb.dial.rol.ru	2
ts1-b137.samara.dial.rol.ru	1
ts2-a36.voronezh.dial.rol.ru	1
ts1-a111.irkutsk.dial.rol.ru	1
cappa.tr155m.lavtech.ru	1
ts3-a20.vladivostok.dial.rol.ru	1

TOTAL: 17	5980

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	1073
82.140.73.76	77
ts1-b137.samara.dial.rol.ru	7
ts1-a221.bratsk.dial.rol.ru	5
83.220.64.60	1
83.220.64.117	1
12.147.176.2	1
83.220.64.114	1

TOTAL: 8	1166

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	17

TOTAL: 1	17

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts30-b62.moscow.dial.rol.ru	2	0
194.67.5.189	1	0
ts30-b243.moscow.dial.rol.ru	1	0

TOTAL: 3	4	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	41793	99.9%
2	pl	57	0.1%
3	fido7	4	0.0%

TOTAL: 3		41854	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	32216
2	alt.binaries.pictures.bras	5449
3	alt.binaries.pictures.artpics	4020
4	pl.sci.historia	53
5	alt.binaries.erotica.pregnant	31
6	alt.binaries.pictures.erotica.female	25
7	alt.binaries.pictures.erotica.incest	16
8	alt.comp.lang.c	11
9	alt.binaries.erotica.pregnant-movies	7
10	alt.binaries.pictures.erotica.alt.sex	7
11	alt.binaries.nospam.incest	5
12	fido7.ru.sat.news	4
13	pl.rec.anime	4
14	alt.binaries.pictures.lolita	2
15	alt.binaries.nospam.female.bodyhair	2
16	alt.binaries.pictures.erotica.amateur.lolita	2

TOTAL: 16		41854