Daily Usenet report

Sep 12 03:00:05 -- Sep 13 03:00:02

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 / 144 lines (3.5%)
Sep 12 04:40:15 perseus controlchan[28453]: Unknown "cmsg" control by winble.bbs@bbs.wretch.cc
Sep 12 04:40:15 perseus controlchan[28453]: Unknown "cmsg" control by kevinee.bbs@bbs.wretch.cc
Sep 12 05:00:16 perseus controlchan[28453]: Unknown "cmsg" control by ricemilk.bbs@bbs.wretch.cc
Sep 12 05:11:37 perseus controlchan[28453]: Unknown "cmsg" control by jiffney.bbs@bbs.wretch.cc
Sep 12 05:11:37 perseus controlchan[28453]: Unknown "cmsg" control by boboba.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2330184	98.1%	206.1 MB	97.6%
innd	21527	0.9%	2.8 MB	1.3%
nnrpd	20285	0.9%	2.0 MB	1.0%
cnfsstat	2304	0.1%	399.5 KB	0.2%
controlchan	145	0.0%	15.5 KB	0.0%
expireover	1	0.0%	0.2 KB	0.0%

TOTAL: 6	2374446	100.0%	211.2 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2320920	98.1%
Negative hits	41901	1.8%
Positive hits	2088	0.1%
Cache misses	1484	0.1%

TOTAL: 4	2366393	100.0%

INND timer:

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

article cancel	00:01:35.785	0.1%	14832	0.000	6.458	1470.000
article cleanup	00:00:25.299	0.0%	2304930	0.003	0.011	0.020
article logging	00:01:53.560	0.1%	2316277	0.004	0.049	4.534
article parse	00:19:32.736	1.4%	165686178	0.005	0.007	0.024
article write	10:33:32.837	44.0%	2275804	3.944	16.703	58.454
artlog/artcncl	00:00:00.327	0.0%	14454	0.000	0.023	9.500
artlog/artparse	00:00:00.000	0.0%	33	0.000	0.000	0.000
data move	00:03:49.178	0.3%	175496425	0.001	0.001	0.003
hisgrep/artcncl	00:01:10.810	0.1%	3412	0.000	20.753	1470.000
hishave/artcncl	00:00:23.366	0.0%	14832	0.000	1.575	380.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:21:03.904	1.5%	2353080	0.001	0.537	10.596
history sync	00:00:00.304	0.0%	290	0.000	1.048	3.000
history write	00:54:17.830	3.8%	2275804	0.024	1.432	12.377
hiswrite/artcncl	00:00:01.193	0.0%	11420	0.000	0.104	4.852
idle	06:35:53.568	27.5%	155206241	0.127	0.153	0.692
nntp read	00:21:23.888	1.5%	163904952	0.006	0.008	0.022
overview write	04:24:11.560	18.3%	2275804	0.597	6.965	88.282
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.004	0.0%	142	0.000	0.028	1.000

TOTAL: 24:00:22.155	23:39:16.149	98.5%	-	-	-	-

nnrpd timer:

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

hisgrep	00:11:55.857	0.6%	26745	0.000	26.766	41.624
idle	29:30:03.359	94.7%	107087	0.000	991.748	200220.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:09:05.369	0.5%	451960	0.000	1.207	1496.406
readart	00:24:04.215	1.3%	56197	0.000	25.699	192.000

TOTAL: 31:08:22.392	30:15:08.800	97.2%	-	-	-	-

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

newsmaster@carnet.hr	0	0	2	0	0	2

TOTAL	0	0	2	0	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	322	2272111	2247681	1	24429	98%	486:06:25

TOTAL: 1		322	2272111	2247681	1	24429	98%	486:06:25

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	415.7 GB	5.2 MB	415.7 GB	99%	191.8 KB	486:06:25

TOTAL: 1		415.7 GB	5.2 MB	415.7 GB	99%	191.8 KB	486:06:25

Incoming articles:

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

