Daily Usenet report

Oct 24 03:00:05 -- Oct 25 03:00:04

Unknown entries from news log file:

First 50 / 244 lines (20.5%)

Oct 24 03:01:20 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Oct 24 04:24:42 twilightnode nnrpd[281748]: Reading access from /usr/local/news/etc/readers.conf
Oct 24 04:24:42 twilightnode nnrpd[281748]: Auth strategy 'localhost' does not match client. Removing.
Oct 24 04:24:42 twilightnode nnrpd[281748]: 174.96.78.81 res <anonymous>
Oct 24 04:24:42 twilightnode nnrpd[281748]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 24 04:24:42 twilightnode nnrpd[281748]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 24 04:24:42 twilightnode nnrpd[281748]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 24 04:24:42 twilightnode nnrpd[281748]: 174.96.78.81 no_post anonymous-read
Oct 24 04:24:42 twilightnode nnrpd[281749]: Reading access from /usr/local/news/etc/readers.conf
Oct 24 04:24:42 twilightnode nnrpd[281749]: Auth strategy 'localhost' does not match client. Removing.
Oct 24 04:24:42 twilightnode nnrpd[281749]: 174.96.78.81 res <anonymous>
Oct 24 04:24:42 twilightnode nnrpd[281749]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 24 04:24:42 twilightnode nnrpd[281749]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 24 04:24:42 twilightnode nnrpd[281749]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 24 04:24:42 twilightnode nnrpd[281749]: 174.96.78.81 no_post anonymous-read
Oct 24 06:32:55 twilightnode nnrpd[287656]: Reading access from /usr/local/news/etc/readers.conf
Oct 24 06:32:55 twilightnode nnrpd[287656]: Auth strategy 'localhost' does not match client. Removing.
Oct 24 06:32:55 twilightnode nnrpd[287656]: 174.96.78.81 res <anonymous>
Oct 24 06:32:55 twilightnode nnrpd[287656]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 24 06:32:55 twilightnode nnrpd[287656]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 24 06:32:55 twilightnode nnrpd[287656]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 24 06:32:55 twilightnode nnrpd[287656]: 174.96.78.81 no_post anonymous-read
Oct 24 06:32:55 twilightnode nnrpd[287657]: Reading access from /usr/local/news/etc/readers.conf
Oct 24 06:32:55 twilightnode nnrpd[287657]: Auth strategy 'localhost' does not match client. Removing.
Oct 24 06:32:55 twilightnode nnrpd[287657]: 174.96.78.81 res <anonymous>
Oct 24 06:32:55 twilightnode nnrpd[287657]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 24 06:32:55 twilightnode nnrpd[287657]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 24 06:32:55 twilightnode nnrpd[287657]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 24 06:32:55 twilightnode nnrpd[287657]: 174.96.78.81 no_post anonymous-read
Oct 24 06:32:59 twilightnode nnrpd[287658]: Reading access from /usr/local/news/etc/readers.conf
Oct 24 06:32:59 twilightnode nnrpd[287658]: Auth strategy 'localhost' does not match client. Removing.
Oct 24 06:32:59 twilightnode nnrpd[287658]: 174.96.78.81 res <anonymous>
Oct 24 06:32:59 twilightnode nnrpd[287658]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 24 06:32:59 twilightnode nnrpd[287658]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 24 06:32:59 twilightnode nnrpd[287658]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 24 06:32:59 twilightnode nnrpd[287658]: 174.96.78.81 no_post anonymous-read
Oct 24 06:33:00 twilightnode nnrpd[287659]: Reading access from /usr/local/news/etc/readers.conf
Oct 24 06:33:00 twilightnode nnrpd[287659]: Auth strategy 'localhost' does not match client. Removing.
Oct 24 06:33:00 twilightnode nnrpd[287659]: 174.96.78.81 res <anonymous>
Oct 24 06:33:00 twilightnode nnrpd[287659]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 24 06:33:00 twilightnode nnrpd[287659]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 24 06:33:00 twilightnode nnrpd[287659]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 24 06:33:00 twilightnode nnrpd[287659]: 174.96.78.81 no_post anonymous-read
Oct 24 08:54:05 twilightnode nnrpd[294429]: Reading access from /usr/local/news/etc/readers.conf
Oct 24 08:54:05 twilightnode nnrpd[294429]: Auth strategy 'localhost' does not match client. Removing.
Oct 24 08:54:05 twilightnode nnrpd[294429]: 174.96.78.81 res <anonymous>
Oct 24 08:54:05 twilightnode nnrpd[294429]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 24 08:54:05 twilightnode nnrpd[294429]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 24 08:54:05 twilightnode nnrpd[294429]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 24 08:54:05 twilightnode nnrpd[294429]: 174.96.78.81 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
inn 8450 39.5%1.4 MB 50.4%
nnrpd 6417 30.0%549.3 KB 18.7%
innd 5181 24.2%705.8 KB 24.1%
innfeed 1335 6.2%199.1 KB 6.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 21384 100.0%2.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 19303 48.8%
Negative hits 11865 30.0%
Do not exist 8423 21.3%
Cache misses 1 0.0%
TOTAL: 4 39592 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.036 0.0%15 1.000 2.400 11.000
article cleanup00:00:00.068 0.0%8430 0.000 0.008 0.077
article logging00:00:00.350 0.0%8452 0.000 0.041 0.300
article parse00:00:00.132 0.0%10538 0.000 0.013 0.105
article write00:00:08.566 0.0%6600 0.846 1.298 3.609
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.150 0.0%41351 0.000 0.004 0.043
hisgrep/artcncl00:00:00.009 0.0%15 0.000 0.600 1.200
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.984 0.0%39621 0.072 0.151 0.378
history sync00:00:00.054 0.0%332 0.000 0.163 2.000
history write00:00:04.562 0.0%8430 0.250 0.541 1.010
idle24:59:46.522 99.9%42582 877.984 2113.253 8218.630
nntp read00:00:00.990 0.0%41586 0.004 0.024 0.085
overview write00:00:06.473 0.0%6600 0.490 0.981 2.800
perl filter00:00:11.765 0.0%8430 0.707 1.396 8.600
python filter00:00:00.783 0.0%8430 0.000 0.093 1.143
site send00:00:00.402 0.0%13153 0.000 0.031 0.143
TOTAL: 1825:00:26.846100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.040 0.0%6626 0.000 0.006 0.524
article prepare00:00:00.001 0.0%30180 0.000 0.000 0.003
article read00:00:01.323 0.0%4482 0.000 0.295 1.714
backlog stats00:00:00.058 0.0%79198 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.662 0.0%44471 0.000 0.015 0.075
data write00:00:01.334 0.0%38112 0.007 0.035 0.082
idle24:59:22.895100.0%79198 516.258 1135.924 4618.623
status file00:00:00.270 0.0%181 0.000 1.492 10.000
TOTAL: 924:59:26.583100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:17:52.955 99.9%6828 5.000 157.140 20101.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.011 0.1%15360 0.000 0.066 11.739
readart00:00:00.091 0.0%209 0.000 0.435 0.600
TOTAL: 400:17:54.057100.0%----

