Daily Usenet report for news.aulich.net

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

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Jan 1 12:15:02 news pgpverify[871136]: pgpverify: verification failed
Jan 1 12:15:02 news pgpverify[871136]: pgpverify: verification failed
Jan 2 00:32:49 news nnrpd[893133]: unable to get certificates from '/etc/news/cert.pem'
Jan 2 00:32:49 news nnrpd[893133]: unable to get certificates from '/etc/news/cert.pem'
Jan 2 00:32:49 news nnrpd[893133]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jan 2 00:32:49 news nnrpd[893133]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jan 2 04:03:02 news nnrpd[900452]: unable to get certificates from '/etc/news/cert.pem'
Jan 2 04:03:02 news nnrpd[900452]: unable to get certificates from '/etc/news/cert.pem'
Jan 2 04:03:02 news nnrpd[900452]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jan 2 04:03:02 news nnrpd[900452]: 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 9805 33.1%1.4 MB 40.3%
innd 9750 32.9%1.2 MB 33.8%
nnrpd 8638 29.2%704.8 KB 20.0%
cnfsstat 864 2.9%117.2 KB 3.3%
innfeed 318 1.1%31.4 KB 0.9%
nocem 182 0.6%48.6 KB 1.4%
controlchan 44 0.1%10.3 KB 0.3%
pgpverify 2 0.0%0.1 KB 0.0%
TOTAL: 8 29603 100.0%3.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 19272 50.9%
Negative hits 18534 48.9%
Cache misses 62 0.2%
Positive hits 16 0.0%
TOTAL: 4 37884 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.744 0.0%992 0.000 0.750 31.000
article cleanup00:00:00.062 0.0%18540 0.000 0.003 0.047
article logging00:00:00.300 0.0%18758 0.000 0.016 0.070
article parse00:00:00.154 0.0%26568 0.000 0.006 0.031
article write00:00:01.350 0.0%17880 0.000 0.076 0.867
artlog/artcncl00:00:00.002 0.0%800 0.000 0.003 0.004
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.134 0.0%36418 0.000 0.004 0.462
hisgrep/artcncl00:00:00.000 0.0%332 0.000 0.000 0.000
hishave/artcncl00:00:00.002 0.0%800 0.000 0.003 0.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.102 0.0%37100 0.000 0.003 0.028
history sync00:00:00.024 0.0%792 0.000 0.030 0.500
history write00:00:02.104 0.0%18542 0.000 0.113 1.923
hiswrite/artcncl00:00:00.006 0.0%730 0.000 0.008 0.018
idle47:41:36.778100.0%42062 1628.046 4081.993 12256.265
nntp read00:00:00.670 0.0%39448 0.000 0.017 0.542
overview write00:00:18.242 0.0%17880 0.000 1.020 4.638
perl filter00:00:00.330 0.0%18540 0.000 0.018 0.087
python filter00:00:00.004 0.0%18540 0.000 0.000 0.012
site send00:00:00.306 0.0%18046 0.000 0.017 0.062
TOTAL: 2147:42:01.314100.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.028 0.0%7468 0.000 0.004 0.038
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:50:37.788100.0%746817186.029 23063.442 24063.080
status file00:00:00.006 0.0%12 0.250 0.500 1.000
TOTAL: 947:50:37.822100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle07:06:01.818 99.9%17376 14.000 1471.099 60095.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:13.988 0.1%41866 0.000 0.334 4.028
readart00:00:02.754 0.0%2332 0.000 1.181 4.704
TOTAL: 407:06:18.560100.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
control@eternal-september.org002002
moderator@dana.de002202
TOTAL004204

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1usenet.blueworldhosting.com 1424 18602 17932 8 662 96%47:35:44
2localhost 62 0 0 0 0 0%00:00:00
TOTAL: 2 1486 18602 17932 8 662 96%47:35:44
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com53.1 MB0.0 KB2.8 MB55.9 MB 95%3.1 KB
2localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 253.1 MB0.0 KB2.8 MB55.9 MB 95%3.1 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 1 04:15:02 - 04:59:59 137 1.5% 0.05271.0 KB 1.0% 0.10
Jan 1 05:00:00 - 05:59:59 216 2.4% 0.06457.7 KB 1.7% 0.13
Jan 1 06:00:00 - 06:59:59 215 2.4% 0.06479.9 KB 1.8% 0.13
Jan 1 07:00:00 - 07:59:59 232 2.6% 0.06619.2 KB 2.3% 0.17
Jan 1 08:00:00 - 08:59:59 329 3.7% 0.092.0 MB 7.6% 0.58
Jan 1 09:00:00 - 09:59:59 320 3.6% 0.093.1 MB 11.6% 0.88
Jan 1 10:00:00 - 10:59:59 362 4.0% 0.10700.5 KB 2.6% 0.19
Jan 1 11:00:00 - 11:59:59 403 4.5% 0.11975.9 KB 3.6% 0.27
Jan 1 12:00:00 - 12:59:59 436 4.9% 0.121.0 MB 3.8% 0.29
Jan 1 13:00:00 - 13:59:59 466 5.2% 0.13885.6 KB 3.3% 0.25
Jan 1 14:00:00 - 14:59:59 514 5.7% 0.141.1 MB 4.1% 0.31
Jan 1 15:00:00 - 15:59:59 489 5.5% 0.141.1 MB 4.0% 0.30
Jan 1 16:00:00 - 16:59:59 451 5.0% 0.131.3 MB 4.9% 0.37
Jan 1 17:00:00 - 17:59:59 488 5.4% 0.141.4 MB 5.2% 0.39
Jan 1 18:00:00 - 18:59:59 428 4.8% 0.121.5 MB 5.6% 0.42
Jan 1 19:00:00 - 19:59:59 503 5.6% 0.141.8 MB 6.6% 0.50
Jan 1 20:00:00 - 20:59:59 494 5.5% 0.141.3 MB 5.1% 0.38
Jan 1 21:00:00 - 21:59:59 527 5.9% 0.151.4 MB 5.3% 0.40
Jan 1 22:00:00 - 22:59:59 367 4.1% 0.10913.3 KB 3.4% 0.25
Jan 1 23:00:00 - 23:59:59 424 4.7% 0.121.0 MB 3.8% 0.28
Jan 2 00:00:00 - 00:59:59 361 4.0% 0.101.1 MB 4.1% 0.31
Jan 2 01:00:00 - 01:59:59 269 3.0% 0.07685.1 KB 2.5% 0.19
Jan 2 02:00:00 - 02:59:59 269 3.0% 0.071.1 MB 4.1% 0.31
Jan 2 03:00:00 - 03:59:59 213 2.4% 0.06464.3 KB 1.7% 0.13
Jan 2 04:00:00 - 04:15:01 52 0.6% 0.06140.7 KB 0.5% 0.16
TOTAL: 23:59:59 8965 100.0% 0.1026.6 MB 100.0% 0.31
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
DE1DE512.0 MB147.8 MB 28.9% 2 0.05 124.70
INTL1INTL512.0 MB363.5 MB 71.0% 17 0.28 21.65
INTL2INTL512.0 MB371.0 MB 72.5% 17 0.27 22.60
TOTAL: 3-1.5 GB882.2 MB 57.4% 36 0.23-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 440 330 0 0 0 0 0 0 110
TOTAL: 1 440 330 0 0 0 0 0 0 110

