Daily Usenet report: May 5 06:01:01

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

May 5 06:02:13 kennel innd: message repeated 2 times: [ ctlinnd command s]
May 6 01:54:00 kennel innd: message repeated 10 times: [ 165.154.41.182 rejected 502]
May 6 01:54:22 kennel innd: message repeated 6 times: [ 165.154.41.182 rejected 502]
May 6 01:54:35 kennel innd: message repeated 2 times: [ 165.154.41.182 rejected 502]
May 6 01:54:59 kennel innd: message repeated 8 times: [ 165.154.41.182 rejected 502]
May 6 01:55:07 kennel innd: message repeated 2 times: [ 165.154.41.182 rejected 502]
May 6 01:55:15 kennel innd: message repeated 2 times: [ 165.154.41.182 rejected 502]
May 6 01:55:42 kennel innd: message repeated 9 times: [ 165.154.41.182 rejected 502]
May 6 01:55:57 kennel innd: message repeated 5 times: [ 165.154.41.182 rejected 502]
May 6 01:56:45 kennel innd: message repeated 14 times: [ 165.154.41.182 rejected 502]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	401727	98.0%	54.5 MB	97.8%
innd	6566	1.6%	1.0 MB	1.8%
innfeed	1362	0.3%	179.0 KB	0.3%
cnfsstat	144	0.0%	24.3 KB	0.0%
nnrpd	35	0.0%	3.5 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	409836	100.0%	55.8 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	672501	45.8%
Positive hits	397276	27.1%
Do not exist	389722	26.5%
Cache misses	8644	0.6%
TOTAL: 4	1468143	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.021	0.0%	67	0.000	0.313	1.000
article cleanup	00:00:04.243	0.0%	399862	0.006	0.011	0.018
article logging	00:00:16.727	0.0%	399940	0.022	0.042	0.058
article parse	00:00:23.336	0.0%	1118860	0.012	0.021	0.029
article write	00:00:15.229	0.0%	144654	0.047	0.105	0.154
artlog/artparse	00:00:00.061	0.0%	1293	0.000	0.047	1.000
data move	00:00:02.404	0.0%	1161842	0.000	0.002	0.008
hisgrep/artcncl	00:00:00.001	0.0%	67	0.000	0.015	0.053
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:20.131	0.0%	1475314	0.002	0.014	0.310
history sync	00:00:00.022	0.0%	305	0.000	0.072	1.000
history write	00:00:25.765	0.0%	390950	0.047	0.066	0.094
idle	23:52:44.278	99.5%	1005616	23.713	85.484	139.508
nntp read	00:00:38.493	0.0%	1006443	0.023	0.038	0.053
overview write	00:00:00.845	0.0%	144654	0.000	0.006	0.014
perl filter	00:00:19.176	0.0%	389680	0.035	0.049	0.065
python filter	00:00:19.645	0.0%	389680	0.039	0.050	0.073
site send	00:00:07.125	0.0%	433962	0.010	0.016	0.112
TOTAL: 24:00:24.292	23:55:57.502	99.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.517	0.0%	144445	0.000	0.004	0.014
article prepare	00:00:00.000	0.0%	842	0.000	0.000	0.000
article read	00:00:00.054	0.0%	552	0.000	0.098	1.000
backlog stats	00:00:00.375	0.0%	432608	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:07.020	0.0%	278634	0.014	0.025	0.043
data write	00:00:06.589	0.0%	159667	0.022	0.041	0.085
idle	23:51:14.792	100.0%	432608	121.207	198.505	353.349
status file	00:00:00.250	0.0%	230	0.000	1.087	25.750
TOTAL: 23:51:42.912	23:51:29.597	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.001	0.1%	8	0.000	0.125	1.000
TOTAL: 00:00:01.443	00:00:00.001	0.1%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	147
name	2
pause	2
paused	2
reload	48
reserve	2
TOTAL: 11	215

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.feeder.erje.net	580	771854	138511	377035	256308	17%	48:38:47
2	hasname-out.news.weretis.net	2	12666	3125	9501	40	24%	49:01:50
3	news.nntp4.net	4	7695	1952	5373	370	25%	24:53:12
4	usenet.blueworldhosting.com	288	7778	1495	6209	74	19%	23:43:38
5	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 5		875	799993	145083	398118	256792	18%	146:17:27

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	1.3 GB	103.4 MB	2.4 GB	3.8 GB	34%	10.0 KB
2	hasname-out.news.weretis.net	8.5 MB	8.9 KB	66.2 KB	8.6 MB	99%	2.8 KB
3	news.nntp4.net	5.6 MB	20.2 KB	3.4 MB	9.0 MB	62%	4.0 KB
4	usenet.blueworldhosting.com	2.8 MB	1.1 KB	234.6 KB	3.0 MB	92%	1.9 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		1.3 GB	103.4 MB	2.4 GB	3.8 GB	34%	9.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 5 06:01:01 - 06:59:59	6037	4.2%	1.71	46.7 MB	3.4%	13.50
May 5 07:00:00 - 07:59:59	8514	5.9%	2.37	68.1 MB	5.0%	19.37
May 5 08:00:00 - 08:59:59	5932	4.1%	1.65	50.5 MB	3.7%	14.37
May 5 09:00:00 - 09:59:59	4434	3.1%	1.23	44.4 MB	3.3%	12.64
May 5 10:00:00 - 10:59:59	5252	3.6%	1.46	51.6 MB	3.8%	14.67
May 5 11:00:00 - 11:59:59	5334	3.7%	1.48	58.0 MB	4.3%	16.51
May 5 12:00:00 - 12:59:59	4677	3.2%	1.30	54.3 MB	4.0%	15.44
May 5 13:00:00 - 13:59:59	7707	5.3%	2.14	82.9 MB	6.1%	23.57
May 5 14:00:00 - 14:59:59	6594	4.5%	1.83	67.5 MB	5.0%	19.20
May 5 15:00:00 - 15:59:59	5672	3.9%	1.58	54.2 MB	4.0%	15.40
May 5 16:00:00 - 16:59:59	6878	4.7%	1.91	66.9 MB	4.9%	19.03
May 5 17:00:00 - 17:59:59	6533	4.5%	1.81	58.1 MB	4.3%	16.52
May 5 18:00:00 - 18:59:59	7504	5.2%	2.08	60.7 MB	4.5%	17.26
May 5 19:00:00 - 19:59:59	6796	4.7%	1.89	63.0 MB	4.7%	17.92
May 5 20:00:00 - 20:59:59	6526	4.5%	1.81	57.9 MB	4.3%	16.47
May 5 21:00:00 - 21:59:59	7493	5.2%	2.08	65.7 MB	4.9%	18.70
May 5 22:00:00 - 22:59:59	7360	5.1%	2.04	60.2 MB	4.5%	17.13
May 5 23:00:00 - 23:59:59	4370	3.0%	1.21	39.7 MB	2.9%	11.29
May 6 00:00:00 - 00:59:59	4133	2.9%	1.15	40.0 MB	3.0%	11.36
May 6 01:00:00 - 01:59:59	5085	3.5%	1.41	53.7 MB	4.0%	15.27
May 6 02:00:00 - 02:59:59	5578	3.8%	1.55	53.4 MB	3.9%	15.18
May 6 03:00:00 - 03:59:59	4265	2.9%	1.18	46.0 MB	3.4%	13.09
May 6 04:00:00 - 04:59:59	5526	3.8%	1.53	48.2 MB	3.6%	13.72
May 6 05:00:00 - 05:59:59	6538	4.5%	1.82	59.5 MB	4.4%	16.94
May 6 06:00:00 - 06:01:02	186	0.1%	3.00	1.7 MB	0.1%	27.70
TOTAL: 24:00:01	144924	100.0%	1.68	1.3 GB	100.0%	16.03

