Daily Usenet report for news.aulich.net

Sep 15 04:15:01 -- Sep 16 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Sep 15 13:32:09 news nnrpd[694570]: unable to get certificates from '/etc/news/cert.pem'
Sep 15 13:32:09 news nnrpd[694570]: unable to get certificates from '/etc/news/cert.pem'
Sep 15 13:32:09 news nnrpd[694570]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Sep 15 13:32:09 news nnrpd[694570]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Sep 15 14:38:19 news nnrpd[696816]: unable to get certificates from '/etc/news/cert.pem'
Sep 15 14:38:19 news nnrpd[696816]: unable to get certificates from '/etc/news/cert.pem'
Sep 15 14:38:19 news nnrpd[696816]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Sep 15 14:38:19 news nnrpd[696816]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Sep 15 17:00:07 news pgpverify[699813]: pgpverify: verification failed
Sep 15 17:00:07 news pgpverify[699813]: pgpverify: verification failed
Sep 15 20:46:21 news nnrpd[703576]: unable to get certificates from '/etc/news/cert.pem'
Sep 15 20:46:21 news nnrpd[703576]: unable to get certificates from '/etc/news/cert.pem'
Sep 15 20:46:21 news nnrpd[703576]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Sep 15 20:46:21 news nnrpd[703576]: 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 8400 44.2%1.2 MB 47.7%
innd 8026 42.3%1.0 MB 40.6%
nnrpd 1256 6.6%129.7 KB 5.1%
cnfsstat 864 4.6%116.1 KB 4.5%
innfeed 318 1.7%34.4 KB 1.3%
nocem 74 0.4%8.9 KB 0.3%
controlchan 48 0.3%11.3 KB 0.4%
pgpverify 2 0.0%0.2 KB 0.0%
TOTAL: 8 18988 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 16618 50.0%
Negative hits 16618 50.0%
Positive hits 18 0.1%
Cache misses 0 0.0%
TOTAL: 4 33254 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.090 0.0%86 0.000 1.047 17.000
article cleanup00:00:00.064 0.0%16614 0.000 0.004 0.032
article logging00:00:00.294 0.0%16770 0.000 0.018 0.125
article parse00:00:00.176 0.0%25304 0.000 0.007 0.061
article write00:00:01.012 0.0%15114 0.000 0.067 0.810
artlog/artcncl00:00:00.000 0.0%18 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%12 0.000 0.000 0.000
data move00:00:00.038 0.0%36640 0.000 0.001 0.017
hisgrep/artcncl00:00:00.050 0.0%104 0.000 0.481 7.000
hishave/artcncl00:00:00.000 0.0%18 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:15.174 0.0%33252 0.000 0.456 5.414
history sync00:00:00.030 0.0%580 0.000 0.052 1.000
history write00:00:20.250 0.0%16626 0.000 1.218 8.379
idle47:59:34.646100.0%43266 1719.341 3993.312 11766.725
nntp read00:00:00.484 0.0%41318 0.000 0.012 0.065
overview write00:00:16.760 0.0%15114 0.000 1.109 8.148
perl filter00:00:00.338 0.0%16614 0.000 0.020 0.078
python filter00:00:00.000 0.0%16614 0.000 0.000 0.000
site send00:00:00.226 0.0%15190 0.000 0.015 0.068
TOTAL: 2048:00:29.632100.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.018 0.0%7466 0.000 0.002 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:40.610100.0%746617153.543 23053.926 23335.111
status file00:00:00.004 0.0%12 0.250 0.333 0.500
TOTAL: 947:48:40.632100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle08:22:26.764100.0%706 16.500 42700.799 95523.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.020 0.0%3880 0.000 0.005 0.250
readart00:00:00.058 0.0%362 0.000 0.160 0.201
TOTAL: 408:22:26.842100.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
group-admin@isc.org004224
TOTAL004224

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1usenet.blueworldhosting.com 1438 16624 15112 0 1512 90%47:32:06
2localhost 50 0 0 0 0 0%00:00:00
TOTAL: 2 1488 16624 15112 0 1512 90%47:32:06
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com44.2 MB0.0 KB11.2 MB55.4 MB 79%3.4 KB
2localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 244.2 MB0.0 KB11.2 MB55.4 MB 79%3.4 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 15 04:15:01 - 04:59:59 95 1.3% 0.04342.0 KB 1.5% 0.13
Sep 15 05:00:00 - 05:59:59 135 1.8% 0.04360.3 KB 1.6% 0.10
Sep 15 06:00:00 - 06:59:59 212 2.8% 0.06636.9 KB 2.8% 0.18
Sep 15 07:00:00 - 07:59:59 205 2.7% 0.06641.4 KB 2.8% 0.18
Sep 15 08:00:00 - 08:59:59 283 3.7% 0.08796.3 KB 3.5% 0.22
Sep 15 09:00:00 - 09:59:59 359 4.8% 0.10877.3 KB 3.9% 0.24
Sep 15 10:00:00 - 10:59:59 523 6.9% 0.151.2 MB 5.3% 0.33
Sep 15 11:00:00 - 11:59:59 403 5.3% 0.111.0 MB 4.5% 0.29
Sep 15 12:00:00 - 12:59:59 386 5.1% 0.111.0 MB 4.7% 0.30
Sep 15 13:00:00 - 13:59:59 417 5.5% 0.12998.6 KB 4.4% 0.28
Sep 15 14:00:00 - 14:59:59 366 4.8% 0.10948.8 KB 4.2% 0.26
Sep 15 15:00:00 - 15:59:59 355 4.7% 0.101.0 MB 4.6% 0.29
Sep 15 16:00:00 - 16:59:59 391 5.2% 0.11961.7 KB 4.2% 0.27
Sep 15 17:00:00 - 17:59:59 407 5.4% 0.112.0 MB 8.8% 0.56
Sep 15 18:00:00 - 18:59:59 352 4.7% 0.101.1 MB 5.1% 0.32
Sep 15 19:00:00 - 19:59:59 406 5.4% 0.111.2 MB 5.4% 0.34
Sep 15 20:00:00 - 20:59:59 417 5.5% 0.121.4 MB 6.4% 0.40
Sep 15 21:00:00 - 21:59:59 377 5.0% 0.101.1 MB 5.0% 0.31
Sep 15 22:00:00 - 22:59:59 416 5.5% 0.121.3 MB 5.7% 0.36
Sep 15 23:00:00 - 23:59:59 295 3.9% 0.081.0 MB 4.7% 0.30
Sep 16 00:00:00 - 00:59:59 217 2.9% 0.06721.0 KB 3.2% 0.20
Sep 16 01:00:00 - 01:59:59 177 2.3% 0.05574.4 KB 2.5% 0.16
Sep 16 02:00:00 - 02:59:59 192 2.5% 0.05647.6 KB 2.9% 0.18
Sep 16 03:00:00 - 03:59:59 129 1.7% 0.04350.9 KB 1.6% 0.10
Sep 16 04:00:00 - 04:15:02 42 0.6% 0.05100.2 KB 0.4% 0.11
TOTAL: 24:00:01 7557 100.0% 0.0922.1 MB 100.0% 0.26
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
DE1DE512.0 MB428.9 MB 83.8% 1 0.13 47.64
INTL1INTL512.0 MB35.1 MB 6.9% 13 0.22 27.20
INTL2INTL512.0 MB36.5 MB 7.1% 13 0.22 27.47
TOTAL: 3-1.5 GB500.6 MB 32.6% 27 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 834 750 0 0 0 0 0 0 84
TOTAL: 1 834 750 0 0 0 0 0 0 84

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 336
fido7.ukrnews 92
lada.talk 57
linux.kernel.git 57
alt.computer.workshop 43
it-alt.sport.calcio.juventus 37
fido7.pushkin.local 18
fido7.f715.techinfo 14
alt.pl.nieruchomosci.gielda 12
fido7.lorapvt.horo 12
fido7.fidonet.online 11
alt.bbs.synchronet 9
eternal-september.info 7
greenend.test 7
fido7.crimea.robots 6
hispagatos.hacking.news 5
linux.ubuntu.security.announce 5
newsgrouper.support 5
alt.slack.goathead 3
fido.pushkin.local 3
TOTAL: 28 750

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
robot@pasdenom.info (spam3)14005656
robot@pasdenom.info (spam2)32003636
robot@pasdenom.info (spam4)12002626
TOTAL: 35800118118

