Daily Usenet report: Aug 12 06:01:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Aug 12 06:01:55 kennel innd: message repeated 2 times: [ ctlinnd command s]
Aug 12 20:00:03 kennel pgpverify[3323775]: pgpverify: verification failed
Aug 12 20:00:08 kennel pgpverify[3323825]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	475306	97.9%	62.9 MB	97.6%
innd	8576	1.8%	1.3 MB	2.0%
innfeed	1366	0.3%	208.3 KB	0.3%
cnfsstat	144	0.0%	25.5 KB	0.0%
nnrpd	101	0.0%	10.5 KB	0.0%
controlchan	3	0.0%	0.2 KB	0.0%
pgpverify	2	0.0%	0.3 KB	0.0%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 8	485499	100.0%	64.5 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	723998	43.1%
Positive hits	474200	28.3%
Do not exist	466795	27.8%
Cache misses	13229	0.8%
TOTAL: 4	1678222	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.017	0.0%	83	0.000	0.205	1.000
article cleanup	00:00:05.113	0.0%	476103	0.007	0.011	0.020
article logging	00:00:18.622	0.0%	476280	0.021	0.039	0.052
article parse	00:00:28.040	0.0%	1350381	0.010	0.021	0.027
article write	00:00:24.511	0.0%	259581	0.055	0.094	0.127
artlog/artparse	00:00:00.026	0.0%	546	0.000	0.048	1.000
data move	00:00:02.702	0.0%	1365255	0.001	0.002	0.005
hisgrep/artcncl	00:00:00.008	0.0%	83	0.000	0.096	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:39.327	0.0%	1688874	0.003	0.023	0.155
history sync	00:00:00.027	0.0%	314	0.000	0.086	1.000
history write	00:00:28.157	0.0%	468778	0.045	0.060	0.078
idle	23:54:34.245	99.6%	1081067	25.491	79.620	241.695
nntp read	00:00:42.352	0.0%	1082720	0.022	0.039	0.062
overview write	00:00:01.405	0.0%	259581	0.002	0.005	0.010
perl filter	00:00:23.475	0.0%	468241	0.032	0.050	0.080
python filter	00:00:23.065	0.0%	468241	0.037	0.049	0.072
site send	00:00:12.211	0.0%	778745	0.011	0.016	0.083
TOTAL: 24:00:24.176	23:58:43.303	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.940	0.0%	258521	0.000	0.004	0.009
article prepare	00:00:00.002	0.0%	4128	0.000	0.000	0.200
article read	00:00:00.159	0.0%	1357	0.000	0.117	0.667
backlog stats	00:00:00.657	0.0%	720524	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:12.503	0.0%	454171	0.011	0.028	0.050
data write	00:00:08.156	0.0%	276774	0.013	0.029	0.054
idle	23:51:22.610	100.0%	720524	52.391	119.195	299.042
status file	00:00:00.147	0.0%	234	0.000	0.628	2.000
TOTAL: 23:52:04.990	23:51:45.174	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%	21	0.000	0.095	1.000
TOTAL: 00:01:08.864	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
reserve	2
TOTAL: 10	167

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
group-admin@isc.org	0	0	0	2	0	0
TOTAL	0	0	0	2	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.feeder.erje.net	577	926836	251560	460283	214993	27%	49:02:51
2	hasname-out.news.weretis.net	4	12635	4991	7613	31	39%	54:41:14
3	news.nntp4.net	3	9093	1997	6851	245	21%	23:58:44
4	usenet.blueworldhosting.com	720	8295	1323	6768	204	15%	23:43:14
5	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 5		1305	956859	259871	481515	215473	27%	151:26:03

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	2.6 GB	75.7 MB	1.6 GB	4.3 GB	60%	9.7 KB
2	news.nntp4.net	33.5 MB	46.2 KB	2.6 MB	36.1 MB	92%	16.5 KB
3	hasname-out.news.weretis.net	13.8 MB	50.5 KB	52.5 KB	13.9 MB	99%	2.8 KB
4	usenet.blueworldhosting.com	2.6 MB	0.0 KB	1.4 MB	4.1 MB	64%	2.7 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		2.7 GB	75.8 MB	1.6 GB	4.4 GB	60%	9.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 12 06:01:01 - 06:59:59	7874	3.0%	2.22	82.4 MB	3.0%	23.85
Aug 12 07:00:00 - 07:59:59	11015	4.2%	3.06	115.9 MB	4.2%	32.97
Aug 12 08:00:00 - 08:59:59	16300	6.3%	4.53	178.6 MB	6.5%	50.80
Aug 12 09:00:00 - 09:59:59	16368	6.3%	4.55	190.8 MB	7.0%	54.29
Aug 12 10:00:00 - 10:59:59	14446	5.6%	4.01	146.3 MB	5.3%	41.63
Aug 12 11:00:00 - 11:59:59	17109	6.6%	4.75	185.4 MB	6.8%	52.73
Aug 12 12:00:00 - 12:59:59	12693	4.9%	3.53	131.7 MB	4.8%	37.46
Aug 12 13:00:00 - 13:59:59	13400	5.2%	3.72	142.8 MB	5.2%	40.63
Aug 12 14:00:00 - 14:59:59	16622	6.4%	4.62	191.9 MB	7.0%	54.58
Aug 12 15:00:00 - 15:59:59	12400	4.8%	3.44	155.8 MB	5.7%	44.30
Aug 12 16:00:00 - 16:59:59	11335	4.4%	3.15	135.2 MB	4.9%	38.45
Aug 12 17:00:00 - 17:59:59	12113	4.7%	3.36	93.9 MB	3.4%	26.72
Aug 12 18:00:00 - 18:59:59	10186	3.9%	2.83	104.0 MB	3.8%	29.59
Aug 12 19:00:00 - 19:59:59	8437	3.2%	2.34	89.1 MB	3.3%	25.34
Aug 12 20:00:00 - 20:59:59	12528	4.8%	3.48	106.7 MB	3.9%	30.36
Aug 12 21:00:00 - 21:59:59	8399	3.2%	2.33	93.7 MB	3.4%	26.65
Aug 12 22:00:00 - 22:59:59	7634	2.9%	2.12	71.7 MB	2.6%	20.39
Aug 12 23:00:00 - 23:59:59	6395	2.5%	1.78	70.3 MB	2.6%	19.99
Aug 13 00:00:00 - 00:59:59	7622	2.9%	2.12	65.8 MB	2.4%	18.71
Aug 13 01:00:00 - 01:59:59	7286	2.8%	2.02	70.8 MB	2.6%	20.15
Aug 13 02:00:00 - 02:59:59	7230	2.8%	2.01	79.5 MB	2.9%	22.62
Aug 13 03:00:00 - 03:59:59	7035	2.7%	1.95	68.8 MB	2.5%	19.58
Aug 13 04:00:00 - 04:59:59	7509	2.9%	2.09	77.1 MB	2.8%	21.93
Aug 13 05:00:00 - 05:59:59	7645	2.9%	2.12	87.0 MB	3.2%	24.74
Aug 13 06:00:00 - 06:01:01	64	0.0%	1.05	394.1 KB	0.0%	6.46
TOTAL: 24:00:00	259645	100.0%	3.01	2.7 GB	100.0%	32.42

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
C1	DEFAULT	10.0 GB	8.5 GB	85.3%	70	38.72	3.13
TOTAL: 1	-	10.0 GB	8.5 GB	85.3%	70	38.72	-

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	hasname-out.feeder.erje.net	215103	206629	7821	1	652
2	news.nntp4.net	306	248	1	0	57
3	usenet.blueworldhosting.com	214	204	0	0	10
4	hasname-out.news.weretis.net	38	28	2	0	8
TOTAL: 4		215661	207109	7824	1	727

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	101879
alt.binaries.font	5103
alt.binaries.encryptnzb.novemeber	4429
alt.binaries.encryptnzb.juliet	4366
alt.binaries.encryptnzb.bravo	4356
alt.binaries.encryptnzb.golf	4316
alt.binaries.encryptnzb.echo	4306
alt.binaries.encryptnzb.kilo	4290
alt.binaries.encryptnzb.beta	4278
alt.binaries.encryptnzb.hotel	4274
alt.binaries.encryptnzb.charlie	4236
alt.binaries.encryptnzb.lima	4220
alt.binaries.encryptnzb.india	4218
alt.binaries.encryptnzb.delta	4215
alt.binaries.encryptnzb.foxtrot	4212
alt.binaries.encryptnzb.alpha	4197
alt.binaries.encryptnzb.mike	4194
alt.binaries.pwp	3111
alt.binaries.fta	2960
alt.binaries.encrypted	2472
TOTAL: 212	207109

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

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

