Daily Usenet report: Sep 3 06:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 3 06:02:01 kennel innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	821738	98.7%	106.5 MB	98.4%
innd	9305	1.1%	1.4 MB	1.3%
innfeed	1493	0.2%	226.4 KB	0.2%
nnrpd	223	0.0%	25.0 KB	0.0%
cnfsstat	144	0.0%	21.4 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	832905	100.0%	108.2 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	833411	49.6%
Do not exist	820725	48.9%
Positive hits	23746	1.4%
Cache misses	915	0.1%
TOTAL: 4	1678797	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.014	0.0%	61	0.000	0.230	1.000
article cleanup	00:00:08.079	0.0%	821851	0.006	0.010	0.020
article logging	00:00:29.676	0.0%	821940	0.015	0.036	0.052
article parse	00:00:40.608	0.0%	2114051	0.007	0.019	0.025
article write	00:00:53.744	0.1%	667386	0.034	0.081	0.137
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:05.744	0.0%	2009572	0.001	0.003	0.007
hisgrep/artcncl	00:00:00.001	0.0%	61	0.000	0.016	0.059
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:34.386	0.0%	1683016	0.001	0.020	0.416
history sync	00:00:00.025	0.0%	291	0.000	0.086	1.000
history write	00:00:45.124	0.1%	821848	0.026	0.055	0.076
idle	23:49:18.132	99.2%	1496053	26.056	57.323	114.635
nntp read	00:01:00.324	0.1%	1498836	0.017	0.040	0.065
overview write	00:00:03.487	0.0%	667386	0.002	0.005	0.009
perl filter	00:00:39.249	0.0%	821848	0.016	0.048	0.078
python filter	00:00:38.430	0.0%	821848	0.022	0.047	0.070
site send	00:00:31.276	0.0%	1808472	0.011	0.017	0.106
TOTAL: 24:00:17.765	23:55:48.299	99.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:01.525	0.0%	472658	0.001	0.003	0.010
article prepare	00:00:00.000	0.0%	430	0.000	0.000	0.000
article read	00:00:00.026	0.0%	304	0.000	0.086	1.000
backlog stats	00:00:01.016	0.0%	1241118	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:18.543	0.0%	768547	0.010	0.024	0.040
data write	00:00:13.229	0.0%	478032	0.006	0.028	0.066
idle	23:49:43.530	99.9%	1241118	23.294	69.118	232.106
status file	00:00:00.203	0.0%	309	0.000	0.657	1.333
TOTAL: 23:50:44.765	23:50:18.072	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.006	0.1%	54	0.000	0.111	1.000
TOTAL: 00:00:09.776	00:00:00.006	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	288	821447	660947	6853	153647	80%	31:44:11
2	hasname-out.news.weretis.net	3	11438	3472	7894	72	30%	51:16:47
3	news.nntp4.net	2	6874	1629	4774	471	23%	23:57:59
4	usenet.blueworldhosting.com	711	7132	1156	5572	404	16%	23:46:59
5	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 5		1005	846891	667204	25093	154594	78%	130:45:56

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	5.0 GB	0.0 KB	1.1 GB	6.1 GB	81%	7.9 KB
2	hasname-out.news.weretis.net	9.5 MB	13.0 KB	140.8 KB	9.6 MB	98%	2.8 KB
3	news.nntp4.net	4.5 MB	8.2 KB	4.9 MB	9.4 MB	47%	4.6 KB
4	usenet.blueworldhosting.com	2.7 MB	8.3 KB	1.0 MB	3.7 MB	72%	2.4 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		5.0 GB	29.5 KB	1.1 GB	6.2 GB	81%	7.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 3 06:01:01 - 06:59:59	21894	3.3%	6.19	170.4 MB	3.3%	49.32
Sep 3 07:00:00 - 07:59:59	20888	3.1%	5.80	165.5 MB	3.2%	47.09
Sep 3 08:00:00 - 08:59:59	19328	2.9%	5.37	155.5 MB	3.0%	44.23
Sep 3 09:00:00 - 09:59:59	15388	2.3%	4.27	135.5 MB	2.6%	38.53
Sep 3 10:00:00 - 10:59:59	32731	4.9%	9.09	165.7 MB	3.2%	47.14
Sep 3 11:00:00 - 11:59:59	24105	3.6%	6.70	197.1 MB	3.8%	56.08
Sep 3 12:00:00 - 12:59:59	22934	3.4%	6.37	185.4 MB	3.6%	52.74
Sep 3 13:00:00 - 13:59:59	39216	5.9%	10.89	223.5 MB	4.4%	63.56
Sep 3 14:00:00 - 14:59:59	22853	3.4%	6.35	206.3 MB	4.0%	58.68
Sep 3 15:00:00 - 15:59:59	26810	4.0%	7.45	240.7 MB	4.7%	68.47
Sep 3 16:00:00 - 16:59:59	24517	3.7%	6.81	175.8 MB	3.4%	50.01
Sep 3 17:00:00 - 17:59:59	26600	4.0%	7.39	184.8 MB	3.6%	52.57
Sep 3 18:00:00 - 18:59:59	22512	3.4%	6.25	172.2 MB	3.4%	48.97
Sep 3 19:00:00 - 19:59:59	17785	2.7%	4.94	158.0 MB	3.1%	44.94
Sep 3 20:00:00 - 20:59:59	20806	3.1%	5.78	196.4 MB	3.8%	55.85
Sep 3 21:00:00 - 21:59:59	18326	2.7%	5.09	156.5 MB	3.0%	44.51
Sep 3 22:00:00 - 22:59:59	28580	4.3%	7.94	197.1 MB	3.8%	56.08
Sep 3 23:00:00 - 23:59:59	57799	8.7%	16.06	357.8 MB	7.0%	101.76
Sep 4 00:00:00 - 00:59:59	45859	6.9%	12.74	363.6 MB	7.1%	103.42
Sep 4 01:00:00 - 01:59:59	26060	3.9%	7.24	237.6 MB	4.6%	67.59
Sep 4 02:00:00 - 02:59:59	46500	7.0%	12.92	311.1 MB	6.1%	88.48
Sep 4 03:00:00 - 03:59:59	22192	3.3%	6.16	247.7 MB	4.8%	70.44
Sep 4 04:00:00 - 04:59:59	38005	5.7%	10.56	283.9 MB	5.5%	80.74
Sep 4 05:00:00 - 05:59:59	24922	3.7%	6.92	242.1 MB	4.7%	68.85
Sep 4 06:00:00 - 06:01:02	450	0.1%	7.26	2.7 MB	0.1%	44.11
TOTAL: 24:00:01	667060	100.0%	7.72	5.0 GB	100.0%	60.83

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
C1	DEFAULT	10.0 GB	113.2 MB	1.1%	172	76.98	1.58
TOTAL: 1	-	10.0 GB	113.2 MB	1.1%	172	76.98	-

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	hasname-out.feeder.erje.net	153694	153649	0	0	45
2	news.nntp4.net	470	461	1	0	8
3	usenet.blueworldhosting.com	404	402	1	1	0
4	hasname-out.news.weretis.net	110	73	1	0	36
TOTAL: 4		154678	154585	3	1	89

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	94424
alt.binaries.encrypted	3414
alt.binaries.amazing	2862
alt.binaries.u-4all	2721
alt.binaries.storage	2060
alt.binaries.flowed	2034
alt.binaries.font	1578
alt.binaries.u4e	1430
alt.binaries.bungabunga	1407
alt.binaries.ath	1280
alt.binaries.wtfnzb.novemeber	1278
alt.binaries.wtfnzb.beta	1255
alt.binaries.wtfnzb.alpha	1236
alt.binaries.wtfnzb.bravo	1229
alt.binaries.wtfnzb.golf	1225
alt.binaries.wtfnzb.delta	1220
alt.binaries.wtfnzb.juliet	1217
alt.binaries.wtfnzb.hotel	1214
alt.binaries.wtfnzb.kilo	1209
alt.binaries.wtfnzb.echo	1207
TOTAL: 171	154585

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

