Daily Usenet report: Sep 22 06:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 22 06:01:55 kennel innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	473839	97.9%	60.3 MB	97.6%
innd	8248	1.7%	1.2 MB	2.0%
innfeed	1440	0.3%	211.5 KB	0.3%
nnrpd	154	0.0%	17.0 KB	0.0%
cnfsstat	144	0.0%	32.3 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
overchan	1	0.0%	0.2 KB	0.0%
TOTAL: 7	483827	100.0%	61.8 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	757470	44.3%
Positive hits	477796	28.0%
Do not exist	462610	27.1%
Cache misses	10632	0.6%
TOTAL: 4	1708508	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.007	0.0%	34	0.000	0.206	1.000
article cleanup	00:00:04.414	0.0%	397788	0.006	0.011	0.019
article logging	00:00:16.216	0.0%	398061	0.028	0.041	0.063
article parse	00:00:46.439	0.1%	1589518	0.009	0.029	0.043
article write	00:00:20.971	0.0%	226546	0.055	0.093	0.128
artlog/artparse	00:00:04.160	0.0%	75644	0.023	0.055	0.085
data move	00:00:03.905	0.0%	1738670	0.001	0.002	0.008
hisgrep/artcncl	00:00:00.003	0.0%	34	0.000	0.088	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:39.034	0.0%	1714648	0.002	0.023	0.257
history sync	00:00:00.030	0.0%	300	0.000	0.100	0.500
history write	00:00:31.740	0.0%	463647	0.046	0.068	0.099
idle	23:50:22.914	99.3%	1374797	21.789	62.426	114.416
nntp read	00:00:56.435	0.1%	1376598	0.021	0.041	0.057
overview write	00:00:01.271	0.0%	226546	0.000	0.006	0.011
perl filter	00:00:20.076	0.0%	389135	0.033	0.052	0.068
python filter	00:00:20.647	0.0%	389135	0.035	0.053	0.082
site send	00:00:09.612	0.0%	538539	0.011	0.018	0.104
TOTAL: 24:00:17.466	23:54:57.874	99.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.276	0.0%	85733	0.000	0.003	0.020
article prepare	00:00:00.000	0.0%	4422	0.000	0.000	0.000
article read	00:00:00.169	0.0%	1416	0.000	0.119	1.500
backlog stats	00:00:00.251	0.0%	259865	0.000	0.001	0.007
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:04.447	0.0%	166762	0.013	0.027	0.058
data write	00:00:03.851	0.0%	104841	0.015	0.037	0.082
idle	23:53:41.391	100.0%	259865	34.136	331.023	2013.611
status file	00:00:00.182	0.0%	270	0.000	0.674	2.000
TOTAL: 23:54:00.078	23:53:50.567	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%	37	0.000	0.162	1.000
TOTAL: 00:00:09.774	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	577	918792	216944	455097	246751	23%	48:23:35
2	hasname-out.news.weretis.net	3	16029	5544	10421	64	34%	52:23:03
3	news.nntp4.net	3	8990	2025	6716	249	22%	24:08:58
4	usenet.blueworldhosting.com	719	9745	1543	7964	238	15%	23:42:06
5	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 5		1303	953556	226056	480198	247302	23%	148:37:42

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	2.2 GB	96.2 MB	3.7 GB	6.0 GB	36%	13.6 KB
2	news.nntp4.net	26.0 MB	32.8 KB	1.8 MB	27.8 MB	93%	12.5 KB
3	hasname-out.news.weretis.net	14.4 MB	26.0 KB	129.9 KB	14.6 MB	98%	2.7 KB
4	usenet.blueworldhosting.com	3.1 MB	0.0 KB	1.3 MB	4.3 MB	70%	2.5 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		2.2 GB	96.2 MB	3.7 GB	6.0 GB	37%	13.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 22 06:01:01 - 06:59:59	9251	4.1%	2.61	103.2 MB	4.5%	29.85
Sep 22 07:00:00 - 07:59:59	11808	5.2%	3.28	111.8 MB	4.9%	31.80
Sep 22 08:00:00 - 08:59:59	8756	3.9%	2.43	107.8 MB	4.7%	30.66
Sep 22 09:00:00 - 09:59:59	8671	3.8%	2.41	91.4 MB	4.0%	26.00
Sep 22 10:00:00 - 10:59:59	9630	4.3%	2.67	98.5 MB	4.3%	28.01
Sep 22 11:00:00 - 11:59:59	9318	4.1%	2.59	83.7 MB	3.6%	23.82
Sep 22 12:00:00 - 12:59:59	8842	3.9%	2.46	89.3 MB	3.9%	25.40
Sep 22 13:00:00 - 13:59:59	7752	3.4%	2.15	91.8 MB	4.0%	26.11
Sep 22 14:00:00 - 14:59:59	8476	3.8%	2.35	89.5 MB	3.9%	25.47
Sep 22 15:00:00 - 15:59:59	6211	2.7%	1.73	61.8 MB	2.7%	17.58
Sep 22 16:00:00 - 16:59:59	6618	2.9%	1.84	64.3 MB	2.8%	18.28
Sep 22 17:00:00 - 17:59:59	9551	4.2%	2.65	111.3 MB	4.8%	31.65
Sep 22 18:00:00 - 18:59:59	8149	3.6%	2.26	86.6 MB	3.8%	24.64
Sep 22 19:00:00 - 19:59:59	9242	4.1%	2.57	83.7 MB	3.6%	23.80
Sep 22 20:00:00 - 20:59:59	9910	4.4%	2.75	100.0 MB	4.3%	28.43
Sep 22 21:00:00 - 21:59:59	9282	4.1%	2.58	103.4 MB	4.5%	29.42
Sep 22 22:00:00 - 22:59:59	7527	3.3%	2.09	75.1 MB	3.3%	21.36
Sep 22 23:00:00 - 23:59:59	26526	11.7%	7.37	161.4 MB	7.0%	45.90
Sep 23 00:00:00 - 00:59:59	7104	3.1%	1.97	90.6 MB	3.9%	25.76
Sep 23 01:00:00 - 01:59:59	8762	3.9%	2.43	109.3 MB	4.8%	31.10
Sep 23 02:00:00 - 02:59:59	8673	3.8%	2.41	97.9 MB	4.3%	27.86
Sep 23 03:00:00 - 03:59:59	7831	3.5%	2.18	87.4 MB	3.8%	24.87
Sep 23 04:00:00 - 04:59:59	7652	3.4%	2.13	90.5 MB	3.9%	25.73
Sep 23 05:00:00 - 05:59:59	10386	4.6%	2.88	110.6 MB	4.8%	31.45
Sep 23 06:00:00 - 06:01:02	95	0.0%	1.53	835.1 KB	0.0%	13.47
TOTAL: 24:00:01	226023	100.0%	2.62	2.2 GB	100.0%	27.28

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
C1	DEFAULT	10.0 GB	1.2 GB	12.3%	83	32.79	3.70
TOTAL: 1	-	10.0 GB	1.2 GB	12.3%	83	32.79	-

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	hasname-out.feeder.erje.net	247196	162678	8680	31	75807
2	news.nntp4.net	311	239	5	0	67
3	usenet.blueworldhosting.com	251	238	0	0	13
4	hasname-out.news.weretis.net	58	48	2	0	8
TOTAL: 4		247816	163203	8687	31	75895

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	39994
alt.binaries.encryptnzb.echo	5112
alt.binaries.encryptnzb.charlie	5090
alt.binaries.encryptnzb.hotel	5088
alt.binaries.encryptnzb.golf	5074
alt.binaries.encryptnzb.kilo	5058
alt.binaries.encryptnzb.delta	5053
alt.binaries.encryptnzb.novemeber	5050
alt.binaries.encryptnzb.beta	5031
alt.binaries.encryptnzb.juliet	5023
alt.binaries.encryptnzb.foxtrot	5013
alt.binaries.encryptnzb.india	5013
alt.binaries.encryptnzb.bravo	4981
alt.binaries.encryptnzb.alpha	4913
alt.binaries.encryptnzb.lima	4857
alt.binaries.encryptnzb.mike	4832
alt.binaries.encrypted	4085
alt.binaries.fta	2171
alt.binaries.wtfnzb.delta	1689
alt.binaries.wtfnzb.juliet	1665
TOTAL: 223	163203

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