Unwanted newsgroups [Top 20]:

NewsgroupCount
fido7.ukrnews 71
linux.kernel.netdev 61
alt.computer.workshop 47
fido7.fidonet.online 45
linux.kernel.git 25
fido7.lorapvt.horo 12
alt.bbs.synchronet 9
fido7.f715.techinfo 8
hispagatos.mastodon.tag.hacking 8
lada.talk 7
alt.slack.goathead 4
fido7.crimea.robots 4
fido7.starper.limited 4
fido7.nodex.tech 3
it-alt.sport.calcio.juventus 3
alt.test.9 2
fido7.altyn.local 2
alt.chat-programs.jabber 1
alt.philosophy 1
alt.religion 1
TOTAL: 32 330

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
nocem@eternal-september.org (misplaced_binary)1807300730
robot@pasdenom.info (spam2)9800110110
robot@pasdenom.info (spam3)14005252
robot@pasdenom.info (spam)26002828
robot@pasdenom.info (spam4)60088
TOTAL: 51620730198928

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.blueworldhosting.com 109
TOTAL: 1 109
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 110

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1usenet.blueworldhosting.com 0 0 0 0 0 0 0%00:20:02
TOTAL: 1 0 0 0 0 0 0 0%00:20:02
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:02
TOTAL: 10.0 KB0.0 KB0.0 KB0.0 KB/s000:20:02
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 244 20124.0 MB 18 0 001:35:59
295.91.193.202 8 238933.3 KB 60 0 005:28:56
TOTAL: 2 252 22504.9 MB 78 0 007:04:55

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 266 22504.9 MB 78 0 007:05:09
2*.ch1.censys-scanner.com 10 00.0 KB 0 0 000:00:45
3*.stretchoid.com 4 00.0 KB 0 0 000:00:20
4*.li.binaryedge.ninja 2 00.0 KB 0 0 000:00:03
5*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
TOTAL: 5 284 22504.9 MB 78 0 007:06:18

