Daily Usenet report

Jun 3 03:00:05 -- Jun 4 03:00:05

Unknown entries from news log file:

First 50 / 1476 lines (3.4%)

Jun 3 03:00:35 twilightnode nnrpd[1147906]: Reading access from /usr/local/news/etc/readers.conf
Jun 3 03:00:35 twilightnode nnrpd[1147906]: Auth strategy 'localhost' does not match client. Removing.
Jun 3 03:00:35 twilightnode nnrpd[1147906]: 195-252-55-9-no600.tbcn.telia.com res <anonymous>
Jun 3 03:00:35 twilightnode nnrpd[1147906]: 195-252-55-9-no600.tbcn.telia.com no_match_user <anonymous> <localhost>
Jun 3 03:00:35 twilightnode nnrpd[1147906]: 195-252-55-9-no600.tbcn.telia.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 3 03:00:35 twilightnode nnrpd[1147906]: 195-252-55-9-no600.tbcn.telia.com match_user <anonymous> <anonymous>
Jun 3 03:00:35 twilightnode nnrpd[1147906]: 195-252-55-9-no600.tbcn.telia.com no_post anonymous-read
Jun 3 03:01:23 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Jun 3 06:56:32 twilightnode nnrpd[1157848]: Reading access from /usr/local/news/etc/readers.conf
Jun 3 06:56:32 twilightnode nnrpd[1157848]: Auth strategy 'localhost' does not match client. Removing.
Jun 3 06:56:32 twilightnode nnrpd[1157848]: prod47client01.academyforinternetresearch.org res <anonymous>
Jun 3 06:56:32 twilightnode nnrpd[1157848]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> <localhost>
Jun 3 06:56:32 twilightnode nnrpd[1157848]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 3 06:56:32 twilightnode nnrpd[1157848]: prod47client01.academyforinternetresearch.org match_user <anonymous> <anonymous>
Jun 3 06:56:32 twilightnode nnrpd[1157848]: prod47client01.academyforinternetresearch.org no_post anonymous-read
Jun 3 06:56:46 twilightnode nnrpd[1157850]: Reading access from /usr/local/news/etc/readers.conf
Jun 3 06:56:46 twilightnode nnrpd[1157850]: Auth strategy 'localhost' does not match client. Removing.
Jun 3 06:56:46 twilightnode nnrpd[1157850]: prod47client01.academyforinternetresearch.org res <anonymous>
Jun 3 06:56:46 twilightnode nnrpd[1157850]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> <localhost>
Jun 3 06:56:46 twilightnode nnrpd[1157850]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 3 06:56:46 twilightnode nnrpd[1157850]: prod47client01.academyforinternetresearch.org match_user <anonymous> <anonymous>
Jun 3 06:56:46 twilightnode nnrpd[1157850]: prod47client01.academyforinternetresearch.org no_post anonymous-read
Jun 3 07:00:06 twilightnode nnrpd[1158662]: Reading access from /usr/local/news/etc/readers.conf
Jun 3 07:00:06 twilightnode nnrpd[1158662]: Auth strategy 'localhost' does not match client. Removing.
Jun 3 07:00:06 twilightnode nnrpd[1158662]: prod47client01.academyforinternetresearch.org res <anonymous>
Jun 3 07:00:06 twilightnode nnrpd[1158662]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> <localhost>
Jun 3 07:00:06 twilightnode nnrpd[1158662]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 3 07:00:06 twilightnode nnrpd[1158662]: prod47client01.academyforinternetresearch.org match_user <anonymous> <anonymous>
Jun 3 07:00:06 twilightnode nnrpd[1158662]: prod47client01.academyforinternetresearch.org no_post anonymous-read
Jun 3 07:00:06 twilightnode nnrpd[1158664]: Reading access from /usr/local/news/etc/readers.conf
Jun 3 07:00:06 twilightnode nnrpd[1158664]: Auth strategy 'localhost' does not match client. Removing.
Jun 3 07:00:06 twilightnode nnrpd[1158664]: prod47client01.academyforinternetresearch.org res <anonymous>
Jun 3 07:00:06 twilightnode nnrpd[1158664]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> <localhost>
Jun 3 07:00:06 twilightnode nnrpd[1158664]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 3 07:00:06 twilightnode nnrpd[1158664]: prod47client01.academyforinternetresearch.org match_user <anonymous> <anonymous>
Jun 3 07:00:06 twilightnode nnrpd[1158664]: prod47client01.academyforinternetresearch.org no_post anonymous-read
Jun 3 07:00:07 twilightnode nnrpd[1158664]: prod47client01.academyforinternetresearch.org res <anonymous>
Jun 3 07:00:07 twilightnode nnrpd[1158664]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> <localhost>
Jun 3 07:00:07 twilightnode nnrpd[1158664]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 3 07:00:07 twilightnode nnrpd[1158664]: prod47client01.academyforinternetresearch.org match_user <anonymous> <anonymous>
Jun 3 07:00:07 twilightnode nnrpd[1158664]: prod47client01.academyforinternetresearch.org no_post anonymous-read
Jun 3 07:00:07 twilightnode nnrpd[1158668]: Reading access from /usr/local/news/etc/readers.conf
Jun 3 07:00:07 twilightnode nnrpd[1158668]: Auth strategy 'localhost' does not match client. Removing.
Jun 3 07:00:07 twilightnode nnrpd[1158668]: prod47client01.academyforinternetresearch.org res <anonymous>
Jun 3 07:00:07 twilightnode nnrpd[1158668]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> <localhost>
Jun 3 07:00:07 twilightnode nnrpd[1158668]: prod47client01.academyforinternetresearch.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 3 07:00:07 twilightnode nnrpd[1158668]: prod47client01.academyforinternetresearch.org match_user <anonymous> <anonymous>
Jun 3 07:00:07 twilightnode nnrpd[1158668]: prod47client01.academyforinternetresearch.org no_post anonymous-read
Jun 3 07:00:37 twilightnode nnrpd[1158694]: Reading access from /usr/local/news/etc/readers.conf
Jun 3 07:00:37 twilightnode nnrpd[1158694]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 5203 58.6%794.2 KB 62.8%
nnrpd 1890 21.3%219.2 KB 17.3%
innfeed 1162 13.1%135.7 KB 10.7%
innd 625 7.0%116.4 KB 9.2%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 8882 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 5600 35.3%
Do not exist 5141 32.4%
Positive hits 5130 32.3%
Cache misses 3 0.0%
TOTAL: 4 15874 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.005 0.0%3 1.000 1.667 2.000
article cleanup00:00:00.066 0.0%5168 0.000 0.013 0.105
article logging00:00:00.175 0.0%5211 0.000 0.034 0.312
article parse00:00:00.064 0.0%6132 0.000 0.010 0.091
article write00:00:03.000 0.0%3777 0.250 0.794 4.917
data move00:00:00.052 0.0%16952 0.000 0.003 0.041
hisgrep/artcncl00:00:00.002 0.0%3 0.000 0.667 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.812 0.0%15955 0.100 0.239 0.747
history sync00:00:00.050 0.0%415 0.000 0.120 0.667
history write00:00:02.701 0.0%5168 0.167 0.523 1.000
idle24:00:41.942100.0%17200 2265.970 5025.694 24003.160
nntp read00:00:00.417 0.0%16623 0.000 0.025 0.075
overview write00:00:01.808 0.0%3777 0.167 0.479 1.688
perl filter00:00:10.103 0.0%5168 1.222 1.955 15.895
python filter00:00:00.758 0.0%5168 0.000 0.147 1.263
site send00:00:00.128 0.0%3777 0.000 0.034 0.167
TOTAL: 1724:01:05.083100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.031 0.0%3755 0.000 0.008 0.083
article prepare00:00:00.002 0.0%30020 0.000 0.000 0.006
article read00:00:00.619 0.0%3755 0.000 0.165 0.739
backlog stats00:00:00.032 0.0%21582 0.000 0.001 0.014
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.201 0.0%11998 0.000 0.017 0.080
data write00:00:00.223 0.0%8292 0.000 0.027 0.111
idle23:50:30.426100.0%21582 2463.918 3976.945 8460.690
status file00:00:00.207 0.0%175 0.000 1.183 17.000
TOTAL: 923:50:31.741100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:11:02.065100.0%136 8.000 4868.125300035.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.011 0.0%415 0.000 0.027 1.000
TOTAL: 300:11:02.076100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 3 10076 3758 4934 1384 37%46:44:09
2localhost 25 0 0 0 0 0%00:00:00
3news.chimia.se 1 0 0 0 0 0%00:10:00
TOTAL: 3 29 10076 3758 4934 1384 37%46:54:09
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net10.2 MB0.0 KB4.2 MB14.4 MB 70%2.9 KB
2localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
3news.chimia.se0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 310.2 MB0.0 KB4.2 MB14.4 MB 70%2.9 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 3 03:00:05 - 03:59:59 70 1.9% 0.02226.8 KB 2.1% 0.06
Jun 3 04:00:00 - 04:59:59 101 2.7% 0.03258.1 KB 2.4% 0.07
Jun 3 05:00:00 - 05:59:59 95 2.5% 0.03210.8 KB 2.0% 0.06
Jun 3 06:00:00 - 06:59:59 83 2.2% 0.02197.8 KB 1.8% 0.05
Jun 3 07:00:00 - 07:59:59 123 3.3% 0.03312.0 KB 2.9% 0.09
Jun 3 08:00:00 - 08:59:59 166 4.4% 0.05464.5 KB 4.3% 0.13
Jun 3 09:00:00 - 09:59:59 186 4.9% 0.05467.4 KB 4.4% 0.13
Jun 3 10:00:00 - 10:59:59 205 5.4% 0.06461.6 KB 4.3% 0.13
Jun 3 11:00:00 - 11:59:59 204 5.4% 0.06501.9 KB 4.7% 0.14
Jun 3 12:00:00 - 12:59:59 171 4.5% 0.05421.1 KB 3.9% 0.12
Jun 3 13:00:00 - 13:59:59 197 5.2% 0.05527.1 KB 4.9% 0.15
Jun 3 14:00:00 - 14:59:59 158 4.2% 0.04347.5 KB 3.2% 0.10
Jun 3 15:00:00 - 15:59:59 189 5.0% 0.05498.3 KB 4.6% 0.14
Jun 3 16:00:00 - 16:59:59 214 5.7% 0.06862.9 KB 8.0% 0.24
Jun 3 17:00:00 - 17:59:59 201 5.3% 0.06591.3 KB 5.5% 0.16
Jun 3 18:00:00 - 18:59:59 198 5.3% 0.06522.9 KB 4.9% 0.15
Jun 3 19:00:00 - 19:59:59 195 5.2% 0.05479.6 KB 4.5% 0.13
Jun 3 20:00:00 - 20:59:59 217 5.8% 0.06696.1 KB 6.5% 0.19
Jun 3 21:00:00 - 21:59:59 169 4.5% 0.05534.2 KB 5.0% 0.15
Jun 3 22:00:00 - 22:59:59 145 3.8% 0.04357.0 KB 3.3% 0.10
Jun 3 23:00:00 - 23:59:59 154 4.1% 0.04438.6 KB 4.1% 0.12
Jun 4 00:00:00 - 00:59:59 104 2.8% 0.03387.6 KB 3.6% 0.11
Jun 4 01:00:00 - 01:59:59 111 2.9% 0.03719.0 KB 6.7% 0.20
Jun 4 02:00:00 - 02:59:59 103 2.7% 0.03244.6 KB 2.3% 0.07
Jun 4 03:00:00 - 03:00:05 9 0.2% 1.807.5 KB 0.1% 1.50
TOTAL: 24:00:00 3768 100.0% 0.0410.5 MB 100.0% 0.12
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1435 1360 0 0 0 0 0 0 75
TOTAL: 1 1435 1360 0 0 0 0 0 0 75

