Daily Usenet report

Aug 30 03:00:04 -- Aug 31 03:00:03

Unknown entries from news log file:

First 50 / 81 lines (61.7%)

Aug 30 03:01:00 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Aug 30 04:01:56 twilightnode nnrpd[2411526]: Reading access from /usr/local/news/etc/readers.conf
Aug 30 04:01:56 twilightnode nnrpd[2411526]: Auth strategy 'localhost' does not match client. Removing.
Aug 30 04:01:56 twilightnode nnrpd[2411526]: 130.172.132.66.censys-scanner.com res <anonymous>
Aug 30 04:01:56 twilightnode nnrpd[2411526]: 130.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 30 04:01:56 twilightnode nnrpd[2411526]: 130.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 30 04:01:56 twilightnode nnrpd[2411526]: 130.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 30 04:01:56 twilightnode nnrpd[2411526]: 130.172.132.66.censys-scanner.com no_post anonymous-read
Aug 30 04:02:02 twilightnode nnrpd[2411533]: Reading access from /usr/local/news/etc/readers.conf
Aug 30 04:02:02 twilightnode nnrpd[2411533]: Auth strategy 'localhost' does not match client. Removing.
Aug 30 04:02:02 twilightnode nnrpd[2411533]: 130.172.132.66.censys-scanner.com res <anonymous>
Aug 30 04:02:02 twilightnode nnrpd[2411533]: 130.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 30 04:02:02 twilightnode nnrpd[2411533]: 130.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 30 04:02:02 twilightnode nnrpd[2411533]: 130.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 30 04:02:02 twilightnode nnrpd[2411533]: 130.172.132.66.censys-scanner.com no_post anonymous-read
Aug 30 04:02:07 twilightnode nnrpd[2411580]: Reading access from /usr/local/news/etc/readers.conf
Aug 30 04:02:07 twilightnode nnrpd[2411580]: Auth strategy 'localhost' does not match client. Removing.
Aug 30 04:02:07 twilightnode nnrpd[2411580]: 130.172.132.66.censys-scanner.com res <anonymous>
Aug 30 04:02:07 twilightnode nnrpd[2411580]: 130.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 30 04:02:07 twilightnode nnrpd[2411580]: 130.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 30 04:02:07 twilightnode nnrpd[2411580]: 130.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 30 04:02:07 twilightnode nnrpd[2411580]: 130.172.132.66.censys-scanner.com no_post anonymous-read
Aug 30 04:02:08 twilightnode nnrpd[2411580]: 130.172.132.66.censys-scanner.com res <anonymous>
Aug 30 04:02:08 twilightnode nnrpd[2411580]: 130.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 30 04:02:08 twilightnode nnrpd[2411580]: 130.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 30 04:02:08 twilightnode nnrpd[2411580]: 130.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 30 04:02:08 twilightnode nnrpd[2411580]: 130.172.132.66.censys-scanner.com no_post anonymous-read
Aug 30 10:59:39 twilightnode nnrpd[2429557]: Reading access from /usr/local/news/etc/readers.conf
Aug 30 10:59:39 twilightnode nnrpd[2429557]: Auth strategy 'localhost' does not match client. Removing.
Aug 30 10:59:39 twilightnode nnrpd[2429557]: r4-224-e0.monitoring.internet-measurement.com res <anonymous>
Aug 30 10:59:39 twilightnode nnrpd[2429557]: r4-224-e0.monitoring.internet-measurement.com no_match_user <anonymous> <localhost>
Aug 30 10:59:39 twilightnode nnrpd[2429557]: r4-224-e0.monitoring.internet-measurement.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 30 10:59:39 twilightnode nnrpd[2429557]: r4-224-e0.monitoring.internet-measurement.com match_user <anonymous> <anonymous>
Aug 30 10:59:39 twilightnode nnrpd[2429557]: r4-224-e0.monitoring.internet-measurement.com no_post anonymous-read
Aug 30 11:22:40 twilightnode nnrpd[2430679]: Reading access from /usr/local/news/etc/readers.conf
Aug 30 11:22:40 twilightnode nnrpd[2430679]: Auth strategy 'localhost' does not match client. Removing.
Aug 30 11:22:40 twilightnode nnrpd[2430679]: r5-142-8e.monitoring.internet-measurement.com res <anonymous>
Aug 30 11:22:40 twilightnode nnrpd[2430679]: r5-142-8e.monitoring.internet-measurement.com no_match_user <anonymous> <localhost>
Aug 30 11:22:40 twilightnode nnrpd[2430679]: r5-142-8e.monitoring.internet-measurement.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 30 11:22:40 twilightnode nnrpd[2430679]: r5-142-8e.monitoring.internet-measurement.com match_user <anonymous> <anonymous>
Aug 30 11:22:40 twilightnode nnrpd[2430679]: r5-142-8e.monitoring.internet-measurement.com no_post anonymous-read
Aug 30 11:37:36 twilightnode nnrpd[2431200]: Reading access from /usr/local/news/etc/readers.conf
Aug 30 11:37:36 twilightnode nnrpd[2431200]: Auth strategy 'localhost' does not match client. Removing.
Aug 30 11:37:36 twilightnode nnrpd[2431200]: 50.146.94.167.censys-scanner.com res <anonymous>
Aug 30 11:37:36 twilightnode nnrpd[2431200]: 50.146.94.167.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 30 11:37:36 twilightnode nnrpd[2431200]: 50.146.94.167.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 30 11:37:36 twilightnode nnrpd[2431200]: 50.146.94.167.censys-scanner.com match_user <anonymous> <anonymous>
Aug 30 11:37:36 twilightnode nnrpd[2431200]: 50.146.94.167.censys-scanner.com no_post anonymous-read
Aug 30 11:37:40 twilightnode nnrpd[2431201]: Reading access from /usr/local/news/etc/readers.conf
Aug 30 11:37:40 twilightnode nnrpd[2431201]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 6406 52.1%1.1 MB 57.5%
innd 4472 36.4%635.6 KB 32.0%
innfeed 1293 10.5%193.8 KB 9.8%
nnrpd 126 1.0%14.0 KB 0.7%
TOTAL: 4 12297 100.0%1.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 17746 53.3%
Negative hits 9178 27.6%
Do not exist 6363 19.1%
Cache misses 17 0.1%
TOTAL: 4 33304 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.080 0.0%30 0.000 2.667 29.000
article cleanup00:00:00.040 0.0%6377 0.000 0.006 0.107
article logging00:00:00.209 0.0%6402 0.000 0.033 0.231
article parse00:00:00.088 0.0%8187 0.000 0.011 0.222
article write00:00:05.512 0.0%5283 0.536 1.043 3.059
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.166 0.0%33936 0.000 0.005 0.043
hisgrep/artcncl00:00:00.013 0.0%30 0.000 0.433 5.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.607 0.0%33396 0.047 0.108 0.304
history sync00:00:00.050 0.0%405 0.000 0.123 1.000
history write00:00:02.905 0.0%6378 0.111 0.455 1.020
idle24:00:26.983100.0%35208 1055.915 2454.754 18777.719
nntp read00:00:00.651 0.0%34161 0.000 0.019 0.056
overview write00:00:03.591 0.0%5283 0.269 0.680 4.714
perl filter00:00:10.690 0.0%6377 0.667 1.676 9.385
python filter00:00:00.695 0.0%6377 0.000 0.109 1.200
site send00:00:00.198 0.0%10539 0.000 0.019 0.083
TOTAL: 1824:00:55.478100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.027 0.0%5452 0.000 0.005 0.111
article prepare00:00:00.010 0.0%23892 0.000 0.000 0.011
article read00:00:00.893 0.0%3505 0.000 0.255 1.500
backlog stats00:00:00.037 0.0%70759 0.000 0.001 0.014
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.539 0.0%38959 0.000 0.014 0.065
data write00:00:00.779 0.0%34173 0.000 0.023 0.106
idle23:49:54.540100.0%70759 432.635 1212.489 6901.444
status file00:00:00.116 0.0%180 0.000 0.644 5.000
TOTAL: 923:49:56.941100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:20.638100.0%15 109.000 1375.867 5246.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%123 0.000 0.000 0.000
TOTAL: 300:00:20.638100.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 8444 4133 4219 92 48%39:55:28
2usenet.blueworldhosting.com 710 6317 748 4690 879 11%23:47:04
3newsfeed.endofthelinebbs.com 3 8219 174 7830 215 2%40:41:08
4news.tebibyte.org 2 3023 51 2972 0 1%23:49:45
5news.sklaffkom.se 31 41 31 10 0 75%05:57:19
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 776 26044 5137 19721 1186 19%134:10:44
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net13.0 MB0.0 KB271.1 KB13.2 MB 98%3.2 KB
2newsfeed.endofthelinebbs.com2.6 MB0.0 KB380.7 KB3.0 MB 87%7.9 KB
3usenet.blueworldhosting.com2.5 MB0.0 KB1.0 MB3.6 MB 70%2.3 KB
4news.tebibyte.org157.1 KB0.0 KB0.0 KB157.1 KB100%3.1 KB
5news.sklaffkom.se74.5 KB0.0 KB0.0 KB74.5 KB100%2.4 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 618.4 MB0.0 KB1.7 MB20.1 MB 91%3.2 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 30 03:00:04 - 03:59:59 90 1.7% 0.03323.2 KB 1.7% 0.09
Aug 30 04:00:00 - 04:59:59 91 1.7% 0.03269.4 KB 1.5% 0.07
Aug 30 05:00:00 - 05:59:59 61 1.2% 0.02162.2 KB 0.9% 0.05
Aug 30 06:00:00 - 06:59:59 73 1.4% 0.02242.9 KB 1.3% 0.07
Aug 30 07:00:00 - 07:59:59 98 1.9% 0.03687.1 KB 3.7% 0.19
Aug 30 08:00:00 - 08:59:59 134 2.5% 0.04455.4 KB 2.5% 0.13
Aug 30 09:00:00 - 09:59:59 273 5.2% 0.08831.5 KB 4.5% 0.23
Aug 30 10:00:00 - 10:59:59 318 6.0% 0.09967.4 KB 5.2% 0.27
Aug 30 11:00:00 - 11:59:59 361 6.8% 0.101.3 MB 7.2% 0.37
Aug 30 12:00:00 - 12:59:59 302 5.7% 0.08896.8 KB 4.8% 0.25
Aug 30 13:00:00 - 13:59:59 304 5.8% 0.08841.7 KB 4.5% 0.23
Aug 30 14:00:00 - 14:59:59 246 4.7% 0.07751.2 KB 4.1% 0.21
Aug 30 15:00:00 - 15:59:59 292 5.5% 0.08904.8 KB 4.9% 0.25
Aug 30 16:00:00 - 16:59:59 211 4.0% 0.06675.3 KB 3.6% 0.19
Aug 30 17:00:00 - 17:59:59 293 5.5% 0.081.2 MB 6.7% 0.34
Aug 30 18:00:00 - 18:59:59 321 6.1% 0.091.1 MB 6.0% 0.31
Aug 30 19:00:00 - 19:59:59 267 5.1% 0.07893.6 KB 4.8% 0.25
Aug 30 20:00:00 - 20:59:59 262 5.0% 0.07918.3 KB 5.0% 0.26
Aug 30 21:00:00 - 21:59:59 262 5.0% 0.07955.1 KB 5.2% 0.27
Aug 30 22:00:00 - 22:59:59 247 4.7% 0.07986.6 KB 5.3% 0.27
Aug 30 23:00:00 - 23:59:59 250 4.7% 0.07819.1 KB 4.4% 0.23
Aug 31 00:00:00 - 00:59:59 196 3.7% 0.05805.0 KB 4.3% 0.22
Aug 31 01:00:00 - 01:59:59 165 3.1% 0.05768.9 KB 4.1% 0.21
Aug 31 02:00:00 - 02:59:59 157 3.0% 0.04679.7 KB 3.7% 0.19
Aug 31 03:00:00 - 03:00:03 12 0.2% 4.0022.2 KB 0.1% 7.40
TOTAL: 23:59:59 5286 100.0% 0.0618.1 MB 100.0% 0.21
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 879 346 0 0 0 0 0 0 533
2newsfeed.endofthelinebbs.com 121 2 0 0 0 0 0 0 119
3twilightnode-out.news.weretis.net 118 12 0 0 0 0 0 0 106
4news.tebibyte.org 2 1 0 0 0 0 0 0 1
TOTAL: 4 1120 361 0 0 0 0 0 0 759

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 42
de.comm.software.mailserver 6
fido.nodelist-police 6
hispagatos.mastodon.tag.hacking 3
alt.fan.dragons 2
fido.esp.softbbs 2
fido.ru.fidonet.today 2
alt.bbs.files-announce 1
alt.sex.pedophilia 1
alt.sympatico.general 1
chmurka.statystyki 1
de.alt.technik.misc 1
de.comm.technik.mobil 1
fido.ru.golded 1
free.it.barzellette 1
muc.lists.freebsd.hubs 1
pl.rec.kajaki 1
TOTAL: 18 361

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 652
Too many newsgroups 53
EMP (phn path) 15
User-issued cancel 9
HTML Multipart 3
Too many newsgroups (meow) 1
TOTAL: 6 733

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 6673 2536 2637 50 36 33 38%23:59:21
2sklaffkom.se 5413 946 1835 2436 42 0 17%23:59:55
3weretis.net 947 5 922 0 0 1 0%23:35:44
4newsfeed.endofthelinebbs.com 9489 3 5139 4 0 182 0%23:59:49
5usenet.blueworldhosting.com 7077 0 4146 0 0 14 0%23:59:55
TOTAL: 5 29599 3490 14679 2490 78 230 11%119:34:44
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org6.8 MB277.4 KB7.1 MB0.1 KB/s2.8 KB23:59:21
2sklaffkom.se1.5 MB9.1 MB10.6 MB0.1 KB/s3.2 KB23:59:55
3weretis.net9.1 KB0.0 KB9.1 KB0.0 KB/s1.8 KB23:35:44
4newsfeed.endofthelinebbs.com4.7 KB10.7 KB15.4 KB0.0 KB/s2.2 KB23:59:49
5usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 58.3 MB9.4 MB17.7 MB0.0 KB/s3.0 KB119:34:44
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1130.172.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:03
250.146.94.167.censys-scanner.com 3 00.0 KB 0 0 000:00:02
3193.32.162.211 1 00.0 KB 0 0 000:00:10
4o038.scanner.modat.io 1 00.0 KB 0 0 000:00:00
5r4-224-e0.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
6r5-142-8e.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 6 10 00.0 KB 0 0 000:00:20

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.167.censys-scanner.com 3 00.0 KB 0 0 000:00:02
2*.66.censys-scanner.com 3 00.0 KB 0 0 000:00:03
3*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
4*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
5unresolved 1 00.0 KB 0 0 000:00:10
TOTAL: 5 10 00.0 KB 0 0 000:00:20

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
193.32.162.211 0.002 0.009 0.00000:00:10
130.172.132.66.censys-scanner.com 0.039 0.028 0.00000:00:03
50.146.94.167.censys-scanner.com 0.033 0.024 0.00000:00:02
r4-224-e0.monitoring.internet-measurement.com 0.003 0.013 0.00000:00:01
r5-142-8e.monitoring.internet-measurement.com 0.005 0.012 0.00000:00:01
o038.scanner.modat.io 0.005 0.009 0.00000:00:00
TOTAL: 6 0.087 0.095 0.00000:00:20

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

SystemConn
193.32.162.211 2
130.172.132.66.censys-scanner.com 1
50.146.94.167.censys-scanner.com 1
TOTAL: 3 4

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

CommandCount
EHLO www.censys.io 2
#001 1
#026#003#001 1
TOTAL: 3 4

NNRP client timeouts [Top 20]:

SystemConnPeer
130.172.132.66.censys-scanner.com 1 2
193.32.162.211 1 1
50.146.94.167.censys-scanner.com 1 2
TOTAL: 3 3 5