Daily Usenet report

Jan 31 03:00:02 -- Feb 1 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 48 / 48 lines (100.0%)
Jan 31 03:45:52 andromeda innd: buffindexed: overview data is too large 25187
Jan 31 03:46:54 andromeda innd: buffindexed: overview data is too large 25438
Jan 31 03:46:54 andromeda innd: buffindexed: overview data is too large 25437
Jan 31 03:46:54 andromeda innd: buffindexed: overview data is too large 25438
Jan 31 03:46:54 andromeda innd: buffindexed: overview data is too large 25438
Jan 31 03:46:54 andromeda innd: buffindexed: overview data is too large 25437
Jan 31 08:04:24 andromeda controlchan[18019]: Unknown "cmsg" control by tw7p1nyisfguxpd@jetable.net
Jan 31 08:18:13 andromeda controlchan[18019]: Unknown "cmsg" control by g4s8i6c9vcv6ypz@jetable.net
Jan 31 08:18:26 andromeda controlchan[18019]: Unknown "cmsg" control by dcnm1q2f5qqz@gmail.com
Jan 31 08:18:27 andromeda controlchan[18019]: Unknown "cmsg" control by dcnm1q2f5qqz@gmail.com__Big5_B_pNGrxzA4MCwgpV+zoaaopEiy4aTRq8csIHWmqKRIsuGk0avHLCAxOKaopEg_____Big5_B_suGk0avHLCCpX7yvuvS49KaopEiy4aTRq8csIKaopEiy4aTRq8cxLCA_____Big5_B_uvS3UqaopEiy4aTRq8csIDZrpqikSLLhpNGrxywgMDgwpqikSLLhpNGrxw______Big5_B_LCCzzKRqpf6yeaaopEiy4aTRq8csILnFuHGmqKRIsuGk0avHLCCop6in____Big5_B_pqikSLLhpNGrxywgpqikSLX4sFSy4aTRq8csIKRAqV2mqKRIsuGk0Q______Big5_B_q8csIKaopEiy4aTRq8elRLhxLA
Jan 31 08:27:13 andromeda controlchan[18019]: Unknown "cmsg" control by qseooet7ehf80xz@jetable.net
Jan 31 08:34:25 andromeda controlchan[18019]: Unknown "cmsg" control by amal9zkpr3bauwa@jetable.com
Jan 31 08:34:47 andromeda controlchan[18019]: Unknown "cmsg" control by 4sxhz86h12d7abc@jetable.net
Jan 31 08:43:45 andromeda controlchan[18019]: Unknown "cmsg" control by rb8tqes4x91kork@jetable.com
Jan 31 08:43:53 andromeda controlchan[18019]: Unknown "cmsg" control by r8z5kvyuwvhxyxa@jetable.org
Jan 31 08:57:03 andromeda controlchan[18019]: Unknown "cmsg" control by 7165oOY7igv1@meltmail.com
Jan 31 08:57:08 andromeda controlchan[18019]: Unknown "cmsg" control by PpsmPADUGvn3@meltmail.com
Jan 31 10:54:20 andromeda controlchan[18019]: Unknown "cmsg" control by ywc.bbs@bbs.cs.nctu.edu.tw
Jan 31 11:19:19 andromeda controlchan[18019]: Unknown "cmsg" control by TheAnswer.bbs@bbs.cs.nctu.edu.tw
Jan 31 11:24:21 andromeda controlchan[18019]: Unknown "cmsg" control by crucifixx.bbs@bbs.cs.nctu.edu.tw
Jan 31 14:49:19 andromeda controlchan[18019]: Unknown "cmsg" control by ywc.bbs@bbs.cs.nctu.edu.tw
Jan 31 14:59:20 andromeda controlchan[18019]: Unknown "cmsg" control by ywc.bbs@bbs.cs.nctu.edu.tw
Jan 31 15:19:19 andromeda controlchan[18019]: Unknown "cmsg" control by doono329.bbs@bbs.cs.nctu.edu.tw
Jan 31 15:51:36 andromeda innd: buffindexed: overview data is too large 25300
Jan 31 15:51:36 andromeda innd: buffindexed: overview data is too large 25299
Jan 31 15:51:36 andromeda innd: buffindexed: overview data is too large 25300
Jan 31 15:51:36 andromeda innd: buffindexed: overview data is too large 25299
Jan 31 15:51:36 andromeda innd: buffindexed: overview data is too large 25299
Jan 31 15:52:26 andromeda innd: buffindexed: overview data is too large 25388
Jan 31 15:52:26 andromeda innd: buffindexed: overview data is too large 25388
Jan 31 15:52:26 andromeda innd: buffindexed: overview data is too large 25387
Jan 31 15:52:26 andromeda innd: buffindexed: overview data is too large 25387
Jan 31 15:52:26 andromeda innd: buffindexed: overview data is too large 25387
Jan 31 15:52:26 andromeda innd: buffindexed: overview data is too large 25387
Jan 31 15:56:31 andromeda innd: buffindexed: overview data is too large 25373
Jan 31 15:56:31 andromeda innd: buffindexed: overview data is too large 25373
Jan 31 15:56:31 andromeda innd: buffindexed: overview data is too large 25372
Jan 31 18:44:20 andromeda controlchan[18019]: Unknown "cmsg" control by amul.bbs@bbs.cs.nctu.edu.tw
Jan 31 18:44:23 andromeda controlchan[18019]: Unknown "cmsg" control by tengion.bbs@bbs.cs.nctu.edu.tw
Jan 31 18:54:19 andromeda controlchan[18019]: Unknown "cmsg" control by lynnapples.bbs@bbs.cs.nctu.edu.tw
Jan 31 20:30:53 andromeda innd: buffindexed: overview data is too large 25187
Jan 31 20:31:25 andromeda innd: buffindexed: overview data is too large 25222
Jan 31 20:34:17 andromeda innd: buffindexed: overview data is too large 10431
Jan 31 20:40:08 andromeda innd: buffindexed: overview data is too large 25221
Jan 31 20:53:26 andromeda innd: buffindexed: overview data is too large 25187
Jan 31 20:54:07 andromeda innd: buffindexed: overview data is too large 10463
Jan 31 21:03:07 andromeda innd: buffindexed: overview data is too large 25187
Jan 31 21:19:21 andromeda innd: buffindexed: overview data is too large 25187

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	553458	94.5%	48.8 MB	93.0%
nnrpd	17974	3.1%	1.8 MB	3.4%
innd	12105	2.1%	1.5 MB	2.8%
cnfsstat	2304	0.4%	400.9 KB	0.7%
controlchan	24	0.0%	2.6 KB	0.0%

