Daily Usenet report

Oct 19 03:00:05 -- Oct 20 03:00:05

Unknown entries from news log file:

First 50 / 197 lines (25.4%)

Oct 19 03:01:27 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Oct 19 16:09:07 twilightnode nnrpd[389229]: Reading access from /usr/local/news/etc/readers.conf
Oct 19 16:09:07 twilightnode nnrpd[389229]: Auth strategy 'localhost' does not match client. Removing.
Oct 19 16:09:07 twilightnode nnrpd[389229]: 81-19-216-69.infrawat.ch res <anonymous>
Oct 19 16:09:07 twilightnode nnrpd[389229]: 81-19-216-69.infrawat.ch no_match_user <anonymous> <localhost>
Oct 19 16:09:07 twilightnode nnrpd[389229]: 81-19-216-69.infrawat.ch no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 19 16:09:07 twilightnode nnrpd[389229]: 81-19-216-69.infrawat.ch match_user <anonymous> <anonymous>
Oct 19 16:09:07 twilightnode nnrpd[389229]: 81-19-216-69.infrawat.ch no_post anonymous-read
Oct 19 16:11:43 twilightnode nnrpd[389489]: Reading access from /usr/local/news/etc/readers.conf
Oct 19 16:11:43 twilightnode nnrpd[389489]: Auth strategy 'localhost' does not match client. Removing.
Oct 19 16:11:43 twilightnode nnrpd[389489]: 31-14-254-101.infrawat.ch res <anonymous>
Oct 19 16:11:43 twilightnode nnrpd[389489]: 31-14-254-101.infrawat.ch no_match_user <anonymous> <localhost>
Oct 19 16:11:43 twilightnode nnrpd[389489]: 31-14-254-101.infrawat.ch no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 19 16:11:43 twilightnode nnrpd[389489]: 31-14-254-101.infrawat.ch match_user <anonymous> <anonymous>
Oct 19 16:11:43 twilightnode nnrpd[389489]: 31-14-254-101.infrawat.ch no_post anonymous-read
Oct 19 16:56:01 twilightnode nnrpd[392087]: Reading access from /usr/local/news/etc/readers.conf
Oct 19 16:56:01 twilightnode nnrpd[392087]: twilightnode.org res <localhost>
Oct 19 16:56:01 twilightnode nnrpd[392087]: twilightnode.org match_user <localhost> <localhost>
Oct 19 16:58:58 twilightnode nnrpd[392962]: Reading access from /usr/local/news/etc/readers.conf
Oct 19 16:58:58 twilightnode nnrpd[392962]: twilightnode.org res <localhost>
Oct 19 16:58:58 twilightnode nnrpd[392962]: twilightnode.org match_user <localhost> <localhost>
Oct 19 17:00:24 twilightnode nnrpd[393161]: Reading access from /usr/local/news/etc/readers.conf
Oct 19 17:00:24 twilightnode nnrpd[393161]: twilightnode.org res <localhost>
Oct 19 17:00:24 twilightnode nnrpd[393161]: twilightnode.org match_user <localhost> <localhost>
Oct 19 18:41:20 twilightnode nnrpd[397880]: Reading access from /usr/local/news/etc/readers.conf
Oct 19 18:41:20 twilightnode nnrpd[397880]: Auth strategy 'localhost' does not match client. Removing.
Oct 19 18:41:20 twilightnode nnrpd[397880]: 223.224.132.66.censys-scanner.com res <anonymous>
Oct 19 18:41:20 twilightnode nnrpd[397880]: 223.224.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Oct 19 18:41:20 twilightnode nnrpd[397880]: 223.224.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 19 18:41:20 twilightnode nnrpd[397880]: 223.224.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Oct 19 18:41:20 twilightnode nnrpd[397880]: 223.224.132.66.censys-scanner.com no_post anonymous-read
Oct 19 18:41:21 twilightnode nnrpd[397880]: 223.224.132.66.censys-scanner.com res <anonymous>
Oct 19 18:41:21 twilightnode nnrpd[397880]: 223.224.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Oct 19 18:41:21 twilightnode nnrpd[397880]: 223.224.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 19 18:41:21 twilightnode nnrpd[397880]: 223.224.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Oct 19 18:41:21 twilightnode nnrpd[397880]: 223.224.132.66.censys-scanner.com no_post anonymous-read
Oct 20 02:15:06 twilightnode nnrpd[432168]: Reading access from /usr/local/news/etc/readers.conf
Oct 20 02:15:06 twilightnode nnrpd[432168]: Auth strategy 'localhost' does not match client. Removing.
Oct 20 02:15:06 twilightnode nnrpd[432168]: azpdss1hcpke.stretchoid.com res <anonymous>
Oct 20 02:15:06 twilightnode nnrpd[432168]: azpdss1hcpke.stretchoid.com no_match_user <anonymous> <localhost>
Oct 20 02:15:06 twilightnode nnrpd[432168]: azpdss1hcpke.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 20 02:15:06 twilightnode nnrpd[432168]: azpdss1hcpke.stretchoid.com match_user <anonymous> <anonymous>
Oct 20 02:15:06 twilightnode nnrpd[432168]: azpdss1hcpke.stretchoid.com no_post anonymous-read
Oct 20 02:23:57 twilightnode nnrpd[432517]: Reading access from /usr/local/news/etc/readers.conf
Oct 20 02:23:57 twilightnode nnrpd[432517]: Auth strategy 'localhost' does not match client. Removing.
Oct 20 02:23:57 twilightnode nnrpd[432517]: 174.96.78.81 res <anonymous>
Oct 20 02:23:57 twilightnode nnrpd[432517]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 20 02:23:57 twilightnode nnrpd[432517]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 20 02:23:57 twilightnode nnrpd[432517]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 20 02:23:57 twilightnode nnrpd[432517]: 174.96.78.81 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
inn 9539 45.4%1.7 MB 57.8%
nnrpd 6842 32.6%584.4 KB 19.7%
innd 3362 16.0%455.3 KB 15.4%
innfeed 1267 6.0%208.7 KB 7.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 21011 100.0%2.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24344 51.3%
Negative hits 13633 28.7%
Do not exist 9463 19.9%
Cache misses 1 0.0%
TOTAL: 4 47441 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.040 0.0%20 1.000 2.000 5.000
article cleanup00:00:00.151 0.0%9476 0.000 0.016 0.105
article logging00:00:00.503 0.0%9512 0.000 0.053 0.294
article parse00:00:00.255 0.0%13891 0.000 0.018 0.091
article write00:00:11.158 0.0%7863 0.434 1.419 2.652
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.287 0.0%50867 0.000 0.006 0.112
hisgrep/artcncl00:00:00.010 0.0%20 0.000 0.500 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.773 0.0%47508 0.067 0.164 0.394
history sync00:00:00.097 0.0%385 0.000 0.252 3.000
history write00:00:05.533 0.0%9475 0.273 0.584 1.232
idle23:49:31.475 99.9%50395 576.618 1701.984 6186.031
nntp read00:00:01.541 0.0%49805 0.007 0.031 0.086
overview write00:00:07.931 0.0%7863 0.295 1.009 2.640
perl filter00:00:24.457 0.0%9475 1.325 2.581 10.000
python filter00:00:02.200 0.0%9478 0.090 0.232 0.933
site send00:00:00.671 0.0%15692 0.000 0.043 0.222
TOTAL: 1823:50:34.082100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.100 0.0%8404 0.000 0.012 0.093
article prepare00:00:00.004 0.0%31760 0.000 0.000 0.006
article read00:00:01.887 0.0%5124 0.143 0.368 5.500
backlog stats00:00:00.096 0.0%100468 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.177 0.0%57389 0.007 0.021 0.070
data write00:00:01.715 0.0%49805 0.010 0.034 0.110
idle23:49:53.910100.0%100468 274.061 853.943 3063.872
status file00:00:00.216 0.0%165 0.000 1.309 7.000
TOTAL: 923:49:59.105100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:18:12.160100.0%7153 7.667 152.686 9817.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.364 0.0%15610 0.000 0.023 0.167
readart00:00:00.120 0.0%166 0.000 0.723 1.333
TOTAL: 400:18:12.644100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 5 14219 5704 8433 82 40%46:24:21
2usenet.blueworldhosting.com 288 9272 1784 6009 1479 19%23:51:35
3newsfeed.endofthelinebbs.com 3 7959 165 7724 70 2%34:51:31
4news.sklaffkom.se 47 124 114 10 0 91%12:59:23
5news.tebibyte.org 1 7598 53 7545 0 0%37:10:45
6localhost 28 3 3 0 0 100%00:00:00
7news.twilightnode.org 3 0 0 0 0 0%00:00:00
TOTAL: 7 375 39175 7823 29721 1631 19%155:17:35
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net17.7 MB0.0 KB342.8 KB18.0 MB 98%3.2 KB
2usenet.blueworldhosting.com9.3 MB5.4 KB3.2 MB12.5 MB 74%3.9 KB
3newsfeed.endofthelinebbs.com6.1 MB0.0 KB120.7 KB6.2 MB 98%27.0 KB
4news.sklaffkom.se347.5 KB0.0 KB0.0 KB347.5 KB100%3.0 KB
5news.tebibyte.org176.2 KB0.0 KB0.0 KB176.2 KB100%3.3 KB
6localhost1.7 KB0.0 KB0.0 KB1.7 KB100%0.6 KB
7news.twilightnode.org0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 733.6 MB5.4 KB3.6 MB37.3 MB 90%4.0 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 19 03:00:05 - 03:59:59 177 2.2% 0.053.4 MB 9.6% 0.97
Oct 19 04:00:00 - 04:59:59 153 1.9% 0.04626.3 KB 1.7% 0.17
Oct 19 05:00:00 - 05:59:59 145 1.8% 0.04868.1 KB 2.4% 0.24
Oct 19 06:00:00 - 06:59:59 167 2.1% 0.05554.9 KB 1.5% 0.15
Oct 19 07:00:00 - 07:59:59 231 2.9% 0.06910.0 KB 2.5% 0.25
Oct 19 08:00:00 - 08:59:59 245 3.1% 0.07716.5 KB 2.0% 0.20
Oct 19 09:00:00 - 09:59:59 321 4.1% 0.091.0 MB 2.9% 0.29
Oct 19 10:00:00 - 10:59:59 402 5.1% 0.111.7 MB 4.8% 0.48
Oct 19 11:00:00 - 11:59:59 381 4.8% 0.111.1 MB 3.0% 0.30
Oct 19 12:00:00 - 12:59:59 490 6.2% 0.141.6 MB 4.6% 0.46
Oct 19 13:00:00 - 13:59:59 436 5.5% 0.121.6 MB 4.6% 0.46
Oct 19 14:00:00 - 14:59:59 356 4.5% 0.101.8 MB 5.1% 0.51
Oct 19 15:00:00 - 15:59:59 385 4.9% 0.111.4 MB 3.9% 0.39
Oct 19 16:00:00 - 16:59:59 495 6.3% 0.141.6 MB 4.6% 0.46
Oct 19 17:00:00 - 17:59:59 650 8.2% 0.182.4 MB 6.8% 0.69
Oct 19 18:00:00 - 18:59:59 424 5.4% 0.121.6 MB 4.4% 0.44
Oct 19 19:00:00 - 19:59:59 459 5.8% 0.131.9 MB 5.4% 0.54
Oct 19 20:00:00 - 20:59:59 376 4.8% 0.101.3 MB 3.8% 0.38
Oct 19 21:00:00 - 21:59:59 307 3.9% 0.091.2 MB 3.4% 0.34
Oct 19 22:00:00 - 22:59:59 282 3.6% 0.081.2 MB 3.5% 0.35
Oct 19 23:00:00 - 23:59:59 313 4.0% 0.092.4 MB 6.7% 0.68
Oct 20 00:00:00 - 00:59:59 252 3.2% 0.072.5 MB 7.1% 0.72
Oct 20 01:00:00 - 01:59:59 213 2.7% 0.061.1 MB 3.0% 0.30
Oct 20 02:00:00 - 02:59:59 216 2.7% 0.06958.5 KB 2.7% 0.27
Oct 20 03:00:00 - 03:00:05 10 0.1% 2.0012.4 KB 0.0% 2.48
TOTAL: 24:00:00 7886 100.0% 0.0935.3 MB 100.0% 0.42
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1479 331 0 1 0 0 0 0 1147
2twilightnode-out.news.weretis.net 123 20 0 0 0 0 0 0 103
3newsfeed.endofthelinebbs.com 51 8 0 0 0 0 0 0 43
TOTAL: 3 1653 359 0 1 0 0 0 0 1293

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 26
hispagatos.mastodon.tag.hacking 8
fido.su.pol 4
linux.altlinux.sisyphus 4
alt.sports.football.pro.dallas-cowboys 3
uk.culture.language.english 3
alt.pl.zbluzgaj 2
alt.politics.bush 2
fido.ru.home 2
alt.autos.audi 1
alt.autos.performance-cars 1
alt.bbs.files-announce 1
alt.music 1
alt.phreaking 1
alt.politics.communism 1
alt.politics.cuba 1
alt.sports.football.pro.buffalo-bills 1
alt.sports.football.pro.cinci-bengals 1
alt.sports.football.pro.houston-oilers 1
TOTAL: 27 359

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 1110
Too many newsgroups 91
HTML Multipart 30
User-issued cancel 26
TOTAL: 4 1257

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 10163 2745 4588 141 0 445 27%23:59:56
2sklaffkom.se 8279 1171 2898 3782 0 10 14%23:59:44
3newsfeed.endofthelinebbs.com 13474 83 7522 31 0 471 0%23:59:51
4usenet.blueworldhosting.com 9445 10 5733 0 0 45 0%23:59:31
5weretis.net 2200 7 2128 0 0 0 0%23:59:56
TOTAL: 5 43561 4016 22869 3954 0 971 9%119:58:58
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org7.0 MB1.2 MB8.2 MB0.1 KB/s2.9 KB23:59:56
2sklaffkom.se1.8 MB23.9 MB25.7 MB0.3 KB/s5.3 KB23:59:44
3newsfeed.endofthelinebbs.com318.3 KB77.4 KB395.8 KB0.0 KB/s3.5 KB23:59:51
4usenet.blueworldhosting.com31.3 KB0.0 KB31.3 KB0.0 KB/s3.1 KB23:59:31
5weretis.net15.1 KB0.0 KB15.1 KB0.0 KB/s2.2 KB23:59:56
TOTAL: 59.1 MB25.2 MB34.3 MB0.1 KB/s4.4 KB119:58:58
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1174.96.78.81 20 1667.2 MB 11 0 000:17:55
2twilightnode.org 3 00.0 KB 0 3 000:00:00
TOTAL: 2 23 1667.2 MB 11 3 000:17:55

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 20 1667.2 MB 11 0 000:17:55
2*.org 3 00.0 KB 0 3 000:00:00
3*.infrawat.ch 2 00.0 KB 0 0 000:00:01
4*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
5*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
6*.stretchoid.com 1 00.0 KB 0 0 000:00:09
TOTAL: 6 29 1667.2 MB 11 3 000:18:12

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
174.96.78.81 0.756 2.363 0.00000:17:55
azpdss1hcpke.stretchoid.com 0.005 0.022 0.00000:00:09
carrillo.probe.onyphe.net 0.005 0.006 0.00000:00:02
223.224.132.66.censys-scanner.com 0.031 0.022 0.00000:00:02
31-14-254-101.infrawat.ch 0.004 0.030 0.00000:00:00
jeremiah.probe.onyphe.net 0.011 0.015 0.00000:00:00
81-19-216-69.infrawat.ch 0.005 0.012 0.00000:00:00
twilightnode.org 0.023 0.049 0.00000:00:00
TOTAL: 8 0.840 2.519 0.00000:18:12

Curious NNRP explorers [Top 20]:

SystemConn
223.224.132.66.censys-scanner.com 1
31-14-254-101.infrawat.ch 1
81-19-216-69.infrawat.ch 1
azpdss1hcpke.stretchoid.com 1
carrillo.probe.onyphe.net 1
jeremiah.probe.onyphe.net 1
TOTAL: 6 6

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

SystemConn
jeremiah.probe.onyphe.net 3
223.224.132.66.censys-scanner.com 1
TOTAL: 2 4

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

CommandCount
#026#003#003#002c#001 1
? >#015: 1
?$?,?r?s?#023#002#023#001?#024?#007?#022?#023?'?/?#024?(?0?`?a... 1
EHLO www.censys.io 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
31-14-254-101.infrawat.ch 1 1
TOTAL: 1 1 2

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

HierarchyCountPct
1microsoft 106 63.9%
2it 47 28.3%
3aus 9 5.4%
4alt 2 1.2%
5linux 2 1.2%
TOTAL: 5 166100.0%

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

NewsgroupCount
1microsoft.public.windowsxp.help_and_support 106
2it.test 47
3aus.cars 9
4linux.debian.l10n.german 2
5alt.checkmate 1
6alt.slack 1
TOTAL: 6 166