Daily Usenet report

Jun 6 03:00:05 -- Jun 7 03:00:05

Unknown entries from news log file:

First 50 / 76 lines (65.8%)

Jun 6 03:01:23 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Jun 6 03:36:39 twilightnode nnrpd[1349112]: Reading access from /usr/local/news/etc/readers.conf
Jun 6 03:36:39 twilightnode nnrpd[1349112]: Auth strategy 'localhost' does not match client. Removing.
Jun 6 03:36:39 twilightnode nnrpd[1349112]: 165.186.132.66.censys-scanner.com res <anonymous>
Jun 6 03:36:39 twilightnode nnrpd[1349112]: 165.186.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Jun 6 03:36:39 twilightnode nnrpd[1349112]: 165.186.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 6 03:36:39 twilightnode nnrpd[1349112]: 165.186.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Jun 6 03:36:39 twilightnode nnrpd[1349112]: 165.186.132.66.censys-scanner.com no_post anonymous-read
Jun 6 03:36:42 twilightnode nnrpd[1349112]: 165.186.132.66.censys-scanner.com res <anonymous>
Jun 6 03:36:42 twilightnode nnrpd[1349112]: 165.186.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Jun 6 03:36:42 twilightnode nnrpd[1349112]: 165.186.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 6 03:36:42 twilightnode nnrpd[1349112]: 165.186.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Jun 6 03:36:42 twilightnode nnrpd[1349112]: 165.186.132.66.censys-scanner.com no_post anonymous-read
Jun 6 09:23:34 twilightnode nnrpd[1365233]: Reading access from /usr/local/news/etc/readers.conf
Jun 6 09:23:34 twilightnode nnrpd[1365233]: Auth strategy 'localhost' does not match client. Removing.
Jun 6 09:23:34 twilightnode nnrpd[1365233]: 193.46.255.148 res <anonymous>
Jun 6 09:23:34 twilightnode nnrpd[1365233]: 193.46.255.148 no_match_user <anonymous> <localhost>
Jun 6 09:23:34 twilightnode nnrpd[1365233]: 193.46.255.148 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 6 09:23:34 twilightnode nnrpd[1365233]: 193.46.255.148 match_user <anonymous> <anonymous>
Jun 6 09:23:34 twilightnode nnrpd[1365233]: 193.46.255.148 no_post anonymous-read
Jun 6 14:26:14 twilightnode nnrpd[1379237]: Reading access from /usr/local/news/etc/readers.conf
Jun 6 14:26:14 twilightnode nnrpd[1379237]: Auth strategy 'localhost' does not match client. Removing.
Jun 6 14:26:14 twilightnode nnrpd[1379237]: 43.98.184.242 res <anonymous>
Jun 6 14:26:14 twilightnode nnrpd[1379237]: 43.98.184.242 no_match_user <anonymous> <localhost>
Jun 6 14:26:14 twilightnode nnrpd[1379237]: 43.98.184.242 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 6 14:26:14 twilightnode nnrpd[1379237]: 43.98.184.242 match_user <anonymous> <anonymous>
Jun 6 14:26:14 twilightnode nnrpd[1379237]: 43.98.184.242 no_post anonymous-read
Jun 6 14:26:15 twilightnode nnrpd[1379238]: Reading access from /usr/local/news/etc/readers.conf
Jun 6 14:26:15 twilightnode nnrpd[1379238]: Auth strategy 'localhost' does not match client. Removing.
Jun 6 14:26:15 twilightnode nnrpd[1379238]: 43.98.184.242 res <anonymous>
Jun 6 14:26:15 twilightnode nnrpd[1379238]: 43.98.184.242 no_match_user <anonymous> <localhost>
Jun 6 14:26:15 twilightnode nnrpd[1379238]: 43.98.184.242 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 6 14:26:15 twilightnode nnrpd[1379238]: 43.98.184.242 match_user <anonymous> <anonymous>
Jun 6 14:26:15 twilightnode nnrpd[1379238]: 43.98.184.242 no_post anonymous-read
Jun 6 14:26:20 twilightnode nnrpd[1379241]: Reading access from /usr/local/news/etc/readers.conf
Jun 6 14:26:20 twilightnode nnrpd[1379241]: Auth strategy 'localhost' does not match client. Removing.
Jun 6 14:26:20 twilightnode nnrpd[1379241]: 43.98.184.242 res <anonymous>
Jun 6 14:26:20 twilightnode nnrpd[1379241]: 43.98.184.242 no_match_user <anonymous> <localhost>
Jun 6 14:26:20 twilightnode nnrpd[1379241]: 43.98.184.242 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 6 14:26:20 twilightnode nnrpd[1379241]: 43.98.184.242 match_user <anonymous> <anonymous>
Jun 6 14:26:20 twilightnode nnrpd[1379241]: 43.98.184.242 no_post anonymous-read
Jun 6 20:05:57 twilightnode nnrpd[1394516]: Reading access from /usr/local/news/etc/readers.conf
Jun 6 20:05:57 twilightnode nnrpd[1394516]: Auth strategy 'localhost' does not match client. Removing.
Jun 6 20:05:57 twilightnode nnrpd[1394516]: sh-chi-us-gp1-wk135c.internet-census.org res <anonymous>
Jun 6 20:05:57 twilightnode nnrpd[1394516]: sh-chi-us-gp1-wk135c.internet-census.org no_match_user <anonymous> <localhost>
Jun 6 20:05:57 twilightnode nnrpd[1394516]: sh-chi-us-gp1-wk135c.internet-census.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 6 20:05:57 twilightnode nnrpd[1394516]: sh-chi-us-gp1-wk135c.internet-census.org match_user <anonymous> <anonymous>
Jun 6 20:05:57 twilightnode nnrpd[1394516]: sh-chi-us-gp1-wk135c.internet-census.org no_post anonymous-read
Jun 6 23:55:50 twilightnode nnrpd[1405046]: Reading access from /usr/local/news/etc/readers.conf
Jun 6 23:55:50 twilightnode nnrpd[1405046]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 5582 69.5%912.8 KB 73.2%
innfeed 1493 18.6%190.3 KB 15.3%
innd 835 10.4%131.2 KB 10.5%
nnrpd 117 1.5%12.5 KB 1.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 8029 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Negative hits 6015 35.1%
Positive hits 5611 32.7%
Do not exist 5523 32.2%
Cache misses 12 0.1%
TOTAL: 4 17161 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.003 0.0%2 1.000 1.500 2.000
article cleanup00:00:00.069 0.0%5557 0.000 0.012 0.125
article logging00:00:00.212 0.0%5597 0.000 0.038 0.150
article parse00:00:00.095 0.0%7089 0.000 0.013 0.111
article write00:00:03.397 0.0%4299 0.370 0.790 2.159
data move00:00:00.048 0.0%18780 0.000 0.003 0.032
hisgrep/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.156 0.0%17265 0.108 0.241 0.891
history sync00:00:00.060 0.0%412 0.000 0.146 1.000
history write00:00:02.874 0.0%5557 0.059 0.517 1.043
idle24:00:42.606100.0%18679 1966.000 4627.796 16664.389
nntp read00:00:00.473 0.0%18303 0.000 0.026 0.188
overview write00:00:01.762 0.0%4299 0.053 0.410 2.889
perl filter00:00:10.012 0.0%5557 0.938 1.802 31.222
python filter00:00:00.835 0.0%5557 0.020 0.150 2.889
site send00:00:00.135 0.0%4299 0.000 0.031 0.222
TOTAL: 1724:01:06.737100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.018 0.0%4287 0.000 0.004 0.071
article prepare00:00:00.003 0.0%25528 0.000 0.000 0.007
article read00:00:00.562 0.0%4272 0.000 0.132 2.167
backlog stats00:00:00.020 0.0%27890 0.000 0.001 0.015
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.213 0.0%15535 0.000 0.014 0.167
data write00:00:00.303 0.0%11351 0.000 0.027 0.087
idle23:50:19.912100.0%27890 1148.598 3077.085 7692.333
status file00:00:00.233 0.0%272 0.000 0.857 12.000
TOTAL: 923:50:21.264100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:36.372100.0%17 184.500 2139.529 5282.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%71 0.000 0.014 0.333
TOTAL: 300:00:36.373100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 4 10989 4179 5579 1231 38%47:04:46
2news.sklaffkom.se 41 96 30 40 26 31%11:03:43
3localhost 25 0 0 0 0 0%00:00:00
4news.chimia.se 1 0 0 0 0 0%00:10:01
TOTAL: 4 71 11085 4209 5619 1257 37%58:18:30
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net11.3 MB0.0 KB6.5 MB17.8 MB 63%3.4 KB
2news.sklaffkom.se102.2 KB0.0 KB65.6 KB167.7 KB 60%3.0 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
4news.chimia.se0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 411.4 MB0.0 KB6.6 MB18.0 MB 63%3.4 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 6 03:00:05 - 03:59:59 62 1.4% 0.02155.4 KB 1.3% 0.04
Jun 6 04:00:00 - 04:59:59 83 1.9% 0.02196.1 KB 1.7% 0.05
Jun 6 05:00:00 - 05:59:59 100 2.3% 0.03335.2 KB 2.8% 0.09
Jun 6 06:00:00 - 06:59:59 143 3.3% 0.04438.8 KB 3.7% 0.12
Jun 6 07:00:00 - 07:59:59 105 2.5% 0.03266.7 KB 2.3% 0.07
Jun 6 08:00:00 - 08:59:59 157 3.7% 0.04390.9 KB 3.3% 0.11
Jun 6 09:00:00 - 09:59:59 224 5.2% 0.06489.7 KB 4.1% 0.14
Jun 6 10:00:00 - 10:59:59 184 4.3% 0.05523.4 KB 4.4% 0.15
Jun 6 11:00:00 - 11:59:59 211 4.9% 0.06475.4 KB 4.0% 0.13
Jun 6 12:00:00 - 12:59:59 191 4.5% 0.05457.0 KB 3.9% 0.13
Jun 6 13:00:00 - 13:59:59 221 5.2% 0.06581.3 KB 4.9% 0.16
Jun 6 14:00:00 - 14:59:59 200 4.7% 0.06473.5 KB 4.0% 0.13
Jun 6 15:00:00 - 15:59:59 367 8.6% 0.10953.6 KB 8.1% 0.26
Jun 6 16:00:00 - 16:59:59 187 4.4% 0.05654.8 KB 5.5% 0.18
Jun 6 17:00:00 - 17:59:59 175 4.1% 0.05480.0 KB 4.1% 0.13
Jun 6 18:00:00 - 18:59:59 174 4.1% 0.05556.9 KB 4.7% 0.15
Jun 6 19:00:00 - 19:59:59 226 5.3% 0.06681.3 KB 5.8% 0.19
Jun 6 20:00:00 - 20:59:59 201 4.7% 0.06488.8 KB 4.1% 0.14
Jun 6 21:00:00 - 21:59:59 212 4.9% 0.06734.1 KB 6.2% 0.20
Jun 6 22:00:00 - 22:59:59 218 5.1% 0.06698.6 KB 5.9% 0.19
Jun 6 23:00:00 - 23:59:59 207 4.8% 0.06546.1 KB 4.6% 0.15
Jun 7 00:00:00 - 00:59:59 189 4.4% 0.05529.3 KB 4.5% 0.15
Jun 7 01:00:00 - 01:59:59 132 3.1% 0.04424.8 KB 3.6% 0.12
Jun 7 02:00:00 - 02:59:59 105 2.5% 0.03288.1 KB 2.4% 0.08
Jun 7 03:00:00 - 03:00:05 9 0.2% 1.807.3 KB 0.1% 1.45
TOTAL: 24:00:00 4283 100.0% 0.0511.5 MB 100.0% 0.14
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1273 1161 0 0 0 0 0 0 112
2news.sklaffkom.se 26 26 0 0 0 0 0 0 0
TOTAL: 2 1299 1187 0 0 0 0 0 0 112

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.usage.english 41
it.sport.calcio.milan 41
cn.comp 40
uk.tech.broadcast 34
uk.legal.moderated 29
dk.politik 25
linux.debian.user 25
pl.soc.prawo 25
alt.bestjobsusa.computer.jobs 24
nl.politiek 24
de.rec.fahrrad 22
de.alt.comm.android 21
aus.politics 20
hfx.general 20
alt.slack 19
de.alt.fan.aldi 19
uk.d-i-y 19
alt.prophecies.nostradamus 18
bln.test 18
de.sci.ing.elektrotechnik 17
TOTAL: 216 1187

