Daily Usenet report: Dec 15 06:01:01

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Dec 15 06:02:20 kennel innd: message repeated 2 times: [ ctlinnd command s]
Dec 15 13:48:10 kennel innfeed[1205159]: nntp4:0 connect: Network is unreachable
Dec 15 14:04:10 kennel innfeed[1205159]: nntp4:0 connect: Network is unreachable
Dec 15 20:37:01 kennel innd: message repeated 2 times: [ 101.36.107.83 rejected 502]
Dec 15 20:37:09 kennel innd: message repeated 2 times: [ 101.36.107.83 rejected 502]
Dec 15 20:37:24 kennel innd: message repeated 5 times: [ 101.36.107.83 rejected 502]
Dec 15 20:37:40 kennel innd: message repeated 5 times: [ 101.36.107.83 rejected 502]
Dec 15 20:37:50 kennel innd: message repeated 3 times: [ 101.36.107.83 rejected 502]
Dec 15 20:38:00 kennel innd: message repeated 2 times: [ 101.36.107.83 rejected 502]
Dec 15 20:38:26 kennel innd: message repeated 7 times: [ 101.36.107.83 rejected 502]
Dec 15 20:38:37 kennel innd: message repeated 3 times: [ 101.36.107.83 rejected 502]
Dec 15 20:38:55 kennel innd: message repeated 6 times: [ 101.36.107.83 rejected 502]
Dec 15 20:39:21 kennel innd: message repeated 7 times: [ 101.36.107.83 rejected 502]
Dec 15 20:39:28 kennel innd: message repeated 2 times: [ 101.36.107.83 rejected 502]
Dec 15 20:39:41 kennel innd: message repeated 4 times: [ 101.36.107.83 rejected 502]
Dec 15 20:39:54 kennel innd: message repeated 3 times: [ 101.36.107.83 rejected 502]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	483767	94.4%	57.5 MB	94.0%
innfeed	19747	3.9%	2.2 MB	3.7%
innd	8800	1.7%	1.4 MB	2.3%
cnfsstat	144	0.0%	22.0 KB	0.0%
nnrpd	44	0.0%	5.3 KB	0.0%
overchan	2	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	512505	100.0%	61.2 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	772641	45.0%
Do not exist	470136	27.4%
Positive hits	465067	27.1%
Cache misses	9134	0.5%
TOTAL: 4	1716978	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.001	0.0%	27	0.000	0.037	1.000
article cleanup	00:00:05.292	0.0%	483207	0.006	0.011	0.017
article logging	00:00:18.670	0.0%	483293	0.025	0.039	0.055
article parse	00:00:29.262	0.0%	1451204	0.007	0.020	0.026
article write	00:00:33.286	0.0%	349547	0.051	0.095	0.119
artlog/artparse	00:00:00.031	0.0%	569	0.000	0.054	1.000
data move	00:00:03.065	0.0%	1589594	0.000	0.002	0.006
hisgrep/artcncl	00:00:00.000	0.0%	27	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:29.566	0.0%	1725112	0.002	0.017	0.363
history sync	00:00:00.018	0.0%	311	0.000	0.058	0.500
history write	00:00:29.186	0.0%	472048	0.031	0.062	0.085
idle	23:51:13.609	99.4%	1216072	27.050	70.616	132.912
nntp read	00:00:47.174	0.1%	1217706	0.022	0.039	0.051
overview write	00:00:01.894	0.0%	349547	0.002	0.005	0.011
perl filter	00:00:24.509	0.0%	471491	0.028	0.052	0.073
python filter	00:00:24.387	0.0%	471491	0.030	0.052	0.068
site send	00:00:13.045	0.0%	741285	0.010	0.018	0.130
TOTAL: 24:00:24.777	23:55:32.995	99.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.154	0.0%	44787	0.000	0.003	0.018
article prepare	00:00:00.000	0.0%	733	0.000	0.000	0.000
article read	00:00:00.044	0.0%	514	0.000	0.086	1.000
backlog stats	00:00:00.133	0.0%	157759	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.499	0.0%	95444	0.009	0.026	0.060
data write	00:00:02.628	0.0%	62422	0.018	0.042	0.079
idle	23:56:02.760	100.0%	157759	76.620	546.167	1340.144
status file	00:00:05.912	0.0%	7986	0.000	0.740	3.070
TOTAL: 23:56:23.623	23:56:14.130	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%	10	0.000	0.200	1.000
TOTAL: 00:00:01.416	00:00:00.002	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	593	915204	341643	439656	133905	37%	52:26:09
2	hasname-out.news.weretis.net	3	16099	4546	11472	81	28%	46:18:04
3	usenet.blueworldhosting.com	719	9553	1673	7764	116	17%	23:42:24
4	news.nntp4.net	2	6610	1559	4874	177	23%	23:59:52
5	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 5		1318	947466	349421	463766	134279	36%	146:26:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	3.5 GB	129.6 MB	1.2 GB	4.8 GB	72%	10.7 KB
2	hasname-out.news.weretis.net	9.9 MB	10.9 KB	165.2 KB	10.1 MB	98%	2.2 KB
3	news.nntp4.net	6.2 MB	1.1 KB	1.5 MB	7.7 MB	80%	4.5 KB
4	usenet.blueworldhosting.com	3.1 MB	0.0 KB	606.6 KB	3.7 MB	84%	2.1 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		3.5 GB	129.6 MB	1.2 GB	4.9 GB	72%	10.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 15 06:01:01 - 06:59:59	18302	5.2%	5.17	211.3 MB	5.8%	61.15
Dec 15 07:00:00 - 07:59:59	19073	5.5%	5.30	201.5 MB	5.6%	57.32
Dec 15 08:00:00 - 08:59:59	20023	5.7%	5.56	212.8 MB	5.9%	60.52
Dec 15 09:00:00 - 09:59:59	18974	5.4%	5.27	193.5 MB	5.3%	55.05
Dec 15 10:00:00 - 10:59:59	19398	5.6%	5.39	197.9 MB	5.5%	56.29
Dec 15 11:00:00 - 11:59:59	15100	4.3%	4.19	150.8 MB	4.2%	42.89
Dec 15 12:00:00 - 12:59:59	10903	3.1%	3.03	116.9 MB	3.2%	33.25
Dec 15 13:00:00 - 13:59:59	8668	2.5%	2.41	103.3 MB	2.8%	29.40
Dec 15 14:00:00 - 14:59:59	12632	3.6%	3.51	115.5 MB	3.2%	32.84
Dec 15 15:00:00 - 15:59:59	11533	3.3%	3.20	110.3 MB	3.0%	31.38
Dec 15 16:00:00 - 16:59:59	11910	3.4%	3.31	121.8 MB	3.4%	34.65
Dec 15 17:00:00 - 17:59:59	8981	2.6%	2.49	97.0 MB	2.7%	27.58
Dec 15 18:00:00 - 18:59:59	8036	2.3%	2.23	87.6 MB	2.4%	24.91
Dec 15 19:00:00 - 19:59:59	8810	2.5%	2.45	102.3 MB	2.8%	29.10
Dec 15 20:00:00 - 20:59:59	10784	3.1%	3.00	108.8 MB	3.0%	30.95
Dec 15 21:00:00 - 21:59:59	11497	3.3%	3.19	134.5 MB	3.7%	38.25
Dec 15 22:00:00 - 22:59:59	13433	3.8%	3.73	141.1 MB	3.9%	40.12
Dec 15 23:00:00 - 23:59:59	13208	3.8%	3.67	134.9 MB	3.7%	38.38
Dec 16 00:00:00 - 00:59:59	14068	4.0%	3.91	128.1 MB	3.5%	36.44
Dec 16 01:00:00 - 01:59:59	14707	4.2%	4.09	125.0 MB	3.4%	35.56
Dec 16 02:00:00 - 02:59:59	19215	5.5%	5.34	171.3 MB	4.7%	48.73
Dec 16 03:00:00 - 03:59:59	19795	5.7%	5.50	220.6 MB	6.1%	62.74
Dec 16 04:00:00 - 04:59:59	21095	6.0%	5.86	223.4 MB	6.2%	63.55
Dec 16 05:00:00 - 05:59:59	18777	5.4%	5.22	211.7 MB	5.8%	60.23
Dec 16 06:00:00 - 06:01:01	479	0.1%	7.85	6.3 MB	0.2%	105.83
TOTAL: 24:00:00	349401	100.0%	4.04	3.5 GB	100.0%	43.00

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
C1	DEFAULT	10.0 GB	4.0 GB	40.2%	106	50.43	2.41
TOTAL: 1	-	10.0 GB	4.0 GB	40.2%	106	50.43	-

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	hasname-out.feeder.erje.net	133927	121629	11701	2	595
2	news.nntp4.net	201	176	1	0	24
3	usenet.blueworldhosting.com	134	114	0	2	18
4	hasname-out.news.weretis.net	104	76	10	0	18
TOTAL: 4		134366	121995	11712	4	655

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	50116
alt.binaries.pwp	6439
alt.binaries.encrypted	3520
alt.binaries.font	2864
alt.binaries.wtfnzb.mike	2041
alt.binaries.wtfnzb.alpha	2015
alt.binaries.ath	2004
alt.binaries.wtfnzb.india	2002
alt.binaries.wtfnzb.charlie	1998
alt.binaries.wtfnzb.foxtrot	1993
alt.binaries.wtfnzb.golf	1983
alt.binaries.wtfnzb.juliet	1981
alt.binaries.wtfnzb.hotel	1975
alt.binaries.wtfnzb.echo	1973
alt.binaries.wtfnzb.beta	1945
alt.binaries.wtfnzb.kilo	1934
alt.binaries.wtfnzb.lima	1906
alt.binaries.wtfnzb.delta	1898
alt.binaries.wtfnzb.novemeber	1898
alt.binaries.wtfnzb.bravo	1889
TOTAL: 233	121995

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

