Daily Usenet report

May 31 03:00:06 -- Jun 1 03:00:05

Unknown entries from news log file:

First 50 / 797 lines (6.3%)

May 31 03:01:23 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
May 31 11:06:01 twilightnode nnrpd[961189]: Reading access from /usr/local/news/etc/readers.conf
May 31 11:06:01 twilightnode nnrpd[961189]: Auth strategy 'localhost' does not match client. Removing.
May 31 11:06:01 twilightnode nnrpd[961189]: 111.155.45.199.censys-scanner.com res <anonymous>
May 31 11:06:01 twilightnode nnrpd[961189]: 111.155.45.199.censys-scanner.com no_match_user <anonymous> <localhost>
May 31 11:06:01 twilightnode nnrpd[961189]: 111.155.45.199.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
May 31 11:06:01 twilightnode nnrpd[961189]: 111.155.45.199.censys-scanner.com match_user <anonymous> <anonymous>
May 31 11:06:01 twilightnode nnrpd[961189]: 111.155.45.199.censys-scanner.com no_post anonymous-read
May 31 11:06:06 twilightnode nnrpd[961198]: Reading access from /usr/local/news/etc/readers.conf
May 31 11:06:06 twilightnode nnrpd[961198]: Auth strategy 'localhost' does not match client. Removing.
May 31 11:06:06 twilightnode nnrpd[961198]: 111.155.45.199.censys-scanner.com res <anonymous>
May 31 11:06:06 twilightnode nnrpd[961198]: 111.155.45.199.censys-scanner.com no_match_user <anonymous> <localhost>
May 31 11:06:06 twilightnode nnrpd[961198]: 111.155.45.199.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
May 31 11:06:06 twilightnode nnrpd[961198]: 111.155.45.199.censys-scanner.com match_user <anonymous> <anonymous>
May 31 11:06:06 twilightnode nnrpd[961198]: 111.155.45.199.censys-scanner.com no_post anonymous-read
May 31 11:06:13 twilightnode nnrpd[961203]: Reading access from /usr/local/news/etc/readers.conf
May 31 11:06:13 twilightnode nnrpd[961203]: Auth strategy 'localhost' does not match client. Removing.
May 31 11:06:13 twilightnode nnrpd[961203]: 111.155.45.199.censys-scanner.com res <anonymous>
May 31 11:06:13 twilightnode nnrpd[961203]: 111.155.45.199.censys-scanner.com no_match_user <anonymous> <localhost>
May 31 11:06:13 twilightnode nnrpd[961203]: 111.155.45.199.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
May 31 11:06:13 twilightnode nnrpd[961203]: 111.155.45.199.censys-scanner.com match_user <anonymous> <anonymous>
May 31 11:06:13 twilightnode nnrpd[961203]: 111.155.45.199.censys-scanner.com no_post anonymous-read
May 31 11:06:14 twilightnode nnrpd[961203]: 111.155.45.199.censys-scanner.com res <anonymous>
May 31 11:06:14 twilightnode nnrpd[961203]: 111.155.45.199.censys-scanner.com no_match_user <anonymous> <localhost>
May 31 11:06:14 twilightnode nnrpd[961203]: 111.155.45.199.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
May 31 11:06:14 twilightnode nnrpd[961203]: 111.155.45.199.censys-scanner.com match_user <anonymous> <anonymous>
May 31 11:06:14 twilightnode nnrpd[961203]: 111.155.45.199.censys-scanner.com no_post anonymous-read
May 31 13:34:39 twilightnode nnrpd[968240]: Reading access from /usr/local/news/etc/readers.conf
May 31 13:34:39 twilightnode nnrpd[968240]: Auth strategy 'localhost' does not match client. Removing.
May 31 13:34:39 twilightnode nnrpd[968240]: prod52client01.academyforinternetresearch.org res <anonymous>
May 31 13:34:39 twilightnode nnrpd[968240]: prod52client01.academyforinternetresearch.org no_match_user <anonymous> <localhost>
May 31 13:34:39 twilightnode nnrpd[968240]: prod52client01.academyforinternetresearch.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
May 31 13:34:39 twilightnode nnrpd[968240]: prod52client01.academyforinternetresearch.org match_user <anonymous> <anonymous>
May 31 13:34:39 twilightnode nnrpd[968240]: prod52client01.academyforinternetresearch.org no_post anonymous-read
May 31 13:35:26 twilightnode nnrpd[968337]: Reading access from /usr/local/news/etc/readers.conf
May 31 13:35:26 twilightnode nnrpd[968337]: Auth strategy 'localhost' does not match client. Removing.
May 31 13:35:26 twilightnode nnrpd[968337]: prod52client01.academyforinternetresearch.org res <anonymous>
May 31 13:35:26 twilightnode nnrpd[968337]: prod52client01.academyforinternetresearch.org no_match_user <anonymous> <localhost>
May 31 13:35:26 twilightnode nnrpd[968337]: prod52client01.academyforinternetresearch.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
May 31 13:35:26 twilightnode nnrpd[968337]: prod52client01.academyforinternetresearch.org match_user <anonymous> <anonymous>
May 31 13:35:26 twilightnode nnrpd[968337]: prod52client01.academyforinternetresearch.org no_post anonymous-read
May 31 13:38:40 twilightnode nnrpd[968571]: Reading access from /usr/local/news/etc/readers.conf
May 31 13:38:40 twilightnode nnrpd[968571]: Auth strategy 'localhost' does not match client. Removing.
May 31 13:38:40 twilightnode nnrpd[968571]: prod52client01.academyforinternetresearch.org res <anonymous>
May 31 13:38:40 twilightnode nnrpd[968571]: prod52client01.academyforinternetresearch.org no_match_user <anonymous> <localhost>
May 31 13:38:40 twilightnode nnrpd[968571]: prod52client01.academyforinternetresearch.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
May 31 13:38:40 twilightnode nnrpd[968571]: prod52client01.academyforinternetresearch.org match_user <anonymous> <anonymous>
May 31 13:38:40 twilightnode nnrpd[968571]: prod52client01.academyforinternetresearch.org no_post anonymous-read
May 31 13:38:41 twilightnode nnrpd[968571]: prod52client01.academyforinternetresearch.org res <anonymous>
May 31 13:38:41 twilightnode nnrpd[968571]: prod52client01.academyforinternetresearch.org no_match_user <anonymous> <localhost>

