Daily Usenet report for news.aulich.net

Jul 18 04:15:01 -- Jul 19 04:15:01

Unknown entries from news log file:

First 50 / 92 lines (54.3%)

Jul 18 16:21:18 news nnrpd[3099158]: unable to get certificates from '/etc/news/cert.pem'
Jul 18 16:21:18 news nnrpd[3099158]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 18 22:00:04 news pgpverify[3107592]: pgpverify: verification failed
Jul 18 22:01:08 news pgpverify[3107608]: pgpverify: verification failed
Jul 18 22:02:12 news pgpverify[3107625]: pgpverify: verification failed
Jul 18 22:03:13 news pgpverify[3107643]: pgpverify: verification failed
Jul 18 22:04:15 news pgpverify[3107659]: pgpverify: verification failed
Jul 18 22:05:17 news pgpverify[3107675]: pgpverify: verification failed
Jul 18 22:06:19 news pgpverify[3107695]: pgpverify: verification failed
Jul 18 22:07:21 news pgpverify[3107713]: pgpverify: verification failed
Jul 18 22:08:22 news pgpverify[3107778]: pgpverify: verification failed
Jul 18 22:09:24 news pgpverify[3107964]: pgpverify: verification failed
Jul 18 22:10:26 news pgpverify[3108011]: pgpverify: verification failed
Jul 18 22:11:27 news pgpverify[3108074]: pgpverify: verification failed
Jul 18 22:12:28 news pgpverify[3108090]: pgpverify: verification failed
Jul 18 22:13:30 news pgpverify[3108107]: pgpverify: verification failed
Jul 18 22:14:32 news pgpverify[3108126]: pgpverify: verification failed
Jul 18 22:15:33 news pgpverify[3108146]: pgpverify: verification failed
Jul 18 22:16:34 news pgpverify[3108163]: pgpverify: verification failed
Jul 18 22:17:36 news pgpverify[3108182]: pgpverify: verification failed
Jul 18 22:18:38 news pgpverify[3108201]: pgpverify: verification failed
Jul 18 22:19:39 news pgpverify[3108362]: pgpverify: verification failed
Jul 18 22:20:41 news pgpverify[3108388]: pgpverify: verification failed
Jul 18 22:21:42 news pgpverify[3108419]: pgpverify: verification failed
Jul 18 22:22:44 news pgpverify[3108441]: pgpverify: verification failed
Jul 18 22:23:45 news pgpverify[3108468]: pgpverify: verification failed
Jul 18 22:24:47 news pgpverify[3108497]: pgpverify: verification failed
Jul 18 22:25:48 news pgpverify[3108523]: pgpverify: verification failed
Jul 18 22:26:50 news pgpverify[3108547]: pgpverify: verification failed
Jul 18 22:27:51 news pgpverify[3108572]: pgpverify: verification failed
Jul 18 22:28:53 news pgpverify[3108598]: pgpverify: verification failed
Jul 18 22:29:54 news pgpverify[3108763]: pgpverify: verification failed
Jul 18 22:30:57 news pgpverify[3108788]: pgpverify: verification failed
Jul 18 22:31:58 news pgpverify[3108813]: pgpverify: verification failed
Jul 18 22:32:59 news pgpverify[3108841]: pgpverify: verification failed
Jul 18 22:34:01 news pgpverify[3108869]: pgpverify: verification failed
Jul 18 22:35:03 news pgpverify[3108898]: pgpverify: verification failed
Jul 18 22:36:07 news pgpverify[3108921]: pgpverify: verification failed
Jul 18 22:37:07 news pgpverify[3108946]: pgpverify: verification failed
Jul 18 22:38:09 news pgpverify[3108972]: pgpverify: verification failed
Jul 18 22:39:10 news pgpverify[3108998]: pgpverify: verification failed
Jul 18 22:40:12 news pgpverify[3109163]: pgpverify: verification failed
Jul 18 22:41:14 news pgpverify[3109188]: pgpverify: verification failed
Jul 18 22:42:15 news pgpverify[3109215]: pgpverify: verification failed
Jul 18 22:43:16 news pgpverify[3109240]: pgpverify: verification failed
Jul 18 22:44:18 news pgpverify[3109263]: pgpverify: verification failed
Jul 18 22:45:20 news pgpverify[3109293]: pgpverify: verification failed
Jul 18 22:46:22 news pgpverify[3109323]: pgpverify: verification failed
Jul 18 22:47:24 news pgpverify[3109346]: pgpverify: verification failed
Jul 18 22:48:25 news pgpverify[3109369]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 8684 62.2%1.2 MB 65.1%
innd 4023 28.8%535.3 KB 27.6%
cnfsstat 432 3.1%54.8 KB 2.8%
nnrpd 392 2.8%38.9 KB 2.0%
controlchan 181 1.3%18.4 KB 0.9%
innfeed 156 1.1%15.4 KB 0.8%
pgpverify 90 0.6%12.2 KB 0.6%
nocem 13 0.1%1.3 KB 0.1%
TOTAL: 8 13971 100.0%1.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 8600 50.0%
Negative hits 8599 50.0%
Positive hits 11 0.1%
Cache misses 3 0.0%
TOTAL: 4 17213 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.561 0.0%54 0.000 10.389 158.000
article cleanup00:00:00.030 0.0%8609 0.000 0.003 0.040
article logging00:00:00.204 0.0%8654 0.000 0.024 0.537
article parse00:00:00.087 0.0%11785 0.000 0.007 0.048
article write00:00:03.350 0.0%8128 0.000 0.412 9.981
artlog/artcncl00:00:00.000 0.0%15 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.167 0.0%17901 0.000 0.009 1.145
hisgrep/artcncl00:00:00.119 0.0%64 0.000 1.859 40.000
hishave/artcncl00:00:00.000 0.0%15 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:27.044 0.0%17220 0.000 1.570 45.763
history sync00:00:00.116 0.0%295 0.000 0.393 32.333
history write00:00:35.659 0.0%8610 0.000 4.142 86.220
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:58:19.242 99.9%20885 1040.836 4132.116 13955.930
nntp read00:00:00.825 0.0%19914 0.000 0.041 3.713
overview write00:00:44.742 0.1%8128 0.000 5.505 122.397
perl filter00:00:00.269 0.0%8609 0.000 0.031 1.273
python filter00:00:00.003 0.0%8609 0.000 0.000 0.043
site send00:00:00.149 0.0%8381 0.000 0.018 0.111
TOTAL: 24:00:21.21124:00:12.567100.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.017 0.0%3730 0.000 0.005 0.111
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.000 0.0%3 0.000 0.000 0.000
data write00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:54:49.514100.0%373017683.853 23080.299 24055.360
status file00:00:00.001 0.0%6 0.000 0.167 0.250
TOTAL: 23:54:49.89823:54:49.532100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:28:32.444100.0%460 4.000 27200.965300033.167
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.049 0.0%2025 0.000 0.024 0.500
readart00:00:00.038 0.0%306 0.000 0.124 0.155
TOTAL: 03:28:33.93703:28:32.531100.0%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 171

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org0900909090
TOTAL0900909090

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1usenet.blueworldhosting.com 717 8621 8136 0 485 94%23:44:14
2localhost 29 0 0 0 0 0%00:00:00
TOTAL: 2 746 8621 8136 0 485 94%23:44:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com23.5 MB0.0 KB2.6 MB26.0 MB 90%3.1 KB
2localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 223.5 MB0.0 KB2.6 MB26.0 MB 90%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 18 04:15:01 - 04:59:59 90 1.1% 0.03246.5 KB 1.0% 0.09
Jul 18 05:00:00 - 05:59:59 123 1.5% 0.03397.7 KB 1.7% 0.11
Jul 18 06:00:00 - 06:59:59 148 1.8% 0.04438.7 KB 1.8% 0.12
Jul 18 07:00:00 - 07:59:59 207 2.5% 0.06815.3 KB 3.4% 0.23
Jul 18 08:00:00 - 08:59:59 292 3.6% 0.08870.3 KB 3.6% 0.24
Jul 18 09:00:00 - 09:59:59 340 4.2% 0.09816.9 KB 3.4% 0.23
Jul 18 10:00:00 - 10:59:59 345 4.2% 0.10908.5 KB 3.8% 0.25
Jul 18 11:00:00 - 11:59:59 431 5.3% 0.121.4 MB 5.9% 0.39
Jul 18 12:00:00 - 12:59:59 390 4.8% 0.111.1 MB 4.6% 0.31
Jul 18 13:00:00 - 13:59:59 360 4.4% 0.101.0 MB 4.4% 0.29
Jul 18 14:00:00 - 14:59:59 363 4.5% 0.101002.6 KB 4.2% 0.28
Jul 18 15:00:00 - 15:59:59 464 5.7% 0.131.2 MB 5.3% 0.36
Jul 18 16:00:00 - 16:59:59 371 4.6% 0.101.2 MB 5.1% 0.34
Jul 18 17:00:00 - 17:59:59 505 6.2% 0.141.7 MB 7.5% 0.50
Jul 18 18:00:00 - 18:59:59 442 5.4% 0.121.4 MB 5.8% 0.39
Jul 18 19:00:00 - 19:59:59 341 4.2% 0.09762.2 KB 3.2% 0.21
Jul 18 20:00:00 - 20:59:59 412 5.1% 0.111.0 MB 4.4% 0.30
Jul 18 21:00:00 - 21:59:59 327 4.0% 0.09731.7 KB 3.0% 0.20
Jul 18 22:00:00 - 22:59:59 809 9.9% 0.222.4 MB 10.1% 0.67
Jul 18 23:00:00 - 23:59:59 392 4.8% 0.111.4 MB 5.8% 0.39
Jul 19 00:00:00 - 00:59:59 283 3.5% 0.081018.0 KB 4.2% 0.28
Jul 19 01:00:00 - 01:59:59 253 3.1% 0.07721.4 KB 3.0% 0.20
Jul 19 02:00:00 - 02:59:59 182 2.2% 0.05451.6 KB 1.9% 0.13
Jul 19 03:00:00 - 03:59:59 219 2.7% 0.06542.9 KB 2.3% 0.15
Jul 19 04:00:00 - 04:15:01 50 0.6% 0.06179.4 KB 0.7% 0.20
TOTAL: 24:00:00 8139 100.0% 0.0923.5 MB 100.0% 0.28
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
DE1DE512.0 MB297.2 MB 58.0% 1 0.11 55.18
INTL1INTL512.0 MB34.0 MB 6.6% 11 0.23 25.84
INTL2INTL512.0 MB36.3 MB 7.1% 11 0.24 25.57
TOTAL: 3-1.5 GB367.5 MB 23.9% 23 0.22-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 530 484 0 0 0 0 0 0 46
TOTAL: 1 530 484 0 0 0 0 0 0 46

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 164
fido7.ukrnews 90
alt.computer.workshop 52
linux.kernel.git 29
fido7.pushkin.local 28
it-alt.sport.calcio.juventus 26
lada.talk 15
fido7.lorapvt.horo 12
fido7.f715.techinfo 11
fido7.altyn.local 7
hispagatos.hacking.news 6
linux.ubuntu.security.announce 6
fido7.crimea.robots 5
alt.poetry 3
hispagatos.talk 3
spline.eisfair 3
news.test 2
alt.linux 2
alt.politics.republican 2
fido7.fidonet.online 2
TOTAL: 35 484

