Daily Usenet report

May 23 03:00:05 -- May 24 03:00:06

Unknown entries from news log file:

First 50 / 138 lines (36.2%)

May 23 03:01:41 mail innd: message repeated 2 times: [ ctlinnd command s]
May 23 04:54:33 mail nnrpd[368920]: Reading access from /usr/local/news/etc/readers.conf
May 23 04:54:33 mail nnrpd[368920]: Auth strategy 'localhost' does not match client. Removing.
May 23 04:54:33 mail nnrpd[368920]: 94.195.132.66.censys-scanner.com no_success_auth
May 23 04:54:38 mail nnrpd[368922]: Reading access from /usr/local/news/etc/readers.conf
May 23 04:54:38 mail nnrpd[368922]: Auth strategy 'localhost' does not match client. Removing.
May 23 04:54:38 mail nnrpd[368922]: 94.195.132.66.censys-scanner.com no_success_auth
May 23 04:54:48 mail nnrpd[368925]: Reading access from /usr/local/news/etc/readers.conf
May 23 04:54:48 mail nnrpd[368925]: Auth strategy 'localhost' does not match client. Removing.
May 23 04:54:48 mail nnrpd[368925]: 94.195.132.66.censys-scanner.com no_success_auth
May 23 04:54:49 mail nnrpd[368925]: unable to get certificates from '/usr/local/news/etc/cert.pem'
May 23 04:54:49 mail nnrpd[368925]: 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 23 06:07:40 mail nnrpd[372185]: Reading access from /usr/local/news/etc/readers.conf
May 23 06:07:40 mail nnrpd[372185]: Auth strategy 'localhost' does not match client. Removing.
May 23 06:07:40 mail nnrpd[372185]: 198.235.24.128 no_success_auth
May 23 09:52:28 mail nnrpd[383847]: Reading access from /usr/local/news/etc/readers.conf
May 23 09:52:28 mail nnrpd[383847]: Auth strategy 'localhost' does not match client. Removing.
May 23 09:52:28 mail nnrpd[383847]: 69.5.169.72 no_success_auth
May 23 10:25:20 mail nnrpd[385356]: Reading access from /usr/local/news/etc/readers.conf
May 23 10:25:20 mail nnrpd[385356]: Auth strategy 'localhost' does not match client. Removing.
May 23 10:25:20 mail nnrpd[385356]: 179.172.132.66.censys-scanner.com no_success_auth
May 23 10:25:24 mail nnrpd[385358]: Reading access from /usr/local/news/etc/readers.conf
May 23 10:25:24 mail nnrpd[385358]: Auth strategy 'localhost' does not match client. Removing.
May 23 10:25:24 mail nnrpd[385358]: 179.172.132.66.censys-scanner.com no_success_auth
May 23 10:25:30 mail nnrpd[385359]: Reading access from /usr/local/news/etc/readers.conf
May 23 10:25:30 mail nnrpd[385359]: Auth strategy 'localhost' does not match client. Removing.
May 23 10:25:30 mail nnrpd[385359]: 179.172.132.66.censys-scanner.com no_success_auth
May 23 10:25:31 mail nnrpd[385359]: unable to get certificates from '/usr/local/news/etc/cert.pem'
May 23 10:25:31 mail nnrpd[385359]: 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 23 10:45:38 mail nnrpd[386284]: Reading access from /usr/local/news/etc/readers.conf
May 23 10:45:38 mail nnrpd[386284]: Auth strategy 'localhost' does not match client. Removing.
May 23 10:45:38 mail nnrpd[386284]: 69.5.169.86 no_success_auth
May 23 11:05:14 mail nnrpd[387126]: Reading access from /usr/local/news/etc/readers.conf
May 23 11:05:14 mail nnrpd[387126]: twilightnode.org res <localhost>
May 23 11:05:14 mail nnrpd[387126]: twilightnode.org match_user <localhost> <localhost>
May 23 12:26:53 mail nnrpd[390750]: Reading access from /usr/local/news/etc/readers.conf
May 23 12:26:53 mail nnrpd[390750]: Auth strategy 'localhost' does not match client. Removing.
May 23 12:26:53 mail nnrpd[390750]: azpdcsfkiwnp.stretchoid.com no_success_auth
May 23 12:27:03 mail nnrpd[390751]: Reading access from /usr/local/news/etc/readers.conf
May 23 12:27:03 mail nnrpd[390751]: Auth strategy 'localhost' does not match client. Removing.
May 23 12:27:03 mail nnrpd[390751]: azpdcsfkiwnp.stretchoid.com no_success_auth
May 23 12:31:22 mail nnrpd[390902]: Reading access from /usr/local/news/etc/readers.conf
May 23 12:31:22 mail nnrpd[390902]: Auth strategy 'localhost' does not match client. Removing.
May 23 12:31:22 mail nnrpd[390902]: 5.226.140.104 no_success_auth
May 23 13:44:19 mail nnrpd[394096]: Reading access from /usr/local/news/etc/readers.conf
May 23 13:44:19 mail nnrpd[394096]: Auth strategy 'localhost' does not match client. Removing.
May 23 13:44:19 mail nnrpd[394096]: 69.5.169.46 no_success_auth
May 23 14:10:45 mail nnrpd[395252]: Reading access from /usr/local/news/etc/readers.conf
May 23 14:10:45 mail nnrpd[395252]: Auth strategy 'localhost' does not match client. Removing.
May 23 14:10:45 mail nnrpd[395252]: 205.210.31.231 no_success_auth