TOTAL: 5	585865	100.0%	52.4 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	547834	94.3%
Negative hits	30096	5.2%
Positive hits	2634	0.5%
Cache misses	594	0.1%

TOTAL: 4	581158	100.0%

INND timer:

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

article cancel	00:00:13.487	0.0%	3123	0.000	4.319	359.333
article cleanup	00:00:06.656	0.0%	547864	0.000	0.012	0.057
article logging	00:00:47.920	0.1%	550404	0.000	0.087	10.980
article parse	00:01:28.474	0.1%	15873446	0.000	0.006	0.049
article write	00:21:46.555	1.5%	514288	0.216	2.541	15.267
artlog/artcncl	00:00:00.050	0.0%	3063	0.000	0.016	13.000
artlog/artparse	00:00:00.000	0.0%	19	0.000	0.000	0.000
data move	00:00:34.761	0.0%	17578358	0.000	0.002	0.007
hisgrep/artcncl	00:00:11.908	0.0%	2674	0.000	4.453	359.333
hishave/artcncl	00:00:00.777	0.0%	3123	0.000	0.249	158.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:04:07.517	0.3%	578333	0.000	0.428	23.526
history sync	00:00:00.506	0.0%	370	0.000	1.368	15.000
history write	00:16:50.545	1.2%	547532	0.007	1.846	31.538
hiswrite/artcncl	00:00:00.634	0.0%	449	0.000	1.412	14.000
idle	21:11:23.781	88.3%	15766244	0.000	4.838	28.320
nntp read	00:01:40.181	0.1%	15866492	0.000	0.006	0.057
overview write	01:56:59.490	8.1%	514288	1.595	13.649	38888.333
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%	24	0.000	0.000	0.000

TOTAL: 23:59:57.717	23:56:13.242	99.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:01:31.979	0.3%	46759	0.000	1.967	0.000
idle	09:20:53.468	97.3%	99912	7.000	336.831	19742.833
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:04:43.955	0.8%	299310	0.000	0.949	0.000
readart	00:05:45.697	1.0%	119522	0.000	2.892	0.000

TOTAL: 09:36:43.023	09:32:55.099	99.3%	-	-	-	-

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

junior@example.com	2	0	0	0	0	2
news@news.belwue.de	0	0	1	0	0	1
usenet@film.rlss.okayama-u.ac.jp	0	0	1	0	0	1

