Daily Usenet report

Nov 5 03:00:01 -- Nov 6 03:00:05

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
Supposedly-moderated groups with unmoderated postings
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 / 30 lines (16.7%)
Nov 5 05:41:17 perseus controlchan[28409]: Unknown "cmsg" control by jesse78131.bbs@bbs.cs.nctu.edu.tw
Nov 5 05:41:17 perseus controlchan[28409]: Unknown "cmsg" control by jesse78131.bbs@bbs.cs.nctu.edu.tw
Nov 5 05:46:08 perseus controlchan[28409]: Unknown "cmsg" control by jesse78131.bbs@bbs.cs.nctu.edu.tw
Nov 5 06:33:04 perseus controlchan[28409]: Unknown "cmsg" control by honestluo.bbs@bbs.cs.nthu.edu.tw
Nov 5 06:36:08 perseus controlchan[28409]: Unknown "cmsg" control by theonly1.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	816038	96.5%	72.1 MB	95.5%
nnrpd	18260	2.2%	1.8 MB	2.4%
innd	8604	1.0%	1.2 MB	1.6%
cnfsstat	2304	0.3%	398.3 KB	0.5%
controlchan	30	0.0%	3.3 KB	0.0%

TOTAL: 5	845236	100.0%	75.5 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	707963	94.6%
Negative hits	35299	4.7%
Positive hits	4049	0.5%
Cache misses	733	0.1%

TOTAL: 4	748044	100.0%

INND timer:

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

article cancel	00:00:13.626	0.0%	6604	0.000	2.063	597.333
article cleanup	00:00:05.846	0.0%	706548	0.000	0.008	0.028
article logging	00:01:07.483	0.1%	809045	0.000	0.083	11.115
article parse	00:01:22.465	0.1%	18729232	0.002	0.004	0.008
article write	01:04:49.832	4.5%	647049	0.262	6.012	27.934
artlog/artcncl	00:00:00.077	0.0%	6577	0.000	0.012	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:23.833	0.0%	21013583	0.000	0.001	0.002
hisgrep/artcncl	00:00:06.442	0.0%	4619	0.000	1.395	597.333
hishave/artcncl	00:00:03.312	0.0%	6604	0.000	0.502	88.900
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:12:26.640	0.9%	741880	0.000	1.006	15.437
history sync	00:00:00.250	0.0%	308	0.000	0.812	31.000
history write	00:31:46.817	2.2%	647049	0.009	2.947	28.469
hiswrite/artcncl	00:00:03.753	0.0%	1985	0.000	1.891	730.000
idle	20:21:52.855	84.9%	18462657	2.284	3.971	8.253
nntp read	00:01:31.033	0.1%	18731503	0.002	0.005	0.009
overview write	01:40:40.170	7.0%	647049	0.927	9.335	61.495
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%	29	0.000	0.000	0.000

TOTAL: 23:59:31.788	23:56:34.434	99.8%	-	-	-	-

nnrpd timer:

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

idle	01:12:43.506	67.8%	6760	0.000	645.489	200211.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:31:41.327	29.6%	19595	0.000	97.031	8449.819
readart	00:00:01.705	0.0%	66	0.000	25.833	88.400

TOTAL: 01:47:13.686	01:44:26.538	97.4%	-	-	-	-

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	547	717893	657810	6	60077	91%	460:50:32

TOTAL: 1		547	717893	657810	6	60077	91%	460:50:32

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	25.4 GB	1.4 MB	25.4 GB	99%	37.1 KB	460:50:32

TOTAL: 1		25.4 GB	1.4 MB	25.4 GB	99%	37.1 KB	460:50:32

Incoming articles:

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

