Daily Usenet report

Oct 26 03:00:05 -- Oct 27 03:00:04

Unknown entries from news log file:

First 50 / 137 lines (36.5%)

Oct 26 03:01:15 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Oct 26 03:10:58 twilightnode nnrpd[414613]: Reading access from /usr/local/news/etc/readers.conf
Oct 26 03:10:58 twilightnode nnrpd[414613]: Auth strategy 'localhost' does not match client. Removing.
Oct 26 03:10:58 twilightnode nnrpd[414613]: 174.96.78.81 res <anonymous>
Oct 26 03:10:58 twilightnode nnrpd[414613]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 26 03:10:58 twilightnode nnrpd[414613]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 26 03:10:58 twilightnode nnrpd[414613]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 26 03:10:58 twilightnode nnrpd[414613]: 174.96.78.81 no_post anonymous-read
Oct 26 03:10:58 twilightnode nnrpd[414614]: Reading access from /usr/local/news/etc/readers.conf
Oct 26 03:10:58 twilightnode nnrpd[414614]: Auth strategy 'localhost' does not match client. Removing.
Oct 26 03:10:58 twilightnode nnrpd[414614]: 174.96.78.81 res <anonymous>
Oct 26 03:10:58 twilightnode nnrpd[414614]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 26 03:10:58 twilightnode nnrpd[414614]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 26 03:10:58 twilightnode nnrpd[414614]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 26 03:10:58 twilightnode nnrpd[414614]: 174.96.78.81 no_post anonymous-read
Oct 26 06:25:35 twilightnode nnrpd[423450]: Reading access from /usr/local/news/etc/readers.conf
Oct 26 06:25:35 twilightnode nnrpd[423450]: Auth strategy 'localhost' does not match client. Removing.
Oct 26 06:25:35 twilightnode nnrpd[423450]: o350.scanner.modat.io res <anonymous>
Oct 26 06:25:35 twilightnode nnrpd[423450]: o350.scanner.modat.io no_match_user <anonymous> <localhost>
Oct 26 06:25:35 twilightnode nnrpd[423450]: o350.scanner.modat.io no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 26 06:25:35 twilightnode nnrpd[423450]: o350.scanner.modat.io match_user <anonymous> <anonymous>
Oct 26 06:25:35 twilightnode nnrpd[423450]: o350.scanner.modat.io no_post anonymous-read
Oct 26 06:53:24 twilightnode nnrpd[425265]: Reading access from /usr/local/news/etc/readers.conf
Oct 26 06:53:24 twilightnode nnrpd[425265]: Auth strategy 'localhost' does not match client. Removing.
Oct 26 06:53:24 twilightnode nnrpd[425265]: 174.96.78.81 res <anonymous>
Oct 26 06:53:24 twilightnode nnrpd[425265]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 26 06:53:24 twilightnode nnrpd[425265]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 26 06:53:24 twilightnode nnrpd[425265]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 26 06:53:24 twilightnode nnrpd[425265]: 174.96.78.81 no_post anonymous-read
Oct 26 06:53:25 twilightnode nnrpd[425266]: Reading access from /usr/local/news/etc/readers.conf
Oct 26 06:53:25 twilightnode nnrpd[425266]: Auth strategy 'localhost' does not match client. Removing.
Oct 26 06:53:25 twilightnode nnrpd[425266]: 174.96.78.81 res <anonymous>
Oct 26 06:53:25 twilightnode nnrpd[425266]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 26 06:53:25 twilightnode nnrpd[425266]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 26 06:53:25 twilightnode nnrpd[425266]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 26 06:53:25 twilightnode nnrpd[425266]: 174.96.78.81 no_post anonymous-read
Oct 26 11:30:08 twilightnode nnrpd[438276]: Reading access from /usr/local/news/etc/readers.conf
Oct 26 11:30:08 twilightnode nnrpd[438276]: Auth strategy 'localhost' does not match client. Removing.
Oct 26 11:30:08 twilightnode nnrpd[438276]: 172.202.106.170 res <anonymous>
Oct 26 11:30:08 twilightnode nnrpd[438276]: 172.202.106.170 no_match_user <anonymous> <localhost>
Oct 26 11:30:08 twilightnode nnrpd[438276]: 172.202.106.170 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 26 11:30:08 twilightnode nnrpd[438276]: 172.202.106.170 match_user <anonymous> <anonymous>
Oct 26 11:30:08 twilightnode nnrpd[438276]: 172.202.106.170 no_post anonymous-read
Oct 26 21:16:56 twilightnode nnrpd[470060]: Reading access from /usr/local/news/etc/readers.conf
Oct 26 21:16:56 twilightnode nnrpd[470060]: Auth strategy 'localhost' does not match client. Removing.
Oct 26 21:16:56 twilightnode nnrpd[470060]: 198.235.24.77 res <anonymous>
Oct 26 21:16:56 twilightnode nnrpd[470060]: 198.235.24.77 no_match_user <anonymous> <localhost>
Oct 26 21:16:56 twilightnode nnrpd[470060]: 198.235.24.77 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 26 21:16:56 twilightnode nnrpd[470060]: 198.235.24.77 match_user <anonymous> <anonymous>
Oct 26 21:16:56 twilightnode nnrpd[470060]: 198.235.24.77 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
inn 8390 42.5%1.4 MB 50.5%
innd 7834 39.7%1.1 MB 36.9%
nnrpd 2221 11.2%192.4 KB 6.6%
innfeed 1297 6.6%176.9 KB 6.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 19743 100.0%2.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 18542 38.7%
Cache misses 10559 22.0%
Negative hits 10483 21.9%
Do not exist 8310 17.4%
TOTAL: 4 47894 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.055 0.0%35 1.000 1.571 3.000
article cleanup00:00:00.105 0.0%8325 0.000 0.013 0.145
article logging00:00:00.311 0.0%8364 0.000 0.037 0.153
article parse00:00:00.119 0.0%11865 0.000 0.010 0.083
article write00:00:08.402 0.0%6574 0.647 1.278 2.333
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.307 0.0%41619 0.000 0.007 0.050
hisgrep/artcncl00:00:00.030 0.0%35 0.000 0.857 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.966 0.0%47938 0.049 0.145 0.917
history sync00:00:00.054 0.0%326 0.000 0.166 2.667
history write00:00:04.359 0.0%8325 0.218 0.524 1.605
idle23:49:42.355 99.9%44134 142.079 1943.680 5717.857
nntp read00:00:01.032 0.0%42481 0.004 0.024 0.073
overview write00:00:06.545 0.0%6574 0.469 0.996 3.120
perl filter00:00:13.290 0.0%8325 0.709 1.596 10.909
python filter00:00:01.025 0.0%8325 0.000 0.123 1.500
site send00:00:00.416 0.0%13099 0.000 0.032 0.140
TOTAL: 1823:50:25.371100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.044 0.0%22922 0.000 0.002 0.170
article prepare00:00:00.004 0.0%33472 0.000 0.000 0.008
article read00:00:01.421 0.0%4748 0.053 0.299 1.500
backlog stats00:00:00.056 0.0%77290 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.702 0.0%44971 0.000 0.016 0.047
data write00:00:01.213 0.0%38587 0.000 0.031 0.078
idle23:50:07.318100.0%77290 71.432 1110.199 2928.902
status file00:00:00.239 0.0%172 0.000 1.390 7.000
TOTAL: 923:50:10.997100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:05:59.986100.0%2271 45.000 158.514 20085.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.110 0.0%5113 0.000 0.022 0.500
readart00:00:00.011 0.0%30 0.357 0.367 0.375
TOTAL: 400:06:00.107100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 3 10653 4852 5710 91 45%42:08:39
2usenet.blueworldhosting.com 1405 7936 1368 4926 1642 17%23:48:56
3news.sklaffkom.se 34 153 150 3 0 98%12:40:35
4news.tebibyte.org 3 2896 35 2861 0 1%24:08:00
5newsfeed.endofthelinebbs.com 2 4242 6 4236 0 0%00:03:00
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 1472 25880 6411 17736 1733 24%102:49:10
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net15.3 MB0.0 KB296.4 KB15.6 MB 98%3.2 KB
2usenet.blueworldhosting.com9.7 MB0.0 KB3.0 MB12.6 MB 76%4.3 KB
3news.sklaffkom.se487.7 KB0.0 KB0.0 KB487.7 KB100%3.3 KB
4newsfeed.endofthelinebbs.com199.6 KB0.0 KB0.0 KB199.6 KB100%33.3 KB
5news.tebibyte.org197.1 KB0.0 KB0.0 KB197.1 KB100%5.6 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 625.8 MB0.0 KB3.3 MB29.1 MB 88%3.7 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 26 03:00:05 - 03:59:59 174 2.6% 0.05660.6 KB 2.3% 0.18
Oct 26 04:00:00 - 04:59:59 158 2.4% 0.04751.8 KB 2.6% 0.21
Oct 26 05:00:00 - 05:59:59 156 2.4% 0.04735.4 KB 2.6% 0.20
Oct 26 06:00:00 - 06:59:59 248 3.8% 0.07954.3 KB 3.3% 0.27
Oct 26 07:00:00 - 07:59:59 184 2.8% 0.05858.3 KB 3.0% 0.24
Oct 26 08:00:00 - 08:59:59 265 4.0% 0.071.2 MB 4.3% 0.35
Oct 26 09:00:00 - 09:59:59 365 5.5% 0.101.5 MB 5.3% 0.42
Oct 26 10:00:00 - 10:59:59 334 5.1% 0.091.2 MB 4.3% 0.34
Oct 26 11:00:00 - 11:59:59 341 5.2% 0.091.4 MB 4.9% 0.40
Oct 26 12:00:00 - 12:59:59 307 4.7% 0.091.2 MB 4.2% 0.34
Oct 26 13:00:00 - 13:59:59 290 4.4% 0.081.2 MB 4.2% 0.34
Oct 26 14:00:00 - 14:59:59 366 5.5% 0.101.2 MB 4.4% 0.35
Oct 26 15:00:00 - 15:59:59 330 5.0% 0.091.4 MB 4.8% 0.39
Oct 26 16:00:00 - 16:59:59 407 6.2% 0.111.7 MB 5.9% 0.47
Oct 26 17:00:00 - 17:59:59 330 5.0% 0.091.2 MB 4.2% 0.33
Oct 26 18:00:00 - 18:59:59 373 5.7% 0.101.5 MB 5.3% 0.42
Oct 26 19:00:00 - 19:59:59 328 5.0% 0.091.2 MB 4.3% 0.35
Oct 26 20:00:00 - 20:59:59 303 4.6% 0.081.1 MB 3.8% 0.31
Oct 26 21:00:00 - 21:59:59 284 4.3% 0.081.0 MB 3.7% 0.29
Oct 26 22:00:00 - 22:59:59 275 4.2% 0.081.4 MB 5.1% 0.41
Oct 26 23:00:00 - 23:59:59 262 4.0% 0.071.1 MB 3.8% 0.31
Oct 27 00:00:00 - 00:59:59 212 3.2% 0.06918.0 KB 3.2% 0.26
Oct 27 01:00:00 - 01:59:59 179 2.7% 0.052.5 MB 8.8% 0.70
Oct 27 02:00:00 - 02:59:59 124 1.9% 0.03512.2 KB 1.8% 0.14
Oct 27 03:00:00 - 03:00:04 1 0.0% 0.255.4 KB 0.0% 1.34
TOTAL: 23:59:59 6596 100.0% 0.0828.1 MB 100.0% 0.33
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1642 386 0 0 0 0 0 0 1256
2twilightnode-out.news.weretis.net 145 13 0 0 0 0 0 0 132
3newsfeed.endofthelinebbs.com 6 0 0 0 0 0 0 0 6
4news.tebibyte.org 1 0 0 0 0 0 0 0 1
TOTAL: 4 1794 399 0 0 0 0 0 0 1395

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 79
hispagatos.mastodon.tag.hacking 9
grenzland.club 5
de.comp.misc 4
pl.comp.sys.amiga 3
oc.forsale 2
a.b.tvshows 1
alt.2600.madrid 1
alt.bbs.files-announce 1
alt.sports.football.pro.cinci-bengals 1
alt.sports.football.pro.kc-chiefs 1
alt.sports.football.pro.la-raiders 1
alt.sports.football.pro.no-saints 1
chmurka.statystyki 1
van.forsale 1
TOTAL: 16 399

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 1081
Too many newsgroups 170
EMP (phn path) 71
User-issued cancel 24
HTML Multipart 10
TOTAL: 5 1356

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 7885 3203 2840 504 0 12 40%23:59:48
2sklaffkom.se 6664 1173 1896 3478 0 0 17%23:59:56
3newsfeed.endofthelinebbs.com 16800 16 16612 11 0 6251 0%23:57:44
4weretis.net 1722 6 1598 0 0 0 0%23:49:13
5usenet.blueworldhosting.com 8133 3 4778 0 0 3 0%23:59:06
TOTAL: 5 41204 4401 27724 3993 0 6266 10%119:45:47
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org8.8 MB6.1 MB14.9 MB0.2 KB/s4.1 KB23:59:48
2sklaffkom.se1.8 MB18.6 MB20.4 MB0.2 KB/s4.5 KB23:59:56
3newsfeed.endofthelinebbs.com48.5 KB81.8 KB130.3 KB0.0 KB/s4.8 KB23:57:44
4usenet.blueworldhosting.com16.5 KB0.0 KB16.5 KB0.0 KB/s5.5 KB23:59:06
5weretis.net12.9 KB0.0 KB12.9 KB0.0 KB/s2.2 KB23:49:13
TOTAL: 510.7 MB24.8 MB35.5 MB0.1 KB/s4.3 KB119:45:47
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1174.96.78.81 4 30147.3 KB 16 0 000:05:17
TOTAL: 1 4 30147.3 KB 16 0 000:05:17

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 8 30147.3 KB 16 0 000:05:47
2*.167.censys-scanner.com 3 00.0 KB 0 0 000:00:01
3*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
4*.probe.onyphe.net 2 00.0 KB 0 0 000:00:04
5*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
6*.infrawat.ch 1 00.0 KB 0 0 000:00:00
7*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 7 18 30147.3 KB 16 0 000:06:00

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
174.96.78.81 0.226 0.848 0.00000:05:17
77.67.26.99 0.008 0.009 0.00000:00:20
172.202.106.170 0.005 0.012 0.00000:00:09
hutchinson.probe.onyphe.net 0.004 0.005 0.00000:00:02
31.195.132.66.censys-scanner.com 0.030 0.014 0.00000:00:02
r3-38-26.monitoring.internet-measurement.com 0.005 0.012 0.00000:00:01
r3-60-3c.monitoring.internet-measurement.com 0.007 0.012 0.00000:00:01
60.146.94.167.censys-scanner.com 0.040 0.025 0.00000:00:01
adelaide.probe.onyphe.net 0.005 0.011 0.00000:00:01
205.210.31.232 0.002 0.017 0.00000:00:00
193-176-29-20.infrawat.ch 0.009 0.016 0.00000:00:00
198.235.24.77 0.006 0.015 0.00000:00:00
o350.scanner.modat.io 0.003 0.015 0.00000:00:00
TOTAL: 13 0.350 1.011 0.00000:06:00

