Daily Usenet report: Jan 21 06:01:01

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Jan 21 06:02:14 kennel innd: message repeated 2 times: [ ctlinnd command s]
Jan 22 03:59:01 kennel innd: message repeated 2 times: [ 165.154.23.25 rejected 502]
Jan 22 03:59:41 kennel innd: message repeated 11 times: [ 165.154.23.25 rejected 502]
Jan 22 03:59:55 kennel innd: message repeated 4 times: [ 165.154.23.25 rejected 502]
Jan 22 04:00:44 kennel innd: message repeated 9 times: [ 165.154.23.25 rejected 502]
Jan 22 04:01:00 kennel innd: message repeated 5 times: [ 165.154.23.25 rejected 502]
Jan 22 04:01:13 kennel innd: message repeated 2 times: [ 165.154.23.25 rejected 502]
Jan 22 04:01:32 kennel innd: message repeated 5 times: [ 165.154.23.25 rejected 502]
Jan 22 04:01:43 kennel innd: message repeated 3 times: [ 165.154.23.25 rejected 502]
Jan 22 04:01:59 kennel innd: message repeated 4 times: [ 165.154.23.25 rejected 502]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	368356	93.1%	45.8 MB	93.0%
innfeed	20516	5.2%	2.3 MB	4.7%
innd	6457	1.6%	1.1 MB	2.2%
cnfsstat	144	0.0%	21.4 KB	0.0%
nnrpd	104	0.0%	12.7 KB	0.0%
overchan	2	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 7	395580	100.0%	49.2 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	610672	45.0%
Positive hits	382216	28.2%
Do not exist	358541	26.4%
Cache misses	5677	0.4%
TOTAL: 4	1357106	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.009	0.0%	58	0.000	0.155	1.000
article cleanup	00:00:03.772	0.0%	368000	0.005	0.010	0.017
article logging	00:00:14.811	0.0%	368108	0.025	0.040	0.055
article parse	00:00:21.387	0.0%	1042831	0.009	0.021	0.026
article write	00:00:20.715	0.0%	219877	0.053	0.094	0.130
artlog/artparse	00:00:00.015	0.0%	280	0.000	0.054	1.000
data move	00:00:06.372	0.0%	1110181	0.001	0.006	0.013
hisgrep/artcncl	00:00:00.003	0.0%	58	0.000	0.052	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:17.361	0.0%	1358888	0.003	0.013	0.244
history sync	00:00:00.031	0.0%	310	0.000	0.100	1.000
history write	00:00:21.453	0.0%	358382	0.032	0.060	0.073
idle	23:52:42.097	99.5%	911026	59.150	94.357	198.172
nntp read	00:00:38.102	0.0%	911766	0.022	0.042	0.060
overview write	00:00:01.282	0.0%	219877	0.001	0.006	0.015
perl filter	00:00:18.261	0.0%	356878	0.031	0.051	0.075
python filter	00:00:18.364	0.0%	356878	0.027	0.051	0.073
site send	00:00:08.785	0.0%	476776	0.011	0.018	0.140
TOTAL: 24:00:30.388	23:55:52.820	99.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.140	0.0%	39973	0.000	0.004	0.023
article prepare	00:00:00.000	0.0%	804	0.000	0.000	0.000
article read	00:00:00.044	0.0%	402	0.000	0.109	1.000
backlog stats	00:00:00.178	0.0%	149268	0.000	0.001	0.007
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.418	0.0%	93160	0.008	0.026	0.047
data write	00:00:02.600	0.0%	62104	0.016	0.042	0.080
idle	23:55:40.651	100.0%	149268	227.341	577.087	1498.349
status file	00:00:05.975	0.0%	8339	0.333	0.717	2.302
TOTAL: 23:56:08.529	23:55:52.006	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.0%	25	0.000	0.080	1.000
TOTAL: 00:00:04.974	00:00:00.002	0.0%	-	-	-	-

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	577	709637	210688	351151	147798	29%	50:33:47
2	hasname-out.news.weretis.net	5	18170	4555	13503	112	25%	47:49:59
3	news.nntp4.net	4	8265	2618	5347	300	31%	21:57:10
4	usenet.blueworldhosting.com	288	10447	2001	8286	160	19%	23:43:11
5	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 5		875	746519	219862	378287	148370	29%	144:04:07

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	1.9 GB	98.4 MB	1.3 GB	3.3 GB	58%	9.7 KB
2	news.nntp4.net	29.9 MB	20.7 KB	2.7 MB	32.7 MB	91%	11.5 KB
3	hasname-out.news.weretis.net	10.0 MB	24.7 KB	189.9 KB	10.2 MB	97%	2.2 KB
4	usenet.blueworldhosting.com	4.0 MB	1.3 KB	345.8 KB	4.4 MB	92%	2.1 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		2.0 GB	98.5 MB	1.3 GB	3.4 GB	58%	9.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 21 06:01:01 - 06:59:59	6236	2.8%	1.76	63.8 MB	3.2%	18.46
Jan 21 07:00:00 - 07:59:59	8247	3.8%	2.29	73.8 MB	3.7%	21.00
Jan 21 08:00:00 - 08:59:59	11097	5.0%	3.08	95.9 MB	4.8%	27.29
Jan 21 09:00:00 - 09:59:59	9134	4.2%	2.54	86.1 MB	4.3%	24.49
Jan 21 10:00:00 - 10:59:59	8827	4.0%	2.45	85.1 MB	4.2%	24.20
Jan 21 11:00:00 - 11:59:59	7667	3.5%	2.13	83.3 MB	4.1%	23.70
Jan 21 12:00:00 - 12:59:59	6096	2.8%	1.69	57.5 MB	2.8%	16.35
Jan 21 13:00:00 - 13:59:59	8403	3.8%	2.33	79.2 MB	3.9%	22.54
Jan 21 14:00:00 - 14:59:59	10130	4.6%	2.81	85.3 MB	4.2%	24.27
Jan 21 15:00:00 - 15:59:59	13217	6.0%	3.67	97.8 MB	4.8%	27.82
Jan 21 16:00:00 - 16:59:59	10119	4.6%	2.81	104.9 MB	5.2%	29.83
Jan 21 17:00:00 - 17:59:59	10910	5.0%	3.03	105.3 MB	5.2%	29.94
Jan 21 18:00:00 - 18:59:59	11921	5.4%	3.31	118.5 MB	5.9%	33.70
Jan 21 19:00:00 - 19:59:59	10884	5.0%	3.02	105.2 MB	5.2%	29.93
Jan 21 20:00:00 - 20:59:59	11572	5.3%	3.21	99.1 MB	4.9%	28.20
Jan 21 21:00:00 - 21:59:59	9703	4.4%	2.70	96.8 MB	4.8%	27.53
Jan 21 22:00:00 - 22:59:59	10077	4.6%	2.80	96.1 MB	4.8%	27.34
Jan 21 23:00:00 - 23:59:59	9623	4.4%	2.67	88.6 MB	4.4%	25.20
Jan 22 00:00:00 - 00:59:59	9669	4.4%	2.69	81.8 MB	4.1%	23.26
Jan 22 01:00:00 - 01:59:59	10347	4.7%	2.87	74.2 MB	3.7%	21.11
Jan 22 02:00:00 - 02:59:59	8330	3.8%	2.31	73.1 MB	3.6%	20.79
Jan 22 03:00:00 - 03:59:59	7647	3.5%	2.12	69.7 MB	3.5%	19.81
Jan 22 04:00:00 - 04:59:59	5317	2.4%	1.48	50.5 MB	2.5%	14.37
Jan 22 05:00:00 - 05:59:59	4590	2.1%	1.27	45.5 MB	2.3%	12.93
Jan 22 06:00:00 - 06:01:01	104	0.0%	1.70	950.3 KB	0.0%	15.58
TOTAL: 24:00:00	219867	100.0%	2.54	2.0 GB	100.0%	23.92

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
C1	DEFAULT	10.0 GB	1.8 GB	17.9%	119	29.32	4.14
TOTAL: 1	-	10.0 GB	1.8 GB	17.9%	119	29.32	-