Groups	Count
alt.binaries.whitburn	31
TOTAL: 1	31

INND no permission servers:

System	Conn
103.193.138.76	30
147.185.132.2	2
162.216.149.134	2
162.216.150.33	2
199.45.154.146	2
162.142.125.202	1
185.247.137.236	1
79.124.49.210	1
87.236.176.241	1
TOTAL: 9	42

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	185
	news.nntp4.net	67
	usenet.blueworldhosting.com	13
	hasname-out.news.weretis.net	8
	TOTAL: 4	273
No colon-space in header field
	hasname-out.feeder.erje.net	404
	TOTAL: 1	404
TOTAL: 3		683

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	415	415	0	0	0	100%	22:13:05
2	blueworldhosting	84794	192	83420	0	264	0%	23:59:53
3	erje	8130	1	8103	0	61	0%	23:59:55
4	nntp4	8009	0	8005	0	41	0%	23:59:56
5	weretis	4187	0	3375	809	7	0%	23:59:54
TOTAL: 5		105535	608	102903	809	373	0%	118:12:43

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	bbsgslincom	1.4 MB	0.0 KB	1.4 MB	0.0 KB/s	3.5 KB	22:13:05
2	blueworldhosting	898.0 KB	0.0 KB	898.0 KB	0.0 KB/s	4.7 KB	23:59:53
3	erje	3.7 KB	0.0 KB	3.7 KB	0.0 KB/s	3.7 KB	23:59:55
4	nntp4	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
5	weretis	0.0 KB	22.3 MB	22.3 MB	0.3 KB/s	28.2 KB	23:59:54
TOTAL: 5		2.3 MB	22.3 MB	24.6 MB	0.1 KB/s	17.8 KB	118:12:43

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
172-232-159-13.ip.linodeusercontent.com	0.022	0.051	00:00:06
zl-dfwc-us-gp1-wk109d.internet-census.org	0.003	0.011	00:00:01
zl-dfwc-us-gp1-wk109a.internet-census.org	0.004	0.012	00:00:00
zl-dfwc-us-gp1-wk109c.internet-census.org	0.002	0.006	00:00:00
optimal.monitoring.internet-measurement.com	0.001	0.003	00:00:00
zl-dfwc-us-gp1-wk109b.internet-census.org	0.005	0.004	00:00:00
162.142.125.201	0.000	0.005	00:00:00
20.29.58.2	0.002	0.006	00:00:00
205.210.31.134	0.000	0.004	00:00:00
205.210.31.174	0.001	0.002	00:00:00
198.235.24.71	0.002	0.002	00:00:00
TOTAL: 11	0.042	0.106	00:00:09

NNRP no permission clients [Top 20]:

System	Conn
172-232-159-13.ip.linodeusercontent.com	19
zl-dfwc-us-gp1-wk109a.internet-census.org	4
zl-dfwc-us-gp1-wk109d.internet-census.org	3
20.29.58.2	2
zl-dfwc-us-gp1-wk109b.internet-census.org	2
zl-dfwc-us-gp1-wk109c.internet-census.org	2
162.142.125.201	1
198.235.24.71	1
205.210.31.134	1
205.210.31.174	1
optimal.monitoring.internet-measurement.com	1
TOTAL: 11	37

Daily Usenet report

Sep 22 06:01:01 -- Sep 23 06:01:02