Daily Usenet report

Sep 14 03:00:04 -- Sep 15 03:00:03

Unknown entries from news log file:

First 50 / 130 lines (38.5%)

Sep 14 03:01:06 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Sep 14 04:31:32 twilightnode nnrpd[3434910]: Reading access from /usr/local/news/etc/readers.conf
Sep 14 04:31:32 twilightnode nnrpd[3434910]: Auth strategy 'localhost' does not match client. Removing.
Sep 14 04:31:32 twilightnode nnrpd[3434910]: 57.195.132.66.censys-scanner.com res <anonymous>
Sep 14 04:31:32 twilightnode nnrpd[3434910]: 57.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Sep 14 04:31:32 twilightnode nnrpd[3434910]: 57.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 14 04:31:32 twilightnode nnrpd[3434910]: 57.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Sep 14 04:31:32 twilightnode nnrpd[3434910]: 57.195.132.66.censys-scanner.com no_post anonymous-read
Sep 14 04:31:34 twilightnode nnrpd[3434910]: 57.195.132.66.censys-scanner.com res <anonymous>
Sep 14 04:31:34 twilightnode nnrpd[3434910]: 57.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Sep 14 04:31:34 twilightnode nnrpd[3434910]: 57.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 14 04:31:34 twilightnode nnrpd[3434910]: 57.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Sep 14 04:31:34 twilightnode nnrpd[3434910]: 57.195.132.66.censys-scanner.com no_post anonymous-read
Sep 14 09:40:04 twilightnode nnrpd[3449274]: Reading access from /usr/local/news/etc/readers.conf
Sep 14 09:40:04 twilightnode nnrpd[3449274]: Auth strategy 'localhost' does not match client. Removing.
Sep 14 09:40:04 twilightnode nnrpd[3449274]: 193-124-20-235.infrawat.ch res <anonymous>
Sep 14 09:40:04 twilightnode nnrpd[3449274]: 193-124-20-235.infrawat.ch no_match_user <anonymous> <localhost>
Sep 14 09:40:04 twilightnode nnrpd[3449274]: 193-124-20-235.infrawat.ch no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 14 09:40:04 twilightnode nnrpd[3449274]: 193-124-20-235.infrawat.ch match_user <anonymous> <anonymous>
Sep 14 09:40:04 twilightnode nnrpd[3449274]: 193-124-20-235.infrawat.ch no_post anonymous-read
Sep 14 09:40:09 twilightnode nnrpd[3449275]: Reading access from /usr/local/news/etc/readers.conf
Sep 14 09:40:09 twilightnode nnrpd[3449275]: Auth strategy 'localhost' does not match client. Removing.
Sep 14 09:40:09 twilightnode nnrpd[3449275]: 193-124-20-226.infrawat.ch res <anonymous>
Sep 14 09:40:09 twilightnode nnrpd[3449275]: 193-124-20-226.infrawat.ch no_match_user <anonymous> <localhost>
Sep 14 09:40:09 twilightnode nnrpd[3449275]: 193-124-20-226.infrawat.ch no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 14 09:40:09 twilightnode nnrpd[3449275]: 193-124-20-226.infrawat.ch match_user <anonymous> <anonymous>
Sep 14 09:40:09 twilightnode nnrpd[3449275]: 193-124-20-226.infrawat.ch no_post anonymous-read
Sep 14 16:53:44 twilightnode nnrpd[3469180]: Reading access from /usr/local/news/etc/readers.conf
Sep 14 16:53:44 twilightnode nnrpd[3469180]: Auth strategy 'localhost' does not match client. Removing.
Sep 14 16:53:44 twilightnode nnrpd[3469180]: pd9fbdf49.dip0.t-ipconnect.de res <anonymous>
Sep 14 16:53:44 twilightnode nnrpd[3469180]: pd9fbdf49.dip0.t-ipconnect.de no_match_user <anonymous> <localhost>
Sep 14 16:53:44 twilightnode nnrpd[3469180]: pd9fbdf49.dip0.t-ipconnect.de no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 14 16:53:44 twilightnode nnrpd[3469180]: pd9fbdf49.dip0.t-ipconnect.de match_user <anonymous> <anonymous>
Sep 14 16:53:44 twilightnode nnrpd[3469180]: pd9fbdf49.dip0.t-ipconnect.de no_post anonymous-read
Sep 14 17:57:15 twilightnode nnrpd[3472014]: Reading access from /usr/local/news/etc/readers.conf
Sep 14 17:57:15 twilightnode nnrpd[3472014]: Auth strategy 'localhost' does not match client. Removing.
Sep 14 17:57:15 twilightnode nnrpd[3472014]: 49.146.94.167.censys-scanner.com res <anonymous>
Sep 14 17:57:15 twilightnode nnrpd[3472014]: 49.146.94.167.censys-scanner.com no_match_user <anonymous> <localhost>
Sep 14 17:57:15 twilightnode nnrpd[3472014]: 49.146.94.167.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 14 17:57:15 twilightnode nnrpd[3472014]: 49.146.94.167.censys-scanner.com match_user <anonymous> <anonymous>
Sep 14 17:57:15 twilightnode nnrpd[3472014]: 49.146.94.167.censys-scanner.com no_post anonymous-read
Sep 14 17:57:18 twilightnode nnrpd[3472015]: Reading access from /usr/local/news/etc/readers.conf
Sep 14 17:57:18 twilightnode nnrpd[3472015]: Auth strategy 'localhost' does not match client. Removing.
Sep 14 17:57:18 twilightnode nnrpd[3472015]: 49.146.94.167.censys-scanner.com res <anonymous>
Sep 14 17:57:18 twilightnode nnrpd[3472015]: 49.146.94.167.censys-scanner.com no_match_user <anonymous> <localhost>
Sep 14 17:57:18 twilightnode nnrpd[3472015]: 49.146.94.167.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 14 17:57:18 twilightnode nnrpd[3472015]: 49.146.94.167.censys-scanner.com match_user <anonymous> <anonymous>
Sep 14 17:57:18 twilightnode nnrpd[3472015]: 49.146.94.167.censys-scanner.com no_post anonymous-read
Sep 14 17:57:23 twilightnode nnrpd[3472016]: Reading access from /usr/local/news/etc/readers.conf
Sep 14 17:57:23 twilightnode nnrpd[3472016]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 8372 57.7%1.5 MB 63.2%
innd 4663 32.1%651.4 KB 27.3%
innfeed 1275 8.8%203.9 KB 8.5%
nnrpd 210 1.4%21.8 KB 0.9%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 14522 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 23192 53.5%
Negative hits 11881 27.4%
Do not exist 8314 19.2%
Cache misses 1 0.0%
TOTAL: 4 43388 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.019 0.0%16 0.000 1.188 14.000
article cleanup00:00:00.060 0.0%8337 0.000 0.007 0.136
article logging00:00:00.276 0.0%8365 0.000 0.033 0.161
article parse00:00:00.153 0.0%12429 0.000 0.012 0.072
article write00:00:07.373 0.0%7046 0.514 1.046 4.614
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.304 0.0%47177 0.000 0.006 0.097
hisgrep/artcncl00:00:00.008 0.0%16 0.000 0.500 4.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.653 0.0%43516 0.072 0.153 1.808
history sync00:00:00.053 0.0%324 0.000 0.164 1.000
history write00:00:04.387 0.0%8338 0.214 0.526 4.274
idle23:59:47.957 99.9%47591 892.478 1815.216 8111.689
nntp read00:00:00.961 0.0%46618 0.000 0.021 0.059
overview write00:00:04.532 0.0%7046 0.317 0.643 2.818
perl filter00:00:13.384 0.0%8337 0.815 1.605 7.364
python filter00:00:01.014 0.0%8337 0.000 0.122 0.692
site send00:00:00.346 0.0%14053 0.000 0.025 0.139
TOTAL: 1824:00:27.480100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%7534 0.000 0.003 0.267
article prepare00:00:00.000 0.0%30580 0.000 0.000 0.000
article read00:00:01.125 0.0%4750 0.039 0.237 1.300
backlog stats00:00:00.058 0.0%94348 0.000 0.001 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.679 0.0%53325 0.000 0.013 0.038
data write00:00:01.151 0.0%46473 0.000 0.025 0.056
idle23:50:54.262100.0%94348 301.513 909.974 4082.789
status file00:00:00.220 0.0%173 0.000 1.272 27.000
TOTAL: 923:50:57.520100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:12.292100.0%29 20.500 423.862 3095.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%139 0.000 0.000 0.000
TOTAL: 300:00:12.292100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 5 12020 5284 6626 110 43%45:40:54
2usenet.blueworldhosting.com 719 8274 1041 6202 1031 12%23:54:50
3news.tebibyte.org 1 3375 407 2958 10 12%23:02:27
4newsfeed.endofthelinebbs.com 1 3923 163 3674 86 4%18:27:13
5news.sklaffkom.se 38 61 53 8 0 86%08:00:30
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 789 27653 6948 19468 1237 25%119:05:54
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net20.3 MB0.0 KB183.6 KB20.5 MB 99%3.9 KB
2usenet.blueworldhosting.com7.2 MB0.0 KB1.3 MB8.5 MB 84%4.2 KB
3newsfeed.endofthelinebbs.com3.2 MB0.0 KB140.1 KB3.3 MB 95%13.5 KB
4news.tebibyte.org1.3 MB0.0 KB11.5 KB1.3 MB 99%3.2 KB
5news.sklaffkom.se166.1 KB0.0 KB0.0 KB166.1 KB100%3.1 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 632.1 MB0.0 KB1.7 MB33.7 MB 95%4.2 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 14 03:00:04 - 03:59:59 86 1.2% 0.02550.0 KB 1.6% 0.15
Sep 14 04:00:00 - 04:59:59 97 1.4% 0.03580.8 KB 1.7% 0.16
Sep 14 05:00:00 - 05:59:59 105 1.5% 0.031.3 MB 3.8% 0.37
Sep 14 06:00:00 - 06:59:59 116 1.6% 0.03413.9 KB 1.2% 0.11
Sep 14 07:00:00 - 07:59:59 143 2.0% 0.04414.6 KB 1.2% 0.12
Sep 14 08:00:00 - 08:59:59 237 3.4% 0.07777.5 KB 2.3% 0.22
Sep 14 09:00:00 - 09:59:59 301 4.3% 0.081.2 MB 3.6% 0.34
Sep 14 10:00:00 - 10:59:59 339 4.8% 0.091.2 MB 3.6% 0.35
Sep 14 11:00:00 - 11:59:59 402 5.7% 0.112.2 MB 6.5% 0.62
Sep 14 12:00:00 - 12:59:59 399 5.7% 0.111.6 MB 4.6% 0.44
Sep 14 13:00:00 - 13:59:59 359 5.1% 0.103.2 MB 9.5% 0.91
Sep 14 14:00:00 - 14:59:59 322 4.6% 0.091.5 MB 4.4% 0.42
Sep 14 15:00:00 - 15:59:59 416 5.9% 0.121.5 MB 4.5% 0.43
Sep 14 16:00:00 - 16:59:59 391 5.5% 0.111.7 MB 5.0% 0.48
Sep 14 17:00:00 - 17:59:59 473 6.7% 0.132.0 MB 6.1% 0.58
Sep 14 18:00:00 - 18:59:59 384 5.4% 0.111.7 MB 4.9% 0.47
Sep 14 19:00:00 - 19:59:59 413 5.9% 0.111.4 MB 4.2% 0.40
Sep 14 20:00:00 - 20:59:59 432 6.1% 0.121.5 MB 4.6% 0.44
Sep 14 21:00:00 - 21:59:59 344 4.9% 0.101.8 MB 5.3% 0.50
Sep 14 22:00:00 - 22:59:59 334 4.7% 0.091.5 MB 4.4% 0.42
Sep 14 23:00:00 - 23:59:59 279 4.0% 0.081.7 MB 5.1% 0.49
Sep 15 00:00:00 - 00:59:59 215 3.0% 0.06839.8 KB 2.4% 0.23
Sep 15 01:00:00 - 01:59:59 227 3.2% 0.061.5 MB 4.4% 0.42
Sep 15 02:00:00 - 02:59:59 227 3.2% 0.061.8 MB 5.3% 0.50
Sep 15 03:00:00 - 03:00:03 11 0.2% 3.6713.6 KB 0.0% 4.53
TOTAL: 23:59:59 7052 100.0% 0.0833.7 MB 100.0% 0.40
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1031 340 0 0 0 0 0 0 691
2twilightnode-out.news.weretis.net 150 26 0 0 0 0 0 0 124
3newsfeed.endofthelinebbs.com 129 14 0 0 0 0 0 0 115
4news.tebibyte.org 10 1 0 0 0 0 0 0 9
TOTAL: 4 1320 381 0 0 0 0 0 0 939

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
fido.ru.fidonet.today 24
hispagatos.hacking.ransomware 15
de.comm.software.mailreader 6
dfw.forsale 5
hispagatos.mastodon.tag.hacking 5
pl.listserv.chomor-l 5
fido.golded 4
alt.forsale.seattle 3
alt.asshole.binky 2
alt.sports.football.pro.dallas-cowboys 2
fido.8912.local 2
phl.forsale 2
upenn.forsale 2
alt.bbs.files-announce 1
alt.cellular.t-mobile 1
alt.crafts.blacksmithing 1
alt.government.employees 1
austin.forsale 1
chi.forsale 1
TOTAL: 30 381

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 756
Too many newsgroups 87
User-issued cancel 62
HTML Multipart 3
Binary: misplaced binary 1
Too many newsgroups (meow) 1
TOTAL: 6 910

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
twilightnode-out.news.weretis.net 28
TOTAL: 1 28
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 29

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 9124 2832 4040 144 0 69 31%23:59:49
2sklaffkom.se 7137 1140 2340 3531 0 2 15%23:59:54
3newsfeed.endofthelinebbs.com 12891 14 6741 10 0 441 0%23:59:42
4weretis.net 1773 4 1705 0 0 0 0%23:49:38
5usenet.blueworldhosting.com 9649 1 5673 0 0 39 0%23:59:52
TOTAL: 5 40574 3991 20499 3685 0 551 9%119:48:55
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org8.3 MB3.1 MB11.4 MB0.1 KB/s3.9 KB23:59:49
2sklaffkom.se1.9 MB21.0 MB22.8 MB0.3 KB/s5.0 KB23:59:54
3newsfeed.endofthelinebbs.com42.8 KB31.1 KB74.0 KB0.0 KB/s3.1 KB23:59:42
4weretis.net6.3 KB0.0 KB6.3 KB0.0 KB/s1.6 KB23:49:38
5usenet.blueworldhosting.com4.5 KB0.0 KB4.5 KB0.0 KB/s4.5 KB23:59:52
TOTAL: 510.2 MB24.1 MB34.3 MB0.1 KB/s4.6 KB119:48:55
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
149.146.94.167.censys-scanner.com 3 00.0 KB 0 0 000:00:01
271.6.235.138 3 00.0 KB 0 0 000:00:00
387.251.64.133 2 00.0 KB 0 0 000:00:00
4193-124-20-226.infrawat.ch 1 00.0 KB 0 0 000:00:00
5193-124-20-235.infrawat.ch 1 00.0 KB 0 0 000:00:00
657.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
794.154.43.21 1 00.0 KB 0 0 000:00:00
8aaminah.probe.onyphe.net 1 00.0 KB 0 0 000:00:00
9kayne.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
10o005.scanner.modat.io 1 00.0 KB 0 0 000:00:00
11o007.scanner.modat.io 1 00.0 KB 0 0 000:00:01
12pd9fbdf49.dip0.t-ipconnect.de 1 00.0 KB 0 0 000:00:00
TOTAL: 12 17 00.0 KB 0 0 000:00:12

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 6 00.0 KB 0 0 000:00:01
2*.167.censys-scanner.com 3 00.0 KB 0 0 000:00:01
3*.infrawat.ch 2 00.0 KB 0 0 000:00:00
4*.probe.onyphe.net 2 00.0 KB 0 0 000:00:04
5*.scanner.modat.io 2 00.0 KB 0 0 000:00:01
6*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
7*.dip0.t-ipconnect.de 1 00.0 KB 0 0 000:00:00
TOTAL: 7 17 00.0 KB 0 0 000:00:12

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
kayne.probe.onyphe.net 0.005 0.003 0.00000:00:03
57.195.132.66.censys-scanner.com 0.032 0.014 0.00000:00:02
49.146.94.167.censys-scanner.com 0.035 0.031 0.00000:00:01
o007.scanner.modat.io 0.008 0.007 0.00000:00:01
aaminah.probe.onyphe.net 0.008 0.009 0.00000:00:00
71.6.235.138 0.015 0.018 0.00000:00:00
94.154.43.21 0.011 0.008 0.00000:00:00
193-124-20-235.infrawat.ch 0.004 0.013 0.00000:00:00
pd9fbdf49.dip0.t-ipconnect.de 0.003 0.011 0.00000:00:00
87.251.64.133 0.008 0.018 0.00000:00:00
o005.scanner.modat.io 0.004 0.009 0.00000:00:00
193-124-20-226.infrawat.ch 0.006 0.007 0.00000:00:00
TOTAL: 12 0.139 0.148 0.00000:00:12

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

SystemConn
87.251.64.133 10
71.6.235.138 2
aaminah.probe.onyphe.net 2
49.146.94.167.censys-scanner.com 1
57.195.132.66.censys-scanner.com 1
TOTAL: 5 16

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

CommandCount
EHLO www.censys.io 2
#023#003#023#001#023#002#001 1
#026#003#001 1
#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
?E?6j?5"?m$~?/?f\:\?C?l? ?"?g#037?L?... 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
GET / HTTP/1.1 1
Host: 172.234.115.63:119 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
TOTAL: 15 16

NNRP client timeouts [Top 20]:

SystemConnPeer
193-124-20-226.infrawat.ch 1 1
49.146.94.167.censys-scanner.com 1 2
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