Daily Usenet report

Jul 2 03:00:05 -- Jul 3 03:00:06

Unknown entries from news log file:

First 50 / 818 lines (6.1%)

Jul 2 03:01:23 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Jul 2 06:13:45 twilightnode nnrpd[3071722]: Reading access from /usr/local/news/etc/readers.conf
Jul 2 06:13:45 twilightnode nnrpd[3071722]: Auth strategy 'localhost' does not match client. Removing.
Jul 2 06:13:45 twilightnode nnrpd[3071722]: shelton.probe.onyphe.net res <anonymous>
Jul 2 06:13:45 twilightnode nnrpd[3071722]: shelton.probe.onyphe.net no_match_user <anonymous> <localhost>
Jul 2 06:13:45 twilightnode nnrpd[3071722]: shelton.probe.onyphe.net no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 2 06:13:45 twilightnode nnrpd[3071722]: shelton.probe.onyphe.net match_user <anonymous> <anonymous>
Jul 2 06:13:45 twilightnode nnrpd[3071722]: shelton.probe.onyphe.net no_post anonymous-read
Jul 2 06:13:46 twilightnode nnrpd[3071723]: Reading access from /usr/local/news/etc/readers.conf
Jul 2 06:13:46 twilightnode nnrpd[3071723]: Auth strategy 'localhost' does not match client. Removing.
Jul 2 06:13:46 twilightnode nnrpd[3071723]: orozco.probe.onyphe.net res <anonymous>
Jul 2 06:13:46 twilightnode nnrpd[3071723]: orozco.probe.onyphe.net no_match_user <anonymous> <localhost>
Jul 2 06:13:46 twilightnode nnrpd[3071723]: orozco.probe.onyphe.net no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 2 06:13:46 twilightnode nnrpd[3071723]: orozco.probe.onyphe.net match_user <anonymous> <anonymous>
Jul 2 06:13:46 twilightnode nnrpd[3071723]: orozco.probe.onyphe.net no_post anonymous-read
Jul 2 06:38:29 twilightnode nnrpd[3079143]: Reading access from /usr/local/news/etc/readers.conf
Jul 2 06:38:29 twilightnode nnrpd[3079143]: Auth strategy 'localhost' does not match client. Removing.
Jul 2 06:38:29 twilightnode nnrpd[3079143]: o342.scanner.modat.io res <anonymous>
Jul 2 06:38:29 twilightnode nnrpd[3079143]: o342.scanner.modat.io no_match_user <anonymous> <localhost>
Jul 2 06:38:29 twilightnode nnrpd[3079143]: o342.scanner.modat.io no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 2 06:38:29 twilightnode nnrpd[3079143]: o342.scanner.modat.io match_user <anonymous> <anonymous>
Jul 2 06:38:29 twilightnode nnrpd[3079143]: o342.scanner.modat.io no_post anonymous-read
Jul 2 06:50:02 twilightnode nnrpd[3079670]: Reading access from /usr/local/news/etc/readers.conf
Jul 2 06:50:02 twilightnode nnrpd[3079670]: Auth strategy 'localhost' does not match client. Removing.
Jul 2 06:50:02 twilightnode nnrpd[3079670]: o347.scanner.modat.io res <anonymous>
Jul 2 06:50:02 twilightnode nnrpd[3079670]: o347.scanner.modat.io no_match_user <anonymous> <localhost>
Jul 2 06:50:02 twilightnode nnrpd[3079670]: o347.scanner.modat.io no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 2 06:50:02 twilightnode nnrpd[3079670]: o347.scanner.modat.io match_user <anonymous> <anonymous>
Jul 2 06:50:02 twilightnode nnrpd[3079670]: o347.scanner.modat.io no_post anonymous-read
Jul 2 07:43:20 twilightnode nnrpd[3081756]: Reading access from /usr/local/news/etc/readers.conf
Jul 2 07:43:20 twilightnode nnrpd[3081756]: Auth strategy 'localhost' does not match client. Removing.
Jul 2 07:43:20 twilightnode nnrpd[3081756]: 193.176.29.2 res <anonymous>
Jul 2 07:43:20 twilightnode nnrpd[3081756]: 193.176.29.2 no_match_user <anonymous> <localhost>
Jul 2 07:43:20 twilightnode nnrpd[3081756]: 193.176.29.2 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 2 07:43:20 twilightnode nnrpd[3081756]: 193.176.29.2 match_user <anonymous> <anonymous>
Jul 2 07:43:20 twilightnode nnrpd[3081756]: 193.176.29.2 no_post anonymous-read
Jul 2 07:43:28 twilightnode nnrpd[3081757]: Reading access from /usr/local/news/etc/readers.conf
Jul 2 07:43:28 twilightnode nnrpd[3081757]: Auth strategy 'localhost' does not match client. Removing.
Jul 2 07:43:28 twilightnode nnrpd[3081757]: 194.88.98.87 res <anonymous>
Jul 2 07:43:28 twilightnode nnrpd[3081757]: 194.88.98.87 no_match_user <anonymous> <localhost>
Jul 2 07:43:28 twilightnode nnrpd[3081757]: 194.88.98.87 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 2 07:43:28 twilightnode nnrpd[3081757]: 194.88.98.87 match_user <anonymous> <anonymous>
Jul 2 07:43:28 twilightnode nnrpd[3081757]: 194.88.98.87 no_post anonymous-read
Jul 2 08:39:16 twilightnode nnrpd[3083969]: Reading access from /usr/local/news/etc/readers.conf
Jul 2 08:39:16 twilightnode nnrpd[3083969]: Auth strategy 'localhost' does not match client. Removing.
Jul 2 08:39:16 twilightnode nnrpd[3083969]: azpdwsj742d0.stretchoid.com res <anonymous>
Jul 2 08:39:16 twilightnode nnrpd[3083969]: azpdwsj742d0.stretchoid.com no_match_user <anonymous> <localhost>
Jul 2 08:39:16 twilightnode nnrpd[3083969]: azpdwsj742d0.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 2 08:39:16 twilightnode nnrpd[3083969]: azpdwsj742d0.stretchoid.com match_user <anonymous> <anonymous>
Jul 2 08:39:16 twilightnode nnrpd[3083969]: azpdwsj742d0.stretchoid.com no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
innfeed 41208 83.1%5.6 MB 78.9%
inn 6156 12.4%1.2 MB 16.2%
innd 1145 2.3%231.5 KB 3.2%
nnrpd 1086 2.2%127.0 KB 1.7%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 49597 100.0%7.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 14908 51.1%
Negative hits 8157 27.9%
Do not exist 6122 21.0%
Cache misses 2 0.0%
TOTAL: 4 29189 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.010 0.0%4 0.000 2.500 3.500
article cleanup00:00:00.069 0.0%6152 0.000 0.011 0.167
article logging00:00:00.275 0.0%6156 0.000 0.045 0.684
article parse00:00:00.106 0.0%8447 0.000 0.013 0.087
article write00:00:04.393 0.0%4430 0.500 0.992 2.387
data move00:00:00.124 0.0%31510 0.000 0.004 0.053
hisgrep/artcncl00:00:00.003 0.0%4 0.000 0.750 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.606 0.0%29313 0.081 0.157 0.455
history sync00:00:00.061 0.0%412 0.000 0.148 2.000
history write00:00:03.231 0.0%6152 0.059 0.525 1.414
idle24:00:33.598100.0%31221 1487.896 2768.444 9689.645
nntp read00:00:00.780 0.0%30741 0.000 0.025 0.092
overview write00:00:02.405 0.0%4430 0.220 0.543 4.545
perl filter00:00:10.773 0.0%6152 1.100 1.751 14.889
python filter00:00:00.875 0.0%6152 0.000 0.142 1.500
site send00:00:00.145 0.0%4430 0.000 0.033 0.167
TOTAL: 1724:01:01.454100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.027 0.0%10246 0.000 0.003 0.027
article prepare00:00:00.006 0.0%26872 0.000 0.000 0.007
article read00:00:00.823 0.0%4674 0.021 0.176 0.824
backlog stats00:00:00.086 0.0%68275 0.000 0.001 0.019
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.510 0.0%32999 0.000 0.015 0.046
data write00:00:00.850 0.0%28671 0.000 0.030 0.086
idle23:49:42.688100.0%68275 872.361 1256.429 1767.438
status file00:00:10.091 0.0%16931 0.379 0.596 0.983
TOTAL: 923:49:55.081100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:01.927100.0%88 14.500 703.716 10447.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.006 0.0%295 0.000 0.020 0.333
TOTAL: 300:01:01.933100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 9 12176 3940 6970 1266 32%52:17:03
2newsfeed.endofthelinebbs.com 2 5018 417 4171 430 8%25:37:19
3news.sklaffkom.se 42 115 87 27 1 75%12:04:38
4news.tebibyte.org 1 5999 68 5897 34 1%23:59:52
5localhost 25 0 0 0 0 0%00:00:00
6news.chimia.se 1 0 0 0 0 0%00:10:00
TOTAL: 6 80 23308 4512 17065 1731 19%114:08:52
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net10.9 MB0.0 KB4.6 MB15.5 MB 70%3.1 KB
2newsfeed.endofthelinebbs.com4.9 MB0.0 KB741.4 KB5.6 MB 87%6.8 KB
3news.sklaffkom.se659.8 KB0.0 KB8.3 KB668.0 KB 98%7.6 KB
4news.tebibyte.org285.6 KB0.0 KB132.9 KB418.5 KB 68%4.1 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
6news.chimia.se0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 616.7 MB0.0 KB5.5 MB22.2 MB 75%3.6 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 2 03:00:05 - 03:59:59 79 1.8% 0.02241.3 KB 1.5% 0.07
Jul 2 04:00:00 - 04:59:59 95 2.1% 0.03293.3 KB 1.8% 0.08
Jul 2 05:00:00 - 05:59:59 147 3.3% 0.041.0 MB 6.6% 0.30
Jul 2 06:00:00 - 06:59:59 166 3.7% 0.05462.6 KB 2.8% 0.13
Jul 2 07:00:00 - 07:59:59 122 2.8% 0.03364.0 KB 2.2% 0.10
Jul 2 08:00:00 - 08:59:59 129 2.9% 0.04419.1 KB 2.6% 0.12
Jul 2 09:00:00 - 09:59:59 213 4.8% 0.06657.5 KB 4.0% 0.18
Jul 2 10:00:00 - 10:59:59 260 5.9% 0.07774.5 KB 4.7% 0.22
Jul 2 11:00:00 - 11:59:59 179 4.0% 0.05736.8 KB 4.5% 0.20
Jul 2 12:00:00 - 12:59:59 170 3.8% 0.05609.4 KB 3.7% 0.17
Jul 2 13:00:00 - 13:59:59 184 4.2% 0.05911.3 KB 5.6% 0.25
Jul 2 14:00:00 - 14:59:59 232 5.2% 0.061.1 MB 6.8% 0.31
Jul 2 15:00:00 - 15:59:59 241 5.4% 0.07836.3 KB 5.1% 0.23
Jul 2 16:00:00 - 16:59:59 252 5.7% 0.071.0 MB 6.5% 0.29
Jul 2 17:00:00 - 17:59:59 238 5.4% 0.07695.5 KB 4.3% 0.19
Jul 2 18:00:00 - 18:59:59 238 5.4% 0.07616.5 KB 3.8% 0.17
Jul 2 19:00:00 - 19:59:59 226 5.1% 0.06705.9 KB 4.3% 0.20
Jul 2 20:00:00 - 20:59:59 230 5.2% 0.06666.0 KB 4.1% 0.19
Jul 2 21:00:00 - 21:59:59 248 5.6% 0.07823.3 KB 5.0% 0.23
Jul 2 22:00:00 - 22:59:59 214 4.8% 0.061.2 MB 7.6% 0.34
Jul 2 23:00:00 - 23:59:59 196 4.4% 0.05708.0 KB 4.3% 0.20
Jul 3 00:00:00 - 00:59:59 162 3.7% 0.04670.9 KB 4.1% 0.19
Jul 3 01:00:00 - 01:59:59 106 2.4% 0.03419.1 KB 2.6% 0.12
Jul 3 02:00:00 - 02:59:59 96 2.2% 0.03235.3 KB 1.4% 0.07
Jul 3 03:00:00 - 03:00:06 9 0.2% 1.507.4 KB 0.0% 1.23
TOTAL: 24:00:01 4432 100.0% 0.0515.9 MB 100.0% 0.19
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1292 1276 0 0 0 0 0 0 16
2newsfeed.endofthelinebbs.com 391 67 0 0 0 0 0 0 324
3news.tebibyte.org 39 38 0 0 0 0 0 0 1
4news.sklaffkom.se 2 2 0 0 0 0 0 0 0
TOTAL: 4 1724 1383 0 0 0 0 0 0 341

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.usage.english 91
it.hobby.cucina 65
fido7.ru.home 59
de.alt.talk.unmut 48
alt.recovery.aa 44
alt.checkmate 43
linux.debian.maint.ocaml.maint 34
fr.sci.maths 28
pl.misc.elektronika 28
pl.biznes.banki 26
bln.test 25
uk.legal.moderated 25
fido7.su.tormoz 23
pl.soc.prawo 23
alt.slack 21
de.soc.umwelt 20
hfx.general 20
muc.lists.freebsd.bugs 20
cn.comp 19
de.talk.jokes 18
TOTAL: 217 1383

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 326
Too many newsgroups 6
User-issued cancel 4
HTML Multipart 1
TOTAL: 4 337

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1chimia.se 4433 4419 0 12 0 1 99%23:59:38
2sklaffkom.se 4734 776 2105 1539 0 267 16%23:59:55
3news.tebibyte.org 2836 0 0 0 0 7255 0%23:59:55
4newsfeed.endofthelinebbs.com 2773 0 0 0 0 6834 0%23:59:54
5weretis.net 564 0 513 0 0 0 0%22:25:33
6sklaff.dev 0 0 0 0 0 4419 0%23:59:31
7thebunker.nu 0 0 0 0 0 4432 0%23:59:20
8usenet.blueworldhosting.com 0 0 0 0 0 3982 0%23:59:55
TOTAL: 8 15340 5195 2618 1551 0 27190 33%190:23:41
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1chimia.se15.9 MB21.9 KB15.9 MB0.2 KB/s3.7 KB23:59:38
2sklaffkom.se1.3 MB7.8 MB9.1 MB0.1 KB/s4.0 KB23:59:55
3news.tebibyte.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
4newsfeed.endofthelinebbs.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
5sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:31
6thebunker.nu0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:20
7usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
8weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s022:25:33
TOTAL: 817.2 MB7.8 MB25.0 MB0.0 KB/s3.8 KB190:23:41
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1prod47client01.academyforinternetresearch.org 60 00.0 KB 0 0 000:00:33
2134.122.61.120 6 00.0 KB 0 0 000:00:06
3azpdwsj742d0.stretchoid.com 2 00.0 KB 0 0 000:00:10
4193.176.29.2 1 00.0 KB 0 0 000:00:00
5194.88.98.87 1 00.0 KB 0 0 000:00:00
6236.224.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
747.245.131.237 1 00.0 KB 0 0 000:00:03
8o342.scanner.modat.io 1 00.0 KB 0 0 000:00:00
9o347.scanner.modat.io 1 00.0 KB 0 0 000:00:00
10orozco.probe.onyphe.net 1 00.0 KB 0 0 000:00:02
11shelton.probe.onyphe.net 1 00.0 KB 0 0 000:00:00
TOTAL: 11 76 00.0 KB 0 0 000:01:01

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.academyforinternetresearch.org 60 00.0 KB 0 0 000:00:33
2unresolved 9 00.0 KB 0 0 000:00:10
3*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
4*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
5*.stretchoid.com 2 00.0 KB 0 0 000:00:10
6*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
TOTAL: 6 76 00.0 KB 0 0 000:01:01

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
prod47client01.academyforinternetresearch.org 1.527 0.513 0.00000:00:33
azpdwsj742d0.stretchoid.com 0.010 0.042 0.00000:00:10
134.122.61.120 0.017 0.054 0.00000:00:06
47.245.131.237 0.007 0.038 0.00000:00:03
orozco.probe.onyphe.net 0.004 0.006 0.00000:00:02
236.224.132.66.censys-scanner.com 0.036 0.019 0.00000:00:02
shelton.probe.onyphe.net 0.006 0.014 0.00000:00:00
o347.scanner.modat.io 0.005 0.010 0.00000:00:00
194.88.98.87 0.001 0.008 0.00000:00:00
193.176.29.2 0.001 0.017 0.00000:00:00
o342.scanner.modat.io 0.004 0.013 0.00000:00:00
TOTAL: 11 1.618 0.734 0.00000:01:01

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

SystemConn
134.122.61.120 11
shelton.probe.onyphe.net 3
236.224.132.66.censys-scanner.com 1
azpdwsj742d0.stretchoid.com 1
TOTAL: 4 16

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

CommandCount
#023#003#023#001#023#002#001 1
#026#003#001 1
#026#003#003#002c#001 1
$4 1
*1 1
? <#014 ?`?1(=?#032#023(?B?b?4?2K#017>#026.#033?!? 1
?$?,?r?s?#023#002#023#001?#024?#007?#022?#023?'?/?#024?(?0?`?a... 1
?0?#007]#037#020?#034G9? 1
Accept-Encoding: gzip 1
Accept: */* 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
PING 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
TOTAL: 16 16

NNRP client timeouts [Top 20]:

SystemConnPeer
134.122.61.120 1 3
194.88.98.87 1 1
47.245.131.237 1 1
prod47client01.academyforinternetresearch.org 1 1
TOTAL: 4 4 7
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