TOTAL	2	0	2	0	0	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	1500	547527	511536	222	35769	93%	291:05:16

TOTAL: 1		1500	547527	511536	222	35769	93%	291:05:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	22.4 GB	6.2 MB	22.4 GB	99%	42.9 KB	291:05:16

TOTAL: 1		22.4 GB	6.2 MB	22.4 GB	99%	42.9 KB	291:05:16

Incoming articles:

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

Jan 31 03:00:02 - 03:59:59	20321	4.0%	5.65	1.1 GB	4.8%	320.89
Jan 31 04:00:00 - 04:59:59	17067	3.3%	4.74	878.3 MB	3.8%	249.84
Jan 31 05:00:00 - 05:59:59	20254	3.9%	5.63	1.2 GB	5.1%	337.12
Jan 31 06:00:00 - 06:59:59	11579	2.3%	3.22	521.4 MB	2.2%	148.30
Jan 31 07:00:00 - 07:59:59	10440	2.0%	2.90	332.8 MB	1.4%	94.65
Jan 31 08:00:00 - 08:59:59	10850	2.1%	3.01	334.7 MB	1.4%	95.20
Jan 31 09:00:00 - 09:59:59	11483	2.2%	3.19	489.0 MB	2.1%	139.08
Jan 31 10:00:00 - 10:59:59	11431	2.2%	3.18	507.8 MB	2.2%	144.45
Jan 31 11:00:00 - 11:59:59	18476	3.6%	5.13	849.2 MB	3.6%	241.56
Jan 31 12:00:00 - 12:59:59	19298	3.8%	5.36	816.1 MB	3.5%	232.14
Jan 31 13:00:00 - 13:59:59	24355	4.7%	6.77	1.2 GB	5.1%	342.51
Jan 31 14:00:00 - 14:59:59	34210	6.7%	9.50	1.6 GB	7.0%	464.62
Jan 31 15:00:00 - 15:59:59	38423	7.5%	10.67	1.5 GB	6.5%	429.40
Jan 31 16:00:00 - 16:59:59	31525	6.1%	8.76	1.3 GB	5.9%	390.09
Jan 31 17:00:00 - 17:59:59	31894	6.2%	8.86	1.4 GB	6.1%	408.84
Jan 31 18:00:00 - 18:59:59	29700	5.8%	8.25	1.4 GB	6.1%	407.69
Jan 31 19:00:00 - 19:59:59	24562	4.8%	6.82	1.1 GB	4.9%	324.44
Jan 31 20:00:00 - 20:59:59	24828	4.8%	6.90	1.1 GB	4.7%	312.02
Jan 31 21:00:00 - 21:59:59	23768	4.6%	6.60	1.0 GB	4.4%	292.58
Jan 31 22:00:00 - 22:59:59	23697	4.6%	6.58	1.1 GB	4.7%	314.56
Jan 31 23:00:00 - 23:59:59	17247	3.4%	4.79	826.3 MB	3.5%	235.05
Feb 1 00:00:00 - 00:59:59	18250	3.5%	5.07	863.5 MB	3.7%	245.62
Feb 1 01:00:00 - 01:59:59	24843	4.8%	6.90	880.8 MB	3.8%	250.53
Feb 1 02:00:00 - 02:59:59	15760	3.1%	4.38	809.9 MB	3.5%	230.37
Feb 1 03:00:00 - 03:00:01	9	0.0%	9.00	283.1 KB	0.0%	283.10

TOTAL: 23:59:59	514270	100.0%	5.95	22.8 GB	100.0%	277.15

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	9.9 GB	7.2%	197	41.50	40.31
02	BIN	137.8 GB	48.2 GB	35.0%	197	41.62	40.18
03	SMALL	13.0 GB	1.1 GB	8.4%	21	7.64	20.71
04	BIN	80.1 GB	43.0 GB	53.7%	153	20.64	47.09
05	BIN	80.1 GB	27.7 GB	34.6%	170	20.93	46.44
06	SMALL	13.0 GB	525.6 MB	3.9%	21	7.69	20.58
07	BIN	80.1 GB	31.6 GB	39.5%	153	20.98	46.33
08	BIN	80.1 GB	10.5 GB	13.1%	170	21.03	46.23
09	SMALL	13.0 GB	610.1 MB	4.6%	21	7.68	20.60
10	BIN	80.1 GB	25.3 GB	31.6%	153	20.93	46.44
11	BIN	80.1 GB	34.8 GB	43.4%	170	20.79	46.75
12	BIN	13.0 GB	7.9 GB	60.8%	580	21.23	7.45
13	BIN	80.1 GB	68.1 GB	85.0%	94	20.93	46.44
14	SMALL	80.1 GB	42.3 GB	52.8%	2	7.74	125.59

