Daily Usenet report

May 26 03:00:05 -- May 27 03:00:06

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

May 26 03:00:08 mail nnrpd[549474]: Reading access from /usr/local/news/etc/readers.conf
May 26 03:00:08 mail nnrpd[549474]: Auth strategy 'localhost' does not match client. Removing.
May 26 03:00:08 mail nnrpd[549474]: 195-252-55-9-no600.tbcn.telia.com no_success_auth
May 26 03:01:38 mail innd: message repeated 2 times: [ ctlinnd command s]
May 26 18:57:35 mail nnrpd[591722]: Reading access from /usr/local/news/etc/readers.conf
May 26 18:57:35 mail nnrpd[591722]: Auth strategy 'localhost' does not match client. Removing.
May 26 18:57:35 mail nnrpd[591722]: 93.152.208.38 no_success_auth
May 26 18:57:35 mail nnrpd[591723]: Reading access from /usr/local/news/etc/readers.conf
May 26 18:57:35 mail nnrpd[591723]: Auth strategy 'localhost' does not match client. Removing.
May 26 18:57:35 mail nnrpd[591723]: 93.152.208.38 no_success_auth
May 27 00:38:02 mail nnrpd[615019]: Reading access from /usr/local/news/etc/readers.conf
May 27 00:38:02 mail nnrpd[615019]: Auth strategy 'localhost' does not match client. Removing.
May 27 00:38:02 mail nnrpd[615019]: 214.172.132.66.censys-scanner.com no_success_auth
May 27 00:38:04 mail nnrpd[615019]: 214.172.132.66.censys-scanner.com no_success_auth
May 27 03:00:04 mail nnrpd[621687]: Reading access from /usr/local/news/etc/readers.conf
May 27 03:00:04 mail nnrpd[621687]: Auth strategy 'localhost' does not match client. Removing.
May 27 03:00:04 mail nnrpd[621687]: 195-252-55-9-no600.tbcn.telia.com no_success_auth

Log entries by program:

Program nameLines%LinesSize%Size
inn 7125 69.4%1.0 MB 72.3%
innd 1929 18.8%247.4 KB 17.3%
innfeed 1176 11.4%145.1 KB 10.1%
nnrpd 41 0.4%3.8 KB 0.3%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 10273 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 7697 35.2%
Do not exist 7088 32.4%
Positive hits 7056 32.3%
Cache misses 20 0.1%
TOTAL: 4 21861 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.008 0.0%1 8.000 8.000 8.000
article cleanup00:00:00.081 0.0%7110 0.000 0.011 0.092
article logging00:00:00.280 0.0%7133 0.000 0.039 0.143
article parse00:00:00.147 0.0%9064 0.000 0.016 0.098
article write00:00:02.392 0.0%3423 0.207 0.699 3.903
data move00:00:00.086 0.0%20902 0.000 0.004 0.055
hisgrep/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.945 0.0%21933 0.092 0.225 1.000
history sync00:00:00.127 0.0%414 0.000 0.307 14.000
history write00:00:04.137 0.0%7110 0.214 0.582 1.400
idle24:00:36.791100.0%20775 1770.823 4160.616 20023.967
nntp read00:00:00.534 0.0%20454 0.000 0.026 0.109
overview write00:00:01.698 0.0%3423 0.095 0.496 1.778
perl filter00:00:14.715 0.0%7110 0.677 2.070 21.909
python filter00:00:01.165 0.0%7110 0.033 0.164 1.273
site send00:00:00.118 0.0%3423 0.000 0.034 0.250
TOTAL: 1724:01:07.224100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%3423 0.000 0.007 0.125
article prepare00:00:00.002 0.0%27332 0.000 0.000 0.005
article read00:00:00.572 0.0%3423 0.000 0.167 0.727
backlog stats00:00:00.029 0.0%23441 0.000 0.001 0.018
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.203 0.0%12570 0.000 0.016 0.071
data write00:00:00.312 0.0%9226 0.000 0.034 0.136
idle23:59:31.530100.0%23441 1728.402 3684.635 8701.000
status file00:00:00.226 0.0%182 0.000 1.242 10.000
TOTAL: 923:59:32.897100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:10:04.213100.0%9 45.333 67134.778300395.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%34 0.000 0.000 0.000
TOTAL: 300:10:04.213100.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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 2 13862 3338 6903 3621 24%46:42:46
2localhost 25 0 0 0 0 0%00:00:00
3news.chimia.se 1 0 0 0 0 0%00:10:00
TOTAL: 3 28 13862 3338 6903 3621 24%46:52:46
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net9.9 MB0.0 KB11.1 MB21.0 MB 47%3.1 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: 39.9 MB0.0 KB11.1 MB21.0 MB 47%3.1 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
May 26 03:00:05 - 03:59:59 60 1.8% 0.02172.5 KB 1.6% 0.05
May 26 04:00:00 - 04:59:59 68 2.0% 0.02242.3 KB 2.3% 0.07
May 26 05:00:00 - 05:59:59 78 2.3% 0.02225.9 KB 2.2% 0.06
May 26 06:00:00 - 06:59:59 125 3.7% 0.03364.5 KB 3.5% 0.10
May 26 07:00:00 - 07:59:59 121 3.5% 0.03275.9 KB 2.6% 0.08
May 26 08:00:00 - 08:59:59 101 3.0% 0.03239.1 KB 2.3% 0.07
May 26 09:00:00 - 09:59:59 159 4.6% 0.04350.6 KB 3.3% 0.10
May 26 10:00:00 - 10:59:59 127 3.7% 0.04334.0 KB 3.2% 0.09
May 26 11:00:00 - 11:59:59 141 4.1% 0.04344.6 KB 3.3% 0.10
May 26 12:00:00 - 12:59:59 142 4.2% 0.041.0 MB 10.0% 0.29
May 26 13:00:00 - 13:59:59 148 4.3% 0.04391.6 KB 3.7% 0.11
May 26 14:00:00 - 14:59:59 108 3.2% 0.03416.8 KB 4.0% 0.12
May 26 15:00:00 - 15:59:59 140 4.1% 0.04398.1 KB 3.8% 0.11
May 26 16:00:00 - 16:59:59 167 4.9% 0.05486.4 KB 4.6% 0.14
May 26 17:00:00 - 17:59:59 158 4.6% 0.04496.0 KB 4.7% 0.14
May 26 18:00:00 - 18:59:59 187 5.5% 0.05555.9 KB 5.3% 0.15
May 26 19:00:00 - 19:59:59 198 5.8% 0.06582.9 KB 5.6% 0.16
May 26 20:00:00 - 20:59:59 236 6.9% 0.07626.5 KB 6.0% 0.17
May 26 21:00:00 - 21:59:59 261 7.6% 0.07721.1 KB 6.9% 0.20
May 26 22:00:00 - 22:59:59 176 5.1% 0.05513.3 KB 4.9% 0.14
May 26 23:00:00 - 23:59:59 198 5.8% 0.06571.2 KB 5.5% 0.16
May 27 00:00:00 - 00:59:59 137 4.0% 0.04495.1 KB 4.7% 0.14
May 27 01:00:00 - 01:59:59 103 3.0% 0.03417.8 KB 4.0% 0.12
May 27 02:00:00 - 02:59:59 71 2.1% 0.02187.5 KB 1.8% 0.05
May 27 03:00:00 - 03:00:06 10 0.3% 1.6711.2 KB 0.1% 1.86
TOTAL: 24:00:01 3420 100.0% 0.0410.2 MB 100.0% 0.12
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 3705 2642 0 0 0 0 0 0 1063
TOTAL: 1 3705 2642 0 0 0 0 0 0 1063

