Daily Usenet report for news.aulich.net: Aug 1 04:15:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Aug 1 07:45:04 news pgpverify[3599447]: pgpverify: verification failed
Aug 1 10:34:50 news nnrpd[3603254]: unable to get certificates from '/etc/news/cert.pem'
Aug 1 10:34:50 news nnrpd[3603254]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Aug 1 18:37:13 news nnrpd[3614438]: unable to get certificates from '/etc/news/cert.pem'
Aug 1 18:37:13 news nnrpd[3614438]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	8853	64.4%	1.3 MB	67.2%
innd	3956	28.8%	520.1 KB	27.3%
cnfsstat	432	3.1%	53.8 KB	2.8%
nnrpd	333	2.4%	32.2 KB	1.7%
innfeed	159	1.2%	16.1 KB	0.8%
controlchan	12	0.1%	2.4 KB	0.1%
nocem	1	0.0%	0.0 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 8	13747	100.0%	1.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	8745	49.8%
Negative hits	8745	49.8%
Cache misses	63	0.4%
Positive hits	3	0.0%
TOTAL: 4	17556	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:04.335	0.0%	176	0.000	24.631	161.000
article cleanup	00:00:00.040	0.0%	8752	0.000	0.005	0.057
article logging	00:00:00.191	0.0%	8787	0.000	0.022	0.154
article parse	00:00:00.082	0.0%	12120	0.000	0.007	0.071
article write	00:00:27.544	0.0%	8324	0.000	3.309	56.222
artlog/artcncl	00:00:00.001	0.0%	66	0.000	0.015	0.032
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:00:00.007	0.0%	18642	0.000	0.000	0.028
hisgrep/artcncl	00:00:00.006	0.0%	242	0.000	0.025	0.064
hishave/artcncl	00:00:00.001	0.0%	66	0.000	0.015	0.053
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.061	0.0%	17506	0.000	0.003	0.034
history sync	00:00:00.006	0.0%	290	0.000	0.021	1.000
history write	00:00:17.574	0.0%	8753	0.000	2.008	23.200
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:57:58.020	99.8%	22015	2180.861	3919.056	18719.656
nntp read	00:00:00.284	0.0%	21063	0.000	0.013	0.074
overview write	00:00:49.971	0.1%	8324	0.000	6.003	87.588
perl filter	00:00:00.788	0.0%	8752	0.000	0.090	7.458
python filter	00:00:00.001	0.0%	8752	0.000	0.000	0.012
site send	00:00:00.137	0.0%	8354	0.000	0.016	0.086
TOTAL: 24:00:19.449	23:59:39.049	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.000	0.0%	0	0.000	0.000	0.000
article prepare	00:00:00.000	0.0%	0	0.000	0.000	0.000
article read	00:00:00.000	0.0%	0	0.000	0.000	0.000
backlog stats	00:00:00.005	0.0%	3730	0.000	0.001	0.038
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.000	0.0%	3	0.000	0.000	0.000
data write	00:00:00.000	0.0%	3	0.000	0.000	0.000
idle	23:54:14.338	100.0%	3730	17690.235	23070.868	24067.680
status file	00:00:00.524	0.0%	6	0.000	87.333	131.000
TOTAL: 23:54:15.295	23:54:14.867	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:23:42.221	99.9%	393	8.500	12779.188	13694.485
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.213	0.0%	47021	0.000	0.005	0.050
readart	00:00:01.679	0.0%	230	7.300	7.300	7.300
TOTAL: 01:23:47.141	01:23:44.113	99.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	171

