Daily Usenet report

Sep 24 03:00:04 -- Sep 25 03:00:04

Unknown entries from news log file:

First 50 / 130 lines (38.5%)

Sep 24 03:01:16 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Sep 24 04:17:06 twilightnode nnrpd[4131915]: Reading access from /usr/local/news/etc/readers.conf
Sep 24 04:17:06 twilightnode nnrpd[4131915]: Auth strategy 'localhost' does not match client. Removing.
Sep 24 04:17:06 twilightnode nnrpd[4131915]: 194-88-98-113.infrawat.ch res <anonymous>
Sep 24 04:17:06 twilightnode nnrpd[4131915]: 194-88-98-113.infrawat.ch no_match_user <anonymous> <localhost>
Sep 24 04:17:06 twilightnode nnrpd[4131915]: 194-88-98-113.infrawat.ch no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 24 04:17:06 twilightnode nnrpd[4131915]: 194-88-98-113.infrawat.ch match_user <anonymous> <anonymous>
Sep 24 04:17:06 twilightnode nnrpd[4131915]: 194-88-98-113.infrawat.ch no_post anonymous-read
Sep 24 04:17:09 twilightnode nnrpd[4131916]: Reading access from /usr/local/news/etc/readers.conf
Sep 24 04:17:09 twilightnode nnrpd[4131916]: Auth strategy 'localhost' does not match client. Removing.
Sep 24 04:17:09 twilightnode nnrpd[4131916]: 89-37-172-151.infrawat.ch res <anonymous>
Sep 24 04:17:09 twilightnode nnrpd[4131916]: 89-37-172-151.infrawat.ch no_match_user <anonymous> <localhost>
Sep 24 04:17:09 twilightnode nnrpd[4131916]: 89-37-172-151.infrawat.ch no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 24 04:17:09 twilightnode nnrpd[4131916]: 89-37-172-151.infrawat.ch match_user <anonymous> <anonymous>
Sep 24 04:17:09 twilightnode nnrpd[4131916]: 89-37-172-151.infrawat.ch no_post anonymous-read
Sep 24 06:31:20 twilightnode nnrpd[4138590]: Reading access from /usr/local/news/etc/readers.conf
Sep 24 06:31:20 twilightnode nnrpd[4138590]: Auth strategy 'localhost' does not match client. Removing.
Sep 24 06:31:20 twilightnode nnrpd[4138590]: 200.172.132.66.censys-scanner.com res <anonymous>
Sep 24 06:31:20 twilightnode nnrpd[4138590]: 200.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Sep 24 06:31:20 twilightnode nnrpd[4138590]: 200.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 24 06:31:20 twilightnode nnrpd[4138590]: 200.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Sep 24 06:31:20 twilightnode nnrpd[4138590]: 200.172.132.66.censys-scanner.com no_post anonymous-read
Sep 24 06:31:21 twilightnode nnrpd[4138590]: 200.172.132.66.censys-scanner.com res <anonymous>
Sep 24 06:31:21 twilightnode nnrpd[4138590]: 200.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Sep 24 06:31:21 twilightnode nnrpd[4138590]: 200.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 24 06:31:21 twilightnode nnrpd[4138590]: 200.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Sep 24 06:31:21 twilightnode nnrpd[4138590]: 200.172.132.66.censys-scanner.com no_post anonymous-read
Sep 24 07:32:12 twilightnode nnrpd[4147712]: Reading access from /usr/local/news/etc/readers.conf
Sep 24 07:32:12 twilightnode nnrpd[4147712]: Auth strategy 'localhost' does not match client. Removing.
Sep 24 07:32:12 twilightnode nnrpd[4147712]: 179.172.132.66.censys-scanner.com res <anonymous>
Sep 24 07:32:12 twilightnode nnrpd[4147712]: 179.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Sep 24 07:32:12 twilightnode nnrpd[4147712]: 179.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 24 07:32:12 twilightnode nnrpd[4147712]: 179.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Sep 24 07:32:12 twilightnode nnrpd[4147712]: 179.172.132.66.censys-scanner.com no_post anonymous-read
Sep 24 07:32:20 twilightnode nnrpd[4147713]: Reading access from /usr/local/news/etc/readers.conf
Sep 24 07:32:20 twilightnode nnrpd[4147713]: Auth strategy 'localhost' does not match client. Removing.
Sep 24 07:32:20 twilightnode nnrpd[4147713]: 179.172.132.66.censys-scanner.com res <anonymous>
Sep 24 07:32:20 twilightnode nnrpd[4147713]: 179.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Sep 24 07:32:20 twilightnode nnrpd[4147713]: 179.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 24 07:32:20 twilightnode nnrpd[4147713]: 179.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Sep 24 07:32:20 twilightnode nnrpd[4147713]: 179.172.132.66.censys-scanner.com no_post anonymous-read
Sep 24 07:32:26 twilightnode nnrpd[4147714]: Reading access from /usr/local/news/etc/readers.conf
Sep 24 07:32:26 twilightnode nnrpd[4147714]: Auth strategy 'localhost' does not match client. Removing.
Sep 24 07:32:26 twilightnode nnrpd[4147714]: 179.172.132.66.censys-scanner.com res <anonymous>
Sep 24 07:32:26 twilightnode nnrpd[4147714]: 179.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Sep 24 07:32:26 twilightnode nnrpd[4147714]: 179.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 24 07:32:26 twilightnode nnrpd[4147714]: 179.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Sep 24 07:32:26 twilightnode nnrpd[4147714]: 179.172.132.66.censys-scanner.com no_post anonymous-read
Sep 24 07:32:26 twilightnode nnrpd[4147714]: 179.172.132.66.censys-scanner.com res <anonymous>
Sep 24 07:32:26 twilightnode nnrpd[4147714]: 179.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>

