Daily Usenet report for news.aulich.net

Apr 2 04:15:01 -- Apr 3 04:15:02

Unknown entries from news log file:

First 22 / 22 lines (100.0%)

Apr 2 19:00:03 news pgpverify[766086]: pgpverify: verification failed
Apr 2 19:00:03 news pgpverify[766086]: pgpverify: verification failed
Apr 2 19:00:03 news pgpverify[766095]: pgpverify: verification failed
Apr 2 19:00:03 news pgpverify[766095]: pgpverify: verification failed
Apr 2 19:00:03 news pgpverify[766104]: pgpverify: verification failed
Apr 2 19:00:03 news pgpverify[766104]: pgpverify: verification failed
Apr 2 19:00:04 news pgpverify[766113]: pgpverify: verification failed
Apr 2 19:00:04 news pgpverify[766113]: pgpverify: verification failed
Apr 2 19:00:04 news pgpverify[766122]: pgpverify: verification failed
Apr 2 19:00:04 news pgpverify[766122]: pgpverify: verification failed
Apr 2 19:00:04 news pgpverify[766131]: pgpverify: verification failed
Apr 2 19:00:04 news pgpverify[766131]: pgpverify: verification failed
Apr 2 19:00:04 news pgpverify[766140]: pgpverify: verification failed
Apr 2 19:00:04 news pgpverify[766140]: pgpverify: verification failed
Apr 2 19:00:30 news pgpverify[766157]: pgpverify: verification failed
Apr 2 19:00:30 news pgpverify[766157]: pgpverify: verification failed
Apr 2 19:02:02 news pgpverify[766194]: pgpverify: verification failed
Apr 2 19:02:02 news pgpverify[766194]: pgpverify: verification failed
Apr 3 03:38:47 news nnrpd[780367]: unable to get certificates from '/etc/news/cert.pem'
Apr 3 03:38:47 news nnrpd[780367]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Apr 3 03:38:47 news nnrpd[780367]: unable to get certificates from '/etc/news/cert.pem'
Apr 3 03:38:47 news nnrpd[780367]: 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 nameLines%LinesSize%Size
inn 7440 48.3%1.1 MB 52.5%
innd 5034 32.7%632.7 KB 30.9%
nnrpd 1600 10.4%165.5 KB 8.1%
cnfsstat 864 5.6%117.8 KB 5.7%
innfeed 318 2.1%38.8 KB 1.9%
nocem 110 0.7%14.0 KB 0.7%
controlchan 20 0.1%2.0 KB 0.1%
pgpverify 18 0.1%2.0 KB 0.1%
TOTAL: 8 15404 100.0%2.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 14766 50.0%
Negative hits 14756 49.9%
Positive hits 24 0.1%
Cache misses 6 0.0%
TOTAL: 4 29552 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.026 0.0%134 0.000 0.194 11.000
article cleanup00:00:00.052 0.0%14762 0.000 0.004 0.040
article logging00:00:00.264 0.0%14838 0.000 0.018 0.081
article parse00:00:00.128 0.0%20822 0.000 0.006 0.056
article write00:00:00.932 0.0%13274 0.000 0.070 2.027
artlog/artcncl00:00:00.000 0.0%40 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.010 0.0%31402 0.000 0.000 0.014
hisgrep/artcncl00:00:00.000 0.0%154 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%40 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.160 0.0%29524 0.000 0.005 0.643
history sync00:00:00.022 0.0%596 0.000 0.037 0.500
history write00:00:02.958 0.0%14762 0.000 0.200 2.206
hiswrite/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
idle48:00:05.046100.0%34898 2061.337 4951.718 15003.150
nntp read00:00:00.404 0.0%33844 0.000 0.012 0.061
overview write00:00:19.280 0.0%13274 0.000 1.452 16.455
perl filter00:00:00.288 0.0%14762 0.000 0.020 0.094
python filter00:00:00.000 0.0%14762 0.000 0.000 0.000
site send00:00:00.180 0.0%13396 0.000 0.013 0.100
TOTAL: 2148:00:29.750100.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%7462 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:48:34.842100.0%746217151.343 23065.511 24046.360
status file00:00:00.002 0.0%12 0.000 0.167 0.250
TOTAL: 947:48:34.868100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle08:49:34.870100.0%1562 25.000 20342.426 81867.636
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.446 0.0%7664 0.000 1.102 2.836
readart00:00:00.032 0.0%992 0.000 0.032 0.054
TOTAL: 408:49:43.348100.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.de0001800
TOTAL0001800

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1usenet.blueworldhosting.com 576 14758 13270 0 1488 89%47:26:14
2localhost 52 0 0 0 0 0%00:00:00
TOTAL: 2 628 14758 13270 0 1488 89%47:26:14
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com33.6 MB0.0 KB11.1 MB44.7 MB 75%3.1 KB
2localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 233.6 MB0.0 KB11.1 MB44.7 MB 75%3.1 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 2 04:15:01 - 04:59:59 95 1.4% 0.04207.5 KB 1.2% 0.08
Apr 2 05:00:00 - 05:59:59 117 1.8% 0.03304.2 KB 1.8% 0.08
Apr 2 06:00:00 - 06:59:59 155 2.3% 0.04448.4 KB 2.6% 0.12
Apr 2 07:00:00 - 07:59:59 172 2.6% 0.05479.7 KB 2.8% 0.13
Apr 2 08:00:00 - 08:59:59 210 3.2% 0.06491.0 KB 2.8% 0.14
Apr 2 09:00:00 - 09:59:59 299 4.5% 0.08975.6 KB 5.7% 0.27
Apr 2 10:00:00 - 10:59:59 370 5.6% 0.10727.9 KB 4.2% 0.20
Apr 2 11:00:00 - 11:59:59 400 6.0% 0.11811.9 KB 4.7% 0.23
Apr 2 12:00:00 - 12:59:59 364 5.5% 0.10910.4 KB 5.3% 0.25
Apr 2 13:00:00 - 13:59:59 370 5.6% 0.10905.0 KB 5.2% 0.25
Apr 2 14:00:00 - 14:59:59 423 6.4% 0.121.2 MB 7.2% 0.35
Apr 2 15:00:00 - 15:59:59 380 5.7% 0.11840.9 KB 4.9% 0.23
Apr 2 16:00:00 - 16:59:59 400 6.0% 0.11955.5 KB 5.5% 0.27
Apr 2 17:00:00 - 17:59:59 339 5.1% 0.09889.8 KB 5.2% 0.25
Apr 2 18:00:00 - 18:59:59 357 5.4% 0.10986.2 KB 5.7% 0.27
Apr 2 19:00:00 - 19:59:59 371 5.6% 0.10976.3 KB 5.7% 0.27
Apr 2 20:00:00 - 20:59:59 327 4.9% 0.09857.6 KB 5.0% 0.24
Apr 2 21:00:00 - 21:59:59 315 4.7% 0.09802.7 KB 4.7% 0.22
Apr 2 22:00:00 - 22:59:59 248 3.7% 0.07649.1 KB 3.8% 0.18
Apr 2 23:00:00 - 23:59:59 235 3.5% 0.07615.6 KB 3.6% 0.17
Apr 3 00:00:00 - 00:59:59 229 3.4% 0.06934.5 KB 5.4% 0.26
Apr 3 01:00:00 - 01:59:59 147 2.2% 0.04378.5 KB 2.2% 0.11
Apr 3 02:00:00 - 02:59:59 118 1.8% 0.03362.5 KB 2.1% 0.10
Apr 3 03:00:00 - 03:59:59 154 2.3% 0.04370.5 KB 2.1% 0.10
Apr 3 04:00:00 - 04:15:02 43 0.6% 0.05120.4 KB 0.7% 0.13
TOTAL: 24:00:01 6638 100.0% 0.0816.8 MB 100.0% 0.20
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
DE1DE512.0 MB341.3 MB 66.7% 2 0.13 47.18
INTL1INTL512.0 MB141.7 MB 27.7% 21 0.18 33.66
INTL2INTL512.0 MB149.5 MB 29.2% 21 0.18 33.05
TOTAL: 3-1.5 GB632.5 MB 41.2% 44 0.18-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 782 743 0 0 1 0 0 0 38
TOTAL: 1 782 743 0 0 1 0 0 0 38

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 360
linux.kernel.git 98
fido7.ukrnews 84
alt.computer.workshop 48
hispagatos.hacking.ransomware 26
it-alt.sport.calcio.juventus 14
fido7.lorapvt.horo 12
lada.talk 10
fido7.f715.techinfo 8
fido7.crimea.robots 5
fido7.fidonet.online 5
fido7.pushkin.local 5
hispagatos.mastodon.tag.hacking 5
wolfsburg.test 5
alt.bbs.synchronet 4
fido7.f715.echo 4
hispagatos.talk 4
fido7.nodex.tech 3
alt.att 2
fido7.altyn.local 2
TOTAL: 56 743

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