Log entries by program:

Program nameLines%LinesSize%Size
inn 6266 61.7%944.0 KB 65.7%
innfeed 1592 15.7%198.9 KB 13.8%
innd 1208 11.9%164.5 KB 11.4%
nnrpd 1044 10.3%122.0 KB 8.5%
controlchan 41 0.4%7.5 KB 0.5%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 6 10152 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 6822 35.7%
Do not exist 6150 32.2%
Positive hits 6135 32.1%
Cache misses 3 0.0%
TOTAL: 4 19110 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%0 0.000 0.000 0.000
article cleanup00:00:00.040 0.0%6218 0.000 0.006 0.100
article logging00:00:00.240 0.0%6253 0.000 0.038 0.160
article parse00:00:00.096 0.0%7813 0.000 0.012 0.091
article write00:00:03.149 0.0%4315 0.182 0.730 1.750
data move00:00:00.062 0.0%20061 0.000 0.003 0.036
hisgrep/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.159 0.0%19320 0.069 0.215 0.471
history sync00:00:00.055 0.0%408 0.000 0.135 2.500
history write00:00:03.316 0.0%6218 0.111 0.533 1.056
idle24:00:38.123100.0%19978 1709.026 4326.665 18773.250
nntp read00:00:00.465 0.0%19490 0.000 0.024 0.100
overview write00:00:01.825 0.0%4315 0.128 0.423 1.889
perl filter00:00:10.175 0.0%6218 0.677 1.636 22.909
python filter00:00:00.752 0.0%6218 0.000 0.121 2.000
site send00:00:00.117 0.0%4317 0.000 0.027 0.273
TOTAL: 1724:01:02.574100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%12311 0.000 0.002 0.100
article prepare00:00:00.009 0.0%59036 0.000 0.000 0.005
article read00:00:03.111 0.0%12311 0.000 0.253 1.400
backlog stats00:00:00.037 0.0%27348 0.000 0.001 0.017
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.177 0.0%15471 0.000 0.011 0.119
data write00:00:00.291 0.0%11284 0.000 0.026 0.190
idle23:40:31.335100.0%27348 115.732 3116.547 10031.150
status file00:00:00.191 0.0%228 0.000 0.838 5.000
TOTAL: 923:40:35.170100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:10:38.044100.0%82 47.667 7781.024300200.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.004 0.0%352 0.000 0.011 0.333
TOTAL: 300:10:38.048100.0%----

