Daily Usenet report

Sep 25 03:00:03 -- Sep 26 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 / 73 lines (6.8%)
Sep 25 03:21:13 perseus controlchan[16499]: Unknown "cmsg" control by skypiper.bbs@bbs.cs.nctu.edu.tw
Sep 25 03:25:57 perseus controlchan[16499]: Unknown "cmsg" control by kknd.bbs@bbs.cs.nctu.edu.tw
Sep 25 04:21:01 perseus controlchan[16499]: Unknown "cmsg" control by sux0116.bbs@bbs.cs.nctu.edu.tw
Sep 25 04:21:04 perseus controlchan[16499]: Unknown "cmsg" control by sux0116.bbs@bbs.cs.nctu.edu.tw
Sep 25 05:10:51 perseus controlchan[16499]: Unknown "cmsg" control by pgli.bbs@bbs.cs.nctu.edu.tw

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	585321	89.1%	54.9 MB	89.4%
innd	50698	7.7%	4.5 MB	7.3%
nnrpd	18226	2.8%	1.6 MB	2.6%
cnfsstat	2304	0.4%	396.1 KB	0.6%
controlchan	74	0.0%	6.8 KB	0.0%

TOTAL: 5	656623	100.0%	61.4 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	563751	92.8%
Negative hits	39770	6.5%
Positive hits	3268	0.5%
Cache misses	535	0.1%

TOTAL: 4	607324	100.0%

INND timer:

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

article cancel	00:00:16.016	0.0%	5376	0.000	2.979	285.267
article cleanup	00:00:05.284	0.0%	562560	0.000	0.009	0.033
article logging	00:01:43.821	0.1%	580054	0.000	0.179	54.027
article parse	00:02:49.365	0.2%	41323460	0.000	0.004	0.008
article write	00:45:29.231	3.2%	483004	0.174	5.651	33.742
artlog/artcncl	00:00:09.683	0.0%	5303	0.000	1.826	285.200
artlog/artparse	00:00:00.000	0.0%	8	0.000	0.000	0.000
data move	00:00:43.030	0.0%	43384945	0.000	0.001	0.002
hisgrep/artcncl	00:00:05.271	0.0%	3731	0.000	1.413	269.667
hishave/artcncl	00:00:00.502	0.0%	5376	0.000	0.093	36.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:09:00.082	0.6%	602367	0.000	0.897	13.816
history sync	00:00:00.293	0.0%	341	0.000	0.859	46.000
history write	00:26:51.814	1.9%	483004	0.006	3.337	42.619
hiswrite/artcncl	00:00:00.526	0.0%	1645	0.000	0.320	90.000
idle	21:06:55.654	88.0%	41132744	0.580	1.848	96.436
nntp read	00:03:22.445	0.2%	41346434	0.002	0.005	0.012
overview write	01:17:34.366	5.4%	483004	0.843	9.636	56.527
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%	72	0.000	0.014	1.000

TOTAL: 24:00:09.208	23:55:07.384	99.7%	-	-	-	-

nnrpd timer:

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

hisgrep	00:02:12.447	0.4%	13582	0.000	9.752	24.053
idle	09:39:34.215	95.5%	33777	0.000	1029.523	200336.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:08:06.520	1.3%	100717	0.000	4.831	272.182
readart	00:04:50.027	0.8%	27380	0.000	10.593	31.833

TOTAL: 10:06:50.258	09:54:43.209	98.0%	-	-	-	-

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	1	0	0	1

TOTAL	0	0	1	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	1173	553716	474669	8	79039	85%	439:56:40

TOTAL: 1		1173	553716	474669	8	79039	85%	439:56:40

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	50.1 GB	140.9 KB	50.1 GB	99%	94.9 KB	439:56:40

TOTAL: 1		50.1 GB	140.9 KB	50.1 GB	99%	94.9 KB	439:56:40

Incoming articles:

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