Log entries by program:

Program nameLines%LinesSize%Size
inn 5348 67.1%767.0 KB 68.9%
innfeed 1164 14.6%147.3 KB 13.2%
innd 1126 14.1%163.0 KB 14.6%
nnrpd 317 4.0%31.9 KB 2.9%
controlchan 15 0.2%3.1 KB 0.3%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 6 7971 100.0%1.1 MB100.0%

History cache:

ReasonCount%Count
Negative hits 5944 35.8%
Do not exist 5326 32.1%
Positive hits 5323 32.1%
Cache misses 0 0.0%
TOTAL: 4 16593 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.007 0.0%6 0.000 1.167 2.000
article cleanup00:00:00.084 0.0%5374 0.000 0.016 0.167
article logging00:00:00.269 0.0%5374 0.000 0.050 0.250
article parse00:00:00.111 0.0%6625 0.000 0.017 0.212
article write00:00:01.452 0.0%1548 0.000 0.938 2.333
data move00:00:00.030 0.0%17499 0.000 0.002 0.022
hisgrep/artcncl00:00:00.002 0.0%6 0.000 0.333 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.983 0.0%16744 0.123 0.238 0.670
history sync00:00:00.087 0.0%408 0.000 0.213 2.000
history write00:00:03.332 0.0%5374 0.308 0.620 1.333
idle24:00:41.375100.0%17426 1922.885 4960.483 21380.536
nntp read00:00:00.459 0.0%17030 0.000 0.027 0.131
overview write00:00:01.140 0.0%1548 0.000 0.736 2.778
perl filter00:00:12.360 0.0%5374 1.092 2.300 16.579
python filter00:00:01.112 0.0%5375 0.024 0.207 1.368
site send00:00:00.080 0.0%1549 0.000 0.052 0.400
TOTAL: 1724:01:05.883100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.018 0.0%1533 0.000 0.012 0.400
article prepare00:00:00.000 0.0%12232 0.000 0.000 0.000
article read00:00:00.414 0.0%1533 0.000 0.270 0.778
backlog stats00:00:00.016 0.0%11965 0.000 0.001 0.032
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.076 0.0%4954 0.000 0.015 0.133
data write00:00:00.129 0.0%3475 0.000 0.037 0.417
idle23:59:25.610100.0%11965 3208.599 7218.187 13983.860
status file00:00:00.234 0.0%176 0.000 1.330 31.000
TOTAL: 923:59:26.497100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:10:37.533100.0%72 9.000 8854.625300379.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%315 0.000 0.003 0.200
TOTAL: 300:10:37.534100.0%----

Control commands to innd:

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

