Daily Usenet report

Jun 25 03:00:05 -- Jun 26 03:00:05

Unknown entries from news log file:

First 50 / 116 lines (43.1%)

Jun 25 03:01:21 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Jun 25 05:29:25 twilightnode nnrpd[2615369]: Reading access from /usr/local/news/etc/readers.conf
Jun 25 05:29:25 twilightnode nnrpd[2615369]: Auth strategy 'localhost' does not match client. Removing.
Jun 25 05:29:25 twilightnode nnrpd[2615369]: 77.211.203.35.bc.googleusercontent.com res <anonymous>
Jun 25 05:29:25 twilightnode nnrpd[2615369]: 77.211.203.35.bc.googleusercontent.com no_match_user <anonymous> <localhost>
Jun 25 05:29:25 twilightnode nnrpd[2615369]: 77.211.203.35.bc.googleusercontent.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 25 05:29:25 twilightnode nnrpd[2615369]: 77.211.203.35.bc.googleusercontent.com match_user <anonymous> <anonymous>
Jun 25 05:29:25 twilightnode nnrpd[2615369]: 77.211.203.35.bc.googleusercontent.com no_post anonymous-read
Jun 25 06:56:04 twilightnode nnrpd[2619103]: Reading access from /usr/local/news/etc/readers.conf
Jun 25 06:56:04 twilightnode nnrpd[2619103]: Auth strategy 'localhost' does not match client. Removing.
Jun 25 06:56:04 twilightnode nnrpd[2619103]: 81.19.216.104 res <anonymous>
Jun 25 06:56:04 twilightnode nnrpd[2619103]: 81.19.216.104 no_match_user <anonymous> <localhost>
Jun 25 06:56:04 twilightnode nnrpd[2619103]: 81.19.216.104 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 25 06:56:04 twilightnode nnrpd[2619103]: 81.19.216.104 match_user <anonymous> <anonymous>
Jun 25 06:56:04 twilightnode nnrpd[2619103]: 81.19.216.104 no_post anonymous-read
Jun 25 06:56:13 twilightnode nnrpd[2619104]: Reading access from /usr/local/news/etc/readers.conf
Jun 25 06:56:13 twilightnode nnrpd[2619104]: Auth strategy 'localhost' does not match client. Removing.
Jun 25 06:56:13 twilightnode nnrpd[2619104]: 69.5.169.66 res <anonymous>
Jun 25 06:56:13 twilightnode nnrpd[2619104]: 69.5.169.66 no_match_user <anonymous> <localhost>
Jun 25 06:56:13 twilightnode nnrpd[2619104]: 69.5.169.66 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 25 06:56:13 twilightnode nnrpd[2619104]: 69.5.169.66 match_user <anonymous> <anonymous>
Jun 25 06:56:13 twilightnode nnrpd[2619104]: 69.5.169.66 no_post anonymous-read
Jun 25 07:10:53 twilightnode nnrpd[2619668]: Reading access from /usr/local/news/etc/readers.conf
Jun 25 07:10:53 twilightnode nnrpd[2619668]: Auth strategy 'localhost' does not match client. Removing.
Jun 25 07:10:53 twilightnode nnrpd[2619668]: 45-79-168-97.ip.linodeusercontent.com res <anonymous>
Jun 25 07:10:53 twilightnode nnrpd[2619668]: 45-79-168-97.ip.linodeusercontent.com no_match_user <anonymous> <localhost>
Jun 25 07:10:53 twilightnode nnrpd[2619668]: 45-79-168-97.ip.linodeusercontent.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 25 07:10:53 twilightnode nnrpd[2619668]: 45-79-168-97.ip.linodeusercontent.com match_user <anonymous> <anonymous>
Jun 25 07:10:53 twilightnode nnrpd[2619668]: 45-79-168-97.ip.linodeusercontent.com no_post anonymous-read
Jun 25 07:10:55 twilightnode nnrpd[2619670]: Reading access from /usr/local/news/etc/readers.conf
Jun 25 07:10:55 twilightnode nnrpd[2619670]: Auth strategy 'localhost' does not match client. Removing.
Jun 25 07:10:55 twilightnode nnrpd[2619670]: 45-79-168-97.ip.linodeusercontent.com res <anonymous>
Jun 25 07:10:55 twilightnode nnrpd[2619670]: 45-79-168-97.ip.linodeusercontent.com no_match_user <anonymous> <localhost>
Jun 25 07:10:55 twilightnode nnrpd[2619670]: 45-79-168-97.ip.linodeusercontent.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 25 07:10:55 twilightnode nnrpd[2619670]: 45-79-168-97.ip.linodeusercontent.com match_user <anonymous> <anonymous>
Jun 25 07:10:55 twilightnode nnrpd[2619670]: 45-79-168-97.ip.linodeusercontent.com no_post anonymous-read
Jun 25 07:12:05 twilightnode nnrpd[2619695]: Reading access from /usr/local/news/etc/readers.conf
Jun 25 07:12:05 twilightnode nnrpd[2619695]: Auth strategy 'localhost' does not match client. Removing.
Jun 25 07:12:05 twilightnode nnrpd[2619695]: 45-79-168-97.ip.linodeusercontent.com res <anonymous>
Jun 25 07:12:05 twilightnode nnrpd[2619695]: 45-79-168-97.ip.linodeusercontent.com no_match_user <anonymous> <localhost>
Jun 25 07:12:05 twilightnode nnrpd[2619695]: 45-79-168-97.ip.linodeusercontent.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 25 07:12:05 twilightnode nnrpd[2619695]: 45-79-168-97.ip.linodeusercontent.com match_user <anonymous> <anonymous>
Jun 25 07:12:05 twilightnode nnrpd[2619695]: 45-79-168-97.ip.linodeusercontent.com no_post anonymous-read
Jun 25 15:25:58 twilightnode nnrpd[2641101]: Reading access from /usr/local/news/etc/readers.conf
Jun 25 15:25:58 twilightnode nnrpd[2641101]: Auth strategy 'localhost' does not match client. Removing.
Jun 25 15:25:58 twilightnode nnrpd[2641101]: 185.186.132.66.censys-scanner.com res <anonymous>
Jun 25 15:25:58 twilightnode nnrpd[2641101]: 185.186.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Jun 25 15:25:58 twilightnode nnrpd[2641101]: 185.186.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 25 15:25:58 twilightnode nnrpd[2641101]: 185.186.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Jun 25 15:25:58 twilightnode nnrpd[2641101]: 185.186.132.66.censys-scanner.com no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
innfeed 42299 81.5%5.8 MB 77.5%
inn 7807 15.0%1.4 MB 18.2%
innd 1559 3.0%300.2 KB 3.9%
nnrpd 184 0.4%21.0 KB 0.3%
controlchan 28 0.1%2.3 KB 0.0%
TOTAL: 5 51877 100.0%7.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 15913 46.8%
Negative hits 10377 30.5%
Do not exist 7736 22.7%
Cache misses 4 0.0%
TOTAL: 4 34030 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.018 0.0%2 1.000 9.000 17.000
article cleanup00:00:00.060 0.0%7763 0.000 0.008 0.083
article logging00:00:00.270 0.0%7792 0.000 0.035 0.154
article parse00:00:00.163 0.0%16624 0.000 0.010 0.088
article write00:00:04.622 0.0%4153 0.286 1.113 28.543
data move00:00:00.119 0.0%40711 0.000 0.003 0.046
hisgrep/artcncl00:00:00.001 0.0%2 0.000 0.500 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.835 0.0%34146 0.068 0.200 4.366
history sync00:00:00.051 0.0%408 0.000 0.125 1.000
history write00:00:04.614 0.0%7763 0.077 0.594 17.789
idle23:50:27.461 99.9%41670 216.153 2059.694 9680.790
nntp read00:00:00.999 0.0%41307 0.000 0.024 0.099
overview write00:00:01.945 0.0%4153 0.150 0.468 2.111
perl filter00:00:12.014 0.0%7758 0.822 1.549 12.588
python filter00:00:00.723 0.0%7758 0.000 0.093 1.000
site send00:00:00.109 0.0%4153 0.000 0.026 0.167
TOTAL: 1723:51:00.004100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.042 0.0%9662 0.000 0.004 0.038
article prepare00:00:00.002 0.0%24460 0.000 0.000 0.006
article read00:00:00.600 0.0%4119 0.000 0.146 1.231
backlog stats00:00:00.079 0.0%66997 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.541 0.0%32107 0.000 0.017 0.066
data write00:00:00.803 0.0%28058 0.005 0.029 0.082
idle23:40:02.983100.0%66997 933.801 1271.743 1704.527
status file00:00:10.820 0.0%16940 0.427 0.639 5.289
TOTAL: 923:40:15.870100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:21.632100.0%23 42.000 940.522 10734.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.003 0.0%147 0.000 0.020 0.250
TOTAL: 300:00:21.635100.0%----