NNRP auth users [Top 20]:

UserConn
peter@aulich.net 8
TOTAL: 1 8

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
95.91.193.202 0.074 0.060 0.02405:28:56
66.61.98.95 1.370 1.964 0.00001:35:59
scanner-07.ch1.censys-scanner.com 0.008 0.048 0.00000:00:37
azpdsswjg3it.stretchoid.com 0.018 0.006 0.00000:00:20
scanner-06.ch1.censys-scanner.com 0.016 0.024 0.00000:00:07
167.94.146.54 0.038 0.028 0.00000:00:07
205.210.31.59 0.000 0.012 0.00000:00:05
prod-boron-us-southeast-8.li.binaryedge.ninja 0.000 0.012 0.00000:00:03
205.210.31.211 0.000 0.012 0.00000:00:00
185.169.4.104 0.012 0.000 0.00000:00:00
o314.scanner.modat.io 0.008 0.008 0.00000:00:00
198.235.24.171 0.012 0.000 0.00000:00:00
TOTAL: 12 1.556 2.174 0.02407:06:18

Curious NNRP explorers [Top 20]:

SystemConn
scanner-07.ch1.censys-scanner.com 8
167.94.146.54 6
azpdsswjg3it.stretchoid.com 4
185.169.4.104 2
198.235.24.171 2
205.210.31.211 2
205.210.31.59 2
o314.scanner.modat.io 2
prod-boron-us-southeast-8.li.binaryedge.ninja 2
scanner-06.ch1.censys-scanner.com 2
TOTAL: 10 32

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

SystemConn
167.94.146.54 2
185.169.4.104 2
azpdsswjg3it.stretchoid.com 2
scanner-06.ch1.censys-scanner.com 2
TOTAL: 4 8

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

CommandCount
EHLO www.censys.io 4
#003 2
MGLNDD_85.31.187.13_119 2
TOTAL: 3 8

NNRP client timeouts [Top 20]:

SystemConnPeer
95.91.193.202 6 0
167.94.146.54 2 4
185.169.4.104 2 2
scanner-07.ch1.censys-scanner.com 2 6
TOTAL: 4 12 18

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

HierarchyCountPct
1de 2168 96.4%
2comp 16 0.7%
3fido7 12 0.5%
4linux 12 0.5%
5can 8 0.4%
6it 8 0.4%
7pl 8 0.4%
8eternal-september 6 0.3%
9news 6 0.3%
10sci 4 0.2%
11alt 2 0.1%
TOTAL: 11 2250100.0%

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

NewsgroupCount
1de.sci.electronics 1976
2de.comp.os.unix.linux.misc 50
3de.rec.tv.technik 28
4de.sci.ing.elektrotechnik 26
5de.etc.fahrzeug.auto 22
6comp.os.linux.misc 14
7de.comp.security.misc 12
8linux.debian.user 12
9de.alt.folklore.computer 10
10de.test 8
11fido7.ru.ludeny 8
12pl.misc.elektronika 8
13de.comp.os.unix.apps.kde 6
14de.comp.os.unix.linux.hardware 6
15eternal-september.talk 6
16can.community.asian 4
17can.motss 4
18de.etc.haushalt 4
19de.etc.post 4
20de.rec.fotografie 4
21de.rec.mampf 4
22fido7.ru.fidonet.digest 4
23it.sociale.volontariato 4
24it.tlc.cellulari.android 4
25news.software.nntp 4
26sci.physics.research 4
27alt.usenet.peering 2
28comp.sys.raspberry-pi 2
29de.alt.netdigest 2
30de.comm.provider.usenet 2
31de.comm.software.newsreader 2
32de.rec.reisen.misc 2
33news.admin.peering 2
TOTAL: 33 2250