Daily Usenet report for news.aulich.net

Mar 14 04:15:01 -- Mar 15 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Mar 14 08:30:04 news pgpverify[30942]: pgpverify: verification failed
Mar 14 08:30:04 news pgpverify[30942]: pgpverify: verification failed
Mar 14 08:30:04 news pgpverify[30951]: pgpverify: verification failed
Mar 14 08:30:04 news pgpverify[30951]: pgpverify: verification failed
Mar 14 08:33:32 news nnrpd[30967]: unable to get certificates from '/etc/news/cert.pem'
Mar 14 08:33:32 news nnrpd[30967]: unable to get certificates from '/etc/news/cert.pem'
Mar 14 08:33:32 news nnrpd[30967]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Mar 14 08:33:32 news nnrpd[30967]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Mar 14 12:56:53 news nnrpd[37237]: unable to get certificates from '/etc/news/cert.pem'
Mar 14 12:56:53 news nnrpd[37237]: unable to get certificates from '/etc/news/cert.pem'
Mar 14 12:56:53 news nnrpd[37237]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Mar 14 12:56:53 news nnrpd[37237]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Mar 14 22:00:05 news pgpverify[51175]: pgpverify: verification failed
Mar 14 22:00:05 news pgpverify[51175]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 9007 40.2%1.3 MB 48.3%
nnrpd 6102 27.2%500.8 KB 18.5%
innd 5850 26.1%704.4 KB 26.0%
cnfsstat 864 3.9%120.5 KB 4.4%
innfeed 318 1.4%34.6 KB 1.3%
nocem 254 1.1%36.6 KB 1.3%
controlchan 28 0.1%5.8 KB 0.2%
pgpverify 6 0.0%0.5 KB 0.0%
TOTAL: 8 22429 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 17780 50.1%
Negative hits 17654 49.8%
Positive hits 24 0.1%
Cache misses 16 0.0%
TOTAL: 4 35474 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.076 0.0%224 0.000 0.339 11.000
article cleanup00:00:00.074 0.0%17658 0.000 0.004 0.050
article logging00:00:00.348 0.0%17820 0.000 0.020 0.125
article parse00:00:00.184 0.0%23766 0.000 0.008 0.043
article write00:00:01.786 0.0%16730 0.000 0.107 1.520
artlog/artcncl00:00:00.002 0.0%166 0.000 0.012 0.200
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.008 0.0%35804 0.000 0.000 0.009
hisgrep/artcncl00:00:00.004 0.0%138 0.000 0.029 0.143
hishave/artcncl00:00:00.000 0.0%166 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.110 0.0%35316 0.000 0.003 0.042
history sync00:00:00.022 0.0%826 0.000 0.027 0.500
history write00:00:03.350 0.0%17658 0.000 0.190 1.700
hiswrite/artcncl00:00:00.006 0.0%126 0.000 0.048 0.200
idle47:42:14.234100.0%39896 1542.270 4304.548 19359.194
nntp read00:00:00.480 0.0%38388 0.000 0.013 0.259
overview write00:00:08.744 0.0%16730 0.000 0.523 7.909
perl filter00:00:00.322 0.0%17658 0.000 0.018 0.083
python filter00:00:00.000 0.0%17658 0.000 0.000 0.000
site send00:00:00.268 0.0%16970 0.000 0.016 0.079
TOTAL: 2147:42:30.018100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.000 0.0%0 0.000 0.000 0.000
article prepare00:00:00.000 0.0%0 0.000 0.000 0.000
article read00:00:00.000 0.0%0 0.000 0.000 0.000
backlog stats00:00:00.024 0.0%7454 0.000 0.003 0.040
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.000 0.0%6 0.000 0.000 0.000
data write00:00:00.000 0.0%6 0.000 0.000 0.000
idle47:48:49.540100.0%745417166.629 23092.238 24234.385
status file00:00:00.022 0.0%12 0.500 1.833 2.500
TOTAL: 947:48:49.586100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:40:19.746100.0%12752 22.000 1601.298 81869.182
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.694 0.0%28192 0.000 0.308 2.550
readart00:00:00.266 0.0%926 0.000 0.287 4.500
TOTAL: 405:40:28.706100.0%----

Control commands to innd:

CommandNumber
flush 10
flushlogs 4
go 4
logmode 4
lowmark 2
mode 298
name 4
pause 4
paused 4
reload 4
reserve 4
TOTAL: 11 342

