Daily Usenet report for news.aulich.net

Nov 14 04:15:01 -- Nov 15 04:15:01

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Nov 14 08:32:04 news nnrpd[2917552]: unable to get certificates from '/etc/news/cert.pem'
Nov 14 08:32:04 news nnrpd[2917552]: unable to get certificates from '/etc/news/cert.pem'
Nov 14 08:32:04 news nnrpd[2917552]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Nov 14 08:32:04 news nnrpd[2917552]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Nov 14 22:00:50 news pgpverify[2937645]: pgpverify: verification failed
Nov 14 22:00:50 news pgpverify[2937645]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
innd 15278 54.6%1.9 MB 51.0%
inn 10947 39.2%1.5 MB 41.9%
cnfsstat 864 3.1%117.0 KB 3.1%
nnrpd 384 1.4%35.5 KB 0.9%
innfeed 318 1.1%33.3 KB 0.9%
nocem 142 0.5%78.6 KB 2.1%
controlchan 26 0.1%5.5 KB 0.1%
pgpverify 2 0.0%0.2 KB 0.0%
TOTAL: 8 27961 100.0%3.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 21700 51.6%
Negative hits 20308 48.3%
Cache misses 24 0.1%
Positive hits 6 0.0%
TOTAL: 4 42038 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.154 0.0%1468 0.000 0.786 52.000
article cleanup00:00:00.074 0.0%20336 0.000 0.004 0.031
article logging00:00:00.504 0.0%20478 0.000 0.025 0.885
article parse00:00:00.184 0.0%26036 0.000 0.007 0.057
article write00:00:01.166 0.0%19170 0.000 0.061 0.964
artlog/artcncl00:00:00.008 0.0%1414 0.000 0.006 0.024
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.016 0.0%37694 0.000 0.000 0.015
hisgrep/artcncl00:00:00.332 0.0%112 0.000 2.964 11.000
hishave/artcncl00:00:00.004 0.0%1414 0.000 0.003 0.037
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.170 0.0%40672 0.000 0.004 0.019
history sync00:00:00.018 0.0%598 0.000 0.030 1.000
history write00:00:01.608 0.0%20336 0.000 0.079 1.341
hiswrite/artcncl00:00:00.022 0.0%1384 0.000 0.016 0.074
idle47:59:39.356100.0%45700 1734.306 3780.730 9677.435
nntp read00:00:00.476 0.0%42484 0.000 0.011 0.043
overview write00:00:32.472 0.0%19170 0.000 1.694 6.409
perl filter00:00:00.320 0.0%20336 0.000 0.016 0.062
python filter00:00:00.006 0.0%20336 0.000 0.000 0.013
site send00:00:00.362 0.0%19274 0.000 0.019 0.077
TOTAL: 2148:00:18.252100.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.022 0.0%7464 0.000 0.003 0.077
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:49:43.288100.0%746417170.629 23068.501 25070.708
status file00:00:00.112 0.0%12 0.000 9.333 14.000
TOTAL: 947:49:43.422100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:16:35.540100.0%550 40.000 27991.891 60887.945
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.136 0.0%2348 0.000 0.058 0.167
readart00:00:02.040 0.0%374 3.842 5.455 5.637
TOTAL: 404:16:37.716100.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
newgroups-request@fido7.org002202
TOTAL002202

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1usenet.blueworldhosting.com 2756 20340 19174 0 1166 94%47:39:26
2localhost 64 0 0 0 0 0%00:00:00
TOTAL: 2 2820 20340 19174 0 1166 94%47:39:26
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com42.6 MB0.0 KB6.4 MB49.0 MB 86%2.5 KB
2localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 242.6 MB0.0 KB6.4 MB49.0 MB 86%2.5 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 14 04:15:01 - 04:59:59 165 1.7% 0.06312.7 KB 1.4% 0.12
Nov 14 05:00:00 - 05:59:59 205 2.1% 0.06363.6 KB 1.7% 0.10
Nov 14 06:00:00 - 06:59:59 284 3.0% 0.08618.1 KB 2.8% 0.17
Nov 14 07:00:00 - 07:59:59 308 3.2% 0.09610.5 KB 2.8% 0.17
Nov 14 08:00:00 - 08:59:59 363 3.8% 0.10852.6 KB 3.9% 0.24
Nov 14 09:00:00 - 09:59:59 417 4.4% 0.12756.8 KB 3.5% 0.21
Nov 14 10:00:00 - 10:59:59 502 5.2% 0.141.1 MB 5.1% 0.31
Nov 14 11:00:00 - 11:59:59 535 5.6% 0.151.0 MB 4.8% 0.29
Nov 14 12:00:00 - 12:59:59 454 4.7% 0.13923.9 KB 4.2% 0.26
Nov 14 13:00:00 - 13:59:59 493 5.1% 0.141.1 MB 5.2% 0.32
Nov 14 14:00:00 - 14:59:59 498 5.2% 0.141011.0 KB 4.6% 0.28
Nov 14 15:00:00 - 15:59:59 513 5.4% 0.141.1 MB 5.1% 0.31
Nov 14 16:00:00 - 16:59:59 488 5.1% 0.14976.8 KB 4.5% 0.27
Nov 14 17:00:00 - 17:59:59 519 5.4% 0.141.4 MB 6.8% 0.41
Nov 14 18:00:00 - 18:59:59 500 5.2% 0.141.2 MB 5.7% 0.35
Nov 14 19:00:00 - 19:59:59 472 4.9% 0.131.1 MB 5.4% 0.32
Nov 14 20:00:00 - 20:59:59 440 4.6% 0.121.0 MB 4.8% 0.29
Nov 14 21:00:00 - 21:59:59 450 4.7% 0.121.1 MB 5.1% 0.31
Nov 14 22:00:00 - 22:59:59 431 4.5% 0.121.2 MB 5.9% 0.35
Nov 14 23:00:00 - 23:59:59 356 3.7% 0.10926.4 KB 4.2% 0.26
Nov 15 00:00:00 - 00:59:59 327 3.4% 0.09729.7 KB 3.3% 0.20
Nov 15 01:00:00 - 01:59:59 304 3.2% 0.08749.1 KB 3.4% 0.21
Nov 15 02:00:00 - 02:59:59 255 2.7% 0.07587.5 KB 2.7% 0.16
Nov 15 03:00:00 - 03:59:59 251 2.6% 0.07501.7 KB 2.3% 0.14
Nov 15 04:00:00 - 04:15:01 56 0.6% 0.06139.0 KB 0.6% 0.15
TOTAL: 24:00:00 9586 100.0% 0.1121.3 MB 100.0% 0.25
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
DE1DE512.0 MB55.1 MB 10.8% 2 0.09 64.65
INTL1INTL512.0 MB361.5 MB 70.6% 15 0.26 23.75
INTL2INTL512.0 MB366.9 MB 71.7% 15 0.26 23.38
TOTAL: 3-1.5 GB783.5 MB 51.0% 32 0.24-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 654 583 0 0 0 0 0 0 71
TOTAL: 1 654 583 0 0 0 0 0 0 71

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 171
lada.talk 82
fido7.ukrnews 81
linux.kernel.git 47
fido7.fidonet.online 33
alt.computer.workshop 15
alt.slack.goathead 15
hispagatos.hacking.ransomware 14
alt.test.9 13
fido7.pushkin.local 13
hispagatos.mastodon.tag.hacking 13
fido7.lorapvt.horo 12
spline.fli4l.geschnatter 10
fido7.f715.techinfo 9
spline.eisfair 8
alt.politics.usa 5
fido7.crimea.robots 5
fido7.starper.limited 5
it-alt.sport.calcio.juventus 5
alt.bbs.synchronet 4
TOTAL: 34 583

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
nocem@eternal-september.org (misplaced_binary)360138601386
robot@pasdenom.info (spam3)8004242
robot@pasdenom.info (spam)24003838
robot@pasdenom.info (spam2)28003232
robot@pasdenom.info (spam4)6001010
TOTAL: 5102013861221508

