Daily Usenet report

Aug 26 03:00:03 -- Aug 27 03:00:02

Unknown entries from news log file:

First 50 / 95 lines (52.6%)

Aug 26 03:00:57 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Aug 26 05:24:58 twilightnode nnrpd[2156256]: Reading access from /usr/local/news/etc/readers.conf
Aug 26 05:24:58 twilightnode nnrpd[2156256]: Auth strategy 'localhost' does not match client. Removing.
Aug 26 05:24:58 twilightnode nnrpd[2156256]: 81-19-216-83.infrawat.ch res <anonymous>
Aug 26 05:24:58 twilightnode nnrpd[2156256]: 81-19-216-83.infrawat.ch no_match_user <anonymous> <localhost>
Aug 26 05:24:58 twilightnode nnrpd[2156256]: 81-19-216-83.infrawat.ch no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 26 05:24:58 twilightnode nnrpd[2156256]: 81-19-216-83.infrawat.ch match_user <anonymous> <anonymous>
Aug 26 05:24:58 twilightnode nnrpd[2156256]: 81-19-216-83.infrawat.ch no_post anonymous-read
Aug 26 05:25:15 twilightnode nnrpd[2156347]: Reading access from /usr/local/news/etc/readers.conf
Aug 26 05:25:15 twilightnode nnrpd[2156347]: Auth strategy 'localhost' does not match client. Removing.
Aug 26 05:25:15 twilightnode nnrpd[2156347]: 193-32-209-254.infrawat.ch res <anonymous>
Aug 26 05:25:15 twilightnode nnrpd[2156347]: 193-32-209-254.infrawat.ch no_match_user <anonymous> <localhost>
Aug 26 05:25:15 twilightnode nnrpd[2156347]: 193-32-209-254.infrawat.ch no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 26 05:25:15 twilightnode nnrpd[2156347]: 193-32-209-254.infrawat.ch match_user <anonymous> <anonymous>
Aug 26 05:25:15 twilightnode nnrpd[2156347]: 193-32-209-254.infrawat.ch no_post anonymous-read
Aug 26 07:19:15 twilightnode nnrpd[2161576]: Reading access from /usr/local/news/etc/readers.conf
Aug 26 07:19:15 twilightnode nnrpd[2161576]: Auth strategy 'localhost' does not match client. Removing.
Aug 26 07:19:15 twilightnode nnrpd[2161576]: 216.226.76.10 res <anonymous>
Aug 26 07:19:15 twilightnode nnrpd[2161576]: 216.226.76.10 no_match_user <anonymous> <localhost>
Aug 26 07:19:15 twilightnode nnrpd[2161576]: 216.226.76.10 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 26 07:19:15 twilightnode nnrpd[2161576]: 216.226.76.10 match_user <anonymous> <anonymous>
Aug 26 07:19:15 twilightnode nnrpd[2161576]: 216.226.76.10 no_post anonymous-read
Aug 26 16:31:33 twilightnode nnrpd[2185870]: Reading access from /usr/local/news/etc/readers.conf
Aug 26 16:31:33 twilightnode nnrpd[2185870]: Auth strategy 'localhost' does not match client. Removing.
Aug 26 16:31:33 twilightnode nnrpd[2185870]: 108.195.132.66.censys-scanner.com res <anonymous>
Aug 26 16:31:33 twilightnode nnrpd[2185870]: 108.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 26 16:31:33 twilightnode nnrpd[2185870]: 108.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 26 16:31:33 twilightnode nnrpd[2185870]: 108.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 26 16:31:33 twilightnode nnrpd[2185870]: 108.195.132.66.censys-scanner.com no_post anonymous-read
Aug 26 16:31:34 twilightnode nnrpd[2185870]: 108.195.132.66.censys-scanner.com res <anonymous>
Aug 26 16:31:34 twilightnode nnrpd[2185870]: 108.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 26 16:31:34 twilightnode nnrpd[2185870]: 108.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 26 16:31:34 twilightnode nnrpd[2185870]: 108.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 26 16:31:34 twilightnode nnrpd[2185870]: 108.195.132.66.censys-scanner.com no_post anonymous-read
Aug 26 16:59:58 twilightnode nnrpd[2187020]: Reading access from /usr/local/news/etc/readers.conf
Aug 26 16:59:58 twilightnode nnrpd[2187020]: Auth strategy 'localhost' does not match client. Removing.
Aug 26 16:59:58 twilightnode nnrpd[2187020]: 205.210.31.70 res <anonymous>
Aug 26 16:59:58 twilightnode nnrpd[2187020]: 205.210.31.70 no_match_user <anonymous> <localhost>
Aug 26 16:59:58 twilightnode nnrpd[2187020]: 205.210.31.70 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 26 16:59:58 twilightnode nnrpd[2187020]: 205.210.31.70 match_user <anonymous> <anonymous>
Aug 26 16:59:58 twilightnode nnrpd[2187020]: 205.210.31.70 no_post anonymous-read
Aug 26 23:19:18 twilightnode nnrpd[2203029]: Reading access from /usr/local/news/etc/readers.conf
Aug 26 23:19:18 twilightnode nnrpd[2203029]: Auth strategy 'localhost' does not match client. Removing.
Aug 26 23:19:18 twilightnode nnrpd[2203029]: 60.195.132.66.censys-scanner.com res <anonymous>
Aug 26 23:19:18 twilightnode nnrpd[2203029]: 60.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 26 23:19:18 twilightnode nnrpd[2203029]: 60.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 26 23:19:18 twilightnode nnrpd[2203029]: 60.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 26 23:19:18 twilightnode nnrpd[2203029]: 60.195.132.66.censys-scanner.com no_post anonymous-read
Aug 26 23:19:21 twilightnode nnrpd[2203030]: Reading access from /usr/local/news/etc/readers.conf
Aug 26 23:19:21 twilightnode nnrpd[2203030]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 6485 51.8%1.1 MB 57.1%
innd 4580 36.6%641.5 KB 32.1%
innfeed 1296 10.4%200.1 KB 10.0%
nnrpd 149 1.2%15.9 KB 0.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 12511 100.0%2.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 17607 52.9%
Negative hits 9215 27.7%
Do not exist 6436 19.3%
Cache misses 7 0.0%
TOTAL: 4 33265 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.014 0.0%20 0.250 0.700 4.000
article cleanup00:00:00.067 0.0%6457 0.000 0.010 0.100
article logging00:00:00.171 0.0%6491 0.000 0.026 0.188
article parse00:00:00.116 0.0%8255 0.000 0.014 0.100
article write00:00:04.393 0.0%5269 0.400 0.834 1.686
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.058 0.0%34332 0.000 0.002 0.012
hisgrep/artcncl00:00:00.007 0.0%20 0.000 0.350 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.956 0.0%33375 0.033 0.089 0.258
history sync00:00:00.036 0.0%413 0.000 0.087 0.667
history write00:00:02.580 0.0%6457 0.100 0.400 1.188
idle24:00:37.570100.0%35761 1125.008 2417.090 10920.982
nntp read00:00:00.641 0.0%34693 0.000 0.018 0.053
overview write00:00:02.623 0.0%5269 0.125 0.498 1.769
perl filter00:00:09.816 0.0%6457 0.689 1.520 7.682
python filter00:00:00.639 0.0%6457 0.000 0.099 0.710
site send00:00:00.203 0.0%10467 0.000 0.019 0.097
TOTAL: 1824:01:01.890100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%5445 0.000 0.004 0.073
article prepare00:00:00.007 0.0%23814 0.000 0.000 0.011
article read00:00:00.723 0.0%3504 0.000 0.206 1.091
backlog stats00:00:00.036 0.0%71378 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.503 0.0%39406 0.000 0.013 0.063
data write00:00:00.883 0.0%34318 0.000 0.026 0.081
idle23:50:22.229100.0%71378 355.309 1202.362 5009.975
status file00:00:00.099 0.0%180 0.000 0.550 3.000
TOTAL: 923:50:24.503100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:08.137100.0%18 23.000 452.056 3838.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%107 0.000 0.009 0.059
TOTAL: 300:00:08.138100.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 11769 4140 7312 317 35%54:35:22
2usenet.blueworldhosting.com 712 6362 844 4696 822 13%23:48:50
3newsfeed.endofthelinebbs.com 1 4532 180 4234 118 3%23:18:36
4news.tebibyte.org 1 3008 84 2883 41 2%23:59:56
5news.sklaffkom.se 39 64 58 6 0 90%08:29:03
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 783 25735 5306 19131 1298 20%134:11:47
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net13.1 MB0.0 KB1.1 MB14.3 MB 92%3.3 KB
2usenet.blueworldhosting.com3.4 MB0.0 KB1.1 MB4.5 MB 75%2.8 KB
3newsfeed.endofthelinebbs.com1.5 MB0.0 KB209.2 KB1.7 MB 87%5.7 KB
4news.tebibyte.org315.4 KB0.0 KB437.4 KB752.9 KB 41%6.0 KB
5news.sklaffkom.se183.2 KB0.0 KB0.0 KB183.2 KB100%3.2 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 618.5 MB0.0 KB2.9 MB21.4 MB 86%3.3 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 26 03:00:03 - 03:59:59 114 2.2% 0.03463.7 KB 2.5% 0.13
Aug 26 04:00:00 - 04:59:59 101 1.9% 0.03499.6 KB 2.7% 0.14
Aug 26 05:00:00 - 05:59:59 106 2.0% 0.03343.4 KB 1.8% 0.10
Aug 26 06:00:00 - 06:59:59 109 2.1% 0.03305.8 KB 1.6% 0.08
Aug 26 07:00:00 - 07:59:59 154 2.9% 0.04432.7 KB 2.3% 0.12
Aug 26 08:00:00 - 08:59:59 198 3.8% 0.06541.0 KB 2.9% 0.15
Aug 26 09:00:00 - 09:59:59 240 4.6% 0.07997.0 KB 5.4% 0.28
Aug 26 10:00:00 - 10:59:59 272 5.2% 0.08795.9 KB 4.3% 0.22
Aug 26 11:00:00 - 11:59:59 254 4.8% 0.07875.3 KB 4.7% 0.24
Aug 26 12:00:00 - 12:59:59 261 5.0% 0.07971.0 KB 5.2% 0.27
Aug 26 13:00:00 - 13:59:59 260 4.9% 0.07751.2 KB 4.0% 0.21
Aug 26 14:00:00 - 14:59:59 278 5.3% 0.08950.4 KB 5.1% 0.26
Aug 26 15:00:00 - 15:59:59 292 5.5% 0.081006.4 KB 5.4% 0.28
Aug 26 16:00:00 - 16:59:59 266 5.1% 0.07980.9 KB 5.3% 0.27
Aug 26 17:00:00 - 17:59:59 235 4.5% 0.07684.4 KB 3.7% 0.19
Aug 26 18:00:00 - 18:59:59 317 6.0% 0.091007.9 KB 5.4% 0.28
Aug 26 19:00:00 - 19:59:59 360 6.8% 0.101.4 MB 7.7% 0.40
Aug 26 20:00:00 - 20:59:59 302 5.7% 0.081.2 MB 6.4% 0.33
Aug 26 21:00:00 - 21:59:59 257 4.9% 0.07725.5 KB 3.9% 0.20
Aug 26 22:00:00 - 22:59:59 264 5.0% 0.07993.0 KB 5.3% 0.28
Aug 26 23:00:00 - 23:59:59 220 4.2% 0.06849.6 KB 4.6% 0.24
Aug 27 00:00:00 - 00:59:59 165 3.1% 0.05947.7 KB 5.1% 0.26
Aug 27 01:00:00 - 01:59:59 135 2.6% 0.04536.3 KB 2.9% 0.15
Aug 27 02:00:00 - 02:59:59 102 1.9% 0.03310.1 KB 1.7% 0.09
Aug 27 03:00:00 - 03:00:02 2 0.0% 1.001.7 KB 0.0% 0.86
TOTAL: 23:59:59 5264 100.0% 0.0618.2 MB 100.0% 0.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 822 368 0 0 0 0 0 0 454
2twilightnode-out.news.weretis.net 267 2 0 0 0 0 0 0 265
3newsfeed.endofthelinebbs.com 130 25 0 0 0 0 0 0 105
4news.tebibyte.org 2 0 0 0 0 0 0 0 2
TOTAL: 4 1221 395 0 0 0 0 0 0 826

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
fido.ru.fidonet.today 42
hispagatos.hacking.ransomware 40
hispagatos.mastodon.tag.hacking 4
alt.asshole.binky 3
alt.sex.pedophilia 3
fido.downgrade.talks 3
pl.rec.kuchnia 2
undernet.retro 2
alt.bbs.files-announce 1
alt.managing.techsupport 1
chmurka.statystyki 1
fido.utf8.ftn.messaging 1
hispagatos.mastodon.tag.hackers 1
kraft.talks 1
local.general 1
newsgrouper.support 1
TOTAL: 17 395

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 511
EMP (phn path) 161
Too many newsgroups 54
User-issued cancel 45
Too many newsgroups (meow) 18
HTML Multipart 3
TOTAL: 6 792

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
twilightnode-out.news.weretis.net 33
newsfeed.endofthelinebbs.com 1
TOTAL: 2 34
TOTAL: 1 34

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 6571 2428 2635 99 35 23 36%23:59:56
2sklaffkom.se 5343 845 1767 2541 41 4 15%23:59:56
3newsfeed.endofthelinebbs.com 9581 12 5013 6 0 217 0%23:59:56
4weretis.net 1283 2 1229 0 0 1 0%23:38:16
5usenet.blueworldhosting.com 6892 1 4024 0 0 20 0%23:59:28
TOTAL: 5 29670 3288 14668 2646 76 265 11%119:37:32
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org6.8 MB611.9 KB7.4 MB0.1 KB/s3.0 KB23:59:56
2sklaffkom.se1.3 MB9.9 MB11.3 MB0.1 KB/s3.4 KB23:59:56
3newsfeed.endofthelinebbs.com74.2 KB14.8 KB89.0 KB0.0 KB/s4.9 KB23:59:56
4usenet.blueworldhosting.com3.2 KB0.0 KB3.2 KB0.0 KB/s3.2 KB23:59:28
5weretis.net2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:38:16
TOTAL: 58.2 MB10.5 MB18.7 MB0.0 KB/s3.2 KB119:37:32
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
160.195.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:01
2108.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:00
316.5.0.133 1 00.0 KB 0 0 000:00:03
4188-240-59-58.infrawat.ch 1 00.0 KB 0 0 000:00:00
5193-124-20-248.infrawat.ch 1 00.0 KB 0 0 000:00:00
6193-32-209-254.infrawat.ch 1 00.0 KB 0 0 000:00:00
7205.210.31.70 1 00.0 KB 0 0 000:00:00
8216.226.76.10 1 00.0 KB 0 0 000:00:00
981-19-216-83.infrawat.ch 1 00.0 KB 0 0 000:00:00
10o037.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 10 12 00.0 KB 0 0 000:00:08

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.66.censys-scanner.com 4 00.0 KB 0 0 000:00:01
2*.infrawat.ch 4 00.0 KB 0 0 000:00:01
3unresolved 3 00.0 KB 0 0 000:00:04
4*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 4 12 00.0 KB 0 0 000:00:08

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
16.5.0.133 0.007 0.008 0.00000:00:03
60.195.132.66.censys-scanner.com 0.038 0.021 0.00000:00:01
108.195.132.66.censys-scanner.com 0.026 0.024 0.00000:00:00
193-124-20-248.infrawat.ch 0.005 0.008 0.00000:00:00
o037.scanner.modat.io 0.005 0.006 0.00000:00:00
205.210.31.70 0.003 0.006 0.00000:00:00
193-32-209-254.infrawat.ch 0.003 0.008 0.00000:00:00
188-240-59-58.infrawat.ch 0.003 0.004 0.00000:00:00
81-19-216-83.infrawat.ch 0.003 0.012 0.00000:00:00
216.226.76.10 0.004 0.010 0.00000:00:00
TOTAL: 10 0.097 0.107 0.00000:00:08

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

SystemConn
108.195.132.66.censys-scanner.com 1
60.195.132.66.censys-scanner.com 1
TOTAL: 2 2

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
188-240-59-58.infrawat.ch 1 1
193-32-209-254.infrawat.ch 1 1
60.195.132.66.censys-scanner.com 1 2
TOTAL: 3 3 7