Daily Usenet report

Aug 23 03:00:03 -- Aug 24 03:00:03

Unknown entries from news log file:

First 50 / 3327 lines (1.5%)

Aug 23 03:01:02 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Aug 23 03:02:00 twilightnode nnrpd[1955319]: Reading access from /usr/local/news/etc/readers.conf
Aug 23 03:02:00 twilightnode nnrpd[1955320]: Reading access from /usr/local/news/etc/readers.conf
Aug 23 03:02:00 twilightnode nnrpd[1955320]: Auth strategy 'localhost' does not match client. Removing.
Aug 23 03:02:00 twilightnode nnrpd[1955320]: usenet.blueworldhosting.com res <anonymous>
Aug 23 03:02:00 twilightnode nnrpd[1955320]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 23 03:02:00 twilightnode nnrpd[1955320]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 23 03:02:00 twilightnode nnrpd[1955320]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 23 03:02:00 twilightnode nnrpd[1955320]: usenet.blueworldhosting.com no_post anonymous-read
Aug 23 03:02:00 twilightnode nnrpd[1955319]: Auth strategy 'localhost' does not match client. Removing.
Aug 23 03:02:00 twilightnode nnrpd[1955319]: usenet.blueworldhosting.com res <anonymous>
Aug 23 03:02:00 twilightnode nnrpd[1955319]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 23 03:02:00 twilightnode nnrpd[1955319]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 23 03:02:00 twilightnode nnrpd[1955319]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 23 03:02:00 twilightnode nnrpd[1955319]: usenet.blueworldhosting.com no_post anonymous-read
Aug 23 03:02:01 twilightnode nnrpd[1955319]: usenet.blueworldhosting.com noperm ihave without permission
Aug 23 03:02:01 twilightnode nnrpd[1955320]: usenet.blueworldhosting.com noperm ihave without permission
Aug 23 03:04:00 twilightnode nnrpd[1955334]: Reading access from /usr/local/news/etc/readers.conf
Aug 23 03:04:00 twilightnode nnrpd[1955334]: Auth strategy 'localhost' does not match client. Removing.
Aug 23 03:04:00 twilightnode nnrpd[1955334]: usenet.blueworldhosting.com res <anonymous>
Aug 23 03:04:00 twilightnode nnrpd[1955334]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 23 03:04:00 twilightnode nnrpd[1955334]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 23 03:04:00 twilightnode nnrpd[1955334]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 23 03:04:00 twilightnode nnrpd[1955334]: usenet.blueworldhosting.com no_post anonymous-read
Aug 23 03:04:00 twilightnode nnrpd[1955333]: Reading access from /usr/local/news/etc/readers.conf
Aug 23 03:04:00 twilightnode nnrpd[1955333]: Auth strategy 'localhost' does not match client. Removing.
Aug 23 03:04:00 twilightnode nnrpd[1955333]: usenet.blueworldhosting.com res <anonymous>
Aug 23 03:04:00 twilightnode nnrpd[1955333]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 23 03:04:00 twilightnode nnrpd[1955333]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 23 03:04:00 twilightnode nnrpd[1955333]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 23 03:04:00 twilightnode nnrpd[1955333]: usenet.blueworldhosting.com no_post anonymous-read
Aug 23 03:04:00 twilightnode nnrpd[1955333]: usenet.blueworldhosting.com noperm ihave without permission
Aug 23 03:04:00 twilightnode nnrpd[1955334]: usenet.blueworldhosting.com noperm ihave without permission
Aug 23 03:06:00 twilightnode nnrpd[1955490]: Reading access from /usr/local/news/etc/readers.conf
Aug 23 03:06:00 twilightnode nnrpd[1955489]: Reading access from /usr/local/news/etc/readers.conf
Aug 23 03:06:00 twilightnode nnrpd[1955489]: Auth strategy 'localhost' does not match client. Removing.
Aug 23 03:06:00 twilightnode nnrpd[1955489]: usenet.blueworldhosting.com res <anonymous>
Aug 23 03:06:00 twilightnode nnrpd[1955489]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 23 03:06:00 twilightnode nnrpd[1955489]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 23 03:06:00 twilightnode nnrpd[1955489]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 23 03:06:00 twilightnode nnrpd[1955489]: usenet.blueworldhosting.com no_post anonymous-read
Aug 23 03:06:00 twilightnode nnrpd[1955490]: Auth strategy 'localhost' does not match client. Removing.
Aug 23 03:06:00 twilightnode nnrpd[1955490]: usenet.blueworldhosting.com res <anonymous>
Aug 23 03:06:00 twilightnode nnrpd[1955490]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 23 03:06:00 twilightnode nnrpd[1955490]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 23 03:06:00 twilightnode nnrpd[1955490]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 23 03:06:00 twilightnode nnrpd[1955490]: usenet.blueworldhosting.com no_post anonymous-read
Aug 23 03:06:00 twilightnode nnrpd[1955489]: usenet.blueworldhosting.com noperm ihave without permission
Aug 23 03:06:00 twilightnode nnrpd[1955490]: usenet.blueworldhosting.com noperm ihave without permission
Aug 23 03:08:00 twilightnode nnrpd[1955638]: Reading access from /usr/local/news/etc/readers.conf

