Daily Usenet report

Aug 7 03:00:04 -- Aug 8 03:00:04

Unknown entries from news log file:

First 50 / 175 lines (28.6%)

Aug 7 03:01:30 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Aug 7 05:37:33 twilightnode nnrpd[817176]: Reading access from /usr/local/news/etc/readers.conf
Aug 7 05:37:33 twilightnode nnrpd[817176]: Auth strategy 'localhost' does not match client. Removing.
Aug 7 05:37:33 twilightnode nnrpd[817176]: 53.195.132.66.censys-scanner.com res <anonymous>
Aug 7 05:37:33 twilightnode nnrpd[817176]: 53.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 7 05:37:33 twilightnode nnrpd[817176]: 53.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 7 05:37:33 twilightnode nnrpd[817176]: 53.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 7 05:37:33 twilightnode nnrpd[817176]: 53.195.132.66.censys-scanner.com no_post anonymous-read
Aug 7 05:37:37 twilightnode nnrpd[817177]: Reading access from /usr/local/news/etc/readers.conf
Aug 7 05:37:37 twilightnode nnrpd[817177]: Auth strategy 'localhost' does not match client. Removing.
Aug 7 05:37:37 twilightnode nnrpd[817177]: 53.195.132.66.censys-scanner.com res <anonymous>
Aug 7 05:37:37 twilightnode nnrpd[817177]: 53.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 7 05:37:37 twilightnode nnrpd[817177]: 53.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 7 05:37:37 twilightnode nnrpd[817177]: 53.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 7 05:37:37 twilightnode nnrpd[817177]: 53.195.132.66.censys-scanner.com no_post anonymous-read
Aug 7 05:37:43 twilightnode nnrpd[817178]: Reading access from /usr/local/news/etc/readers.conf
Aug 7 05:37:43 twilightnode nnrpd[817178]: Auth strategy 'localhost' does not match client. Removing.
Aug 7 05:37:43 twilightnode nnrpd[817178]: 53.195.132.66.censys-scanner.com res <anonymous>
Aug 7 05:37:43 twilightnode nnrpd[817178]: 53.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 7 05:37:43 twilightnode nnrpd[817178]: 53.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 7 05:37:43 twilightnode nnrpd[817178]: 53.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 7 05:37:43 twilightnode nnrpd[817178]: 53.195.132.66.censys-scanner.com no_post anonymous-read
Aug 7 05:37:44 twilightnode nnrpd[817178]: 53.195.132.66.censys-scanner.com res <anonymous>
Aug 7 05:37:44 twilightnode nnrpd[817178]: 53.195.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 7 05:37:44 twilightnode nnrpd[817178]: 53.195.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 7 05:37:44 twilightnode nnrpd[817178]: 53.195.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 7 05:37:44 twilightnode nnrpd[817178]: 53.195.132.66.censys-scanner.com no_post anonymous-read
Aug 7 07:39:50 twilightnode nnrpd[822908]: Reading access from /usr/local/news/etc/readers.conf
Aug 7 07:39:50 twilightnode nnrpd[822908]: Auth strategy 'localhost' does not match client. Removing.
Aug 7 07:39:50 twilightnode nnrpd[822908]: kco.tkk.iki.fi res <anonymous>
Aug 7 07:39:50 twilightnode nnrpd[822908]: kco.tkk.iki.fi no_match_user <anonymous> <localhost>
Aug 7 07:39:50 twilightnode nnrpd[822908]: kco.tkk.iki.fi no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 7 07:39:50 twilightnode nnrpd[822908]: kco.tkk.iki.fi match_user <anonymous> <anonymous>
Aug 7 07:39:50 twilightnode nnrpd[822908]: kco.tkk.iki.fi no_post anonymous-read
Aug 7 07:40:06 twilightnode nnrpd[823019]: Reading access from /usr/local/news/etc/readers.conf
Aug 7 07:40:06 twilightnode nnrpd[823019]: Auth strategy 'localhost' does not match client. Removing.
Aug 7 07:40:06 twilightnode nnrpd[823019]: kco.tkk.iki.fi res <anonymous>
Aug 7 07:40:06 twilightnode nnrpd[823019]: kco.tkk.iki.fi no_match_user <anonymous> <localhost>
Aug 7 07:40:06 twilightnode nnrpd[823019]: kco.tkk.iki.fi no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 7 07:40:06 twilightnode nnrpd[823019]: kco.tkk.iki.fi match_user <anonymous> <anonymous>
Aug 7 07:40:06 twilightnode nnrpd[823019]: kco.tkk.iki.fi no_post anonymous-read
Aug 7 07:43:33 twilightnode nnrpd[823049]: Reading access from /usr/local/news/etc/readers.conf
Aug 7 07:43:33 twilightnode nnrpd[823049]: Auth strategy 'localhost' does not match client. Removing.
Aug 7 07:43:33 twilightnode nnrpd[823049]: 84-231-161-217.elisa-mobile.fi res <anonymous>
Aug 7 07:43:33 twilightnode nnrpd[823049]: 84-231-161-217.elisa-mobile.fi no_match_user <anonymous> <localhost>
Aug 7 07:43:33 twilightnode nnrpd[823049]: 84-231-161-217.elisa-mobile.fi no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 7 07:43:33 twilightnode nnrpd[823049]: 84-231-161-217.elisa-mobile.fi match_user <anonymous> <anonymous>
Aug 7 07:43:33 twilightnode nnrpd[823049]: 84-231-161-217.elisa-mobile.fi no_post anonymous-read
Aug 7 07:43:56 twilightnode nnrpd[823056]: Reading access from /usr/local/news/etc/readers.conf
Aug 7 07:43:56 twilightnode nnrpd[823056]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 6794 69.1%1.0 MB 70.2%
innd 1455 14.8%216.9 KB 14.8%
innfeed 1241 12.6%181.1 KB 12.4%
nnrpd 321 3.3%33.8 KB 2.3%
controlchan 22 0.2%4.6 KB 0.3%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 6 9834 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 14244 47.8%
Negative hits 8771 29.5%
Do not exist 6754 22.7%
Cache misses 0 0.0%
TOTAL: 4 29769 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.025 0.0%14 0.500 1.786 6.000
article cleanup00:00:00.046 0.0%6771 0.000 0.007 0.065
article logging00:00:00.285 0.0%6795 0.000 0.042 0.194
article parse00:00:00.093 0.0%9480 0.000 0.010 0.062
article write00:00:04.860 0.0%5008 0.308 0.970 2.161
data move00:00:00.153 0.0%33053 0.000 0.005 0.031
hisgrep/artcncl00:00:00.008 0.0%14 0.000 0.571 3.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.475 0.0%29844 0.094 0.150 0.276
history sync00:00:00.036 0.0%328 0.000 0.110 2.000
history write00:00:03.094 0.0%6771 0.150 0.457 1.208
idle24:00:02.632100.0%32366 1387.910 2669.549 12503.854
nntp read00:00:00.599 0.0%32044 0.000 0.019 0.054
overview write00:00:02.693 0.0%5008 0.204 0.538 4.667
perl filter00:00:10.503 0.0%6771 0.705 1.551 9.611
python filter00:00:00.722 0.0%6771 0.000 0.107 0.778
site send00:00:00.078 0.0%4971 0.000 0.016 0.115
TOTAL: 1724:00:30.302100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%5378 0.000 0.004 0.083
article prepare00:00:00.003 0.0%20752 0.000 0.000 0.005
article read00:00:00.725 0.0%3651 0.050 0.199 2.200
backlog stats00:00:00.026 0.0%55447 0.000 0.000 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.365 0.0%30088 0.000 0.012 0.049
data write00:00:00.620 0.0%25107 0.000 0.025 0.083
idle23:59:08.465100.0%55447 404.138 1557.315 5568.546
status file00:00:00.186 0.0%226 0.000 0.823 3.000
TOTAL: 923:59:10.409100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:13:06.125100.0%111 62.000 7082.207 23332.778
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.251 0.0%9749 0.000 0.026 2.720
readart00:00:00.005 0.0%21 0.000 0.238 1.000
TOTAL: 400:13:06.381100.0%----

