Daily Usenet report

Jul 24 03:00:05 -- Jul 25 03:00:06

Unknown entries from news log file:

First 50 / 116 lines (43.1%)

Jul 24 03:01:25 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Jul 24 03:51:03 twilightnode nnrpd[546244]: Reading access from /usr/local/news/etc/readers.conf
Jul 24 03:51:03 twilightnode nnrpd[546244]: Auth strategy 'localhost' does not match client. Removing.
Jul 24 03:51:03 twilightnode nnrpd[546244]: 57.146.94.167.censys-scanner.com res <anonymous>
Jul 24 03:51:03 twilightnode nnrpd[546244]: 57.146.94.167.censys-scanner.com no_match_user <anonymous> <localhost>
Jul 24 03:51:03 twilightnode nnrpd[546244]: 57.146.94.167.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 24 03:51:03 twilightnode nnrpd[546244]: 57.146.94.167.censys-scanner.com match_user <anonymous> <anonymous>
Jul 24 03:51:03 twilightnode nnrpd[546244]: 57.146.94.167.censys-scanner.com no_post anonymous-read
Jul 24 03:51:07 twilightnode nnrpd[546245]: Reading access from /usr/local/news/etc/readers.conf
Jul 24 03:51:07 twilightnode nnrpd[546245]: Auth strategy 'localhost' does not match client. Removing.
Jul 24 03:51:07 twilightnode nnrpd[546245]: 57.146.94.167.censys-scanner.com res <anonymous>
Jul 24 03:51:07 twilightnode nnrpd[546245]: 57.146.94.167.censys-scanner.com no_match_user <anonymous> <localhost>
Jul 24 03:51:07 twilightnode nnrpd[546245]: 57.146.94.167.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 24 03:51:07 twilightnode nnrpd[546245]: 57.146.94.167.censys-scanner.com match_user <anonymous> <anonymous>
Jul 24 03:51:07 twilightnode nnrpd[546245]: 57.146.94.167.censys-scanner.com no_post anonymous-read
Jul 24 03:51:11 twilightnode nnrpd[546246]: Reading access from /usr/local/news/etc/readers.conf
Jul 24 03:51:11 twilightnode nnrpd[546246]: Auth strategy 'localhost' does not match client. Removing.
Jul 24 03:51:11 twilightnode nnrpd[546246]: 57.146.94.167.censys-scanner.com res <anonymous>
Jul 24 03:51:11 twilightnode nnrpd[546246]: 57.146.94.167.censys-scanner.com no_match_user <anonymous> <localhost>
Jul 24 03:51:11 twilightnode nnrpd[546246]: 57.146.94.167.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 24 03:51:11 twilightnode nnrpd[546246]: 57.146.94.167.censys-scanner.com match_user <anonymous> <anonymous>
Jul 24 03:51:11 twilightnode nnrpd[546246]: 57.146.94.167.censys-scanner.com no_post anonymous-read
Jul 24 03:51:11 twilightnode nnrpd[546246]: 57.146.94.167.censys-scanner.com res <anonymous>
Jul 24 03:51:11 twilightnode nnrpd[546246]: 57.146.94.167.censys-scanner.com no_match_user <anonymous> <localhost>
Jul 24 03:51:11 twilightnode nnrpd[546246]: 57.146.94.167.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 24 03:51:11 twilightnode nnrpd[546246]: 57.146.94.167.censys-scanner.com match_user <anonymous> <anonymous>
Jul 24 03:51:11 twilightnode nnrpd[546246]: 57.146.94.167.censys-scanner.com no_post anonymous-read
Jul 24 12:47:49 twilightnode nnrpd[569336]: Reading access from /usr/local/news/etc/readers.conf
Jul 24 12:47:49 twilightnode nnrpd[569336]: Auth strategy 'localhost' does not match client. Removing.
Jul 24 12:47:49 twilightnode nnrpd[569336]: azpdsgkml0gq.stretchoid.com res <anonymous>
Jul 24 12:47:49 twilightnode nnrpd[569336]: azpdsgkml0gq.stretchoid.com no_match_user <anonymous> <localhost>
Jul 24 12:47:49 twilightnode nnrpd[569336]: azpdsgkml0gq.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 24 12:47:49 twilightnode nnrpd[569336]: azpdsgkml0gq.stretchoid.com match_user <anonymous> <anonymous>
Jul 24 12:47:49 twilightnode nnrpd[569336]: azpdsgkml0gq.stretchoid.com no_post anonymous-read
Jul 24 12:47:59 twilightnode nnrpd[569337]: Reading access from /usr/local/news/etc/readers.conf
Jul 24 12:47:59 twilightnode nnrpd[569337]: Auth strategy 'localhost' does not match client. Removing.
Jul 24 12:47:59 twilightnode nnrpd[569337]: azpdsgkml0gq.stretchoid.com res <anonymous>
Jul 24 12:47:59 twilightnode nnrpd[569337]: azpdsgkml0gq.stretchoid.com no_match_user <anonymous> <localhost>
Jul 24 12:47:59 twilightnode nnrpd[569337]: azpdsgkml0gq.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 24 12:47:59 twilightnode nnrpd[569337]: azpdsgkml0gq.stretchoid.com match_user <anonymous> <anonymous>
Jul 24 12:47:59 twilightnode nnrpd[569337]: azpdsgkml0gq.stretchoid.com no_post anonymous-read
Jul 24 13:52:19 twilightnode nnrpd[572080]: Reading access from /usr/local/news/etc/readers.conf
Jul 24 13:52:19 twilightnode nnrpd[572080]: Auth strategy 'localhost' does not match client. Removing.
Jul 24 13:52:19 twilightnode nnrpd[572080]: 172.233.117.214.socradar-curiosity-wide-scan-project.socradar.com res <anonymous>
Jul 24 13:52:19 twilightnode nnrpd[572080]: 172.233.117.214.socradar-curiosity-wide-scan-project.socradar.com no_match_user <anonymous> <localhost>
Jul 24 13:52:19 twilightnode nnrpd[572080]: 172.233.117.214.socradar-curiosity-wide-scan-project.socradar.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 24 13:52:19 twilightnode nnrpd[572080]: 172.233.117.214.socradar-curiosity-wide-scan-project.socradar.com match_user <anonymous> <anonymous>
Jul 24 13:52:19 twilightnode nnrpd[572080]: 172.233.117.214.socradar-curiosity-wide-scan-project.socradar.com no_post anonymous-read
Jul 24 15:37:05 twilightnode nnrpd[576769]: Reading access from /usr/local/news/etc/readers.conf
Jul 24 15:37:05 twilightnode nnrpd[576769]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 6730 71.5%1017.8 KB 72.0%
innd 1284 13.6%198.8 KB 14.1%
innfeed 1211 12.9%177.3 KB 12.5%
nnrpd 186 2.0%20.6 KB 1.5%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 9412 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 14609 46.9%
Negative hits 9817 31.5%
Do not exist 6708 21.5%
Cache misses 0 0.0%
TOTAL: 4 31134 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.013 0.0%7 1.000 1.857 3.000
article cleanup00:00:00.044 0.0%6733 0.000 0.007 0.077
article logging00:00:00.273 0.0%6740 0.000 0.041 0.118
article parse00:00:00.094 0.0%8802 0.000 0.011 0.071
article write00:00:05.114 0.0%4887 0.587 1.046 3.633
data move00:00:00.107 0.0%33810 0.000 0.003 0.040
hisgrep/artcncl00:00:00.004 0.0%7 0.000 0.571 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.562 0.0%31247 0.087 0.178 0.371
history sync00:00:00.062 0.0%418 0.000 0.148 0.667
history write00:00:04.038 0.0%6733 0.211 0.600 2.724
idle24:00:39.350100.0%33186 1373.874 2604.693 13642.182
nntp read00:00:00.850 0.0%32820 0.000 0.026 0.082
overview write00:00:02.865 0.0%4887 0.143 0.586 4.467
perl filter00:00:10.920 0.0%6733 0.632 1.622 18.062
python filter00:00:00.695 0.0%6733 0.000 0.103 1.000
site send00:00:00.127 0.0%4877 0.000 0.026 0.222
TOTAL: 1724:01:10.118100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.016 0.0%4938 0.000 0.003 0.148
article prepare00:00:00.001 0.0%17500 0.000 0.000 0.007
article read00:00:00.834 0.0%3236 0.000 0.258 4.667
backlog stats00:00:00.050 0.0%52432 0.000 0.001 0.012
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.545 0.0%28757 0.000 0.019 0.124
data write00:00:00.768 0.0%23784 0.000 0.032 0.100
idle23:50:01.320100.0%52432 449.047 1636.430 5235.328
status file00:00:00.147 0.0%214 0.000 0.687 4.000
TOTAL: 923:50:03.681100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:34.925100.0%24 66.000 1455.208 10360.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.002 0.0%157 0.000 0.013 0.500
TOTAL: 300:00:34.927100.0%----