Nov 5 03:00:01 - 03:59:59	18364	2.8%	5.10	849.1 MB	3.2%	241.60
Nov 5 04:00:00 - 04:59:59	24098	3.7%	6.69	1.2 GB	4.7%	349.48
Nov 5 05:00:00 - 05:59:59	23294	3.6%	6.47	1.0 GB	4.1%	305.02
Nov 5 06:00:00 - 06:59:59	20379	3.1%	5.66	865.3 MB	3.3%	246.13
Nov 5 07:00:00 - 07:59:59	22452	3.5%	6.24	951.9 MB	3.6%	270.77
Nov 5 08:00:00 - 08:59:59	19762	3.1%	5.49	905.7 MB	3.4%	257.61
Nov 5 09:00:00 - 09:59:59	22400	3.5%	6.22	956.3 MB	3.6%	272.02
Nov 5 10:00:00 - 10:59:59	23612	3.6%	6.56	1.1 GB	4.4%	327.27
Nov 5 11:00:00 - 11:59:59	28982	4.5%	8.05	1.2 GB	4.6%	346.37
Nov 5 12:00:00 - 12:59:59	28630	4.4%	7.95	1.1 GB	4.4%	332.86
Nov 5 13:00:00 - 13:59:59	29649	4.6%	8.24	1.1 GB	4.3%	325.87
Nov 5 14:00:00 - 14:59:59	26553	4.1%	7.38	1.4 GB	5.3%	395.32
Nov 5 15:00:00 - 15:59:59	28337	4.4%	7.87	1.3 GB	5.1%	381.85
Nov 5 16:00:00 - 16:59:59	27099	4.2%	7.53	1.1 GB	4.3%	320.74
Nov 5 17:00:00 - 17:59:59	23130	3.6%	6.42	944.6 MB	3.6%	268.70
Nov 5 18:00:00 - 18:59:59	27117	4.2%	7.53	1.1 GB	4.3%	323.03
Nov 5 19:00:00 - 19:59:59	29350	4.5%	8.15	1.2 GB	4.5%	340.44
Nov 5 20:00:00 - 20:59:59	34853	5.4%	9.68	1.1 GB	4.2%	318.17
Nov 5 21:00:00 - 21:59:59	37287	5.8%	10.36	990.2 MB	3.8%	281.66
Nov 5 22:00:00 - 22:59:59	30182	4.7%	8.38	1.2 GB	4.6%	342.51
Nov 5 23:00:00 - 23:59:59	26644	4.1%	7.40	960.4 MB	3.6%	273.18
Nov 6 00:00:00 - 00:59:59	28929	4.5%	8.04	952.2 MB	3.6%	270.84
Nov 6 01:00:00 - 01:59:59	36585	5.7%	10.16	1.2 GB	4.7%	349.90
Nov 6 02:00:00 - 02:59:59	29577	4.6%	8.22	1.2 GB	4.7%	354.49
Nov 6 03:00:00 - 03:00:05	50	0.0%	10.00	2.1 MB	0.0%	439.25

TOTAL: 24:00:04	647315	100.0%	7.49	25.7 GB	100.0%	312.33

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	37.7 GB	27.4%	218	46.87	35.68
02	BIN	137.8 GB	128.5 GB	93.2%	218	46.97	35.61
03	SMALL	13.0 GB	8.9 GB	68.0%	19	8.88	17.81
04	BIN	80.1 GB	51.8 GB	64.7%	168	23.37	41.59
05	BIN	80.1 GB	76.7 GB	95.7%	188	23.51	41.34
06	SMALL	13.0 GB	8.8 GB	67.7%	19	8.77	18.03
07	BIN	80.1 GB	30.7 GB	38.3%	168	23.56	41.26
08	BIN	80.1 GB	58.7 GB	73.3%	188	23.52	41.32
09	SMALL	13.0 GB	7.8 GB	59.9%	19	8.84	17.89
10	BIN	80.1 GB	15.4 GB	19.2%	168	23.88	40.71
11	BIN	80.1 GB	18.0 GB	22.5%	189	23.39	41.56
12	SMALL	13.0 GB	8.6 GB	66.2%	19	8.82	17.94
13	BIN	80.1 GB	12.5 GB	15.6%	168	23.46	41.43
14	BIN	80.1 GB	60.2 GB	75.1%	188	23.30	41.72

TOTAL: 14	-	968.5 GB	524.3 GB	54.1%	1937	22.67	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	162145	59394	0	160	36	0	0	0	102555