NoCeM on Spool:

IdGoodBadUniqueTotal
nocem@eternal-september.org3033
i2pn2-nocem@i2pn2.org1011
TOTAL: 24044

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

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

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ip-77-25-40-88.web.vodafone.de 5 306767.9 KB 23 0 003:27:51
TOTAL: 1 5 306767.9 KB 23 0 003:28:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.web.vodafone.de 5 306767.9 KB 23 0 003:27:51
2*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:01
3unresolved 15 00.0 KB 0 0 000:00:40
TOTAL: 3 22 306767.9 KB 23 0 003:28:33

NNRP auth users [Top 20]:

UserConn
peter@aulich.net 5
TOTAL: 1 5

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ip-77-25-40-88.web.vodafone.de 0.030 0.085 0.02603:27:51
198.235.24.157 0.011 0.008 0.00000:00:29
167.94.138.204 0.043 0.010 0.00000:00:06
198.235.24.84 0.003 0.003 0.00000:00:03
integral.monitoring.internet-measurement.com 0.000 0.008 0.00000:00:01
147.185.132.64 0.008 0.004 0.00000:00:00
45.82.78.254 0.009 0.015 0.00000:00:00
20.65.137.218 0.004 0.004 0.00000:00:00
vital.monitoring.internet-measurement.com 0.024 1.359 0.00000:00:00
198.235.24.201 0.000 0.009 0.00000:00:00
88.214.25.125 0.007 0.000 0.00000:00:00
TOTAL: 11 0.139 1.505 0.02603:28:33