Miscellaneous innd statistics [Top 10]:

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

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 2 3361.1 MB 36 0 002:24:32
295.91.193.202 2 3886.5 KB 4 0 001:51:37
TOTAL: 2 4 3741.2 MB 40 0 004:16:10

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.dynamic.kabel-deutschland.de 2 3361.1 MB 36 0 002:24:32
2unresolved 8 3886.5 KB 4 0 001:51:44
3*.stretchoid.com 4 00.0 KB 0 0 000:00:20
4*.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:00
5*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
TOTAL: 5 18 3741.2 MB 40 0 004:16:37

NNRP auth users [Top 20]:

UserConn
peter@aulich.net 4
TOTAL: 1 4

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ip5f5bc1ca.dynamic.kabel-deutschland.de 0.048 0.060 0.00802:24:32
95.91.193.202 0.018 0.018 0.00801:51:37
azpdcs7g8bzu.stretchoid.com 0.000 0.030 0.00000:00:20
205.210.31.148 0.000 0.012 0.00000:00:03
147.185.132.82 0.014 0.000 0.00000:00:02
167.94.138.205 0.030 0.008 0.00000:00:00
55.211.203.35.bc.googleusercontent.com 0.008 0.008 0.00000:00:00
o49.scanner.modat.io 0.000 0.014 0.00000:00:00
TOTAL: 8 0.118 0.150 0.01604:16:37

Curious NNRP explorers [Top 20]:

SystemConn
azpdcs7g8bzu.stretchoid.com 4
147.185.132.82 2
167.94.138.205 2
205.210.31.148 2
55.211.203.35.bc.googleusercontent.com 2
o49.scanner.modat.io 2
TOTAL: 6 14

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

SystemConn
55.211.203.35.bc.googleusercontent.com 8
167.94.138.205 2
azpdcs7g8bzu.stretchoid.com 2
TOTAL: 3 12

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

CommandCount
Accept-Encoding: gzip 2
EHLO www.censys.io 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: 6 12

NNRP client timeouts [Top 20]:

SystemConnPeer
95.91.193.202 2 0
ip5f5bc1ca.dynamic.kabel-deutschland.de 2 0
TOTAL: 2 4 4

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

HierarchyCountPct
1de 296 79.1%
2linux 44 11.8%
3ger 26 7.0%
4eternal-september 6 1.6%
5news 2 0.5%
TOTAL: 5 374100.0%

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

NewsgroupCount
1de.soc.recht.misc 150
2de.test 68
3linux.debian.user 42
4de.sci.electronics 26
5ger.ct 26
6de.comp.os.unix.linux.hardware 14
7de.soc.recht.strassenverkehr 10
8de.comp.security.misc 8
9de.etc.fahrzeug.auto 6
10de.soc.recht.strafrecht 6
11de.comm.software.newsreader 2
12de.comp.hardware.netzwerke.misc 2
13de.comp.os.unix.linux.misc 2
14de.etc.haushalt 2
15eternal-september.newusers 2
16eternal-september.support 2
17eternal-september.talk 2
18linux.debian.user.german 2
19news.admin.peering 2
TOTAL: 19 374