GroupsCount
tw.bbs.announce 1
TOTAL: 1 1

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
nocem@eternal-september.org (misplaced_binary)4010010
robot@pasdenom.info (spam2)46005656
robot@pasdenom.info (spam)34004242
robot@pasdenom.info (spam3)8001818
robot@pasdenom.info (spam4)12001818
TOTAL: 5104010134144

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
usenet.blueworldhosting.com 2
TOTAL: 1 2
Including strange strings
usenet.blueworldhosting.com 38
TOTAL: 1 38
TOTAL: 2 40

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 12 9922.6 MB 120 0 008:49:30
TOTAL: 1 12 9922.6 MB 120 0 008:49:30

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.dynamic.kabel-deutschland.de 12 9922.6 MB 120 0 008:49:30
2*.probe.onyphe.net 4 00.0 KB 0 0 000:00:07
3unresolved 4 00.0 KB 0 0 000:00:01
4*.66.censys-scanner.com 2 00.0 KB 0 0 000:00:04
5*.compute.amazonaws.com 2 00.0 KB 0 0 000:00:00
TOTAL: 5 24 9922.6 MB 120 0 008:49:43

NNRP auth users [Top 20]:

UserConn
peter@aulich.net 12
TOTAL: 1 12

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ip5f5bc1ca.dynamic.kabel-deutschland.de 0.130 0.252 0.05008:49:30
theodore.probe.onyphe.net 0.006 0.006 0.00000:00:06
204.172.132.66.censys-scanner.com 0.046 0.000 0.00000:00:04
leyla.probe.onyphe.net 0.000 0.014 0.00000:00:01
205.210.31.26 0.000 0.012 0.00000:00:00
71.6.134.234 0.006 0.006 0.00000:00:00
ec2-54-153-17-33.us-west-1.compute.amazonaws.com 0.006 0.006 0.00000:00:00
TOTAL: 7 0.194 0.296 0.05008:49:43

