Daily Usenet report

Aug 16 03:00:04 -- Aug 17 03:00:04

Unknown entries from news log file:

First 50 / 11582 lines (0.4%)

Aug 16 03:00:54 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Aug 16 03:02:00 twilightnode nnrpd[1433170]: Reading access from /usr/local/news/etc/readers.conf
Aug 16 03:02:00 twilightnode nnrpd[1433171]: Reading access from /usr/local/news/etc/readers.conf
Aug 16 03:02:00 twilightnode nnrpd[1433170]: Auth strategy 'localhost' does not match client. Removing.
Aug 16 03:02:00 twilightnode nnrpd[1433170]: usenet.blueworldhosting.com res <anonymous>
Aug 16 03:02:00 twilightnode nnrpd[1433170]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 16 03:02:00 twilightnode nnrpd[1433170]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 16 03:02:00 twilightnode nnrpd[1433170]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 16 03:02:00 twilightnode nnrpd[1433170]: usenet.blueworldhosting.com no_post anonymous-read
Aug 16 03:02:00 twilightnode nnrpd[1433171]: Auth strategy 'localhost' does not match client. Removing.
Aug 16 03:02:00 twilightnode nnrpd[1433171]: usenet.blueworldhosting.com res <anonymous>
Aug 16 03:02:00 twilightnode nnrpd[1433171]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 16 03:02:00 twilightnode nnrpd[1433171]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 16 03:02:00 twilightnode nnrpd[1433171]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 16 03:02:00 twilightnode nnrpd[1433171]: usenet.blueworldhosting.com no_post anonymous-read
Aug 16 03:02:00 twilightnode nnrpd[1433170]: usenet.blueworldhosting.com noperm ihave without permission
Aug 16 03:02:00 twilightnode nnrpd[1433171]: usenet.blueworldhosting.com noperm ihave without permission
Aug 16 03:04:00 twilightnode nnrpd[1433335]: Reading access from /usr/local/news/etc/readers.conf
Aug 16 03:04:00 twilightnode nnrpd[1433335]: Auth strategy 'localhost' does not match client. Removing.
Aug 16 03:04:00 twilightnode nnrpd[1433335]: usenet.blueworldhosting.com res <anonymous>
Aug 16 03:04:00 twilightnode nnrpd[1433335]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 16 03:04:00 twilightnode nnrpd[1433335]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 16 03:04:00 twilightnode nnrpd[1433335]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 16 03:04:00 twilightnode nnrpd[1433335]: usenet.blueworldhosting.com no_post anonymous-read
Aug 16 03:04:00 twilightnode nnrpd[1433336]: Reading access from /usr/local/news/etc/readers.conf
Aug 16 03:04:00 twilightnode nnrpd[1433336]: Auth strategy 'localhost' does not match client. Removing.
Aug 16 03:04:00 twilightnode nnrpd[1433336]: usenet.blueworldhosting.com res <anonymous>
Aug 16 03:04:00 twilightnode nnrpd[1433336]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 16 03:04:00 twilightnode nnrpd[1433336]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 16 03:04:00 twilightnode nnrpd[1433336]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 16 03:04:00 twilightnode nnrpd[1433336]: usenet.blueworldhosting.com no_post anonymous-read
Aug 16 03:04:00 twilightnode nnrpd[1433335]: usenet.blueworldhosting.com noperm ihave without permission
Aug 16 03:04:00 twilightnode nnrpd[1433336]: usenet.blueworldhosting.com noperm ihave without permission
Aug 16 03:06:00 twilightnode nnrpd[1433478]: Reading access from /usr/local/news/etc/readers.conf
Aug 16 03:06:00 twilightnode nnrpd[1433479]: Reading access from /usr/local/news/etc/readers.conf
Aug 16 03:06:00 twilightnode nnrpd[1433478]: Auth strategy 'localhost' does not match client. Removing.
Aug 16 03:06:00 twilightnode nnrpd[1433478]: usenet.blueworldhosting.com res <anonymous>
Aug 16 03:06:00 twilightnode nnrpd[1433478]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 16 03:06:00 twilightnode nnrpd[1433478]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 16 03:06:00 twilightnode nnrpd[1433478]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 16 03:06:00 twilightnode nnrpd[1433478]: usenet.blueworldhosting.com no_post anonymous-read
Aug 16 03:06:00 twilightnode nnrpd[1433479]: Auth strategy 'localhost' does not match client. Removing.
Aug 16 03:06:00 twilightnode nnrpd[1433479]: usenet.blueworldhosting.com res <anonymous>
Aug 16 03:06:00 twilightnode nnrpd[1433479]: usenet.blueworldhosting.com no_match_user <anonymous> <localhost>
Aug 16 03:06:00 twilightnode nnrpd[1433479]: usenet.blueworldhosting.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 16 03:06:00 twilightnode nnrpd[1433479]: usenet.blueworldhosting.com match_user <anonymous> <anonymous>
Aug 16 03:06:00 twilightnode nnrpd[1433479]: usenet.blueworldhosting.com no_post anonymous-read
Aug 16 03:06:00 twilightnode nnrpd[1433478]: usenet.blueworldhosting.com noperm ihave without permission
Aug 16 03:06:00 twilightnode nnrpd[1433479]: usenet.blueworldhosting.com noperm ihave without permission
Aug 16 03:08:00 twilightnode nnrpd[1433488]: Reading access from /usr/local/news/etc/readers.conf

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 15939 64.1%1.7 MB 56.3%
inn 6169 24.8%938.3 KB 31.1%
innd 1394 5.6%180.6 KB 6.0%
innfeed 1367 5.5%199.7 KB 6.6%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 24870 100.0%2.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 14253 49.6%
Negative hits 8374 29.1%
Do not exist 6108 21.3%
Cache misses 0 0.0%
TOTAL: 4 28735 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.011 0.0%4 2.000 2.750 5.000
article cleanup00:00:00.043 0.0%6133 0.000 0.007 0.050
article logging00:00:00.229 0.0%6164 0.000 0.037 0.222
article parse00:00:00.121 0.0%7967 0.000 0.015 0.077
article write00:00:04.330 0.0%4648 0.524 0.932 2.000
data move00:00:00.102 0.0%30358 0.000 0.003 0.024
hisgrep/artcncl00:00:00.006 0.0%4 1.000 1.500 3.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.781 0.0%28843 0.061 0.131 0.378
history sync00:00:00.091 0.0%306 0.000 0.297 2.000
history write00:00:02.869 0.0%6133 0.083 0.468 1.111
idle23:59:55.717100.0%33032 1227.450 2615.516 11767.980
nntp read00:00:00.618 0.0%29948 0.000 0.021 0.096
overview write00:00:02.314 0.0%4648 0.000 0.498 2.000
perl filter00:00:11.764 0.0%6133 1.000 1.918 6.805
python filter00:00:00.856 0.0%6133 0.000 0.140 0.732
site send00:00:00.116 0.0%4630 0.000 0.025 0.238
TOTAL: 1724:00:22.968100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%4879 0.000 0.004 0.143
article prepare00:00:00.004 0.0%16404 0.000 0.000 0.012
article read00:00:00.605 0.0%3083 0.000 0.196 1.500
backlog stats00:00:00.050 0.0%52195 0.000 0.001 0.020
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.358 0.0%27976 0.000 0.013 0.045
data write00:00:00.601 0.0%23334 0.000 0.026 0.065
idle23:50:27.863100.0%52195 579.493 1644.369 5883.667
status file00:00:00.204 0.0%305 0.000 0.669 4.000
TOTAL: 923:50:29.704100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:17:50.340100.0%4333 144.333 247.021 3181.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.215 0.0%10123 0.000 0.021 0.714
TOTAL: 300:17:50.555100.0%----

