Daily Usenet report

Sep 20 03:00:03 -- Sep 21 03:00:04

Unknown entries from news log file:

First 50 / 132 lines (37.9%)

Sep 20 03:01:14 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Sep 20 03:37:28 twilightnode nnrpd[3839610]: Reading access from /usr/local/news/etc/readers.conf
Sep 20 03:37:28 twilightnode nnrpd[3839610]: Auth strategy 'localhost' does not match client. Removing.
Sep 20 03:37:28 twilightnode nnrpd[3839610]: r4-187-bb.monitoring.internet-measurement.com res <anonymous>
Sep 20 03:37:28 twilightnode nnrpd[3839610]: r4-187-bb.monitoring.internet-measurement.com no_match_user <anonymous> <localhost>
Sep 20 03:37:28 twilightnode nnrpd[3839610]: r4-187-bb.monitoring.internet-measurement.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 20 03:37:28 twilightnode nnrpd[3839610]: r4-187-bb.monitoring.internet-measurement.com match_user <anonymous> <anonymous>
Sep 20 03:37:28 twilightnode nnrpd[3839610]: r4-187-bb.monitoring.internet-measurement.com no_post anonymous-read
Sep 20 06:43:12 twilightnode nnrpd[3848148]: Reading access from /usr/local/news/etc/readers.conf
Sep 20 06:43:12 twilightnode nnrpd[3848148]: Auth strategy 'localhost' does not match client. Removing.
Sep 20 06:43:12 twilightnode nnrpd[3848148]: 193.46.255.155 res <anonymous>
Sep 20 06:43:12 twilightnode nnrpd[3848148]: 193.46.255.155 no_match_user <anonymous> <localhost>
Sep 20 06:43:12 twilightnode nnrpd[3848148]: 193.46.255.155 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 20 06:43:12 twilightnode nnrpd[3848148]: 193.46.255.155 match_user <anonymous> <anonymous>
Sep 20 06:43:12 twilightnode nnrpd[3848148]: 193.46.255.155 no_post anonymous-read
Sep 20 12:52:59 twilightnode nnrpd[3864983]: Reading access from /usr/local/news/etc/readers.conf
Sep 20 12:52:59 twilightnode nnrpd[3864983]: Auth strategy 'localhost' does not match client. Removing.
Sep 20 12:52:59 twilightnode nnrpd[3864983]: zl-dfwc-us-gp1-wk109b.internet-census.org res <anonymous>
Sep 20 12:52:59 twilightnode nnrpd[3864983]: zl-dfwc-us-gp1-wk109b.internet-census.org no_match_user <anonymous> <localhost>
Sep 20 12:52:59 twilightnode nnrpd[3864983]: zl-dfwc-us-gp1-wk109b.internet-census.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 20 12:52:59 twilightnode nnrpd[3864983]: zl-dfwc-us-gp1-wk109b.internet-census.org match_user <anonymous> <anonymous>
Sep 20 12:52:59 twilightnode nnrpd[3864983]: zl-dfwc-us-gp1-wk109b.internet-census.org no_post anonymous-read
Sep 20 12:54:22 twilightnode nnrpd[3865006]: Reading access from /usr/local/news/etc/readers.conf
Sep 20 12:54:22 twilightnode nnrpd[3865006]: Auth strategy 'localhost' does not match client. Removing.
Sep 20 12:54:22 twilightnode nnrpd[3865006]: azpdsgpmx5eg.stretchoid.com res <anonymous>
Sep 20 12:54:22 twilightnode nnrpd[3865006]: azpdsgpmx5eg.stretchoid.com no_match_user <anonymous> <localhost>
Sep 20 12:54:22 twilightnode nnrpd[3865006]: azpdsgpmx5eg.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 20 12:54:22 twilightnode nnrpd[3865006]: azpdsgpmx5eg.stretchoid.com match_user <anonymous> <anonymous>
Sep 20 12:54:22 twilightnode nnrpd[3865006]: azpdsgpmx5eg.stretchoid.com no_post anonymous-read
Sep 20 12:54:32 twilightnode nnrpd[3865007]: Reading access from /usr/local/news/etc/readers.conf
Sep 20 12:54:32 twilightnode nnrpd[3865007]: Auth strategy 'localhost' does not match client. Removing.
Sep 20 12:54:32 twilightnode nnrpd[3865007]: azpdsgpmx5eg.stretchoid.com res <anonymous>
Sep 20 12:54:32 twilightnode nnrpd[3865007]: azpdsgpmx5eg.stretchoid.com no_match_user <anonymous> <localhost>
Sep 20 12:54:32 twilightnode nnrpd[3865007]: azpdsgpmx5eg.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 20 12:54:32 twilightnode nnrpd[3865007]: azpdsgpmx5eg.stretchoid.com match_user <anonymous> <anonymous>
Sep 20 12:54:32 twilightnode nnrpd[3865007]: azpdsgpmx5eg.stretchoid.com no_post anonymous-read
Sep 20 12:58:26 twilightnode nnrpd[3865257]: Reading access from /usr/local/news/etc/readers.conf
Sep 20 12:58:26 twilightnode nnrpd[3865257]: Auth strategy 'localhost' does not match client. Removing.
Sep 20 12:58:26 twilightnode nnrpd[3865257]: r4-224-e0.monitoring.internet-measurement.com res <anonymous>
Sep 20 12:58:26 twilightnode nnrpd[3865257]: r4-224-e0.monitoring.internet-measurement.com no_match_user <anonymous> <localhost>
Sep 20 12:58:26 twilightnode nnrpd[3865257]: r4-224-e0.monitoring.internet-measurement.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 20 12:58:26 twilightnode nnrpd[3865257]: r4-224-e0.monitoring.internet-measurement.com match_user <anonymous> <anonymous>
Sep 20 12:58:26 twilightnode nnrpd[3865257]: r4-224-e0.monitoring.internet-measurement.com no_post anonymous-read
Sep 20 13:57:19 twilightnode nnrpd[3867911]: Reading access from /usr/local/news/etc/readers.conf
Sep 20 13:57:19 twilightnode nnrpd[3867911]: Auth strategy 'localhost' does not match client. Removing.
Sep 20 13:57:19 twilightnode nnrpd[3867911]: 194.164.107.5 res <anonymous>
Sep 20 13:57:19 twilightnode nnrpd[3867911]: 194.164.107.5 no_match_user <anonymous> <localhost>
Sep 20 13:57:19 twilightnode nnrpd[3867911]: 194.164.107.5 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 20 13:57:19 twilightnode nnrpd[3867911]: 194.164.107.5 match_user <anonymous> <anonymous>
Sep 20 13:57:19 twilightnode nnrpd[3867911]: 194.164.107.5 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
inn 6744 53.4%1.2 MB 58.8%
innd 4396 34.8%619.2 KB 30.2%
innfeed 1263 10.0%201.0 KB 9.8%
nnrpd 213 1.7%22.5 KB 1.1%
controlchan 12 0.1%2.8 KB 0.1%
TOTAL: 5 12628 100.0%2.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 18708 52.6%
Negative hits 10167 28.6%
Do not exist 6691 18.8%
Cache misses 29 0.1%
TOTAL: 4 35595 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.018 0.0%14 0.100 1.286 8.000
article cleanup00:00:00.097 0.0%6710 0.000 0.014 0.143
article logging00:00:00.211 0.0%6744 0.000 0.031 0.169
article parse00:00:00.111 0.0%9359 0.000 0.012 0.093
article write00:00:05.762 0.0%5672 0.605 1.016 1.737
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.209 0.0%37348 0.000 0.006 0.047
hisgrep/artcncl00:00:00.004 0.0%14 0.000 0.286 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.851 0.0%35688 0.055 0.108 0.291
history sync00:00:00.063 0.0%331 0.000 0.190 1.000
history write00:00:03.141 0.0%6710 0.118 0.468 2.854
idle23:59:55.628 99.9%38641 1084.532 2235.854 8826.912
nntp read00:00:00.781 0.0%37666 0.000 0.021 0.060
overview write00:00:04.022 0.0%5672 0.308 0.709 2.292
perl filter00:00:13.047 0.0%6710 1.025 1.944 9.889
python filter00:00:00.993 0.0%6710 0.000 0.148 1.000
site send00:00:00.206 0.0%11241 0.000 0.018 0.109
TOTAL: 1824:00:28.144100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%5978 0.000 0.004 0.067
article prepare00:00:00.001 0.0%23748 0.000 0.000 0.005
article read00:00:00.964 0.0%3740 0.000 0.258 1.545
backlog stats00:00:00.035 0.0%74255 0.000 0.000 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.554 0.0%41465 0.000 0.013 0.069
data write00:00:00.859 0.0%36025 0.000 0.024 0.069
idle23:58:48.868100.0%74255 326.568 1162.600 5219.800
status file00:00:00.223 0.0%167 0.000 1.335 10.000
TOTAL: 923:58:51.526100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:46.758100.0%29 70.333 1612.345 10540.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.200
TOTAL: 300:00:46.759100.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