Sites sending bad articles:

Server		Total	Group	Duplic	TooOld	Other
1	hasname-out.feeder.erje.net	147810	136423	9859	1225	303
2	news.nntp4.net	334	309	5	0	20
3	usenet.blueworldhosting.com	206	160	1	0	45
4	hasname-out.news.weretis.net	139	93	26	0	20
TOTAL: 4		148489	136985	9891	1225	388

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	53072
alt.binaries.pwp	7611
alt.binaries.font	4974
alt.binaries.encrypted	4089
alt.binaries.amazing	3110
alt.binaries.u-4all	2644
alt.binaries.wtfnzb.india	2317
alt.binaries.wtfnzb.juliet	2313
alt.binaries.wtfnzb.novemeber	2292
alt.binaries.wtfnzb.echo	2286
alt.binaries.wtfnzb.mike	2276
alt.binaries.wtfnzb.foxtrot	2257
alt.binaries.wtfnzb.alpha	2253
alt.binaries.wtfnzb.bravo	2222
alt.binaries.wtfnzb.kilo	2211
alt.binaries.wtfnzb.golf	2210
alt.binaries.wtfnzb.delta	2207
alt.binaries.wtfnzb.beta	2179
alt.binaries.wtfnzb.lima	2177
alt.binaries.wtfnzb.charlie	2171
TOTAL: 216	136985

