Daily Usenet report

Oct 3 03:00:05 -- Oct 4 03:00:05

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 / 87 lines (5.7%)
Oct 3 04:10:25 perseus controlchan[10305]: Unknown "cmsg" control by ittsmme.bbs@bbs.wretch.cc
Oct 3 05:28:15 perseus controlchan[10305]: Unknown "cmsg" control by calibre.bbs@bbs.cs.nctu.edu.tw
Oct 3 05:28:16 perseus controlchan[10305]: Unknown "cmsg" control by calibre.bbs@bbs.cs.nctu.edu.tw
Oct 3 06:10:40 perseus controlchan[10305]: Unknown "cmsg" control by lovemn.bbs@bbs.wretch.cc
Oct 3 06:50:18 perseus controlchan[10305]: Unknown "cmsg" control by icrjack.bbs@bbs.wretch.cc

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	2231656	97.9%	194.3 MB	97.3%
innd	24550	1.1%	3.0 MB	1.5%
nnrpd	20149	0.9%	2.0 MB	1.0%
cnfsstat	2304	0.1%	398.1 KB	0.2%
controlchan	92	0.0%	10.1 KB	0.0%

TOTAL: 5	2278751	100.0%	199.7 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	2197269	97.3%
Negative hits	40783	1.8%
Cache misses	11841	0.5%
Positive hits	9376	0.4%

TOTAL: 4	2259269	100.0%

INND timer:

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

article cancel	00:05:54.740	0.4%	31997	0.000	11.087	1391.000
article cleanup	00:00:25.010	0.0%	2184516	0.004	0.011	0.023
article logging	00:02:42.716	0.2%	2199638	0.004	0.074	4.897
article parse	00:18:23.422	1.3%	158597617	0.005	0.007	0.020
article write	09:40:04.125	40.3%	2161106	3.717	16.105	28.230
artlog/artcncl	00:00:00.332	0.0%	31833	0.000	0.010	2.200
artlog/artparse	00:00:00.001	0.0%	90	0.000	0.011	1.000
data move	00:03:36.371	0.3%	168021666	0.001	0.001	0.003
hisgrep/artcncl	00:05:20.206	0.4%	20996	0.000	15.251	1391.000
hishave/artcncl	00:00:15.277	0.0%	31997	0.000	0.477	238.429
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:20:06.381	1.4%	2229084	0.001	0.541	16.610
history sync	00:00:00.313	0.0%	290	0.000	1.079	14.000
history write	00:52:28.500	3.6%	2161106	0.023	1.457	13.901
hiswrite/artcncl	00:00:18.738	0.0%	11001	0.000	1.703	270.286
idle	07:09:53.673	29.9%	149232748	0.127	0.173	0.665
nntp read	00:20:11.661	1.4%	157116497	0.006	0.008	0.018
overview write	04:44:01.091	19.7%	2161106	1.294	7.885	90.378
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%	87	0.000	0.011	1.000

TOTAL: 23:59:58.031	23:43:42.558	98.9%	-	-	-	-

nnrpd timer:

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

hisgrep	00:10:50.619	0.7%	50601	0.000	12.858	167.603
idle	23:15:38.247	84.1%	212495	0.000	394.072	200130.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	02:26:43.579	8.8%	774774	0.000	11.363	19385.667
readart	00:31:52.404	1.9%	107456	0.000	17.797	369.048

TOTAL: 27:38:48.007	26:25:04.849	95.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

defence@alt-comp-config.at	3	0	0	0	0	3
hamstermumke@xs4all.nl	0	1	0	0	0	1
sheradon.hugeboner@gmail.com	1	0	0	0	0	1

TOTAL	4	1	0	0	0	5

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	326	2173083	2150691	1	22391	98%	467:15:15

TOTAL: 1		326	2173083	2150691	1	22391	98%	467:15:15

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	391.1 GB	5.2 MB	391.1 GB	99%	188.7 KB	467:15:15

TOTAL: 1		391.1 GB	5.2 MB	391.1 GB	99%	188.7 KB	467:15:15

Incoming articles:

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