Sep 12 03:00:05 - 03:59:59	92176	4.1%	25.64	17.0 GB	4.1%	4949.75
Sep 12 04:00:00 - 04:59:59	88399	3.9%	24.56	16.9 GB	4.0%	4916.91
Sep 12 05:00:00 - 05:59:59	87483	3.8%	24.30	17.1 GB	4.1%	4970.14
Sep 12 06:00:00 - 06:59:59	80910	3.6%	22.48	15.5 GB	3.7%	4507.32
Sep 12 07:00:00 - 07:59:59	89108	3.9%	24.75	16.9 GB	4.1%	4926.80
Sep 12 08:00:00 - 08:59:59	85893	3.8%	23.86	16.5 GB	4.0%	4806.13
Sep 12 09:00:00 - 09:59:59	88304	3.9%	24.53	17.1 GB	4.1%	4970.53
Sep 12 10:00:00 - 10:59:59	90323	4.0%	25.09	16.6 GB	4.0%	4835.25
Sep 12 11:00:00 - 11:59:59	97297	4.3%	27.03	17.6 GB	4.2%	5126.71
Sep 12 12:00:00 - 12:59:59	101707	4.5%	28.25	18.3 GB	4.4%	5319.57
Sep 12 13:00:00 - 13:59:59	102647	4.5%	28.51	18.3 GB	4.4%	5324.97
Sep 12 14:00:00 - 14:59:59	100734	4.4%	27.98	18.6 GB	4.5%	5424.83
Sep 12 15:00:00 - 15:59:59	98810	4.3%	27.45	18.5 GB	4.4%	5384.11
Sep 12 16:00:00 - 16:59:59	99229	4.4%	27.56	17.8 GB	4.3%	5188.77
Sep 12 17:00:00 - 17:59:59	96514	4.2%	26.81	17.8 GB	4.3%	5184.91
Sep 12 18:00:00 - 18:59:59	92674	4.1%	25.74	17.6 GB	4.2%	5130.97
Sep 12 19:00:00 - 19:59:59	97033	4.3%	26.95	17.8 GB	4.3%	5187.76
Sep 12 20:00:00 - 20:59:59	99889	4.4%	27.75	17.7 GB	4.2%	5149.63
Sep 12 21:00:00 - 21:59:59	102207	4.5%	28.39	18.1 GB	4.4%	5284.12
Sep 12 22:00:00 - 22:59:59	101711	4.5%	28.25	19.0 GB	4.5%	5521.30
Sep 12 23:00:00 - 23:59:59	99883	4.4%	27.75	18.1 GB	4.3%	5278.13
Sep 13 00:00:00 - 00:59:59	88633	3.9%	24.62	16.1 GB	3.9%	4682.52
Sep 13 01:00:00 - 01:59:59	101175	4.4%	28.10	15.2 GB	3.6%	4416.61
Sep 13 02:00:00 - 02:59:59	92420	4.1%	25.67	17.0 GB	4.1%	4958.36
Sep 13 03:00:00 - 03:00:02	82	0.0%	41.00	14.3 MB	0.0%	7342.83

TOTAL: 23:59:57	2275241	100.0%	26.33	416.9 GB	100.0%	5060.31

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	89.4 GB	64.8%	78	832.53	2.01
02	BIN	137.8 GB	114.0 GB	82.7%	78	832.89	2.01
03	SMALL	13.0 GB	12.0 GB	91.7%	4	5.83	27.13
04	BIN	80.1 GB	35.3 GB	44.1%	48	423.79	2.29
05	BIN	80.1 GB	31.9 GB	39.9%	68	426.94	2.28
06	SMALL	13.0 GB	11.9 GB	91.5%	4	5.88	26.91
07	BIN	80.1 GB	29.9 GB	37.4%	48	422.56	2.30
08	BIN	80.1 GB	27.7 GB	34.6%	68	425.74	2.28
09	SMALL	13.0 GB	11.7 GB	89.6%	4	5.82	27.17
10	BIN	80.1 GB	26.1 GB	32.6%	48	421.01	2.31
11	BIN	80.1 GB	34.1 GB	42.5%	68	427.22	2.28
12	SMALL	13.0 GB	11.9 GB	91.2%	4	5.82	27.18
13	BIN	80.1 GB	25.5 GB	31.8%	48	420.26	2.31
14	BIN	80.1 GB	24.3 GB	30.3%	68	424.85	2.29

TOTAL: 14	-	968.5 GB	485.5 GB	50.1%	636	364.81	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	40461	28966	0	164	0	0	0	0	11331
2	?	33	0	0	0	0	0	0	0	33

TOTAL: 2		40494	28966	0	164	0	0	0	0	11364

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.movie	3628
alt.binaries.	1102
alt.binaries.pictures.erotica.asian.female	599
alt.binaries.pictures.amateur.butts	583
alt.binaries.pictures.eroctica.torture	564
alt.binaries.pictures.erotic.unusual.object.penetrat	526
alt.binaries.pictures.eroctica.rape	501
alt.binaries.ua-r	327
alt.binaries.pictures.erotica.feti	281
pedo.japanese.fetish.lolita	227
alt.binaries.multimedia.erotica.transexuals	219
alt.binaries.erotica.erotica.bisexuals	216
alt.binaries.bodybuilding	213
alt.binaries.multimedia.transsexuals	200
alt.binaires.pictures.erotica.male	168
ccu.bbs.talk.market	148
alt.binaries.pictures.erotica.teen.male.masturbation	142
adobe.photoshop.elements.tips.tricks	126
alt.binaries.pictures.fetish.urine	113
lada.soft	111

TOTAL: 2224	28966

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

TOTAL: 2		11340

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	5	26687	1.0 GB	15	0	0	15:23:56
2	ts27-a9.moscow.dial.rol.ru	3	8	737.5 KB	2	0	0	00:15:43
3	ts2-a43.bryansk.dial.rol.ru	9	1	14.9 KB	7	0	0	00:24:38