Sep 25 03:00:03 - 03:59:59	21362	4.4%	5.94	2.8 GB	5.5%	805.72
Sep 25 04:00:00 - 04:59:59	20032	4.1%	5.56	2.7 GB	5.5%	797.56
Sep 25 05:00:00 - 05:59:59	21706	4.5%	6.03	2.7 GB	5.4%	787.29
Sep 25 06:00:00 - 06:59:59	18707	3.9%	5.20	2.7 GB	5.3%	774.58
Sep 25 07:00:00 - 07:59:59	18134	3.8%	5.04	2.7 GB	5.4%	791.67
Sep 25 08:00:00 - 08:59:59	19408	4.0%	5.39	3.0 GB	6.0%	877.16
Sep 25 09:00:00 - 09:59:59	19180	4.0%	5.33	2.8 GB	5.7%	829.45
Sep 25 10:00:00 - 10:59:59	17336	3.6%	4.82	2.0 GB	4.0%	586.59
Sep 25 11:00:00 - 11:59:59	17372	3.6%	4.83	1.5 GB	3.0%	434.56
Sep 25 12:00:00 - 12:59:59	16048	3.3%	4.46	1.5 GB	2.9%	423.19
Sep 25 13:00:00 - 13:59:59	17824	3.7%	4.95	1.8 GB	3.6%	521.47
Sep 25 14:00:00 - 14:59:59	20568	4.3%	5.71	2.1 GB	4.3%	625.03
Sep 25 15:00:00 - 15:59:59	20593	4.3%	5.72	2.1 GB	4.2%	606.23
Sep 25 16:00:00 - 16:59:59	22309	4.6%	6.20	2.0 GB	4.0%	587.93
Sep 25 17:00:00 - 17:59:59	18627	3.9%	5.17	1.7 GB	3.3%	486.17
Sep 25 18:00:00 - 18:59:59	21949	4.5%	6.10	1.4 GB	2.8%	403.77
Sep 25 19:00:00 - 19:59:59	20527	4.3%	5.70	1.4 GB	2.7%	395.84
Sep 25 20:00:00 - 20:59:59	20707	4.3%	5.75	1.8 GB	3.6%	517.67
Sep 25 21:00:00 - 21:59:59	19553	4.0%	5.43	1.7 GB	3.4%	488.94
Sep 25 22:00:00 - 22:59:59	17449	3.6%	4.85	1.4 GB	2.8%	407.90
Sep 25 23:00:00 - 23:59:59	20167	4.2%	5.60	1.8 GB	3.7%	535.95
Sep 26 00:00:00 - 00:59:59	20362	4.2%	5.66	1.7 GB	3.4%	489.82
Sep 26 01:00:00 - 01:59:59	30890	6.4%	8.58	2.4 GB	4.8%	702.19
Sep 26 02:00:00 - 02:59:59	22148	4.6%	6.15	2.4 GB	4.8%	697.83
Sep 26 03:00:00 - 03:00:02	8	0.0%	4.00	1.3 MB	0.0%	677.84

TOTAL: 23:59:59	482966	100.0%	5.59	50.0 GB	100.0%	607.27

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	BIN	137.8 GB	103.4 GB	75.0%	215	99.68	16.78
02	BIN	137.8 GB	57.5 GB	41.7%	216	99.17	16.87
03	SMALL	13.0 GB	5.9 GB	45.1%	18	3.80	41.60
04	BIN	80.1 GB	38.4 GB	48.0%	166	49.72	19.55
05	BIN	80.1 GB	63.9 GB	79.8%	186	49.62	19.59
06	SMALL	13.0 GB	5.8 GB	44.8%	18	3.78	41.82
07	BIN	80.1 GB	17.1 GB	21.4%	166	49.57	19.61
08	BIN	80.1 GB	45.4 GB	56.7%	186	49.96	19.46
09	SMALL	13.0 GB	4.8 GB	36.9%	18	3.77	41.92
10	BIN	80.1 GB	1.7 GB	2.2%	166	50.15	19.38
11	BIN	80.1 GB	5.1 GB	6.3%	187	49.75	19.54
12	SMALL	13.0 GB	5.6 GB	43.2%	18	3.79	41.76
13	BIN	80.1 GB	79.1 GB	98.7%	165	49.59	19.60
14	BIN	80.1 GB	46.8 GB	58.4%	186	49.90	19.48

TOTAL: 14	-	968.5 GB	480.6 GB	49.6%	1911	43.73	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	97044	54676	0	64	0	0	0	0	42304
2	?	8	0	0	0	0	0	0	0	8

