Daily Usenet report

Sep 30 03:00:04 -- Oct 1 03:00:04

Unknown entries from news log file:

First 50 / 448 lines (11.2%)

Sep 30 03:01:08 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Sep 30 06:38:45 twilightnode nnrpd[372927]: Reading access from /usr/local/news/etc/readers.conf
Sep 30 06:38:45 twilightnode nnrpd[372927]: Auth strategy 'localhost' does not match client. Removing.
Sep 30 06:38:45 twilightnode nnrpd[372927]: 94.195.132.66.censys-scanner.com res <anonymous>
Sep 30 06:38:45 twilightnode nnrpd[372927]: 94.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Sep 30 06:38:45 twilightnode nnrpd[372927]: 94.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 30 06:38:45 twilightnode nnrpd[372927]: 94.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Sep 30 06:38:45 twilightnode nnrpd[372927]: 94.195.132.66.censys-scanner.com no_post anonymous-read
Sep 30 06:38:46 twilightnode nnrpd[372927]: 94.195.132.66.censys-scanner.com res <anonymous>
Sep 30 06:38:46 twilightnode nnrpd[372927]: 94.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Sep 30 06:38:46 twilightnode nnrpd[372927]: 94.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 30 06:38:46 twilightnode nnrpd[372927]: 94.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Sep 30 06:38:46 twilightnode nnrpd[372927]: 94.195.132.66.censys-scanner.com no_post anonymous-read
Sep 30 07:13:11 twilightnode nnrpd[374775]: Reading access from /usr/local/news/etc/readers.conf
Sep 30 07:13:11 twilightnode nnrpd[374775]: Auth strategy 'localhost' does not match client. Removing.
Sep 30 07:13:11 twilightnode nnrpd[374775]: 94.154.43.21 res <anonymous>
Sep 30 07:13:11 twilightnode nnrpd[374775]: 94.154.43.21 no_match_user <anonymous> <localhost>
Sep 30 07:13:11 twilightnode nnrpd[374775]: 94.154.43.21 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 30 07:13:11 twilightnode nnrpd[374775]: 94.154.43.21 match_user <anonymous> <anonymous>
Sep 30 07:13:11 twilightnode nnrpd[374775]: 94.154.43.21 no_post anonymous-read
Sep 30 08:56:41 twilightnode nnrpd[379324]: Reading access from /usr/local/news/etc/readers.conf
Sep 30 08:56:41 twilightnode nnrpd[379324]: Auth strategy 'localhost' does not match client. Removing.
Sep 30 08:56:41 twilightnode nnrpd[379324]: 66.61.98.95 res <anonymous>
Sep 30 08:56:41 twilightnode nnrpd[379324]: 66.61.98.95 no_match_user <anonymous> <localhost>
Sep 30 08:56:41 twilightnode nnrpd[379324]: 66.61.98.95 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 30 08:56:41 twilightnode nnrpd[379324]: 66.61.98.95 match_user <anonymous> <anonymous>
Sep 30 08:56:41 twilightnode nnrpd[379324]: 66.61.98.95 no_post anonymous-read
Sep 30 08:56:42 twilightnode nnrpd[379325]: Reading access from /usr/local/news/etc/readers.conf
Sep 30 08:56:42 twilightnode nnrpd[379325]: Auth strategy 'localhost' does not match client. Removing.
Sep 30 08:56:42 twilightnode nnrpd[379325]: 66.61.98.95 res <anonymous>
Sep 30 08:56:42 twilightnode nnrpd[379325]: 66.61.98.95 no_match_user <anonymous> <localhost>
Sep 30 08:56:42 twilightnode nnrpd[379325]: 66.61.98.95 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 30 08:56:42 twilightnode nnrpd[379325]: 66.61.98.95 match_user <anonymous> <anonymous>
Sep 30 08:56:42 twilightnode nnrpd[379325]: 66.61.98.95 no_post anonymous-read
Sep 30 09:04:54 twilightnode nnrpd[379647]: Reading access from /usr/local/news/etc/readers.conf
Sep 30 09:04:54 twilightnode nnrpd[379647]: Auth strategy 'localhost' does not match client. Removing.
Sep 30 09:04:54 twilightnode nnrpd[379647]: 66.61.98.95 res <anonymous>
Sep 30 09:04:54 twilightnode nnrpd[379647]: 66.61.98.95 no_match_user <anonymous> <localhost>
Sep 30 09:04:54 twilightnode nnrpd[379647]: 66.61.98.95 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 30 09:04:54 twilightnode nnrpd[379647]: 66.61.98.95 match_user <anonymous> <anonymous>
Sep 30 09:04:54 twilightnode nnrpd[379647]: 66.61.98.95 no_post anonymous-read
Sep 30 09:04:54 twilightnode nnrpd[379648]: Reading access from /usr/local/news/etc/readers.conf
Sep 30 09:04:54 twilightnode nnrpd[379648]: Auth strategy 'localhost' does not match client. Removing.
Sep 30 09:04:54 twilightnode nnrpd[379648]: 66.61.98.95 res <anonymous>
Sep 30 09:04:54 twilightnode nnrpd[379648]: 66.61.98.95 no_match_user <anonymous> <localhost>
Sep 30 09:04:54 twilightnode nnrpd[379648]: 66.61.98.95 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 30 09:04:54 twilightnode nnrpd[379648]: 66.61.98.95 match_user <anonymous> <anonymous>
Sep 30 09:04:54 twilightnode nnrpd[379648]: 66.61.98.95 no_post anonymous-read
Sep 30 09:41:15 twilightnode nnrpd[381305]: Reading access from /usr/local/news/etc/readers.conf
Sep 30 09:41:15 twilightnode nnrpd[381305]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 7717 58.8%1.3 MB 66.4%
innd 2268 17.3%319.2 KB 15.4%
nnrpd 1866 14.2%164.6 KB 7.9%
innfeed 1249 9.5%206.9 KB 10.0%
controlchan 26 0.2%6.6 KB 0.3%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 6 13127 100.0%2.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 20346 50.9%
Negative hits 11929 29.8%
Do not exist 7664 19.2%
Cache misses 67 0.2%
TOTAL: 4 40006 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.084 0.0%30 0.000 2.800 6.000
article cleanup00:00:00.072 0.0%7697 0.000 0.009 0.143
article logging00:00:00.265 0.0%7718 0.000 0.034 0.167
article parse00:00:00.111 0.0%11403 0.000 0.010 0.077
article write00:00:06.900 0.0%6502 0.500 1.061 1.841
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.329 0.0%42930 0.000 0.008 0.042
hisgrep/artcncl00:00:00.030 0.0%30 0.000 1.000 1.273
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.848 0.0%40163 0.069 0.121 0.239
history sync00:00:00.060 0.0%417 0.000 0.144 0.667
history write00:00:03.728 0.0%7697 0.250 0.484 1.032
idle24:00:13.835 99.9%42831 839.385 2017.554 10173.068
nntp read00:00:00.969 0.0%42240 0.000 0.023 0.056
overview write00:00:05.069 0.0%6502 0.405 0.780 3.600
perl filter00:00:15.179 0.0%7696 1.053 1.972 8.097
python filter00:00:01.275 0.0%7696 0.016 0.166 0.548
site send00:00:00.276 0.0%12963 0.000 0.021 0.118
TOTAL: 1824:00:53.030100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%6704 0.000 0.004 0.059
article prepare00:00:00.002 0.0%28396 0.000 0.000 0.006
article read00:00:01.169 0.0%4667 0.061 0.250 1.200
backlog stats00:00:00.042 0.0%85497 0.000 0.000 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.681 0.0%48357 0.000 0.014 0.038
data write00:00:01.046 0.0%41967 0.000 0.025 0.074
idle23:50:32.425100.0%85497 411.247 1003.923 5838.107
status file00:00:00.144 0.0%159 0.000 0.906 6.000
TOTAL: 923:50:35.538100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:05:51.739 99.9%1658 71.500 212.147 9863.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.204 0.1%4407 0.000 0.046 0.667
readart00:00:00.114 0.0%139 0.000 0.820 1.966
TOTAL: 400:05:52.057100.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