CNFS buffer status:

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

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	hasname-out.feeder.erje.net	256313	244799	10182	1332
2	news.nntp4.net	342	337	5	0
3	usenet.blueworldhosting.com	96	72	1	23
4	hasname-out.news.weretis.net	52	30	3	19
TOTAL: 4		256803	245238	10191	1374

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	109926
alt.binaries.mp3.abooks	11075
alt.binaries.wtfnzb.kilo	5286
alt.binaries.wtfnzb.mike	5247
alt.binaries.pwp	5232
alt.binaries.wtfnzb.beta	5189
alt.binaries.wtfnzb.india	5184
alt.binaries.wtfnzb.juliet	5129
alt.binaries.wtfnzb.bravo	5115
alt.binaries.wtfnzb.echo	5114
alt.binaries.wtfnzb.golf	5109
alt.binaries.wtfnzb.novemeber	5106
alt.binaries.wtfnzb.foxtrot	5101
alt.binaries.wtfnzb.lima	5098
alt.binaries.wtfnzb.alpha	5093
alt.binaries.wtfnzb.delta	5082
alt.binaries.wtfnzb.hotel	5081
alt.binaries.wtfnzb.charlie	5065
alt.binaries.encrypted	2970
alt.binaries.amazing	2796
TOTAL: 202	245238

