Daily Usenet report

Jul 28 03:00:05 -- Jul 29 03:00:05

Unknown entries from news log file:

First 50 / 62 lines (80.6%)

Jul 28 03:01:25 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Jul 28 06:13:24 twilightnode nnrpd[159786]: Reading access from /usr/local/news/etc/readers.conf
Jul 28 06:13:24 twilightnode nnrpd[159786]: Auth strategy 'localhost' does not match client. Removing.
Jul 28 06:13:24 twilightnode nnrpd[159786]: 185.216.145.166 res <anonymous>
Jul 28 06:13:24 twilightnode nnrpd[159786]: 185.216.145.166 no_match_user <anonymous> <localhost>
Jul 28 06:13:24 twilightnode nnrpd[159786]: 185.216.145.166 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 28 06:13:24 twilightnode nnrpd[159786]: 185.216.145.166 match_user <anonymous> <anonymous>
Jul 28 06:13:24 twilightnode nnrpd[159786]: 185.216.145.166 no_post anonymous-read
Jul 28 06:13:36 twilightnode nnrpd[159793]: Reading access from /usr/local/news/etc/readers.conf
Jul 28 06:13:36 twilightnode nnrpd[159793]: Auth strategy 'localhost' does not match client. Removing.
Jul 28 06:13:36 twilightnode nnrpd[159793]: 81.19.219.245 res <anonymous>
Jul 28 06:13:36 twilightnode nnrpd[159793]: 81.19.219.245 no_match_user <anonymous> <localhost>
Jul 28 06:13:36 twilightnode nnrpd[159793]: 81.19.219.245 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 28 06:13:36 twilightnode nnrpd[159793]: 81.19.219.245 match_user <anonymous> <anonymous>
Jul 28 06:13:36 twilightnode nnrpd[159793]: 81.19.219.245 no_post anonymous-read
Jul 28 08:42:28 twilightnode nnrpd[166158]: Reading access from /usr/local/news/etc/readers.conf
Jul 28 08:42:28 twilightnode nnrpd[166158]: Auth strategy 'localhost' does not match client. Removing.
Jul 28 08:42:28 twilightnode nnrpd[166158]: azpdsss4gb9l.stretchoid.com res <anonymous>
Jul 28 08:42:28 twilightnode nnrpd[166158]: azpdsss4gb9l.stretchoid.com no_match_user <anonymous> <localhost>
Jul 28 08:42:28 twilightnode nnrpd[166158]: azpdsss4gb9l.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 28 08:42:28 twilightnode nnrpd[166158]: azpdsss4gb9l.stretchoid.com match_user <anonymous> <anonymous>
Jul 28 08:42:28 twilightnode nnrpd[166158]: azpdsss4gb9l.stretchoid.com no_post anonymous-read
Jul 28 08:42:39 twilightnode nnrpd[166159]: Reading access from /usr/local/news/etc/readers.conf
Jul 28 08:42:39 twilightnode nnrpd[166159]: Auth strategy 'localhost' does not match client. Removing.
Jul 28 08:42:39 twilightnode nnrpd[166159]: azpdsss4gb9l.stretchoid.com res <anonymous>
Jul 28 08:42:39 twilightnode nnrpd[166159]: azpdsss4gb9l.stretchoid.com no_match_user <anonymous> <localhost>
Jul 28 08:42:39 twilightnode nnrpd[166159]: azpdsss4gb9l.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 28 08:42:39 twilightnode nnrpd[166159]: azpdsss4gb9l.stretchoid.com match_user <anonymous> <anonymous>
Jul 28 08:42:39 twilightnode nnrpd[166159]: azpdsss4gb9l.stretchoid.com no_post anonymous-read
Jul 28 22:06:51 twilightnode nnrpd[201658]: Reading access from /usr/local/news/etc/readers.conf
Jul 28 22:06:51 twilightnode nnrpd[201658]: Auth strategy 'localhost' does not match client. Removing.
Jul 28 22:06:51 twilightnode nnrpd[201658]: 198.235.24.137 res <anonymous>
Jul 28 22:06:51 twilightnode nnrpd[201658]: 198.235.24.137 no_match_user <anonymous> <localhost>
Jul 28 22:06:51 twilightnode nnrpd[201658]: 198.235.24.137 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 28 22:06:51 twilightnode nnrpd[201658]: 198.235.24.137 match_user <anonymous> <anonymous>
Jul 28 22:06:51 twilightnode nnrpd[201658]: 198.235.24.137 no_post anonymous-read
Jul 29 00:33:37 twilightnode nnrpd[210306]: Reading access from /usr/local/news/etc/readers.conf
Jul 29 00:33:37 twilightnode nnrpd[210306]: Auth strategy 'localhost' does not match client. Removing.
Jul 29 00:33:37 twilightnode nnrpd[210306]: 108.172.132.66.censys-scanner.com res <anonymous>
Jul 29 00:33:37 twilightnode nnrpd[210306]: 108.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Jul 29 00:33:37 twilightnode nnrpd[210306]: 108.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 29 00:33:37 twilightnode nnrpd[210306]: 108.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Jul 29 00:33:37 twilightnode nnrpd[210306]: 108.172.132.66.censys-scanner.com no_post anonymous-read
Jul 29 00:33:38 twilightnode nnrpd[210306]: 108.172.132.66.censys-scanner.com res <anonymous>
Jul 29 00:33:38 twilightnode nnrpd[210306]: 108.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Jul 29 00:33:38 twilightnode nnrpd[210306]: 108.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jul 29 00:33:38 twilightnode nnrpd[210306]: 108.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Jul 29 00:33:38 twilightnode nnrpd[210306]: 108.172.132.66.censys-scanner.com no_post anonymous-read
Jul 29 02:35:06 twilightnode nnrpd[216840]: Reading access from /usr/local/news/etc/readers.conf
Jul 29 02:35:06 twilightnode nnrpd[216840]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
inn 6418 71.6%965.0 KB 71.8%
innfeed 1230 13.7%186.1 KB 13.8%
innd 1208 13.5%182.4 KB 13.6%
nnrpd 103 1.1%10.6 KB 0.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 8960 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 14258 49.4%
Negative hits 8268 28.6%
Do not exist 6354 22.0%
Cache misses 4 0.0%
TOTAL: 4 28884 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.001 0.0%1 1.000 1.000 1.000
article cleanup00:00:00.041 0.0%6401 0.000 0.006 0.079
article logging00:00:00.211 0.0%6430 0.000 0.033 0.167
article parse00:00:00.091 0.0%8939 0.000 0.010 0.068
article write00:00:04.094 0.0%4551 0.453 0.900 3.950
data move00:00:00.060 0.0%31607 0.000 0.002 0.020
hisgrep/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.147 0.0%29082 0.071 0.143 0.403
history sync00:00:00.050 0.0%311 0.000 0.161 2.000
history write00:00:03.295 0.0%6401 0.167 0.515 1.055
idle24:00:03.352100.0%30811 1318.433 2804.302 20008.633
nntp read00:00:00.551 0.0%30575 0.000 0.018 0.295
overview write00:00:01.965 0.0%4551 0.080 0.432 1.696
perl filter00:00:07.605 0.0%6401 0.513 1.188 12.679
python filter00:00:00.485 0.0%6401 0.000 0.076 1.250
site send00:00:00.067 0.0%4546 0.000 0.015 0.111
TOTAL: 1724:00:26.015100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.011 0.0%4648 0.000 0.002 0.111
article prepare00:00:00.001 0.0%16700 0.000 0.000 0.007
article read00:00:00.486 0.0%3162 0.000 0.154 0.846
backlog stats00:00:00.037 0.0%50391 0.000 0.001 0.012
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.324 0.0%27142 0.000 0.012 0.066
data write00:00:00.579 0.0%22582 0.000 0.026 0.089
idle23:49:56.552100.0%50391 577.054 1702.617 6981.198
status file00:00:00.103 0.0%225 0.000 0.458 3.000
TOTAL: 923:49:58.093100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:16.166100.0%12 77.000 1347.167 10558.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.002 0.0%51 0.000 0.039 0.200
TOTAL: 300:00:16.168100.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 10794 3996 5461 1337 37%48:07:47
2newsfeed.endofthelinebbs.com 1 5535 557 4477 501 10%27:05:58
3news.tebibyte.org 2 5503 112 5334 57 2%23:59:55
4news.sklaffkom.se 32 71 25 1 45 35%08:05:10
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 63 21903 4690 15273 1940 21%107:18:50
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net12.5 MB0.0 KB4.1 MB16.7 MB 75%3.2 KB
2newsfeed.endofthelinebbs.com5.2 MB0.0 KB1.8 MB7.0 MB 73%6.8 KB
3news.tebibyte.org367.2 KB0.0 KB266.9 KB634.1 KB 57%3.8 KB
4news.sklaffkom.se71.6 KB0.0 KB102.6 KB174.1 KB 41%2.5 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 518.2 MB0.0 KB6.3 MB24.5 MB 74%3.8 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 28 03:00:05 - 03:59:59 125 2.8% 0.03601.4 KB 3.4% 0.17
Jul 28 04:00:00 - 04:59:59 111 2.4% 0.03507.9 KB 2.9% 0.14
Jul 28 05:00:00 - 05:59:59 89 2.0% 0.02385.8 KB 2.2% 0.11
Jul 28 06:00:00 - 06:59:59 145 3.2% 0.04471.2 KB 2.7% 0.13
Jul 28 07:00:00 - 07:59:59 143 3.1% 0.04435.5 KB 2.5% 0.12
Jul 28 08:00:00 - 08:59:59 162 3.6% 0.04509.8 KB 2.9% 0.14
Jul 28 09:00:00 - 09:59:59 194 4.3% 0.05601.1 KB 3.4% 0.17
Jul 28 10:00:00 - 10:59:59 209 4.6% 0.06766.2 KB 4.3% 0.21
Jul 28 11:00:00 - 11:59:59 252 5.6% 0.07810.6 KB 4.6% 0.23
Jul 28 12:00:00 - 12:59:59 223 4.9% 0.06760.9 KB 4.3% 0.21
Jul 28 13:00:00 - 13:59:59 220 4.8% 0.06862.5 KB 4.9% 0.24
Jul 28 14:00:00 - 14:59:59 188 4.1% 0.05842.3 KB 4.7% 0.23
Jul 28 15:00:00 - 15:59:59 308 6.8% 0.091.5 MB 8.9% 0.44
Jul 28 16:00:00 - 16:59:59 213 4.7% 0.06850.6 KB 4.8% 0.24
Jul 28 17:00:00 - 17:59:59 250 5.5% 0.071006.7 KB 5.7% 0.28
Jul 28 18:00:00 - 18:59:59 213 4.7% 0.061.1 MB 6.1% 0.30
Jul 28 19:00:00 - 19:59:59 254 5.6% 0.07921.4 KB 5.2% 0.26
Jul 28 20:00:00 - 20:59:59 221 4.9% 0.06682.8 KB 3.9% 0.19
Jul 28 21:00:00 - 21:59:59 217 4.8% 0.06866.7 KB 4.9% 0.24
Jul 28 22:00:00 - 22:59:59 204 4.5% 0.06775.3 KB 4.4% 0.22
Jul 28 23:00:00 - 23:59:59 224 4.9% 0.06995.0 KB 5.6% 0.28
Jul 29 00:00:00 - 00:59:59 167 3.7% 0.05650.0 KB 3.7% 0.18
Jul 29 01:00:00 - 01:59:59 116 2.6% 0.03492.5 KB 2.8% 0.14
Jul 29 02:00:00 - 02:59:59 83 1.8% 0.02270.4 KB 1.5% 0.08
Jul 29 03:00:00 - 03:00:05 9 0.2% 1.809.0 KB 0.1% 1.81
TOTAL: 24:00:00 4540 100.0% 0.0517.3 MB 100.0% 0.21
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1338 1227 0 0 0 0 0 0 111
2newsfeed.endofthelinebbs.com 458 64 0 0 0 0 0 0 394
3news.sklaffkom.se 46 46 0 0 0 0 0 0 0
4news.tebibyte.org 36 35 0 0 0 0 0 0 1
TOTAL: 4 1878 1372 0 0 0 0 0 0 506

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.debian.maint.ocaml.maint 169
alt.usage.english 54
de.etc.haushalt 43
eternal-september.talk 39
linux.debian.vote 38
alt.checkmate 34
de.alt.talk.unmut 32
pl.soc.prawo 31
fido7.r50.crisis 30
linux.debian.maint.hams 27
it.tlc.cellulari.android 24
pl.misc.elektronika 24
pl.soc.polityka 23
fido7.ukrnews 22
alt.home.repair 21
alt.food.fast-food 20
cn.comp 20
de.alt.fan.pluesch 20
alt.slack 19
de.soc.recht.strassenverkehr 19
TOTAL: 216 1372

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 413
User-issued cancel 39
Too many newsgroups (meow) 19
HTML Multipart 6
TOTAL: 4 477

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
1news.tebibyte.org 6420 1055 3472 5 0 14 16%23:59:56
2sklaffkom.se 4681 765 1419 2350 0 1 16%23:59:45
3newsfeed.endofthelinebbs.com 7571 20 4023 2 0 130 0%23:59:32
4weretis.net 630 1 613 0 0 0 0%22:28:56
TOTAL: 4 19302 1841 9527 2357 0 145 9%94:28:09
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org3.5 MB235.2 KB3.7 MB0.0 KB/s3.6 KB23:59:56
2sklaffkom.se1.3 MB11.0 MB12.3 MB0.1 KB/s4.1 KB23:59:45
3newsfeed.endofthelinebbs.com64.4 KB5.1 KB69.5 KB0.0 KB/s3.2 KB23:59:32
4weretis.net1.1 KB0.0 KB1.1 KB0.0 KB/s1.1 KB22:28:56
TOTAL: 44.9 MB11.3 MB16.1 MB0.0 KB/s3.9 KB94:28:09
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1azpdsss4gb9l.stretchoid.com 2 00.0 KB 0 0 000:00:10
2108.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
3185.216.145.166 1 00.0 KB 0 0 000:00:00
4193.32.209.228 1 00.0 KB 0 0 000:00:00
5198.235.24.137 1 00.0 KB 0 0 000:00:01
631.14.254.100 1 00.0 KB 0 0 000:00:00
781.19.219.245 1 00.0 KB 0 0 000:00:00
TOTAL: 7 8 00.0 KB 0 0 000:00:16

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 5 00.0 KB 0 0 000:00:02
2*.stretchoid.com 2 00.0 KB 0 0 000:00:10
3*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
TOTAL: 3 8 00.0 KB 0 0 000:00:16

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
azpdsss4gb9l.stretchoid.com 0.004 0.017 0.00000:00:10
108.172.132.66.censys-scanner.com 0.024 0.015 0.00000:00:02
198.235.24.137 0.003 0.015 0.00000:00:01
193.32.209.228 0.006 0.010 0.00000:00:00
81.19.219.245 0.004 0.004 0.00000:00:00
31.14.254.100 0.004 0.005 0.00000:00:00
185.216.145.166 0.004 0.008 0.00000:00:00
TOTAL: 7 0.049 0.074 0.00000:00:16

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

SystemConn
108.172.132.66.censys-scanner.com 1
azpdsss4gb9l.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
31.14.254.100 1 1
81.19.219.245 1 1
TOTAL: 2 2 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