Daily Usenet report

Feb 14 03:00:01 -- Feb 15 03:00:01

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
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 client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

First 22 / 22 lines (100.0%)
Feb 14 06:03:57 andromeda controlchan[18019]: Unknown "cmsg" control by Oshin.bbs@bbs.cs.nctu.edu.tw
Feb 14 06:53:15 andromeda controlchan[18019]: Unknown "cmsg" control by jeffyc.bbs@bbs.cs.nctu.edu.tw
Feb 14 07:13:45 andromeda controlchan[18019]: Unknown "cmsg" control by away312.bbs@bbs.cs.nctu.edu.tw
Feb 14 08:48:12 andromeda controlchan[18019]: Unknown "cmsg" control by akw102000.bbs@bbs.cs.nctu.edu.tw
Feb 14 09:53:08 andromeda controlchan[18019]: Unknown "cmsg" control by daveblog.bbs@bbs.cs.nctu.edu.tw
Feb 14 10:43:06 andromeda controlchan[18019]: Unknown "cmsg" control by freefellow.bbs@bbs.cs.nctu.edu.tw
Feb 14 10:43:07 andromeda controlchan[18019]: Unknown "cmsg" control by freefellow.bbs@bbs.cs.nctu.edu.tw
Feb 14 10:48:07 andromeda controlchan[18019]: Unknown "cmsg" control by JayBruce.bbs@bbs.cs.nctu.edu.tw
Feb 14 11:13:53 andromeda innd: buffindexed: overview data is too large 29004
Feb 14 11:13:53 andromeda innd: buffindexed: overview data is too large 29004
Feb 14 11:13:53 andromeda innd: buffindexed: overview data is too large 29004
Feb 14 11:13:53 andromeda innd: buffindexed: overview data is too large 29004
Feb 14 11:13:53 andromeda innd: buffindexed: overview data is too large 29003
Feb 14 11:13:53 andromeda innd: buffindexed: overview data is too large 29003
Feb 14 12:44:03 andromeda controlchan[18019]: skipping rmgroup alt.usenet.peering spam@uce.gov (would be no change)
Feb 14 15:43:05 andromeda controlchan[18019]: Unknown "cmsg" control by mike1026915.bbs@bbs.cs.nctu.edu.tw
Feb 14 15:58:25 andromeda controlchan[18019]: Unknown "cmsg" control by nowar100.bbs@bbs.cs.nctu.edu.tw
Feb 14 16:28:04 andromeda controlchan[18019]: Unknown "cmsg" control by Ace12345x.bbs@bbs.cs.nctu.edu.tw
Feb 14 16:53:05 andromeda controlchan[18019]: Unknown "cmsg" control by badlaugh.bbs@bbs.cs.nctu.edu.tw
Feb 14 21:21:36 andromeda controlchan[18019]: Unknown "cmsg" control by mike1026915.bbs@bbs.cs.nctu.edu.tw
Feb 15 00:01:03 andromeda pgpverify[32425]: pgpverify: verification failed
Feb 15 00:01:03 andromeda controlchan[18019]: skipping checkgroups newgroups-request@fido7.ru(pgpverify failed) in <1234645260.99930@fido7.ru>

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	810187	95.6%	72.9 MB	94.6%
nnrpd	18172	2.1%	1.8 MB	2.4%
innd	16574	2.0%	1.9 MB	2.5%
cnfsstat	2304	0.3%	402.1 KB	0.5%
controlchan	16	0.0%	1.7 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%

TOTAL: 6	847254	100.0%	77.0 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	756466	90.2%
Negative hits	75323	9.0%
Positive hits	5640	0.7%
Cache misses	1027	0.1%

TOTAL: 4	838456	100.0%

INND timer:

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

article cancel	00:00:09.043	0.0%	6968	0.000	1.298	217.000
article cleanup	00:00:09.809	0.0%	755352	0.000	0.013	0.067
article logging	00:01:43.969	0.1%	802910	0.000	0.129	8.464
article parse	00:03:31.561	0.2%	36294176	0.000	0.006	0.073
article write	00:43:10.429	3.0%	709317	0.267	3.652	1954.135
artlog/artcncl	00:00:00.063	0.0%	6910	0.000	0.009	1.000
artlog/artparse	00:00:00.001	0.0%	47	0.000	0.021	0.143
data move	00:01:14.686	0.1%	39268889	0.000	0.002	0.013
hisgrep/artcncl	00:00:07.122	0.0%	5410	0.000	1.316	217.000
hishave/artcncl	00:00:01.490	0.0%	6968	0.000	0.214	18.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:06:24.518	0.4%	831639	0.000	0.462	7.348
history sync	00:00:00.366	0.0%	280	0.000	1.307	7.000
history write	00:14:05.669	1.0%	754877	0.000	1.120	10.776
hiswrite/artcncl	00:00:00.298	0.0%	1558	0.000	0.191	13.000
idle	18:56:33.015	79.0%	35843000	0.000	1.903	6.831
nntp read	00:04:02.907	0.3%	36233214	0.001	0.007	0.101
overview write	03:40:01.993	15.3%	709317	1.665	18.612	59992.714
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%	15	0.000	0.067	1.000