Control channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
admin@mail.su.gy001001
TOTAL001001

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 4 10913 4213 6602 98 38%48:44:43
2usenet.blueworldhosting.com 714 6562 990 4722 850 15%23:48:57
3newsfeed.endofthelinebbs.com 2 4878 175 4614 89 3%24:57:20
4news.tebibyte.org 2 3472 83 3386 3 2%23:59:17
5news.sklaffkom.se 37 81 69 12 0 85%09:28:23
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 784 25906 5530 19336 1040 21%130:58:40
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net13.6 MB0.0 KB316.7 KB13.9 MB 97%3.3 KB
2usenet.blueworldhosting.com4.4 MB0.0 KB1.1 MB5.5 MB 79%3.1 KB
3newsfeed.endofthelinebbs.com2.1 MB0.0 KB154.4 KB2.2 MB 93%8.5 KB
4news.tebibyte.org426.7 KB0.0 KB3.2 KB429.9 KB 99%5.0 KB
5news.sklaffkom.se210.1 KB0.0 KB0.0 KB210.1 KB100%3.0 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 620.7 MB0.0 KB1.6 MB22.2 MB 92%3.5 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 20 03:00:03 - 03:59:59 114 2.0% 0.03475.4 KB 2.1% 0.13
Sep 20 04:00:00 - 04:59:59 131 2.3% 0.04729.3 KB 3.2% 0.20
Sep 20 05:00:00 - 05:59:59 145 2.6% 0.041.2 MB 5.4% 0.34
Sep 20 06:00:00 - 06:59:59 94 1.7% 0.03332.2 KB 1.5% 0.09
Sep 20 07:00:00 - 07:59:59 93 1.6% 0.03482.3 KB 2.1% 0.13
Sep 20 08:00:00 - 08:59:59 166 2.9% 0.05495.4 KB 2.2% 0.14
Sep 20 09:00:00 - 09:59:59 229 4.0% 0.06701.7 KB 3.1% 0.19
Sep 20 10:00:00 - 10:59:59 248 4.4% 0.07666.5 KB 3.0% 0.19
Sep 20 11:00:00 - 11:59:59 325 5.7% 0.091.1 MB 4.8% 0.30
Sep 20 12:00:00 - 12:59:59 326 5.7% 0.091.1 MB 5.1% 0.32
Sep 20 13:00:00 - 13:59:59 319 5.6% 0.09977.7 KB 4.3% 0.27
Sep 20 14:00:00 - 14:59:59 257 4.5% 0.07697.3 KB 3.1% 0.19
Sep 20 15:00:00 - 15:59:59 246 4.3% 0.07801.4 KB 3.6% 0.22
Sep 20 16:00:00 - 16:59:59 322 5.7% 0.091.1 MB 4.9% 0.31
Sep 20 17:00:00 - 17:59:59 317 5.6% 0.091.3 MB 5.7% 0.36
Sep 20 18:00:00 - 18:59:59 297 5.2% 0.081012.4 KB 4.5% 0.28
Sep 20 19:00:00 - 19:59:59 300 5.3% 0.081.1 MB 4.8% 0.30
Sep 20 20:00:00 - 20:59:59 319 5.6% 0.091019.9 KB 4.5% 0.28
Sep 20 21:00:00 - 21:59:59 372 6.6% 0.101.3 MB 6.0% 0.37
Sep 20 22:00:00 - 22:59:59 278 4.9% 0.081017.8 KB 4.5% 0.28
Sep 20 23:00:00 - 23:59:59 239 4.2% 0.071.7 MB 7.7% 0.48
Sep 21 00:00:00 - 00:59:59 253 4.5% 0.072.0 MB 9.3% 0.58
Sep 21 01:00:00 - 01:59:59 139 2.5% 0.04474.5 KB 2.1% 0.13
Sep 21 02:00:00 - 02:59:59 130 2.3% 0.04499.2 KB 2.2% 0.14
Sep 21 03:00:00 - 03:00:04 12 0.2% 3.0016.1 KB 0.1% 4.01
TOTAL: 24:00:01 5671 100.0% 0.0722.0 MB 100.0% 0.26
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 850 341 0 0 0 0 0 0 509
2twilightnode-out.news.weretis.net 134 1 0 0 0 0 0 0 133
3newsfeed.endofthelinebbs.com 86 18 0 0 0 0 0 0 68
4news.tebibyte.org 3 2 0 0 0 0 0 0 1
TOTAL: 4 1073 362 0 0 0 0 0 0 711

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
fido.su.pol 10
hispagatos.hacking.ransomware 10
fido.ru.golded 9
fido.ru.modem 6
fido.ru.home 4
fido.ru.military 3
hispagatos.mastodon.tag.hacking 3
alt.gl.test 2
alt.test.9 2
fido.golded 2
fido.ru.fidonet.today 2
fido.su.tormoz 2
hispagatos.mastodon.tag.hackers 2
newsgrouper.support 2
realms.lgbt 2
alive.music.charts.nl 1
alt.asshole.binky 1
alt.bbs.files-announce 1
alt.sex.pedophilia 1
TOTAL: 29 362

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 460
Too many newsgroups 119
User-issued cancel 44
EMP (phn path) 43
HTML Multipart 10
MID-Bot 1
TOTAL: 6 677

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 7316 2184 3294 87 0 42 29%23:59:57
2sklaffkom.se 5706 851 1995 2722 0 2 14%23:59:49
3newsfeed.endofthelinebbs.com 9928 58 5331 24 0 351 0%23:59:42
4usenet.blueworldhosting.com 7000 15 4143 0 0 27 0%23:59:57
5weretis.net 1499 7 1400 0 0 0 0%23:57:32
TOTAL: 5 31449 3115 16163 2833 0 422 9%119:56:57
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org5.4 MB938.5 KB6.3 MB0.1 KB/s2.9 KB23:59:57
2sklaffkom.se1.4 MB12.6 MB14.1 MB0.2 KB/s4.0 KB23:59:49
3newsfeed.endofthelinebbs.com160.8 KB89.0 KB249.8 KB0.0 KB/s3.0 KB23:59:42
4usenet.blueworldhosting.com40.7 KB0.0 KB40.7 KB0.0 KB/s2.7 KB23:59:57
5weretis.net32.8 KB0.0 KB32.8 KB0.0 KB/s4.7 KB23:57:32
TOTAL: 57.1 MB13.6 MB20.7 MB0.0 KB/s3.6 KB119:56:57
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
132.172.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:02
247.84.103.165 3 00.0 KB 0 0 000:00:15
3azpdsgpmx5eg.stretchoid.com 2 00.0 KB 0 0 000:00:10
4147.185.132.46 1 00.0 KB 0 0 000:00:01
5193.46.255.155 1 00.0 KB 0 0 000:00:00
6194.164.107.5 1 00.0 KB 0 0 000:00:00
7213-166-84-54.infrawat.ch 1 00.0 KB 0 0 000:00:00
869-5-169-150.infrawat.ch 1 00.0 KB 0 0 000:00:00
994.154.43.21 1 00.0 KB 0 0 000:00:00
10n300.scanner.modat.io 1 00.0 KB 0 0 000:00:00
11r4-187-bb.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
12r4-224-e0.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
13zl-dfwc-us-gp1-wk109b.internet-census.org 1 00.0 KB 0 0 000:00:11
TOTAL: 13 18 00.0 KB 0 0 000:00:46

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 7 00.0 KB 0 0 000:00:17
2*.66.censys-scanner.com 3 00.0 KB 0 0 000:00:02
3*.infrawat.ch 2 00.0 KB 0 0 000:00:00
4*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
5*.stretchoid.com 2 00.0 KB 0 0 000:00:10
6*.internet-census.org 1 00.0 KB 0 0 000:00:11
7*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 7 18 00.0 KB 0 0 000:00:46

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.84.103.165 0.020 0.028 0.00000:00:15
zl-dfwc-us-gp1-wk109b.internet-census.org 0.004 0.023 0.00000:00:11
azpdsgpmx5eg.stretchoid.com 0.013 0.007 0.00000:00:10
32.172.132.66.censys-scanner.com 0.037 0.031 0.00000:00:02
r4-224-e0.monitoring.internet-measurement.com 0.005 0.007 0.00000:00:01
r4-187-bb.monitoring.internet-measurement.com 0.006 0.015 0.00000:00:01
147.185.132.46 0.006 0.013 0.00000:00:01
69-5-169-150.infrawat.ch 0.004 0.011 0.00000:00:00
194.164.107.5 0.005 0.007 0.00000:00:00
n300.scanner.modat.io 0.004 0.010 0.00000:00:00
213-166-84-54.infrawat.ch 0.004 0.014 0.00000:00:00
193.46.255.155 0.003 0.020 0.00000:00:00
94.154.43.21 0.005 0.010 0.00000:00:00
TOTAL: 13 0.116 0.196 0.00000:00:46

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

SystemConn
47.84.103.165 3
193.46.255.155 2
32.172.132.66.censys-scanner.com 1
azpdsgpmx5eg.stretchoid.com 1
TOTAL: 4 7

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

CommandCount
#026#003#001 2
#001 1
?#024 1
?#?' 1
EHLO www.censys.io 1
MGLNDD_172.234.115.63_119 1
TOTAL: 6 7

NNRP client timeouts [Top 20]:

SystemConnPeer
193.46.255.155 1 1
32.172.132.66.censys-scanner.com 1 2
69-5-169-150.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