Daily Usenet report

Nov 4 03:00:05 -- Nov 5 03:00:04

Unknown entries from news log file:

First 50 / 153 lines (32.7%)

Nov 4 03:00:46 twilightnode nnrpd[1072706]: Reading access from /usr/local/news/etc/readers.conf
Nov 4 03:00:46 twilightnode nnrpd[1072706]: Auth strategy 'localhost' does not match client. Removing.
Nov 4 03:00:46 twilightnode nnrpd[1072706]: 174.96.78.81 res <anonymous>
Nov 4 03:00:46 twilightnode nnrpd[1072706]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 4 03:00:46 twilightnode nnrpd[1072706]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 4 03:00:46 twilightnode nnrpd[1072706]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 4 03:00:46 twilightnode nnrpd[1072706]: 174.96.78.81 no_post anonymous-read
Nov 4 03:00:46 twilightnode nnrpd[1072707]: Reading access from /usr/local/news/etc/readers.conf
Nov 4 03:00:46 twilightnode nnrpd[1072707]: Auth strategy 'localhost' does not match client. Removing.
Nov 4 03:00:46 twilightnode nnrpd[1072707]: 174.96.78.81 res <anonymous>
Nov 4 03:00:46 twilightnode nnrpd[1072707]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 4 03:00:46 twilightnode nnrpd[1072707]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 4 03:00:46 twilightnode nnrpd[1072707]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 4 03:00:46 twilightnode nnrpd[1072707]: 174.96.78.81 no_post anonymous-read
Nov 4 03:01:24 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Nov 4 03:05:31 twilightnode nnrpd[1072928]: Reading access from /usr/local/news/etc/readers.conf
Nov 4 03:05:31 twilightnode nnrpd[1072928]: Auth strategy 'localhost' does not match client. Removing.
Nov 4 03:05:31 twilightnode nnrpd[1072928]: 174.96.78.81 res <anonymous>
Nov 4 03:05:31 twilightnode nnrpd[1072928]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 4 03:05:31 twilightnode nnrpd[1072928]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 4 03:05:31 twilightnode nnrpd[1072928]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 4 03:05:31 twilightnode nnrpd[1072928]: 174.96.78.81 no_post anonymous-read
Nov 4 03:05:31 twilightnode nnrpd[1072929]: Reading access from /usr/local/news/etc/readers.conf
Nov 4 03:05:31 twilightnode nnrpd[1072929]: Auth strategy 'localhost' does not match client. Removing.
Nov 4 03:05:31 twilightnode nnrpd[1072929]: 174.96.78.81 res <anonymous>
Nov 4 03:05:31 twilightnode nnrpd[1072929]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 4 03:05:31 twilightnode nnrpd[1072929]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 4 03:05:31 twilightnode nnrpd[1072929]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 4 03:05:31 twilightnode nnrpd[1072929]: 174.96.78.81 no_post anonymous-read
Nov 4 03:10:05 twilightnode nnrpd[1073308]: Reading access from /usr/local/news/etc/readers.conf
Nov 4 03:10:05 twilightnode nnrpd[1073308]: Auth strategy 'localhost' does not match client. Removing.
Nov 4 03:10:05 twilightnode nnrpd[1073308]: 174.96.78.81 res <anonymous>
Nov 4 03:10:05 twilightnode nnrpd[1073308]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 4 03:10:05 twilightnode nnrpd[1073308]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 4 03:10:05 twilightnode nnrpd[1073308]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 4 03:10:05 twilightnode nnrpd[1073308]: 174.96.78.81 no_post anonymous-read
Nov 4 03:10:05 twilightnode nnrpd[1073310]: Reading access from /usr/local/news/etc/readers.conf
Nov 4 03:10:05 twilightnode nnrpd[1073310]: Auth strategy 'localhost' does not match client. Removing.
Nov 4 03:10:05 twilightnode nnrpd[1073310]: 174.96.78.81 res <anonymous>
Nov 4 03:10:05 twilightnode nnrpd[1073310]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 4 03:10:05 twilightnode nnrpd[1073310]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 4 03:10:05 twilightnode nnrpd[1073310]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 4 03:10:05 twilightnode nnrpd[1073310]: 174.96.78.81 no_post anonymous-read
Nov 4 03:11:42 twilightnode nnrpd[1073323]: Reading access from /usr/local/news/etc/readers.conf
Nov 4 03:11:42 twilightnode nnrpd[1073323]: Auth strategy 'localhost' does not match client. Removing.
Nov 4 03:11:42 twilightnode nnrpd[1073323]: 174.96.78.81 res <anonymous>
Nov 4 03:11:42 twilightnode nnrpd[1073323]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 4 03:11:42 twilightnode nnrpd[1073323]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 4 03:11:42 twilightnode nnrpd[1073323]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 4 03:11:42 twilightnode nnrpd[1073323]: 174.96.78.81 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
inn 7783 68.5%1.3 MB 72.7%
innd 2078 18.3%273.4 KB 14.5%
innfeed 1264 11.1%218.9 KB 11.6%
nnrpd 240 2.1%24.5 KB 1.3%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 11366 100.0%1.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 20416 51.3%
Negative hits 11656 29.3%
Do not exist 7730 19.4%
Cache misses 8 0.0%
TOTAL: 4 39810 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.068 0.0%39 0.000 1.744 3.000
article cleanup00:00:00.055 0.0%7754 0.000 0.007 0.125
article logging00:00:00.256 0.0%7786 0.000 0.033 0.118
article parse00:00:00.145 0.0%12405 0.000 0.012 0.057
article write00:00:08.552 0.0%6411 0.754 1.334 3.538
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.310 0.0%45116 0.000 0.007 0.037
hisgrep/artcncl00:00:00.028 0.0%39 0.000 0.718 1.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.336 0.0%39905 0.071 0.134 0.292
history sync00:00:00.048 0.0%312 0.000 0.154 1.000
history write00:00:04.066 0.0%7754 0.208 0.524 1.111
idle23:59:45.132 99.9%43585 1004.533 1981.992 8697.884
nntp read00:00:01.139 0.0%43291 0.000 0.026 0.079
overview write00:00:07.092 0.0%6411 0.564 1.106 3.364
perl filter00:00:13.036 0.0%7754 0.913 1.681 6.871
python filter00:00:01.218 0.0%7754 0.024 0.157 1.812
site send00:00:00.417 0.0%12766 0.000 0.033 0.139
TOTAL: 1824:00:26.898100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%6493 0.000 0.004 0.273
article prepare00:00:00.000 0.0%27656 0.000 0.000 0.000
article read00:00:01.374 0.0%4669 0.053 0.294 1.000
backlog stats00:00:00.048 0.0%84469 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.641 0.0%47557 0.000 0.013 0.045
data write00:00:01.311 0.0%41220 0.007 0.032 0.085
idle23:58:57.102100.0%84469 375.340 1022.116 3923.026
status file00:00:00.250 0.0%167 0.000 1.497 6.000
TOTAL: 923:59:00.750100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:41.396100.0%23 73.000 1799.826 9777.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%67 0.000 0.015 0.500
TOTAL: 300:00:41.397100.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 3 11091 4469 6554 68 40%48:03:55
2usenet.blueworldhosting.com 56 7717 1312 5227 1178 17%23:55:50
3newsfeed.endofthelinebbs.com 2 6442 460 5887 95 7%28:09:48
4news.sklaffkom.se 37 121 109 11 1 90%11:21:37
5news.tebibyte.org 1 3450 61 3388 1 1%23:59:57
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 124 28821 6411 21067 1343 22%135:31:07
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net14.6 MB0.0 KB171.5 KB14.8 MB 98%3.3 KB
2usenet.blueworldhosting.com9.4 MB0.0 KB2.3 MB11.7 MB 80%4.8 KB
3newsfeed.endofthelinebbs.com8.6 MB0.0 KB140.3 KB8.7 MB 98%16.1 KB
4news.sklaffkom.se311.5 KB0.0 KB0.9 KB312.5 KB 99%2.8 KB
5news.tebibyte.org310.9 KB0.0 KB1.9 KB312.8 KB 99%5.0 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 633.2 MB0.0 KB2.6 MB35.8 MB 92%4.7 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 4 03:00:05 - 03:59:59 112 1.7% 0.03601.0 KB 1.8% 0.17
Nov 4 04:00:00 - 04:59:59 120 1.9% 0.03588.4 KB 1.7% 0.16
Nov 4 05:00:00 - 05:59:59 120 1.9% 0.03439.2 KB 1.3% 0.12
Nov 4 06:00:00 - 06:59:59 162 2.5% 0.04565.3 KB 1.7% 0.16
Nov 4 07:00:00 - 07:59:59 131 2.0% 0.04658.2 KB 2.0% 0.18
Nov 4 08:00:00 - 08:59:59 180 2.8% 0.051.3 MB 3.8% 0.36
Nov 4 09:00:00 - 09:59:59 236 3.7% 0.07817.4 KB 2.4% 0.23
Nov 4 10:00:00 - 10:59:59 320 5.0% 0.092.4 MB 7.2% 0.67
Nov 4 11:00:00 - 11:59:59 305 4.8% 0.081.3 MB 3.9% 0.36
Nov 4 12:00:00 - 12:59:59 304 4.7% 0.081.1 MB 3.2% 0.30
Nov 4 13:00:00 - 13:59:59 265 4.1% 0.071.1 MB 3.3% 0.30
Nov 4 14:00:00 - 14:59:59 334 5.2% 0.091.4 MB 4.2% 0.40
Nov 4 15:00:00 - 15:59:59 337 5.3% 0.091.7 MB 5.2% 0.49
Nov 4 16:00:00 - 16:59:59 395 6.2% 0.111.4 MB 4.3% 0.41
Nov 4 17:00:00 - 17:59:59 373 5.8% 0.101.8 MB 5.6% 0.53
Nov 4 18:00:00 - 18:59:59 422 6.6% 0.121.8 MB 5.6% 0.53
Nov 4 19:00:00 - 19:59:59 406 6.3% 0.112.4 MB 7.2% 0.67
Nov 4 20:00:00 - 20:59:59 349 5.4% 0.101.8 MB 5.5% 0.52
Nov 4 21:00:00 - 21:59:59 380 5.9% 0.112.7 MB 8.2% 0.77
Nov 4 22:00:00 - 22:59:59 296 4.6% 0.081.9 MB 5.8% 0.55
Nov 4 23:00:00 - 23:59:59 303 4.7% 0.081.7 MB 5.3% 0.49
Nov 5 00:00:00 - 00:59:59 246 3.8% 0.071.6 MB 4.9% 0.46
Nov 5 01:00:00 - 01:59:59 168 2.6% 0.05933.5 KB 2.8% 0.26
Nov 5 02:00:00 - 03:00:04 144 2.2% 0.041003.7 KB 3.0% 0.28
TOTAL: 23:59:59 6408 100.0% 0.0732.9 MB 100.0% 0.39
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1178 375 0 0 0 0 0 0 803
2twilightnode-out.news.weretis.net 109 9 0 0 0 0 0 0 100
3newsfeed.endofthelinebbs.com 86 1 0 0 0 0 0 0 85
4news.sklaffkom.se 1 0 0 0 0 0 0 0 1
5news.tebibyte.org 1 0 0 0 0 0 0 0 1
TOTAL: 5 1375 385 0 0 0 0 0 0 990

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 63
grenzland.club 9
alt.test.test.jojo 4
alt.kooks 3
de.soc.recht.datennetze 2
fido.ru.space 2
hispagatos.mastodon.tag.hackers 2
hispagatos.mastodon.tag.hacking 2
alt.rock-n-roll.metal.metallica 1
alt.sys.pdp8 1
alt.test.9 1
chmurka.statystyki 1
christnet.evangelical 1
christnet.general 1
christnet.philosophy 1
fido.su.pol 1
local.general 1
toulouse.test 1
TOTAL: 19 385

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 763
Too many newsgroups 138
User-issued cancel 27
EMP (phn path) 24
HTML Multipart 6
TOTAL: 5 958

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 8579 2131 4049 172 0 0 24%23:59:30
2sklaffkom.se 6456 1061 1817 3474 0 0 16%23:59:15
3newsfeed.endofthelinebbs.com 10425 51 5874 24 0 135 0%23:59:54
4weretis.net 1914 2 1844 0 0 0 0%23:57:50
5usenet.blueworldhosting.com 7828 0 4597 0 0 7 0%23:59:35
TOTAL: 5 35202 3245 18181 3670 0 142 9%119:56:04
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org6.0 MB2.8 MB8.8 MB0.1 KB/s3.9 KB23:59:30
2sklaffkom.se1.8 MB22.7 MB24.5 MB0.3 KB/s5.5 KB23:59:15
3newsfeed.endofthelinebbs.com149.1 KB60.3 KB209.3 KB0.0 KB/s2.8 KB23:59:54
4weretis.net2.4 KB0.0 KB2.4 KB0.0 KB/s1.2 KB23:57:50
5usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:35
TOTAL: 57.9 MB25.5 MB33.5 MB0.1 KB/s5.0 KB119:56:04
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1174.96.78.81 14 00.0 KB 0 0 000:00:18
2118.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:08
313.89.122.168 1 00.0 KB 0 0 000:00:09
4147.185.133.244 1 00.0 KB 0 0 000:00:00
5200.138.46.35 1 00.0 KB 0 0 000:00:00
65-226-140-78.infrawat.ch 1 00.0 KB 0 0 000:00:00
7r3-8-8.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
8r5-129-81.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 8 21 00.0 KB 0 0 000:00:41

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 17 00.0 KB 0 0 000:00:28
2*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
3*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:08
4*.infrawat.ch 1 00.0 KB 0 0 000:00:00
TOTAL: 4 21 00.0 KB 0 0 000:00:41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
174.96.78.81 0.072 0.126 0.00000:00:18
13.89.122.168 0.003 0.017 0.00000:00:09
118.195.132.66.censys-scanner.com 0.027 0.023 0.00000:00:08
r3-8-8.monitoring.internet-measurement.com 0.005 0.013 0.00000:00:01
r5-129-81.monitoring.internet-measurement.com 0.008 0.012 0.00000:00:01
147.185.133.244 0.002 0.017 0.00000:00:00
5-226-140-78.infrawat.ch 0.002 0.012 0.00000:00:00
200.138.46.35 0.004 0.014 0.00000:00:00
TOTAL: 8 0.123 0.234 0.00000:00:41

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

SystemConn
118.195.132.66.censys-scanner.com 1
TOTAL: 1 1

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
5-226-140-78.infrawat.ch 1 1
TOTAL: 1 1 3
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