Control commands to innd:

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

Control channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org081109
TOTAL081109

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 21 10949 4265 5427 1257 38%44:48:19
2newsfeed.endofthelinebbs.com 9 4554 474 3682 398 10%20:56:25
3news.tebibyte.org 1 4786 101 4663 22 2%23:59:55
4news.sklaffkom.se 40 85 40 22 23 47%10:56:09
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 96 20374 4880 13794 1700 23%100:40:48
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net12.2 MB0.0 KB3.6 MB15.8 MB 77%2.9 KB
2newsfeed.endofthelinebbs.com5.4 MB0.0 KB637.3 KB6.1 MB 89%7.1 KB
3news.tebibyte.org334.1 KB0.0 KB129.2 KB463.2 KB 72%3.8 KB
4news.sklaffkom.se104.5 KB0.0 KB48.6 KB153.1 KB 68%2.4 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 518.1 MB0.0 KB4.4 MB22.5 MB 80%3.5 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 7 03:00:04 - 03:59:59 104 2.1% 0.03469.2 KB 2.4% 0.13
Aug 7 04:00:00 - 04:59:59 99 2.0% 0.03425.2 KB 2.2% 0.12
Aug 7 05:00:00 - 05:59:59 167 3.3% 0.051.1 MB 5.8% 0.31
Aug 7 06:00:00 - 06:59:59 146 2.9% 0.04828.6 KB 4.3% 0.23
Aug 7 07:00:00 - 07:59:59 201 4.0% 0.06653.1 KB 3.4% 0.18
Aug 7 08:00:00 - 08:59:59 174 3.5% 0.05656.1 KB 3.4% 0.18
Aug 7 09:00:00 - 09:59:59 277 5.5% 0.081.1 MB 6.0% 0.32
Aug 7 10:00:00 - 10:59:59 260 5.2% 0.07719.0 KB 3.7% 0.20
Aug 7 11:00:00 - 11:59:59 246 4.9% 0.07853.7 KB 4.4% 0.24
Aug 7 12:00:00 - 12:59:59 192 3.8% 0.05574.8 KB 3.0% 0.16
Aug 7 13:00:00 - 13:59:59 196 3.9% 0.05575.3 KB 3.0% 0.16
Aug 7 14:00:00 - 14:59:59 229 4.6% 0.06638.1 KB 3.3% 0.18
Aug 7 15:00:00 - 15:59:59 264 5.3% 0.071.5 MB 7.9% 0.42
Aug 7 16:00:00 - 16:59:59 260 5.2% 0.07950.5 KB 5.0% 0.26
Aug 7 17:00:00 - 17:59:59 320 6.4% 0.091.2 MB 6.6% 0.35
Aug 7 18:00:00 - 18:59:59 268 5.4% 0.07944.9 KB 4.9% 0.26
Aug 7 19:00:00 - 19:59:59 299 6.0% 0.081.1 MB 5.6% 0.30
Aug 7 20:00:00 - 20:59:59 217 4.3% 0.06710.3 KB 3.7% 0.20
Aug 7 21:00:00 - 21:59:59 205 4.1% 0.06586.0 KB 3.1% 0.16
Aug 7 22:00:00 - 22:59:59 234 4.7% 0.07849.9 KB 4.4% 0.24
Aug 7 23:00:00 - 23:59:59 261 5.2% 0.07948.0 KB 4.9% 0.26
Aug 8 00:00:00 - 00:59:59 150 3.0% 0.04678.8 KB 3.5% 0.19
Aug 8 01:00:00 - 01:59:59 128 2.6% 0.04445.5 KB 2.3% 0.12
Aug 8 02:00:00 - 02:59:59 102 2.0% 0.03546.6 KB 2.8% 0.15
Aug 8 03:00:00 - 03:00:04 9 0.2% 2.257.6 KB 0.0% 1.89
TOTAL: 24:00:00 5008 100.0% 0.0618.7 MB 100.0% 0.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1323 1081 0 0 0 0 0 0 242
2newsfeed.endofthelinebbs.com 409 46 0 0 0 0 0 0 363
3news.tebibyte.org 31 27 0 0 0 0 0 0 4
4news.sklaffkom.se 23 23 0 0 0 0 0 0 0
TOTAL: 4 1786 1177 0 0 0 0 0 0 609

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.net.news.moderation 54
lada.talk 46
alt.usage.english 44
de.talk.jokes 38
alt.fan.rush-limbaurgh 36
de.alt.talk.unmut 36
pl.soc.prawo 29
alt.atheism 27
it.hobby.cucina 27
alt.bestjobsusa.computer.jobs 26
alt.checkmate 26
muc.lists.freebsd.bugs 22
alt.slack 20
hfx.general 20
uk.legal.moderated 20
de.comm.software.mozilla.nightly-builds 19
dk.politik 19
francom.esoterisme 18
pl.sci.fizyka 17
alt.privacy.anon-server 16
TOTAL: 203 1177

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 398
EMP (phn path) 118
User-issued cancel 52
Too many newsgroups 11
HTML Multipart 4
Too many newsgroups (meow) 2
TOTAL: 6 585

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
twilightnode-out.news.weretis.net 23
newsfeed.endofthelinebbs.com 1
TOTAL: 2 24
TOTAL: 1 24

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 6482 1624 3333 1 0 10 25%23:59:47
2sklaffkom.se 5280 920 1434 2606 0 248 17%23:59:55
3newsfeed.endofthelinebbs.com 8600 37 4376 9 0 169 0%23:59:55
4weretis.net 689 1 679 0 0 0 0%22:06:23
TOTAL: 4 21051 2582 9822 2616 0 427 12%94:06:00
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org4.0 MB231.9 KB4.3 MB0.1 KB/s2.7 KB23:59:47
2sklaffkom.se1.5 MB12.6 MB14.1 MB0.2 KB/s4.1 KB23:59:55
3newsfeed.endofthelinebbs.com88.7 KB26.5 KB115.1 KB0.0 KB/s2.5 KB23:59:55
4weretis.net1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB22:06:23
TOTAL: 45.7 MB12.8 MB18.5 MB0.1 KB/s3.6 KB94:06:00
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
184-231-161-217.elisa-mobile.fi 4 2119.3 KB 17 0 100:11:24
TOTAL: 1 4 2119.3 KB 17 0 100:11:24

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.elisa-mobile.fi 4 2119.3 KB 17 0 100:11:24
2*.probe.onyphe.net 4 00.0 KB 0 0 000:00:07
3*.167.censys-scanner.com 3 00.0 KB 0 0 000:00:01
4*.66.censys-scanner.com 3 00.0 KB 0 0 000:00:04
5*.tkk.iki.fi 3 00.0 KB 0 0 000:01:06
6unresolved 3 00.0 KB 0 0 000:00:01
7*.stretchoid.com 2 00.0 KB 0 0 000:00:10
8*.cust.telenor.se 1 00.0 KB 0 0 000:00:10
TOTAL: 8 23 2119.3 KB 17 0 100:13:06

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
84-231-161-217.elisa-mobile.fi 0.038 0.071 0.00000:11:24
kco.tkk.iki.fi 0.008 0.022 0.00000:00:49
mxo.tkk.iki.fi 0.004 0.013 0.00000:00:17
azpdesj0pi01.stretchoid.com 0.011 0.016 0.00000:00:10
c-5eea5b77-74736162.cust.telenor.se 0.004 0.010 0.00000:00:10
53.195.132.66.censys-scanner.com 0.039 0.076 0.00000:00:04
richards.probe.onyphe.net 0.004 0.004 0.00000:00:02
ciara.probe.onyphe.net 0.003 0.006 0.00000:00:02
57.146.94.167.censys-scanner.com 0.031 0.019 0.00000:00:01
louisa.probe.onyphe.net 0.001 0.012 0.00000:00:00
denis.probe.onyphe.net 0.006 0.011 0.00000:00:00
205.210.31.158 0.002 0.014 0.00000:00:00
69.5.169.47 0.004 0.011 0.00000:00:00
193.124.20.248 0.003 0.015 0.00000:00:00
TOTAL: 14 0.158 0.300 0.00000:13:06

