Daily Usenet report

Feb 5 03:00:07 -- Feb 6 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
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 / 12 lines (41.7%)
Feb 5 03:11:33 perseus controlchan[24499]: Unknown "cmsg" control by max252378.bbs@bbs.wretch.cc
Feb 5 05:12:06 perseus expireover[9023]: OVDB: expiregroup: recounting alt.binaries.cores
Feb 5 06:57:29 perseus expireover[9023]: OVDB: expiregroup: recounting alt.binaries.boneless
Feb 5 11:41:14 perseus controlchan[24499]: Unknown "cmsg" control by Econtinued.bbs@bbs.wretch.cc
Feb 5 12:41:14 perseus controlchan[24499]: Unknown "cmsg" control by qwert12345.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2293700	98.1%	209.6 MB	97.6%
innd	23414	1.0%	2.9 MB	1.4%
nnrpd	18555	0.8%	1.9 MB	0.9%
cnfsstat	2304	0.1%	398.9 KB	0.2%
controlchan	10	0.0%	1.1 KB	0.0%
expireover	2	0.0%	0.2 KB	0.0%

TOTAL: 6	2337985	100.0%	214.8 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2293219	93.7%
Negative hits	147559	6.0%
Positive hits	6867	0.3%
Cache misses	835	0.0%

TOTAL: 4	2448480	100.0%

INND timer:

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

article cancel	00:00:45.889	0.1%	9460	0.000	4.851	1802.000
article cleanup	00:00:24.618	0.0%	2276036	0.003	0.011	0.023
article logging	00:02:01.144	0.1%	2284326	0.004	0.053	3.960
article parse	00:18:08.959	1.3%	146759258	0.005	0.007	0.015
article write	11:24:48.329	47.6%	2171521	3.514	18.921	41.426
artlog/artcncl	00:00:00.152	0.0%	9277	0.000	0.016	2.571
artlog/artparse	00:00:00.000	0.0%	35	0.000	0.000	0.000
data move	00:03:26.573	0.2%	155856851	0.001	0.001	0.002
hisgrep/artcncl	00:00:43.545	0.1%	6906	0.000	6.305	1802.000
hishave/artcncl	00:00:01.729	0.0%	9460	0.000	0.183	278.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:15:33.168	1.1%	2440555	0.001	0.382	14.087
history sync	00:00:00.279	0.0%	289	0.000	0.965	2.000
history write	00:50:35.780	3.5%	2171521	0.028	1.398	11.655
hiswrite/artcncl	00:00:00.395	0.0%	2554	0.000	0.155	36.600
idle	05:38:05.207	23.5%	136522215	0.127	0.149	0.827
nntp read	00:19:36.844	1.4%	145078747	0.006	0.008	0.014
overview write	04:46:36.967	19.9%	2171521	1.461	7.919	439.207
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%	9	0.000	0.000	0.000

TOTAL: 23:59:56.063	23:40:49.578	98.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:00:02.251	0.0%	53	0.000	42.472	55.846
idle	02:57:31.241	74.9%	7392	0.000	1440.915	139043.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:42:10.629	17.8%	85173	0.000	29.712	2279.930
readart	00:01:11.576	0.5%	673	0.000	106.354	344.250

TOTAL: 03:57:02.673	03:40:55.697	93.2%	-	-	-	-

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	357	2278314	2179700	183	98431	95%	487:44:37

TOTAL: 1		357	2278314	2179700	183	98431	95%	487:44:37

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	389.7 GB	4.7 MB	389.8 GB	99%	179.4 KB	487:44:37

TOTAL: 1		389.7 GB	4.7 MB	389.8 GB	99%	179.4 KB	487:44:37

Incoming articles:

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

