Daily Usenet report: Jun 4 06:01:01

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Jun 4 06:01:46 kennel innd: message repeated 2 times: [ ctlinnd command s]
Jun 4 08:45:01 kennel pgpverify[441039]: pgpverify: verification failed
Jun 4 08:45:02 kennel pgpverify[441059]: pgpverify: verification failed
Jun 4 08:45:02 kennel pgpverify[441077]: pgpverify: verification failed
Jun 4 08:45:02 kennel pgpverify[441086]: pgpverify: verification failed
Jun 4 08:45:03 kennel pgpverify[441095]: pgpverify: verification failed
Jun 4 09:00:01 kennel pgpverify[442989]: pgpverify: verification failed
Jun 4 09:00:07 kennel pgpverify[443011]: pgpverify: verification failed
Jun 4 09:00:07 kennel pgpverify[443020]: pgpverify: verification failed
Jun 4 09:00:07 kennel pgpverify[443029]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	469179	97.3%	61.7 MB	97.1%
innd	11295	2.3%	1.6 MB	2.6%
innfeed	1405	0.3%	191.5 KB	0.3%
cnfsstat	144	0.0%	21.5 KB	0.0%
nnrpd	54	0.0%	5.8 KB	0.0%
controlchan	10	0.0%	0.7 KB	0.0%
pgpverify	9	0.0%	1.4 KB	0.0%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 8	482097	100.0%	63.5 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	768012	45.0%
Positive hits	470658	27.6%
Do not exist	453534	26.6%
Cache misses	14073	0.8%
TOTAL: 4	1706277	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.004	0.0%	37	0.000	0.108	1.000
article cleanup	00:00:04.788	0.0%	464627	0.004	0.010	0.021
article logging	00:00:18.560	0.0%	464845	0.015	0.040	0.056
article parse	00:00:24.218	0.0%	1173007	0.007	0.021	0.031
article write	00:00:18.088	0.0%	198968	0.034	0.091	0.131
artlog/artparse	00:00:00.140	0.0%	2677	0.000	0.052	1.000
data move	00:00:02.108	0.0%	1158933	0.000	0.002	0.007
hisgrep/artcncl	00:00:00.002	0.0%	37	0.000	0.054	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:06.192	0.0%	1712986	0.002	0.004	0.007
history sync	00:00:00.027	0.0%	317	0.000	0.085	1.000
history write	00:00:27.449	0.0%	454518	0.027	0.060	0.096
idle	23:53:15.366	99.5%	979027	46.622	87.838	225.530
nntp read	00:00:38.837	0.0%	978605	0.017	0.040	0.055
overview write	00:00:01.101	0.0%	198968	0.000	0.006	0.014
perl filter	00:00:20.915	0.0%	451266	0.015	0.046	0.062
python filter	00:00:20.860	0.0%	451266	0.022	0.046	0.069
site send	00:00:08.177	0.0%	508651	0.011	0.016	0.130
TOTAL: 24:00:27.627	23:56:26.832	99.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.433	0.0%	113526	0.000	0.004	0.015
article prepare	00:00:00.000	0.0%	1614	0.000	0.000	0.000
article read	00:00:00.092	0.0%	969	0.000	0.095	0.667
backlog stats	00:00:00.327	0.0%	344030	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:05.886	0.0%	222568	0.012	0.026	0.052
data write	00:00:05.721	0.0%	126628	0.013	0.045	0.084
idle	23:51:47.198	100.0%	344030	125.077	249.708	798.366
status file	00:00:00.174	0.0%	255	0.000	0.682	1.200
TOTAL: 23:52:11.161	23:51:59.831	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%	13	0.000	0.154	1.000
TOTAL: 00:00:07.707	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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
moderator@dana.de	0	0	0	9	0	0
TOTAL	0	0	0	9	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.feeder.erje.net	577	918107	192599	456030	269478	20%	47:33:40
2	news.nntp4.net	8	8182	2916	4887	379	35%	27:06:45
3	hasname-out.news.weretis.net	16	11342	2817	8480	45	24%	48:41:29
4	usenet.blueworldhosting.com	1377	7177	775	6307	95	10%	23:30:03
5	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 5		1979	944808	199107	475704	269997	21%	146:51:57

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	1.7 GB	106.1 MB	2.0 GB	3.7 GB	44%	8.5 KB
2	news.nntp4.net	23.4 MB	0.0 KB	3.5 MB	26.9 MB	86%	8.4 KB
3	hasname-out.news.weretis.net	7.9 MB	52.0 KB	75.6 KB	8.0 MB	98%	2.9 KB
4	usenet.blueworldhosting.com	1.8 MB	0.0 KB	228.7 KB	2.1 MB	89%	2.4 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		1.7 GB	106.2 MB	2.0 GB	3.8 GB	44%	8.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 4 06:01:01 - 06:59:59	4441	2.2%	1.25	46.2 MB	2.7%	13.38
Jun 4 07:00:00 - 07:59:59	8138	4.1%	2.26	86.7 MB	5.0%	24.67
Jun 4 08:00:00 - 08:59:59	9382	4.7%	2.61	91.1 MB	5.3%	25.92
Jun 4 09:00:00 - 09:59:59	10202	5.1%	2.83	100.1 MB	5.8%	28.47
Jun 4 10:00:00 - 10:59:59	9518	4.8%	2.64	90.1 MB	5.2%	25.63
Jun 4 11:00:00 - 11:59:59	10034	5.0%	2.79	98.3 MB	5.7%	27.97
Jun 4 12:00:00 - 12:59:59	17163	8.6%	4.77	124.4 MB	7.2%	35.37
Jun 4 13:00:00 - 13:59:59	11522	5.8%	3.20	101.1 MB	5.8%	28.77
Jun 4 14:00:00 - 14:59:59	10053	5.1%	2.79	91.4 MB	5.3%	26.01
Jun 4 15:00:00 - 15:59:59	10049	5.1%	2.79	85.4 MB	4.9%	24.30
Jun 4 16:00:00 - 16:59:59	8531	4.3%	2.37	69.9 MB	4.0%	19.88
Jun 4 17:00:00 - 17:59:59	10488	5.3%	2.91	76.8 MB	4.4%	21.84
Jun 4 18:00:00 - 18:59:59	9214	4.6%	2.56	77.5 MB	4.5%	22.06
Jun 4 19:00:00 - 19:59:59	8395	4.2%	2.33	64.0 MB	3.7%	18.20
Jun 4 20:00:00 - 20:59:59	8619	4.3%	2.39	60.4 MB	3.5%	17.18
Jun 4 21:00:00 - 21:59:59	9244	4.6%	2.57	76.3 MB	4.4%	21.70
Jun 4 22:00:00 - 22:59:59	7684	3.9%	2.13	59.3 MB	3.4%	16.86
Jun 4 23:00:00 - 23:59:59	5729	2.9%	1.59	41.5 MB	2.4%	11.79
Jun 5 00:00:00 - 00:59:59	7686	3.9%	2.13	60.3 MB	3.5%	17.14
Jun 5 01:00:00 - 01:59:59	5860	2.9%	1.63	60.1 MB	3.5%	17.10
Jun 5 02:00:00 - 02:59:59	4824	2.4%	1.34	47.8 MB	2.8%	13.59
Jun 5 03:00:00 - 03:59:59	4098	2.1%	1.14	41.3 MB	2.4%	11.76
Jun 5 04:00:00 - 04:59:59	4345	2.2%	1.21	45.5 MB	2.6%	12.95
Jun 5 05:00:00 - 05:59:59	3638	1.8%	1.01	33.6 MB	1.9%	9.54
Jun 5 06:00:00 - 06:01:01	56	0.0%	0.92	506.7 KB	0.0%	8.31
TOTAL: 24:00:00	198913	100.0%	2.30	1.7 GB	100.0%	20.50

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
C1	DEFAULT	10.0 GB	5.5 GB	55.3%	148	25.45	4.77
TOTAL: 1	-	10.0 GB	5.5 GB	55.3%	148	25.45	-