Curious NNRP explorers [Top 20]:

SystemConn
60.146.94.167.censys-scanner.com 3
172.202.106.170 1
193-176-29-20.infrawat.ch 1
198.235.24.77 1
205.210.31.232 1
31.195.132.66.censys-scanner.com 1
77.67.26.99 1
adelaide.probe.onyphe.net 1
hutchinson.probe.onyphe.net 1
o350.scanner.modat.io 1
r3-38-26.monitoring.internet-measurement.com 1
r3-60-3c.monitoring.internet-measurement.com 1
TOTAL: 12 14

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

SystemConn
adelaide.probe.onyphe.net 3
31.195.132.66.censys-scanner.com 1
60.146.94.167.censys-scanner.com 1
TOTAL: 3 5

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

CommandCount
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
C*#030?9?"#015#015?O? },?#035?b?/<?!3#0024?"ww?/... 1
TOTAL: 4 5

NNRP client timeouts [Top 20]:

SystemConnPeer
193-176-29-20.infrawat.ch 1 1
60.146.94.167.censys-scanner.com 1 2
TOTAL: 2 2 5

Newsgroup request counts (by hierarchy) [Top 100]:

HierarchyCountPct
1lada 6 20.0%
2linux 6 20.0%
3alt 5 16.7%
4it 4 13.3%
5rec 3 10.0%
6junk 2 6.7%
7misc 2 6.7%
8free 1 3.3%
9news 1 3.3%
TOTAL: 9 30100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1lada.talk 6
2linux.kernel.netdev 6
3rec.arts.tv 3
4it.comp.os.linux.iniziare 2
5junk 2
6misc.news.internet.discuss 2
7alt.atheism 1
8alt.bible.prophecy 1
9alt.christnet.bible 1
10alt.christnet.christianlife 1
11alt.tv.simpsons 1
12free.pt 1
13it.comp.www 1
14it.comp.www.hosting 1
15news.lists.filters 1
TOTAL: 15 30
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