Groups	Count
soc.culture.hawaii	1
TOTAL: 1	1

INND no permission servers:

System	Conn
103.193.138.76	30
8.209.96.38	3
66.132.195.71	1
85.217.149.1	1
85.217.149.22	1
85.217.149.58	1
87.251.64.23	1
91.231.89.81	1
91.231.89.86	1
TOTAL: 9	40

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	hasname-out.feeder.erje.net	15
	TOTAL: 1	15
Including strange strings
	hasname-out.feeder.erje.net	45
	hasname-out.news.weretis.net	36
	news.nntp4.net	8
	TOTAL: 3	89
TOTAL: 2		104

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	263	263	0	0	0	100%	17:47:04
2	blueworldhosting	473907	36	471367	1	1608	0%	23:59:54
3	erje	5533	0	5523	0	0	0%	23:58:31
4	nntp4	4623	0	4623	0	0	0%	23:59:55
5	weretis	2802	0	2797	5	0	0%	23:59:55
TOTAL: 5		487128	299	484310	6	1608	0%	113:45:19

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	815.7 KB	0.0 KB	815.7 KB	3.1 KB	17:47:04
2	blueworldhosting	290.8 KB	18.5 KB	309.3 KB	8.4 KB	23:59:54
3	erje	0.0 KB	0.0 KB	0.0 KB	0	23:58:31
4	nntp4	0.0 KB	0.0 KB	0.0 KB	0	23:59:55
5	weretis	0.0 KB	13.9 KB	13.9 KB	2.8 KB	23:59:55
TOTAL: 5		1.1 MB	32.4 KB	1.1 MB	3.7 KB	113:45:19

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
prod56client01.academyforinternetresearch.org	0.017	0.052	00:00:03
prod16tokyo.academyforinternetresearch.org	0.015	0.048	00:00:02
hammond.probe.onyphe.net	0.002	0.003	00:00:00
172-239-64-86.ip.linodeusercontent.com	0.002	0.006	00:00:00
karina.probe.onyphe.net	0.002	0.002	00:00:00
154-16-44-41.infrawat.ch	0.002	0.003	00:00:00
43.98.166.170	0.002	0.009	00:00:00
194-88-98-126.infrawat.ch	0.001	0.003	00:00:00
56.146.94.167.censys-scanner.com	0.003	0.008	00:00:00
93.123.109.120	0.000	0.004	00:00:00
45-33-14-197.ip.linodeusercontent.com	0.000	0.004	00:00:00
87.251.64.23	0.002	0.002	00:00:00
o025.scanner.modat.io	0.001	0.003	00:00:00
45-33-109-18.ip.linodeusercontent.com	0.000	0.004	00:00:00
205.210.31.246	0.000	0.004	00:00:00
o058.scanner.modat.io	0.001	0.003	00:00:00
o008.scanner.modat.io	0.000	0.004	00:00:00
o023.scanner.modat.io	0.001	0.003	00:00:00
205.210.31.199	0.001	0.003	00:00:00
TOTAL: 19	0.052	0.168	00:00:09

NNRP no permission clients [Top 20]:

System	Conn
prod16tokyo.academyforinternetresearch.org	16
prod56client01.academyforinternetresearch.org	16
43.98.166.170	3
56.146.94.167.censys-scanner.com	3
172-239-64-86.ip.linodeusercontent.com	2
154-16-44-41.infrawat.ch	1
194-88-98-126.infrawat.ch	1
205.210.31.199	1
205.210.31.246	1
45-33-109-18.ip.linodeusercontent.com	1
45-33-14-197.ip.linodeusercontent.com	1
87.251.64.23	1
93.123.109.120	1
hammond.probe.onyphe.net	1
karina.probe.onyphe.net	1
o008.scanner.modat.io	1
o023.scanner.modat.io	1
o025.scanner.modat.io	1
o058.scanner.modat.io	1
TOTAL: 19	54

Daily Usenet report

Sep 3 06:01:01 -- Sep 4 06:01:02