Miscellaneous innd statistics [Top 10]:

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

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 8 362883.6 KB 50 0 008:14:02
TOTAL: 1 8 362883.6 KB 50 0 008:14:02

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.dynamic.kabel-deutschland.de 8 362883.6 KB 50 0 008:14:02
2unresolved 42 00.0 KB 0 0 000:08:24
TOTAL: 2 50 362883.6 KB 50 0 008:22:26

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
ip5f5bc1ca.dynamic.kabel-deutschland.de 0.036 0.114 0.03208:14:02
205.210.31.7 0.006 0.030 0.00000:06:28
205.210.31.160 0.000 0.012 0.00000:00:27
199.45.154.116 0.074 0.022 0.00000:00:21
48.214.144.135 0.008 0.020 0.00000:00:21
52.180.136.250 0.020 0.006 0.00000:00:20
206.168.34.222 0.014 0.030 0.00000:00:09
167.94.146.57 0.050 0.022 0.00000:00:06
198.235.24.104 0.006 0.006 0.00000:00:04
198.235.24.151 0.006 0.006 0.00000:00:02
194.165.16.161 0.006 0.006 0.00000:00:00
183.160.195.167 0.000 0.014 0.00000:00:00
TOTAL: 12 0.226 0.288 0.03208:22:26

