Daily Usenet report: Jan 31 06:01:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jan 31 06:01:55 kennel innd: message repeated 2 times: [ ctlinnd command s]
Jan 31 20:04:44 kennel innd: message repeated 3 times: [ 31.43.185.3 rejected 502]
Feb 1 00:04:03 kennel pgpverify[1336482]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	588473	98.8%	73.2 MB	98.6%
innd	6100	1.0%	980.9 KB	1.3%
innfeed	593	0.1%	79.3 KB	0.1%
cnfsstat	144	0.0%	22.2 KB	0.0%
nnrpd	40	0.0%	4.4 KB	0.0%
controlchan	22	0.0%	5.2 KB	0.0%
pgpverify	1	0.0%	0.2 KB	0.0%
TOTAL: 7	595373	100.0%	74.2 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	855801	42.7%
Do not exist	578482	28.9%
Positive hits	553022	27.6%
Cache misses	16621	0.8%
TOTAL: 4	2003926	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.018	0.0%	81	0.000	0.222	1.000
article cleanup	00:00:05.737	0.0%	585541	0.006	0.010	0.014
article logging	00:00:21.607	0.0%	585643	0.025	0.037	0.057
article parse	00:00:31.790	0.0%	1808265	0.010	0.018	0.022
article write	00:00:28.651	0.0%	361507	0.042	0.079	0.110
artlog/artparse	00:00:00.149	0.0%	2956	0.000	0.050	1.000
data move	00:00:03.918	0.0%	1832161	0.000	0.002	0.009
hisgrep/artcncl	00:00:00.010	0.0%	81	0.000	0.123	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:02.228	0.1%	2007172	0.004	0.031	0.323
history sync	00:00:00.020	0.0%	314	0.000	0.064	1.000
history write	00:00:34.292	0.0%	578391	0.039	0.059	0.090
idle	23:53:23.855	99.5%	1446051	17.512	59.475	152.783
nntp read	00:00:55.576	0.1%	1447852	0.022	0.038	0.055
overview write	00:00:01.850	0.0%	361507	0.001	0.005	0.009
perl filter	00:00:27.961	0.0%	575487	0.027	0.049	0.079
python filter	00:00:27.184	0.0%	575487	0.030	0.047	0.075
site send	00:00:12.018	0.0%	730431	0.010	0.016	0.141
TOTAL: 24:00:28.968	23:58:36.864	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.029	0.0%	7379	0.000	0.004	0.040
article prepare	00:00:00.000	0.0%	124	0.000	0.000	0.000
article read	00:00:00.004	0.0%	31	0.000	0.129	1.000
backlog stats	00:00:00.017	0.0%	26499	0.000	0.001	0.013
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.398	0.0%	14589	0.000	0.027	0.083
data write	00:00:00.534	0.0%	7518	0.000	0.071	0.222
idle	23:49:57.831	100.0%	26499	1546.938	3237.776	8966.567
status file	00:00:00.051	0.0%	147	0.000	0.347	7.000
TOTAL: 23:49:59.775	23:49:58.864	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:00.000	0.0%	0	0.000	0.000	0.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.002	0.1%	9	0.000	0.222	1.000
TOTAL: 00:00:01.774	00:00:00.002	0.1%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	Other	Bad PGP	OK
bofh-control@killfile.org	1	0	1
us-control@lists.killfile.org	0	1	0
TOTAL	1	1	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.feeder.erje.net	579	1139457	353127	559551	226779	30%	50:46:29
2	newsfeed.hasname.com	49	9421	8363	929	129	88%	25:01:16
3	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 3		629	1148878	361490	560480	226908	31%	75:47:45

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	2.8 GB	102.6 MB	2.7 GB	5.6 GB	49%	10.2 KB
2	newsfeed.hasname.com	24.0 MB	80.4 KB	241.1 KB	24.3 MB	98%	2.9 KB
3	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 3		2.8 GB	102.7 MB	2.7 GB	5.7 GB	49%	10.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 31 06:01:02 - 06:59:59	13717	3.8%	3.88	94.4 MB	3.3%	27.33
Jan 31 07:00:00 - 07:59:59	10102	2.8%	2.81	86.4 MB	3.0%	24.59
Jan 31 08:00:00 - 08:59:59	14852	4.1%	4.13	103.1 MB	3.6%	29.34
Jan 31 09:00:00 - 09:59:59	10335	2.9%	2.87	89.7 MB	3.1%	25.51
Jan 31 10:00:00 - 10:59:59	14506	4.0%	4.03	95.6 MB	3.3%	27.19
Jan 31 11:00:00 - 11:59:59	14153	3.9%	3.93	119.6 MB	4.1%	34.02
Jan 31 12:00:00 - 12:59:59	16102	4.5%	4.47	120.8 MB	4.2%	34.35
Jan 31 13:00:00 - 13:59:59	16676	4.6%	4.63	146.7 MB	5.1%	41.72
Jan 31 14:00:00 - 14:59:59	16113	4.5%	4.48	143.6 MB	5.0%	40.86
Jan 31 15:00:00 - 15:59:59	17255	4.8%	4.79	137.9 MB	4.8%	39.22
Jan 31 16:00:00 - 16:59:59	18166	5.0%	5.05	155.7 MB	5.4%	44.27
Jan 31 17:00:00 - 17:59:59	21803	6.0%	6.06	181.8 MB	6.3%	51.72
Jan 31 18:00:00 - 18:59:59	19336	5.3%	5.37	175.1 MB	6.0%	49.81
Jan 31 19:00:00 - 19:59:59	22762	6.3%	6.32	181.4 MB	6.3%	51.61
Jan 31 20:00:00 - 20:59:59	23845	6.6%	6.62	163.6 MB	5.6%	46.55
Jan 31 21:00:00 - 21:59:59	15934	4.4%	4.43	115.3 MB	4.0%	32.79
Jan 31 22:00:00 - 22:59:59	17017	4.7%	4.73	124.0 MB	4.3%	35.26
Jan 31 23:00:00 - 23:59:59	9049	2.5%	2.51	67.8 MB	2.3%	19.30
Feb 1 00:00:00 - 00:59:59	13403	3.7%	3.72	119.4 MB	4.1%	33.95
Feb 1 01:00:00 - 01:59:59	11768	3.3%	3.27	99.1 MB	3.4%	28.20
Feb 1 02:00:00 - 02:59:59	10884	3.0%	3.02	95.4 MB	3.3%	27.14
Feb 1 03:00:00 - 03:59:59	10593	2.9%	2.94	86.6 MB	3.0%	24.62
Feb 1 04:00:00 - 04:59:59	10070	2.8%	2.80	92.4 MB	3.2%	26.29
Feb 1 05:00:00 - 05:59:59	12697	3.5%	3.53	100.8 MB	3.5%	28.67
Feb 1 06:00:00 - 06:01:01	366	0.1%	6.00	2.6 MB	0.1%	43.81
TOTAL: 23:59:59	361504	100.0%	4.18	2.8 GB	100.0%	34.36

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
C1	DEFAULT	10.0 GB	5.4 GB	53.9%	1	43.16	2.81
TOTAL: 1	-	10.0 GB	5.4 GB	53.9%	1	43.16	-

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	hasname-out.feeder.erje.net	226745	213750	10030	2965
2	newsfeed.hasname.com	224	104	27	93
TOTAL: 2		226969	213854	10057	3058

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	130809
alt.binaries.pictures.purebeauty	12074
alt.binaries.font	6905
alt.binaries.u-4all	5418
alt.binaries.encrypted	4416
alt.binaries.pwp	4272
alt.binaries.moovee	1930
alt.binaries.wtfnzb.alpha	1237
alt.binaries.wtfnzb.mike	1237
alt.binaries.wtfnzb.charlie	1233
alt.binaries.wtfnzb.bravo	1226
alt.binaries.wtfnzb.beta	1223
alt.binaries.wtfnzb.novemeber	1223
alt.binaries.wtfnzb.golf	1200
alt.binaries.wtfnzb.kilo	1200
alt.binaries.wtfnzb.lima	1196
alt.binaries.wtfnzb.echo	1195
alt.binaries.wtfnzb.hotel	1194
alt.binaries.wtfnzb.india	1191
alt.binaries.wtfnzb.juliet	1188
TOTAL: 252	213854