TOTAL: 23:59:26.329	23:51:16.940	99.4%	-	-	-	-

nnrpd timer:

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

hisgrep	00:01:00.968	0.1%	87989	0.000	0.693	0.000
idle	13:25:35.072	97.0%	342801	5.266	141.000	200113.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:01:05.091	0.1%	870157	0.000	0.075	0.000
readart	00:09:08.409	1.1%	178640	0.000	3.070	0.000

TOTAL: 13:50:14.624	13:36:49.540	98.4%	-	-	-	-

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

spam@uce.gov	0	1	0	0	0	1

TOTAL	0	1	0	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	2067	790406	743140	783	46483	94%	377:30:11

TOTAL: 1		2067	790406	743140	783	46483	94%	377:30:11

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	57.3 GB	11.9 MB	57.3 GB	99%	76.0 KB	377:30:11

TOTAL: 1		57.3 GB	11.9 MB	57.3 GB	99%	76.0 KB	377:30:11

Incoming articles:

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

Feb 14 03:00:01 - 03:59:59	24605	3.5%	6.84	1.9 GB	3.4%	555.35
Feb 14 04:00:00 - 04:59:59	32603	4.6%	9.06	3.0 GB	5.2%	865.75
Feb 14 05:00:00 - 05:59:59	29557	4.2%	8.21	3.1 GB	5.4%	890.64
Feb 14 06:00:00 - 06:59:59	27846	3.9%	7.74	3.2 GB	5.6%	919.83
Feb 14 07:00:00 - 07:59:59	26796	3.8%	7.44	2.8 GB	5.0%	829.23
Feb 14 08:00:00 - 08:59:59	29398	4.1%	8.17	3.0 GB	5.4%	887.29
Feb 14 09:00:00 - 09:59:59	29055	4.1%	8.07	2.7 GB	4.8%	798.95
Feb 14 10:00:00 - 10:59:59	28238	4.0%	7.84	3.0 GB	5.3%	882.64
Feb 14 11:00:00 - 11:59:59	32110	4.5%	8.92	2.9 GB	5.1%	852.70
Feb 14 12:00:00 - 12:59:59	30884	4.4%	8.58	2.3 GB	4.1%	677.73
Feb 14 13:00:00 - 13:59:59	31354	4.4%	8.71	2.6 GB	4.5%	744.99
Feb 14 14:00:00 - 14:59:59	31616	4.5%	8.78	2.7 GB	4.8%	796.66
Feb 14 15:00:00 - 15:59:59	28064	4.0%	7.80	2.2 GB	3.8%	627.60
Feb 14 16:00:00 - 16:59:59	30250	4.3%	8.40	1.9 GB	3.4%	562.67
Feb 14 17:00:00 - 17:59:59	30123	4.2%	8.37	2.2 GB	3.8%	636.58
Feb 14 18:00:00 - 18:59:59	31236	4.4%	8.68	2.2 GB	3.9%	650.10
Feb 14 19:00:00 - 19:59:59	31479	4.4%	8.74	1.9 GB	3.4%	557.53
Feb 14 20:00:00 - 20:59:59	38273	5.4%	10.63	1.9 GB	3.3%	548.02
Feb 14 21:00:00 - 21:59:59	28216	4.0%	7.84	1.6 GB	2.8%	469.42
Feb 14 22:00:00 - 22:59:59	26616	3.8%	7.39	2.0 GB	3.6%	588.63
Feb 14 23:00:00 - 23:59:59	26549	3.7%	7.37	2.3 GB	4.0%	664.38
Feb 15 00:00:00 - 00:59:59	24716	3.5%	6.87	1.5 GB	2.7%	442.30
Feb 15 01:00:00 - 01:59:59	30099	4.2%	8.36	1.1 GB	2.0%	332.44
Feb 15 02:00:00 - 02:59:59	29907	4.2%	8.31	2.7 GB	4.7%	778.82
Feb 15 03:00:00 - 03:00:01	13	0.0%	13.00	1.4 MB	0.0%	1437.70

TOTAL: 24:00:00	709603	100.0%	8.21	56.9 GB	100.0%	690.02

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	13.2 GB	9.6%	198	112.15	14.91
02	BIN	137.8 GB	50.9 GB	36.9%	198	111.19	15.04
03	SMALL	13.0 GB	9.7 GB	74.4%	21	7.12	22.23
04	BIN	80.1 GB	33.2 GB	41.5%	154	55.76	17.43
05	BIN	80.1 GB	17.7 GB	22.1%	171	55.52	17.51
06	SMALL	13.0 GB	9.1 GB	70.0%	21	7.08	22.36
07	BIN	80.1 GB	21.9 GB	27.3%	154	55.83	17.41
08	BIN	80.1 GB	700.0 MB	0.9%	171	55.95	17.37
09	SMALL	13.0 GB	9.2 GB	70.7%	21	7.11	22.26
10	BIN	80.1 GB	15.6 GB	19.5%	154	55.76	17.43
11	BIN	80.1 GB	25.0 GB	31.2%	171	55.90	17.39
12	BIN	13.0 GB	65.7 MB	0.5%	586	56.07	2.82
13	BIN	80.1 GB	58.6 GB	73.2%	95	55.82	17.41
14	SMALL	80.1 GB	50.9 GB	63.5%	2	7.14	136.15

