Daily Usenet report

Nov 7 03:00:05 -- Nov 8 03:00:04

Unknown entries from news log file:

First 50 / 13950 lines (0.4%)

Nov 7 03:01:12 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Nov 7 05:48:48 twilightnode nnrpd[1281176]: Reading access from /usr/local/news/etc/readers.conf
Nov 7 05:48:48 twilightnode nnrpd[1281176]: Auth strategy 'localhost' does not match client. Removing.
Nov 7 05:48:48 twilightnode nnrpd[1281176]: 147.185.132.146 res <anonymous>
Nov 7 05:48:48 twilightnode nnrpd[1281176]: 147.185.132.146 no_match_user <anonymous> <localhost>
Nov 7 05:48:48 twilightnode nnrpd[1281176]: 147.185.132.146 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 7 05:48:48 twilightnode nnrpd[1281176]: 147.185.132.146 match_user <anonymous> <anonymous>
Nov 7 05:48:48 twilightnode nnrpd[1281176]: 147.185.132.146 no_post anonymous-read
Nov 7 10:36:37 twilightnode nnrpd[1299329]: Reading access from /usr/local/news/etc/readers.conf
Nov 7 10:36:37 twilightnode nnrpd[1299329]: Auth strategy 'localhost' does not match client. Removing.
Nov 7 10:36:37 twilightnode nnrpd[1299329]: 204.186.132.66.censys-scanner.com res <anonymous>
Nov 7 10:36:37 twilightnode nnrpd[1299329]: 204.186.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Nov 7 10:36:37 twilightnode nnrpd[1299329]: 204.186.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 7 10:36:37 twilightnode nnrpd[1299329]: 204.186.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Nov 7 10:36:37 twilightnode nnrpd[1299329]: 204.186.132.66.censys-scanner.com no_post anonymous-read
Nov 7 10:36:40 twilightnode nnrpd[1299329]: 204.186.132.66.censys-scanner.com res <anonymous>
Nov 7 10:36:40 twilightnode nnrpd[1299329]: 204.186.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Nov 7 10:36:40 twilightnode nnrpd[1299329]: 204.186.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 7 10:36:40 twilightnode nnrpd[1299329]: 204.186.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Nov 7 10:36:40 twilightnode nnrpd[1299329]: 204.186.132.66.censys-scanner.com no_post anonymous-read
Nov 7 14:33:17 twilightnode nnrpd[1310399]: Reading access from /usr/local/news/etc/readers.conf
Nov 7 14:33:17 twilightnode nnrpd[1310399]: Auth strategy 'localhost' does not match client. Removing.
Nov 7 14:33:17 twilightnode nnrpd[1310399]: o315.scanner.modat.io res <anonymous>
Nov 7 14:33:17 twilightnode nnrpd[1310399]: o315.scanner.modat.io no_match_user <anonymous> <localhost>
Nov 7 14:33:17 twilightnode nnrpd[1310399]: o315.scanner.modat.io no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 7 14:33:17 twilightnode nnrpd[1310399]: o315.scanner.modat.io match_user <anonymous> <anonymous>
Nov 7 14:33:17 twilightnode nnrpd[1310399]: o315.scanner.modat.io no_post anonymous-read
Nov 7 16:32:13 twilightnode nnrpd[1315729]: Reading access from /usr/local/news/etc/readers.conf
Nov 7 16:32:13 twilightnode nnrpd[1315729]: Auth strategy 'localhost' does not match client. Removing.
Nov 7 16:32:13 twilightnode nnrpd[1315729]: r4-91-5b.monitoring.internet-measurement.com res <anonymous>
Nov 7 16:32:13 twilightnode nnrpd[1315729]: r4-91-5b.monitoring.internet-measurement.com no_match_user <anonymous> <localhost>
Nov 7 16:32:13 twilightnode nnrpd[1315729]: r4-91-5b.monitoring.internet-measurement.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 7 16:32:13 twilightnode nnrpd[1315729]: r4-91-5b.monitoring.internet-measurement.com match_user <anonymous> <anonymous>
Nov 7 16:32:13 twilightnode nnrpd[1315729]: r4-91-5b.monitoring.internet-measurement.com no_post anonymous-read
Nov 7 18:20:43 twilightnode nnrpd[1320594]: Reading access from /usr/local/news/etc/readers.conf
Nov 7 18:20:43 twilightnode nnrpd[1320594]: Auth strategy 'localhost' does not match client. Removing.
Nov 7 18:20:43 twilightnode nnrpd[1320594]: 174.96.78.81 res <anonymous>
Nov 7 18:20:43 twilightnode nnrpd[1320594]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 7 18:20:43 twilightnode nnrpd[1320594]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 7 18:20:43 twilightnode nnrpd[1320594]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 7 18:20:43 twilightnode nnrpd[1320594]: 174.96.78.81 no_post anonymous-read
Nov 7 18:20:44 twilightnode nnrpd[1320595]: Reading access from /usr/local/news/etc/readers.conf
Nov 7 18:20:44 twilightnode nnrpd[1320595]: Auth strategy 'localhost' does not match client. Removing.
Nov 7 18:20:44 twilightnode nnrpd[1320595]: 174.96.78.81 res <anonymous>
Nov 7 18:20:44 twilightnode nnrpd[1320595]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 7 18:20:44 twilightnode nnrpd[1320595]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 7 18:20:44 twilightnode nnrpd[1320595]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 7 18:20:44 twilightnode nnrpd[1320595]: 174.96.78.81 no_post anonymous-read
Nov 7 18:22:20 twilightnode nnrpd[1320618]: Reading access from /usr/local/news/etc/readers.conf
Nov 7 18:22:20 twilightnode nnrpd[1320618]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 46521 70.9%4.1 MB 59.4%
innd 10361 15.8%1.3 MB 19.3%
inn 7458 11.4%1.3 MB 18.4%
innfeed 1257 1.9%202.1 KB 2.8%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 5 65598 100.0%7.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 20100 52.4%
Negative hits 10811 28.2%
Do not exist 7438 19.4%
Cache misses 0 0.0%
TOTAL: 4 38349 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.073 0.0%42 0.000 1.738 10.000
article cleanup00:00:00.072 0.0%7439 0.000 0.010 0.088
article logging00:00:00.327 0.0%7458 0.000 0.044 0.280
article parse00:00:00.140 0.0%10302 0.000 0.014 0.133
article write00:00:07.810 0.0%6001 0.582 1.301 3.250
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.393 0.0%42836 0.000 0.009 0.088
hisgrep/artcncl00:00:00.038 0.0%42 0.000 0.905 7.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.507 0.0%38361 0.085 0.144 0.405
history sync00:00:00.075 0.0%319 0.000 0.235 4.500
history write00:00:04.158 0.0%7439 0.212 0.559 1.278
idle23:59:38.136 99.9%50156 752.917 1722.189 8220.863
nntp read00:00:01.208 0.0%43877 0.000 0.028 0.075
overview write00:00:06.623 0.0%6001 0.400 1.104 4.375
perl filter00:00:14.402 0.0%7438 0.977 1.936 8.400
python filter00:00:01.159 0.0%7438 0.030 0.156 1.194
site send00:00:00.436 0.0%11971 0.000 0.036 0.300
TOTAL: 1824:00:20.557100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%6197 0.000 0.004 0.105
article prepare00:00:00.000 0.0%27332 0.000 0.000 0.000
article read00:00:01.452 0.0%4326 0.000 0.336 1.167
backlog stats00:00:00.079 0.0%80499 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.708 0.0%45030 0.000 0.016 0.055
data write00:00:01.378 0.0%39193 0.007 0.035 0.146
idle23:58:31.882100.0%80499 366.378 1072.211 4271.177
status file00:00:00.266 0.0%164 0.000 1.622 11.000
TOTAL: 923:58:35.789100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:39:33.106100.0%31206 25.500 191.409 12060.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.554 0.0%78388 0.000 0.020 0.667
readart00:00:00.100 0.0%303 0.000 0.330 1.167
TOTAL: 401:39:34.760100.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 11688 4708 6937 43 40%50:12:08
2usenet.blueworldhosting.com 73 7431 1003 5106 1322 13%24:01:57
3newsfeed.endofthelinebbs.com 2020 7462 339 7013 110 4%32:42:37
4news.sklaffkom.se 40 116 103 13 0 88%11:37:34
5news.tebibyte.org 1 3861 98 3754 9 2%23:59:51
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 2162 30558 6251 22823 1484 20%142:34:07
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net18.0 MB0.0 KB117.8 KB18.1 MB 99%3.9 KB
2usenet.blueworldhosting.com5.4 MB0.0 KB1.7 MB7.1 MB 76%3.1 KB
3newsfeed.endofthelinebbs.com3.6 MB0.0 KB182.5 KB3.8 MB 95%8.7 KB
4news.sklaffkom.se323.0 KB0.0 KB0.0 KB323.0 KB100%3.1 KB
5news.tebibyte.org318.2 KB12.4 KB6.1 KB336.6 KB 94%3.1 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 627.7 MB12.4 KB2.0 MB29.6 MB 93%3.9 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 7 03:00:05 - 03:59:59 90 1.5% 0.03435.9 KB 1.6% 0.12
Nov 7 04:00:00 - 04:59:59 91 1.5% 0.03458.9 KB 1.7% 0.13
Nov 7 05:00:00 - 05:59:59 109 1.8% 0.03615.9 KB 2.3% 0.17
Nov 7 06:00:00 - 06:59:59 129 2.1% 0.04523.0 KB 2.0% 0.15
Nov 7 07:00:00 - 07:59:59 98 1.6% 0.03387.6 KB 1.5% 0.11
Nov 7 08:00:00 - 08:59:59 169 2.8% 0.05528.4 KB 2.0% 0.15
Nov 7 09:00:00 - 09:59:59 263 4.4% 0.071.3 MB 4.9% 0.36
Nov 7 10:00:00 - 10:59:59 374 6.2% 0.102.3 MB 8.7% 0.64
Nov 7 11:00:00 - 11:59:59 312 5.2% 0.091.1 MB 4.3% 0.32
Nov 7 12:00:00 - 12:59:59 315 5.2% 0.091.0 MB 3.9% 0.29
Nov 7 13:00:00 - 13:59:59 383 6.4% 0.111.4 MB 5.4% 0.40
Nov 7 14:00:00 - 14:59:59 308 5.1% 0.09999.1 KB 3.8% 0.28
Nov 7 15:00:00 - 15:59:59 315 5.2% 0.09868.8 KB 3.3% 0.24
Nov 7 16:00:00 - 16:59:59 422 7.0% 0.122.0 MB 7.8% 0.58
Nov 7 17:00:00 - 17:59:59 339 5.6% 0.091.3 MB 5.1% 0.38
Nov 7 18:00:00 - 18:59:59 352 5.9% 0.101.4 MB 5.5% 0.41
Nov 7 19:00:00 - 19:59:59 351 5.8% 0.102.7 MB 10.3% 0.76
Nov 7 20:00:00 - 20:59:59 294 4.9% 0.081.2 MB 4.6% 0.34
Nov 7 21:00:00 - 21:59:59 286 4.8% 0.081.3 MB 4.9% 0.36
Nov 7 22:00:00 - 22:59:59 256 4.3% 0.071.2 MB 4.7% 0.34
Nov 7 23:00:00 - 23:59:59 235 3.9% 0.071021.7 KB 3.8% 0.28
Nov 8 00:00:00 - 00:59:59 181 3.0% 0.05773.2 KB 2.9% 0.21
Nov 8 01:00:00 - 01:59:59 188 3.1% 0.05846.7 KB 3.2% 0.24
Nov 8 02:00:00 - 02:59:59 140 2.3% 0.04489.6 KB 1.8% 0.14
Nov 8 03:00:00 - 03:00:04 1 0.0% 0.253.4 KB 0.0% 0.86
TOTAL: 23:59:59 6001 100.0% 0.0726.0 MB 100.0% 0.31
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1322 350 0 0 0 0 0 0 972
2newsfeed.endofthelinebbs.com 71 3 0 0 0 0 0 0 68
3twilightnode-out.news.weretis.net 60 12 0 0 0 0 0 0 48
4news.tebibyte.org 4 4 0 0 0 0 0 0 0
TOTAL: 4 1457 369 0 0 0 0 0 0 1088

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 38
free.misc 11
local.general 6
test 6
alt.test.test.jojo 3
free.munch.onions 2
alt.bbs.files-announce 1
alt.dragons-inn 1
alt.games.nintendo 1
alt.music 1
alt.politics.republican 1
alt.religion.satanism 1
alt.sports.basketball.nba.la-lakers 1
alt.support.addiction 1
brasil.noticias 1
chmurka.statystyki 1
de.comm.software.crosspoint 1
hamster.de.tools 1
hispagatos.mastodon.tag.hackers 1
TOTAL: 22 369

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 892
Too many newsgroups 149
User-issued cancel 17
EMP (phn path) 7
Too many newsgroups (meow) 3
TOTAL: 5 1068

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 7749 2386 3434 150 0 18 30%23:59:54
2sklaffkom.se 6071 1205 1798 2967 0 0 19%23:59:54
3newsfeed.endofthelinebbs.com 10605 42 5647 81 0 199 0%23:59:54
4weretis.net 1474 4 1358 1 0 0 0%23:47:28
5usenet.blueworldhosting.com 7605 1 4506 0 0 14 0%23:59:48
TOTAL: 5 33504 3638 16743 3199 0 231 10%119:46:58
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org7.7 MB3.1 MB10.8 MB0.1 KB/s4.3 KB23:59:54
2sklaffkom.se2.0 MB17.2 MB19.2 MB0.2 KB/s4.7 KB23:59:54
3newsfeed.endofthelinebbs.com154.0 KB450.4 KB604.4 KB0.0 KB/s4.9 KB23:59:54
4weretis.net11.0 KB12.2 KB23.2 KB0.0 KB/s4.6 KB23:47:28
5usenet.blueworldhosting.com1.8 KB0.0 KB1.8 KB0.0 KB/s1.8 KB23:59:48
TOTAL: 59.8 MB20.7 MB30.6 MB0.1 KB/s4.6 KB119:46:58
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1174.96.78.811980 3034.9 MB 99 0 001:39:15
TOTAL: 11980 3034.9 MB 99 0 001:39:15

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved1984 3034.9 MB 99 0 001:39:16
2*.infrawat.ch 2 00.0 KB 0 0 000:00:00
3*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
4*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
5*.ip.frontiernet.net 1 00.0 KB 0 0 000:00:00
6*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
7*.stretchoid.com 1 00.0 KB 0 0 000:00:09
TOTAL: 71992 3034.9 MB 99 0 001:39:34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
174.96.78.81 13.080 23.862 0.00001:39:15
azpdes2lvrcs.stretchoid.com 0.006 0.010 0.00000:00:09
204.186.132.66.censys-scanner.com 0.033 0.023 0.00000:00:02
r3-217-d9.monitoring.internet-measurement.com 0.009 0.010 0.00000:00:01
r4-91-5b.monitoring.internet-measurement.com 0.004 0.010 0.00000:00:01
71.6.242.35 0.018 0.026 0.00000:00:00
188-240-59-59.infrawat.ch 0.005 0.011 0.00000:00:00
69-5-169-50.infrawat.ch 0.005 0.005 0.00000:00:00
147.185.132.146 0.004 0.012 0.00000:00:00
172-99-61-198.e55debe299579139e7cfe9be84b63964.ip.frontiernet.net 0.004 0.014 0.00000:00:00
o315.scanner.modat.io 0.003 0.017 0.00000:00:00
TOTAL: 11 13.171 24.000 0.00001:39:34