Curious NNRP explorers [Top 20]:

SystemConn
53.195.132.66.censys-scanner.com 3
57.146.94.167.censys-scanner.com 3
azpdesj0pi01.stretchoid.com 2
kco.tkk.iki.fi 2
193.124.20.248 1
205.210.31.158 1
69.5.169.47 1
c-5eea5b77-74736162.cust.telenor.se 1
ciara.probe.onyphe.net 1
denis.probe.onyphe.net 1
louisa.probe.onyphe.net 1
mxo.tkk.iki.fi 1
richards.probe.onyphe.net 1
TOTAL: 13 19

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

SystemConn
denis.probe.onyphe.net 2
louisa.probe.onyphe.net 2
53.195.132.66.censys-scanner.com 1
57.146.94.167.censys-scanner.com 1
azpdesj0pi01.stretchoid.com 1
TOTAL: 5 7

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

CommandCount
#026#003#003#002c#001 2
?$?,?r?s?#023#002#023#001?#024?#007?#022?#023?'?/?#024?(?0?`?a... 2
EHLO www.censys.io 2
MGLNDD_172.234.115.63_119 1
TOTAL: 4 7

NNRP client timeouts [Top 20]:

SystemConnPeer
53.195.132.66.censys-scanner.com 1 2
57.146.94.167.censys-scanner.com 1 2
69.5.169.47 1 1
TOTAL: 3 3 7

Newsgroup request counts (by hierarchy) [Top 100]:

HierarchyCountPct
1swnet 9 52.9%
2misc 5 29.4%
3alt 3 17.6%
TOTAL: 3 17100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1swnet.sklaff.test 9
2misc.test 5
3alt.test 3
TOTAL: 3 17
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