Log entries by program:

Program nameLines%LinesSize%Size
inn 7235 62.6%1.3 MB 67.2%
innd 2853 24.7%396.8 KB 20.7%
innfeed 1250 10.8%209.0 KB 10.9%
nnrpd 214 1.9%22.4 KB 1.2%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 11553 100.0%1.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 19121 51.4%
Negative hits 10899 29.3%
Do not exist 7196 19.3%
Cache misses 6 0.0%
TOTAL: 4 37222 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.072 0.0%31 0.000 2.323 5.000
article cleanup00:00:00.084 0.0%7214 0.000 0.012 0.125
article logging00:00:00.263 0.0%7238 0.000 0.036 0.231
article parse00:00:00.113 0.0%9963 0.000 0.011 0.086
article write00:00:06.350 0.0%6051 0.565 1.049 2.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.268 0.0%39316 0.000 0.007 0.083
hisgrep/artcncl00:00:00.025 0.0%31 0.000 0.806 1.077
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.548 0.0%37315 0.064 0.122 0.334
history sync00:00:00.041 0.0%333 0.000 0.123 1.000
history write00:00:03.225 0.0%7214 0.133 0.447 1.000
idle23:59:48.691 99.9%39565 1106.655 2183.462 6978.105
nntp read00:00:00.841 0.0%39007 0.000 0.022 0.054
overview write00:00:04.532 0.0%6051 0.353 0.749 2.200
perl filter00:00:13.496 0.0%7214 0.900 1.871 12.462
python filter00:00:01.064 0.0%7214 0.000 0.147 1.034
site send00:00:00.257 0.0%12055 0.000 0.021 0.088
TOTAL: 1824:00:23.870100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%6161 0.000 0.004 0.048
article prepare00:00:00.003 0.0%25732 0.000 0.000 0.008
article read00:00:01.065 0.0%4191 0.000 0.254 4.250
backlog stats00:00:00.037 0.0%80475 0.000 0.000 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.641 0.0%45144 0.000 0.014 0.051
data write00:00:00.980 0.0%39189 0.000 0.025 0.058
idle23:59:37.248100.0%80475 346.502 1073.343 3455.236
status file00:00:00.126 0.0%160 0.000 0.787 6.000
TOTAL: 923:59:40.125100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:32.347100.0%29 15.000 1115.414 10045.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%149 0.000 0.007 0.125
TOTAL: 300:00:32.348100.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 12367 4262 8058 47 34%56:12:16
2usenet.blueworldhosting.com 297 7120 1694 4354 1072 23%23:38:24
3newsfeed.endofthelinebbs.com 2 1616 122 1475 19 7%10:23:28
4news.tebibyte.org 2 3340 99 3240 1 2%23:59:54
5news.sklaffkom.se 33 61 45 16 0 73%07:37:50
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 364 24504 6222 17143 1139 25%121:51:52
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net13.8 MB0.0 KB167.6 KB13.9 MB 98%3.3 KB
2usenet.blueworldhosting.com9.5 MB0.0 KB1.7 MB11.2 MB 84%4.1 KB
3newsfeed.endofthelinebbs.com1.1 MB0.0 KB25.8 KB1.1 MB 97%8.3 KB
4news.tebibyte.org349.8 KB0.0 KB1.4 KB351.2 KB 99%3.5 KB
5news.sklaffkom.se190.0 KB0.0 KB0.0 KB190.0 KB100%4.2 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 624.9 MB0.0 KB1.9 MB26.8 MB 92%3.7 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 24 03:00:04 - 03:59:59 111 1.8% 0.03860.5 KB 3.4% 0.24
Sep 24 04:00:00 - 04:59:59 174 2.9% 0.05925.5 KB 3.6% 0.26
Sep 24 05:00:00 - 05:59:59 125 2.1% 0.03451.5 KB 1.8% 0.13
Sep 24 06:00:00 - 06:59:59 122 2.0% 0.03392.4 KB 1.5% 0.11
Sep 24 07:00:00 - 07:59:59 187 3.1% 0.05750.5 KB 2.9% 0.21
Sep 24 08:00:00 - 08:59:59 173 2.9% 0.05535.8 KB 2.1% 0.15
Sep 24 09:00:00 - 09:59:59 330 5.5% 0.091.3 MB 5.1% 0.36
Sep 24 10:00:00 - 10:59:59 298 4.9% 0.08871.0 KB 3.4% 0.24
Sep 24 11:00:00 - 11:59:59 340 5.6% 0.091.2 MB 4.7% 0.33
Sep 24 12:00:00 - 12:59:59 348 5.8% 0.101.1 MB 4.5% 0.32
Sep 24 13:00:00 - 13:59:59 293 4.8% 0.081.2 MB 4.9% 0.35
Sep 24 14:00:00 - 14:59:59 293 4.8% 0.081.0 MB 4.2% 0.30
Sep 24 15:00:00 - 15:59:59 305 5.0% 0.081.4 MB 5.7% 0.41
Sep 24 16:00:00 - 16:59:59 336 5.6% 0.091.2 MB 4.7% 0.33
Sep 24 17:00:00 - 17:59:59 298 4.9% 0.081.5 MB 5.9% 0.42
Sep 24 18:00:00 - 18:59:59 298 4.9% 0.081.2 MB 5.0% 0.35
Sep 24 19:00:00 - 19:59:59 321 5.3% 0.091.3 MB 5.1% 0.36
Sep 24 20:00:00 - 20:59:59 324 5.4% 0.091.5 MB 6.0% 0.43
Sep 24 21:00:00 - 21:59:59 293 4.8% 0.08982.9 KB 3.9% 0.27
Sep 24 22:00:00 - 22:59:59 275 4.5% 0.081.1 MB 4.4% 0.31
Sep 24 23:00:00 - 23:59:59 240 4.0% 0.071.1 MB 4.3% 0.31
Sep 25 00:00:00 - 00:59:59 212 3.5% 0.061.1 MB 4.5% 0.32
Sep 25 01:00:00 - 01:59:59 213 3.5% 0.061.2 MB 4.8% 0.34
Sep 25 02:00:00 - 02:59:59 129 2.1% 0.04861.8 KB 3.4% 0.24
Sep 25 03:00:00 - 03:00:04 10 0.2% 2.509.7 KB 0.0% 2.42
TOTAL: 24:00:00 6048 100.0% 0.0724.9 MB 100.0% 0.30
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1074 339 0 0 0 0 0 0 735
2twilightnode-out.news.weretis.net 70 6 0 0 0 0 0 0 64
3newsfeed.endofthelinebbs.com 42 2 0 0 2 0 0 0 38
4news.tebibyte.org 1 0 0 0 0 0 0 0 1
TOTAL: 4 1187 347 0 0 2 0 0 0 838

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 287
hispagatos.hacking.ransomware 27
fido.ru.fidonet.today 9
hispagatos.mastodon.tag.hacking 6
alt.fan.states.new-mexico 2
alt.society.nottingham 2
realms.testing 2
alt.2600.madrid 1
alt.autos.performance-cars 1
alt.bbs.files-announce 1
alt.sex.pedophilia 1
chmurka.statystyki 1
fido.english_tutor 1
fido.ru.space 1
fido.su.pol 1
hispagatos.mastodon.tag.hackers 1
pl.comp.sys.macintosh 1
realms.games 1
va.politics 1
TOTAL: 19 347

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
uk.religion.christian 2
TOTAL: 1 2

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 698
Too many newsgroups 78
User-issued cancel 27
HTML Multipart 11
TOTAL: 4 814

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 8356 2245 3675 81 0 8 26%23:59:56
2sklaffkom.se 6120 805 1950 3248 0 0 13%23:59:56
3newsfeed.endofthelinebbs.com 10372 42 5815 15 0 156 0%23:59:48
4weretis.net 2062 4 2009 0 0 0 0%23:57:54
5usenet.blueworldhosting.com 7010 2 4039 0 0 2 0%23:59:01
TOTAL: 5 33920 3098 17488 3344 0 166 9%119:56:35
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org5.8 MB1.1 MB7.0 MB0.1 KB/s3.1 KB23:59:56
2sklaffkom.se1.5 MB16.2 MB17.7 MB0.2 KB/s4.5 KB23:59:56
3newsfeed.endofthelinebbs.com198.9 KB52.9 KB251.8 KB0.0 KB/s4.4 KB23:59:48
4weretis.net28.5 KB0.0 KB28.5 KB0.0 KB/s7.1 KB23:57:54
5usenet.blueworldhosting.com15.6 KB0.0 KB15.6 KB0.0 KB/s7.8 KB23:59:01
TOTAL: 57.6 MB17.4 MB25.0 MB0.1 KB/s4.0 KB119:56:35
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1118.193.69.177 3 00.0 KB 0 0 000:00:11
2179.172.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:03
387.251.64.131 2 00.0 KB 0 0 000:00:00
4azpdcgoi70ue.stretchoid.com 2 00.0 KB 0 0 000:00:09
516.5.0.241 1 00.0 KB 0 0 000:00:03
6185-223-235-39.infrawat.ch 1 00.0 KB 0 0 000:00:00
7194-88-98-113.infrawat.ch 1 00.0 KB 0 0 000:00:00
8200.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:01
981-19-219-243.infrawat.ch 1 00.0 KB 0 0 000:00:00
1089-37-172-151.infrawat.ch 1 00.0 KB 0 0 000:00:00
11o031.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 11 17 00.0 KB 0 0 000:00:32

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 6 00.0 KB 0 0 000:00:15
2*.66.censys-scanner.com 4 00.0 KB 0 0 000:00:05
3*.infrawat.ch 4 00.0 KB 0 0 000:00:01
4*.stretchoid.com 2 00.0 KB 0 0 000:00:09
5*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 5 17 00.0 KB 0 0 000:00:32

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
118.193.69.177 0.018 0.023 0.00000:00:11
azpdcgoi70ue.stretchoid.com 0.008 0.025 0.00000:00:09
179.172.132.66.censys-scanner.com 0.041 0.038 0.00000:00:03
16.5.0.241 0.010 0.023 0.00000:00:03
200.172.132.66.censys-scanner.com 0.030 0.024 0.00000:00:01
89-37-172-151.infrawat.ch 0.005 0.003 0.00000:00:00
185-223-235-39.infrawat.ch 0.001 0.014 0.00000:00:00
81-19-219-243.infrawat.ch 0.003 0.006 0.00000:00:00
o031.scanner.modat.io 0.005 0.009 0.00000:00:00
194-88-98-113.infrawat.ch 0.006 0.018 0.00000:00:00
87.251.64.131 0.010 0.019 0.00000:00:00
TOTAL: 11 0.137 0.202 0.00000:00:32

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

SystemConn
87.251.64.131 10
118.193.69.177 2
179.172.132.66.censys-scanner.com 1
200.172.132.66.censys-scanner.com 1
azpdcgoi70ue.stretchoid.com 1
TOTAL: 5 15

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

CommandCount
EHLO www.censys.io 2
#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 1
#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
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: 14 15

NNRP client timeouts [Top 20]:

SystemConnPeer
179.172.132.66.censys-scanner.com 1 2
81-19-219-243.infrawat.ch 1 1
89-37-172-151.infrawat.ch 1 1
TOTAL: 3 3 6
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