Daily Usenet report

May 28 03:00:05 -- May 29 03:00:05

Unknown entries from news log file:

First 44 / 44 lines (100.0%)

May 28 03:01:37 mail innd: message repeated 2 times: [ ctlinnd command s]
May 28 06:08:00 mail nnrpd[714022]: Reading access from /usr/local/news/etc/readers.conf
May 28 06:08:00 mail nnrpd[714022]: Auth strategy 'localhost' does not match client. Removing.
May 28 06:08:00 mail nnrpd[714022]: 205.210.31.151 no_success_auth
May 28 10:00:39 twilightnode nnrpd[726678]: Reading access from /usr/local/news/etc/readers.conf
May 28 10:00:39 twilightnode nnrpd[726678]: Auth strategy 'localhost' does not match client. Removing.
May 28 10:00:39 twilightnode nnrpd[726678]: 71.6.235.244 no_success_auth
May 28 10:00:42 twilightnode nnrpd[726683]: Reading access from /usr/local/news/etc/readers.conf
May 28 10:00:42 twilightnode nnrpd[726683]: Auth strategy 'localhost' does not match client. Removing.
May 28 10:00:42 twilightnode nnrpd[726683]: 71.6.235.244 no_success_auth
May 28 10:01:53 twilightnode nnrpd[726719]: Reading access from /usr/local/news/etc/readers.conf
May 28 10:01:53 twilightnode nnrpd[726719]: Auth strategy 'localhost' does not match client. Removing.
May 28 10:01:53 twilightnode nnrpd[726719]: 71.6.235.244 no_success_auth
May 28 11:19:07 twilightnode nnrpd[731110]: Reading access from /usr/local/news/etc/readers.conf
May 28 11:19:07 twilightnode nnrpd[731110]: Auth strategy 'localhost' does not match client. Removing.
May 28 11:19:07 twilightnode nnrpd[731110]: azpdsgebcoxy.stretchoid.com no_success_auth
May 28 11:19:18 twilightnode nnrpd[731118]: Reading access from /usr/local/news/etc/readers.conf
May 28 11:19:18 twilightnode nnrpd[731118]: Auth strategy 'localhost' does not match client. Removing.
May 28 11:19:18 twilightnode nnrpd[731118]: azpdsgebcoxy.stretchoid.com no_success_auth
May 28 11:22:54 twilightnode nnrpd[731308]: Reading access from /usr/local/news/etc/readers.conf
May 28 11:22:54 twilightnode nnrpd[731308]: Auth strategy 'localhost' does not match client. Removing.
May 28 11:22:54 twilightnode nnrpd[731308]: 179.149.216.162.bc.googleusercontent.com no_success_auth
May 28 19:22:15 twilightnode nnrpd[759070]: Reading access from /usr/local/news/etc/readers.conf
May 28 19:22:15 twilightnode nnrpd[759070]: Auth strategy 'localhost' does not match client. Removing.
May 28 19:22:15 twilightnode nnrpd[759070]: 194.88.98.111 no_success_auth
May 28 19:31:10 twilightnode nnrpd[759589]: Reading access from /usr/local/news/etc/readers.conf
May 28 19:31:10 twilightnode nnrpd[759589]: Auth strategy 'localhost' does not match client. Removing.
May 28 19:31:10 twilightnode nnrpd[759589]: 69.5.169.64 no_success_auth
May 28 21:10:32 twilightnode nnrpd[765167]: Reading access from /usr/local/news/etc/readers.conf
May 28 21:10:32 twilightnode nnrpd[765167]: Auth strategy 'localhost' does not match client. Removing.
May 28 21:10:32 twilightnode nnrpd[765167]: 69.5.169.187 no_success_auth
May 28 21:10:38 twilightnode nnrpd[765170]: Reading access from /usr/local/news/etc/readers.conf
May 28 21:10:38 twilightnode nnrpd[765170]: Auth strategy 'localhost' does not match client. Removing.
May 28 21:10:38 twilightnode nnrpd[765170]: 69.5.169.32 no_success_auth
May 28 21:38:36 twilightnode nnrpd[766636]: Reading access from /usr/local/news/etc/readers.conf
May 28 21:38:36 twilightnode nnrpd[766636]: Auth strategy 'localhost' does not match client. Removing.
May 28 21:38:36 twilightnode nnrpd[766636]: 79.224.132.66.censys-scanner.com no_success_auth
May 28 21:38:36 twilightnode nnrpd[766636]: 79.224.132.66.censys-scanner.com no_success_auth
May 29 00:27:18 twilightnode nnrpd[775779]: Reading access from /usr/local/news/etc/readers.conf
May 29 00:27:18 twilightnode nnrpd[775779]: Auth strategy 'localhost' does not match client. Removing.
May 29 00:27:18 twilightnode nnrpd[775779]: r4-127-7f.monitoring.internet-measurement.com no_success_auth
May 29 03:00:04 twilightnode nnrpd[783100]: Reading access from /usr/local/news/etc/readers.conf
May 29 03:00:04 twilightnode nnrpd[783100]: Auth strategy 'localhost' does not match client. Removing.
May 29 03:00:04 twilightnode nnrpd[783100]: 195-252-55-9-no600.tbcn.telia.com no_success_auth