Control commands to innd:

CommandNumber
flush 2
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 166

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 5 11233 4338 5889 1006 38%49:41:49
2newsfeed.endofthelinebbs.com 2 3181 166 2663 352 5%18:22:30
3news.tebibyte.org 1 4899 58 4800 41 1%23:59:50
4news.sklaffkom.se 26 69 29 19 21 42%07:28:52
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 59 19382 4591 13371 1420 23%99:33:01
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net12.5 MB0.0 KB3.4 MB15.9 MB 78%3.0 KB
2newsfeed.endofthelinebbs.com1.9 MB0.0 KB1.1 MB3.0 MB 63%6.0 KB
3news.tebibyte.org190.9 KB0.0 KB73.9 KB264.7 KB 72%2.7 KB
4news.sklaffkom.se75.1 KB0.0 KB49.2 KB124.4 KB 60%2.5 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 514.7 MB0.0 KB4.6 MB19.3 MB 76%3.3 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 16 03:00:04 - 03:59:59 93 2.0% 0.03286.5 KB 1.8% 0.08
Aug 16 04:00:00 - 04:59:59 75 1.6% 0.02997.9 KB 6.4% 0.28
Aug 16 05:00:00 - 05:59:59 98 2.1% 0.03292.4 KB 1.9% 0.08
Aug 16 06:00:00 - 06:59:59 73 1.6% 0.02160.0 KB 1.0% 0.04
Aug 16 07:00:00 - 07:59:59 119 2.6% 0.03448.0 KB 2.9% 0.12
Aug 16 08:00:00 - 08:59:59 176 3.8% 0.05561.1 KB 3.6% 0.16
Aug 16 09:00:00 - 09:59:59 183 3.9% 0.05477.0 KB 3.1% 0.13
Aug 16 10:00:00 - 10:59:59 216 4.6% 0.06570.1 KB 3.7% 0.16
Aug 16 11:00:00 - 11:59:59 201 4.3% 0.06473.9 KB 3.0% 0.13
Aug 16 12:00:00 - 12:59:59 293 6.3% 0.08814.4 KB 5.2% 0.23
Aug 16 13:00:00 - 13:59:59 226 4.9% 0.06599.0 KB 3.8% 0.17
Aug 16 14:00:00 - 14:59:59 286 6.1% 0.08877.0 KB 5.6% 0.24
Aug 16 15:00:00 - 15:59:59 310 6.7% 0.09915.4 KB 5.9% 0.25
Aug 16 16:00:00 - 16:59:59 236 5.1% 0.07715.4 KB 4.6% 0.20
Aug 16 17:00:00 - 17:59:59 192 4.1% 0.05512.8 KB 3.3% 0.14
Aug 16 18:00:00 - 18:59:59 279 6.0% 0.081.0 MB 6.7% 0.29
Aug 16 19:00:00 - 19:59:59 262 5.6% 0.07757.4 KB 4.9% 0.21
Aug 16 20:00:00 - 20:59:59 253 5.4% 0.07816.4 KB 5.2% 0.23
Aug 16 21:00:00 - 21:59:59 273 5.9% 0.081.0 MB 6.7% 0.29
Aug 16 22:00:00 - 22:59:59 212 4.6% 0.06849.2 KB 5.4% 0.24
Aug 16 23:00:00 - 23:59:59 169 3.6% 0.05640.8 KB 4.1% 0.18
Aug 17 00:00:00 - 00:59:59 178 3.8% 0.05527.8 KB 3.4% 0.15
Aug 17 01:00:00 - 01:59:59 149 3.2% 0.04821.8 KB 5.3% 0.23
Aug 17 02:00:00 - 02:59:59 90 1.9% 0.03373.3 KB 2.4% 0.10
Aug 17 03:00:00 - 03:00:04 13 0.3% 3.2524.6 KB 0.2% 6.15
TOTAL: 24:00:00 4655 100.0% 0.0515.2 MB 100.0% 0.18
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1038 954 0 0 0 0 0 0 84
2newsfeed.endofthelinebbs.com 427 68 0 0 0 0 0 0 359
3news.tebibyte.org 28 28 0 0 0 0 0 0 0
4news.sklaffkom.se 21 21 0 0 0 0 0 0 0
TOTAL: 4 1514 1071 0 0 0 0 0 0 443