TOTAL: 14	-	968.5 GB	315.8 GB	32.6%	2117	49.89	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	93668	45577	0	475	0	0	0	0	47616
2	?	5	0	0	0	0	0	0	0	5

TOTAL: 2		93673	45577	0	475	0	0	0	0	47621

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.pwp	4071
bellsouth.net.test	2880
alt.binaries.dvdrs.pw	2846
alt.fan.teenboy	1347
microsoft.public.test	1153
alt.binaries.images.andmore	578
pictures.erotica.lesbians	477
alt.binaries.pictures.eroctica.butts	461
alt.binaries.pictures.senior-citizens	430
alt.binaries.blu-ray	387
alt.binaires.erotica.teen	321
alt.binaires.pictures.erotica.teens	305
alt.binaries.erotic.erotika.young	268
alt.binaries.pictures.erotica.young.female	259
alt.binaries.pictures.erotica.voyeurism.hidden-cam	255
alt.binaries.erotica.best-teens	252
alt.binaries.pictures.erotica.early-teen	247
alt.binaires.pictures.erotica.amatuer.female	247
alt.binaries.alt.binaries.pictures.erotica	244
alt.binaires.erotica	237

TOTAL: 2096	45577

INND misc events:

Events	Count

CCreader	10

TOTAL: 1	10

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	47574
	TOTAL: 1	47574

TOTAL: 1		47574

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	6	87989	1.7 GB	36	0	0	12:43:06
2	82.142.145.110	3	2	76.6 KB	2	0	0	00:04:13
3	net1-x-ring.tony.pp.ru	71	1	3.4 KB	4	0	0	00:24:19

TOTAL: 3		80	87992	1.7 GB	42	0	0	13:50:15

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	6	87989	1.7 GB	36	0	0	12:43:06
2	unresolved	4	2	76.6 KB	2	0	0	00:05:28
3	*.tony.pp.ru	71	1	3.4 KB	4	0	0	00:24:19
4	*.sovintel.net	13	0	0.0 KB	0	0	0	00:00:03
5	*.rol.kis.ru	3	0	0.0 KB	0	0	0	00:23:10
6	*.moscow.dial.rol.ru	1	0	0.0 KB	0	0	0	00:00:00
7	*.rol.ru	5760	0	0.0 KB	0	0	0	00:14:06

TOTAL: 7		5858	87992	1.7 GB	42	0	0	13:50:14

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	39.632	55.550	0.000	12:43:06
net1-x-ring.tony.pp.ru	179.372	211.176	0.000	00:24:19
rol91.rol.kis.ru	0.032	0.024	0.000	00:23:10
balancer-a.rol.ru	3.344	3.448	0.000	00:07:10
balancer-b.rol.ru	3.260	3.496	0.000	00:06:56
82.142.145.110	0.008	0.028	0.000	00:04:13
195.218.244.87	0.004	0.004	0.000	00:01:14
fw-nat.sovintel.net	0.080	0.044	0.000	00:00:03
cornholio.migtel.ru	0.024	0.060	0.000	00:00:00
ts11-a244.moscow.dial.rol.ru	0.000	0.000	0.000	00:00:00

TOTAL: 10	225.756	273.830	0.000	13:50:15

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2880
balancer-a.rol.ru	2880
fw-nat.sovintel.net	13
rol91.rol.kis.ru	3
ts11-a244.moscow.dial.rol.ru	1
195.218.244.87	1

TOTAL: 6	5778

NNRP no permission clients:

System	Conn

cornholio.migtel.ru	31

TOTAL: 1	31

NNRP client timeouts [Top 20]:

System	Conn	Peer

rol91.rol.kis.ru	2	0

TOTAL: 1	2	1

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	86390	98.2%
2	hr	1621	1.8%
3	fido7	1	0.0%

TOTAL: 3		88012	100.0%

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

Newsgroup		Count

1	alt.binaries.multimedia.erotic.playboy	54299
2	alt.binaries.pictures.bras	16245
3	alt.binaries.full.post.verified.playboy	9255
4	alt.mag.playboy	6446
5	hr.alt.seks.binaries.playboy	1620
6	alt.binaries.photos.nude-art.moderated	144
7	alt.binaries.multimedia.cartoons.looneytunes	1
8	hr.rec.humor	1
9	fido7.ru.drugs	1

TOTAL: 9		88012