Daily Usenet report

May 20 03:00:03 -- May 21 03:00:05

Unknown entries from news log file:

First 42 / 42 lines (100.0%)

May 20 03:00:04 mail nnrpd[157706]: Reading access from /usr/local/news/etc/readers.conf
May 20 03:00:04 mail nnrpd[157706]: Auth strategy 'localhost' does not match client. Removing.
May 20 03:00:04 mail nnrpd[157706]: 195-252-55-9-no600.tbcn.telia.com no_success_auth
May 20 03:00:35 mail nnrpd[157925]: Reading access from /usr/local/news/etc/readers.conf
May 20 03:00:35 mail nnrpd[157925]: Auth strategy 'localhost' does not match client. Removing.
May 20 03:00:35 mail nnrpd[157925]: 195-252-55-9-no600.tbcn.telia.com no_success_auth
May 20 03:01:41 mail innd: message repeated 2 times: [ ctlinnd command s]
May 20 13:51:30 mail nnrpd[188860]: Reading access from /usr/local/news/etc/readers.conf
May 20 13:51:30 mail nnrpd[188860]: Auth strategy 'localhost' does not match client. Removing.
May 20 13:51:30 mail nnrpd[188860]: 45.172.132.66.censys-scanner.com no_success_auth
May 20 13:51:38 mail nnrpd[188865]: Reading access from /usr/local/news/etc/readers.conf
May 20 13:51:38 mail nnrpd[188865]: Auth strategy 'localhost' does not match client. Removing.
May 20 13:51:38 mail nnrpd[188865]: 45.172.132.66.censys-scanner.com no_success_auth
May 20 13:51:47 mail nnrpd[188868]: Reading access from /usr/local/news/etc/readers.conf
May 20 13:51:47 mail nnrpd[188868]: Auth strategy 'localhost' does not match client. Removing.
May 20 13:51:47 mail nnrpd[188868]: 45.172.132.66.censys-scanner.com no_success_auth
May 20 13:51:47 mail nnrpd[188868]: unable to get certificates from '/usr/local/news/etc/cert.pem'
May 20 13:51:47 mail nnrpd[188868]: 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 20 14:24:13 mail nnrpd[190403]: Reading access from /usr/local/news/etc/readers.conf
May 20 14:24:13 mail nnrpd[190403]: Auth strategy 'localhost' does not match client. Removing.
May 20 14:24:13 mail nnrpd[190403]: 93.152.208.38 no_success_auth
May 20 14:24:13 mail nnrpd[190404]: Reading access from /usr/local/news/etc/readers.conf
May 20 14:24:13 mail nnrpd[190404]: Auth strategy 'localhost' does not match client. Removing.
May 20 14:24:13 mail nnrpd[190404]: 93.152.208.38 no_success_auth
May 20 15:12:28 mail nnrpd[192688]: Reading access from /usr/local/news/etc/readers.conf
May 20 15:12:28 mail nnrpd[192688]: Auth strategy 'localhost' does not match client. Removing.
May 20 15:12:28 mail nnrpd[192688]: 118.194.250.2 no_success_auth
May 20 15:12:29 mail nnrpd[192689]: Reading access from /usr/local/news/etc/readers.conf
May 20 15:12:29 mail nnrpd[192689]: Auth strategy 'localhost' does not match client. Removing.
May 20 15:12:29 mail nnrpd[192689]: 118.194.250.2 no_success_auth
May 20 15:12:39 mail nnrpd[192691]: Reading access from /usr/local/news/etc/readers.conf
May 20 15:12:39 mail nnrpd[192691]: Auth strategy 'localhost' does not match client. Removing.
May 20 15:12:39 mail nnrpd[192691]: 118.194.250.2 no_success_auth
May 20 18:25:00 mail nnrpd[202402]: Reading access from /usr/local/news/etc/readers.conf
May 20 18:25:00 mail nnrpd[202402]: Auth strategy 'localhost' does not match client. Removing.
May 20 18:25:00 mail nnrpd[202402]: 205.210.31.134 no_success_auth
May 20 22:42:10 mail nnrpd[214586]: Reading access from /usr/local/news/etc/readers.conf
May 20 22:42:10 mail nnrpd[214586]: Auth strategy 'localhost' does not match client. Removing.
May 20 22:42:10 mail nnrpd[214586]: 47.89.244.159 no_success_auth
May 21 03:00:04 mail nnrpd[226555]: Reading access from /usr/local/news/etc/readers.conf
May 21 03:00:04 mail nnrpd[226555]: Auth strategy 'localhost' does not match client. Removing.
May 21 03:00:04 mail nnrpd[226555]: 195-252-55-9-no600.tbcn.telia.com no_success_auth