Log entries by program:

Program nameLines%LinesSize%Size
inn 6463 38.8%1.1 MB 46.6%
nnrpd 4593 27.6%486.4 KB 20.6%
innd 4187 25.2%553.5 KB 23.4%
innfeed 1401 8.4%223.9 KB 9.5%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 16646 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 16300 51.9%
Negative hits 8427 26.8%
Do not exist 6345 20.2%
Cache misses 357 1.1%
TOTAL: 4 31429 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.021 0.0%4 2.000 5.250 10.000
article cleanup00:00:00.054 0.0%6420 0.000 0.008 0.111
article logging00:00:00.192 0.0%6444 0.000 0.030 0.292
article parse00:00:00.138 0.0%8370 0.000 0.016 0.111
article write00:00:04.318 0.0%4711 0.333 0.917 1.964
artlog/artparse00:00:00.001 0.0%1 1.000 1.000 1.000
data move00:00:00.102 0.0%32307 0.000 0.003 0.030
hisgrep/artcncl00:00:00.002 0.0%4 0.000 0.500 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.491 0.0%31582 0.049 0.111 0.218
history sync00:00:00.056 0.0%377 0.000 0.149 1.000
history write00:00:02.950 0.0%6376 0.059 0.463 1.000
idle23:50:24.686100.0%34241 873.841 2506.489 13640.159
nntp read00:00:00.583 0.0%32527 0.000 0.018 0.095
overview write00:00:02.381 0.0%4711 0.125 0.505 1.750
perl filter00:00:11.431 0.0%6373 0.803 1.794 9.520
python filter00:00:00.602 0.0%6373 0.000 0.094 0.360
site send00:00:00.241 0.0%9371 0.000 0.026 0.167
TOTAL: 1823:50:51.249100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.390 0.0%789630 0.000 0.000 0.053
article prepare00:00:00.078 0.0%1590962 0.000 0.000 0.009
article read00:00:28.096 0.0%787253 0.000 0.036 0.889
backlog stats00:00:00.187 0.0%545226 0.000 0.000 0.012
callbacks00:00:00.182 0.0%117030 0.000 0.002 0.003
data read00:00:02.715 0.0%239535 0.000 0.011 0.155
data write00:00:01.966 0.0%235497 0.000 0.008 0.093
idle23:48:40.695100.0%545226 28.221 157.220 5467.673
status file00:00:00.166 0.0%218 0.000 0.761 8.000
TOTAL: 923:49:14.475100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:09:40.193100.0%1251 61.000 463.783 15864.375
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.119 0.0%2951 0.000 0.040 2.833
TOTAL: 300:09:40.312100.0%----

Control commands to innd:

CommandNumber
flush 4
flushlogs 2
go 3
logmode 2
lowmark 1
mode 167
name 16
pause 3
paused 3
reload 4
reserve 2
xexec 4
TOTAL: 12 211

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 6 9178 3650 4844 684 39%43:26:36
2usenet.blueworldhosting.com 554 5640 538 4280 822 9%16:52:56
3news.tebibyte.org 3 5669 302 5288 79 5%39:23:10
4newsfeed.endofthelinebbs.com 3 1357 106 1095 156 7%11:36:16
5news.sklaffkom.se 37 61 50 6 5 81%07:32:46
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 628 21905 4646 15513 1746 21%118:51:44
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net11.2 MB85.9 KB2.1 MB13.4 MB 83%3.2 KB
2usenet.blueworldhosting.com1.7 MB17.0 KB1.3 MB3.0 MB 56%2.2 KB
3news.tebibyte.org993.2 KB32.6 KB279.9 KB1.3 MB 76%3.4 KB
4newsfeed.endofthelinebbs.com811.6 KB0.0 KB274.8 KB1.1 MB 74%4.1 KB
5news.sklaffkom.se122.7 KB0.0 KB7.5 KB130.2 KB 94%2.4 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 614.8 MB135.5 KB3.9 MB18.8 MB 78%3.0 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 23 03:00:03 - 03:59:59 92 1.9% 0.03295.2 KB 1.8% 0.08
Aug 23 04:00:00 - 04:59:59 75 1.6% 0.02237.7 KB 1.4% 0.07
Aug 23 05:00:00 - 05:59:59 83 1.8% 0.02319.6 KB 1.9% 0.09
Aug 23 06:00:00 - 06:59:59 78 1.7% 0.02192.2 KB 1.1% 0.05
Aug 23 07:00:00 - 07:59:59 92 1.9% 0.03251.0 KB 1.5% 0.07
Aug 23 08:00:00 - 08:59:59 124 2.6% 0.03319.3 KB 1.9% 0.09
Aug 23 09:00:00 - 09:59:59 244 5.2% 0.07866.9 KB 5.2% 0.24
Aug 23 10:00:00 - 10:59:59 194 4.1% 0.05438.5 KB 2.6% 0.12
Aug 23 11:00:00 - 11:59:59 256 5.4% 0.07554.5 KB 3.3% 0.15
Aug 23 12:00:00 - 12:59:59 223 4.7% 0.06664.0 KB 4.0% 0.18
Aug 23 13:00:00 - 13:59:59 188 4.0% 0.05594.9 KB 3.6% 0.17
Aug 23 14:00:00 - 14:59:59 196 4.2% 0.05525.6 KB 3.1% 0.15
Aug 23 15:00:00 - 15:59:59 247 5.2% 0.07746.3 KB 4.5% 0.21
Aug 23 16:00:00 - 16:59:59 203 4.3% 0.06695.0 KB 4.2% 0.19
Aug 23 17:00:00 - 17:59:59 179 3.8% 0.05585.1 KB 3.5% 0.16
Aug 23 18:00:00 - 18:59:59 229 4.8% 0.06733.2 KB 4.4% 0.20
Aug 23 19:00:00 - 19:59:59 263 5.6% 0.072.1 MB 12.8% 0.59
Aug 23 20:00:00 - 20:59:59 332 7.0% 0.091.6 MB 9.8% 0.45
Aug 23 21:00:00 - 21:59:59 345 7.3% 0.101.1 MB 6.6% 0.30
Aug 23 22:00:00 - 22:59:59 345 7.3% 0.101.1 MB 7.0% 0.32
Aug 23 23:00:00 - 23:59:59 225 4.8% 0.06769.4 KB 4.6% 0.21
Aug 24 00:00:00 - 00:59:59 219 4.6% 0.06805.9 KB 4.8% 0.22
Aug 24 01:00:00 - 01:59:59 165 3.5% 0.05623.4 KB 3.7% 0.17
Aug 24 02:00:00 - 02:59:59 116 2.5% 0.03452.4 KB 2.7% 0.13
Aug 24 03:00:00 - 03:00:03 9 0.2% 3.008.8 KB 0.1% 2.93
TOTAL: 24:00:00 4722 100.0% 0.0516.3 MB 100.0% 0.19
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 822 284 0 7 0 0 0 0 531
2twilightnode-out.news.weretis.net 670 423 0 24 0 0 0 0 223
3newsfeed.endofthelinebbs.com 199 14 0 1 0 0 0 0 184
4news.tebibyte.org 45 24 0 13 0 0 0 0 8
5news.sklaffkom.se 5 5 0 0 0 0 0 0 0
TOTAL: 5 1741 750 0 45 0 0 0 0 946

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 221
hispagatos.hacking.ransomware 38
lada.talk 23
uk.net.news.moderation 23
de.talk.jokes 21
fr.sci.physique 15
de.alt.fan.pluesch 13
de.soc.umwelt 13
linux.debian.maint.emacsen 13
it.sport.formula1 12
muc.lists.freebsd.bugs 12
alt.usage.english 11
no.alt.diskusjoner 11
pl.soc.prawo 11
muc.lists.freebsd.ports 10
dk.politik 9
pl.soc.polityka 9
uk.comp.sys.mac 9
wolfsburg.test 9
de.rec.heimwerken 8
TOTAL: 150 750

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 536
EMP (phl) 157
EMP (phn path) 107
Too many newsgroups 68
User-issued cancel 29
EMP (phr path) 9
HTML Multipart 6
Too many newsgroups (meow) 6
Binary: misplaced binary 1
TOTAL: 9 919