Curious NNRP explorers [Top 20]:

SystemConn
71.6.242.35 3
147.185.132.146 1
172-99-61-198.e55debe299579139e7cfe9be84b63964.ip.frontiernet.net 1
188-240-59-59.infrawat.ch 1
204.186.132.66.censys-scanner.com 1
69-5-169-50.infrawat.ch 1
azpdes2lvrcs.stretchoid.com 1
o315.scanner.modat.io 1
r3-217-d9.monitoring.internet-measurement.com 1
r4-91-5b.monitoring.internet-measurement.com 1
TOTAL: 10 12

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

SystemConn
147.185.132.146 4
71.6.242.35 3
204.186.132.66.censys-scanner.com 1
TOTAL: 3 8

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

CommandCount
#022?/?*N?,#0222?[;?8? 1
#023#003#023#001#023#002#001 1
#026#003#001 1
Accept-Encoding: gzip 1
EHLO www.censys.io 1
GET / HTTP/1.1 1
Host: 172.234.115.63:119 1
User-Agent: Hello from Palo Alto Network... 1
TOTAL: 8 8

NNRP client timeouts [Top 20]:

SystemConnPeer
188-240-59-59.infrawat.ch 1 1
TOTAL: 1 1 2

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

HierarchyCountPct
1alt 73 24.1%
2linux 49 16.2%
3microsoft 49 16.2%
4it 22 7.3%
5free 19 6.3%
6uk 19 6.3%
7de 18 5.9%
8comp 16 5.3%
9lada 8 2.6%
10control 5 1.7%
11junk 5 1.7%
12fr 4 1.3%
13talk 3 1.0%
14aus 2 0.7%
15hispagatos 2 0.7%
16nl 2 0.7%
17pl 2 0.7%
18rec 2 0.7%
19eternal-september 1 0.3%
20sac 1 0.3%
21sfnet 1 0.3%
TOTAL: 21 303100.0%

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

