Daily Usenet report

Jun 30 03:00:06 -- Jul 1 03:00:06

Unknown entries from news log file:

First 50 / 90 lines (55.6%)

Jun 30 03:01:23 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Jun 30 05:26:40 twilightnode nnrpd[2945985]: Reading access from /usr/local/news/etc/readers.conf
Jun 30 05:26:40 twilightnode nnrpd[2945985]: Auth strategy 'localhost' does not match client. Removing.
Jun 30 05:26:40 twilightnode nnrpd[2945985]: r5-27-1b.monitoring.internet-measurement.com res <anonymous>
Jun 30 05:26:40 twilightnode nnrpd[2945985]: r5-27-1b.monitoring.internet-measurement.com no_match_user <anonymous> <localhost>
Jun 30 05:26:40 twilightnode nnrpd[2945985]: r5-27-1b.monitoring.internet-measurement.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 30 05:26:40 twilightnode nnrpd[2945985]: r5-27-1b.monitoring.internet-measurement.com match_user <anonymous> <anonymous>
Jun 30 05:26:40 twilightnode nnrpd[2945985]: r5-27-1b.monitoring.internet-measurement.com no_post anonymous-read
Jun 30 07:38:16 twilightnode nnrpd[2952136]: Reading access from /usr/local/news/etc/readers.conf
Jun 30 07:38:16 twilightnode nnrpd[2952136]: Auth strategy 'localhost' does not match client. Removing.
Jun 30 07:38:16 twilightnode nnrpd[2952136]: 69.5.169.214 res <anonymous>
Jun 30 07:38:16 twilightnode nnrpd[2952136]: 69.5.169.214 no_match_user <anonymous> <localhost>
Jun 30 07:38:16 twilightnode nnrpd[2952136]: 69.5.169.214 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 30 07:38:16 twilightnode nnrpd[2952136]: 69.5.169.214 match_user <anonymous> <anonymous>
Jun 30 07:38:16 twilightnode nnrpd[2952136]: 69.5.169.214 no_post anonymous-read
Jun 30 07:38:25 twilightnode nnrpd[2952137]: Reading access from /usr/local/news/etc/readers.conf
Jun 30 07:38:25 twilightnode nnrpd[2952137]: Auth strategy 'localhost' does not match client. Removing.
Jun 30 07:38:25 twilightnode nnrpd[2952137]: 69.5.169.3 res <anonymous>
Jun 30 07:38:25 twilightnode nnrpd[2952137]: 69.5.169.3 no_match_user <anonymous> <localhost>
Jun 30 07:38:25 twilightnode nnrpd[2952137]: 69.5.169.3 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 30 07:38:25 twilightnode nnrpd[2952137]: 69.5.169.3 match_user <anonymous> <anonymous>
Jun 30 07:38:25 twilightnode nnrpd[2952137]: 69.5.169.3 no_post anonymous-read
Jun 30 07:38:39 twilightnode nnrpd[2952138]: Reading access from /usr/local/news/etc/readers.conf
Jun 30 07:38:39 twilightnode nnrpd[2952138]: Auth strategy 'localhost' does not match client. Removing.
Jun 30 07:38:39 twilightnode nnrpd[2952138]: 173.186.132.66.censys-scanner.com res <anonymous>
Jun 30 07:38:39 twilightnode nnrpd[2952138]: 173.186.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Jun 30 07:38:39 twilightnode nnrpd[2952138]: 173.186.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 30 07:38:39 twilightnode nnrpd[2952138]: 173.186.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Jun 30 07:38:39 twilightnode nnrpd[2952138]: 173.186.132.66.censys-scanner.com no_post anonymous-read
Jun 30 07:38:44 twilightnode nnrpd[2952139]: Reading access from /usr/local/news/etc/readers.conf
Jun 30 07:38:44 twilightnode nnrpd[2952139]: Auth strategy 'localhost' does not match client. Removing.
Jun 30 07:38:44 twilightnode nnrpd[2952139]: 173.186.132.66.censys-scanner.com res <anonymous>
Jun 30 07:38:44 twilightnode nnrpd[2952139]: 173.186.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Jun 30 07:38:44 twilightnode nnrpd[2952139]: 173.186.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 30 07:38:44 twilightnode nnrpd[2952139]: 173.186.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Jun 30 07:38:44 twilightnode nnrpd[2952139]: 173.186.132.66.censys-scanner.com no_post anonymous-read
Jun 30 07:38:51 twilightnode nnrpd[2952140]: Reading access from /usr/local/news/etc/readers.conf
Jun 30 07:38:51 twilightnode nnrpd[2952140]: Auth strategy 'localhost' does not match client. Removing.
Jun 30 07:38:51 twilightnode nnrpd[2952140]: 173.186.132.66.censys-scanner.com res <anonymous>
Jun 30 07:38:51 twilightnode nnrpd[2952140]: 173.186.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Jun 30 07:38:51 twilightnode nnrpd[2952140]: 173.186.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 30 07:38:51 twilightnode nnrpd[2952140]: 173.186.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Jun 30 07:38:51 twilightnode nnrpd[2952140]: 173.186.132.66.censys-scanner.com no_post anonymous-read
Jun 30 07:38:51 twilightnode nnrpd[2952140]: 173.186.132.66.censys-scanner.com res <anonymous>
Jun 30 07:38:51 twilightnode nnrpd[2952140]: 173.186.132.66.censys-scanner.com no_match_user <anonymous> <localhost>
Jun 30 07:38:51 twilightnode nnrpd[2952140]: 173.186.132.66.censys-scanner.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Jun 30 07:38:51 twilightnode nnrpd[2952140]: 173.186.132.66.censys-scanner.com match_user <anonymous> <anonymous>
Jun 30 07:38:51 twilightnode nnrpd[2952140]: 173.186.132.66.censys-scanner.com no_post anonymous-read
Jun 30 14:31:44 twilightnode nnrpd[2969894]: Reading access from /usr/local/news/etc/readers.conf
Jun 30 14:31:44 twilightnode nnrpd[2969894]: Auth strategy 'localhost' does not match client. Removing.

