Daily Usenet report

Aug 28 03:00:04 -- Aug 29 03:00:03

Unknown entries from news log file:

First 50 / 83 lines (60.2%)

Aug 28 03:00:59 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Aug 28 13:22:53 twilightnode nnrpd[2306906]: Reading access from /usr/local/news/etc/readers.conf
Aug 28 13:22:53 twilightnode nnrpd[2306906]: Auth strategy 'localhost' does not match client. Removing.
Aug 28 13:22:53 twilightnode nnrpd[2306906]: 151.243.11.16 res <anonymous>
Aug 28 13:22:53 twilightnode nnrpd[2306906]: 151.243.11.16 no_match_user <anonymous> <localhost>
Aug 28 13:22:53 twilightnode nnrpd[2306906]: 151.243.11.16 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 28 13:22:53 twilightnode nnrpd[2306906]: 151.243.11.16 match_user <anonymous> <anonymous>
Aug 28 13:22:53 twilightnode nnrpd[2306906]: 151.243.11.16 no_post anonymous-read
Aug 28 14:02:07 twilightnode nnrpd[2308545]: Reading access from /usr/local/news/etc/readers.conf
Aug 28 14:02:07 twilightnode nnrpd[2308545]: Auth strategy 'localhost' does not match client. Removing.
Aug 28 14:02:07 twilightnode nnrpd[2308545]: 151.243.11.8 res <anonymous>
Aug 28 14:02:07 twilightnode nnrpd[2308545]: 151.243.11.8 no_match_user <anonymous> <localhost>
Aug 28 14:02:07 twilightnode nnrpd[2308545]: 151.243.11.8 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 28 14:02:07 twilightnode nnrpd[2308545]: 151.243.11.8 match_user <anonymous> <anonymous>
Aug 28 14:02:07 twilightnode nnrpd[2308545]: 151.243.11.8 no_post anonymous-read
Aug 28 14:33:05 twilightnode nnrpd[2309869]: Reading access from /usr/local/news/etc/readers.conf
Aug 28 14:33:05 twilightnode nnrpd[2309869]: Auth strategy 'localhost' does not match client. Removing.
Aug 28 14:33:05 twilightnode nnrpd[2309869]: 131.172.132.66.censys-scanner.com res <anonymous>
Aug 28 14:33:05 twilightnode nnrpd[2309869]: 131.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 28 14:33:05 twilightnode nnrpd[2309869]: 131.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 28 14:33:05 twilightnode nnrpd[2309869]: 131.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 28 14:33:05 twilightnode nnrpd[2309869]: 131.172.132.66.censys-scanner.com no_post anonymous-read
Aug 28 14:33:06 twilightnode nnrpd[2309869]: 131.172.132.66.censys-scanner.com res <anonymous>
Aug 28 14:33:06 twilightnode nnrpd[2309869]: 131.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 28 14:33:06 twilightnode nnrpd[2309869]: 131.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 28 14:33:06 twilightnode nnrpd[2309869]: 131.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 28 14:33:06 twilightnode nnrpd[2309869]: 131.172.132.66.censys-scanner.com no_post anonymous-read
Aug 28 16:23:57 twilightnode nnrpd[2314678]: Reading access from /usr/local/news/etc/readers.conf
Aug 28 16:23:57 twilightnode nnrpd[2314678]: Auth strategy 'localhost' does not match client. Removing.
Aug 28 16:23:57 twilightnode nnrpd[2314678]: 45.205.1.243 res <anonymous>
Aug 28 16:23:57 twilightnode nnrpd[2314678]: 45.205.1.243 no_match_user <anonymous> <localhost>
Aug 28 16:23:57 twilightnode nnrpd[2314678]: 45.205.1.243 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 28 16:23:57 twilightnode nnrpd[2314678]: 45.205.1.243 match_user <anonymous> <anonymous>
Aug 28 16:23:57 twilightnode nnrpd[2314678]: 45.205.1.243 no_post anonymous-read
Aug 28 16:31:33 twilightnode nnrpd[2315068]: Reading access from /usr/local/news/etc/readers.conf
Aug 28 16:31:33 twilightnode nnrpd[2315068]: Auth strategy 'localhost' does not match client. Removing.
Aug 28 16:31:33 twilightnode nnrpd[2315068]: maxim.probe.onyphe.net res <anonymous>
Aug 28 16:31:33 twilightnode nnrpd[2315068]: maxim.probe.onyphe.net no_match_user <anonymous> <localhost>
Aug 28 16:31:33 twilightnode nnrpd[2315068]: maxim.probe.onyphe.net no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 28 16:31:33 twilightnode nnrpd[2315068]: maxim.probe.onyphe.net match_user <anonymous> <anonymous>
Aug 28 16:31:33 twilightnode nnrpd[2315068]: maxim.probe.onyphe.net no_post anonymous-read
Aug 28 16:31:34 twilightnode nnrpd[2315069]: Reading access from /usr/local/news/etc/readers.conf
Aug 28 16:31:34 twilightnode nnrpd[2315069]: Auth strategy 'localhost' does not match client. Removing.
Aug 28 16:31:34 twilightnode nnrpd[2315069]: ellen.probe.onyphe.net res <anonymous>
Aug 28 16:31:34 twilightnode nnrpd[2315069]: ellen.probe.onyphe.net no_match_user <anonymous> <localhost>
Aug 28 16:31:34 twilightnode nnrpd[2315069]: ellen.probe.onyphe.net no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 28 16:31:34 twilightnode nnrpd[2315069]: ellen.probe.onyphe.net match_user <anonymous> <anonymous>
Aug 28 16:31:34 twilightnode nnrpd[2315069]: ellen.probe.onyphe.net no_post anonymous-read
Aug 28 19:32:22 twilightnode nnrpd[2322900]: Reading access from /usr/local/news/etc/readers.conf
Aug 28 19:32:22 twilightnode nnrpd[2322900]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 7059 52.8%1.2 MB 57.9%
innd 4925 36.8%685.6 KB 32.4%
innfeed 1255 9.4%193.7 KB 9.1%
nnrpd 128 1.0%13.1 KB 0.6%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 13368 100.0%2.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 18697 51.4%
Negative hits 10652 29.3%
Do not exist 7012 19.3%
Cache misses 1 0.0%
TOTAL: 4 36362 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.062 0.0%23 0.000 2.696 27.000
article cleanup00:00:00.049 0.0%7039 0.000 0.007 0.080
article logging00:00:00.179 0.0%7068 0.000 0.025 0.105
article parse00:00:00.103 0.0%8823 0.000 0.012 0.200
article write00:00:05.847 0.0%5520 0.556 1.059 2.600
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.130 0.0%37832 0.000 0.003 0.077
hisgrep/artcncl00:00:00.008 0.0%23 0.000 0.348 3.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.850 0.0%36523 0.057 0.105 0.302
history sync00:00:00.053 0.0%415 0.000 0.128 1.000
history write00:00:02.918 0.0%7039 0.000 0.415 0.824
idle24:00:36.514100.0%39209 1028.098 2204.507 8120.486
nntp read00:00:00.694 0.0%38131 0.000 0.018 0.237
overview write00:00:03.727 0.0%5520 0.314 0.675 2.421
perl filter00:00:10.198 0.0%7039 0.727 1.449 5.633
python filter00:00:00.574 0.0%7039 0.000 0.082 0.649
site send00:00:00.236 0.0%10962 0.000 0.022 0.083
TOTAL: 1824:01:05.142100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%5635 0.000 0.005 0.091
article prepare00:00:00.012 0.0%24254 0.000 0.000 0.021
article read00:00:00.850 0.0%3621 0.000 0.235 1.286
backlog stats00:00:00.053 0.0%73418 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.496 0.0%40811 0.000 0.012 0.056
data write00:00:00.925 0.0%35317 0.000 0.026 0.095
idle23:57:38.420100.0%73418 415.855 1174.895 5377.634
status file00:00:00.112 0.0%162 0.000 0.691 3.000
TOTAL: 923:57:40.896100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:23.801100.0%15 2.000 1586.733 4095.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%38 0.000 0.026 0.077
TOTAL: 300:00:23.802100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 3 10004 4236 5579 189 42%43:51:36
2usenet.blueworldhosting.com 717 6972 1009 4819 1144 14%23:48:15
3newsfeed.endofthelinebbs.com 1 5485 201 5152 132 3%25:35:27
4news.tebibyte.org 2 3118 118 2998 2 3%23:57:09
5news.sklaffkom.se 43 75 58 17 0 77%09:37:20
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 791 25654 5622 18565 1467 21%126:49:47
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net12.2 MB0.0 KB513.8 KB12.7 MB 96%2.9 KB
2usenet.blueworldhosting.com3.8 MB0.0 KB1.8 MB5.6 MB 68%2.7 KB
3newsfeed.endofthelinebbs.com2.4 MB0.0 KB268.2 KB2.6 MB 90%8.1 KB
4news.tebibyte.org340.7 KB0.0 KB48.6 KB389.3 KB 87%3.2 KB
5news.sklaffkom.se149.7 KB0.0 KB0.0 KB149.7 KB100%2.6 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 618.8 MB0.0 KB2.6 MB21.4 MB 87%3.1 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 28 03:00:04 - 03:59:59 99 1.8% 0.03399.9 KB 2.1% 0.11
Aug 28 04:00:00 - 04:59:59 135 2.4% 0.04444.2 KB 2.4% 0.12
Aug 28 05:00:00 - 05:59:59 97 1.8% 0.03417.0 KB 2.2% 0.12
Aug 28 06:00:00 - 06:59:59 116 2.1% 0.03353.3 KB 1.9% 0.10
Aug 28 07:00:00 - 07:59:59 152 2.8% 0.04450.8 KB 2.4% 0.13
Aug 28 08:00:00 - 08:59:59 201 3.6% 0.06535.1 KB 2.9% 0.15
Aug 28 09:00:00 - 09:59:59 239 4.3% 0.07805.8 KB 4.3% 0.22
Aug 28 10:00:00 - 10:59:59 287 5.2% 0.081.5 MB 8.1% 0.42
Aug 28 11:00:00 - 11:59:59 329 6.0% 0.091.4 MB 7.5% 0.39
Aug 28 12:00:00 - 12:59:59 299 5.4% 0.08926.1 KB 5.0% 0.26
Aug 28 13:00:00 - 13:59:59 347 6.3% 0.101.0 MB 5.6% 0.29
Aug 28 14:00:00 - 14:59:59 322 5.8% 0.09914.4 KB 4.9% 0.25
Aug 28 15:00:00 - 15:59:59 298 5.4% 0.08876.5 KB 4.7% 0.24
Aug 28 16:00:00 - 16:59:59 290 5.3% 0.08803.6 KB 4.3% 0.22
Aug 28 17:00:00 - 17:59:59 314 5.7% 0.09905.4 KB 4.9% 0.25
Aug 28 18:00:00 - 18:59:59 338 6.1% 0.091.2 MB 6.5% 0.34
Aug 28 19:00:00 - 19:59:59 311 5.6% 0.09881.2 KB 4.7% 0.24
Aug 28 20:00:00 - 20:59:59 223 4.0% 0.06631.4 KB 3.4% 0.18
Aug 28 21:00:00 - 21:59:59 269 4.9% 0.07918.1 KB 4.9% 0.26
Aug 28 22:00:00 - 22:59:59 186 3.4% 0.05634.4 KB 3.4% 0.18
Aug 28 23:00:00 - 23:59:59 212 3.8% 0.06805.6 KB 4.3% 0.22
Aug 29 00:00:00 - 00:59:59 209 3.8% 0.061002.9 KB 5.4% 0.28
Aug 29 01:00:00 - 01:59:59 130 2.4% 0.04496.6 KB 2.7% 0.14
Aug 29 02:00:00 - 02:59:59 101 1.8% 0.03273.4 KB 1.5% 0.08
Aug 29 03:00:00 - 03:00:03 9 0.2% 3.009.0 KB 0.0% 3.00
TOTAL: 23:59:59 5513 100.0% 0.0618.2 MB 100.0% 0.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1144 373 0 0 0 0 0 0 771
2twilightnode-out.news.weretis.net 266 2 0 0 0 0 0 0 264
3newsfeed.endofthelinebbs.com 132 28 0 0 0 0 0 0 104
4news.tebibyte.org 4 0 0 0 0 0 0 0 4
TOTAL: 4 1546 403 0 0 0 0 0 0 1143

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
fido.ru.fidonet.today 39
hispagatos.hacking.ransomware 28
fido.ru.ftn.develop 21
hispagatos.mastodon.tag.hacking 8
alt.sex.pedophilia 2
fido.golded 2
fido.utf8.ftn.messaging 2
alt.bbs.files-announce 1
alt.drwho 1
alt.fr.jeux.cryptarithmes 1
alt.honda 1
alt.test.9 1
chmurka.statystyki 1
fido.android.unlimited 1
fido.fido_util 1
fido.fidosoft.ger 1
fido.ru.golded 1
fido.su.pol 1
nz.tech 1
TOTAL: 21 403

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 781
EMP (phn path) 197
Too many newsgroups 87
User-issued cancel 43
Binary: misplaced binary 2
Too many newsgroups (meow) 2
HTML Multipart 1
Too many newsgroups (low_xpost) 1
TOTAL: 8 1114

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 6807 2455 2875 78 29 4 36%23:59:49
2sklaffkom.se 5544 976 1892 2513 51 4 17%23:57:06
3weretis.net 1320 6 1279 0 0 0 0%23:50:40
4newsfeed.endofthelinebbs.com 9576 0 5251 0 0 210 0%23:59:55
5usenet.blueworldhosting.com 7024 0 3998 0 0 0 0%23:59:55
TOTAL: 5 30271 3437 15295 2591 80 218 11%119:47:25
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org6.2 MB642.0 KB6.9 MB0.1 KB/s2.8 KB23:59:49
2sklaffkom.se1.6 MB9.7 MB11.3 MB0.1 KB/s3.3 KB23:57:06
3weretis.net11.2 KB0.0 KB11.2 KB0.0 KB/s1.9 KB23:50:40
4newsfeed.endofthelinebbs.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
5usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 57.8 MB10.3 MB18.1 MB0.0 KB/s3.1 KB119:47:25
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1azpdsgmv8a97.stretchoid.com 2 00.0 KB 0 0 000:00:01
2131.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:01
3151.243.11.16 1 00.0 KB 0 0 000:00:04
4151.243.11.8 1 00.0 KB 0 0 000:00:04
5198.235.24.66 1 00.0 KB 0 0 000:00:00
645.205.1.241 1 00.0 KB 0 0 000:00:03
745.205.1.243 1 00.0 KB 0 0 000:00:03
8ellen.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
9maxim.probe.onyphe.net 1 00.0 KB 0 0 000:00:00
10o017.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 10 11 00.0 KB 0 0 000:00:23

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 5 00.0 KB 0 0 000:00:16
2*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
3*.stretchoid.com 2 00.0 KB 0 0 000:00:01
4*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:01
5*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 5 11 00.0 KB 0 0 000:00:23

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
151.243.11.8 0.003 0.008 0.00000:00:04
151.243.11.16 0.005 0.013 0.00000:00:04
45.205.1.243 0.001 0.013 0.00000:00:03
45.205.1.241 0.001 0.017 0.00000:00:03
ellen.probe.onyphe.net 0.004 0.004 0.00000:00:03
131.172.132.66.censys-scanner.com 0.028 0.014 0.00000:00:01
azpdsgmv8a97.stretchoid.com 0.009 0.012 0.00000:00:01
maxim.probe.onyphe.net 0.006 0.011 0.00000:00:00
198.235.24.66 0.006 0.012 0.00000:00:00
o017.scanner.modat.io 0.004 0.012 0.00000:00:00
TOTAL: 10 0.067 0.116 0.00000:00:23

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

SystemConn
maxim.probe.onyphe.net 4
131.172.132.66.censys-scanner.com 1
azpdsgmv8a97.stretchoid.com 1
TOTAL: 3 6

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

CommandCount
#026#003#003#002c#001 1
? ,?#001?)fr#?#001>?a#026 1
?$?,?r?s?#023#002#023#001?#024?#007?#022?#023?'?/?#024?(?0?`?a... 1
?1?J?y3?*?L#023 1
EHLO www.censys.io 1
MGLNDD_172.234.115.63_119 1
TOTAL: 6 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