Daily Usenet report

Aug 6 03:00:03 -- Aug 7 03:00:04

Unknown entries from news log file:

First 50 / 62 lines (80.6%)

Aug 6 03:01:24 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Aug 6 07:35:08 twilightnode nnrpd[756005]: Reading access from /usr/local/news/etc/readers.conf
Aug 6 07:35:08 twilightnode nnrpd[756005]: Auth strategy 'localhost' does not match client. Removing.
Aug 6 07:35:08 twilightnode nnrpd[756005]: 78.195.132.66.censys-scanner.com res <anonymous>
Aug 6 07:35:08 twilightnode nnrpd[756005]: 78.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 6 07:35:08 twilightnode nnrpd[756005]: 78.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 6 07:35:08 twilightnode nnrpd[756005]: 78.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 6 07:35:08 twilightnode nnrpd[756005]: 78.195.132.66.censys-scanner.com no_post anonymous-read
Aug 6 07:35:09 twilightnode nnrpd[756005]: 78.195.132.66.censys-scanner.com res <anonymous>
Aug 6 07:35:09 twilightnode nnrpd[756005]: 78.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 6 07:35:09 twilightnode nnrpd[756005]: 78.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 6 07:35:09 twilightnode nnrpd[756005]: 78.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 6 07:35:09 twilightnode nnrpd[756005]: 78.195.132.66.censys-scanner.com no_post anonymous-read
Aug 6 07:53:08 twilightnode nnrpd[756775]: Reading access from /usr/local/news/etc/readers.conf
Aug 6 07:53:08 twilightnode nnrpd[756775]: Auth strategy 'localhost' does not match client. Removing.
Aug 6 07:53:08 twilightnode nnrpd[756775]: r4-32-20.monitoring.internet-measurement.com res <anonymous>
Aug 6 07:53:08 twilightnode nnrpd[756775]: r4-32-20.monitoring.internet-measurement.com no_match_user <anonymous> <localhost>
Aug 6 07:53:08 twilightnode nnrpd[756775]: r4-32-20.monitoring.internet-measurement.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 6 07:53:08 twilightnode nnrpd[756775]: r4-32-20.monitoring.internet-measurement.com match_user <anonymous> <anonymous>
Aug 6 07:53:08 twilightnode nnrpd[756775]: r4-32-20.monitoring.internet-measurement.com no_post anonymous-read
Aug 6 08:34:05 twilightnode nnrpd[758579]: Reading access from /usr/local/news/etc/readers.conf
Aug 6 08:34:05 twilightnode nnrpd[758579]: Auth strategy 'localhost' does not match client. Removing.
Aug 6 08:34:05 twilightnode nnrpd[758579]: 95.211.203.35.bc.googleusercontent.com res <anonymous>
Aug 6 08:34:05 twilightnode nnrpd[758579]: 95.211.203.35.bc.googleusercontent.com no_match_user <anonymous> <localhost>
Aug 6 08:34:05 twilightnode nnrpd[758579]: 95.211.203.35.bc.googleusercontent.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 6 08:34:05 twilightnode nnrpd[758579]: 95.211.203.35.bc.googleusercontent.com match_user <anonymous> <anonymous>
Aug 6 08:34:05 twilightnode nnrpd[758579]: 95.211.203.35.bc.googleusercontent.com no_post anonymous-read
Aug 6 08:53:38 twilightnode nnrpd[759510]: Reading access from /usr/local/news/etc/readers.conf
Aug 6 08:53:38 twilightnode nnrpd[759510]: Auth strategy 'localhost' does not match client. Removing.
Aug 6 08:53:38 twilightnode nnrpd[759510]: o022.scanner.modat.io res <anonymous>
Aug 6 08:53:38 twilightnode nnrpd[759510]: o022.scanner.modat.io no_match_user <anonymous> <localhost>
Aug 6 08:53:38 twilightnode nnrpd[759510]: o022.scanner.modat.io no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 6 08:53:38 twilightnode nnrpd[759510]: o022.scanner.modat.io match_user <anonymous> <anonymous>
Aug 6 08:53:38 twilightnode nnrpd[759510]: o022.scanner.modat.io no_post anonymous-read
Aug 6 09:20:42 twilightnode nnrpd[760788]: Reading access from /usr/local/news/etc/readers.conf
Aug 6 09:20:42 twilightnode nnrpd[760788]: Auth strategy 'localhost' does not match client. Removing.
Aug 6 09:20:42 twilightnode nnrpd[760788]: azpdsgleoey2.stretchoid.com res <anonymous>
Aug 6 09:20:42 twilightnode nnrpd[760788]: azpdsgleoey2.stretchoid.com no_match_user <anonymous> <localhost>
Aug 6 09:20:42 twilightnode nnrpd[760788]: azpdsgleoey2.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 6 09:20:42 twilightnode nnrpd[760788]: azpdsgleoey2.stretchoid.com match_user <anonymous> <anonymous>
Aug 6 09:20:42 twilightnode nnrpd[760788]: azpdsgleoey2.stretchoid.com no_post anonymous-read
Aug 6 09:20:52 twilightnode nnrpd[760792]: Reading access from /usr/local/news/etc/readers.conf
Aug 6 09:20:52 twilightnode nnrpd[760792]: Auth strategy 'localhost' does not match client. Removing.
Aug 6 09:20:52 twilightnode nnrpd[760792]: azpdsgleoey2.stretchoid.com res <anonymous>
Aug 6 09:20:52 twilightnode nnrpd[760792]: azpdsgleoey2.stretchoid.com no_match_user <anonymous> <localhost>
Aug 6 09:20:52 twilightnode nnrpd[760792]: azpdsgleoey2.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 6 09:20:52 twilightnode nnrpd[760792]: azpdsgleoey2.stretchoid.com match_user <anonymous> <anonymous>
Aug 6 09:20:52 twilightnode nnrpd[760792]: azpdsgleoey2.stretchoid.com no_post anonymous-read
Aug 6 14:03:18 twilightnode nnrpd[773768]: Reading access from /usr/local/news/etc/readers.conf
Aug 6 14:03:18 twilightnode nnrpd[773768]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 6893 73.6%1.0 MB 74.0%
innfeed 1192 12.7%177.2 KB 12.5%
innd 1177 12.6%179.3 KB 12.7%
nnrpd 100 1.1%11.2 KB 0.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 9363 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 14815 48.9%
Negative hits 8662 28.6%
Do not exist 6834 22.5%
Cache misses 0 0.0%
TOTAL: 4 30311 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.006 0.0%2 3.000 3.000 3.000
article cleanup00:00:00.056 0.0%6853 0.000 0.008 0.056
article logging00:00:00.238 0.0%6894 0.000 0.035 0.233
article parse00:00:00.109 0.0%9822 0.000 0.011 0.078
article write00:00:05.043 0.0%5366 0.438 0.940 4.750
data move00:00:00.156 0.0%34136 0.000 0.005 0.151
hisgrep/artcncl00:00:00.003 0.0%2 1.500 1.500 1.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.349 0.0%30383 0.091 0.143 0.288
history sync00:00:00.050 0.0%310 0.000 0.161 1.000
history write00:00:03.254 0.0%6853 0.234 0.475 0.938
idle24:00:00.845100.0%32832 1290.133 2631.605 12248.184
nntp read00:00:00.597 0.0%32589 0.000 0.018 0.091
overview write00:00:02.389 0.0%5366 0.119 0.445 1.364
perl filter00:00:09.119 0.0%6853 0.596 1.331 14.500
python filter00:00:00.551 0.0%6853 0.000 0.080 0.722
site send00:00:00.093 0.0%5314 0.000 0.018 0.167
TOTAL: 1724:00:26.858100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.020 0.0%5544 0.000 0.004 0.091
article prepare00:00:00.004 0.0%20084 0.000 0.000 0.009
article read00:00:00.619 0.0%3625 0.000 0.171 0.600
backlog stats00:00:00.044 0.0%58840 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.404 0.0%32130 0.000 0.013 0.040
data write00:00:00.694 0.0%26779 0.000 0.026 0.105
idle23:58:11.254100.0%58840 452.312 1466.541 7741.595
status file00:00:00.133 0.0%208 0.000 0.639 6.000
TOTAL: 923:58:13.172100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:28.630100.0%13 80.500 2202.308 10335.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%39 0.000 0.000 0.000
TOTAL: 300:00:28.630100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 5 13039 4825 7001 1213 37%53:32:01
2newsfeed.endofthelinebbs.com 1 5159 618 4262 279 11%24:23:17
3news.tebibyte.org 1 5244 74 5142 28 1%21:55:27
4news.sklaffkom.se 39 78 36 11 31 46%09:00:33
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 71 23520 5553 16416 1551 23%108:51:18
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net15.1 MB0.0 KB3.6 MB18.6 MB 80%3.2 KB
2newsfeed.endofthelinebbs.com6.0 MB0.0 KB1007.7 KB7.0 MB 85%8.0 KB
3news.tebibyte.org178.2 KB0.0 KB143.2 KB321.5 KB 55%3.2 KB
4news.sklaffkom.se90.9 KB0.0 KB67.2 KB158.0 KB 57%2.4 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 521.3 MB0.0 KB4.7 MB26.1 MB 81%3.8 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 6 03:00:03 - 03:59:59 89 1.7% 0.02488.1 KB 2.3% 0.14
Aug 6 04:00:00 - 04:59:59 99 1.8% 0.03635.1 KB 3.0% 0.18
Aug 6 05:00:00 - 05:59:59 121 2.3% 0.03460.8 KB 2.2% 0.13
Aug 6 06:00:00 - 06:59:59 132 2.5% 0.04652.1 KB 3.1% 0.18
Aug 6 07:00:00 - 07:59:59 107 2.0% 0.03433.2 KB 2.0% 0.12
Aug 6 08:00:00 - 08:59:59 189 3.5% 0.05665.5 KB 3.1% 0.18
Aug 6 09:00:00 - 09:59:59 202 3.8% 0.06631.5 KB 3.0% 0.18
Aug 6 10:00:00 - 10:59:59 286 5.3% 0.08859.9 KB 4.0% 0.24
Aug 6 11:00:00 - 11:59:59 297 5.5% 0.08999.8 KB 4.7% 0.28
Aug 6 12:00:00 - 12:59:59 250 4.7% 0.07808.5 KB 3.8% 0.22
Aug 6 13:00:00 - 13:59:59 300 5.6% 0.081.0 MB 4.9% 0.29
Aug 6 14:00:00 - 14:59:59 232 4.3% 0.06712.3 KB 3.4% 0.20
Aug 6 15:00:00 - 15:59:59 280 5.2% 0.081.1 MB 5.2% 0.31
Aug 6 16:00:00 - 16:59:59 313 5.8% 0.091.2 MB 5.9% 0.35
Aug 6 17:00:00 - 17:59:59 346 6.4% 0.101.8 MB 8.9% 0.52
Aug 6 18:00:00 - 18:59:59 357 6.6% 0.101.4 MB 6.9% 0.41
Aug 6 19:00:00 - 19:59:59 371 6.9% 0.101.3 MB 6.1% 0.36
Aug 6 20:00:00 - 20:59:59 291 5.4% 0.081.2 MB 5.6% 0.33
Aug 6 21:00:00 - 21:59:59 217 4.0% 0.06846.9 KB 4.0% 0.24
Aug 6 22:00:00 - 22:59:59 263 4.9% 0.07865.2 KB 4.1% 0.24
Aug 6 23:00:00 - 23:59:59 193 3.6% 0.05667.5 KB 3.1% 0.19
Aug 7 00:00:00 - 00:59:59 156 2.9% 0.04596.5 KB 2.8% 0.17
Aug 7 01:00:00 - 01:59:59 143 2.7% 0.04999.7 KB 4.7% 0.28
Aug 7 02:00:00 - 02:59:59 124 2.3% 0.03691.5 KB 3.3% 0.19
Aug 7 03:00:00 - 03:00:04 11 0.2% 2.7518.0 KB 0.1% 4.49
TOTAL: 24:00:01 5369 100.0% 0.0620.8 MB 100.0% 0.25
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1184 983 0 0 0 0 0 0 201
2newsfeed.endofthelinebbs.com 286 39 0 0 0 0 0 0 247
3news.sklaffkom.se 31 31 0 0 0 0 0 0 0
4news.tebibyte.org 23 16 0 0 0 0 0 0 7
TOTAL: 4 1524 1069 0 0 0 0 0 0 455

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.hobby.cucina 60
alt.usage.english 58
de.alt.fan.pluesch 37
uk.net.news.moderation 37
uk.legal.moderated 33
pl.sci.fizyka 29
pl.misc.samochody 27
hfx.general 24
it.discussioni.commercialisti 23
pl.soc.prawo 23
alt.checkmate 20
it-alt.sport.calcio.juventus 20
lada.talk 20
de.rec.garten 19
no.alt.diskusjoner 18
alt.privacy.anon-server 17
francom.esoterisme 16
eternal-september.test 15
linux.debian.vote 15
eternal-september.talk 14
TOTAL: 194 1069

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 247
EMP (phn path) 98
User-issued cancel 43
Too many newsgroups 14
HTML Multipart 6
Too many newsgroups (meow) 5
Binary: misplaced binary 1
TOTAL: 7 414

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 7358 1449 3863 9 0 22 19%23:59:57
2sklaffkom.se 5508 1019 1786 2514 0 1 18%23:59:57
3newsfeed.endofthelinebbs.com 9046 21 4671 15 0 216 0%23:59:56
4weretis.net 726 0 717 0 0 0 0%22:01:14
TOTAL: 4 22638 2489 11037 2538 0 239 10%94:01:04
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org3.8 MB680.4 KB4.4 MB0.1 KB/s3.1 KB23:59:57
2sklaffkom.se1.7 MB12.5 MB14.2 MB0.2 KB/s4.1 KB23:59:57
3newsfeed.endofthelinebbs.com53.9 KB49.9 KB103.8 KB0.0 KB/s2.9 KB23:59:56
4weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s022:01:14
TOTAL: 45.6 MB13.2 MB18.8 MB0.1 KB/s3.8 KB94:01:04
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1azpdsgleoey2.stretchoid.com 2 00.0 KB 0 0 000:00:10
247.250.83.149 1 00.0 KB 0 0 000:00:03
364.89.162.15 1 00.0 KB 0 0 000:00:09
478.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
595.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
6o022.scanner.modat.io 1 00.0 KB 0 0 000:00:00
7r4-32-20.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 7 8 00.0 KB 0 0 000:00:28

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.stretchoid.com 2 00.0 KB 0 0 000:00:10
2unresolved 2 00.0 KB 0 0 000:00:13
3*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
4*.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
6*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 6 8 00.0 KB 0 0 000:00:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
azpdsgleoey2.stretchoid.com 0.005 0.017 0.00000:00:10
64.89.162.15 0.004 0.018 0.00000:00:09
47.250.83.149 0.003 0.010 0.00000:00:03
78.195.132.66.censys-scanner.com 0.029 0.009 0.00000:00:02
r4-32-20.monitoring.internet-measurement.com 0.002 0.015 0.00000:00:01
o022.scanner.modat.io 0.002 0.021 0.00000:00:00
95.211.203.35.bc.googleusercontent.com 0.005 0.016 0.00000:00:00
TOTAL: 7 0.050 0.106 0.00000:00:28

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

SystemConn
95.211.203.35.bc.googleusercontent.com 4
47.250.83.149 3
64.89.162.15 1
78.195.132.66.censys-scanner.com 1
azpdsgleoey2.stretchoid.com 1
TOTAL: 5 10

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

CommandCount
#023#001#023#002#023#003#001 1
#026#003#001 1
?#024 1
Accept-Encoding: gzip 1
EHLO www.censys.io 1
GET / HTTP/1.1 1
Host: 172.234.115.63:119 1
MGLNDD_172.234.115.63_119 1
SSH-2.0-OpenSSH_10.2 1
User-Agent: Hello from Palo Alto Network... 1
TOTAL: 10 10

NNRP client timeouts [Top 20]:

SystemConnPeer
47.250.83.149 1 1
TOTAL: 1 1 1
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