Daily Usenet report: Apr 14 15:00:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Apr 14 15:00:47 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Apr 14 Apr 14 16:44:51.008 + news.nntp4.net <qn6e7g9u1jbt6ne47hovjmvlbo42d57lq9@4ax.com> 5684 overview! aioe inpaths!

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17099	81.7%	1.9 MB	78.4%
innd	2176	10.4%	293.6 KB	12.1%
innfeed	1061	5.1%	147.4 KB	6.1%
cnfsstat	580	2.8%	78.1 KB	3.2%
nnrpd	18	0.1%	1.9 KB	0.1%
controlchan	3	0.0%	0.3 KB	0.0%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	20938	100.0%	2.4 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	27538	48.3%
Do not exist	16532	29.0%
Positive hits	12919	22.7%
Cache misses	23	0.0%
TOTAL: 4	57012	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.547	0.0%	61	0.000	58.148	300.444
article cleanup	00:00:00.085	0.0%	16649	0.000	0.005	0.031
article logging	00:00:00.980	0.0%	16999	0.000	0.058	4.157
article parse	00:00:00.279	0.0%	36645	0.000	0.008	0.030
article write	00:00:05.328	0.0%	15906	0.000	0.335	18.159
artlog/artcncl	00:00:00.000	0.0%	59	0.000	0.000	0.000
data move	00:00:00.042	0.0%	74374	0.000	0.001	0.008
hisgrep/artcncl	00:00:00.002	0.0%	41	0.000	0.049	1.000
hishave/artcncl	00:00:01.693	0.0%	61	0.000	27.754	193.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:04:00.696	0.3%	57271	0.000	4.203	40.342
history sync	00:00:00.021	0.0%	406	0.000	0.052	0.500
history write	00:00:04.094	0.0%	16600	0.000	0.247	8.395
hiswrite/artcncl	00:00:00.001	0.0%	20	0.000	0.050	1.000
idle	23:45:57.801	99.6%	75098	424.339	1139.282	8003.093
nntp read	00:00:00.642	0.0%	74924	0.000	0.009	0.027
overview write	00:00:00.050	0.0%	15906	0.000	0.003	0.056
perl filter	00:00:20.566	0.0%	16600	0.819	1.239	15.658
python filter	00:00:00.457	0.0%	16600	0.000	0.028	0.109
site send	00:00:02.461	0.0%	47453	0.018	0.052	0.084
TOTAL: 23:51:05.236	23:50:38.745	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.033	0.0%	15486	0.000	0.002	0.022
article prepare	00:00:00.001	0.0%	480	0.000	0.002	0.500
article read	00:00:00.255	0.0%	474	0.000	0.538	59.000
backlog stats	00:00:00.026	0.0%	53270	0.000	0.000	0.006
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.272	0.0%	31986	0.000	0.009	0.035
data write	00:00:00.524	0.0%	16602	0.000	0.032	0.078
idle	23:38:16.347	100.0%	53270	996.213	1597.453	5764.869
status file	00:00:00.066	0.0%	238	0.000	0.277	2.000
TOTAL: 23:38:20.907	23:38:17.524	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:03.463	63.1%	2	1133.000	1731.500	2330.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.000	0.0%	9	0.000	0.000	0.000
TOTAL: 00:00:05.488	00:00:03.463	63.1%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	148
name	2
pause	2
paused	2
reserve	2
TOTAL: 10	168

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	5	13081	11339	1698	44	86%	23:48:19
2	news.nntp4.net	4	15284	4257	10438	589	27%	22:44:10
3	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 3		10	28365	15596	12136	633	54%	46:32:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	30.2 MB	74.6 KB	108.9 KB	30.4 MB	99%	2.7 KB
2	news.nntp4.net	11.8 MB	35.2 KB	5.9 MB	17.8 MB	66%	3.8 KB
3	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 3		42.0 MB	109.9 KB	6.0 MB	48.2 MB	87%	3.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 14 15:00:02 - 15:59:59	837	5.3%	0.23	2.3 MB	5.3%	0.65
Apr 14 16:00:00 - 16:59:59	904	5.7%	0.25	2.5 MB	5.9%	0.72
Apr 14 17:00:00 - 17:59:59	890	5.6%	0.25	2.6 MB	6.0%	0.73
Apr 14 18:00:00 - 18:59:59	873	5.5%	0.24	2.4 MB	5.5%	0.68
Apr 14 19:00:00 - 19:59:59	899	5.6%	0.25	2.8 MB	6.5%	0.79
Apr 14 20:00:00 - 20:59:59	723	4.5%	0.20	1.7 MB	4.0%	0.49
Apr 14 21:00:00 - 21:59:59	646	4.1%	0.18	1.8 MB	4.1%	0.50
Apr 14 22:00:00 - 22:59:59	560	3.5%	0.16	1.7 MB	4.0%	0.48
Apr 14 23:00:00 - 23:59:59	450	2.8%	0.12	1.3 MB	3.0%	0.36
Apr 15 00:00:00 - 00:59:59	397	2.5%	0.11	1.4 MB	3.2%	0.39
Apr 15 01:00:00 - 01:59:59	350	2.2%	0.10	1.0 MB	2.4%	0.29
Apr 15 02:00:00 - 02:59:59	305	1.9%	0.08	1.1 MB	2.5%	0.30
Apr 15 03:00:00 - 03:59:59	220	1.4%	0.06	757.9 KB	1.7%	0.21
Apr 15 04:00:00 - 04:59:59	310	1.9%	0.09	1.0 MB	2.4%	0.29
Apr 15 05:00:00 - 05:59:59	411	2.6%	0.11	1.1 MB	2.7%	0.33
Apr 15 06:00:00 - 06:59:59	509	3.2%	0.14	1.2 MB	2.9%	0.35
Apr 15 07:00:00 - 07:59:59	754	4.7%	0.21	1.8 MB	4.1%	0.50
Apr 15 08:00:00 - 08:59:59	756	4.7%	0.21	2.0 MB	4.6%	0.56
Apr 15 09:00:00 - 09:59:59	819	5.1%	0.23	1.8 MB	4.1%	0.50
Apr 15 10:00:00 - 10:59:59	890	5.6%	0.25	2.1 MB	4.9%	0.59
Apr 15 11:00:00 - 11:59:59	778	4.9%	0.22	1.9 MB	4.3%	0.53
Apr 15 12:00:00 - 12:59:59	829	5.2%	0.23	2.3 MB	5.4%	0.66
Apr 15 13:00:00 - 13:59:59	940	5.9%	0.26	2.3 MB	5.5%	0.67
Apr 15 14:00:00 - 14:59:59	890	5.6%	0.25	2.3 MB	5.3%	0.64
Apr 15 15:00:00 - 15:00:02	2	0.0%	1.00	4.4 KB	0.0%	2.20
TOTAL: 24:00:00	15942	100.0%	0.18	42.9 MB	100.0%	0.51

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
FOUR	DEFAULT	1024.0 MB	347.4 MB	33.9%	0	0.23	53.67
ONE	DEFAULT	1024.0 MB	505.9 MB	49.4%	2	0.23	52.92
THREE	DEFAULT	1024.0 MB	348.7 MB	34.1%	0	0.23	53.65
TWO	DEFAULT	1024.0 MB	350.1 MB	34.2%	0	0.24	51.58
TOTAL: 4	-	4.0 GB	1.5 GB	37.9%	2	0.23	-

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nntp4.net	752	26	20	1	705
2	news-out.aioe.org	346	0	29	0	317
TOTAL: 2		1098	26	49	1	1022

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.hardware	9
alt.support.chronic.pain	5
0.test	3
afj.test	3
alt.penthouse.sex.femdom	1
netscape.public.mozilla.test	1
alt.fetish.feet	1
3dfx.products.voodoobanshee	1
alt.pcnews	1
alt.marriage-minded.women	1
TOTAL: 10	26

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