Control commands to innd:

CommandNumber
flush 3
flushlogs 2
go 2
logmode 2
lowmark 1
mode 154
name 2
newgroup 9
pause 2
paused 2
reload 4
reserve 2
xexec 1
TOTAL: 13 186

Newsgroups created:

GroupMode
fr.bio.medeciney
fr.lettres.langue.francaisey
it.testy
uk.current-events.terrorismy
uk.rec.motorcyclesy
TOTAL5

Control channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
us-control@lists.killfile.org001101
TOTAL002102

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 5 12404 4485 5997 1922 36%49:15:59
2localhost 25 0 0 0 0 0%00:00:01
3news.chimia.se 1 0 0 0 0 0%00:10:00
TOTAL: 3 31 12404 4485 5997 1922 36%49:26:00
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net12.8 MB0.0 KB6.1 MB18.8 MB 67%3.0 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: 312.8 MB0.0 KB6.1 MB18.8 MB 67%3.0 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
May 31 03:00:06 - 03:59:59 62 1.4% 0.02159.3 KB 1.3% 0.04
May 31 04:00:00 - 04:59:59 90 2.1% 0.03238.4 KB 1.9% 0.07
May 31 05:00:00 - 05:59:59 116 2.7% 0.03345.1 KB 2.7% 0.10
May 31 06:00:00 - 06:59:59 121 2.8% 0.03392.5 KB 3.1% 0.11
May 31 07:00:00 - 07:59:59 162 3.7% 0.04443.6 KB 3.5% 0.12
May 31 08:00:00 - 08:59:59 177 4.1% 0.05487.8 KB 3.9% 0.14
May 31 09:00:00 - 09:59:59 214 4.9% 0.06493.1 KB 3.9% 0.14
May 31 10:00:00 - 10:59:59 238 5.5% 0.07581.7 KB 4.6% 0.16
May 31 11:00:00 - 11:59:59 264 6.1% 0.07695.3 KB 5.5% 0.19
May 31 12:00:00 - 12:59:59 215 5.0% 0.06653.4 KB 5.2% 0.18
May 31 13:00:00 - 13:59:59 254 5.9% 0.07608.9 KB 4.8% 0.17
May 31 14:00:00 - 14:59:59 233 5.4% 0.06674.7 KB 5.4% 0.19
May 31 15:00:00 - 15:59:59 235 5.4% 0.07581.4 KB 4.6% 0.16
May 31 16:00:00 - 16:59:59 232 5.4% 0.06703.3 KB 5.6% 0.20
May 31 17:00:00 - 17:59:59 176 4.1% 0.05482.4 KB 3.8% 0.13
May 31 18:00:00 - 18:59:59 170 3.9% 0.05533.1 KB 4.2% 0.15
May 31 19:00:00 - 19:59:59 223 5.2% 0.06736.2 KB 5.8% 0.20
May 31 20:00:00 - 20:59:59 250 5.8% 0.07910.7 KB 7.2% 0.25
May 31 21:00:00 - 21:59:59 268 6.2% 0.07982.1 KB 7.8% 0.27
May 31 22:00:00 - 22:59:59 214 4.9% 0.06513.0 KB 4.1% 0.14
May 31 23:00:00 - 23:59:59 130 3.0% 0.04467.4 KB 3.7% 0.13
Jun 1 00:00:00 - 00:59:59 104 2.4% 0.03311.2 KB 2.5% 0.09
Jun 1 01:00:00 - 01:59:59 82 1.9% 0.02348.7 KB 2.8% 0.10
Jun 1 02:00:00 - 02:59:59 89 2.1% 0.02247.2 KB 2.0% 0.07
Jun 1 03:00:00 - 03:00:05 9 0.2% 1.807.3 KB 0.1% 1.47
TOTAL: 23:59:59 4328 100.0% 0.0512.3 MB 100.0% 0.15
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1938 1530 0 0 0 0 0 0 408
TOTAL: 1 1938 1530 0 0 0 0 0 0 408

Unwanted newsgroups [Top 20]:

NewsgroupCount
fido7.ru.news 276
nl.politiek 58
cn.comp 36
pl.soc.prawo 32
fido7.ru.home 31
alt.slack 29
it.hobby.cucina 28
fido7.ru.military 26
alt.usage.english 23
eternal-september.support 23
de.alt.comm.android 21
de.rec.fotografie 21
linux.debian.l10n.german 21
linux.debian.user 21
de.alt.folklore.computer 20
lada.talk 20
aus.politics 19
de.talk.jokes 18
dk.politik 18
de.alt.fan.aldi 17
TOTAL: 217 1530

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phl) 201
EMP (phn path) 95
User-issued cancel 49
Too many newsgroups 17
HTML Multipart 7
EMP (md5) 4
TOTAL: 6 373

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1thebunker.nu 10634 9542 0 974 0 1868 89%23:59:38
2chimia.se 4323 4294 0 25 0 9 99%23:59:38
3sklaff.dev 0 0 0 0 0 4298 0%23:47:41
4usenet.blueworldhosting.com 0 0 0 0 0 3853 0%23:59:35
5weretis.net 0 0 0 0 0 0 0%00:36:37
TOTAL: 5 14957 13836 0 999 0 10028 92%96:23:09
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1thebunker.nu25.7 MB4.1 MB29.7 MB0.4 KB/s2.9 KB23:59:38
2chimia.se12.3 MB32.7 KB12.3 MB0.1 KB/s2.9 KB23:59:38
3sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:41
4usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:35
5weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:36:37
TOTAL: 537.9 MB4.1 MB42.0 MB0.1 KB/s2.9 KB96:23:09
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1prod52client01.academyforinternetresearch.org 60 00.0 KB 0 0 000:00:25
2111.155.45.199.censys-scanner.com 3 00.0 KB 0 0 000:00:06
355.195.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:04
4195-252-55-9-no600.tbcn.telia.com 2 00.0 KB 0 0 000:10:00
593.152.208.38 2 00.0 KB 0 0 000:00:00
6194.88.98.87 1 00.0 KB 0 0 000:00:00
7194.88.98.93 1 00.0 KB 0 0 000:00:00
8213.166.84.40 1 00.0 KB 0 0 000:00:00
TOTAL: 8 73 00.0 KB 0 0 000:10:38

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.academyforinternetresearch.org 60 00.0 KB 0 0 000:00:25
2unresolved 5 00.0 KB 0 0 000:00:01
3*.199.censys-scanner.com 3 00.0 KB 0 0 000:00:06
4*.66.censys-scanner.com 3 00.0 KB 0 0 000:00:04
5*.tbcn.telia.com 2 00.0 KB 0 0 000:10:00
TOTAL: 5 73 00.0 KB 0 0 000:10:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
195-252-55-9-no600.tbcn.telia.com 0.008 0.008 0.00000:10:00
prod52client01.academyforinternetresearch.org 1.813 0.523 0.00000:00:25
111.155.45.199.censys-scanner.com 0.034 0.038 0.00000:00:06
55.195.132.66.censys-scanner.com 0.055 0.035 0.00000:00:04
194.88.98.87 0.004 0.013 0.00000:00:00
213.166.84.40 0.005 0.011 0.00000:00:00
194.88.98.93 0.004 0.010 0.00000:00:00
93.152.208.38 0.007 0.023 0.00000:00:00
TOTAL: 8 1.930 0.661 0.00000:10:38

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

SystemConn
93.152.208.38 9
111.155.45.199.censys-scanner.com 1
55.195.132.66.censys-scanner.com 1
TOTAL: 3 11

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

CommandCount
EHLO www.censys.io 2
#026#003#001#002 1
?#024?#011?#023 1
Accept-Encoding: gzip, deflate, br 1
Accept-Language: en-US,en;q=0.9 1
Accept: text/html,application/xhtml+xml,... 1
Connection: close 1
GET / HTTP/1.1 1
Host: 172.234.115.63:119 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
TOTAL: 10 11

NNRP client timeouts [Top 20]:

SystemConnPeer
111.155.45.199.censys-scanner.com 1 2
194.88.98.87 1 1
194.88.98.93 1 1
55.195.132.66.censys-scanner.com 1 2
prod52client01.academyforinternetresearch.org 1 1
TOTAL: 5 5 8
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