NewsgroupCount
1alt.anonymous.messages 35
2microsoft.public.windowsxp.help_and_support 28
3microsoft.public.windowsxp.general 21
4free.usenet 18
5linux.debian.changes.devel 17
6uk.legal.moderated 16
7alt.arts.poetry.comments 10
8de.alt.folklore.computer 10
9linux.debian.bugs.rc 10
10it.tlc.cellulari.android 8
11lada.talk 8
12linux.kernel.netdev 8
13linux.debian.bugs.dist 7
14alt.computer.workshop 6
15alt.home.repair 6
16comp.arch 6
17alt.test 5
18control.cancel 5
19it.test 5
20junk 5
21linux.kernel.git 5
22comp.lang.c 4
23comp.os.linux.misc 4
24fr.bio.medecine 4
25alt.usage.english 3
26de.etc.bahn.misc 3
27it.cultura.filosofia 3
28it.hobby.fai-da-te 3
29aus.politics 2
30de.comm.software.mozilla.mailnews 2
31de.comp.os.ms-windows.netzwerke 2
32hispagatos.talk 2
33linux.debian.user 2
34nl.politiek 2
35talk.politics.guns 2
36uk.telecom 2
37alt.bible 1
38alt.checkmate 1
39alt.comp.os.windows-11 1
40alt.recovery.aa 1
41alt.russian.z1 1
42alt.slack 1
43alt.support.depression.crisis 1
44alt.tv.survivor 1
45comp.sys.acorn.programmer 1
46comp.unix.shell 1
47de.rec.sport.misc 1
48eternal-september.talk 1
49free.pt 1
50it.comp.console 1
51it.politica 1
52it.sport.motociclismo 1
53pl.misc.militaria 1
54pl.pregierz 1
55rec.arts.poems 1
56rec.arts.tv 1
57sac.politics 1
58sfnet.keskustelu.varaventtiili 1
59talk.politics.misc 1
60uk.comp.sys.mac 1
TOTAL: 60 303