TOTAL: 1		162145	59394	0	160	36	0	0	0	102555

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pictures.amateur.butts	4585
alt.binaries.dvdrs.pw	2158
alt.binaries.pwp	2156
alt.binaries.boys	1194
microsoft.public.test	1150
alt.binaries.amazing	877
alt.binaires.pictures.erotica.male	796
alt.binaries.pictures.erotica.teen.male.masturbation	662
a.b.dvd	647
alt.binaries.pictures.eroctica.butts	534
pictures.erotica.lesbians	513
alt.binaries.pictures.blonde	468
alt.binaries.pictures.erotica.blackfemales	427
alt.binaries.pictures.erotica.amateur.black	427
alt.binaries.pictures.black.erotica	424
alt.binaries.pictures.black.erotica.females	422
alt.binaries.pictures.butts	337
alt.binaires.pictures.erotica.teens	304
alt.binaries.images.andmore	292
alt.binaries.pictures.erotica.group.sex	264

TOTAL: 3311	59394

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count

pl.rec.foto.cyfrowa	36

TOTAL: 1	36

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Bad newsgroups received
	SERVER	11
	TOTAL: 1	11
Including strange strings
	192.168.33.37	102554
	TOTAL: 1	102554

TOTAL: 2		102565

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	ts18-a71.moscow.dial.rol.ru	1	50	2.0 MB	2	0	0	00:48:43
2	82.142.145.94	3	11	112.8 KB	2	0	0	00:06:00
3	195.218.244.87	1	5	274.5 KB	1	0	0	00:00:15

TOTAL: 3		5	66	2.4 MB	5	0	0	01:47:14

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.moscow.dial.rol.ru	1	50	2.0 MB	2	0	0	00:48:43
2	unresolved	5	16	387.3 KB	3	0	0	00:06:57
3	*.sovintel.net	9	0	0.0 KB	0	0	0	00:00:10
4	*.fttb.kis.ru	4	0	0.0 KB	0	0	0	00:01:23
5	*.sarov.dial.rol.ru	3	0	0.0 KB	0	0	0	00:30:02
6	*.tony.pp.ru	80	0	0.0 KB	0	0	0	00:02:52
7	*.rol.ru	5761	0	0.0 KB	0	0	0	00:16:54

TOTAL: 7		5863	66	2.4 MB	5	0	0	01:47:13

NNRP total resource statistics [Top 20]:

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

ts18-a71.moscow.dial.rol.ru	0.000	0.012	0.000	00:48:43
ts2-a202.sarov.dial.rol.ru	0.012	0.000	0.000	00:10:00
ts2-a197.sarov.dial.rol.ru	0.000	0.004	0.000	00:10:00
ts2-a18.sarov.dial.rol.ru	0.000	0.000	0.000	00:10:00
balancer-a.rol.ru	3.492	3.232	0.000	00:08:33
balancer-b.rol.ru	3.452	2.952	0.000	00:08:21
82.142.145.94	0.024	0.012	0.000	00:06:00
net1-x-ring.tony.pp.ru	0.124	0.144	0.000	00:02:52
dyn-166-125.fttb.kis.ru	0.004	0.008	0.000	00:01:23
194.186.71.137	0.000	0.000	0.000	00:00:41
195.218.244.87	0.012	0.008	0.000	00:00:15
?	0.000	0.000	0.000	00:00:10
fw-nat.sovintel.net	0.068	0.040	0.000	00:00:10
dyn-184-232.fttb.kis.ru	0.004	0.004	0.000	00:00:00
cornholio.migtel.ru	0.004	0.004	0.000	00:00:00

TOTAL: 15	7.196	6.420	0.000	01:47:14

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2881
balancer-b.rol.ru	2880
net1-x-ring.tony.pp.ru	80
fw-nat.sovintel.net	9
dyn-166-125.fttb.kis.ru	4
194.186.71.137	1
ts2-a197.sarov.dial.rol.ru	1
ts2-a18.sarov.dial.rol.ru	1
ts2-a202.sarov.dial.rol.ru	1

TOTAL: 9	5858

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	3
dyn-184-232.fttb.kis.ru	2

TOTAL: 2	5

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	2

TOTAL: 1	2

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a197.sarov.dial.rol.ru	1	0
ts2-a18.sarov.dial.rol.ru	1	0
ts2-a202.sarov.dial.rol.ru	1	0

TOTAL: 3	3	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	3220	99.5%
2	hr	11	0.3%
3	japan	4	0.1%

TOTAL: 3		3235	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.girlfriends	3169
2	alt.binaries.pictures.lolita	46
3	hr.rec.humor	11
4	alt.binaries.erotica.pornstars	5
5	japan.binaries.pictures.lolita	4

TOTAL: 5		3235