Oct 3 03:00:05 - 03:59:59	90920	4.2%	25.29	17.1 GB	4.4%	4983.13
Oct 3 04:00:00 - 04:59:59	89042	4.1%	24.73	17.0 GB	4.4%	4960.87
Oct 3 05:00:00 - 05:59:59	84789	3.9%	23.55	16.2 GB	4.1%	4721.83
Oct 3 06:00:00 - 06:59:59	84844	3.9%	23.57	15.6 GB	4.0%	4554.17
Oct 3 07:00:00 - 07:59:59	80967	3.7%	22.49	14.7 GB	3.8%	4293.30
Oct 3 08:00:00 - 08:59:59	90921	4.2%	25.26	17.2 GB	4.4%	5018.84
Oct 3 09:00:00 - 09:59:59	80611	3.7%	22.39	15.5 GB	4.0%	4519.84
Oct 3 10:00:00 - 10:59:59	88425	4.1%	24.56	15.6 GB	4.0%	4546.11
Oct 3 11:00:00 - 11:59:59	95308	4.4%	26.47	14.0 GB	3.6%	4090.56
Oct 3 12:00:00 - 12:59:59	93920	4.3%	26.09	17.3 GB	4.4%	5043.65
Oct 3 13:00:00 - 13:59:59	100257	4.6%	27.85	17.2 GB	4.4%	5006.71
Oct 3 14:00:00 - 14:59:59	96275	4.5%	26.74	17.8 GB	4.6%	5191.88
Oct 3 15:00:00 - 15:59:59	98416	4.6%	27.34	18.0 GB	4.6%	5234.51
Oct 3 16:00:00 - 16:59:59	97727	4.5%	27.15	16.5 GB	4.2%	4811.64
Oct 3 17:00:00 - 17:59:59	85241	3.9%	23.68	15.7 GB	4.0%	4583.31
Oct 3 18:00:00 - 18:59:59	94291	4.4%	26.19	17.4 GB	4.4%	5056.87
Oct 3 19:00:00 - 19:59:59	93484	4.3%	25.97	16.8 GB	4.3%	4889.54
Oct 3 20:00:00 - 20:59:59	85612	4.0%	23.78	15.9 GB	4.1%	4637.73
Oct 3 21:00:00 - 21:59:59	86159	4.0%	23.93	15.1 GB	3.9%	4395.92
Oct 3 22:00:00 - 22:59:59	92061	4.3%	25.57	16.3 GB	4.2%	4749.74
Oct 3 23:00:00 - 23:59:59	87612	4.1%	24.34	16.4 GB	4.2%	4772.40
Oct 4 00:00:00 - 00:59:59	83599	3.9%	23.22	14.8 GB	3.8%	4304.34
Oct 4 01:00:00 - 01:59:59	90873	4.2%	25.24	15.6 GB	4.0%	4548.90
Oct 4 02:00:00 - 02:59:59	89748	4.2%	24.93	16.9 GB	4.3%	4920.54
Oct 4 03:00:00 - 03:00:05	112	0.0%	22.40	21.6 MB	0.0%	4423.77

TOTAL: 24:00:00	2161214	100.0%	25.01	390.8 GB	100.0%	4743.15

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	18.6 GB	13.5%	89	773.03	2.16
02	BIN	137.8 GB	52.4 GB	38.0%	89	779.60	2.15
03	SMALL	13.0 GB	8.4 GB	64.2%	5	6.72	23.55
04	BIN	80.1 GB	38.3 GB	47.8%	57	395.78	2.46
05	BIN	80.1 GB	40.0 GB	50.0%	77	398.08	2.44
06	SMALL	13.0 GB	8.3 GB	63.9%	5	6.70	23.61
07	BIN	80.1 GB	30.7 GB	38.3%	57	395.98	2.45
08	BIN	80.1 GB	33.6 GB	42.0%	77	397.23	2.45
09	SMALL	13.0 GB	8.0 GB	61.7%	5	6.69	23.66
10	BIN	80.1 GB	25.2 GB	31.4%	57	395.13	2.46
11	BIN	80.1 GB	43.2 GB	54.0%	77	398.76	2.44
12	SMALL	13.0 GB	8.3 GB	63.5%	5	6.63	23.86
13	BIN	80.1 GB	24.0 GB	29.9%	57	394.90	2.46
14	BIN	80.1 GB	30.0 GB	37.4%	77	397.70	2.44