Log entries by program:

Program nameLines%LinesSize%Size
inn 6383 70.2%902.2 KB 72.1%
innd 1432 15.8%192.3 KB 15.4%
innfeed 1166 12.8%146.6 KB 11.7%
nnrpd 107 1.2%10.0 KB 0.8%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 9090 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 7091 35.8%
Do not exist 6369 32.1%
Positive hits 6364 32.1%
Cache misses 6 0.0%
TOTAL: 4 19830 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.010 0.0%1 10.000 10.000 10.000
article cleanup00:00:00.110 0.0%6382 0.000 0.017 0.125
article logging00:00:00.336 0.0%6382 0.000 0.053 0.242
article parse00:00:00.146 0.0%7714 0.000 0.019 0.167
article write00:00:01.733 0.0%1653 0.188 1.048 34.625
data move00:00:00.045 0.0%20169 0.000 0.002 0.057
hisgrep/artcncl00:00:00.001 0.0%1 1.000 1.000 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.596 0.0%19871 0.135 0.282 5.244
history sync00:00:00.066 0.0%410 0.000 0.161 2.000
history write00:00:04.250 0.0%6382 0.250 0.666 2.685
idle24:00:32.902100.0%20106 2126.383 4298.861 15395.846
nntp read00:00:00.537 0.0%19771 0.000 0.027 0.165
overview write00:00:01.139 0.0%1653 0.125 0.689 3.111
perl filter00:00:14.024 0.0%6382 1.042 2.197 13.889
python filter00:00:01.280 0.0%6382 0.000 0.201 1.222
site send00:00:00.070 0.0%1653 0.000 0.042 0.667
TOTAL: 1724:01:02.245100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.015 0.0%1646 0.000 0.009 0.143
article prepare00:00:00.002 0.0%13160 0.000 0.000 0.011
article read00:00:00.400 0.0%1646 0.000 0.243 1.100
backlog stats00:00:00.029 0.0%13773 0.000 0.002 0.032
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.131 0.0%5986 0.000 0.022 0.714
data write00:00:00.140 0.0%4391 0.000 0.032 0.158
idle23:56:29.324100.0%13773 2858.276 6257.847 12032.220
status file00:00:00.266 0.0%177 0.000 1.503 22.000
TOTAL: 923:56:30.307100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:10:24.585100.0%21 53.000 29742.143300321.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.003 0.0%137 0.000 0.022 0.167
TOTAL: 300:10:24.588100.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 3 12801 1673 6303 4825 13%48:16:42
2localhost 25 0 0 0 0 0%00:00:00
3news.chimia.se 2 0 0 0 0 0%00:10:00
TOTAL: 3 30 12801 1673 6303 4825 13%48:26:42
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net4.4 MB0.0 KB14.4 MB18.8 MB 23%3.0 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.4 MB0.0 KB14.4 MB18.8 MB 23%3.0 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
May 20 03:00:03 - 03:59:59 53 3.2% 0.01175.2 KB 4.0% 0.05
May 20 04:00:00 - 04:59:59 82 5.0% 0.02213.5 KB 4.8% 0.06
May 20 05:00:00 - 05:59:59 61 3.7% 0.02226.6 KB 5.1% 0.06
May 20 06:00:00 - 06:59:59 51 3.1% 0.0196.3 KB 2.2% 0.03
May 20 07:00:00 - 07:59:59 82 5.0% 0.02268.3 KB 6.1% 0.07
May 20 08:00:00 - 08:59:59 49 3.0% 0.01164.8 KB 3.7% 0.05
May 20 09:00:00 - 09:59:59 57 3.4% 0.02161.6 KB 3.7% 0.04
May 20 10:00:00 - 10:59:59 65 3.9% 0.02150.9 KB 3.4% 0.04
May 20 11:00:00 - 11:59:59 53 3.2% 0.01112.5 KB 2.5% 0.03
May 20 12:00:00 - 12:59:59 54 3.3% 0.01109.6 KB 2.5% 0.03
May 20 13:00:00 - 13:59:59 54 3.3% 0.0184.1 KB 1.9% 0.02
May 20 14:00:00 - 14:59:59 74 4.5% 0.02147.6 KB 3.3% 0.04
May 20 15:00:00 - 15:59:59 74 4.5% 0.02400.7 KB 9.1% 0.11
May 20 16:00:00 - 16:59:59 72 4.4% 0.02177.9 KB 4.0% 0.05
May 20 17:00:00 - 17:59:59 76 4.6% 0.02210.4 KB 4.8% 0.06
May 20 18:00:00 - 18:59:59 69 4.2% 0.02158.3 KB 3.6% 0.04
May 20 19:00:00 - 19:59:59 78 4.7% 0.02189.9 KB 4.3% 0.05
May 20 20:00:00 - 20:59:59 96 5.8% 0.03237.0 KB 5.4% 0.07
May 20 21:00:00 - 21:59:59 78 4.7% 0.02151.2 KB 3.4% 0.04
May 20 22:00:00 - 22:59:59 102 6.2% 0.03241.0 KB 5.5% 0.07
May 20 23:00:00 - 23:59:59 67 4.0% 0.02159.7 KB 3.6% 0.04
May 21 00:00:00 - 00:59:59 83 5.0% 0.02279.9 KB 6.3% 0.08
May 21 01:00:00 - 01:59:59 66 4.0% 0.02174.2 KB 3.9% 0.05
May 21 02:00:00 - 02:59:59 50 3.0% 0.01117.4 KB 2.7% 0.03
May 21 03:00:00 - 03:00:05 9 0.5% 1.807.3 KB 0.2% 1.45
TOTAL: 24:00:02 1655 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 4728 4187 0 0 0 0 0 0 541
TOTAL: 1 4728 4187 0 0 0 0 0 0 541

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.usenet 1262
free.pt 243
linux.debian.changes.devel 135
de.soc.politik.misc 130
alt.buddha.short.fat.guy 103
fr.soc.politique 99
linux.debian.bugs.dist 99
alt.arts.poetry.comments 90
alt.russian.z1 74
it.hobby.cucina 68
linux.debian.bugs.rc 68
fr.sci.maths 64
alt.usage.english 53
fido7.su.pol 49
de.alt.talk.unmut 48
de.etc.fahrzeug.auto 47
aus.cars 42
it.politica 42
it.test 41
alt.slack 39
TOTAL: 244 4187

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 426
EMP (phl) 46
User-issued cancel 34
EMP (md5) 13
Too many newsgroups 12
HTML Multipart 10
TOTAL: 6 541

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1chimia.se 1656 1655 0 0 0 0 99%23:59:34
2thebunker.nu 1660 1512 0 144 0 1 91%23:58:46
3sklaff.dev 0 0 0 0 0 1649 0%23:57:46
4usenet.blueworldhosting.com 0 0 0 0 0 1405 0%23:59:58
5weretis.net 0 0 0 0 0 0 0%00:10:30
TOTAL: 5 3316 3167 0 144 0 3055 95%96:06:34
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:34
2thebunker.nu3.8 MB483.8 KB4.3 MB0.1 KB/s2.7 KB23:58:46
3sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
4usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:58
5weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:30
TOTAL: 58.2 MB483.8 KB8.6 MB0.0 KB/s2.7 KB96:06:34
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1118.194.250.2 3 00.0 KB 0 0 000:00:12
2195-252-55-9-no600.tbcn.telia.com 3 00.0 KB 0 0 000:10:01
345.172.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:06
493.152.208.38 2 00.0 KB 0 0 000:00:00
5205.210.31.134 1 00.0 KB 0 0 000:00:00
647.89.244.159 1 00.0 KB 0 0 000:00:03
TOTAL: 6 13 00.0 KB 0 0 000:10:24

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 7 00.0 KB 0 0 000:00:16
2*.66.censys-scanner.com 3 00.0 KB 0 0 000:00:06
3*.tbcn.telia.com 3 00.0 KB 0 0 000:10:01
TOTAL: 3 13 00.0 KB 0 0 000:10:24

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
195-252-55-9-no600.tbcn.telia.com 0.011 0.029 0.00000:10:01
118.194.250.2 0.007 0.027 0.00000:00:12
45.172.132.66.censys-scanner.com 0.035 0.045 0.00000:00:06
47.89.244.159 0.006 0.014 0.00000:00:03
205.210.31.134 0.005 0.017 0.00000:00:00
93.152.208.38 0.007 0.018 0.00000:00:00
TOTAL: 6 0.071 0.150 0.00000:10:24

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

SystemConn
93.152.208.38 9
118.194.250.2 2
45.172.132.66.censys-scanner.com 1
TOTAL: 3 12

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

CommandCount
#026#003#001 1
#026#003#001#002 1
?#024 1
?#024?#011?#023 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
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
TOTAL: 12 12

NNRP client timeouts [Top 20]:

SystemConnPeer
45.172.132.66.censys-scanner.com 1 2
47.89.244.159 1 1
TOTAL: 2 2 4
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