Daily Usenet report

Oct 21 03:00:05 -- Oct 22 03:00:04

Unknown entries from news log file:

First 50 / 774 lines (6.5%)

Oct 21 03:01:15 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Oct 21 03:10:32 twilightnode nnrpd[30328]: Reading access from /usr/local/news/etc/readers.conf
Oct 21 03:10:32 twilightnode nnrpd[30328]: Auth strategy 'localhost' does not match client. Removing.
Oct 21 03:10:32 twilightnode nnrpd[30328]: 174.96.78.81 res <anonymous>
Oct 21 03:10:32 twilightnode nnrpd[30328]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 21 03:10:32 twilightnode nnrpd[30328]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 21 03:10:32 twilightnode nnrpd[30328]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 21 03:10:32 twilightnode nnrpd[30328]: 174.96.78.81 no_post anonymous-read
Oct 21 03:10:32 twilightnode nnrpd[30329]: Reading access from /usr/local/news/etc/readers.conf
Oct 21 03:10:32 twilightnode nnrpd[30329]: Auth strategy 'localhost' does not match client. Removing.
Oct 21 03:10:32 twilightnode nnrpd[30329]: 174.96.78.81 res <anonymous>
Oct 21 03:10:32 twilightnode nnrpd[30329]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 21 03:10:32 twilightnode nnrpd[30329]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 21 03:10:32 twilightnode nnrpd[30329]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 21 03:10:32 twilightnode nnrpd[30329]: 174.96.78.81 no_post anonymous-read
Oct 21 04:14:30 twilightnode nnrpd[33010]: Reading access from /usr/local/news/etc/readers.conf
Oct 21 04:14:30 twilightnode nnrpd[33010]: Auth strategy 'localhost' does not match client. Removing.
Oct 21 04:14:30 twilightnode nnrpd[33010]: 174.96.78.81 res <anonymous>
Oct 21 04:14:30 twilightnode nnrpd[33010]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 21 04:14:30 twilightnode nnrpd[33010]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 21 04:14:30 twilightnode nnrpd[33010]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 21 04:14:30 twilightnode nnrpd[33010]: 174.96.78.81 no_post anonymous-read
Oct 21 04:14:31 twilightnode nnrpd[33011]: Reading access from /usr/local/news/etc/readers.conf
Oct 21 04:14:31 twilightnode nnrpd[33011]: Auth strategy 'localhost' does not match client. Removing.
Oct 21 04:14:31 twilightnode nnrpd[33011]: 174.96.78.81 res <anonymous>
Oct 21 04:14:31 twilightnode nnrpd[33011]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 21 04:14:31 twilightnode nnrpd[33011]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 21 04:14:31 twilightnode nnrpd[33011]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 21 04:14:31 twilightnode nnrpd[33011]: 174.96.78.81 no_post anonymous-read
Oct 21 04:46:05 twilightnode nnrpd[34552]: Reading access from /usr/local/news/etc/readers.conf
Oct 21 04:46:05 twilightnode nnrpd[34552]: Auth strategy 'localhost' does not match client. Removing.
Oct 21 04:46:05 twilightnode nnrpd[34552]: 203.55.131.5 res <anonymous>
Oct 21 04:46:05 twilightnode nnrpd[34552]: 203.55.131.5 no_match_user <anonymous> <localhost>
Oct 21 04:46:05 twilightnode nnrpd[34552]: 203.55.131.5 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 21 04:46:05 twilightnode nnrpd[34552]: 203.55.131.5 match_user <anonymous> <anonymous>
Oct 21 04:46:05 twilightnode nnrpd[34552]: 203.55.131.5 no_post anonymous-read
Oct 21 05:18:21 twilightnode nnrpd[35869]: Reading access from /usr/local/news/etc/readers.conf
Oct 21 05:18:21 twilightnode nnrpd[35869]: Auth strategy 'localhost' does not match client. Removing.
Oct 21 05:18:21 twilightnode nnrpd[35869]: 174.96.78.81 res <anonymous>
Oct 21 05:18:21 twilightnode nnrpd[35869]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 21 05:18:21 twilightnode nnrpd[35869]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 21 05:18:21 twilightnode nnrpd[35869]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 21 05:18:21 twilightnode nnrpd[35869]: 174.96.78.81 no_post anonymous-read
Oct 21 05:18:22 twilightnode nnrpd[35870]: Reading access from /usr/local/news/etc/readers.conf
Oct 21 05:18:22 twilightnode nnrpd[35870]: Auth strategy 'localhost' does not match client. Removing.
Oct 21 05:18:22 twilightnode nnrpd[35870]: 174.96.78.81 res <anonymous>
Oct 21 05:18:22 twilightnode nnrpd[35870]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 21 05:18:22 twilightnode nnrpd[35870]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 21 05:18:22 twilightnode nnrpd[35870]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 21 05:18:22 twilightnode nnrpd[35870]: 174.96.78.81 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 20312 59.8%1.7 MB 42.4%
inn 9356 27.6%1.7 MB 42.3%
innd 3024 8.9%425.0 KB 10.5%
innfeed 1266 3.7%193.2 KB 4.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 33959 100.0%3.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24306 51.0%
Negative hits 13983 29.4%
Do not exist 9324 19.6%
Cache misses 0 0.0%
TOTAL: 4 47613 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.077 0.0%33 2.000 2.333 5.000
article cleanup00:00:00.162 0.0%9347 0.000 0.017 0.105
article logging00:00:00.433 0.0%9362 0.000 0.046 0.194
article parse00:00:00.224 0.0%13013 0.000 0.017 0.067
article write00:00:10.688 0.0%8047 0.744 1.328 4.326
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.308 0.0%50915 0.000 0.006 0.126
hisgrep/artcncl00:00:00.037 0.0%33 0.000 1.121 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.491 0.0%47740 0.086 0.157 0.476
history sync00:00:00.087 0.0%403 0.000 0.216 5.000
history write00:00:05.535 0.0%9348 0.138 0.592 1.439
idle23:59:43.822 99.9%51023 825.382 1693.037 13344.311
nntp read00:00:01.347 0.0%50256 0.000 0.027 0.130
overview write00:00:07.602 0.0%8047 0.485 0.945 4.188
perl filter00:00:22.087 0.0%9347 1.526 2.363 9.786
python filter00:00:01.862 0.0%9347 0.060 0.199 1.222
site send00:00:00.654 0.0%16057 0.000 0.041 0.222
TOTAL: 1824:00:42.416100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.095 0.0%8497 0.000 0.011 0.167
article prepare00:00:00.003 0.0%35372 0.000 0.000 0.004
article read00:00:01.824 0.0%5555 0.094 0.328 1.875
backlog stats00:00:00.099 0.0%106627 0.000 0.001 0.012
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.121 0.0%60985 0.000 0.018 0.062
data write00:00:01.746 0.0%52888 0.000 0.033 0.093
idle23:58:19.545100.0%106627 280.441 809.359 4934.951
status file00:00:00.269 0.0%165 0.000 1.630 14.000
TOTAL: 923:58:24.702100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:47:02.913 99.6%26376 105.500 243.514 9846.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:25.663 0.4%67826 0.000 0.378 3.300
readart00:00:02.257 0.0%3534 0.000 0.639 1.333
TOTAL: 401:47:30.833100.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 4 16581 5435 11110 36 32%52:27:37
2usenet.blueworldhosting.com 288 9210 2237 5740 1233 24%23:44:21
3newsfeed.endofthelinebbs.com 2 5887 179 5666 42 3%24:59:21
4news.sklaffkom.se 48 146 120 25 1 82%15:13:34
5news.tebibyte.org 1 694 38 656 0 5%07:11:57
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 368 32518 8009 23197 1312 24%123:36:50
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net16.6 MB0.0 KB50.9 KB16.7 MB 99%3.1 KB
2usenet.blueworldhosting.com11.0 MB0.0 KB2.2 MB13.2 MB 83%3.9 KB
3newsfeed.endofthelinebbs.com2.2 MB0.0 KB65.4 KB2.3 MB 97%10.5 KB
4news.sklaffkom.se389.4 KB0.0 KB0.9 KB390.4 KB 99%3.2 KB
5news.tebibyte.org115.4 KB0.0 KB0.0 KB115.4 KB100%3.0 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 630.3 MB0.0 KB2.3 MB32.7 MB 92%3.6 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 21 03:00:05 - 03:59:59 119 1.5% 0.03488.7 KB 1.5% 0.14
Oct 21 04:00:00 - 04:59:59 117 1.5% 0.03727.1 KB 2.2% 0.20
Oct 21 05:00:00 - 05:59:59 71 0.9% 0.02362.6 KB 1.1% 0.10
Oct 21 06:00:00 - 06:59:59 126 1.6% 0.04527.7 KB 1.6% 0.15
Oct 21 07:00:00 - 07:59:59 141 1.8% 0.04722.8 KB 2.2% 0.20
Oct 21 08:00:00 - 08:59:59 217 2.7% 0.061.4 MB 4.5% 0.40
Oct 21 09:00:00 - 09:59:59 516 6.4% 0.141.5 MB 4.8% 0.44
Oct 21 10:00:00 - 10:59:59 502 6.2% 0.141.3 MB 4.0% 0.36
Oct 21 11:00:00 - 11:59:59 509 6.3% 0.141.4 MB 4.3% 0.39
Oct 21 12:00:00 - 12:59:59 512 6.4% 0.141.7 MB 5.2% 0.47
Oct 21 13:00:00 - 13:59:59 553 6.9% 0.151.8 MB 5.7% 0.52
Oct 21 14:00:00 - 14:59:59 478 5.9% 0.131.8 MB 5.5% 0.50
Oct 21 15:00:00 - 15:59:59 466 5.8% 0.131.5 MB 4.8% 0.43
Oct 21 16:00:00 - 16:59:59 494 6.1% 0.141.6 MB 5.2% 0.47
Oct 21 17:00:00 - 17:59:59 511 6.4% 0.141.9 MB 6.0% 0.55
Oct 21 18:00:00 - 18:59:59 461 5.7% 0.132.4 MB 7.4% 0.67
Oct 21 19:00:00 - 19:59:59 448 5.6% 0.121.6 MB 4.9% 0.44
Oct 21 20:00:00 - 20:59:59 370 4.6% 0.101.4 MB 4.3% 0.39
Oct 21 21:00:00 - 21:59:59 304 3.8% 0.081.1 MB 3.5% 0.31
Oct 21 22:00:00 - 22:59:59 253 3.1% 0.07986.8 KB 3.0% 0.27
Oct 21 23:00:00 - 23:59:59 302 3.8% 0.081.2 MB 3.7% 0.34
Oct 22 00:00:00 - 00:59:59 192 2.4% 0.052.0 MB 6.1% 0.56
Oct 22 01:00:00 - 01:59:59 199 2.5% 0.062.0 MB 6.2% 0.56
Oct 22 02:00:00 - 03:00:04 178 2.2% 0.05739.8 KB 2.3% 0.21
TOTAL: 23:59:59 8039 100.0% 0.0931.9 MB 100.0% 0.38
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1234 355 0 0 0 0 0 0 879
2twilightnode-out.news.weretis.net 41 5 0 0 0 0 0 0 36
3newsfeed.endofthelinebbs.com 40 2 0 0 0 0 0 0 38
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 1317 362 0 0 0 0 0 0 955

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 38
hispagatos.mastodon.tag.hacking 24
be.politics 2
grenzland.club 2
hispagatos.test 2
alt.bbs.files-announce 1
alt.fun 1
alt.journalism.newspapers 1
alt.sports.basketball.nba.la-lakers 1
chmurka.statystyki 1
linux.debian.ports.mips 1
TOTAL: 12 362

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 793
Too many newsgroups 125
User-issued cancel 21
TOTAL: 3 939

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
twilightnode-out.news.weretis.net 15
TOTAL: 1 15
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 16

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 10942 3196 4669 138 0 7 29%23:59:54
2sklaffkom.se 8426 1134 2586 4282 0 59 13%23:59:54
3newsfeed.endofthelinebbs.com 14034 51 7746 43 0 425 0%23:59:54
4weretis.net 2803 3 2715 1 0 0 0%23:56:52
5usenet.blueworldhosting.com 9318 0 5530 0 0 4 0%23:59:47
TOTAL: 5 45523 4384 23246 4464 0 495 9%119:56:21
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org7.7 MB1.2 MB8.9 MB0.1 KB/s2.7 KB23:59:54
2sklaffkom.se1.8 MB21.5 MB23.3 MB0.3 KB/s4.4 KB23:59:54
3newsfeed.endofthelinebbs.com181.1 KB108.5 KB289.6 KB0.0 KB/s3.1 KB23:59:54
4weretis.net4.2 KB139.3 KB143.5 KB0.0 KB/s35.9 KB23:56:52
5usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
TOTAL: 59.7 MB23.0 MB32.7 MB0.1 KB/s3.8 KB119:56:21
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1174.96.78.81 100 3534120.8 MB 211 0 001:47:15
TOTAL: 1 100 3534120.8 MB 211 0 001:47:15

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 102 3534120.8 MB 211 0 001:47:16
2*.167.censys-scanner.com 3 00.0 KB 0 0 000:00:00
3*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:01
4*.infrawat.ch 1 00.0 KB 0 0 000:00:00
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
6*.stretchoid.com 1 00.0 KB 0 0 000:00:09
TOTAL: 6 109 3534120.8 MB 211 0 001:47:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
174.96.78.81 8.019 29.372 0.00001:47:15
azpdssfl1m4f.stretchoid.com 0.006 0.011 0.00000:00:09
r3-59-3b.monitoring.internet-measurement.com 0.007 0.018 0.00000:00:01
138.172.132.66.censys-scanner.com 0.032 0.026 0.00000:00:01
60.146.94.167.censys-scanner.com 0.036 0.025 0.00000:00:00
5-226-140-116.infrawat.ch 0.006 0.026 0.00000:00:00
86.38.187.86 0.011 0.015 0.00000:00:00
203.55.131.5 0.008 0.035 0.00000:00:00
TOTAL: 8 8.125 29.528 0.00001:47:30