Control commands to innd:

CommandNumber
flush 3
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
newgroup 12
pause 2
paused 2
reload 2
reserve 2
xexec 1
TOTAL: 13 182

Newsgroups created:

GroupMode
alt.sex.fetish.news-serverssy
alt.sex.nudels.me.tooy
alt.sex.nudismy
alt.sex.young-woman.foroldermeny
de.rec.fahrrady
fido7.ru.militaryy
it.discussioni.misteriy
it.sport.calcio.milany
linux.kernel.gity
linux.kernel.netdevy
nl.politieky
uk.d-i-yy
TOTAL12

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 6 10356 3899 4972 1485 37%43:33:13
2news.tebibyte.org 3 7487 104 7118 265 1%26:14:49
3newsfeed.endofthelinebbs.com 3 5594 57 3621 1916 1%20:59:35
4news.sklaffkom.se 29 67 41 7 19 61%06:55:53
5localhost 25 0 0 0 0 0%00:00:00
6news.chimia.se 1 0 0 0 0 0%00:10:00
TOTAL: 6 67 23504 4101 15718 3685 17%97:53:30
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net10.2 MB0.0 KB4.3 MB14.5 MB 70%2.8 KB
2news.tebibyte.org461.5 KB0.0 KB1.2 MB1.7 MB 26%4.7 KB
3news.sklaffkom.se196.4 KB0.0 KB38.5 KB234.9 KB 83%3.9 KB
4newsfeed.endofthelinebbs.com159.1 KB0.0 KB33.3 MB33.4 MB 0%17.4 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
6news.chimia.se0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 611.0 MB0.0 KB38.8 MB49.8 MB 22%6.6 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 25 03:00:05 - 03:59:59 75 1.8% 0.02272.8 KB 2.4% 0.08
Jun 25 04:00:00 - 04:59:59 91 2.2% 0.03255.8 KB 2.2% 0.07
Jun 25 05:00:00 - 05:59:59 74 1.8% 0.02167.7 KB 1.5% 0.05
Jun 25 06:00:00 - 06:59:59 134 3.2% 0.04382.2 KB 3.3% 0.11
Jun 25 07:00:00 - 07:59:59 163 3.9% 0.05464.8 KB 4.0% 0.13
Jun 25 08:00:00 - 08:59:59 168 4.0% 0.05392.9 KB 3.4% 0.11
Jun 25 09:00:00 - 09:59:59 258 6.2% 0.07647.9 KB 5.6% 0.18
Jun 25 10:00:00 - 10:59:59 208 5.0% 0.06528.9 KB 4.6% 0.15
Jun 25 11:00:00 - 11:59:59 206 4.9% 0.06469.9 KB 4.1% 0.13
Jun 25 12:00:00 - 12:59:59 214 5.1% 0.06553.4 KB 4.8% 0.15
Jun 25 13:00:00 - 13:59:59 211 5.1% 0.06485.7 KB 4.2% 0.13
Jun 25 14:00:00 - 14:59:59 258 6.2% 0.07633.1 KB 5.5% 0.18
Jun 25 15:00:00 - 15:59:59 209 5.0% 0.06598.3 KB 5.2% 0.17
Jun 25 16:00:00 - 16:59:59 220 5.3% 0.06548.0 KB 4.8% 0.15
Jun 25 17:00:00 - 17:59:59 218 5.2% 0.06878.3 KB 7.6% 0.24
Jun 25 18:00:00 - 18:59:59 235 5.6% 0.07843.1 KB 7.3% 0.23
Jun 25 19:00:00 - 19:59:59 162 3.9% 0.04395.3 KB 3.4% 0.11
Jun 25 20:00:00 - 20:59:59 184 4.4% 0.05519.4 KB 4.5% 0.14
Jun 25 21:00:00 - 21:59:59 154 3.7% 0.04433.7 KB 3.8% 0.12
Jun 25 22:00:00 - 22:59:59 201 4.8% 0.06556.8 KB 4.8% 0.15
Jun 25 23:00:00 - 23:59:59 197 4.7% 0.05491.1 KB 4.3% 0.14
Jun 26 00:00:00 - 00:59:59 125 3.0% 0.03360.8 KB 3.1% 0.10
Jun 26 01:00:00 - 01:59:59 118 2.8% 0.03342.2 KB 3.0% 0.10
Jun 26 02:00:00 - 02:59:59 74 1.8% 0.02302.6 KB 2.6% 0.08
Jun 26 03:00:00 - 03:00:05 9 0.2% 1.807.2 KB 0.1% 1.43
TOTAL: 24:00:00 4166 100.0% 0.0511.3 MB 100.0% 0.13
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.endofthelinebbs.com 1899 1333 0 0 0 5 0 0 561
2twilightnode-out.news.weretis.net 1539 1403 0 0 0 0 0 0 136
3news.tebibyte.org 184 177 0 0 0 0 0 0 7
4news.sklaffkom.se 19 19 0 0 0 0 0 0 0
TOTAL: 4 3641 2932 0 0 0 5 0 0 704

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.sex.nudism 416
alt.sex.panties 254
linux.kernel.netdev 207
alt.sex.sugardaddy.wanted 84
uk.d-i-y 79
nl.politiek 78
alt.sex.wanted.me 67
de.alt.talk.unmut 61
fido7.ru.home 47
alt.sex.young-woman.foroldermen 44
alt.sex.porn.gay 41
alt.sex.videos.gay 39
alt.sex.oral 38
it.discussioni.misteri 38
de.comp.os.unix.networking.misc 37
fido7.ru.military 33
it.sport.calcio.milan 32
linux.kernel.git 29
pl.soc.prawo 25
de.alt.folklore.ddr 24
TOTAL: 307 2932

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 560
User-issued cancel 60
EMP (phl) 32
EMP (phn path) 11
HTML post 6
HTML Multipart 2
Subject Rejected 2
EMP (fsl) 1
Too many newsgroups 1
TOTAL: 9 675

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1chimia.se 4168 4119 2 45 0 0 98%23:59:16
2sklaffkom.se 4547 920 2147 1094 0 2 20%23:59:16
3news.tebibyte.org 2845 0 0 0 0 7003 0%23:59:12
4newsfeed.endofthelinebbs.com 2788 0 0 0 0 6839 0%23:59:01
5weretis.net 235 0 213 0 0 2 0%16:39:20
6sklaff.dev 0 0 0 0 0 4161 0%23:56:54
7thebunker.nu 0 0 0 0 0 4166 0%23:59:15
8usenet.blueworldhosting.com 0 0 0 0 0 3946 0%23:59:06
TOTAL: 8 14583 5039 2362 1139 0 26119 34%184:31:20
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1chimia.se11.1 MB172.7 KB11.3 MB0.1 KB/s2.8 KB23:59:16
2sklaffkom.se1.4 MB3.6 MB5.1 MB0.1 KB/s2.6 KB23:59:16
3news.tebibyte.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:12
4newsfeed.endofthelinebbs.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:01
5sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:54
6thebunker.nu0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:15
7usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:06
8weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s016:39:20
TOTAL: 812.5 MB3.8 MB16.3 MB0.0 KB/s2.7 KB184:31:20
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1185.186.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:04
245-79-168-97.ip.linodeusercontent.com 3 00.0 KB 0 0 000:00:00
3azpdcg1l1xnw.stretchoid.com 2 00.0 KB 0 0 000:00:10
4203.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:01
547.250.95.122 1 00.0 KB 0 0 000:00:03
669.5.169.66 1 00.0 KB 0 0 000:00:00
777.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
881.19.216.104 1 00.0 KB 0 0 000:00:00
9o340.scanner.modat.io 1 00.0 KB 0 0 000:00:00
10o343.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 10 15 00.0 KB 0 0 000:00:21

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.66.censys-scanner.com 4 00.0 KB 0 0 000:00:05
2*.ip.linodeusercontent.com 3 00.0 KB 0 0 000:00:00
3unresolved 3 00.0 KB 0 0 000:00:03
4*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
5*.stretchoid.com 2 00.0 KB 0 0 000:00:10
6*.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
TOTAL: 6 15 00.0 KB 0 0 000:00:21

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
azpdcg1l1xnw.stretchoid.com 0.007 0.022 0.00000:00:10
185.186.132.66.censys-scanner.com 0.042 0.029 0.00000:00:04
47.250.95.122 0.007 0.017 0.00000:00:03
203.172.132.66.censys-scanner.com 0.030 0.012 0.00000:00:01
o343.scanner.modat.io 0.002 0.015 0.00000:00:00
81.19.216.104 0.007 0.012 0.00000:00:00
77.211.203.35.bc.googleusercontent.com 0.003 0.012 0.00000:00:00
45-79-168-97.ip.linodeusercontent.com 0.013 0.020 0.00000:00:00
69.5.169.66 0.003 0.010 0.00000:00:00
o340.scanner.modat.io 0.002 0.013 0.00000:00:00
TOTAL: 10 0.116 0.162 0.00000:00:21

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

SystemConn
77.211.203.35.bc.googleusercontent.com 4
45-79-168-97.ip.linodeusercontent.com 3
185.186.132.66.censys-scanner.com 1
203.172.132.66.censys-scanner.com 1
azpdcg1l1xnw.stretchoid.com 1
TOTAL: 5 10

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

CommandCount
EHLO www.censys.io 2
#023#003#023#001#023#002#001 1
#026#003#001 1
?#032C?)#023#015?K#0241?, ?_? 1
Accept-Encoding: gzip 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: 9 10

NNRP client timeouts [Top 20]:

SystemConnPeer
185.186.132.66.censys-scanner.com 1 2
47.250.95.122 1 1
69.5.169.66 1 1
TOTAL: 3 3 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