Feb 5 03:00:07 - 03:59:59	93355	4.3%	25.98	16.0 GB	4.1%	4670.94
Feb 5 04:00:00 - 04:59:59	87810	4.0%	24.39	15.9 GB	4.1%	4618.29
Feb 5 05:00:00 - 05:59:59	83775	3.9%	23.27	15.9 GB	4.1%	4630.83
Feb 5 06:00:00 - 06:59:59	75021	3.5%	20.84	14.6 GB	3.8%	4256.92
Feb 5 07:00:00 - 07:59:59	78588	3.6%	21.83	14.9 GB	3.8%	4342.53
Feb 5 08:00:00 - 08:59:59	81941	3.8%	22.76	15.4 GB	4.0%	4487.21
Feb 5 09:00:00 - 09:59:59	80119	3.7%	22.26	16.0 GB	4.1%	4649.07
Feb 5 10:00:00 - 10:59:59	82179	3.8%	22.83	15.1 GB	3.9%	4395.47
Feb 5 11:00:00 - 11:59:59	93300	4.3%	25.92	16.9 GB	4.4%	4930.05
Feb 5 12:00:00 - 12:59:59	97899	4.5%	27.19	16.8 GB	4.3%	4890.53
Feb 5 13:00:00 - 13:59:59	97466	4.5%	27.07	17.2 GB	4.4%	5021.32
Feb 5 14:00:00 - 14:59:59	95046	4.4%	26.40	17.7 GB	4.5%	5146.17
Feb 5 15:00:00 - 15:59:59	94667	4.4%	26.30	17.9 GB	4.6%	5204.75
Feb 5 16:00:00 - 16:59:59	96654	4.5%	26.85	17.5 GB	4.5%	5101.73
Feb 5 17:00:00 - 17:59:59	92550	4.3%	25.71	17.2 GB	4.4%	5019.62
Feb 5 18:00:00 - 18:59:59	93894	4.3%	26.08	16.6 GB	4.3%	4842.57
Feb 5 19:00:00 - 19:59:59	94557	4.4%	26.27	16.6 GB	4.3%	4840.02
Feb 5 20:00:00 - 20:59:59	92432	4.3%	25.68	15.6 GB	4.0%	4547.92
Feb 5 21:00:00 - 21:59:59	96960	4.5%	26.93	15.9 GB	4.1%	4634.59
Feb 5 22:00:00 - 22:59:59	95574	4.4%	26.55	16.1 GB	4.1%	4684.47
Feb 5 23:00:00 - 23:59:59	95340	4.4%	26.48	15.2 GB	3.9%	4433.05
Feb 6 00:00:00 - 00:59:59	86901	4.0%	24.14	14.8 GB	3.8%	4319.75
Feb 6 01:00:00 - 01:59:59	97660	4.5%	27.13	16.2 GB	4.2%	4719.34
Feb 6 02:00:00 - 02:59:59	87835	4.0%	24.40	16.3 GB	4.2%	4747.47
Feb 6 03:00:00 - 03:00:02	73	0.0%	36.50	13.3 MB	0.0%	6795.73

TOTAL: 23:59:55	2171596	100.0%	25.14	388.4 GB	100.0%	4713.99

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	105.8 GB	76.8%	145	780.25	2.14
02	BIN	137.8 GB	41.6 GB	30.2%	146	790.93	2.11
03	SMALL	13.0 GB	10.3 GB	79.4%	10	9.15	17.29
04	BIN	80.1 GB	21.2 GB	26.4%	106	393.46	2.47
05	BIN	80.1 GB	40.8 GB	50.9%	126	396.04	2.45
06	SMALL	13.0 GB	10.3 GB	79.4%	10	9.15	17.30
07	BIN	80.1 GB	4.9 GB	6.1%	106	392.02	2.48
08	BIN	80.1 GB	25.9 GB	32.4%	126	395.17	2.46
09	SMALL	13.0 GB	9.5 GB	73.2%	10	9.04	17.51
10	BIN	80.1 GB	72.3 GB	90.2%	105	390.76	2.49
11	BIN	80.1 GB	51.6 GB	64.5%	126	396.32	2.45
12	SMALL	13.0 GB	10.1 GB	77.8%	10	9.08	17.42
13	BIN	80.1 GB	69.0 GB	86.2%	105	390.59	2.49
14	BIN	80.1 GB	23.3 GB	29.1%	126	395.01	2.46

TOTAL: 14	-	968.5 GB	496.9 GB	51.3%	1257	340.00	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	112792	101421	0	609	0	0	0	0	10762
2	?	35	0	0	0	0	0	0	0	35