Curious NNRP explorers [Top 20]:

SystemConn
60.146.94.167.censys-scanner.com 3
138.172.132.66.censys-scanner.com 1
203.55.131.5 1
5-226-140-116.infrawat.ch 1
86.38.187.86 1
azpdssfl1m4f.stretchoid.com 1
r3-59-3b.monitoring.internet-measurement.com 1
TOTAL: 7 9

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

SystemConn
138.172.132.66.censys-scanner.com 1
60.146.94.167.censys-scanner.com 1
TOTAL: 2 2

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
174.96.78.81 2 0
5-226-140-116.infrawat.ch 1 1
60.146.94.167.censys-scanner.com 1 2
TOTAL: 3 4 4

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

HierarchyCountPct
1alt 1400 39.6%
2microsoft 1170 33.1%
3free 426 12.1%
4linux 292 8.3%
5aus 41 1.2%
6de 37 1.0%
7it 29 0.8%
8uk 27 0.8%
9lada 17 0.5%
10rec 17 0.5%
11pl 13 0.4%
12comp 9 0.3%
13talk 9 0.3%
14junk 7 0.2%
15eternal-september 6 0.2%
16cn 5 0.1%
17ger 5 0.1%
18nl 4 0.1%
19sci 4 0.1%
20sfnet 4 0.1%
21dk 3 0.1%
22fr 3 0.1%
23news 2 0.1%
24misc 1 0.0%
25muc 1 0.0%
26nz 1 0.0%
27tp 1 0.0%
TOTAL: 27 3534100.0%

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