Control channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de000400
newgroups-request@fido7.org002202
TOTAL002602

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1usenet.blueworldhosting.com 576 17698 16770 0 928 94%47:29:06
2localhost 64 0 0 0 0 0%00:00:00
TOTAL: 2 640 17698 16770 0 928 94%47:29:06
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com46.6 MB0.0 KB5.9 MB52.5 MB 88%3.0 KB
2localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 246.6 MB0.0 KB5.9 MB52.5 MB 88%3.0 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 14 04:15:01 - 04:59:59 62 0.7% 0.02192.8 KB 0.8% 0.07
Mar 14 05:00:00 - 05:59:59 147 1.8% 0.04520.4 KB 2.2% 0.14
Mar 14 06:00:00 - 06:59:59 168 2.0% 0.05523.3 KB 2.2% 0.15
Mar 14 07:00:00 - 07:59:59 222 2.6% 0.06555.4 KB 2.3% 0.15
Mar 14 08:00:00 - 08:59:59 325 3.9% 0.09718.4 KB 3.0% 0.20
Mar 14 09:00:00 - 09:59:59 492 5.9% 0.141.4 MB 6.1% 0.40
Mar 14 10:00:00 - 10:59:59 503 6.0% 0.141.1 MB 4.9% 0.33
Mar 14 11:00:00 - 11:59:59 517 6.2% 0.141019.0 KB 4.3% 0.28
Mar 14 12:00:00 - 12:59:59 490 5.8% 0.14950.1 KB 4.0% 0.26
Mar 14 13:00:00 - 13:59:59 577 6.9% 0.162.7 MB 11.8% 0.78
Mar 14 14:00:00 - 14:59:59 548 6.5% 0.151.5 MB 6.4% 0.42
Mar 14 15:00:00 - 15:59:59 545 6.5% 0.151.3 MB 5.8% 0.38
Mar 14 16:00:00 - 16:59:59 447 5.3% 0.121.3 MB 5.7% 0.38
Mar 14 17:00:00 - 17:59:59 427 5.1% 0.121.0 MB 4.4% 0.29
Mar 14 18:00:00 - 18:59:59 402 4.8% 0.11981.4 KB 4.1% 0.27
Mar 14 19:00:00 - 19:59:59 334 4.0% 0.09862.1 KB 3.6% 0.24
Mar 14 20:00:00 - 20:59:59 385 4.6% 0.111.1 MB 4.8% 0.32
Mar 14 21:00:00 - 21:59:59 295 3.5% 0.08978.4 KB 4.1% 0.27
Mar 14 22:00:00 - 22:59:59 355 4.2% 0.101.1 MB 4.7% 0.31
Mar 14 23:00:00 - 23:59:59 325 3.9% 0.09846.2 KB 3.5% 0.24
Mar 15 00:00:00 - 00:59:59 221 2.6% 0.06820.6 KB 3.4% 0.23
Mar 15 01:00:00 - 01:59:59 221 2.6% 0.06638.1 KB 2.7% 0.18
Mar 15 02:00:00 - 02:59:59 150 1.8% 0.04432.3 KB 1.8% 0.12
Mar 15 03:00:00 - 03:59:59 192 2.3% 0.05701.4 KB 2.9% 0.19
Mar 15 04:00:00 - 04:15:02 28 0.3% 0.0373.1 KB 0.3% 0.08
TOTAL: 24:00:01 8378 100.0% 0.1023.3 MB 100.0% 0.28
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
DE1DE512.0 MB304.2 MB 59.4% 2 0.03 189.17
INTL1INTL512.0 MB330.4 MB 64.5% 20 0.24 25.01
INTL2INTL512.0 MB337.6 MB 65.9% 20 0.24 25.23
TOTAL: 3-1.5 GB972.2 MB 63.3% 42 0.19-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 546 464 0 0 1 0 0 0 81
TOTAL: 1 546 464 0 0 1 0 0 0 81

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 173
alt.computer.workshop 56
linux.kernel.git 41
fido7.ukrnews 35
lada.talk 21
fido7.pushkin.local 17
hispagatos.hacking.ransomware 17
fido7.lorapvt.horo 12
fido7.f715.techinfo 9
fido7.crimea.robots 7
fido7.crimea.business 6
fido7.f715.echo 6
local.general 6
spline.eisfair 6
frn.informatique 5
alt.bbs.synchronet 4
it-alt.sport.calcio.juventus 4
kraft.politics 4
alt.managing.techsupport 3
24hoursupport.helpdesk 2
TOTAL: 43 464

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