Control Channel:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	718	8753	8324	429	95%	23:44:58
2	localhost	25	0	0	0	0%	00:00:00
TOTAL: 2		743	8753	8324	429	95%	23:44:58

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	22.4 MB	2.4 MB	24.8 MB	90%	2.9 KB
2	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 2		22.4 MB	2.4 MB	24.8 MB	90%	2.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 1 04:15:02 - 04:59:59	109	1.3%	0.04	337.6 KB	1.5%	0.13
Aug 1 05:00:00 - 05:59:59	163	2.0%	0.05	365.8 KB	1.6%	0.10
Aug 1 06:00:00 - 06:59:59	165	2.0%	0.05	356.5 KB	1.6%	0.10
Aug 1 07:00:00 - 07:59:59	154	1.9%	0.04	456.7 KB	2.0%	0.13
Aug 1 08:00:00 - 08:59:59	398	4.8%	0.11	1.3 MB	5.7%	0.36
Aug 1 09:00:00 - 09:59:59	478	5.7%	0.13	1.3 MB	6.0%	0.38
Aug 1 10:00:00 - 10:59:59	479	5.8%	0.13	1.3 MB	5.7%	0.36
Aug 1 11:00:00 - 11:59:59	422	5.1%	0.12	1.0 MB	4.6%	0.29
Aug 1 12:00:00 - 12:59:59	313	3.8%	0.09	742.9 KB	3.2%	0.21
Aug 1 13:00:00 - 13:59:59	524	6.3%	0.15	1.4 MB	6.2%	0.39
Aug 1 14:00:00 - 14:59:59	427	5.1%	0.12	1.0 MB	4.6%	0.29
Aug 1 15:00:00 - 15:59:59	498	6.0%	0.14	1.4 MB	6.4%	0.41
Aug 1 16:00:00 - 16:59:59	492	5.9%	0.14	1.5 MB	6.6%	0.42
Aug 1 17:00:00 - 17:59:59	472	5.7%	0.13	1.2 MB	5.2%	0.33
Aug 1 18:00:00 - 18:59:59	453	5.4%	0.13	1.2 MB	5.5%	0.35
Aug 1 19:00:00 - 19:59:59	450	5.4%	0.12	1.1 MB	4.8%	0.31
Aug 1 20:00:00 - 20:59:59	515	6.2%	0.14	1.6 MB	7.3%	0.47
Aug 1 21:00:00 - 21:59:59	462	5.6%	0.13	1.0 MB	4.7%	0.30
Aug 1 22:00:00 - 22:59:59	348	4.2%	0.10	783.6 KB	3.4%	0.22
Aug 1 23:00:00 - 23:59:59	295	3.5%	0.08	956.0 KB	4.2%	0.27
Aug 2 00:00:00 - 00:59:59	221	2.7%	0.06	701.3 KB	3.1%	0.19
Aug 2 01:00:00 - 01:59:59	220	2.6%	0.06	632.8 KB	2.8%	0.18
Aug 2 02:00:00 - 02:59:59	133	1.6%	0.04	412.5 KB	1.8%	0.11
Aug 2 03:00:00 - 03:59:59	110	1.3%	0.03	340.9 KB	1.5%	0.09
Aug 2 04:00:00 - 04:15:01	22	0.3%	0.02	51.8 KB	0.2%	0.06
TOTAL: 23:59:59	8323	100.0%	0.10	22.4 MB	100.0%	0.27

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
DE1	DE	512.0 MB	328.1 MB	64.1%	1	0.14	42.89
INTL1	INTL	512.0 MB	261.7 MB	51.1%	11	0.24	25.46
INTL2	INTL	512.0 MB	264.5 MB	51.7%	11	0.24	25.54
TOTAL: 3	-	1.5 GB	854.3 MB	55.6%	23	0.23	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other
1	usenet.blueworldhosting.com	464	428	0	0	0	0	0	0	36
TOTAL: 1		464	428	0	0	0	0	0	0	36

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	116
alt.computer.workshop	70
linux.kernel.git	66
lada.talk	42
alt.slack.goathead	30
fido7.pushkin.local	26
fido7.lorapvt.horo	12
it-alt.sport.calcio.juventus	10
fido7.fidonet.online	9
al.christnet.bible	6
fido7.crimea.robots	5
hispagatos.hacking.news	5
fido7.starper.limited	4
fido7.crimea.business	2
fido7.f715.techinfo	2
panix.chat.politics	2
alt.poetry	2
alt.french	1
news.test	1
soc.culture.iran	1
TOTAL: 36	428

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	usenet.blueworldhosting.com	35
	TOTAL: 1	35
No colon-space in header field
	usenet.blueworldhosting.com	1
	TOTAL: 1	1