Curious NNRP explorers [Top 20]:

SystemConn
204.172.132.66.censys-scanner.com 2
205.210.31.26 2
71.6.134.234 2
ec2-54-153-17-33.us-west-1.compute.amazonaws.com 2
leyla.probe.onyphe.net 2
theodore.probe.onyphe.net 2
TOTAL: 6 12

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

SystemConn
leyla.probe.onyphe.net 6
204.172.132.66.censys-scanner.com 2
TOTAL: 2 8

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

CommandCount
$l>?#017|?2?!?#004#0031#022#032#032?D?5o?#035j#020?(? 2
#026#003#003#001?#001 2
?$?,?r?s?#023#002#023#001?#024?#007?#022?#023?'?/?#024?(?0?`?a... 2
EHLO www.censys.io 2
TOTAL: 4 8

NNRP client timeouts [Top 20]:

SystemConnPeer
ip5f5bc1ca.dynamic.kabel-deutschland.de 12 0
TOTAL: 1 12 2

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

HierarchyCountPct
1de 630 63.5%
2ger 216 21.8%
3linux 70 7.1%
4comp 38 3.8%
5eternal-september 18 1.8%
6news 18 1.8%
7alt 2 0.2%
TOTAL: 7 992100.0%

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

NewsgroupCount
1ger.ct 216
2de.test 104
3de.rec.fahrrad 96
4linux.debian.user 70
5de.comp.os.unix.linux.misc 60
6de.sci.electronics 60
7de.rec.mampf 58
8de.alt.folklore.computer 46
9de.admin.news.groups 40
10comp.sys.raspberry-pi 38
11de.etc.fahrzeug.auto 36
12de.rec.heimwerken 24
13de.etc.haushalt 20
14eternal-september.support 16
15news.software.nntp 12
16de.comm.software.newsreader 10
17de.comp.lang.perl 10
18de.soc.recht.misc 10
19de.soc.recht.arbeit+soziales 8
20de.admin.news.announce 6
21de.comp.security.misc 6
22de.rec.tv.technik 6
23de.soc.recht.wohnen 6
24de.alt.folklore.usenet 4
25de.alt.netdigest 4
26de.comm.software.mailserver 4
27de.org.ccc 4
28news.software.readers 4
29alt.usenet.peering 2
30de.admin.news.misc 2
31de.comp.os.unix.networking.misc 2
32de.etc.post 2
33de.rec.fotografie 2
34eternal-september.talk 2
35news.admin.peering 2
TOTAL: 35 992