Groups	Count
bit.listserv.catholic	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	532
EMP (phl)	97
EMP (phn path)	20
Scoring filter	10
HTML Multipart	8
Binary: misplaced binary	6
HTML post	1
TOTAL: 7	674

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	304
	news.nntp4.net	48
	TOTAL: 2	352
TOTAL: 1		352

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	%Took	Elapsed
1	bbsgslincom	475	475	0	100%	20:28:34
2	aioe	4330	2	4254	0%	23:45:32
3	nntp4	11328	0	11316	0%	23:45:23
TOTAL: 3		16133	477	15570	2%	67:59:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	1.8 MB	1.8 MB	3.8 KB	20:28:34
2	aioe	5.5 KB	5.5 KB	2.7 KB	23:45:32
3	nntp4	0.0 KB	0.0 KB	0	23:45:23
TOTAL: 3		1.8 MB	1.8 MB	3.8 KB	67:59:29

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	122-116-104-21.hinet-ip.hinet.net	2	0	0.0 KB	0	0	0	00:00:04
TOTAL: 1		2	0	0.0 KB	0	0	0	00:00:05

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.hinet-ip.hinet.net	2	0	0.0 KB	0	0	0	00:00:04
TOTAL: 1		2	0	0.0 KB	0	0	0	00:00:04

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
122-116-104-21.hinet-ip.hinet.net	0.002	0.003	00:00:04
news.nntp4.net	0.002	0.006	00:00:01
TOTAL: 2	0.004	0.009	00:00:05

NNRP no permission clients:

System	Conn
news.nntp4.net	3
TOTAL: 1	3

Daily Usenet report

Apr 14 15:00:02 -- Apr 15 15:00:02