Control channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
nl-admin@nic.surfnet.nl001101
TOTAL001101

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 2 11023 1531 5733 3759 13%46:41:50
2localhost 26 1 1 0 0 100%00:00:01
3news.chimia.se 1 0 0 0 0 0%00:10:00
4news.twilightnode.org 1 0 0 0 0 0%00:00:00
TOTAL: 4 30 11024 1532 5733 3759 13%46:51:51
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net4.3 MB0.0 KB11.2 MB15.5 MB 27%3.0 KB
2localhost0.6 KB0.0 KB0.0 KB0.6 KB100%0.6 KB
3news.chimia.se0.0 KB0.0 KB0.0 KB0.0 KB 0%0
4news.twilightnode.org0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 44.3 MB0.0 KB11.2 MB15.5 MB 27%3.0 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
May 23 03:00:05 - 03:59:59 51 3.3% 0.01154.8 KB 3.5% 0.04
May 23 04:00:00 - 04:59:59 68 4.4% 0.02171.5 KB 3.8% 0.05
May 23 05:00:00 - 05:59:59 33 2.2% 0.0173.5 KB 1.6% 0.02
May 23 06:00:00 - 06:59:59 77 5.0% 0.02230.0 KB 5.1% 0.06
May 23 07:00:00 - 07:59:59 45 2.9% 0.0183.0 KB 1.9% 0.02
May 23 08:00:00 - 08:59:59 50 3.3% 0.0198.2 KB 2.2% 0.03
May 23 09:00:00 - 09:59:59 62 4.0% 0.02160.6 KB 3.6% 0.04
May 23 10:00:00 - 10:59:59 55 3.6% 0.02140.6 KB 3.1% 0.04
May 23 11:00:00 - 11:59:59 57 3.7% 0.02139.9 KB 3.1% 0.04
May 23 12:00:00 - 12:59:59 81 5.3% 0.02206.0 KB 4.6% 0.06
May 23 13:00:00 - 13:59:59 44 2.9% 0.0179.6 KB 1.8% 0.02
May 23 14:00:00 - 14:59:59 53 3.5% 0.01110.5 KB 2.5% 0.03
May 23 15:00:00 - 15:59:59 83 5.4% 0.02240.1 KB 5.4% 0.07
May 23 16:00:00 - 16:59:59 79 5.1% 0.02345.2 KB 7.7% 0.10
May 23 17:00:00 - 17:59:59 92 6.0% 0.03268.0 KB 6.0% 0.07
May 23 18:00:00 - 18:59:59 71 4.6% 0.02164.2 KB 3.7% 0.05
May 23 19:00:00 - 19:59:59 73 4.8% 0.02177.8 KB 4.0% 0.05
May 23 20:00:00 - 20:59:59 110 7.2% 0.03286.6 KB 6.4% 0.08
May 23 21:00:00 - 21:59:59 103 6.7% 0.03411.5 KB 9.2% 0.11
May 23 22:00:00 - 22:59:59 67 4.4% 0.02401.7 KB 9.0% 0.11
May 23 23:00:00 - 23:59:59 43 2.8% 0.01117.5 KB 2.6% 0.03
May 24 00:00:00 - 00:59:59 51 3.3% 0.01220.0 KB 4.9% 0.06
May 24 01:00:00 - 01:59:59 41 2.7% 0.0195.3 KB 2.1% 0.03
May 24 02:00:00 - 02:59:59 35 2.3% 0.0180.0 KB 1.8% 0.02
May 24 03:00:00 - 03:00:06 10 0.7% 1.6710.1 KB 0.2% 1.69
TOTAL: 24:00:01 1534 100.0% 0.024.4 MB 100.0% 0.05
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 3814 3573 0 0 0 0 0 0 241
TOTAL: 1 3814 3573 0 0 0 0 0 0 241

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1103
free.pt 161
linux.debian.bugs.dist 126
linux.debian.changes.devel 123
alt.buddha.short.fat.guy 105
alt.russian.z1 102
linux.debian.bugs.rc 92
alt.arts.poetry.comments 73
fr.soc.politique 60
uk.railway 60
it.test 56
fido7.su.pol 46
cn.comp 40
linux.debian.devel.release 40
pl.soc.polityka 40
alt.usage.english 35
lada.talk 35
de.soc.politik.misc 34
fido7.ru.fidonet.today 33
de.comp.os.unix.linux.misc 31
TOTAL: 240 3573

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 216
User-issued cancel 13
EMP (md5) 6
Too many newsgroups 3
HTML Multipart 2
Too many newsgroups (meow) 1
TOTAL: 6 241

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1chimia.se 1535 1532 0 1 0 10 99%23:59:56
2thebunker.nu 1536 1464 0 70 0 0 95%23:59:56
3weretis.net 1 0 0 1 0 0 0%00:20:30
4sklaff.dev 0 0 0 0 0 1529 0%23:57:43
5usenet.blueworldhosting.com 0 0 0 0 0 1368 0%23:59:55
TOTAL: 5 3072 2996 0 72 0 2907 97%96:18:00
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1chimia.se4.4 MB3.4 KB4.4 MB0.1 KB/s2.9 KB23:59:56
2thebunker.nu4.1 MB312.6 KB4.4 MB0.1 KB/s2.9 KB23:59:56
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.6 KB0.6 KB0.0 KB/s0.6 KB00:20:30
TOTAL: 58.4 MB316.6 KB8.7 MB0.0 KB/s2.9 KB96:18:00
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1139-162-186-99.ip.linodeusercontent.com 11 00.0 KB 0 0 000:00:06
2dev05.academyforinternetresearch.org 11 00.0 KB 0 0 000:00:05
3179.172.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:04
494.195.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:06
5azpdcsfkiwnp.stretchoid.com 2 00.0 KB 0 0 000:00:10
6195-252-55-9-no600.tbcn.telia.com 1 00.0 KB 0 0 000:10:00
7198.235.24.128 1 00.0 KB 0 0 000:00:00
8205.210.31.231 1 00.0 KB 0 0 000:00:00
95.226.140.104 1 00.0 KB 0 0 000:00:00
1069.5.169.100 1 00.0 KB 0 0 000:00:00
1169.5.169.12 1 00.0 KB 0 0 000:00:00
1269.5.169.46 1 00.0 KB 0 0 000:00:00
1369.5.169.72 1 00.0 KB 0 0 000:00:00
1469.5.169.86 1 00.0 KB 0 0 000:00:00
15twilightnode.org 1 00.0 KB 0 1 000:00:00
TOTAL: 15 40 00.0 KB 0 1 000:10:37

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.academyforinternetresearch.org 11 00.0 KB 0 0 000:00:05
2*.ip.linodeusercontent.com 11 00.0 KB 0 0 000:00:06
3unresolved 8 00.0 KB 0 0 000:00:02
4*.66.censys-scanner.com 6 00.0 KB 0 0 000:00:11
5*.stretchoid.com 2 00.0 KB 0 0 000:00:10
6*.org 1 00.0 KB 0 1 000:00:00
7*.tbcn.telia.com 1 00.0 KB 0 0 000:10:00
TOTAL: 7 40 00.0 KB 0 1 000:10:37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
195-252-55-9-no600.tbcn.telia.com 0.004 0.021 0.00000:10:00
azpdcsfkiwnp.stretchoid.com 0.006 0.025 0.00000:00:10
94.195.132.66.censys-scanner.com 0.040 0.037 0.00000:00:06
139-162-186-99.ip.linodeusercontent.com 0.120 0.092 0.00000:00:06
dev05.academyforinternetresearch.org 0.123 0.099 0.00000:00:05
179.172.132.66.censys-scanner.com 0.040 0.043 0.00000:00:04
205.210.31.231 0.008 0.015 0.00000:00:00
69.5.169.100 0.002 0.024 0.00000:00:00
198.235.24.128 0.007 0.013 0.00000:00:00
5.226.140.104 0.007 0.010 0.00000:00:00
69.5.169.12 0.004 0.009 0.00000:00:00
69.5.169.72 0.004 0.016 0.00000:00:00
69.5.169.46 0.004 0.018 0.00000:00:00
69.5.169.86 0.004 0.016 0.00000:00:00
twilightnode.org 0.007 0.009 0.00000:00:00
TOTAL: 15 0.380 0.447 0.00000:10:37

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

SystemConn
139-162-186-99.ip.linodeusercontent.com 7
dev05.academyforinternetresearch.org 7
179.172.132.66.censys-scanner.com 1
94.195.132.66.censys-scanner.com 1
azpdcsfkiwnp.stretchoid.com 1
TOTAL: 5 17

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

CommandCount
#026#003#001 4
#026#003#001#002 4
?#024 4
#010#013#010#004#010#005#010#006#004#001#005#001#006#001#003#003#003#001#003#002#004#002#005#002#006#002 2
EHLO www.censys.io 2
MGLNDD_172.234.115.63_119 1
TOTAL: 6 17

NNRP client timeouts [Top 20]:

SystemConnPeer
139-162-186-99.ip.linodeusercontent.com 2 2
dev05.academyforinternetresearch.org 2 2
179.172.132.66.censys-scanner.com 1 2
69.5.169.100 1 1
69.5.169.12 1 1
69.5.169.46 1 1
69.5.169.86 1 1
94.195.132.66.censys-scanner.com 1 2
TOTAL: 8 10 16
innreport from INN 2.7.3 based on initial work (©) 1996-2001 by Fabien Tassin <fta@sofaraway.org> and enhanced by several contributors since then