Unwanted newsgroups [Top 20]:

NewsgroupCount
fido7.ru.news 150
it.sport.calcio.milan 124
de.soc.politik.misc 122
uk.railway 88
fr.soc.politique 84
de.etc.fahrzeug.auto 76
nl.politiek 62
it.test 58
fido7.ru.home 47
it.hobby.cucina 45
fr.rec.photo 44
it.politica 43
muc.lists.freebsd.bugs 42
alt.slack 38
aus.cars 37
lada.talk 36
alt.fan.rush-limbaugh 34
uk.d-i-y 34
de.etc.finanz.banken+broker 33
pl.soc.polityka 33
TOTAL: 248 2642

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 919
EMP (phl) 64
Too many newsgroups 28
User-issued cancel 12
EMP (md5) 7
Too many newsgroups (meow) 6
HTML Multipart 4
TOTAL: 7 1040

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1chimia.se 3429 3427 0 0 0 0 99%23:59:34
2thebunker.nu 3428 3075 0 349 0 2 89%23:59:29
3sklaff.dev 0 0 0 0 0 3415 0%23:57:44
4usenet.blueworldhosting.com 0 0 0 0 0 3078 0%23:59:57
5weretis.net 0 0 0 0 0 0 0%00:10:30
TOTAL: 5 6857 6502 0 349 0 6495 94%96:07:14
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1chimia.se10.2 MB0.0 KB10.2 MB0.1 KB/s3.1 KB23:59:34
2thebunker.nu8.9 MB1.4 MB10.2 MB0.1 KB/s3.1 KB23:59:29
3sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:44
4usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
5weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:30
TOTAL: 519.1 MB1.4 MB20.5 MB0.1 KB/s3.1 KB96:07:14
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1195-252-55-9-no600.tbcn.telia.com 2 00.0 KB 0 0 000:10:00
293.152.208.38 2 00.0 KB 0 0 000:00:00
3214.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
TOTAL: 3 5 00.0 KB 0 0 000:10:04

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.tbcn.telia.com 2 00.0 KB 0 0 000:10:00
2unresolved 2 00.0 KB 0 0 000:00:00
3*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
TOTAL: 3 5 00.0 KB 0 0 000:10:04

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
195-252-55-9-no600.tbcn.telia.com 0.008 0.007 0.00000:10:00
214.172.132.66.censys-scanner.com 0.037 0.018 0.00000:00:03
93.152.208.38 0.011 0.034 0.00000:00:00
TOTAL: 3 0.056 0.059 0.00000:10:04

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

SystemConn
93.152.208.38 9
214.172.132.66.censys-scanner.com 1
TOTAL: 2 10

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

CommandCount
#026#003#001#002 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: 10 10
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