Log entries by program:

Program nameLines%LinesSize%Size
innfeed 41123 82.8%5.6 MB 77.9%
inn 6956 14.0%1.3 MB 17.9%
innd 1449 2.9%293.1 KB 4.0%
nnrpd 146 0.3%16.5 KB 0.2%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 49676 100.0%7.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 16025 49.5%
Negative hits 9450 29.2%
Do not exist 6917 21.4%
Cache misses 2 0.0%
TOTAL: 4 32394 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.007 0.0%5 0.000 1.400 2.000
article cleanup00:00:00.089 0.0%6936 0.000 0.013 0.083
article logging00:00:00.281 0.0%6957 0.000 0.040 0.243
article parse00:00:00.132 0.0%10076 0.000 0.013 0.071
article write00:00:04.399 0.0%4830 0.400 0.911 1.731
data move00:00:00.118 0.0%35779 0.000 0.003 0.037
hisgrep/artcncl00:00:00.004 0.0%5 0.000 0.800 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.812 0.0%32468 0.082 0.148 0.309
history sync00:00:00.059 0.0%411 0.000 0.144 1.000
history write00:00:03.763 0.0%6936 0.214 0.543 1.217
idle24:00:29.325100.0%34953 1070.907 2472.730 9849.098
nntp read00:00:00.790 0.0%34621 0.000 0.023 0.118
overview write00:00:02.400 0.0%4830 0.133 0.497 1.769
perl filter00:00:10.903 0.0%6936 0.896 1.572 4.520
python filter00:00:00.910 0.0%6936 0.000 0.131 0.435
site send00:00:00.102 0.0%4830 0.000 0.021 0.111
TOTAL: 1724:00:58.094100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%10370 0.000 0.002 0.130
article prepare00:00:00.004 0.0%29008 0.000 0.000 0.005
article read00:00:00.753 0.0%4804 0.000 0.157 0.458
backlog stats00:00:00.056 0.0%71580 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.538 0.0%35307 0.000 0.015 0.077
data write00:00:00.891 0.0%30566 0.006 0.029 0.105
idle23:49:48.427100.0%71580 843.990 1198.497 1601.838
status file00:00:09.652 0.0%16887 0.435 0.572 0.917
TOTAL: 923:50:00.345100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:25.938100.0%17 62.500 1525.765 10368.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%136 0.000 0.007 0.200
TOTAL: 300:00:25.939100.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 4 10890 4171 5439 1280 38%48:02:43
2newsfeed.endofthelinebbs.com 3 5147 538 3927 682 10%22:48:12
3news.sklaffkom.se 39 86 57 22 7 66%09:35:18
4news.tebibyte.org 2 1125 10 917 198 0%07:09:16
5localhost 25 0 0 0 0 0%00:00:00
6news.chimia.se 1 0 0 0 0 0%00:10:00
TOTAL: 6 74 17248 4776 10305 2167 27%87:45:29
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net13.6 MB0.0 KB3.9 MB17.5 MB 77%3.3 KB
2newsfeed.endofthelinebbs.com5.8 MB0.0 KB3.7 MB9.5 MB 61%8.0 KB
3news.sklaffkom.se270.8 KB0.0 KB22.1 KB293.0 KB 92%4.6 KB
4news.tebibyte.org62.2 KB0.0 KB998.1 KB1.0 MB 5%5.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: 619.7 MB0.0 KB8.6 MB28.3 MB 69%4.2 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 30 03:00:06 - 03:59:59 89 1.8% 0.02710.9 KB 3.6% 0.20
Jun 30 04:00:00 - 04:59:59 118 2.4% 0.03500.3 KB 2.5% 0.14
Jun 30 05:00:00 - 05:59:59 107 2.2% 0.03721.9 KB 3.6% 0.20
Jun 30 06:00:00 - 06:59:59 146 3.0% 0.04866.7 KB 4.3% 0.24
Jun 30 07:00:00 - 07:59:59 178 3.7% 0.051.2 MB 5.9% 0.33
Jun 30 08:00:00 - 08:59:59 210 4.3% 0.06948.8 KB 4.8% 0.26
Jun 30 09:00:00 - 09:59:59 229 4.7% 0.061.2 MB 6.2% 0.34
Jun 30 10:00:00 - 10:59:59 228 4.7% 0.06704.4 KB 3.5% 0.20
Jun 30 11:00:00 - 11:59:59 240 5.0% 0.07689.7 KB 3.5% 0.19
Jun 30 12:00:00 - 12:59:59 226 4.7% 0.06629.1 KB 3.2% 0.17
Jun 30 13:00:00 - 13:59:59 224 4.6% 0.06958.6 KB 4.8% 0.27
Jun 30 14:00:00 - 14:59:59 207 4.3% 0.06851.1 KB 4.3% 0.24
Jun 30 15:00:00 - 15:59:59 261 5.4% 0.07859.1 KB 4.3% 0.24
Jun 30 16:00:00 - 16:59:59 298 6.2% 0.081.5 MB 7.7% 0.42
Jun 30 17:00:00 - 17:59:59 290 6.0% 0.081.0 MB 5.3% 0.29
Jun 30 18:00:00 - 18:59:59 257 5.3% 0.07734.5 KB 3.7% 0.20
Jun 30 19:00:00 - 19:59:59 230 4.8% 0.06609.3 KB 3.1% 0.17
Jun 30 20:00:00 - 20:59:59 293 6.1% 0.081.1 MB 5.5% 0.31
Jun 30 21:00:00 - 21:59:59 185 3.8% 0.05952.6 KB 4.8% 0.26
Jun 30 22:00:00 - 22:59:59 185 3.8% 0.05702.9 KB 3.5% 0.20
Jun 30 23:00:00 - 23:59:59 182 3.8% 0.05729.5 KB 3.7% 0.20
Jul 1 00:00:00 - 00:59:59 178 3.7% 0.05652.2 KB 3.3% 0.18
Jul 1 01:00:00 - 01:59:59 140 2.9% 0.04608.5 KB 3.1% 0.17
Jul 1 02:00:00 - 02:59:59 118 2.4% 0.03379.6 KB 1.9% 0.11
Jul 1 03:00:00 - 03:00:06 10 0.2% 1.6721.8 KB 0.1% 3.64
TOTAL: 24:00:00 4829 100.0% 0.0619.5 MB 100.0% 0.23
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1twilightnode-out.news.weretis.net 1305 1219 0 0 0 0 0 0 86
2newsfeed.endofthelinebbs.com 719 118 0 0 0 0 0 0 601
3news.tebibyte.org 96 93 0 0 0 0 0 0 3
4news.sklaffkom.se 7 7 0 0 0 0 0 0 0
TOTAL: 4 2127 1437 0 0 0 0 0 0 690