GroupsCount
uk.legal.moderated 1
TOTAL: 1 1

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
nocem@eternal-september.org (misplaced_binary)1801260126
robot@pasdenom.info (spam2)13600174174
robot@pasdenom.info (spam)48006262
robot@pasdenom.info (spam3)18005050
robot@pasdenom.info (spam4)14003434
TOTAL: 52340126320446

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.blueworldhosting.com 81
TOTAL: 1 81
TOTAL: 1 81

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1usenet.blueworldhosting.com 0 0 0 0 0 0 0%00:20:00
TOTAL: 1 0 0 0 0 0 0 0%00:20:00
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s000:20:00
TOTAL: 10.0 KB0.0 KB0.0 KB0.0 KB/s000:20:00
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1ip5f5bc1ca.dynamic.kabel-deutschland.de 6 282722.7 KB 50 0 004:50:21
266.61.98.95 100 168585.9 KB 22 0 000:48:13
TOTAL: 2 106 4501.3 MB 72 0 005:38:35

NNRP connection statistics (by domain) [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1*.dynamic.kabel-deutschland.de 6 282722.7 KB 50 0 004:50:21
2unresolved 112 168585.9 KB 22 0 000:49:02
3*.167.censys-scanner.com 6 00.0 KB 0 0 000:00:29
4*.stretchoid.com 4 00.0 KB 0 0 000:00:20
5*.206.censys-scanner.com 2 00.0 KB 0 0 000:00:13
6*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
TOTAL: 6 132 4501.3 MB 72 0 005:40:28

NNRP auth users [Top 20]:

UserConn
peter@aulich.net 6
TOTAL: 1 6

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ip5f5bc1ca.dynamic.kabel-deutschland.de 0.060 0.058 0.02404:50:21
66.61.98.95 0.776 1.066 0.00000:48:13
81.29.142.6 0.046 0.006 0.00000:00:44
51.138.94.167.censys-scanner.com 0.048 0.022 0.00000:00:29
azpdcs1633ss.stretchoid.com 0.012 0.012 0.00000:00:20
48.34.168.206.censys-scanner.com 0.030 0.008 0.00000:00:13
147.185.133.142 0.000 0.014 0.00000:00:02
198.235.24.53 0.010 0.004 0.00000:00:01
o350.scanner.modat.io 0.000 0.014 0.00000:00:00
TOTAL: 9 0.982 1.204 0.02405:40:28

Curious NNRP explorers [Top 20]:

SystemConn
81.29.142.6 8
51.138.94.167.censys-scanner.com 6
azpdcs1633ss.stretchoid.com 4
147.185.133.142 2
198.235.24.53 2
48.34.168.206.censys-scanner.com 2
o350.scanner.modat.io 2
TOTAL: 7 26

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

SystemConn
147.185.133.142 8
81.29.142.6 4
48.34.168.206.censys-scanner.com 2
51.138.94.167.censys-scanner.com 2
azpdcs1633ss.stretchoid.com 2
TOTAL: 5 18

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

CommandCount
EHLO www.censys.io 4
AUTH TLS 2
Accept-Encoding: gzip 2
EHLO 85.31.187.13 2
GET / HTTP/1.1 2
Host: 85.31.187.13:119 2
MGLNDD_85.31.187.13_119 2
User-Agent: Hello from Palo Alto Network... 2
TOTAL: 8 18

NNRP client timeouts [Top 20]:

SystemConnPeer
ip5f5bc1ca.dynamic.kabel-deutschland.de 6 0
51.138.94.167.censys-scanner.com 2 4
TOTAL: 2 8 8

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

HierarchyCountPct
1de 278 61.8%
2linux 74 16.4%
3alt 48 10.7%
4eternal-september 14 3.1%
5news 12 2.7%
6nl 8 1.8%
7pl 8 1.8%
8fr 4 0.9%
9it 4 0.9%
TOTAL: 9 450100.0%

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

NewsgroupCount
1linux.debian.l10n.german 60
2de.comm.software.mailserver 48
3alt.bible 32
4de.admin.news.groups 30
5de.comm.software.mozilla.mailnews 28
6de.sci.ing.elektrotechnik 28
7de.rec.fahrrad 24
8de.alt.folklore.computer 20
9de.comp.os.unix.linux.misc 16
10de.test 16
11de.comp.security.misc 14
12linux.debian.user 14
13alt.support.diabetes 12
14de.etc.haushalt 12
15de.soc.recht.misc 10
16news.admin.peering 10
17nl.taal 8
18pl.soc.polityka 8
19de.alt.netdigest 6
20de.etc.fahrzeug.auto 6
21eternal-september.talk 6
22alt.sex.young 4
23de.rec.mampf 4
24de.sci.electronics 4
25de.soc.recht.arbeit+soziales 4
26eternal-september.support 4
27eternal-september.test 4
28fr.comp.usenet.lecteurs-de-news 4
29it.tlc.gestori.fastweb 4
30de.comp.os.unix.apps.kde 2
31de.etc.notfallrettung 2
32de.rec.fotografie 2
33de.rec.heimwerken 2
34news.software.readers 2
TOTAL: 34 450