INND no permission servers:

System	Conn
103.193.138.76	30
162.142.125.115	4
TOTAL: 2	34

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	hasname-out.feeder.erje.net	1
	TOTAL: 1	1
Including strange strings
	hasname-out.feeder.erje.net	102
	news.nntp4.net	57
	usenet.blueworldhosting.com	10
	hasname-out.news.weretis.net	8
	TOTAL: 4	177
No colon-space in header field
	hasname-out.feeder.erje.net	549
	TOTAL: 1	549
TOTAL: 3		727

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	438	438	0	0	0	100%	20:38:55
2	nntp4	6822	3	6816	0	1	0%	23:58:51
3	blueworldhosting	258746	0	258027	13	125	0%	23:59:52
4	erje	7198	0	7197	1	0	0%	23:59:53
5	weretis	3991	0	3005	973	1	0%	23:59:53
TOTAL: 5		277195	441	275045	987	127	0%	116:37:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	bbsgslincom	1.3 MB	0.0 KB	1.3 MB	0.0 KB/s	3.1 KB	20:38:55
2	nntp4	3.9 KB	0.0 KB	3.9 KB	0.0 KB/s	1.3 KB	23:58:51
3	blueworldhosting	0.0 KB	109.9 KB	109.9 KB	0.0 KB/s	8.5 KB	23:59:52
4	erje	0.0 KB	1.6 KB	1.6 KB	0.0 KB/s	1.6 KB	23:59:53
5	weretis	0.0 KB	26.2 MB	26.2 MB	0.3 KB/s	27.6 KB	23:59:53
TOTAL: 5		1.3 MB	26.3 MB	27.6 MB	0.1 KB/s	19.8 KB	116:37:24

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
164.52.24.190	0.007	0.021	00:01:04
39.99.144.96	0.003	0.003	00:00:02
candid.monitoring.internet-measurement.com	0.001	0.004	00:00:00
167.94.145.106	0.003	0.008	00:00:00
azpdcg98t1t7.stretchoid.com	0.000	0.005	00:00:00
azpdsskaier6.stretchoid.com	0.001	0.007	00:00:00
167.94.138.163	0.007	0.008	00:00:00
198.235.24.23	0.000	0.004	00:00:00
205.210.31.40	0.001	0.002	00:00:00
TOTAL: 9	0.023	0.062	00:01:08

NNRP no permission clients [Top 20]:

System	Conn
164.52.24.190	6
167.94.138.163	4
167.94.145.106	3
39.99.144.96	2
azpdsskaier6.stretchoid.com	2
198.235.24.23	1
205.210.31.40	1
azpdcg98t1t7.stretchoid.com	1
candid.monitoring.internet-measurement.com	1
TOTAL: 9	21

Daily Usenet report

Aug 12 06:01:01 -- Aug 13 06:01:01