Control commands to innd:

CommandNumber
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 153
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 174

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 4 12612 4764 7670 178 37%49:24:58
2usenet.blueworldhosting.com 709 8372 1586 5168 1618 18%24:49:17
3newsfeed.endofthelinebbs.com 1 7326 121 7127 78 1%35:02:14
4news.sklaffkom.se 37 93 81 12 0 87%09:44:37
5news.tebibyte.org 1 4189 24 4165 0 0%23:59:50
6localhost 26 0 0 0 0 0%00:00:00
TOTAL: 6 778 32592 6576 24142 1874 20%143:00:56
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net14.5 MB0.0 KB685.9 KB15.2 MB 95%3.1 KB
2usenet.blueworldhosting.com6.1 MB0.0 KB4.0 MB10.1 MB 60%3.2 KB
3newsfeed.endofthelinebbs.com1.4 MB0.0 KB121.3 KB1.5 MB 91%7.6 KB
4news.sklaffkom.se217.6 KB0.0 KB0.0 KB217.6 KB100%2.7 KB
5news.tebibyte.org72.3 KB0.0 KB0.0 KB72.3 KB100%3.0 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 622.3 MB0.0 KB4.8 MB27.0 MB 82%3.3 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 24 03:00:05 - 03:59:59 149 2.3% 0.04495.0 KB 2.3% 0.14
Oct 24 04:00:00 - 04:59:59 128 1.9% 0.04389.2 KB 1.8% 0.11
Oct 24 05:00:00 - 05:59:59 103 1.6% 0.03333.6 KB 1.5% 0.09
Oct 24 06:00:00 - 06:59:59 125 1.9% 0.03387.0 KB 1.8% 0.11
Oct 24 07:00:00 - 07:59:59 141 2.1% 0.04466.1 KB 2.1% 0.13
Oct 24 08:00:00 - 08:59:59 214 3.2% 0.06701.6 KB 3.2% 0.19
Oct 24 09:00:00 - 09:59:59 396 6.0% 0.111.3 MB 6.2% 0.38
Oct 24 10:00:00 - 10:59:59 322 4.9% 0.09831.1 KB 3.8% 0.23
Oct 24 11:00:00 - 11:59:59 366 5.5% 0.101.4 MB 6.5% 0.40
Oct 24 12:00:00 - 12:59:59 298 4.5% 0.081.1 MB 4.9% 0.30
Oct 24 13:00:00 - 13:59:59 272 4.1% 0.08719.9 KB 3.3% 0.20
Oct 24 14:00:00 - 14:59:59 239 3.6% 0.07811.8 KB 3.7% 0.23
Oct 24 15:00:00 - 15:59:59 327 5.0% 0.09927.8 KB 4.2% 0.26
Oct 24 16:00:00 - 16:59:59 409 6.2% 0.111.4 MB 6.6% 0.40
Oct 24 17:00:00 - 17:59:59 406 6.2% 0.111.6 MB 7.6% 0.46
Oct 24 18:00:00 - 18:59:59 315 4.8% 0.091.1 MB 5.3% 0.32
Oct 24 19:00:00 - 19:59:59 330 5.0% 0.091013.7 KB 4.6% 0.28
Oct 24 20:00:00 - 20:59:59 288 4.4% 0.08842.9 KB 3.8% 0.23
Oct 24 21:00:00 - 21:59:59 323 4.9% 0.09906.9 KB 4.1% 0.25
Oct 24 22:00:00 - 22:59:59 272 4.1% 0.08877.4 KB 4.0% 0.24
Oct 24 23:00:00 - 23:59:59 302 4.6% 0.081.0 MB 4.7% 0.29
Oct 25 00:00:00 - 00:59:59 271 4.1% 0.08922.8 KB 4.2% 0.26
Oct 25 01:00:00 - 01:59:59 247 3.7% 0.07838.4 KB 3.8% 0.23
Oct 25 02:00:00 - 02:59:59 356 5.4% 0.101.2 MB 5.8% 0.35
Oct 25 03:00:00 - 03:00:04 1 0.0% 0.254.6 KB 0.0% 1.16
TOTAL: 23:59:59 6600 100.0% 0.0821.4 MB 100.0% 0.25
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1616 358 0 0 0 0 0 0 1258
2twilightnode-out.news.weretis.net 198 16 0 0 0 0 0 0 182
3newsfeed.endofthelinebbs.com 36 0 0 0 0 0 0 0 36
TOTAL: 3 1850 374 0 0 0 0 0 0 1476

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 300
hispagatos.hacking.ransomware 29
hispagatos.mastodon.tag.hacking 12
fr.rec.son-image.video.realisation 3
swnet.sys.amiga 3
de.comp.misc 2
alt.activism 1
alt.alien.visitors 1
alt.architecture 1
alt.bbs.files-announce 1
alt.censorship 1
alt.consumers.experiences 1
alt.culture 1
alt.dating 1
alt.fan.sailor-moon 1
alt.sports.basketball.nba.la-lakers 1
alt.sports.football.pro.kc-chiefs 1
alt.sports.football.pro.la-raiders 1
alt.sports.football.pro.tennessee 1
alt.sports.football.pro.wash-redskins 1
TOTAL: 31 374

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 930
EMP (fsl) 259
Too many newsgroups 106
EMP (phn path) 80
User-issued cancel 72
HTML Multipart 7
TOTAL: 6 1454

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 8549 2967 3458 128 0 13 34%24:59:56
2sklaffkom.se 6770 1079 2152 3322 0 0 15%24:59:49
3newsfeed.endofthelinebbs.com 5772 24 3444 18 0 3088 0%24:59:56
4weretis.net 1798 4 1741 0 0 0 0%24:58:00
5usenet.blueworldhosting.com 8137 3 4683 0 0 12 0%24:59:30
TOTAL: 5 31026 4077 15478 3468 0 3113 13%124:57:11
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org7.5 MB1.3 MB8.8 MB0.1 KB/s2.9 KB24:59:56
2sklaffkom.se1.7 MB12.8 MB14.5 MB0.2 KB/s3.4 KB24:59:49
3newsfeed.endofthelinebbs.com54.0 KB52.0 KB106.0 KB0.0 KB/s2.5 KB24:59:56
4weretis.net10.6 KB0.0 KB10.6 KB0.0 KB/s2.6 KB24:58:00
5usenet.blueworldhosting.com8.2 KB0.0 KB8.2 KB0.0 KB/s2.7 KB24:59:30
TOTAL: 59.3 MB14.2 MB23.5 MB0.1 KB/s3.2 KB124:57:11
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1174.96.78.81 20 209437.9 KB 43 0 000:16:55
TOTAL: 1 20 209437.9 KB 43 0 000:16:55

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 27 209437.9 KB 43 0 000:17:33
2*.66.censys-scanner.com 5 00.0 KB 0 0 000:00:20
3*.infrawat.ch 1 00.0 KB 0 0 000:00:00
4*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 4 34 209437.9 KB 43 0 000:17:54

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
174.96.78.81 0.519 2.512 0.00000:16:55
77.67.26.217 0.006 0.016 0.00000:00:20
185.172.132.66.censys-scanner.com 0.021 0.031 0.00000:00:17
4.246.226.179 0.009 0.027 0.00000:00:09
151.243.11.192 0.010 0.032 0.00000:00:07
101.172.132.66.censys-scanner.com 0.027 0.024 0.00000:00:02
198.235.24.75 0.001 0.019 0.00000:00:00
o320.scanner.modat.io 0.004 0.019 0.00000:00:00
5-226-140-75.infrawat.ch 0.003 0.008 0.00000:00:00
205.210.31.155 0.005 0.016 0.00000:00:00
TOTAL: 10 0.605 2.704 0.00000:17:54