TOTAL: 2		112827	101421	0	609	0	0	0	0	10797

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.sounds.mp3.disney	14678
microsoft.public.test	1399
alt.binaries.pictures.erotica.ametuer.female	831
alt.binaries.pictures.erotica.breasts.sm	758
alt.binaires.erotica	724
alt.binaries.picture.erotica.anal	716
alt.binaries.erotics	664
alt.binaries.pictures.erotica.group	623
alt.binaries.pictures.erotica.voyerism	605
alt.binaries.pictures.erotica.amatuer.female	593
alt.binaries.pictures.erotica.cheerleders	570
alt.binaries.erotica.toys	554
alt.binaries.pictures.erotica.erotic	546
alt.binaries.pictures.erotica.breats	534
alt.binaries.pictures.erotica.bisexual	518
alt.binaries.pictures.erotica.brests	502
alt.binaries.pictures.erotica.amateur.digicam	497
alt.binaries.erotic.incest	496
alt.binaries.pictures.erotica.highheels	493
alt.binaries.erotica.early-teens	492

TOTAL: 2990	101421

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	9
	TOTAL: 1	9
Including strange strings
	192.168.33.37	8290
	TOTAL: 1	8290

TOTAL: 2		8299

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	news.pcs-net.net	9	509	88.7 MB	49	0	0	03:17:58
2	195.218.244.87	2	5	609.4 KB	1	0	0	00:09:12

TOTAL: 2		11	514	89.3 MB	50	0	2	03:56:21

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.pcs-net.net	9	509	88.7 MB	49	0	0	03:17:58
2	unresolved	3	5	609.4 KB	1	0	0	00:09:15
3	*.krasnoyarsk.dial.rol.ru	3	0	0.0 KB	0	0	0	00:00:17
4	*.sovintel.net	13	0	0.0 KB	0	0	0	00:00:29
5	*.moscow.dial.rol.ru	2	0	0.0 KB	0	0	0	00:01:35
6	*.tony.pp.ru	74	0	0.0 KB	0	0	0	00:03:18
7	*.rol.ru	5770	0	0.0 KB	0	0	0	00:21:55
8	*.nn.ru	7	0	0.0 KB	0	0	0	00:00:01
9	*.tr155m.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:01

TOTAL: 9		5882	514	89.3 MB	50	0	1	03:56:13

NNRP total resource statistics [Top 20]:

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

news.pcs-net.net	0.176	0.624	0.000	03:17:58
balancer-b.rol.ru	3.544	3.556	0.000	00:10:59
balancer-a.rol.ru	3.676	3.488	0.000	00:10:56
195.218.244.87	0.016	0.012	0.000	00:09:12
net1-x-ring.tony.pp.ru	0.140	0.128	0.000	00:03:18
?	0.012	0.008	0.000	00:01:21
ts27-a183.moscow.dial.rol.ru	0.024	0.040	0.000	00:00:51
ts30-a75.moscow.dial.rol.ru	0.016	0.004	0.000	00:00:43
fw-nat.sovintel.net	0.140	0.048	0.000	00:00:29
ts1-b166.krasnoyarsk.dial.rol.ru	0.292	0.464	0.000	00:00:17
cornholio.migtel.ru	0.084	0.056	0.000	00:00:07
194.186.71.137	0.004	0.000	0.000	00:00:03
cappa.tr155m.lavtech.ru	0.004	0.000	0.000	00:00:01
ppp91-76-22-150.pppoe.mtu-net.ru	0.004	0.016	0.000	00:00:01
delta.nn.ru	0.004	0.004	0.000	00:00:00
gray.nn.ru	0.000	0.000	0.000	00:00:00

TOTAL: 16	8.136	8.448	0.000	03:56:21

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2888
balancer-b.rol.ru	2882
net1-x-ring.tony.pp.ru	74
fw-nat.sovintel.net	13
gray.nn.ru	4
delta.nn.ru	3
ts1-b166.krasnoyarsk.dial.rol.ru	3
ts27-a183.moscow.dial.rol.ru	1
194.186.71.137	1
ts30-a75.moscow.dial.rol.ru	1
cappa.tr155m.lavtech.ru	1

TOTAL: 11	5871

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	49
ppp91-76-22-150.pppoe.mtu-net.ru	2

TOTAL: 2	51

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	17

TOTAL: 1	17

NNRP client timeouts [Top 20]:

System	Conn	Peer

news.pcs-net.net	1	0

TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	514	100.0%

TOTAL: 1		514	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.vladmodels	252
2	alt.binaries.pictures.webeweb	108
3	alt.binaries.pictures.sandra	72
4	alt.binaries.pictures.youth	49
5	alt.binaries.pictures.wals	28
6	alt.binaries.pictures.pornstars	5

TOTAL: 6		514