NewsgroupCount
1alt.anonymous.messages 932
2microsoft.public.windowsxp.general 702
3microsoft.public.windowsxp.help_and_support 468
4alt.test 433
5free.usenet 421
6linux.kernel.netdev 243
7aus.cars 31
8de.etc.fahrzeug.auto 27
9linux.debian.changes.devel 21
10uk.tech.digital-tv 20
11lada.talk 17
12it.hobby.fai-da-te 15
13aus.politics 10
14linux.debian.bugs.dist 9
15linux.debian.bugs.rc 9
16alt.fan.rush-limbaugh 8
17pl.soc.polityka 8
18rec.arts.sf.written 8
19junk 7
20linux.debian.user 6
21rec.food.cooking 6
22comp.os.linux.misc 5
23ger.ct 5
24alt.arts.poetry.comments 4
25alt.privacy.anon-server 4
26cn.test 4
27de.soc.politik.misc 4
28free.pt 4
29it.discussioni.auto 4
30nl.politiek 4
31pl.misc.elektronika 4
32sfnet.keskustelu.varaventtiili 4
33talk.politics.guns 4
34talk.politics.misc 4
35alt.privacy.anon-server.stats 3
36de.comp.security.misc 3
37dk.politik 3
38eternal-september.config 3
39it.discussioni.geometri 3
40uk.railway 3
41alt.computer.workshop 2
42alt.jobs 2
43comp.text.tex 2
44de.talk.tagesgeschehen 2
45eternal-september.support 2
46fr.comp.usenet.lecteurs-de-news 2
47it.politica 2
48it.sport.calcio.inter-fc 2
49linux.debian.kernel 2
50linux.kernel.git 2
51news.lists.filters 2
52sci.electronics.design 2
53uk.legal 2
54alt.atheism 1
55alt.checkmate 1
56alt.christnet.christianlife 1
57alt.comp.freeware 1
58alt.jobs.offered 1
59alt.poetry 1
60alt.politics 1
61alt.politics.trump 1
62alt.prophecies.nostradamus 1
63alt.russian.z1 1
64alt.test.test 1
65alt.usage.english 1
66cn.fan 1
67comp.arch 1
68comp.os.linux.advocacy 1
69de.comp.os.unix.linux.misc 1
70eternal-september.grouprequests 1
71fr.sci.electronique 1
72free.it.scienza.fisica 1
73it.fan.tv 1
74it.sport.calcio.milan 1
75it.tlc.cellulari.android 1
76misc.jobs.contract 1
77muc.lists.freebsd.security.notifications 1
78nz.general 1
79pl.misc.samochody 1
80rec.arts.anime.misc 1
81rec.arts.poems 1
82rec.arts.sf.movies 1
83sci.med 1
84sci.med.cardiology 1
85talk.religion.newage 1
86tp.test 1
87uk.net.news.moderation 1
88uk.telecom.broadband 1
TOTAL: 88 3534