TOTAL: 2		97052	54676	0	64	0	0	0	0	42312

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.dvdrs.pw	8228
alt.binaries.pwp	4883
bih.rec.photo.binaries	2345
alt.binaries.movie	1640
microsoft.public.test	1154
alt.binaries.private.not.yours	856
a.b.music	649
alt.binaries.usenet-world.com	639
alt.binaries.boneless.nl	598
alt.binaries.pictures.amateur.butts	413
alt.binaries.amazing	357
alt.binaries.nospam.female.short-hair	316
easynews.alt.binaries.games.apps.movies	249
mozilla.feedback.firefox	245
alt.binaries.game	240
tin.it.sport.calcio	203
macromedia.flex.general_discussion	191
easynews.alt.binaries.apps.games.movies	147
alt.binaries.pictures.maxwell	140
it-alt.discussioni.infanzia	127

TOTAL: 3747	54676

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	17498
	TOTAL: 1	17498

TOTAL: 1		17498

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	keyhole.sovam.com	3	13582	851.8 MB	12	0	0	09:23:52
2	195.218.244.87	1	48	2.6 MB	1	0	0	00:02:26
3	194.186.147.157	1	1	36.5 KB	1	0	0	00:00:08

TOTAL: 3		5	13631	854.5 MB	14	0	0	10:06:50

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.sovam.com	3	13582	851.8 MB	12	0	0	09:23:52
2	unresolved	2	49	2.7 MB	2	0	0	00:02:34
3	*.sovintel.net	16	0	0.0 KB	0	0	0	00:00:29
4	*.sarov.dial.rol.ru	4	0	0.0 KB	0	0	0	00:22:18
5	*.tony.pp.ru	74	0	0.0 KB	0	0	0	00:02:42
6	*.rol.ru	5764	0	0.0 KB	0	0	0	00:14:27

TOTAL: 6		5863	13631	854.5 MB	14	0	0	10:06:49

NNRP total resource statistics [Top 20]:

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

keyhole.sovam.com	10.264	103.980	0.000	09:23:52
ts2-a107.sarov.dial.rol.ru	0.004	0.000	0.000	00:10:12
ts2-a176.sarov.dial.rol.ru	0.000	0.004	0.000	00:10:01
balancer-b.rol.ru	3.524	3.416	0.000	00:08:00
balancer-a.rol.ru	3.584	3.248	0.000	00:06:26
net1-x-ring.tony.pp.ru	0.152	0.116	0.000	00:02:42
195.218.244.87	0.012	0.028	0.000	00:02:26
ts2-a134.sarov.dial.rol.ru	0.004	0.004	0.000	00:02:05
fw-nat.sovintel.net	0.100	0.072	0.000	00:00:29
?	0.000	0.004	0.000	00:00:24
194.186.147.157	0.000	0.000	0.000	00:00:08
83.167.112.149	0.000	0.000	0.000	00:00:00
dial-101.vl-cen-as3.avtlg.ru	0.008	0.000	0.000	00:00:00
12.27.233.129	0.000	0.004	0.000	00:00:00
cs1-ats30-1.dialup.mts-nn.ru	0.000	0.000	0.000	00:00:00
cornholio.migtel.ru	0.000	0.000	0.000	00:00:00

TOTAL: 16	17.652	110.876	0.000	10:06:50

Curious NNRP server explorers [Top 20]:

System	Conn

balancer-b.rol.ru	2882
balancer-a.rol.ru	2882
net1-x-ring.tony.pp.ru	74
fw-nat.sovintel.net	16
ts2-a134.sarov.dial.rol.ru	2
ts2-a176.sarov.dial.rol.ru	1
ts2-a107.sarov.dial.rol.ru	1

TOTAL: 7	5858

NNRP no permission clients:

System	Conn

dial-101.vl-cen-as3.avtlg.ru	2
cs1-ats30-1.dialup.mts-nn.ru	1
83.167.112.149	1
cornholio.migtel.ru	1
12.27.233.129	1

TOTAL: 5	6

NNRP gethostbyaddr failures [Top 20]:

System	Conn

? (can't getpeername)	5

TOTAL: 1	5

NNRP client timeouts [Top 20]:

System	Conn	Peer

ts2-a176.sarov.dial.rol.ru	1	0
ts2-a107.sarov.dial.rol.ru	1	0

TOTAL: 2	2	0

Newsgroup request counts (by category):

Category		Count	Pct

1	alt	13248	100.0%

TOTAL: 1		13248	100.0%

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

Newsgroup		Count

1	alt.binaries.pictures.erotica.vintage	6968
2	alt.binaries.pictures.bras	5089
3	alt.binaries.pictures.artpics	1142
4	alt.binaries.erotica.pornstars	48
5	alt.binaries.nospam.female.bodyhair.pubes	1

TOTAL: 5		13248