Control channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
us-control@lists.killfile.org001101
TOTAL002102

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 5 12423 4260 8096 67 34%50:14:14
2usenet.blueworldhosting.com 144 7572 1950 4518 1104 25%23:49:42
3news.tebibyte.org 2 3732 196 3534 2 5%23:59:36
4newsfeed.endofthelinebbs.com 2 7440 129 7290 21 1%33:50:01
5news.sklaffkom.se 40 101 83 18 0 82%11:05:20
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 218 31268 6618 23456 1194 21%142:58:53
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net13.9 MB0.0 KB206.5 KB14.1 MB 98%3.3 KB
2usenet.blueworldhosting.com10.4 MB0.0 KB1.4 MB11.8 MB 88%4.0 KB
3newsfeed.endofthelinebbs.com2.2 MB0.0 KB27.5 KB2.2 MB 98%14.9 KB
4news.tebibyte.org597.9 KB0.0 KB1.9 KB599.8 KB 99%3.0 KB
5news.sklaffkom.se251.8 KB0.0 KB0.0 KB251.8 KB100%3.0 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 627.4 MB0.0 KB1.6 MB28.9 MB 94%3.8 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 30 03:00:04 - 03:59:59 125 1.9% 0.03686.1 KB 2.3% 0.19
Sep 30 04:00:00 - 04:59:59 126 1.9% 0.04680.3 KB 2.2% 0.19
Sep 30 05:00:00 - 05:59:59 116 1.8% 0.03662.7 KB 2.2% 0.18
Sep 30 06:00:00 - 06:59:59 141 2.2% 0.04651.9 KB 2.1% 0.18
Sep 30 07:00:00 - 07:59:59 213 3.3% 0.06739.5 KB 2.4% 0.21
Sep 30 08:00:00 - 08:59:59 247 3.8% 0.07874.2 KB 2.9% 0.24
Sep 30 09:00:00 - 09:59:59 355 5.5% 0.101.7 MB 5.7% 0.48
Sep 30 10:00:00 - 10:59:59 319 4.9% 0.091.2 MB 4.0% 0.34
Sep 30 11:00:00 - 11:59:59 317 4.9% 0.091.2 MB 3.9% 0.33
Sep 30 12:00:00 - 12:59:59 326 5.0% 0.091.6 MB 5.5% 0.47
Sep 30 13:00:00 - 13:59:59 329 5.1% 0.091.4 MB 4.5% 0.38
Sep 30 14:00:00 - 14:59:59 348 5.4% 0.101.1 MB 3.5% 0.30
Sep 30 15:00:00 - 15:59:59 330 5.1% 0.09994.2 KB 3.3% 0.28
Sep 30 16:00:00 - 16:59:59 329 5.1% 0.091.3 MB 4.5% 0.38
Sep 30 17:00:00 - 17:59:59 388 6.0% 0.114.0 MB 13.3% 1.13
Sep 30 18:00:00 - 18:59:59 310 4.8% 0.091.1 MB 3.7% 0.32
Sep 30 19:00:00 - 19:59:59 343 5.3% 0.101.3 MB 4.3% 0.37
Sep 30 20:00:00 - 20:59:59 308 4.7% 0.091.0 MB 3.4% 0.29
Sep 30 21:00:00 - 21:59:59 290 4.5% 0.08953.8 KB 3.1% 0.26
Sep 30 22:00:00 - 22:59:59 281 4.3% 0.081.2 MB 4.0% 0.34
Sep 30 23:00:00 - 23:59:59 264 4.1% 0.071.4 MB 4.5% 0.38
Oct 1 00:00:00 - 00:59:59 311 4.8% 0.091.8 MB 5.9% 0.50
Oct 1 01:00:00 - 01:59:59 190 2.9% 0.051.4 MB 4.7% 0.40
Oct 1 02:00:00 - 02:59:59 183 2.8% 0.051.1 MB 3.8% 0.32
Oct 1 03:00:00 - 03:00:04 12 0.2% 3.0021.1 KB 0.1% 5.29
TOTAL: 24:00:00 6501 100.0% 0.0829.7 MB 100.0% 0.35
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1104 374 0 0 1 0 0 0 729
2twilightnode-out.news.weretis.net 94 8 0 0 0 0 0 0 86
3newsfeed.endofthelinebbs.com 18 2 0 0 0 0 0 0 16
TOTAL: 3 1216 384 0 0 1 0 0 0 831

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 61
hispagatos.mastodon.tag.hacking 4
fido.ru.golded 3
fido.su.pol 3
local.general 3
realms.testing 2
alt.bbs.files-announce 1
alt.law.enforcement 1
alt.sex.breast 1
alt.sports.soccer.manchester.united 1
alt.test.9 1
chmurka.statystyki 1
de.comp.office-pakete.ms-office.misc 1
de.rec.sf.perry-rhodan 1
fido.english_tutor 1
fido.ru.modem 1
fido.ru.space 1
fido.su.tormoz 1
fidonet.fn_sysop 1
TOTAL: 27 384

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
uk.religion.christian 1
TOTAL: 1 1

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 665
Too many newsgroups 109
EMP (phn path) 21
User-issued cancel 14
TOTAL: 4 809

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 8970 2397 3955 106 0 12 26%23:59:55
2sklaffkom.se 6625 994 1913 3551 0 1 15%23:59:48
3newsfeed.endofthelinebbs.com 11172 66 6254 20 0 262 0%23:58:36
4usenet.blueworldhosting.com 7387 1 4243 0 0 13 0%23:58:28
5weretis.net 2302 0 2227 0 0 0 0%23:59:55
TOTAL: 5 36456 3458 18592 3677 0 288 9%119:56:42
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org6.3 MB1.6 MB8.0 MB0.1 KB/s3.3 KB23:59:55
2sklaffkom.se1.5 MB18.3 MB19.8 MB0.2 KB/s4.5 KB23:59:48
3newsfeed.endofthelinebbs.com278.0 KB50.9 KB328.9 KB0.0 KB/s3.8 KB23:58:36
4usenet.blueworldhosting.com3.4 KB0.0 KB3.4 KB0.0 KB/s3.4 KB23:58:28
5weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 58.1 MB20.0 MB28.1 MB0.1 KB/s4.0 KB119:56:42
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 56 1391.4 MB 46 0 000:05:38
TOTAL: 1 56 1391.4 MB 46 0 000:05:38

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 60 1391.4 MB 46 0 000:05:49
2*.infrawat.ch 2 00.0 KB 0 0 000:00:00
3*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:01
TOTAL: 3 63 1391.4 MB 46 0 000:05:52

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.61.98.95 0.428 1.264 0.00000:05:38
20.12.241.170 0.008 0.019 0.00000:00:10
94.195.132.66.censys-scanner.com 0.030 0.015 0.00000:00:01
81-19-219-229.infrawat.ch 0.004 0.010 0.00000:00:00
94.154.43.21 0.002 0.018 0.00000:00:00
89-21-67-159.infrawat.ch 0.006 0.011 0.00000:00:00
205.210.31.90 0.005 0.010 0.00000:00:00
TOTAL: 7 0.483 1.347 0.00000:05:52

