Daily Usenet report

Jun 24 03:00:05 -- Jun 25 03:00:05

Unknown entries from news log file:

First 50 / 62 lines (80.6%)

Jun 24 03:01:19 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Jun 24 03:45:50 twilightnode nnrpd[2542348]: Reading access from /usr/local/news/etc/readers.conf
Jun 24 03:45:50 twilightnode nnrpd[2542348]: Auth strategy 'localhost' does not match client. Removing.
Jun 24 03:45:50 twilightnode nnrpd[2542348]: r3-34-22.monitoring.internet-measurement.com res <anonymous>
Jun 24 03:45:50 twilightnode nnrpd[2542348]: r3-34-22.monitoring.internet-measurement.com no_match_user <anonymous> <localhost>
Jun 24 03:45:50 twilightnode nnrpd[2542348]: r3-34-22.monitoring.internet-measurement.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 24 03:45:50 twilightnode nnrpd[2542348]: r3-34-22.monitoring.internet-measurement.com match_user <anonymous> <anonymous>
Jun 24 03:45:50 twilightnode nnrpd[2542348]: r3-34-22.monitoring.internet-measurement.com no_post anonymous-read
Jun 24 04:10:36 twilightnode nnrpd[2543351]: Reading access from /usr/local/news/etc/readers.conf
Jun 24 04:10:36 twilightnode nnrpd[2543351]: Auth strategy 'localhost' does not match client. Removing.
Jun 24 04:10:36 twilightnode nnrpd[2543351]: sh-chi-us-gp1-wk137d.internet-census.org res <anonymous>
Jun 24 04:10:36 twilightnode nnrpd[2543351]: sh-chi-us-gp1-wk137d.internet-census.org no_match_user <anonymous> <localhost>
Jun 24 04:10:36 twilightnode nnrpd[2543351]: sh-chi-us-gp1-wk137d.internet-census.org no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 24 04:10:36 twilightnode nnrpd[2543351]: sh-chi-us-gp1-wk137d.internet-census.org match_user <anonymous> <anonymous>
Jun 24 04:10:36 twilightnode nnrpd[2543351]: sh-chi-us-gp1-wk137d.internet-census.org no_post anonymous-read
Jun 24 07:54:15 twilightnode nnrpd[2553615]: Reading access from /usr/local/news/etc/readers.conf
Jun 24 07:54:15 twilightnode nnrpd[2553615]: Auth strategy 'localhost' does not match client. Removing.
Jun 24 07:54:15 twilightnode nnrpd[2553615]: 69.5.169.198 res <anonymous>
Jun 24 07:54:15 twilightnode nnrpd[2553615]: 69.5.169.198 no_match_user <anonymous> <localhost>
Jun 24 07:54:15 twilightnode nnrpd[2553615]: 69.5.169.198 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 24 07:54:15 twilightnode nnrpd[2553615]: 69.5.169.198 match_user <anonymous> <anonymous>
Jun 24 07:54:15 twilightnode nnrpd[2553615]: 69.5.169.198 no_post anonymous-read
Jun 24 07:54:27 twilightnode nnrpd[2553616]: Reading access from /usr/local/news/etc/readers.conf
Jun 24 07:54:27 twilightnode nnrpd[2553616]: Auth strategy 'localhost' does not match client. Removing.
Jun 24 07:54:27 twilightnode nnrpd[2553616]: 69.5.169.58 res <anonymous>
Jun 24 07:54:27 twilightnode nnrpd[2553616]: 69.5.169.58 no_match_user <anonymous> <localhost>
Jun 24 07:54:27 twilightnode nnrpd[2553616]: 69.5.169.58 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 24 07:54:27 twilightnode nnrpd[2553616]: 69.5.169.58 match_user <anonymous> <anonymous>
Jun 24 07:54:27 twilightnode nnrpd[2553616]: 69.5.169.58 no_post anonymous-read
Jun 24 10:43:30 twilightnode nnrpd[2561222]: Reading access from /usr/local/news/etc/readers.conf
Jun 24 10:43:30 twilightnode nnrpd[2561222]: Auth strategy 'localhost' does not match client. Removing.
Jun 24 10:43:30 twilightnode nnrpd[2561222]: 198.235.24.92 res <anonymous>
Jun 24 10:43:30 twilightnode nnrpd[2561222]: 198.235.24.92 no_match_user <anonymous> <localhost>
Jun 24 10:43:30 twilightnode nnrpd[2561222]: 198.235.24.92 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 24 10:43:30 twilightnode nnrpd[2561222]: 198.235.24.92 match_user <anonymous> <anonymous>
Jun 24 10:43:30 twilightnode nnrpd[2561222]: 198.235.24.92 no_post anonymous-read
Jun 24 14:36:28 twilightnode nnrpd[2571829]: Reading access from /usr/local/news/etc/readers.conf
Jun 24 14:36:28 twilightnode nnrpd[2571829]: Auth strategy 'localhost' does not match client. Removing.
Jun 24 14:36:28 twilightnode nnrpd[2571829]: 111.172.132.66.censys-scanner.com res <anonymous>
Jun 24 14:36:28 twilightnode nnrpd[2571829]: 111.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Jun 24 14:36:28 twilightnode nnrpd[2571829]: 111.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 24 14:36:28 twilightnode nnrpd[2571829]: 111.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Jun 24 14:36:28 twilightnode nnrpd[2571829]: 111.172.132.66.censys-scanner.com no_post anonymous-read
Jun 24 14:36:29 twilightnode nnrpd[2571829]: 111.172.132.66.censys-scanner.com res <anonymous>
Jun 24 14:36:29 twilightnode nnrpd[2571829]: 111.172.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Jun 24 14:36:29 twilightnode nnrpd[2571829]: 111.172.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 24 14:36:29 twilightnode nnrpd[2571829]: 111.172.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Jun 24 14:36:29 twilightnode nnrpd[2571829]: 111.172.132.66.censys-scanner.com no_post anonymous-read
Jun 24 19:15:45 twilightnode nnrpd[2584169]: Reading access from /usr/local/news/etc/readers.conf
Jun 24 19:15:45 twilightnode nnrpd[2584169]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
innfeed 41341 80.8%5.7 MB 76.6%
inn 8317 16.3%1.5 MB 19.6%
innd 1389 2.7%274.2 KB 3.6%
nnrpd 97 0.2%10.9 KB 0.1%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 51146 100.0%7.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 17434 47.5%
Negative hits 10997 30.0%
Do not exist 8275 22.5%
Cache misses 0 0.0%
TOTAL: 4 36706 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.002 0.0%1 2.000 2.000 2.000
article cleanup00:00:00.054 0.0%8297 0.000 0.007 0.087
article logging00:00:00.339 0.0%8313 0.000 0.041 0.150
article parse00:00:00.198 0.0%16718 0.000 0.012 0.095
article write00:00:04.442 0.0%4519 0.381 0.983 3.182
data move00:00:00.125 0.0%42682 0.000 0.003 0.025
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:06.142 0.0%36808 0.080 0.167 1.900
history sync00:00:00.043 0.0%405 0.000 0.106 1.000
history write00:00:05.700 0.0%8297 0.133 0.687 18.368
idle24:00:22.955 99.9%43368 318.802 1992.782 8828.015
nntp read00:00:01.098 0.0%43072 0.000 0.025 0.091
overview write00:00:02.272 0.0%4519 0.081 0.503 2.083
perl filter00:00:12.302 0.0%8259 0.808 1.490 19.042
python filter00:00:00.897 0.0%8259 0.000 0.109 1.167
site send00:00:00.104 0.0%4519 0.000 0.023 0.143
TOTAL: 1724:00:56.673100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%10082 0.000 0.002 0.074
article prepare00:00:00.006 0.0%25916 0.000 0.000 0.019
article read00:00:00.654 0.0%4495 0.000 0.145 1.077
backlog stats00:00:00.057 0.0%69052 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.552 0.0%33478 0.000 0.016 0.063
data write00:00:00.770 0.0%29036 0.000 0.027 0.065
idle23:50:07.105100.0%69052 872.523 1242.645 1700.806
status file00:00:10.224 0.0%17015 0.427 0.601 2.187
TOTAL: 923:50:19.387100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:26.492100.0%12 85.500 2207.667 10322.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:26.493100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 2 12521 4265 6515 1741 34%49:06:53
2news.tebibyte.org 1 10041 125 9521 395 1%32:36:06
3newsfeed.endofthelinebbs.com 1 6888 87 5090 1711 1%26:27:23
4news.sklaffkom.se 40 132 81 24 27 61%11:42:13
5localhost 25 0 0 0 0 0%00:00:00
6news.chimia.se 1 0 0 0 0 0%00:10:00
TOTAL: 6 70 29582 4558 21150 3874 15%120:02:35
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net12.0 MB0.0 KB5.9 MB17.9 MB 67%3.0 KB
2news.tebibyte.org595.6 KB0.0 KB2.6 MB3.2 MB 18%6.3 KB
3news.sklaffkom.se260.3 KB0.0 KB54.2 KB314.5 KB 82%2.9 KB
4newsfeed.endofthelinebbs.com229.0 KB0.0 KB28.0 MB28.3 MB 0%16.1 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: 613.0 MB0.0 KB36.6 MB49.6 MB 26%6.0 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 24 03:00:05 - 03:59:59 89 2.0% 0.02308.6 KB 2.3% 0.09
Jun 24 04:00:00 - 04:59:59 88 1.9% 0.02277.6 KB 2.1% 0.08
Jun 24 05:00:00 - 05:59:59 96 2.1% 0.03306.5 KB 2.3% 0.09
Jun 24 06:00:00 - 06:59:59 128 2.8% 0.04327.1 KB 2.5% 0.09
Jun 24 07:00:00 - 07:59:59 115 2.5% 0.03504.2 KB 3.8% 0.14
Jun 24 08:00:00 - 08:59:59 161 3.6% 0.04369.7 KB 2.8% 0.10
Jun 24 09:00:00 - 09:59:59 179 4.0% 0.05464.3 KB 3.5% 0.13
Jun 24 10:00:00 - 10:59:59 209 4.6% 0.06518.7 KB 3.9% 0.14
Jun 24 11:00:00 - 11:59:59 279 6.2% 0.08821.4 KB 6.2% 0.23
Jun 24 12:00:00 - 12:59:59 244 5.4% 0.07607.7 KB 4.6% 0.17
Jun 24 13:00:00 - 13:59:59 221 4.9% 0.06587.4 KB 4.5% 0.16
Jun 24 14:00:00 - 14:59:59 222 4.9% 0.06638.1 KB 4.8% 0.18
Jun 24 15:00:00 - 15:59:59 234 5.2% 0.07690.1 KB 5.2% 0.19
Jun 24 16:00:00 - 16:59:59 255 5.6% 0.07822.4 KB 6.2% 0.23
Jun 24 17:00:00 - 17:59:59 239 5.3% 0.07640.8 KB 4.9% 0.18
Jun 24 18:00:00 - 18:59:59 244 5.4% 0.07590.0 KB 4.5% 0.16
Jun 24 19:00:00 - 19:59:59 216 4.8% 0.06584.3 KB 4.4% 0.16
Jun 24 20:00:00 - 20:59:59 254 5.6% 0.07813.1 KB 6.2% 0.23
Jun 24 21:00:00 - 21:59:59 188 4.2% 0.05511.1 KB 3.9% 0.14
Jun 24 22:00:00 - 22:59:59 244 5.4% 0.07829.5 KB 6.3% 0.23
Jun 24 23:00:00 - 23:59:59 225 5.0% 0.06781.3 KB 5.9% 0.22
Jun 25 00:00:00 - 00:59:59 174 3.9% 0.05595.9 KB 4.5% 0.17
Jun 25 01:00:00 - 01:59:59 98 2.2% 0.03271.3 KB 2.1% 0.08
Jun 25 02:00:00 - 02:59:59 107 2.4% 0.03314.3 KB 2.4% 0.09
Jun 25 03:00:00 - 03:00:05 9 0.2% 1.807.3 KB 0.1% 1.45
TOTAL: 24:00:00 4518 100.0% 0.0512.9 MB 100.0% 0.15
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1693 1433 0 0 0 0 0 0 260
2newsfeed.endofthelinebbs.com 1648 1248 0 0 0 38 0 0 362
3news.tebibyte.org 431 420 0 0 0 0 0 0 11
4news.sklaffkom.se 27 27 0 0 0 0 0 0 0
TOTAL: 4 3799 3128 0 0 0 38 0 0 633

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.sex.nudism 469
linux.kernel.netdev 211
alt.sex.young-woman.foroldermen 209
alt.sex.nudels.me.too 180
uk.d-i-y 97
linux.kernel.git 73
it.discussioni.misteri 55
fido7.ru.military 45
nl.politiek 44
de.rec.fahrrad 39
it.sport.calcio.milan 37
alt.sex.fetish.news-serverss 34
de.etc.bahn.misc 34
it.sport.calcio.inter-fc 33
pl.soc.prawo 32
uk.legal.moderated 31
alt.usage.english 30
alt.clothing.lingerie 27
fido7.ru.home 23
alt.prophecies.nostradamus 22
TOTAL: 334 3128

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 352
EMP (phl) 126
EMP (phn path) 94
User-issued cancel 33
Too many newsgroups 5
Too many newsgroups (meow) 3
HTML Multipart 2
HTML post 2
TOTAL: 8 617

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
1chimia.se 4520 4448 18 52 0 0 98%23:59:26
2sklaffkom.se 4888 722 2508 1283 0 1 14%23:59:55
3news.tebibyte.org 2839 0 0 0 0 7352 0%23:59:54
4newsfeed.endofthelinebbs.com 2782 0 0 0 0 7217 0%23:59:54
5weretis.net 322 0 273 0 0 0 0%18:25:36
6sklaff.dev 0 0 0 0 0 4513 0%23:57:02
7thebunker.nu 0 0 0 0 0 4518 0%23:59:55
8usenet.blueworldhosting.com 0 0 0 0 0 4199 0%23:59:55
TOTAL: 8 15351 5170 2799 1335 0 27800 33%186:21:37
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1chimia.se12.6 MB239.4 KB12.8 MB0.2 KB/s2.9 KB23:59:26
2sklaffkom.se1.1 MB4.2 MB5.3 MB0.1 KB/s2.7 KB23:59:55
3news.tebibyte.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
4newsfeed.endofthelinebbs.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
5sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:02
6thebunker.nu0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
7usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
8weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s018:25:36
TOTAL: 813.7 MB4.4 MB18.1 MB0.0 KB/s2.9 KB186:21:37
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1azpdwsxs9gxv.stretchoid.com 2 00.0 KB 0 0 000:00:10
2111.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
3198.235.24.92 1 00.0 KB 0 0 000:00:00
469.5.169.198 1 00.0 KB 0 0 000:00:00
569.5.169.58 1 00.0 KB 0 0 000:00:00
6r3-34-22.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
7sh-chi-us-gp1-wk137d.internet-census.org 1 00.0 KB 0 0 000:00:10
TOTAL: 7 8 00.0 KB 0 0 000:00:26

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 3 00.0 KB 0 0 000:00:00
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
4*.internet-census.org 1 00.0 KB 0 0 000:00:10
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 5 8 00.0 KB 0 0 000:00:26

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
sh-chi-us-gp1-wk137d.internet-census.org 0.005 0.019 0.00000:00:10
azpdwsxs9gxv.stretchoid.com 0.009 0.045 0.00000:00:10
111.172.132.66.censys-scanner.com 0.030 0.018 0.00000:00:02
r3-34-22.monitoring.internet-measurement.com 0.007 0.010 0.00000:00:01
198.235.24.92 0.004 0.009 0.00000:00:00
69.5.169.58 0.005 0.006 0.00000:00:00
69.5.169.198 0.006 0.021 0.00000:00:00
TOTAL: 7 0.066 0.128 0.00000:00:26

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

SystemConn
111.172.132.66.censys-scanner.com 1
azpdwsxs9gxv.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
69.5.169.58 1 1
TOTAL: 1 1 3