INND no permission servers:

System	Conn
103.193.138.76	30
54.36.109.115	30
165.154.23.25	27
47.251.88.12	3
147.185.133.36	2
162.216.149.110	2
167.94.146.50	2
167.94.138.35	1
185.247.137.224	1
87.236.176.221	1
TOTAL: 10	99

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	usenet.blueworldhosting.com	45
	hasname-out.feeder.erje.net	23
	hasname-out.news.weretis.net	20
	news.nntp4.net	20
	TOTAL: 4	108
No colon-space in header field
	hasname-out.feeder.erje.net	280
	TOTAL: 1	280
TOTAL: 2		388

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	268	268	0	0	0	100%	18:38:08
2	blueworldhosting	36067	91	34464	0	206	0%	23:59:47
3	weretis	9023	0	8972	44	29	0%	23:59:42
4	erje	8800	0	8797	0	73	0%	23:59:47
5	nntp4	2722	0	0	0	10854	0%	23:59:47
TOTAL: 5		56880	359	52233	44	11162	0%	114:37:11

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	983.6 KB	0.0 KB	983.6 KB	3.7 KB	18:38:08
2	blueworldhosting	683.0 KB	0.0 KB	683.0 KB	7.5 KB	23:59:47
3	erje	0.0 KB	0.0 KB	0.0 KB	0	23:59:47
4	nntp4	0.0 KB	0.0 KB	0.0 KB	0	23:59:47
5	weretis	0.0 KB	1.2 MB	1.2 MB	28.4 KB	23:59:42
TOTAL: 5		1.6 MB	1.2 MB	2.8 MB	7.2 KB	114:37:11

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
prod57client01.academyforinternetresearch.org	0.019	0.045	00:00:03
194.165.16.167	0.002	0.002	00:00:00
magical.monitoring.internet-measurement.com	0.001	0.003	00:00:00
azpdwsp3gg3p.stretchoid.com	0.001	0.007	00:00:00
o607.scanner.modat.io	0.001	0.001	00:00:00
41.125.142.162.censys-scanner.com	0.001	0.003	00:00:00
205.210.31.206	0.000	0.004	00:00:00
203.55.131.3	0.000	0.004	00:00:00
198.235.24.206	0.001	0.002	00:00:00
TOTAL: 9	0.026	0.071	00:00:04

NNRP no permission clients [Top 20]:

System	Conn
prod57client01.academyforinternetresearch.org	16
azpdwsp3gg3p.stretchoid.com	2
194.165.16.167	1
198.235.24.206	1
203.55.131.3	1
205.210.31.206	1
41.125.142.162.censys-scanner.com	1
magical.monitoring.internet-measurement.com	1
o607.scanner.modat.io	1
TOTAL: 9	25

Daily Usenet report

Jan 21 06:01:01 -- Jan 22 06:01:01