Curious NNRP server explorers [Top 20]:

SystemConn
45.82.78.254 4
167.94.138.204 3
198.235.24.157 3
vital.monitoring.internet-measurement.com 1
20.65.137.218 1
88.214.25.125 1
198.235.24.84 1
147.185.132.64 1
198.235.24.201 1
integral.monitoring.internet-measurement.com 1
TOTAL: 10 17

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

SystemConn
vital.monitoring.internet-measurement.com 6
45.82.78.254 5
88.214.25.125 1
167.94.138.204 1
20.65.137.218 1
TOTAL: 5 14

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

CommandCount
#026#003#001 2
À#024#023#001#023#002#023#003#001 2
MGLNDD_85.31.187.13_119 1
Accept-Encoding: gzip 1
GET / HTTP/1.1 1
#003 1
Host: 85.31.187.13:119 1
EHLO www.censys.io 1
User-Agent: Mozilla/5.0 (compatible; Int... 1
½Íù#016*Þ#002L4 1
Accept: */* 1
Connection: close 1
TOTAL: 12 14

NNRP client timeouts [Top 20]:

SystemConnPeer
ip-77-25-40-88.web.vodafone.de 5 0
198.235.24.157 3 3
88.214.25.125 1 1
45.82.78.254 1 1
167.94.138.204 1 2
TOTAL: 5 11 10

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1de 269 87.9%
2ger 29 9.5%
3news 7 2.3%
4eternal-september 1 0.3%
TOTAL: 4 306100.0%

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

NewsgroupCount
1de.sci.electronics 52
2de.rec.fahrrad 40
3ger.ct 29
4de.rec.heimwerken 29
5de.comp.security.misc 25
6de.etc.haushalt 24
7de.rec.mampf 22
8de.test 12
9de.alt.fan.aldi 11
10de.etc.post 11
11de.alt.folklore.computer 10
12de.soc.recht.misc 10
13de.soc.recht.wohnen 7
14news.admin.peering 7
15de.comp.hardware.netzwerke.misc 6
16de.etc.handel.auktionshaeuser 4
17de.comp.os.unix.linux.hardware 3
18de.comp.os.unix.shell 1
19de.comm.software.newsreader 1
20eternal-september.config 1
21de.comp.os.unix.linux.misc 1
TOTAL: 21 306