Daily Usenet report

May 22 03:00:05 -- May 23 03:00:05

Unknown entries from news log file:

First 39 / 39 lines (100.0%)

May 22 03:01:46 mail innd: message repeated 2 times: [ ctlinnd command s]
May 22 05:35:24 mail nnrpd[303886]: Reading access from /usr/local/news/etc/readers.conf
May 22 05:35:24 mail nnrpd[303886]: Auth strategy 'localhost' does not match client. Removing.
May 22 05:35:24 mail nnrpd[303886]: 195.206.182.213 no_success_auth
May 22 06:13:22 mail nnrpd[305746]: Reading access from /usr/local/news/etc/readers.conf
May 22 06:13:22 mail nnrpd[305746]: Auth strategy 'localhost' does not match client. Removing.
May 22 06:13:22 mail nnrpd[305746]: 69.5.169.24 no_success_auth
May 22 09:02:15 mail nnrpd[313560]: Reading access from /usr/local/news/etc/readers.conf
May 22 09:02:15 mail nnrpd[313560]: Auth strategy 'localhost' does not match client. Removing.
May 22 09:02:15 mail nnrpd[313560]: 69.5.169.33 no_success_auth
May 22 10:29:34 mail nnrpd[317612]: Reading access from /usr/local/news/etc/readers.conf
May 22 10:29:34 mail nnrpd[317612]: Auth strategy 'localhost' does not match client. Removing.
May 22 10:29:34 mail nnrpd[317612]: azpdcgveqc7n.stretchoid.com no_success_auth
May 22 10:29:44 mail nnrpd[317616]: Reading access from /usr/local/news/etc/readers.conf
May 22 10:29:44 mail nnrpd[317616]: Auth strategy 'localhost' does not match client. Removing.
May 22 10:29:44 mail nnrpd[317616]: azpdcgveqc7n.stretchoid.com no_success_auth
May 22 10:53:33 mail nnrpd[318856]: Reading access from /usr/local/news/etc/readers.conf
May 22 10:53:33 mail nnrpd[318856]: Auth strategy 'localhost' does not match client. Removing.
May 22 10:53:33 mail nnrpd[318856]: 81.19.219.205 no_success_auth
May 22 15:32:22 mail nnrpd[332063]: Reading access from /usr/local/news/etc/readers.conf
May 22 15:32:22 mail nnrpd[332063]: Auth strategy 'localhost' does not match client. Removing.
May 22 15:32:22 mail nnrpd[332063]: 188.172.132.66.censys-scanner.com no_success_auth
May 22 15:32:24 mail nnrpd[332063]: unable to get certificates from '/usr/local/news/etc/cert.pem'
May 22 15:32:24 mail nnrpd[332063]: error initializing TLS: [CA_file: ] [CA_path: /usr/local/news/etc] [cert_file: /usr/local/news/etc/cert.pem] [key_file: /usr/local/news/etc/key.pem]
May 22 15:53:36 mail nnrpd[332991]: Reading access from /usr/local/news/etc/readers.conf
May 22 15:53:36 mail nnrpd[332991]: Auth strategy 'localhost' does not match client. Removing.
May 22 15:53:36 mail nnrpd[332991]: 93.152.208.38 no_success_auth
May 22 15:53:36 mail nnrpd[332992]: Reading access from /usr/local/news/etc/readers.conf
May 22 15:53:36 mail nnrpd[332992]: Auth strategy 'localhost' does not match client. Removing.
May 22 15:53:36 mail nnrpd[332992]: 93.152.208.38 no_success_auth
May 22 17:33:21 mail nnrpd[337467]: Reading access from /usr/local/news/etc/readers.conf
May 22 17:33:21 mail nnrpd[337467]: Auth strategy 'localhost' does not match client. Removing.
May 22 17:33:21 mail nnrpd[337467]: candice.probe.onyphe.net no_success_auth
May 22 17:33:22 mail nnrpd[337468]: Reading access from /usr/local/news/etc/readers.conf
May 22 17:33:22 mail nnrpd[337468]: Auth strategy 'localhost' does not match client. Removing.
May 22 17:33:22 mail nnrpd[337468]: rogers.probe.onyphe.net no_success_auth
May 23 03:00:04 mail nnrpd[363355]: Reading access from /usr/local/news/etc/readers.conf
May 23 03:00:04 mail nnrpd[363355]: Auth strategy 'localhost' does not match client. Removing.
May 23 03:00:04 mail nnrpd[363355]: 195-252-55-9-no600.tbcn.telia.com no_success_auth

Log entries by program:

Program nameLines%LinesSize%Size
inn 6191 70.5%878.1 KB 72.0%
innd 1336 15.2%190.6 KB 15.6%
innfeed 1154 13.1%140.6 KB 11.5%
nnrpd 102 1.2%9.5 KB 0.8%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 8785 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 6777 35.5%
Do not exist 6146 32.2%
Positive hits 6137 32.2%
Cache misses 4 0.0%
TOTAL: 4 19064 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.004 0.0%2 0.000 2.000 4.000
article cleanup00:00:00.074 0.0%6158 0.000 0.012 0.083
article logging00:00:00.341 0.0%6159 0.000 0.055 0.456
article parse00:00:00.142 0.0%7768 0.000 0.018 0.122
article write00:00:01.541 0.0%1662 0.125 0.927 2.450
data move00:00:00.051 0.0%19808 0.000 0.003 0.022
hisgrep/artcncl00:00:00.002 0.0%2 0.000 1.000 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.494 0.0%19110 0.130 0.235 0.588
history sync00:00:00.069 0.0%402 0.000 0.172 0.667
history write00:00:03.826 0.0%6158 0.286 0.621 1.188
idle23:50:30.416100.0%19610 1801.817 4376.870 17149.543
nntp read00:00:00.494 0.0%19280 0.000 0.026 0.094
overview write00:00:01.254 0.0%1662 0.000 0.755 2.778
perl filter00:00:13.962 0.0%6158 0.958 2.267 12.710
python filter00:00:01.206 0.0%6158 0.037 0.196 1.065
site send00:00:00.077 0.0%1662 0.000 0.046 0.333
TOTAL: 1723:50:57.953100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.017 0.0%1677 0.000 0.010 0.333
article prepare00:00:00.001 0.0%13388 0.000 0.000 0.016
article read00:00:00.434 0.0%1677 0.000 0.259 1.000
backlog stats00:00:00.030 0.0%12496 0.000 0.002 0.033
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.104 0.0%5389 0.000 0.019 0.111
data write00:00:00.137 0.0%3759 0.000 0.036 0.227
idle23:59:25.432100.0%12496 3213.679 6911.446 12774.723
status file00:00:00.275 0.0%172 0.000 1.599 24.000
TOTAL: 923:59:26.430100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:10:19.218100.0%23 50.000 26922.522300351.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%94 0.000 0.011 0.053
TOTAL: 300:10:19.219100.0%----

Control commands to innd:

CommandNumber
flush 3
flushlogs 2
go 2
logmode 2
lowmark 1
mode 146
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 166

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 5 12184 1674 5914 4596 13%47:17:04
2localhost 25 0 0 0 0 0%00:00:00
3news.chimia.se 1 0 0 0 0 0%00:10:00
TOTAL: 3 31 12184 1674 5914 4596 13%47:27:04
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net4.3 MB0.0 KB15.7 MB20.0 MB 21%3.3 KB
2localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
3news.chimia.se0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 34.3 MB0.0 KB15.7 MB20.0 MB 21%3.3 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
May 22 03:00:05 - 03:59:59 50 3.0% 0.01121.3 KB 2.7% 0.03
May 22 04:00:00 - 04:59:59 60 3.6% 0.02134.9 KB 3.0% 0.04
May 22 05:00:00 - 05:59:59 75 4.5% 0.02291.2 KB 6.6% 0.08
May 22 06:00:00 - 06:59:59 69 4.1% 0.02228.8 KB 5.2% 0.06
May 22 07:00:00 - 07:59:59 48 2.9% 0.01180.6 KB 4.1% 0.05
May 22 08:00:00 - 08:59:59 70 4.2% 0.02198.1 KB 4.5% 0.06
May 22 09:00:00 - 09:59:59 70 4.2% 0.02135.0 KB 3.0% 0.04
May 22 10:00:00 - 10:59:59 43 2.6% 0.01106.0 KB 2.4% 0.03
May 22 11:00:00 - 11:59:59 58 3.5% 0.02135.3 KB 3.1% 0.04
May 22 12:00:00 - 12:59:59 57 3.4% 0.02118.7 KB 2.7% 0.03
May 22 13:00:00 - 13:59:59 60 3.6% 0.02133.3 KB 3.0% 0.04
May 22 14:00:00 - 14:59:59 59 3.5% 0.02180.3 KB 4.1% 0.05
May 22 15:00:00 - 15:59:59 72 4.3% 0.02176.4 KB 4.0% 0.05
May 22 16:00:00 - 16:59:59 63 3.8% 0.02196.2 KB 4.4% 0.05
May 22 17:00:00 - 17:59:59 84 5.0% 0.02291.5 KB 6.6% 0.08
May 22 18:00:00 - 18:59:59 62 3.7% 0.02149.9 KB 3.4% 0.04
May 22 19:00:00 - 19:59:59 85 5.1% 0.02186.7 KB 4.2% 0.05
May 22 20:00:00 - 20:59:59 70 4.2% 0.02151.4 KB 3.4% 0.04
May 22 21:00:00 - 21:59:59 99 5.9% 0.03197.4 KB 4.5% 0.05
May 22 22:00:00 - 22:59:59 83 4.9% 0.02233.2 KB 5.3% 0.06
May 22 23:00:00 - 23:59:59 84 5.0% 0.02231.7 KB 5.2% 0.06
May 23 00:00:00 - 00:59:59 120 7.1% 0.03323.7 KB 7.3% 0.09
May 23 01:00:00 - 01:59:59 77 4.6% 0.02178.8 KB 4.0% 0.05
May 23 02:00:00 - 02:59:59 53 3.2% 0.01146.1 KB 3.3% 0.04
May 23 03:00:00 - 03:00:05 9 0.5% 1.807.3 KB 0.2% 1.45
TOTAL: 24:00:00 1680 100.0% 0.024.3 MB 100.0% 0.05
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 4511 4065 0 0 0 0 0 0 446
TOTAL: 1 4511 4065 0 0 0 0 0 0 446

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 906
free.pt 202
linux.debian.bugs.dist 137
linux.debian.changes.devel 136
alt.russian.z1 124
alt.buddha.short.fat.guy 114
it.politica 100
alt.arts.poetry.comments 84
fr.soc.politique 71
linux.debian.bugs.rc 66
fido7.ru.fidonet.today 59
linux.debian.kernel 54
lada.talk 51
de.talk.tagesgeschehen 48
fido7.su.pol 48
fr.sci.maths 48
sfnet.keskustelu.varaventtiili 47
alt.fan.rush-limbaugh 42
de.soc.politik.misc 40
alt.global-warming 39
TOTAL: 250 4065

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 357
User-issued cancel 58
Too many newsgroups 12
EMP (md5) 7
HTML Multipart 6
Too many newsgroups (meow) 3
EMP (phl) 2
TOTAL: 7 445

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
twilightnode-out.news.weretis.net 1
TOTAL: 1 1
TOTAL: 1 1

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1chimia.se 1673 1671 0 0 0 9 99%23:59:55
2thebunker.nu 1688 1571 0 116 0 0 93%23:59:55
3sklaff.dev 0 0 0 0 0 1675 0%23:57:43
4usenet.blueworldhosting.com 0 0 0 0 0 1515 0%23:59:55
5weretis.net 0 0 0 0 0 0 0%00:10:30
TOTAL: 5 3361 3242 0 116 0 3199 96%96:07:58
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1chimia.se4.3 MB0.0 KB4.3 MB0.1 KB/s2.7 KB23:59:55
2thebunker.nu4.0 MB381.5 KB4.3 MB0.1 KB/s2.6 KB23:59:55
3sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:43
4usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
5weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:30
TOTAL: 58.3 MB381.5 KB8.7 MB0.0 KB/s2.6 KB96:07:58
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
193.152.208.38 2 00.0 KB 0 0 000:00:00
2azpdcgveqc7n.stretchoid.com 2 00.0 KB 0 0 000:00:10
3188.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
4195-252-55-9-no600.tbcn.telia.com 1 00.0 KB 0 0 000:10:00
5195.206.182.213 1 00.0 KB 0 0 000:00:00
669.5.169.24 1 00.0 KB 0 0 000:00:00
769.5.169.33 1 00.0 KB 0 0 000:00:00
881.19.219.205 1 00.0 KB 0 0 000:00:00
9candice.probe.onyphe.net 1 00.0 KB 0 0 000:00:00
10rogers.probe.onyphe.net 1 00.0 KB 0 0 000:00:02
TOTAL: 10 12 00.0 KB 0 0 000:10:19

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 6 00.0 KB 0 0 000:00:01
2*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
3*.stretchoid.com 2 00.0 KB 0 0 000:00:10
4*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
5*.tbcn.telia.com 1 00.0 KB 0 0 000:10:00
TOTAL: 5 12 00.0 KB 0 0 000:10:19

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
195-252-55-9-no600.tbcn.telia.com 0.003 0.032 0.00000:10:00
azpdcgveqc7n.stretchoid.com 0.008 0.031 0.00000:00:10
rogers.probe.onyphe.net 0.005 0.006 0.00000:00:02
188.172.132.66.censys-scanner.com 0.031 0.021 0.00000:00:02
candice.probe.onyphe.net 0.004 0.020 0.00000:00:00
81.19.219.205 0.006 0.014 0.00000:00:00
195.206.182.213 0.008 0.039 0.00000:00:00
93.152.208.38 0.006 0.021 0.00000:00:00
69.5.169.24 0.006 0.025 0.00000:00:00
69.5.169.33 0.003 0.020 0.00000:00:00
TOTAL: 10 0.080 0.229 0.00000:10:19

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

SystemConn
93.152.208.38 9
candice.probe.onyphe.net 2
188.172.132.66.censys-scanner.com 1
azpdcgveqc7n.stretchoid.com 1
TOTAL: 4 13

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

CommandCount
#026#003#001#002 1
#026#003#003#002c#001 1
?#024?#011?#023 1
?$?,?r?s?#023#002#023#001?#024?#007?#022?#023?'?/?#024?(?0?`?a... 1
Accept-Encoding: gzip, deflate, br 1
Accept-Language: en-US,en;q=0.9 1
Accept: text/html,application/xhtml+xml,... 1
Connection: close 1
EHLO www.censys.io 1
GET / HTTP/1.1 1
Host: 172.234.115.63:119 1
MGLNDD_172.234.115.63_119 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
TOTAL: 13 13

NNRP client timeouts [Top 20]:

SystemConnPeer
69.5.169.24 1 1
81.19.219.205 1 1
TOTAL: 2 2 4