TOTAL: 14	-	968.5 GB	351.6 GB	36.3%	2102	20.12	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	36112	33234	0	332	0	0	0	0	2546
2	?	13	0	0	0	0	0	0	0	13

TOTAL: 2		36125	33234	0	332	0	0	0	0	2559

Unwanted newsgroups [Top 20]:

Newsgroup	Count

bellsouth.net.test	2880
alt.binaries.pwp	2416
microsoft.public.test	1148
alt.binaries.picture.ls-series	1056
alt.binaries.dvdrs.pw	470
alt.fan.teenboy	438
a.b.games.xbox360	438
bih.rec.photo.binaries	311
lada.avia	277
alt.binaries.amazing	272
alt.binaries.pictures.erotica.teen.male.masturbation	196
alt.binaries.pictures.erotica.early-teen	177
alt.binaries.pictures.katie	174
alt.binaries.boys	169
alt.binaries.fetish	169
alt.binaries.multimedia.breasts.large	145
alt.binaries.pictures.erotica.latinal	142
cakewalk.coffeehouse	140
alt.binaries.pictures.erotica.alt	139
alt.binaries.pictures.erotica.nipples	139

TOTAL: 4429	33234

INND misc events:

Events	Count

CCreader	2

TOTAL: 1	2

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	2540
	TOTAL: 1	2540

TOTAL: 1		2540

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	1	46759	1.6 GB	12	0	0	09:06:32
2	194.186.147.146	5	36	1.9 MB	5	0	0	00:09:02
3	195.218.244.87	2	9	520.9 KB	1	0	0	00:01:12

TOTAL: 3		8	46804	1.6 GB	18	0	0	09:36:43

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	1	46759	1.6 GB	12	0	0	09:06:32
2	unresolved	9	45	2.4 MB	6	0	0	00:10:54
3	*.sovintel.net	12	0	0.0 KB	0	0	0	00:00:02
4	*.tony.pp.ru	75	0	0.0 KB	0	0	0	00:02:34
5	*.rol.ru	5761	0	0.0 KB	0	0	0	00:16:39

TOTAL: 5		5858	46804	1.6 GB	18	0	0	09:36:43

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	14.892	26.478	0.000	09:06:32
194.186.147.146	0.008	0.048	0.000	00:09:02
balancer-a.rol.ru	3.272	3.348	0.000	00:08:39
balancer-b.rol.ru	3.148	3.600	0.000	00:08:00
net1-x-ring.tony.pp.ru	0.104	0.148	0.000	00:02:34
195.218.244.87	0.048	0.088	0.000	00:01:12
194.154.86.251	0.004	0.000	0.000	00:00:28
194.186.32.44	0.004	0.000	0.000	00:00:11
fw-nat.sovintel.net	0.080	0.020	0.000	00:00:02
ppp92-101-41-147.pppoe.avangarddsl.ru	0.004	0.000	0.000	00:00:00
cornholio.migtel.ru	0.000	0.000	0.000	00:00:00

TOTAL: 11	21.564	33.730	0.000	09:36:43

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-a.rol.ru	2881
balancer-b.rol.ru	2880
net1-x-ring.tony.pp.ru	75
fw-nat.sovintel.net	12
194.154.86.251	1
194.186.32.44	1

TOTAL: 6	5850

NNRP no permission clients:

System	Conn

ppp92-101-41-147.pppoe.avangarddsl.ru	1
cornholio.migtel.ru	1

TOTAL: 2	2

NNRP client timeouts [Top 20]:

System	Conn	Peer

194.186.147.146	1	1

TOTAL: 1	1	1

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	27546	76.2%
2	hr	8624	23.8%

TOTAL: 2		36170	100.0%

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

Newsgroup		Count

1	alt.binaries.multimedia.erotic.playboy	18395
2	hr.alt.seks.binaries.playboy	8624
3	alt.binaries.full.post.verified.playboy	4671
4	alt.mag.playboy	2597
5	alt.binaries.pictures.bras	1813
6	alt.binaries.nospam.female.bodyhair.pubes	36
7	alt.binaries.photos.nude-art.moderated	25
8	alt.binaries.erotica.pornstars	9

TOTAL: 8		36170