Unwanted newsgroups [Top 20]:

NewsgroupCount
pl.soc.polityka 74
alt.usage.english 68
uk.net.news.moderation 56
alt.checkmate 54
hfx.general 35
alt.atheism 29
de.alt.fan.pluesch 29
uk.legal.moderated 23
cn.comp 19
aus.politics 18
dk.politik 18
pl.misc.elektronika 18
pl.pregierz 18
de.talk.jokes 17
edm.general 15
alt.prophecies.nostradamus 14
linux.debian.project 14
muc.lists.freebsd.bugs 14
pl.sci.fizyka 14
aus.computers 12
TOTAL: 181 1071

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 360
User-issued cancel 32
Too many newsgroups (meow) 11
HTML Multipart 3
Too many newsgroups 3
TOTAL: 5 409

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 6627 1076 3555 6 0 15 16%23:59:10
2sklaffkom.se 4876 848 1622 2168 0 0 17%23:59:58
3newsfeed.endofthelinebbs.com 8419 21 4400 8 0 246 0%23:59:57
4weretis.net 322 0 313 0 0 0 0%19:28:12
TOTAL: 4 20244 1945 9890 2182 0 261 9%91:27:17
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org3.2 MB33.3 KB3.2 MB0.0 KB/s3.1 KB23:59:10
2sklaffkom.se1.4 MB8.7 MB10.1 MB0.1 KB/s3.4 KB23:59:58
3newsfeed.endofthelinebbs.com48.8 KB17.6 KB66.5 KB0.0 KB/s2.3 KB23:59:57
4weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s019:28:12
TOTAL: 44.7 MB8.7 MB13.4 MB0.0 KB/s3.3 KB91:27:17
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1usenet.blueworldhosting.com1440 00.0 KB 0 0 000:17:36
2172-99-61-198.e55debe299579139e7cfe9be84b63964.ip.frontiernet.net 1 00.0 KB 0 0 000:00:00
3193.176.29.20 1 00.0 KB 0 0 000:00:00
4198.235.24.161 1 00.0 KB 0 0 000:00:00
5213.166.84.44 1 00.0 KB 0 0 000:00:00
637.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
764.89.162.15 1 00.0 KB 0 0 000:00:04
8safwan.probe.onyphe.net 1 00.0 KB 0 0 000:00:01
9tiago.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
TOTAL: 91448 00.0 KB 0 0 000:17:50

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.blueworldhosting.com1440 00.0 KB 0 0 000:17:36
2unresolved 4 00.0 KB 0 0 000:00:06
3*.probe.onyphe.net 2 00.0 KB 0 0 000:00:04
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
TOTAL: 51448 00.0 KB 0 0 000:17:50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
usenet.blueworldhosting.com 5.381 9.459 0.00000:17:36
64.89.162.15 0.004 0.006 0.00000:00:04
tiago.probe.onyphe.net 0.002 0.006 0.00000:00:03
37.195.132.66.censys-scanner.com 0.034 0.007 0.00000:00:02
safwan.probe.onyphe.net 0.004 0.006 0.00000:00:01
198.235.24.161 0.004 0.005 0.00000:00:00
213.166.84.44 0.004 0.013 0.00000:00:00
172-99-61-198.e55debe299579139e7cfe9be84b63964.ip.frontiernet.net 0.003 0.011 0.00000:00:00
193.176.29.20 0.005 0.005 0.00000:00:00
TOTAL: 9 5.441 9.518 0.00000:17:50

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

SystemConn
safwan.probe.onyphe.net 2
37.195.132.66.censys-scanner.com 1
64.89.162.15 1
TOTAL: 3 4

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

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

NNRP client timeouts [Top 20]:

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