INND no permission servers:

System	Conn
103.193.138.76	30
165.154.41.182	15
66.132.172.109	1
69.5.169.135	1
69.5.169.184	1
69.5.169.213	1
69.5.169.228	1
69.5.169.75	1
79.124.49.194	1
TOTAL: 9	52

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	hasname-out.feeder.erje.net	6
	TOTAL: 1	6
Including strange strings
	hasname-out.feeder.erje.net	37
	usenet.blueworldhosting.com	22
	hasname-out.news.weretis.net	19
	TOTAL: 3	78
No colon-space in header field
	hasname-out.feeder.erje.net	1295
	usenet.blueworldhosting.com	1
	TOTAL: 2	1296
TOTAL: 3		1380

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	459	459	0	0	0	100%	21:30:10
2	nntp4	5306	2	5284	0	91	0%	23:59:55
3	erje	5913	1	5886	0	74	0%	23:59:55
4	blueworldhosting	145646	0	143164	87	465	0%	23:59:53
5	weretis	3879	0	3860	7	0	0%	23:59:53
TOTAL: 5		161203	462	158194	94	630	0%	117:29:46

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	1.3 MB	0.0 KB	1.3 MB	2.9 KB	21:30:10
2	nntp4	4.0 KB	0.0 KB	4.0 KB	2.0 KB	23:59:55
3	erje	1.3 KB	0.0 KB	1.3 KB	1.3 KB	23:59:55
4	blueworldhosting	0.0 KB	841.3 KB	841.3 KB	9.7 KB	23:59:53
5	weretis	0.0 KB	13.4 KB	13.4 KB	1.9 KB	23:59:53
TOTAL: 5		1.3 MB	854.7 KB	2.2 MB	4.0 KB	117:29:46

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
vmd129036.contaboserver.net	0.000	0.005	00:00:00
69.5.169.133	0.002	0.003	00:00:00
69.5.169.119	0.001	0.001	00:00:00
86.54.25.199	0.001	0.003	00:00:00
196.172.132.66.censys-scanner.com	0.004	0.009	00:00:00
160.186.132.66.censys-scanner.com	0.000	0.005	00:00:00
TOTAL: 6	0.008	0.026	00:00:01

NNRP no permission clients [Top 20]:

System	Conn
196.172.132.66.censys-scanner.com	3
160.186.132.66.censys-scanner.com	1
69.5.169.119	1
69.5.169.133	1
86.54.25.199	1
vmd129036.contaboserver.net	1
TOTAL: 6	8

Daily Usenet report

May 5 06:01:01 -- May 6 06:01:02