Daily Usenet report

Jul 30 03:00:05 -- Jul 31 03:00:05

Unknown entries from news log file:

First 50 / 62 lines (80.6%)

Jul 30 03:01:18 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Jul 30 05:28:47 twilightnode nnrpd[291311]: Reading access from /usr/local/news/etc/readers.conf
Jul 30 05:28:47 twilightnode nnrpd[291311]: Auth strategy 'localhost' does not match client. Removing.
Jul 30 05:28:47 twilightnode nnrpd[291311]: 193.124.20.254 res <anonymous>
Jul 30 05:28:47 twilightnode nnrpd[291311]: 193.124.20.254 no_match_user <anonymous> <localhost>
Jul 30 05:28:47 twilightnode nnrpd[291311]: 193.124.20.254 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 30 05:28:47 twilightnode nnrpd[291311]: 193.124.20.254 match_user <anonymous> <anonymous>
Jul 30 05:28:47 twilightnode nnrpd[291311]: 193.124.20.254 no_post anonymous-read
Jul 30 05:29:09 twilightnode nnrpd[291312]: Reading access from /usr/local/news/etc/readers.conf
Jul 30 05:29:09 twilightnode nnrpd[291312]: Auth strategy 'localhost' does not match client. Removing.
Jul 30 05:29:09 twilightnode nnrpd[291312]: 188.240.59.42 res <anonymous>
Jul 30 05:29:09 twilightnode nnrpd[291312]: 188.240.59.42 no_match_user <anonymous> <localhost>
Jul 30 05:29:09 twilightnode nnrpd[291312]: 188.240.59.42 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 30 05:29:09 twilightnode nnrpd[291312]: 188.240.59.42 match_user <anonymous> <anonymous>
Jul 30 05:29:09 twilightnode nnrpd[291312]: 188.240.59.42 no_post anonymous-read
Jul 30 11:10:01 twilightnode nnrpd[307449]: Reading access from /usr/local/news/etc/readers.conf
Jul 30 11:10:01 twilightnode nnrpd[307449]: Auth strategy 'localhost' does not match client. Removing.
Jul 30 11:10:01 twilightnode nnrpd[307449]: vmd129036.contaboserver.net res <anonymous>
Jul 30 11:10:01 twilightnode nnrpd[307449]: vmd129036.contaboserver.net no_match_user <anonymous> <localhost>
Jul 30 11:10:01 twilightnode nnrpd[307449]: vmd129036.contaboserver.net no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 30 11:10:01 twilightnode nnrpd[307449]: vmd129036.contaboserver.net match_user <anonymous> <anonymous>
Jul 30 11:10:01 twilightnode nnrpd[307449]: vmd129036.contaboserver.net no_post anonymous-read
Jul 30 18:52:58 twilightnode nnrpd[328459]: Reading access from /usr/local/news/etc/readers.conf
Jul 30 18:52:58 twilightnode nnrpd[328459]: Auth strategy 'localhost' does not match client. Removing.
Jul 30 18:52:58 twilightnode nnrpd[328459]: r4-239-ef.monitoring.internet-measurement.com res <anonymous>
Jul 30 18:52:58 twilightnode nnrpd[328459]: r4-239-ef.monitoring.internet-measurement.com no_match_user <anonymous> <localhost>
Jul 30 18:52:58 twilightnode nnrpd[328459]: r4-239-ef.monitoring.internet-measurement.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 30 18:52:58 twilightnode nnrpd[328459]: r4-239-ef.monitoring.internet-measurement.com match_user <anonymous> <anonymous>
Jul 30 18:52:58 twilightnode nnrpd[328459]: r4-239-ef.monitoring.internet-measurement.com no_post anonymous-read
Jul 30 20:49:52 twilightnode nnrpd[333767]: Reading access from /usr/local/news/etc/readers.conf
Jul 30 20:49:52 twilightnode nnrpd[333767]: Auth strategy 'localhost' does not match client. Removing.
Jul 30 20:49:52 twilightnode nnrpd[333767]: zl-dfwc-us-gp1-wk106d.internet-census.org res <anonymous>
Jul 30 20:49:52 twilightnode nnrpd[333767]: zl-dfwc-us-gp1-wk106d.internet-census.org no_match_user <anonymous> <localhost>
Jul 30 20:49:52 twilightnode nnrpd[333767]: zl-dfwc-us-gp1-wk106d.internet-census.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 30 20:49:52 twilightnode nnrpd[333767]: zl-dfwc-us-gp1-wk106d.internet-census.org match_user <anonymous> <anonymous>
Jul 30 20:49:52 twilightnode nnrpd[333767]: zl-dfwc-us-gp1-wk106d.internet-census.org no_post anonymous-read
Jul 30 23:22:38 twilightnode nnrpd[340364]: Reading access from /usr/local/news/etc/readers.conf
Jul 30 23:22:38 twilightnode nnrpd[340364]: Auth strategy 'localhost' does not match client. Removing.
Jul 30 23:22:38 twilightnode nnrpd[340364]: azpdws7ams9u.stretchoid.com res <anonymous>
Jul 30 23:22:38 twilightnode nnrpd[340364]: azpdws7ams9u.stretchoid.com no_match_user <anonymous> <localhost>
Jul 30 23:22:38 twilightnode nnrpd[340364]: azpdws7ams9u.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 30 23:22:38 twilightnode nnrpd[340364]: azpdws7ams9u.stretchoid.com match_user <anonymous> <anonymous>
Jul 30 23:22:38 twilightnode nnrpd[340364]: azpdws7ams9u.stretchoid.com no_post anonymous-read
Jul 30 23:22:48 twilightnode nnrpd[340368]: Reading access from /usr/local/news/etc/readers.conf
Jul 30 23:22:48 twilightnode nnrpd[340368]: Auth strategy 'localhost' does not match client. Removing.
Jul 30 23:22:48 twilightnode nnrpd[340368]: azpdws7ams9u.stretchoid.com res <anonymous>
Jul 30 23:22:48 twilightnode nnrpd[340368]: azpdws7ams9u.stretchoid.com no_match_user <anonymous> <localhost>
Jul 30 23:22:48 twilightnode nnrpd[340368]: azpdws7ams9u.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 30 23:22:48 twilightnode nnrpd[340368]: azpdws7ams9u.stretchoid.com match_user <anonymous> <anonymous>
Jul 30 23:22:48 twilightnode nnrpd[340368]: azpdws7ams9u.stretchoid.com no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
inn 6560 73.6%993.2 KB 73.6%
innfeed 1155 13.0%177.2 KB 13.1%
innd 1098 12.3%168.7 KB 12.5%
nnrpd 94 1.1%10.6 KB 0.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 8908 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 14802 48.6%
Negative hits 9145 30.0%
Do not exist 6502 21.4%
Cache misses 0 0.0%
TOTAL: 4 30449 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.010 0.0%10 0.000 1.000 2.000
article cleanup00:00:00.048 0.0%6548 0.000 0.007 0.083
article logging00:00:00.202 0.0%6565 0.000 0.031 0.238
article parse00:00:00.095 0.0%9336 0.000 0.010 0.105
article write00:00:04.158 0.0%4887 0.297 0.851 3.071
data move00:00:00.090 0.0%33499 0.000 0.003 0.020
hisgrep/artcncl00:00:00.003 0.0%10 0.000 0.300 1.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.263 0.0%30584 0.063 0.139 0.440
history sync00:00:00.041 0.0%324 0.000 0.127 2.500
history write00:00:03.115 0.0%6531 0.150 0.477 1.143
idle24:00:03.861100.0%32509 1304.426 2657.844 11767.608
nntp read00:00:00.555 0.0%32244 0.000 0.017 0.045
overview write00:00:02.251 0.0%4887 0.154 0.461 2.542
perl filter00:00:07.875 0.0%6531 0.712 1.206 7.556
python filter00:00:00.533 0.0%6531 0.000 0.082 0.833
site send00:00:00.070 0.0%4886 0.000 0.014 0.278
TOTAL: 1724:00:27.170100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.016 0.0%5332 0.000 0.003 0.167
article prepare00:00:00.000 0.0%16988 0.000 0.000 0.000
article read00:00:00.500 0.0%3263 0.000 0.153 0.750
backlog stats00:00:00.045 0.0%52899 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.380 0.0%28822 0.000 0.013 0.050
data write00:00:00.569 0.0%23908 0.000 0.024 0.071
idle23:50:07.253100.0%52899 391.775 1622.096 5831.641
status file00:00:00.197 0.0%186 0.000 1.059 99.000
TOTAL: 923:50:08.960100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:28.441100.0%12 88.500 2370.083 10582.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%67 0.000 0.015 0.200
TOTAL: 300:00:28.442100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 3 11534 4172 6120 1242 36%48:11:57
2newsfeed.endofthelinebbs.com 1 5013 547 4116 350 10%23:56:58
3news.tebibyte.org 1 5060 99 4906 55 1%23:59:57
4news.sklaffkom.se 37 132 58 22 52 43%12:01:52
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 67 21739 4876 15164 1699 22%108:10:44
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net12.4 MB48.0 KB4.0 MB16.4 MB 75%3.1 KB
2newsfeed.endofthelinebbs.com5.1 MB0.0 KB638.8 KB5.7 MB 89%6.5 KB
3news.tebibyte.org270.0 KB0.0 KB244.7 KB514.8 KB 52%3.3 KB
4news.sklaffkom.se164.1 KB0.0 KB116.6 KB280.8 KB 58%2.6 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 517.9 MB48.0 KB4.9 MB22.9 MB 78%3.6 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 30 03:00:05 - 03:59:59 100 2.0% 0.03440.0 KB 2.3% 0.12
Jul 30 04:00:00 - 04:59:59 111 2.3% 0.03316.2 KB 1.7% 0.09
Jul 30 05:00:00 - 05:59:59 125 2.6% 0.03394.0 KB 2.1% 0.11
Jul 30 06:00:00 - 06:59:59 128 2.6% 0.04439.9 KB 2.3% 0.12
Jul 30 07:00:00 - 07:59:59 176 3.6% 0.05628.0 KB 3.3% 0.17
Jul 30 08:00:00 - 08:59:59 152 3.1% 0.04522.7 KB 2.8% 0.15
Jul 30 09:00:00 - 09:59:59 231 4.7% 0.06686.5 KB 3.6% 0.19
Jul 30 10:00:00 - 10:59:59 211 4.3% 0.06664.5 KB 3.5% 0.18
Jul 30 11:00:00 - 11:59:59 217 4.4% 0.06808.4 KB 4.3% 0.22
Jul 30 12:00:00 - 12:59:59 255 5.2% 0.071.1 MB 5.7% 0.30
Jul 30 13:00:00 - 13:59:59 244 5.0% 0.071.1 MB 6.0% 0.32
Jul 30 14:00:00 - 14:59:59 205 4.2% 0.06903.1 KB 4.8% 0.25
Jul 30 15:00:00 - 15:59:59 243 5.0% 0.07933.0 KB 5.0% 0.26
Jul 30 16:00:00 - 16:59:59 417 8.5% 0.121.7 MB 9.3% 0.48
Jul 30 17:00:00 - 17:59:59 307 6.3% 0.091.0 MB 5.6% 0.29
Jul 30 18:00:00 - 18:59:59 257 5.3% 0.07885.9 KB 4.7% 0.25
Jul 30 19:00:00 - 19:59:59 240 4.9% 0.07860.5 KB 4.6% 0.24
Jul 30 20:00:00 - 20:59:59 283 5.8% 0.081.1 MB 5.8% 0.30
Jul 30 21:00:00 - 21:59:59 234 4.8% 0.07911.7 KB 4.8% 0.25
Jul 30 22:00:00 - 22:59:59 233 4.8% 0.061014.5 KB 5.4% 0.28
Jul 30 23:00:00 - 23:59:59 167 3.4% 0.05648.5 KB 3.4% 0.18
Jul 31 00:00:00 - 00:59:59 127 2.6% 0.04520.6 KB 2.8% 0.14
Jul 31 01:00:00 - 01:59:59 116 2.4% 0.03457.6 KB 2.4% 0.13
Jul 31 02:00:00 - 02:59:59 99 2.0% 0.03678.7 KB 3.6% 0.19
Jul 31 03:00:00 - 03:00:05 9 0.2% 1.808.2 KB 0.0% 1.63
TOTAL: 24:00:00 4887 100.0% 0.0618.4 MB 100.0% 0.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1232 1162 0 17 0 0 0 0 53
2newsfeed.endofthelinebbs.com 349 39 0 0 0 0 0 0 310
3news.sklaffkom.se 52 52 0 0 0 0 0 0 0
4news.tebibyte.org 40 37 0 0 0 0 0 0 3
TOTAL: 4 1673 1290 0 17 0 0 0 0 366