Control commands to innd:

CommandNumber
flush 2
flushlogs 2
go 2
logmode 2
lowmark 1
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 167

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 3 11191 4253 5749 1189 38%47:54:04
2newsfeed.endofthelinebbs.com 2 5235 454 4217 564 8%24:54:08
3news.tebibyte.org 1 2267 56 2195 16 2%12:50:28
4news.sklaffkom.se 38 85 49 8 28 57%09:44:55
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 69 18778 4812 12169 1797 25%95:23:35
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net11.9 MB0.0 KB3.7 MB15.6 MB 76%2.9 KB
2newsfeed.endofthelinebbs.com4.7 MB0.0 KB1.1 MB5.8 MB 80%5.9 KB
3news.tebibyte.org193.8 KB0.0 KB66.8 KB260.6 KB 74%3.6 KB
4news.sklaffkom.se172.5 KB0.0 KB50.3 KB222.8 KB 77%2.9 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 517.0 MB0.0 KB5.0 MB22.0 MB 77%3.4 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 24 03:00:05 - 03:59:59 95 1.9% 0.03359.0 KB 2.1% 0.10
Jul 24 04:00:00 - 04:59:59 112 2.3% 0.03432.8 KB 2.5% 0.12
Jul 24 05:00:00 - 05:59:59 70 1.4% 0.02201.4 KB 1.2% 0.06
Jul 24 06:00:00 - 06:59:59 111 2.3% 0.03359.5 KB 2.1% 0.10
Jul 24 07:00:00 - 07:59:59 151 3.1% 0.04529.0 KB 3.0% 0.15
Jul 24 08:00:00 - 08:59:59 217 4.4% 0.06881.2 KB 5.1% 0.24
Jul 24 09:00:00 - 09:59:59 234 4.8% 0.07816.2 KB 4.7% 0.23
Jul 24 10:00:00 - 10:59:59 220 4.5% 0.06530.4 KB 3.1% 0.15
Jul 24 11:00:00 - 11:59:59 235 4.8% 0.07689.3 KB 4.0% 0.19
Jul 24 12:00:00 - 12:59:59 252 5.2% 0.071.1 MB 6.7% 0.32
Jul 24 13:00:00 - 13:59:59 268 5.5% 0.07798.7 KB 4.6% 0.22
Jul 24 14:00:00 - 14:59:59 270 5.5% 0.07836.3 KB 4.8% 0.23
Jul 24 15:00:00 - 15:59:59 277 5.7% 0.081.1 MB 6.2% 0.30
Jul 24 16:00:00 - 16:59:59 254 5.2% 0.07951.1 KB 5.5% 0.26
Jul 24 17:00:00 - 17:59:59 282 5.8% 0.081.3 MB 7.6% 0.37
Jul 24 18:00:00 - 18:59:59 229 4.7% 0.06814.1 KB 4.7% 0.23
Jul 24 19:00:00 - 19:59:59 245 5.0% 0.07858.6 KB 4.9% 0.24
Jul 24 20:00:00 - 20:59:59 283 5.8% 0.08794.7 KB 4.6% 0.22
Jul 24 21:00:00 - 21:59:59 290 5.9% 0.081.1 MB 6.7% 0.32
Jul 24 22:00:00 - 22:59:59 199 4.1% 0.06575.2 KB 3.3% 0.16
Jul 24 23:00:00 - 23:59:59 170 3.5% 0.05653.7 KB 3.8% 0.18
Jul 25 00:00:00 - 00:59:59 160 3.3% 0.04631.2 KB 3.6% 0.18
Jul 25 01:00:00 - 01:59:59 150 3.1% 0.04499.4 KB 2.9% 0.14
Jul 25 02:00:00 - 02:59:59 99 2.0% 0.03427.2 KB 2.5% 0.12
Jul 25 03:00:00 - 03:00:06 9 0.2% 1.507.7 KB 0.0% 1.29
TOTAL: 24:00:01 4882 100.0% 0.0617.0 MB 100.0% 0.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1191 1135 0 0 0 0 0 0 56
2newsfeed.endofthelinebbs.com 565 89 0 0 0 0 0 0 476
3news.tebibyte.org 65 63 0 0 0 0 0 0 2
4news.sklaffkom.se 27 26 0 0 0 0 0 0 1
TOTAL: 4 1848 1313 0 0 0 0 0 0 535

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.checkmate 98
alt.slack 56
alt.home.repair 49
alt.usage.english 49
pl.soc.prawo 47
linux.debian.vote 46
pl.misc.elektronika 44
alt.fan.rush-limbaurgh 39
lada.talk 34
pl.soc.polityka 30
fr.sci.maths 24
uk.tech.broadcast 24
alt.bestjobsusa.computer.jobs 21
free.it.ai.general 21
cn.comp 20
it.hobby.cucina 19
de.etc.bahn.bahnpolitik 18
it.tlc.cellulari.android 17
hfx.general 16
aus.politics 14
TOTAL: 210 1313

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 484
EMP (phn path) 27
User-issued cancel 11
Too many newsgroups 5
Too many newsgroups (meow) 1
TOTAL: 5 528

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 6454 1178 3691 3 0 2 18%23:59:21
2sklaffkom.se 5087 891 1680 2302 0 0 17%23:59:58
3newsfeed.endofthelinebbs.com 7944 21 4397 3 0 75 0%23:59:30
4weretis.net 614 0 606 0 0 0 0%22:17:45
TOTAL: 4 20099 2090 10374 2308 0 77 10%94:16:34
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org3.0 MB165.5 KB3.2 MB0.0 KB/s2.8 KB23:59:21
2sklaffkom.se1.4 MB10.5 MB12.0 MB0.1 KB/s3.8 KB23:59:58
3newsfeed.endofthelinebbs.com54.8 KB13.8 KB68.6 KB0.0 KB/s2.9 KB23:59:30
4weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s022:17:45
TOTAL: 44.5 MB10.7 MB15.2 MB0.0 KB/s3.5 KB94:16:34
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
145.172.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:06
257.146.94.167.censys-scanner.com 3 00.0 KB 0 0 000:00:00
3172-236-228-222.ip.linodeusercontent.com 2 00.0 KB 0 0 000:00:00
4azpdsgkml0gq.stretchoid.com 2 00.0 KB 0 0 000:00:10
5147.185.132.115 1 00.0 KB 0 0 000:00:00
6172.233.117.214.socradar-curiosity-wide-scan-project.socradar.com 1 00.0 KB 0 0 000:00:10
7annie.probe.onyphe.net 1 00.0 KB 0 0 000:00:00
8gibbons.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
9r3-81-51.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 9 15 00.0 KB 0 0 000:00:34

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.167.censys-scanner.com 3 00.0 KB 0 0 000:00:00
2*.66.censys-scanner.com 3 00.0 KB 0 0 000:00:06
3*.ip.linodeusercontent.com 2 00.0 KB 0 0 000:00:00
4*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
5*.stretchoid.com 2 00.0 KB 0 0 000:00:10
6*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
7*.socradar-curiosity-wide-scan-project.socradar.com 1 00.0 KB 0 0 000:00:10
8unresolved 1 00.0 KB 0 0 000:00:00
TOTAL: 8 15 00.0 KB 0 0 000:00:34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
azpdsgkml0gq.stretchoid.com 0.013 0.060 0.00000:00:10
172.233.117.214.socradar-curiosity-wide-scan-project.socradar.com 0.003 0.010 0.00000:00:10
45.172.132.66.censys-scanner.com 0.031 0.029 0.00000:00:06
gibbons.probe.onyphe.net 0.002 0.009 0.00000:00:03
r3-81-51.monitoring.internet-measurement.com 0.006 0.006 0.00000:00:01
57.146.94.167.censys-scanner.com 0.030 0.035 0.00000:00:00
annie.probe.onyphe.net 0.005 0.010 0.00000:00:00
172-236-228-222.ip.linodeusercontent.com 0.007 0.019 0.00000:00:00
147.185.132.115 0.004 0.014 0.00000:00:00
TOTAL: 9 0.101 0.192 0.00000:00:34

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

SystemConn
172-236-228-222.ip.linodeusercontent.com 8
annie.probe.onyphe.net 2
45.172.132.66.censys-scanner.com 1
57.146.94.167.censys-scanner.com 1
azpdsgkml0gq.stretchoid.com 1
TOTAL: 5 13

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

CommandCount
#001 2
#026#003#001#001 2
?#024 2
?$?(?#?' 2
EHLO www.censys.io 2
#026#003#003#002c#001 1
?$?,?r?s?#023#002#023#001?#024?#007?#022?#023?'?/?#024?(?0?`?a... 1
MGLNDD_172.234.115.63_119 1
TOTAL: 8 13

NNRP client timeouts [Top 20]:

SystemConnPeer
45.172.132.66.censys-scanner.com 1 2
57.146.94.167.censys-scanner.com 1 2
TOTAL: 2 2 5
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