Perl filter (innd) [Top 20]:

ReasonCount
User-issued cancel 37
EMP (md5) 13
Too many newsgroups 8
Too many newsgroups (meow) 6
EMP (phl) 5
HTML Multipart 3
TOTAL: 6 72

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1chimia.se 4278 4198 0 78 0 7 98%23:59:56
2sklaffkom.se 4707 979 2148 1151 0 26 20%23:59:56
3weretis.net 34 0 30 0 0 0 0%04:08:25
4sklaff.dev 0 0 0 0 0 4278 0%23:54:40
5thebunker.nu 0 0 0 0 0 4283 0%23:59:56
6usenet.blueworldhosting.com 0 0 0 0 0 3821 0%23:59:56
TOTAL: 6 9019 5177 2178 1229 0 12415 57%124:02:49
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1chimia.se11.5 MB102.6 KB11.6 MB0.1 KB/s2.8 KB23:59:56
2sklaffkom.se1.5 MB3.5 MB5.0 MB0.1 KB/s2.4 KB23:59:56
3sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:40
4thebunker.nu0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
5usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
6weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s004:08:25
TOTAL: 613.0 MB3.6 MB16.6 MB0.0 KB/s2.7 KB124:02:49
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
143.98.184.242 3 00.0 KB 0 0 000:00:15
2165.186.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
3172-234-228-172.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
4172-99-61-198.e55debe299579139e7cfe9be84b63964.ip.frontiernet.net 1 00.0 KB 0 0 000:00:00
5193.46.255.148 1 00.0 KB 0 0 000:00:02
6194.164.107.5 1 00.0 KB 0 0 000:00:00
7prod-boron-sfo2-47.do.binaryedge.ninja 1 00.0 KB 0 0 000:00:02
8sh-chi-us-gp1-wk135c.internet-census.org 1 00.0 KB 0 0 000:00:10
TOTAL: 8 10 00.0 KB 0 0 000:00:36

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 5 00.0 KB 0 0 000:00:18
2*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
3*.do.binaryedge.ninja 1 00.0 KB 0 0 000:00:02
4*.internet-census.org 1 00.0 KB 0 0 000:00:10
5*.ip.frontiernet.net 1 00.0 KB 0 0 000:00:00
6*.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
TOTAL: 6 10 00.0 KB 0 0 000:00:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
43.98.184.242 0.012 0.019 0.00000:00:15
sh-chi-us-gp1-wk135c.internet-census.org 0.005 0.011 0.00000:00:10
165.186.132.66.censys-scanner.com 0.029 0.019 0.00000:00:03
193.46.255.148 0.003 0.012 0.00000:00:02
prod-boron-sfo2-47.do.binaryedge.ninja 0.006 0.016 0.00000:00:02
172-234-228-172.ip.linodeusercontent.com 0.003 0.011 0.00000:00:00
172-99-61-198.e55debe299579139e7cfe9be84b63964.ip.frontiernet.net 0.004 0.009 0.00000:00:00
194.164.107.5 0.005 0.012 0.00000:00:00
TOTAL: 8 0.067 0.109 0.00000:00:36

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

SystemConn
43.98.184.242 4
193.46.255.148 2
165.186.132.66.censys-scanner.com 1
TOTAL: 3 7

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

CommandCount
#026#003#001 2
#001 1
?#024 1
?#?' 1
EHLO www.censys.io 1
r#020?#024d?q#JY?B?g?#022ig?$F? ?P{?v?... 1
TOTAL: 6 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