Unwanted newsgroups [Top 20]:

NewsgroupCount
pl.soc.prawo 70
uk.d-i-y 56
it.sport.calcio.milan 54
uk.legal.moderated 48
nl.politiek 46
it.discussioni.auto 37
fr.sci.maths 36
uk.religion.christian 34
fido7.crimea.talk 29
alt.prophecies.nostradamus 28
alt.usage.english 21
bln.test 21
de.alt.talk.unmut 21
it.hobby.cucina 21
cn.comp 20
it.sport.calcio.inter-fc 19
eternal-september.test 18
de.talk.jokes 17
dk.politik 17
fido7.ru.fidonet.today 16
TOTAL: 214 1360

Perl filter (innd) [Top 20]:

ReasonCount
User-issued cancel 15
Too many newsgroups (meow) 7
EMP (md5) 6
HTML Multipart 3
Too many newsgroups 2
TOTAL: 5 33

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1chimia.se 3770 3768 0 0 0 0 99%23:59:23
2thebunker.nu 3773 3571 0 200 0 2 94%23:59:55
3sklaff.dev 0 0 0 0 0 3763 0%23:57:39
4usenet.blueworldhosting.com 0 0 0 0 0 3278 0%23:59:55
5weretis.net 0 0 0 0 0 0 0%00:10:30
TOTAL: 5 7543 7339 0 200 0 7043 97%96:07:22
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1chimia.se10.5 MB0.0 KB10.5 MB0.1 KB/s2.9 KB23:59:23
2thebunker.nu9.4 MB1.1 MB10.5 MB0.1 KB/s2.9 KB23:59:55
3sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:39
4usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
5weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:30
TOTAL: 519.9 MB1.1 MB21.0 MB0.1 KB/s2.9 KB96:07:22
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1139-162-186-99.ip.linodeusercontent.com 60 00.0 KB 0 0 000:00:23
2prod47client01.academyforinternetresearch.org 60 00.0 KB 0 0 000:00:21
3azpdcgcto85s.stretchoid.com 2 00.0 KB 0 0 000:00:10
4195-252-55-9-no600.tbcn.telia.com 1 00.0 KB 0 0 000:10:00
5217.146.80.117 1 00.0 KB 0 0 000:00:00
6225.224.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
762.164.177.41 1 00.0 KB 0 0 000:00:02
869.5.169.10 1 00.0 KB 0 0 000:00:00
969.5.169.7 1 00.0 KB 0 0 000:00:00
1069.5.169.89 1 00.0 KB 0 0 000:00:00
11ec2-54-177-253-151.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
TOTAL: 11 130 00.0 KB 0 0 000:11:02

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.academyforinternetresearch.org 60 00.0 KB 0 0 000:00:21
2*.ip.linodeusercontent.com 60 00.0 KB 0 0 000:00:23
3unresolved 5 00.0 KB 0 0 000:00:03
4*.stretchoid.com 2 00.0 KB 0 0 000:00:10
5*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
6*.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
7*.tbcn.telia.com 1 00.0 KB 0 0 000:10:00
TOTAL: 7 130 00.0 KB 0 0 000:11:02

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
195-252-55-9-no600.tbcn.telia.com 0.005 0.016 0.00000:10:00
139-162-186-99.ip.linodeusercontent.com 1.698 0.480 0.00000:00:23
prod47client01.academyforinternetresearch.org 2.068 0.553 0.00000:00:21
azpdcgcto85s.stretchoid.com 0.009 0.019 0.00000:00:10
225.224.132.66.censys-scanner.com 0.026 0.023 0.00000:00:03
62.164.177.41 0.006 0.014 0.00000:00:02
69.5.169.7 0.003 0.010 0.00000:00:00
69.5.169.10 0.004 0.009 0.00000:00:00
217.146.80.117 0.004 0.012 0.00000:00:00
ec2-54-177-253-151.us-west-1.compute.amazonaws.com 0.003 0.015 0.00000:00:00
69.5.169.89 0.004 0.016 0.00000:00:00
TOTAL: 11 3.830 1.167 0.00000:11:02

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

SystemConn
225.224.132.66.censys-scanner.com 1
62.164.177.41 1
azpdcgcto85s.stretchoid.com 1
TOTAL: 3 3

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

CommandCount
#003 1
EHLO www.censys.io 1
MGLNDD_172.234.115.63_119 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
139-162-186-99.ip.linodeusercontent.com 1 1
62.164.177.41 1 1
69.5.169.10 1 1
69.5.169.7 1 1
prod47client01.academyforinternetresearch.org 1 1
TOTAL: 5 5 7
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