Log entries by program:

Program nameLines%LinesSize%Size
inn 5877 68.5%866.4 KB 70.1%
innd 1401 16.3%202.1 KB 16.3%
innfeed 1189 13.9%156.6 KB 12.7%
nnrpd 113 1.3%11.7 KB 0.9%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 8582 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 6404 35.4%
Do not exist 5840 32.3%
Positive hits 5830 32.3%
Cache misses 2 0.0%
TOTAL: 4 18076 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.006 0.0%2 3.000 3.000 3.000
article cleanup00:00:00.056 0.0%5862 0.000 0.010 0.094
article logging00:00:00.253 0.0%5881 0.000 0.043 0.150
article parse00:00:00.100 0.0%7334 0.000 0.014 0.103
article write00:00:02.463 0.0%3099 0.276 0.795 2.091
data move00:00:00.064 0.0%18517 0.000 0.003 0.033
hisgrep/artcncl00:00:00.006 0.0%2 3.000 3.000 3.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.436 0.0%18144 0.125 0.244 0.553
history sync00:00:00.069 0.0%413 0.000 0.167 3.333
history write00:00:03.533 0.0%5862 0.267 0.603 2.125
idle24:00:36.882100.0%18403 1986.192 4696.891 20720.069
nntp read00:00:00.503 0.0%18060 0.000 0.028 0.113
overview write00:00:01.420 0.0%3099 0.103 0.458 1.917
perl filter00:00:12.435 0.0%5862 1.061 2.121 13.147
python filter00:00:00.994 0.0%5862 0.033 0.170 1.412
site send00:00:00.110 0.0%3099 0.000 0.035 0.412
TOTAL: 1724:01:03.330100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%3225 0.000 0.007 0.125
article prepare00:00:00.003 0.0%24712 0.000 0.000 0.008
article read00:00:00.620 0.0%3225 0.000 0.192 0.812
backlog stats00:00:00.025 0.0%19494 0.000 0.001 0.025
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.157 0.0%10248 0.000 0.015 0.083
data write00:00:00.215 0.0%7231 0.000 0.030 0.167
idle23:50:16.192100.0%19494 1925.651 4402.185 10489.617
status file00:00:00.212 0.0%183 0.000 1.158 9.000
TOTAL: 923:50:17.446100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:10:17.736100.0%21 27.000 29416.000300602.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%85 0.000 0.012 0.500
TOTAL: 300:10:17.737100.0%----

Control commands to innd:

CommandNumber
flush 3
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
newgroup 1
pause 2
paused 2
reload 2
reserve 2
TOTAL: 12 168

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 2 11811 3150 5855 2806 26%48:22:32
2localhost 25 0 0 0 0 0%00:00:00
3news.chimia.se 1 0 0 0 0 0%00:10:00
TOTAL: 3 28 11811 3150 5855 2806 26%48:32:32
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net8.9 MB0.0 KB9.3 MB18.2 MB 48%3.1 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: 38.9 MB0.0 KB9.3 MB18.2 MB 48%3.1 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
May 28 03:00:05 - 03:59:59 63 2.0% 0.02132.5 KB 1.5% 0.04
May 28 04:00:00 - 04:59:59 74 2.4% 0.02165.5 KB 1.9% 0.05
May 28 05:00:00 - 05:59:59 54 1.7% 0.01122.5 KB 1.4% 0.03
May 28 06:00:00 - 06:59:59 77 2.5% 0.02321.1 KB 3.6% 0.09
May 28 07:00:00 - 07:59:59 102 3.3% 0.03268.6 KB 3.0% 0.07
May 28 08:00:00 - 08:59:59 136 4.4% 0.04439.5 KB 5.0% 0.12
May 28 09:00:00 - 09:59:59 165 5.3% 0.05455.0 KB 5.1% 0.13
May 28 10:00:00 - 10:59:59 127 4.1% 0.04289.6 KB 3.3% 0.08
May 28 11:00:00 - 11:59:59 162 5.2% 0.04521.7 KB 5.9% 0.14
May 28 12:00:00 - 12:59:59 127 4.1% 0.04413.8 KB 4.7% 0.11
May 28 13:00:00 - 13:59:59 181 5.8% 0.05567.4 KB 6.4% 0.16
May 28 14:00:00 - 14:59:59 153 4.9% 0.04383.3 KB 4.3% 0.11
May 28 15:00:00 - 15:59:59 140 4.5% 0.04412.9 KB 4.7% 0.11
May 28 16:00:00 - 16:59:59 141 4.6% 0.04397.6 KB 4.5% 0.11
May 28 17:00:00 - 17:59:59 172 5.6% 0.05518.9 KB 5.9% 0.14
May 28 18:00:00 - 18:59:59 123 4.0% 0.03298.3 KB 3.4% 0.08
May 28 19:00:00 - 19:59:59 152 4.9% 0.04385.3 KB 4.4% 0.11
May 28 20:00:00 - 20:59:59 138 4.5% 0.04321.7 KB 3.6% 0.09
May 28 21:00:00 - 21:59:59 182 5.9% 0.05621.3 KB 7.0% 0.17
May 28 22:00:00 - 22:59:59 97 3.1% 0.03247.6 KB 2.8% 0.07
May 28 23:00:00 - 23:59:59 164 5.3% 0.05605.7 KB 6.8% 0.17
May 29 00:00:00 - 00:59:59 172 5.6% 0.05409.9 KB 4.6% 0.11
May 29 01:00:00 - 01:59:59 100 3.2% 0.03338.1 KB 3.8% 0.09
May 29 02:00:00 - 02:59:59 83 2.7% 0.02198.3 KB 2.2% 0.06
May 29 03:00:00 - 03:00:05 12 0.4% 2.4021.5 KB 0.2% 4.30
TOTAL: 24:00:00 3097 100.0% 0.048.6 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 2780 2243 0 0 0 0 0 0 537
TOTAL: 1 2780 2243 0 0 0 0 0 0 537

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.russian.z1 123
de.etc.fahrzeug.auto 112
de.soc.politik.misc 112
fr.soc.politique 100
ger.ct 79
de.sci.electronics 78
aus.cars 66
it.sport.calcio.milan 60
alt.anonymous.messages 47
de.etc.sprache.deutsch 46
it.hobby.fai-da-te 46
alt.fan.rush-limbaugh 36
uk.d-i-y 35
alt.food.fast-food 34
uk.railway 33
sfnet.keskustelu.varaventtiili 32
alt.usage.english 31
pl.soc.prawo 29
de.alt.folklore.computer 28
de.comp.os.unix.linux.misc 28
TOTAL: 227 2243

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 435
User-issued cancel 63
Too many newsgroups 10
EMP (md5) 7
HTML Multipart 3
TOTAL: 5 518

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1chimia.se 3111 3087 0 1 0 154 99%23:59:55
2thebunker.nu 3102 2848 0 250 0 1 91%23:59:46
3sklaff.dev 0 0 0 0 0 3092 0%23:57:41
4usenet.blueworldhosting.com 0 0 0 0 0 2871 0%23:59:55
5weretis.net 0 0 0 0 0 0 0%00:10:30
TOTAL: 5 6213 5935 0 251 0 6118 95%96:07:47
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1chimia.se8.6 MB1.2 KB8.6 MB0.1 KB/s2.9 KB23:59:55
2thebunker.nu7.5 MB1.2 MB8.7 MB0.1 KB/s2.9 KB23:59:46
3sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:41
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: 516.2 MB1.2 MB17.3 MB0.1 KB/s2.9 KB96:07:47
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
171.6.235.244 3 00.0 KB 0 0 000:00:00
2azpdsgebcoxy.stretchoid.com 2 00.0 KB 0 0 000:00:10
3179.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
4194.88.98.111 1 00.0 KB 0 0 000:00:00
5195-252-55-9-no600.tbcn.telia.com 1 00.0 KB 0 0 000:10:01
6205.210.31.151 1 00.0 KB 0 0 000:00:00
769.5.169.187 1 00.0 KB 0 0 000:00:00
869.5.169.32 1 00.0 KB 0 0 000:00:00
969.5.169.64 1 00.0 KB 0 0 000:00:00
1079.224.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:01
11r4-127-7f.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 11 14 00.0 KB 0 0 000:10:17

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 8 00.0 KB 0 0 000:00:02
2*.stretchoid.com 2 00.0 KB 0 0 000:00:10
3*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:01
4*.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
6*.tbcn.telia.com 1 00.0 KB 0 0 000:10:01
TOTAL: 6 14 00.0 KB 0 0 000:10:17

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
195-252-55-9-no600.tbcn.telia.com 0.004 0.015 0.00000:10:01
azpdsgebcoxy.stretchoid.com 0.004 0.025 0.00000:00:10
r4-127-7f.monitoring.internet-measurement.com 0.001 0.017 0.00000:00:01
79.224.132.66.censys-scanner.com 0.034 0.018 0.00000:00:01
71.6.235.244 0.016 0.022 0.00000:00:00
205.210.31.151 0.003 0.010 0.00000:00:00
69.5.169.64 0.005 0.005 0.00000:00:00
69.5.169.187 0.003 0.012 0.00000:00:00
69.5.169.32 0.005 0.011 0.00000:00:00
179.149.216.162.bc.googleusercontent.com 0.006 0.015 0.00000:00:00
194.88.98.111 0.006 0.015 0.00000:00:00
TOTAL: 11 0.087 0.165 0.00000:10:17

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

SystemConn
179.149.216.162.bc.googleusercontent.com 4
71.6.235.244 2
79.224.132.66.censys-scanner.com 1
azpdsgebcoxy.stretchoid.com 1
TOTAL: 4 8

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

CommandCount
#023#003#023#001#023#002#001 1
#026#003#001 1
Accept-Encoding: gzip 1
EHLO www.censys.io 1
GET / HTTP/1.1 1
Host: 172.234.115.63:119 1
MGLNDD_172.234.115.63_119 1
User-Agent: Hello from Palo Alto Network... 1
TOTAL: 8 8

NNRP client timeouts [Top 20]:

SystemConnPeer
69.5.169.32 1 1
69.5.169.64 1 1
TOTAL: 2 2 5
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