Miscellaneous innd events:

EventsCount
CCreader 3
TOTAL: 1 3

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 5784 2531 2114 22 1 41 43%23:59:48
2sklaffkom.se 4807 989 1496 2184 2 11 20%23:59:48
3newsfeed.endofthelinebbs.com 8678 33 4492 7 0 225 0%23:59:47
4weretis.net 980 4 928 1 0 0 0%21:01:15
5usenet.blueworldhosting.com 788439 2 3089 0784030 702 0%17:09:54
TOTAL: 5 808688 3559 12119 2214784033 979 0%110:10:32
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org6.6 MB479.4 KB7.1 MB0.1 KB/s2.8 KB23:59:48
2sklaffkom.se1.5 MB9.5 MB11.0 MB0.1 KB/s3.6 KB23:59:48
3newsfeed.endofthelinebbs.com92.3 KB10.0 KB102.3 KB0.0 KB/s2.6 KB23:59:47
4weretis.net11.4 KB218.3 KB229.7 KB0.0 KB/s45.9 KB21:01:15
5usenet.blueworldhosting.com3.1 KB0.0 KB3.1 KB0.0 KB/s1.6 KB17:09:54
TOTAL: 58.2 MB10.2 MB18.4 MB0.0 KB/s3.3 KB110:10:32
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1usenet.blueworldhosting.com 408 00.0 KB 0 0 000:05:00
284-231-161-217.elisa-mobile.fi 2 00.0 KB 0 0 000:04:13
3azpdesnraiee.stretchoid.com 2 00.0 KB 0 0 000:00:10
4128.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:00
547.77.228.10 1 00.0 KB 0 0 000:00:03
6o014.scanner.modat.io 1 00.0 KB 0 0 000:00:00
7zl-dfwc-us-gp1-wk107b.internet-census.org 1 00.0 KB 0 0 000:00:10
TOTAL: 7 416 00.0 KB 0 0 000:09:40

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.blueworldhosting.com 408 00.0 KB 0 0 000:05:00
2*.elisa-mobile.fi 2 00.0 KB 0 0 000:04:13
3*.stretchoid.com 2 00.0 KB 0 0 000:00:10
4*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:00
5*.internet-census.org 1 00.0 KB 0 0 000:00:10
6*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
7unresolved 1 00.0 KB 0 0 000:00:03
TOTAL: 7 416 00.0 KB 0 0 000:09:40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
usenet.blueworldhosting.com 1.646 2.881 0.00000:05:00
84-231-161-217.elisa-mobile.fi 0.011 0.040 0.00000:04:13
azpdesnraiee.stretchoid.com 0.008 0.020 0.00000:00:10
zl-dfwc-us-gp1-wk107b.internet-census.org 0.005 0.007 0.00000:00:10
47.77.228.10 0.005 0.007 0.00000:00:03
128.172.132.66.censys-scanner.com 0.023 0.012 0.00000:00:00
o014.scanner.modat.io 0.003 0.006 0.00000:00:00
TOTAL: 7 1.701 2.973 0.00000:09:40

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

SystemConn
47.77.228.10 3
128.172.132.66.censys-scanner.com 1
azpdesnraiee.stretchoid.com 1
TOTAL: 3 5

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

CommandCount
#023#001#023#002#023#003#001 1
#026#003#001 1
?#024 1
EHLO www.censys.io 1
MGLNDD_172.234.115.63_119 1
TOTAL: 5 5

NNRP client timeouts [Top 20]:

SystemConnPeer
47.77.228.10 1 1
TOTAL: 1 1 1
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