Curious NNRP explorers [Top 20]:

SystemConn
20.12.241.170 2
205.210.31.90 1
81-19-219-229.infrawat.ch 1
89-21-67-159.infrawat.ch 1
94.154.43.21 1
94.195.132.66.censys-scanner.com 1
TOTAL: 6 7

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

SystemConn
20.12.241.170 1
94.195.132.66.censys-scanner.com 1
TOTAL: 2 2

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

CommandCount
EHLO www.censys.io 1
MGLNDD_172.234.115.63_119 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
89-21-67-159.infrawat.ch 1 1
TOTAL: 1 1 3

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

HierarchyCountPct
1alt 29 20.9%
2aus 29 20.9%
3linux 16 11.5%
4cn 13 9.4%
5de 10 7.2%
6hfx 8 5.8%
7it 7 5.0%
8rocksolid 4 2.9%
9junk 3 2.2%
10rec 3 2.2%
11talk 3 2.2%
12comp 2 1.4%
13control 2 1.4%
14fr 2 1.4%
15sci 2 1.4%
16eternal-september 1 0.7%
17grisbi 1 0.7%
18lada 1 0.7%
19nz 1 0.7%
20pl 1 0.7%
21sfnet 1 0.7%
TOTAL: 21 139100.0%

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

NewsgroupCount
1aus.cars 19
2linux.kernel.git 14
3alt.buddha.short.fat.guy 13
4cn.test 13
5aus.politics 10
6hfx.general 8
7it.hobby.fai-da-te 6
8alt.test 5
9alt.computer.workshop 4
10alt.sports.basketball.nba.gs-warriors 4
11de.admin.infos 4
12rocksolid.shared.test 4
13de.test 3
14junk 3
15talk.politics.guns 3
16control.checkgroups 2
17fr.soc.politique 2
18linux.debian.bugs.dist 2
19sci.electronics.design 2
20alt.christnet 1
21alt.christnet.prayer 1
22alt.comp.os.windows-10 1
23comp.mail.pine 1
24comp.text.tex 1
25de.etc.fahrzeug.auto 1
26de.etc.sprache.deutsch 1
27de.talk.jokes 1
28eternal-september.test 1
29grisbi.test 1
30it.test 1
31lada.test 1
32nz.general 1
33pl.misc.elektronika 1
34rec.arts.drwho 1
35rec.arts.tv 1
36rec.crafts.metalworking 1
37sfnet.keskustelu.varaventtiili 1
TOTAL: 37 139
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