Sites sending bad articles:

Server		Total	Group	Duplic	TooOld	Other
1	hasname-out.feeder.erje.net	269712	253494	12743	624	2851
2	news.nntp4.net	381	363	0	0	18
3	usenet.blueworldhosting.com	115	95	0	0	20
4	hasname-out.news.weretis.net	58	34	7	0	17
TOTAL: 4		270266	253986	12750	624	2906

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	166013
alt.binaries.encrypted	5585
alt.binaries.font	3297
alt.binaries.wtfnzb.alpha	3000
alt.binaries.wtfnzb.charlie	2971
alt.binaries.wtfnzb.lima	2971
alt.binaries.wtfnzb.foxtrot	2960
alt.binaries.wtfnzb.india	2941
alt.binaries.wtfnzb.delta	2939
alt.binaries.wtfnzb.mike	2928
alt.binaries.wtfnzb.beta	2924
alt.binaries.wtfnzb.juliet	2910
alt.binaries.wtfnzb.golf	2909
alt.binaries.wtfnzb.kilo	2871
alt.binaries.wtfnzb.echo	2854
alt.binaries.wtfnzb.bravo	2843
alt.binaries.wtfnzb.novemeber	2838
alt.binaries.wtfnzb.hotel	2821
alt.binaries.ucc	2089
de.binaries.musik	2084
TOTAL: 195	253986