Curious NNRP explorers [Top 20]:

SystemConn
185.172.132.66.censys-scanner.com 4
151.243.11.192 2
4.246.226.179 2
101.172.132.66.censys-scanner.com 1
198.235.24.75 1
205.210.31.155 1
5-226-140-75.infrawat.ch 1
77.67.26.217 1
o320.scanner.modat.io 1
TOTAL: 9 14

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

SystemConn
101.172.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
185.172.132.66.censys-scanner.com 1 3
5-226-140-75.infrawat.ch 1 1
TOTAL: 2 2 6

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

HierarchyCountPct
1free 119 56.9%
2alt 44 21.1%
3linux 14 6.7%
4de 10 4.8%
5rec 5 2.4%
6fr 3 1.4%
7comp 2 1.0%
8sci 2 1.0%
9talk 2 1.0%
10aus 1 0.5%
11brasil 1 0.5%
12dk 1 0.5%
13eternal-september 1 0.5%
14it 1 0.5%
15junk 1 0.5%
16pl 1 0.5%
17spline 1 0.5%
TOTAL: 17 209100.0%

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

NewsgroupCount
1free.usenet 119
2alt.test 25
3linux.debian.bugs.dist 9
4alt.computer.workshop 8
5de.etc.fahrzeug.auto 6
6rec.food.cooking 4
7alt.atheism 3
8alt.usage.english 3
9de.talk.jokes 3
10linux.kernel.netdev 3
11alt.home.repair 2
12fr.soc.politique 2
13talk.politics.guns 2
14alt.arts.poetry.comments 1
15alt.bbs.synchronet 1
16alt.christnet.christianlife 1
17aus.politics 1
18brasil.unix 1
19comp.lang.tcl 1
20comp.os.linux.misc 1
21de.etc.sprache.deutsch 1
22dk.politik 1
23eternal-september.talk 1
24fr.sci.maths 1
25it.tlc.cellulari.android 1
26junk 1
27linux.debian.devel 1
28linux.debian.user.german 1
29pl.soc.prawo 1
30rec.arts.tv 1
31sci.logic 1
32sci.physics.relativity 1
33spline.eisfair 1
TOTAL: 33 209
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