Unwanted newsgroups [Top 20]:

NewsgroupCount
fido7.ru.home 64
uk.net.news.moderation 62
alt.sex.pre-amateurs 49
it.hobby.cucina 41
de.alt.talk.unmut 39
alt.usage.english 38
de.alt.fan.pluesch 33
linux.debian.maint.ocaml.maint 30
uk.tech.broadcast 28
alt.sex.amateur.fa 27
it-alt.sport.calcio.juventus 25
linux.debian.changes 24
pl.soc.prawo 23
alt.checkmate 21
cn.comp 20
muc.lists.freebsd.bugs 19
de.alt.folklore.computer 18
de.talk.jokes 18
bln.test 17
de.test 17
TOTAL: 259 1437

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 605
User-issued cancel 59
Too many newsgroups 5
TOTAL: 3 669

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1chimia.se 4830 4776 0 53 0 0 98%23:59:44
2sklaffkom.se 5185 844 2365 1609 0 3 16%23:59:37
3news.tebibyte.org 2838 0 0 0 0 7658 0%23:59:55
4newsfeed.endofthelinebbs.com 2765 0 0 0 0 6988 0%23:59:55
5weretis.net 736 0 707 0 0 0 0%23:12:12
6sklaff.dev 0 0 0 0 0 4820 0%23:59:28
7thebunker.nu 0 0 0 0 0 4829 0%23:59:55
8usenet.blueworldhosting.com 0 0 0 0 0 4531 0%23:59:55
TOTAL: 8 16354 5620 3072 1662 0 28829 34%191:10:41
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1chimia.se19.4 MB115.7 KB19.5 MB0.2 KB/s4.1 KB23:59:44
2sklaffkom.se1.3 MB10.5 MB11.8 MB0.1 KB/s4.9 KB23:59:37
3news.tebibyte.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
4newsfeed.endofthelinebbs.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
5sklaff.dev0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:28
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/s023:12:12
TOTAL: 820.7 MB10.6 MB31.3 MB0.0 KB/s4.4 KB191:10:41
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
164.195.132.66.censys-scanner.com 4 00.0 KB 0 0 000:00:08
2173.186.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:04
3azpdese8sd9i.stretchoid.com 2 00.0 KB 0 0 000:00:10
469.5.169.214 1 00.0 KB 0 0 000:00:00
569.5.169.3 1 00.0 KB 0 0 000:00:00
6r5-27-1b.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 6 12 00.0 KB 0 0 000:00:25

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

SystemConnArtsSizeGroupsPostRejElapsed
1*.66.censys-scanner.com 7 00.0 KB 0 0 000:00:13
2*.stretchoid.com 2 00.0 KB 0 0 000:00:10
3unresolved 2 00.0 KB 0 0 000:00:00
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 4 12 00.0 KB 0 0 000:00:25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
azpdese8sd9i.stretchoid.com 0.008 0.022 0.00000:00:10
64.195.132.66.censys-scanner.com 0.011 0.066 0.00000:00:08
173.186.132.66.censys-scanner.com 0.032 0.024 0.00000:00:04
r5-27-1b.monitoring.internet-measurement.com 0.004 0.014 0.00000:00:01
69.5.169.3 0.004 0.006 0.00000:00:00
69.5.169.214 0.002 0.020 0.00000:00:00
TOTAL: 6 0.061 0.152 0.00000:00:25

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

SystemConn
173.186.132.66.censys-scanner.com 1
azpdese8sd9i.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
173.186.132.66.censys-scanner.com 1 2
64.195.132.66.censys-scanner.com 1 4
69.5.169.3 1 1
TOTAL: 3 3 8
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