INND no permission servers:

System	Conn
103.193.138.76	30
185.247.137.184	1
185.247.137.201	1
212.73.148.26	1
66.132.172.100	1
TOTAL: 5	34

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	hasname-out.feeder.erje.net	165
	usenet.blueworldhosting.com	20
	news.nntp4.net	18
	hasname-out.news.weretis.net	17
	TOTAL: 4	220
No colon-space in header field
	hasname-out.feeder.erje.net	2681
	TOTAL: 1	2681
TOTAL: 2		2901

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	756	756	0	0	0	100%	22:06:48
2	blueworldhosting	113391	202	109532	1	3114	0%	23:59:54
3	weretis	4159	4	4132	6	0	0%	23:59:54
4	nntp4	4342	2	4336	0	0	0%	23:59:54
5	erje	5835	1	5817	0	9	0%	23:59:54
TOTAL: 5		128483	965	123817	7	3123	0%	118:06:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	bbsgslincom	7.9 MB	0.0 KB	7.9 MB	0.1 KB/s	10.6 KB	22:06:48
2	blueworldhosting	1.7 MB	23.5 KB	1.7 MB	0.0 KB/s	8.6 KB	23:59:54
3	weretis	3.8 KB	171.2 KB	174.9 KB	0.0 KB/s	17.5 KB	23:59:54
4	nntp4	2.6 KB	0.0 KB	2.6 KB	0.0 KB/s	1.3 KB	23:59:54
5	erje	1.9 KB	0.0 KB	1.9 KB	0.0 KB/s	1.9 KB	23:59:54
TOTAL: 5		9.5 MB	194.7 KB	9.7 MB	0.0 KB/s	10.2 KB	118:06:24

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
51.146.94.167.censys-scanner.com	0.004	0.008	00:00:05
mary.probe.onyphe.net	0.001	0.004	00:00:00
reese.probe.onyphe.net	0.000	0.005	00:00:00
r4-215-d7.monitoring.internet-measurement.com	0.002	0.003	00:00:00
193.124.20.250	0.004	0.001	00:00:00
azpdwspg5atk.stretchoid.com	0.001	0.007	00:00:00
189.186.132.66.censys-scanner.com	0.001	0.003	00:00:00
10.150.216.162.bc.googleusercontent.com	0.000	0.004	00:00:00
205.210.31.148	0.002	0.001	00:00:00
o611.scanner.modat.io	0.002	0.001	00:00:00
TOTAL: 10	0.017	0.037	00:00:07

NNRP no permission clients [Top 20]:

System	Conn
51.146.94.167.censys-scanner.com	3
azpdwspg5atk.stretchoid.com	2
10.150.216.162.bc.googleusercontent.com	1
189.186.132.66.censys-scanner.com	1
193.124.20.250	1
205.210.31.148	1
mary.probe.onyphe.net	1
o611.scanner.modat.io	1
r4-215-d7.monitoring.internet-measurement.com	1
reese.probe.onyphe.net	1
TOTAL: 10	13

Daily Usenet report

Jun 4 06:01:01 -- Jun 5 06:01:01