Curious NNRP explorers [Top 20]:

SystemConn
199.45.154.116 10
167.94.146.57 6
205.210.31.7 6
48.214.144.135 4
52.180.136.250 4
183.160.195.167 2
194.165.16.161 2
198.235.24.104 2
198.235.24.151 2
205.210.31.160 2
206.168.34.222 2
TOTAL: 11 42

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

SystemConn
199.45.154.116 8
167.94.146.57 2
194.165.16.161 2
206.168.34.222 2
48.214.144.135 2
52.180.136.250 2
TOTAL: 6 18

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

CommandCount
EHLO www.censys.io 6
MGLNDD_85.31.187.13_119 4
#003 2
#023#003#023#001#023#002#001 2
#026#003#001 2
?1?#023 ?#0245?nX#023#010?e?V#030?#034_k?#0233?#036? 2
TOTAL: 6 18

NNRP client timeouts [Top 20]:

SystemConnPeer
ip5f5bc1ca.dynamic.kabel-deutschland.de 8 0
199.45.154.116 4 6
205.210.31.7 4 6
167.94.146.57 2 4
194.165.16.161 2 2
205.210.31.160 2 2
TOTAL: 6 22 24

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

HierarchyCountPct
1de 272 75.1%
2ger 58 16.0%
3eternal-september 16 4.4%
4linux 10 2.8%
5news 6 1.7%
TOTAL: 5 362100.0%

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

NewsgroupCount
1de.comp.os.unix.linux.misc 88
2ger.ct 58
3de.sci.electronics 42
4de.etc.fahrzeug.auto 38
5de.rec.fahrrad 20
6de.alt.folklore.computer 16
7eternal-september.newusers 16
8de.comp.security.misc 12
9de.sci.ing.elektrotechnik 12
10de.soc.recht.misc 12
11linux.debian.user.german 10
12de.rec.mampf 8
13de.etc.haushalt 6
14de.etc.notfallrettung 6
15de.test 6
16news.software.nntp 6
17de.alt.netdigest 4
18de.comp.os.unix.linux.hardware 2
TOTAL: 18 362