Daily Usenet report

Aug 12 03:00:04 -- Aug 13 03:00:03

Unknown entries from news log file:

First 50 / 76 lines (65.8%)

Aug 12 03:00:53 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Aug 12 05:30:15 twilightnode nnrpd[1170772]: Reading access from /usr/local/news/etc/readers.conf
Aug 12 05:30:15 twilightnode nnrpd[1170772]: Auth strategy 'localhost' does not match client. Removing.
Aug 12 05:30:15 twilightnode nnrpd[1170772]: 102.172.132.66.censys-scanner.com res <anonymous>
Aug 12 05:30:15 twilightnode nnrpd[1170772]: 102.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 12 05:30:15 twilightnode nnrpd[1170772]: 102.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 12 05:30:15 twilightnode nnrpd[1170772]: 102.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 12 05:30:15 twilightnode nnrpd[1170772]: 102.172.132.66.censys-scanner.com no_post anonymous-read
Aug 12 05:30:18 twilightnode nnrpd[1170773]: Reading access from /usr/local/news/etc/readers.conf
Aug 12 05:30:18 twilightnode nnrpd[1170773]: Auth strategy 'localhost' does not match client. Removing.
Aug 12 05:30:18 twilightnode nnrpd[1170773]: 102.172.132.66.censys-scanner.com res <anonymous>
Aug 12 05:30:18 twilightnode nnrpd[1170773]: 102.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 12 05:30:18 twilightnode nnrpd[1170773]: 102.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 12 05:30:18 twilightnode nnrpd[1170773]: 102.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 12 05:30:18 twilightnode nnrpd[1170773]: 102.172.132.66.censys-scanner.com no_post anonymous-read
Aug 12 05:30:21 twilightnode nnrpd[1170774]: Reading access from /usr/local/news/etc/readers.conf
Aug 12 05:30:21 twilightnode nnrpd[1170774]: Auth strategy 'localhost' does not match client. Removing.
Aug 12 05:30:21 twilightnode nnrpd[1170774]: 102.172.132.66.censys-scanner.com res <anonymous>
Aug 12 05:30:21 twilightnode nnrpd[1170774]: 102.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 12 05:30:21 twilightnode nnrpd[1170774]: 102.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 12 05:30:21 twilightnode nnrpd[1170774]: 102.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 12 05:30:21 twilightnode nnrpd[1170774]: 102.172.132.66.censys-scanner.com no_post anonymous-read
Aug 12 05:30:22 twilightnode nnrpd[1170774]: 102.172.132.66.censys-scanner.com res <anonymous>
Aug 12 05:30:22 twilightnode nnrpd[1170774]: 102.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Aug 12 05:30:22 twilightnode nnrpd[1170774]: 102.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 12 05:30:22 twilightnode nnrpd[1170774]: 102.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Aug 12 05:30:22 twilightnode nnrpd[1170774]: 102.172.132.66.censys-scanner.com no_post anonymous-read
Aug 12 06:26:58 twilightnode nnrpd[1173107]: Reading access from /usr/local/news/etc/readers.conf
Aug 12 06:26:58 twilightnode nnrpd[1173107]: Auth strategy 'localhost' does not match client. Removing.
Aug 12 06:26:58 twilightnode nnrpd[1173107]: r4-235-eb.monitoring.internet-measurement.com res <anonymous>
Aug 12 06:26:58 twilightnode nnrpd[1173107]: r4-235-eb.monitoring.internet-measurement.com no_match_user <anonymous> <localhost>
Aug 12 06:26:58 twilightnode nnrpd[1173107]: r4-235-eb.monitoring.internet-measurement.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 12 06:26:58 twilightnode nnrpd[1173107]: r4-235-eb.monitoring.internet-measurement.com match_user <anonymous> <anonymous>
Aug 12 06:26:58 twilightnode nnrpd[1173107]: r4-235-eb.monitoring.internet-measurement.com no_post anonymous-read
Aug 12 07:16:09 twilightnode nnrpd[1180910]: Reading access from /usr/local/news/etc/readers.conf
Aug 12 07:16:09 twilightnode nnrpd[1180910]: Auth strategy 'localhost' does not match client. Removing.
Aug 12 07:16:09 twilightnode nnrpd[1180910]: 69.5.169.7 res <anonymous>
Aug 12 07:16:09 twilightnode nnrpd[1180910]: 69.5.169.7 no_match_user <anonymous> <localhost>
Aug 12 07:16:09 twilightnode nnrpd[1180910]: 69.5.169.7 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 12 07:16:09 twilightnode nnrpd[1180910]: 69.5.169.7 match_user <anonymous> <anonymous>
Aug 12 07:16:09 twilightnode nnrpd[1180910]: 69.5.169.7 no_post anonymous-read
Aug 12 07:16:15 twilightnode nnrpd[1180911]: Reading access from /usr/local/news/etc/readers.conf
Aug 12 07:16:15 twilightnode nnrpd[1180911]: Auth strategy 'localhost' does not match client. Removing.
Aug 12 07:16:15 twilightnode nnrpd[1180911]: 194.88.98.89 res <anonymous>
Aug 12 07:16:15 twilightnode nnrpd[1180911]: 194.88.98.89 no_match_user <anonymous> <localhost>
Aug 12 07:16:15 twilightnode nnrpd[1180911]: 194.88.98.89 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Aug 12 07:16:15 twilightnode nnrpd[1180911]: 194.88.98.89 match_user <anonymous> <anonymous>
Aug 12 07:16:15 twilightnode nnrpd[1180911]: 194.88.98.89 no_post anonymous-read
Aug 12 19:44:01 twilightnode nnrpd[1212955]: Reading access from /usr/local/news/etc/readers.conf
Aug 12 19:44:01 twilightnode nnrpd[1212955]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 6744 68.5%1019.2 KB 70.0%
innd 1751 17.8%239.5 KB 16.4%
innfeed 1223 12.4%183.4 KB 12.6%
nnrpd 125 1.3%13.8 KB 1.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 9844 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 14708 48.8%
Negative hits 8708 28.9%
Do not exist 6703 22.3%
Cache misses 5 0.0%
TOTAL: 4 30124 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.009 0.0%5 1.000 1.800 2.500
article cleanup00:00:00.059 0.0%6737 0.000 0.009 0.100
article logging00:00:00.238 0.0%6753 0.000 0.035 0.161
article parse00:00:00.085 0.0%9350 0.000 0.009 0.091
article write00:00:04.428 0.0%4906 0.529 0.903 1.714
data move00:00:00.153 0.0%33640 0.000 0.005 0.045
hisgrep/artcncl00:00:00.004 0.0%5 0.000 0.800 1.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.803 0.0%30263 0.064 0.126 0.271
history sync00:00:00.058 0.0%327 0.000 0.177 1.000
history write00:00:03.011 0.0%6737 0.125 0.447 0.854
idle24:00:10.272100.0%32716 1357.210 2641.224 16218.838
nntp read00:00:00.645 0.0%32428 0.000 0.020 0.059
overview write00:00:02.224 0.0%4906 0.196 0.453 1.727
perl filter00:00:08.798 0.0%6737 0.708 1.306 9.350
python filter00:00:00.576 0.0%6737 0.000 0.085 0.600
site send00:00:00.087 0.0%4881 0.000 0.018 0.143
TOTAL: 1724:00:34.450100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.017 0.0%4942 0.000 0.003 0.111
article prepare00:00:00.001 0.0%16676 0.000 0.000 0.004
article read00:00:00.496 0.0%3235 0.000 0.153 2.333
backlog stats00:00:00.034 0.0%55589 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.327 0.0%29783 0.000 0.011 0.055
data write00:00:00.648 0.0%24775 0.000 0.026 0.167
idle23:49:54.616100.0%55589 389.274 1543.374 5410.423
status file00:00:00.135 0.0%226 0.000 0.597 3.000
TOTAL: 923:49:56.274100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.316100.0%19 61.500 1016.632 5679.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%133 0.000 0.000 0.000
TOTAL: 300:00:19.316100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 4 11649 4251 6101 1297 36%48:55:48
2newsfeed.endofthelinebbs.com 2 4977 555 3947 475 11%23:32:11
3news.tebibyte.org 1 4672 91 4544 37 1%23:59:54
4news.sklaffkom.se 48 134 66 23 45 49%13:50:15
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 80 21432 4963 14615 1854 23%110:18:08
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net13.2 MB0.0 KB4.6 MB17.7 MB 74%3.3 KB
2newsfeed.endofthelinebbs.com4.7 MB0.0 KB897.2 KB5.6 MB 84%5.6 KB
3news.tebibyte.org253.6 KB0.0 KB102.0 KB355.6 KB 71%2.8 KB
4news.sklaffkom.se188.2 KB0.0 KB106.1 KB294.3 KB 63%2.7 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 518.3 MB0.0 KB5.7 MB24.0 MB 76%3.6 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 12 03:00:04 - 03:59:59 96 2.0% 0.03466.2 KB 2.5% 0.13
Aug 12 04:00:00 - 04:59:59 67 1.4% 0.02342.2 KB 1.8% 0.10
Aug 12 05:00:00 - 05:59:59 74 1.5% 0.02191.1 KB 1.0% 0.05
Aug 12 06:00:00 - 06:59:59 113 2.3% 0.03424.2 KB 2.2% 0.12
Aug 12 07:00:00 - 07:59:59 174 3.6% 0.05533.6 KB 2.8% 0.15
Aug 12 08:00:00 - 08:59:59 189 3.9% 0.05655.5 KB 3.5% 0.18
Aug 12 09:00:00 - 09:59:59 199 4.1% 0.06743.8 KB 3.9% 0.21
Aug 12 10:00:00 - 10:59:59 297 6.1% 0.08978.0 KB 5.2% 0.27
Aug 12 11:00:00 - 11:59:59 294 6.0% 0.08854.7 KB 4.5% 0.24
Aug 12 12:00:00 - 12:59:59 260 5.3% 0.071.0 MB 5.6% 0.30
Aug 12 13:00:00 - 13:59:59 215 4.4% 0.06669.1 KB 3.5% 0.19
Aug 12 14:00:00 - 14:59:59 249 5.1% 0.07781.0 KB 4.1% 0.22
Aug 12 15:00:00 - 15:59:59 286 5.8% 0.08952.5 KB 5.0% 0.26
Aug 12 16:00:00 - 16:59:59 348 7.1% 0.101.1 MB 5.8% 0.31
Aug 12 17:00:00 - 17:59:59 299 6.1% 0.081.4 MB 7.7% 0.41
Aug 12 18:00:00 - 18:59:59 290 5.9% 0.081.1 MB 5.9% 0.31
Aug 12 19:00:00 - 19:59:59 254 5.2% 0.07971.8 KB 5.1% 0.27
Aug 12 20:00:00 - 20:59:59 217 4.4% 0.06703.4 KB 3.7% 0.20
Aug 12 21:00:00 - 21:59:59 219 4.5% 0.06731.9 KB 3.9% 0.20
Aug 12 22:00:00 - 22:59:59 203 4.1% 0.061.4 MB 7.7% 0.41
Aug 12 23:00:00 - 23:59:59 211 4.3% 0.061.3 MB 6.8% 0.36
Aug 13 00:00:00 - 00:59:59 142 2.9% 0.04562.4 KB 3.0% 0.16
Aug 13 01:00:00 - 01:59:59 109 2.2% 0.03532.4 KB 2.8% 0.15
Aug 13 02:00:00 - 02:59:59 85 1.7% 0.02343.4 KB 1.8% 0.10
Aug 13 03:00:00 - 03:00:03 10 0.2% 3.339.3 KB 0.0% 3.10
TOTAL: 23:59:59 4900 100.0% 0.0618.5 MB 100.0% 0.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1299 1142 0 0 0 0 0 0 157
2newsfeed.endofthelinebbs.com 478 43 0 0 0 0 0 0 435
3news.sklaffkom.se 45 45 0 0 0 0 0 0 0
4news.tebibyte.org 22 22 0 0 0 0 0 0 0
TOTAL: 4 1844 1252 0 0 0 0 0 0 592

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.debian.vote 58
hfx.general 51
muc.lists.freebsd.bugs 45
alt.checkmate 33
pl.misc.elektronika 30
alt.usage.english 28
uk.legal.moderated 28
de.alt.fan.pluesch 27
it-alt.sport.calcio.juventus 26
de.alt.folklore.computer 25
de.comm.software.mozilla.browser 25
de.soc.recht.misc 25
lada.talk 24
de.soc.verkehr 23
linux.debian.kernel 23
alt.atheism 22
eternal-september.support 22
muc.lists.freebsd.multimedia 22
cn.comp 20
it.cultura.filosofia 19
TOTAL: 190 1252

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 435
EMP (phn path) 96
EMP (phl) 16
User-issued cancel 15
HTML Multipart 7
Too many newsgroups (meow) 6
Too many newsgroups 1
TOTAL: 7 576

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 7090 965 3906 4 0 2 13%23:58:36
2sklaffkom.se 5354 933 1657 2284 0 4 17%23:59:52
3newsfeed.endofthelinebbs.com 8291 3 4287 2 0 85 0%23:59:56
4weretis.net 719 0 715 0 0 0 0%23:01:28
TOTAL: 4 21454 1901 10565 2290 0 91 8%94:59:52
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org2.7 MB259.8 KB3.0 MB0.0 KB/s3.2 KB23:58:36
2sklaffkom.se1.5 MB11.0 MB12.4 MB0.1 KB/s4.0 KB23:59:52
3newsfeed.endofthelinebbs.com13.0 KB7.7 KB20.7 KB0.0 KB/s4.1 KB23:59:56
4weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:01:28
TOTAL: 44.2 MB11.2 MB15.5 MB0.0 KB/s3.8 KB94:59:52
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1102.172.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:01
2193.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
3194.88.98.89 1 00.0 KB 0 0 000:00:00
436.255.97.14 1 00.0 KB 0 0 000:00:01
569.5.169.7 1 00.0 KB 0 0 000:00:00
6r4-235-eb.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
7r5-188-bc.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
8zl-laxc-us-gp1-wk126d.internet-census.org 1 00.0 KB 0 0 000:00:11
TOTAL: 8 10 00.0 KB 0 0 000:00:19

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.66.censys-scanner.com 3 00.0 KB 0 0 000:00:01
2unresolved 3 00.0 KB 0 0 000:00:02
3*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
4*.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
5*.internet-census.org 1 00.0 KB 0 0 000:00:11
TOTAL: 5 10 00.0 KB 0 0 000:00:19

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
zl-laxc-us-gp1-wk126d.internet-census.org 0.003 0.009 0.00000:00:11
r5-188-bc.monitoring.internet-measurement.com 0.002 0.012 0.00000:00:01
r4-235-eb.monitoring.internet-measurement.com 0.005 0.018 0.00000:00:01
36.255.97.14 0.002 0.018 0.00000:00:01
102.172.132.66.censys-scanner.com 0.059 0.034 0.00000:00:01
193.210.203.35.bc.googleusercontent.com 0.005 0.014 0.00000:00:00
69.5.169.7 0.001 0.010 0.00000:00:00
194.88.98.89 0.005 0.003 0.00000:00:00
TOTAL: 8 0.082 0.118 0.00000:00:19

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

SystemConn
193.210.203.35.bc.googleusercontent.com 4
36.255.97.14 3
102.172.132.66.censys-scanner.com 1
TOTAL: 3 8

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

CommandCount
#026#003#001#005?#001 1
?#024#023#001#023#002#023#003#001 1
?kK#034?&n?[?8#021#007#0115?t?i?b(A6)?K?... 1
Accept-Encoding: gzip 1
EHLO www.censys.io 1
GET / HTTP/1.1 1
Host: 172.234.115.63:119 1
User-Agent: Hello from Palo Alto Network... 1
TOTAL: 8 8

NNRP client timeouts [Top 20]:

SystemConnPeer
102.172.132.66.censys-scanner.com 1 2
194.88.98.89 1 1
TOTAL: 2 2 4
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