TOTAL: 2		36

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	usenet.blueworldhosting.com	0	0	0	0	0	0	0%	00:10:00
TOTAL: 1		0	0	0	0	0	0	0%	00:10:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	usenet.blueworldhosting.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	00:10:00
TOTAL: 1		0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	00:10:00

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Rej	Elapsed
1	ip-77-25-40-88.web.vodafone.de	1	230	640.6 KB	25	0	01:22:27
2	exit-14.tor.r0cket.net	2	0	0.0 KB	0	2	00:00:47
TOTAL: 2		3	230	640.6 KB	25	2	01:23:47

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Rej	Elapsed
1	*.web.vodafone.de	1	230	640.6 KB	25	0	01:22:27
2	unresolved	10	0	0.0 KB	0	0	00:00:29
3	*.monitoring.internet-measurement.com	1	0	0.0 KB	0	0	00:00:01
4	*.stretchoid.com	1	0	0.0 KB	0	0	00:00:00
5	*.tor.r0cket.net	2	0	0.0 KB	0	2	00:00:47
TOTAL: 5		15	230	640.6 KB	25	2	01:23:47

NNRP auth users [Top 20]:

User	Conn
peter@aulich.net	1
TOTAL: 1	1

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
ip-77-25-40-88.web.vodafone.de	0.021	0.058	0.007	01:22:27
exit-14.tor.r0cket.net	0.037	0.089	0.000	00:00:47
205.210.31.7	0.003	0.007	0.000	00:00:09
205.210.31.157	0.007	0.000	0.000	00:00:09
167.94.146.49	0.061	0.016	0.000	00:00:04
205.210.31.153	0.000	0.011	0.000	00:00:03
167.94.138.38	0.027	0.016	0.000	00:00:02
gentle.monitoring.internet-measurement.com	0.008	0.004	0.000	00:00:01
198.235.24.56	0.007	0.000	0.000	00:00:01
198.235.24.248	0.000	0.009	0.000	00:00:00
azpdcgrun0fv.stretchoid.com	0.000	0.009	0.000	00:00:00
91.238.181.92	0.005	0.005	0.000	00:00:00
TOTAL: 12	0.176	0.224	0.007	01:23:47

Curious NNRP server explorers [Top 20]:

System	Conn
167.94.146.49	3
198.235.24.248	1
198.235.24.56	1
205.210.31.157	1
205.210.31.7	1
91.238.181.92	1
205.210.31.153	1
gentle.monitoring.internet-measurement.com	1
azpdcgrun0fv.stretchoid.com	1
167.94.138.38	1
TOTAL: 10	12

NNRP unrecognized commands (by host) [Top 20]:

System	Conn
167.94.146.49	1
azpdcgrun0fv.stretchoid.com	1
91.238.181.92	1
167.94.138.38	1
TOTAL: 4	4

NNRP unrecognized commands (by command) [Top 20]:

Command	Count
EHLO www.censys.io	2
MGLNDD_85.31.187.13_119	1
#003	1
TOTAL: 3	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
205.210.31.157	1	1
205.210.31.7	1	1
91.238.181.92	1	1
ip-77-25-40-88.web.vodafone.de	1	0
167.94.146.49	1	2
TOTAL: 5	5	8

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	de	201	87.4%
2	eternal-september	16	7.0%
3	comp	8	3.5%
4	news	4	1.7%
5	alt	1	0.4%
TOTAL: 5		230	100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

Newsgroup		Count
1	de.comp.os.unix.linux.misc	44
2	de.sci.electronics	27
3	de.alt.folklore.computer	26
4	de.rec.fahrrad	21
5	de.soc.recht.strassenverkehr	14
6	de.rec.heimwerken	12
7	de.soc.recht.misc	12
8	de.alt.fan.aldi	9
9	eternal-september.talk	8
10	eternal-september.support	8
11	de.soc.recht.strafrecht	8
12	comp.sys.raspberry-pi	8
13	de.comm.software.newsreader	6
14	de.test	6
15	de.sci.ing.elektrotechnik	5
16	de.etc.fahrzeug.auto	4
17	de.comm.provider.telefonie	3
18	news.software.nntp	2
19	de.comm.provider.usenet	1
20	de.soc.recht.steuern+buchfuehrung	1
21	alt.usenet.peering	1
22	de.comp.editoren	1
23	news.software.readers	1
24	news.admin.peering	1
25	de.alt.netdigest	1
TOTAL: 25		230

Daily Usenet report for news.aulich.net

Aug 1 04:15:02 -- Aug 2 04:15:01