INND no permission servers:

System	Conn
31.43.185.3	1
TOTAL: 1	1

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.hasname.com	93
	hasname-out.feeder.erje.net	9
	TOTAL: 2	102
No colon-space in header field
	hasname-out.feeder.erje.net	2956
	TOTAL: 1	2956
TOTAL: 2		3058

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	erje	7505	31	7358	0	0	0	0%	23:59:55
TOTAL: 1		7505	31	7358	0	0	0	0%	23:59:55

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	erje	76.5 KB	0.0 KB	76.5 KB	0.0 KB/s	2.5 KB	23:59:55
TOTAL: 1		76.5 KB	0.0 KB	76.5 KB	0.0 KB/s	2.5 KB	23:59:55

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
alysha.probe.onyphe.net	0.002	0.003	00:00:00
craig.probe.onyphe.net	0.000	0.004	00:00:00
ec2-3-129-60-214.us-east-2.compute.amazonaws.com	0.002	0.001	00:00:00
165.154.237.249	0.000	0.004	00:00:00
167.94.138.204	0.003	0.005	00:00:00
azpdcgc39.stretchoid.com	0.000	0.002	00:00:00
TOTAL: 6	0.007	0.019	00:00:01

NNRP no permission clients [Top 20]:

System	Conn
167.94.138.204	3
ec2-3-129-60-214.us-east-2.compute.amazonaws.com	2
165.154.237.249	1
alysha.probe.onyphe.net	1
azpdcgc39.stretchoid.com	1
craig.probe.onyphe.net	1
TOTAL: 6	9

Daily Usenet report

Jan 31 06:01:02 -- Feb 1 06:01:01