TOTAL: 14	-	968.5 GB	369.0 GB	38.1%	734	341.23	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	38519	23150	0	223	0	0	0	0	15146
2	?	90	0	0	0	0	0	0	0	90

TOTAL: 2		38609	23150	0	223	0	0	0	0	15236

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.ettekees	1884
alt.binaries.pictures.amateur.butts	836
alt.binaries.multimedia.erotica.transexuals	710
alt.binaries.erotica.freckles	644
alt.binaries.hotrod	585
alt.binaries.multimedia.transsexuals	503
alt.binaries.nonnude	305
alt.binaries.multimedia.anal.fisting	279
alt.binaries.multimedia.erotica.transgendered	198
alt.binaries.pictures.erotica.transsexual	189
alt.binaries.pictures.eroctica.rape	181
alt.binaries.movies.italian.divx	175
alt.binaries.pictures.eroctica.torture	149
alt.binaries.pictures.erotica.transvestite	148
alt.binaries.pictures.erotic.unusual.object.penetrat	145
cakewalk.coffeehouse	139
ccu.bbs.talk.market	129
rss.MoreOver-EntertainmentMovie	125
stu.virus	118
telekabel.tratsch	115

TOTAL: 2092	23150

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad command received
	192.168.33.37	54
	TOTAL: 1	54
Including strange strings
	192.168.33.37	15108
	TOTAL: 1	15108

TOTAL: 2		15162

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	10	50377	1.8 GB	33	0	0	12:57:54
2	ts1-a234.saratov.dial.rol.ru	11	276	22.4 MB	0	0	0	04:26:41
3	heap.micex.ru	9	51	1.7 MB	16	0	0	00:03:44
4	194.186.32.119	12	48	1.8 MB	4	0	0	00:11:25
5	news.pcs-net.net	1	47	7.2 MB	23	0	0	00:22:46
6	212.46.203.81	9	20	1.3 MB	11	0	0	00:06:14
7	ts1-a19.saratov.dial.rol.ru	1	6	15.7 KB	1	0	0	00:56:46
8	ts1-a250.saratov.dial.rol.ru	1	4	9.2 KB	1	0	0	00:56:43
9	ts2-a102.syktyvkar.dial.rol.ru	4	2	155.9 KB	1	0	0	00:03:01
10	ts2-a97.ufa.dial.rol.ru	2	1	115.1 KB	1	0	0	00:08:11
11	ts23-b238.moscow.dial.rol.ru	1	0	0.0 KB	0	4	0	00:00:04

TOTAL: 11		61	50832	1.8 GB	91	4	0	28:40:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	10	50377	1.8 GB	33	0	0	12:57:54
2	*.saratov.dial.rol.ru	13	286	22.4 MB	2	0	0	06:20:10
3	unresolved	70	68	3.1 MB	15	0	0	07:25:11
4	*.micex.ru	9	51	1.7 MB	16	0	0	00:03:44
5	*.pcs-net.net	1	47	7.2 MB	23	0	0	00:22:46
6	*.syktyvkar.dial.rol.ru	4	2	155.9 KB	1	0	0	00:03:01
7	*.ufa.dial.rol.ru	4	1	115.1 KB	1	0	0	00:08:12
8	*.186.49.94.adsl-spb.net.rol.ru	1	0	0.0 KB	0	0	0	00:07:03
9	*.sovintel.net	14	0	0.0 KB	0	0	0	00:00:25
10	*.spb.dial.rol.ru	3	0	0.0 KB	0	0	0	00:00:06
11	*.lek.ru	2	0	0.0 KB	0	0	0	00:01:04
12	*.nsk.dial.rol.ru	19	0	0.0 KB	0	0	0	00:00:10
13	*.moscow.dial.rol.ru	2	0	0.0 KB	0	4	0	00:10:05
14	*.tony.pp.ru	74	0	0.0 KB	0	0	0	00:35:30
15	*.voronezh.dial.rol.ru	2	0	0.0 KB	0	0	0	00:00:01
16	*.rol.ru	5826	0	0.0 KB	0	0	0	00:20:40
17	*.nn.ru	54	0	0.0 KB	0	0	0	00:00:16