Groups	Count
uk.legal.moderated	4
TOTAL: 1	4

INND no permission servers:

System	Conn
103.193.138.76	30
101.36.107.83	21
147.185.133.19	3
145.239.2.227	2
162.216.150.179	2
66.228.53.78	2
162.142.125.41	1
TOTAL: 7	61

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	hasname-out.feeder.erje.net	8
	TOTAL: 1	8
Including strange strings
	hasname-out.feeder.erje.net	26
	news.nntp4.net	24
	hasname-out.news.weretis.net	18
	usenet.blueworldhosting.com	18
	TOTAL: 4	86
No colon-space in header field
	hasname-out.feeder.erje.net	568
	TOTAL: 1	568
TOTAL: 3		662

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	443	443	0	0	0	100%	21:01:30
2	blueworldhosting	42202	69	40066	0	17	0%	23:59:54
3	erje	7385	0	7383	1	1	0%	23:59:54
4	weretis	4176	0	4172	3	0	0%	23:59:54
5	nntp4	2629	0	0	0	10214	0%	23:59:54
TOTAL: 5		56835	512	51621	4	10232	0%	117:01:06

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	1.7 MB	0.0 KB	1.7 MB	3.9 KB	21:01:30
2	blueworldhosting	524.9 KB	0.0 KB	524.9 KB	7.6 KB	23:59:54
3	erje	0.0 KB	46.0 KB	46.0 KB	46.0 KB	23:59:54
4	nntp4	0.0 KB	0.0 KB	0.0 KB	0	23:59:54
5	weretis	0.0 KB	128.8 KB	128.8 KB	42.9 KB	23:59:54
TOTAL: 5		2.2 MB	174.8 KB	2.4 MB	4.7 KB	117:01:06

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
illustrious.monitoring.internet-measurement.com	0.000	0.004	00:00:00
ns3096158.ip-145-239-2.eu	0.001	0.003	00:00:00
45.227.254.152	0.001	0.003	00:00:00
45-33-109-8.ip.linodeusercontent.com	0.001	0.003	00:00:00
47.251.92.52	0.000	0.002	00:00:00
scanner-06.ch1.censys-scanner.com	0.000	0.004	00:00:00
205.210.31.141	0.000	0.001	00:00:00
azpdsgigumtz.stretchoid.com	0.004	0.005	00:00:00
198.235.24.141	0.001	0.000	00:00:00
TOTAL: 9	0.008	0.025	00:00:01

NNRP no permission clients [Top 20]:

System	Conn
azpdsgigumtz.stretchoid.com	2
198.235.24.141	1
205.210.31.141	1
45-33-109-8.ip.linodeusercontent.com	1
45.227.254.152	1
47.251.92.52	1
illustrious.monitoring.internet-measurement.com	1
ns3096158.ip-145-239-2.eu	1
scanner-06.ch1.censys-scanner.com	1
TOTAL: 9	10

Daily Usenet report

Dec 15 06:01:01 -- Dec 16 06:01:01