TOTAL: 3		17	26696	1.0 GB	24	0	2	31:07:43

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	5	26687	1.0 GB	15	0	0	15:23:56
2	*.moscow.dial.rol.ru	17	8	737.5 KB	2	0	0	00:46:48
3	*.bryansk.dial.rol.ru	9	1	14.9 KB	7	0	0	00:24:38
4	*.ufa.dial.rol.ru	5	0	0.0 KB	0	0	0	00:01:11
5	*.sovintel.net	18	0	0.0 KB	0	0	0	00:00:28
6	*.achinsk.dial.rol.ru	1	0	0.0 KB	0	0	0	00:02:13
7	*.lek.ru	1	0	0.0 KB	0	0	0	00:00:02
8	*.pcs-net.net	1	0	0.0 KB	0	0	0	00:00:25
9	*.lavtech.ru	1	0	0.0 KB	0	0	1	00:00:00
10	*.nsk.dial.rol.ru	39	0	0.0 KB	0	0	0	00:01:08
11	*.sarov.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:01
12	*.kemerovo.dial.rol.ru	3	0	0.0 KB	0	0	0	00:21:28
13	unresolved	87	0	0.0 KB	0	0	0	13:05:19
14	*.tony.pp.ru	98	0	0.0 KB	0	0	0	00:27:41
15	*.voronezh.dial.rol.ru	3	0	0.0 KB	0	0	0	00:03:27
16	*.rol.ru	5823	0	0.0 KB	0	0	0	00:19:52
17	*.nn.ru	101	0	0.0 KB	0	0	0	00:00:30
18	*.komi.com	1	0	0.0 KB	0	0	0	00:05:09

TOTAL: 18		6214	26696	1.0 GB	24	0	1	31:07:22

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	17.940	155.618	0.000	15:23:56
194.154.66.131	0.116	0.104	0.000	13:03:17
net1-x-ring.tony.pp.ru	30.820	286.004	0.000	00:27:41
ts2-a43.bryansk.dial.rol.ru	0.040	0.008	0.000	00:24:38
ts1-a233.kemerovo.dial.rol.ru	0.148	0.184	0.000	00:21:28
ts9-a151.moscow.dial.rol.ru	0.016	0.020	0.000	00:20:15
ts27-a9.moscow.dial.rol.ru	0.032	0.028	0.000	00:15:43
ts18-a88.moscow.dial.rol.ru	0.012	0.016	0.000	00:10:01
balancer-a.rol.ru	3.748	3.904	0.000	00:09:57
balancer-b.rol.ru	3.816	3.776	0.000	00:09:55
main.komi.com	0.060	0.052	0.000	00:05:09
ts3-b151.voronezh.dial.rol.ru	0.004	0.008	0.000	00:03:27
?	0.028	0.036	0.000	00:02:57
ts2-a6.achinsk.dial.rol.ru	0.152	0.264	0.000	00:02:13
ts2-b41.ufa.dial.rol.ru	0.016	0.032	0.000	00:01:11
ts2-a144.nsk.dial.rol.ru	0.080	0.064	0.000	00:01:08
81.211.38.37	1.100	10.157	0.000	00:00:53
195.218.197.22	0.020	0.008	0.000	00:00:53
gray.nn.ru	0.184	0.188	0.000	00:00:30
fw-nat.sovintel.net	0.124	0.108	0.000	00:00:28

TOTAL: 37	58.716	460.819	0.000	31:07:43

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2914
balancer-a.rol.ru	2909
gray.nn.ru	101
net1-x-ring.tony.pp.ru	98
194.154.66.131	80
ts2-a144.nsk.dial.rol.ru	39
fw-nat.sovintel.net	18
ts9-a151.moscow.dial.rol.ru	9
ts2-b41.ufa.dial.rol.ru	5
194.186.71.137	3
ts3-b151.voronezh.dial.rol.ru	3
ts1-a233.kemerovo.dial.rol.ru	3
ts28-a58.moscow.dial.rol.ru	3
195.218.197.22	2
main.komi.com	1
ts27-b74.moscow.dial.rol.ru	1
212.92.129.227	1
news.lek.ru	1
ts18-a88.moscow.dial.rol.ru	1
ts2-a6.achinsk.dial.rol.ru	1

TOTAL: 24	6197

NNRP no permission clients:

System	Conn

82.140.73.76	59
87.245.178.164	12
cornholio.migtel.ru	4
host212.achinsk.net	2
83.167.116.18	2
88.87.80.127	2
195.28.36.242	1
83.220.64.79	1
83.220.64.52	1

TOTAL: 9	84

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	48

TOTAL: 1	48

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.154.66.131	6	0
ts9-a151.moscow.dial.rol.ru	2	0
ts1-a233.kemerovo.dial.rol.ru	2	0
ts27-a9.moscow.dial.rol.ru	1	0
ts18-a88.moscow.dial.rol.ru	1	0
ts2-a43.bryansk.dial.rol.ru	1	0

TOTAL: 6	13	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	26769	100.0%
2	comp	1	0.0%

TOTAL: 2		26770	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	20899
2	alt.binaries.pictures.artpics	3537
3	alt.binaries.pictures.bras	2325
4	alt.binaries.pictures.lolita	8
5	comp.windows.news	1

TOTAL: 5		26770