TOTAL: 17		6108	50832	1.8 GB	91	4	0	28:39:13

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	37.748	332.182	0.000	12:57:54
194.154.66.131	0.048	0.080	0.000	07:06:55
ts1-a234.saratov.dial.rol.ru	0.052	0.200	0.000	04:26:41
ts1-a19.saratov.dial.rol.ru	0.148	0.352	0.000	00:56:46
ts1-a250.saratov.dial.rol.ru	0.060	0.108	0.000	00:56:43
net1-x-ring.tony.pp.ru	39.272	360.495	0.000	00:35:30
news.pcs-net.net	0.008	0.076	0.000	00:22:46
194.186.32.119	0.016	0.040	0.000	00:11:25
balancer-a.rol.ru	3.676	3.692	0.000	00:10:39
ts23-b159.moscow.dial.rol.ru	0.020	0.016	0.000	00:10:01
balancer-b.rol.ru	3.692	3.676	0.000	00:10:01
ts2-a97.ufa.dial.rol.ru	0.108	0.176	0.000	00:08:11
194.186.49.94.adsl-spb.net.rol.ru	0.036	0.004	0.000	00:07:03
212.46.203.81	0.024	0.048	0.000	00:06:14
heap.micex.ru	0.028	0.036	0.000	00:03:44
ts2-a102.syktyvkar.dial.rol.ru	0.036	0.080	0.000	00:03:01
?	0.032	0.048	0.000	00:02:45
news.lek.ru	0.176	0.172	0.000	00:01:04
82.140.73.76	0.188	0.288	0.000	00:01:02
212.46.236.238	0.000	0.008	0.000	00:00:29

TOTAL: 39	85.604	702.049	0.000	28:40:28

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2916
balancer-b.rol.ru	2910
net1-x-ring.tony.pp.ru	74
gray.nn.ru	54
194.154.66.131	43
ts2-a178.nsk.dial.rol.ru	19
fw-nat.sovintel.net	14
212.46.235.180	3
ts2-a141.ufa.dial.rol.ru	2
news.lek.ru	2
ts2-a16.voronezh.dial.rol.ru	2
ts5-b197.spb.dial.rol.ru	2
212.46.203.76	2
ts1-a89.spb.dial.rol.ru	1
ts23-b159.moscow.dial.rol.ru	1
212.46.236.238	1
194.186.49.94.adsl-spb.net.rol.ru	1

TOTAL: 17	6047

NNRP no permission clients:

System	Conn

82.140.73.76	142
ppp85-141-130-185.pppoe.mtu-net.ru	4
89.175.167.66	3
cornholio.migtel.ru	3
195.189.80.40	2
ts2-a222.nukus.dial.rol.uz	1
195.28.36.242	1
ppp91-122-23-78.pppoe.avangard-dsl.ru	1
83.167.116.18	1
cpe-76-181-107-141.columbus.res.rr.com	1

TOTAL: 10	159

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	47

TOTAL: 1	47

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts23-b159.moscow.dial.rol.ru	1	0

TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	49689	100.0%
2	fido7	10	0.0%

TOTAL: 2		49699	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	41312
2	alt.binaries.pictures.artpics	4560
3	alt.binaries.pictures.bras	3648
4	alt.binaries.pictures.amateurs	51
5	alt.christnet.sex.fetish.fat.furry	47
6	alt.binaries.pictures.vladmodels	38
7	alt.binaries.pictures.erotic.asian.porn	20
8	fido7.ru.linux	10
9	alt.binaries.erotica.pictures.cheerleaders	9
10	alt.binaries.nospam.female.bodyhair	2
11	alt.binaries.pictures.sex.fetish.fish	1
12	alt.binaries.pictures.erotica.lolita	1

TOTAL: 12		49699