Daily Usenet report

Aug 29 03:00:04 -- Aug 30 03:00:04

Unknown entries from news log file:

First 34 / 34 lines (100.0%)

Aug 29 03:00:59 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Aug 29 03:14:54 twilightnode nnrpd[2344315]: Reading access from /usr/local/news/etc/readers.conf
Aug 29 03:14:54 twilightnode nnrpd[2344315]: Auth strategy 'localhost' does not match client. Removing.
Aug 29 03:14:54 twilightnode nnrpd[2344315]: 151.243.11.12 res <anonymous>
Aug 29 03:14:54 twilightnode nnrpd[2344315]: 151.243.11.12 no_match_user <anonymous> <localhost>
Aug 29 03:14:54 twilightnode nnrpd[2344315]: 151.243.11.12 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 29 03:14:54 twilightnode nnrpd[2344315]: 151.243.11.12 match_user <anonymous> <anonymous>
Aug 29 03:14:54 twilightnode nnrpd[2344315]: 151.243.11.12 no_post anonymous-read
Aug 29 03:27:29 twilightnode nnrpd[2344821]: Reading access from /usr/local/news/etc/readers.conf
Aug 29 03:27:29 twilightnode nnrpd[2344821]: Auth strategy 'localhost' does not match client. Removing.
Aug 29 03:27:29 twilightnode nnrpd[2344821]: 151.243.11.13 res <anonymous>
Aug 29 03:27:29 twilightnode nnrpd[2344821]: 151.243.11.13 no_match_user <anonymous> <localhost>
Aug 29 03:27:29 twilightnode nnrpd[2344821]: 151.243.11.13 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 29 03:27:29 twilightnode nnrpd[2344821]: 151.243.11.13 match_user <anonymous> <anonymous>
Aug 29 03:27:29 twilightnode nnrpd[2344821]: 151.243.11.13 no_post anonymous-read
Aug 29 12:19:14 twilightnode nnrpd[2369371]: Reading access from /usr/local/news/etc/readers.conf
Aug 29 12:19:14 twilightnode nnrpd[2369371]: Auth strategy 'localhost' does not match client. Removing.
Aug 29 12:19:14 twilightnode nnrpd[2369371]: 205.210.31.110 res <anonymous>
Aug 29 12:19:14 twilightnode nnrpd[2369371]: 205.210.31.110 no_match_user <anonymous> <localhost>
Aug 29 12:19:14 twilightnode nnrpd[2369371]: 205.210.31.110 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 29 12:19:14 twilightnode nnrpd[2369371]: 205.210.31.110 match_user <anonymous> <anonymous>
Aug 29 12:19:14 twilightnode nnrpd[2369371]: 205.210.31.110 no_post anonymous-read
Aug 29 15:36:53 twilightnode nnrpd[2378112]: Reading access from /usr/local/news/etc/readers.conf
Aug 29 15:36:53 twilightnode nnrpd[2378112]: Auth strategy 'localhost' does not match client. Removing.
Aug 29 15:36:53 twilightnode nnrpd[2378112]: 136.172.132.66.censys-scanner.com res <anonymous>
Aug 29 15:36:53 twilightnode nnrpd[2378112]: 136.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 29 15:36:53 twilightnode nnrpd[2378112]: 136.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 29 15:36:53 twilightnode nnrpd[2378112]: 136.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 29 15:36:53 twilightnode nnrpd[2378112]: 136.172.132.66.censys-scanner.com no_post anonymous-read
Aug 29 15:36:54 twilightnode nnrpd[2378112]: 136.172.132.66.censys-scanner.com res <anonymous>
Aug 29 15:36:54 twilightnode nnrpd[2378112]: 136.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 29 15:36:54 twilightnode nnrpd[2378112]: 136.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 29 15:36:54 twilightnode nnrpd[2378112]: 136.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 29 15:36:54 twilightnode nnrpd[2378112]: 136.172.132.66.censys-scanner.com no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
inn 6564 52.6%1.1 MB 57.8%
innd 4593 36.8%645.0 KB 32.1%
innfeed 1274 10.2%197.8 KB 9.8%
nnrpd 51 0.4%5.2 KB 0.3%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 5 12484 100.0%2.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 18103 52.7%
Negative hits 9690 28.2%
Do not exist 6532 19.0%
Cache misses 0 0.0%
TOTAL: 4 34325 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.072 0.0%20 0.000 3.600 20.000
article cleanup00:00:00.080 0.0%6543 0.000 0.012 0.095
article logging00:00:00.232 0.0%6564 0.000 0.035 0.149
article parse00:00:00.090 0.0%8002 0.000 0.011 0.111
article write00:00:05.468 0.0%5336 0.595 1.025 3.059
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.115 0.0%35429 0.000 0.003 0.042
hisgrep/artcncl00:00:00.005 0.0%20 0.000 0.250 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.759 0.0%34380 0.049 0.109 0.216
history sync00:00:00.045 0.0%410 0.000 0.110 1.333
history write00:00:02.879 0.0%6543 0.083 0.440 1.022
idle24:00:27.825100.0%36782 1305.026 2349.732 8700.812
nntp read00:00:00.710 0.0%35737 0.000 0.020 0.062
overview write00:00:03.640 0.0%5336 0.333 0.682 2.333
perl filter00:00:11.886 0.0%6543 1.028 1.817 7.478
python filter00:00:00.714 0.0%6543 0.000 0.109 0.556
site send00:00:00.220 0.0%10627 0.000 0.021 0.100
TOTAL: 1824:00:57.740100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%5587 0.000 0.005 0.095
article prepare00:00:00.010 0.0%23568 0.000 0.000 0.009
article read00:00:00.868 0.0%3446 0.000 0.252 1.727
backlog stats00:00:00.049 0.0%72545 0.000 0.001 0.012
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.495 0.0%40053 0.000 0.012 0.109
data write00:00:00.843 0.0%34807 0.000 0.024 0.076
idle23:58:39.266100.0%72545 272.411 1189.872 4303.971
status file00:00:00.119 0.0%173 0.000 0.688 3.000
TOTAL: 923:58:41.679100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:09.488100.0%5 466.500 1897.600 4042.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%11 0.000 0.000 0.000
TOTAL: 300:00:09.488100.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 4 11997 4306 7455 236 35%54:57:29
2usenet.blueworldhosting.com 714 6482 851 4686 945 13%23:48:20
3newsfeed.endofthelinebbs.com 2 1586 80 1470 36 5%11:56:54
4news.sklaffkom.se 38 71 67 4 0 94%08:40:45
5news.tebibyte.org 2 3243 41 3200 2 1%23:52:37
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 785 23379 5345 16815 1219 22%123:16:05
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net13.4 MB0.0 KB519.1 KB13.9 MB 96%3.1 KB
2usenet.blueworldhosting.com2.7 MB0.0 KB1.2 MB3.9 MB 68%2.2 KB
3newsfeed.endofthelinebbs.com496.9 KB0.0 KB60.0 KB556.9 KB 89%4.8 KB
4news.tebibyte.org182.1 KB0.0 KB2.2 KB184.3 KB 98%4.3 KB
5news.sklaffkom.se176.4 KB0.0 KB0.0 KB176.4 KB100%2.6 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 616.9 MB0.0 KB1.8 MB18.7 MB 90%2.9 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 29 03:00:04 - 03:59:59 110 2.1% 0.03389.5 KB 2.2% 0.11
Aug 29 04:00:00 - 04:59:59 115 2.2% 0.03456.6 KB 2.5% 0.13
Aug 29 05:00:00 - 05:59:59 90 1.7% 0.03289.3 KB 1.6% 0.08
Aug 29 06:00:00 - 06:59:59 124 2.3% 0.03349.6 KB 1.9% 0.10
Aug 29 07:00:00 - 07:59:59 129 2.4% 0.04312.1 KB 1.7% 0.09
Aug 29 08:00:00 - 08:59:59 170 3.2% 0.05429.4 KB 2.4% 0.12
Aug 29 09:00:00 - 09:59:59 217 4.1% 0.06613.9 KB 3.4% 0.17
Aug 29 10:00:00 - 10:59:59 262 4.9% 0.07812.1 KB 4.5% 0.23
Aug 29 11:00:00 - 11:59:59 293 5.5% 0.081.1 MB 6.1% 0.31
Aug 29 12:00:00 - 12:59:59 311 5.8% 0.09955.2 KB 5.3% 0.27
Aug 29 13:00:00 - 13:59:59 327 6.1% 0.09842.3 KB 4.7% 0.23
Aug 29 14:00:00 - 14:59:59 249 4.7% 0.07603.3 KB 3.3% 0.17
Aug 29 15:00:00 - 15:59:59 329 6.2% 0.091.2 MB 7.0% 0.35
Aug 29 16:00:00 - 16:59:59 339 6.4% 0.091.1 MB 6.5% 0.33
Aug 29 17:00:00 - 17:59:59 300 5.6% 0.08904.6 KB 5.0% 0.25
Aug 29 18:00:00 - 18:59:59 300 5.6% 0.081.4 MB 7.8% 0.39
Aug 29 19:00:00 - 19:59:59 212 4.0% 0.06605.4 KB 3.3% 0.17
Aug 29 20:00:00 - 20:59:59 214 4.0% 0.061.0 MB 5.7% 0.29
Aug 29 21:00:00 - 21:59:59 241 4.5% 0.07726.9 KB 4.0% 0.20
Aug 29 22:00:00 - 22:59:59 246 4.6% 0.07812.0 KB 4.5% 0.23
Aug 29 23:00:00 - 23:59:59 231 4.3% 0.06963.9 KB 5.3% 0.27
Aug 30 00:00:00 - 00:59:59 241 4.5% 0.07894.1 KB 4.9% 0.25
Aug 30 01:00:00 - 01:59:59 154 2.9% 0.04559.5 KB 3.1% 0.16
Aug 30 02:00:00 - 02:59:59 123 2.3% 0.03579.5 KB 3.2% 0.16
Aug 30 03:00:00 - 03:00:04 9 0.2% 2.257.9 KB 0.0% 1.98
TOTAL: 24:00:00 5336 100.0% 0.0617.7 MB 100.0% 0.21
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 945 365 0 0 0 0 0 0 580
2twilightnode-out.news.weretis.net 180 14 0 0 0 0 0 0 166
3newsfeed.endofthelinebbs.com 103 22 0 0 0 0 0 0 81
TOTAL: 3 1228 401 0 0 0 0 0 0 827

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
fido.nodelist-police 24
fido.ru.fidonet.today 21
fido.fidotest 19
hispagatos.hacking.ransomware 12
fido.testing 11
free.fr.test 4
hispagatos.mastodon.tag.hacking 4
de.comm.technik.mobil 2
fido.pvt.girls 2
wolfsburg.test 2
alt.bbs.files-announce 1
alt.fan.dragons 1
alt.magick 1
alt.nl.radio.zendamateur.gelicentieerd 1
alt.religion.emacs 1
chmurka.statystyki 1
chmurka.test 1
de.comm.software.mailserver 1
fido.altyn.local 1
TOTAL: 23 401

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 577
Too many newsgroups 87
EMP (phn path) 78
User-issued cancel 59
Too many newsgroups (low_xpost) 3
HTML Multipart 2
TOTAL: 6 806

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 6799 2465 2749 61 19 7 36%23:59:41
2sklaffkom.se 5423 925 1940 2407 23 0 17%23:59:57
3weretis.net 1115 5 1063 0 0 0 0%23:49:57
4newsfeed.endofthelinebbs.com 9698 4 5190 4 0 282 0%23:59:56
5usenet.blueworldhosting.com 7003 0 4052 1 0 3 0%23:59:56
TOTAL: 5 30038 3399 14994 2473 42 292 11%119:49:27
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org6.6 MB918.6 KB7.5 MB0.1 KB/s3.0 KB23:59:41
2sklaffkom.se1.5 MB8.6 MB10.1 MB0.1 KB/s3.1 KB23:59:57
3newsfeed.endofthelinebbs.com26.5 KB13.3 KB39.8 KB0.0 KB/s5.0 KB23:59:56
4weretis.net6.2 KB0.0 KB6.2 KB0.0 KB/s1.2 KB23:49:57
5usenet.blueworldhosting.com0.0 KB1.5 KB1.5 KB0.0 KB/s1.5 KB23:59:56
TOTAL: 58.1 MB9.5 MB17.6 MB0.0 KB/s3.1 KB119:49:27
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1136.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2151.243.11.12 1 00.0 KB 0 0 000:00:04
3151.243.11.13 1 00.0 KB 0 0 000:00:04
4205.210.31.110 1 00.0 KB 0 0 000:00:00
TOTAL: 4 4 00.0 KB 0 0 000:00:09

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 3 00.0 KB 0 0 000:00:08
2*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 2 4 00.0 KB 0 0 000:00:09

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
151.243.11.12 0.003 0.013 0.00000:00:04
151.243.11.13 0.003 0.013 0.00000:00:04
136.172.132.66.censys-scanner.com 0.026 0.012 0.00000:00:00
205.210.31.110 0.002 0.022 0.00000:00:00
TOTAL: 4 0.034 0.060 0.00000:00:09

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

SystemConn
136.172.132.66.censys-scanner.com 1
TOTAL: 1 1

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

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1