Unwanted newsgroups [Top 20]:

NewsgroupCount
pl.soc.prawo 83
alt.fan.rush-limbaurgh 53
alt.usage.english 41
pl.misc.elektronika 41
de.alt.talk.unmut 36
pl.soc.polityka 32
alt.checkmate 29
linux.debian.vote 27
spline.eisfair 26
alt.prophecies.nostradamus 25
eternal-september.talk 25
de.alt.comm.android 21
de.test 21
linux.debian.user 21
cn.comp 20
it.tlc.cellulari.android 20
alt.home.repair 19
lada.talk 19
uk.legal.moderated 19
eternal-september.test 18
TOTAL: 212 1290

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 316
User-issued cancel 29
Too many newsgroups (meow) 3
HTML Multipart 1
TOTAL: 4 349

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 6671 1022 3862 0 0 87 15%23:59:56
2sklaffkom.se 5067 755 1713 2418 0 13 14%23:59:41
3newsfeed.endofthelinebbs.com 8321 60 4259 11 0 371 0%23:58:48
4weretis.net 732 0 692 0 0 0 0%22:41:35
TOTAL: 4 20791 1837 10526 2429 0 471 8%94:40:00
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org3.1 MB0.0 KB3.1 MB0.0 KB/s3.1 KB23:59:56
2sklaffkom.se1.5 MB11.1 MB12.6 MB0.1 KB/s4.1 KB23:59:41
3newsfeed.endofthelinebbs.com177.1 KB19.8 KB196.9 KB0.0 KB/s2.8 KB23:58:48
4weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s022:41:35
TOTAL: 44.8 MB11.1 MB15.9 MB0.0 KB/s3.8 KB94:40:00
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1azpdws7ams9u.stretchoid.com 2 00.0 KB 0 0 000:00:10
2188.240.59.42 1 00.0 KB 0 0 000:00:00
3193.124.20.254 1 00.0 KB 0 0 000:00:00
4203.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
5r4-239-ef.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
6vmd129036.contaboserver.net 1 00.0 KB 0 0 000:00:00
7zl-dfwc-us-gp1-wk106d.internet-census.org 1 00.0 KB 0 0 000:00:10
TOTAL: 7 8 00.0 KB 0 0 000:00:28

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.stretchoid.com 2 00.0 KB 0 0 000:00:10
2unresolved 2 00.0 KB 0 0 000:00:00
3*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
4*.contaboserver.net 1 00.0 KB 0 0 000:00:00
5*.internet-census.org 1 00.0 KB 0 0 000:00:10
6*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 6 8 00.0 KB 0 0 000:00:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
zl-dfwc-us-gp1-wk106d.internet-census.org 0.003 0.011 0.00000:00:10
azpdws7ams9u.stretchoid.com 0.006 0.023 0.00000:00:10
203.172.132.66.censys-scanner.com 0.027 0.038 0.00000:00:03
r4-239-ef.monitoring.internet-measurement.com 0.003 0.012 0.00000:00:01
vmd129036.contaboserver.net 0.003 0.011 0.00000:00:00
188.240.59.42 0.003 0.007 0.00000:00:00
193.124.20.254 0.005 0.010 0.00000:00:00
TOTAL: 7 0.050 0.112 0.00000:00:28

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

SystemConn
203.172.132.66.censys-scanner.com 1
azpdws7ams9u.stretchoid.com 1
TOTAL: 2 2

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

CommandCount
EHLO www.censys.io 1
MGLNDD_172.234.115.63_119 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
188.240.59.42 1 1
TOTAL: 1 1 2
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