Daily Usenet report

Oct 17 03:00:05 -- Oct 18 03:00:05

Unknown entries from news log file:

First 50 / 1931 lines (2.6%)

Oct 17 03:01:35 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Oct 17 03:04:20 twilightnode nnrpd[198926]: Reading access from /usr/local/news/etc/readers.conf
Oct 17 03:04:20 twilightnode nnrpd[198926]: Auth strategy 'localhost' does not match client. Removing.
Oct 17 03:04:20 twilightnode nnrpd[198926]: 174.96.78.81 res <anonymous>
Oct 17 03:04:20 twilightnode nnrpd[198926]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 17 03:04:20 twilightnode nnrpd[198926]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 17 03:04:20 twilightnode nnrpd[198926]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 17 03:04:20 twilightnode nnrpd[198926]: 174.96.78.81 no_post anonymous-read
Oct 17 03:04:20 twilightnode nnrpd[198927]: Reading access from /usr/local/news/etc/readers.conf
Oct 17 03:04:20 twilightnode nnrpd[198927]: Auth strategy 'localhost' does not match client. Removing.
Oct 17 03:04:20 twilightnode nnrpd[198927]: 174.96.78.81 res <anonymous>
Oct 17 03:04:20 twilightnode nnrpd[198927]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 17 03:04:20 twilightnode nnrpd[198927]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 17 03:04:20 twilightnode nnrpd[198927]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 17 03:04:20 twilightnode nnrpd[198927]: 174.96.78.81 no_post anonymous-read
Oct 17 03:07:42 twilightnode nnrpd[199095]: Reading access from /usr/local/news/etc/readers.conf
Oct 17 03:07:42 twilightnode nnrpd[199095]: Auth strategy 'localhost' does not match client. Removing.
Oct 17 03:07:42 twilightnode nnrpd[199095]: 174.96.78.81 res <anonymous>
Oct 17 03:07:42 twilightnode nnrpd[199095]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 17 03:07:42 twilightnode nnrpd[199095]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 17 03:07:42 twilightnode nnrpd[199095]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 17 03:07:42 twilightnode nnrpd[199095]: 174.96.78.81 no_post anonymous-read
Oct 17 03:07:43 twilightnode nnrpd[199096]: Reading access from /usr/local/news/etc/readers.conf
Oct 17 03:07:43 twilightnode nnrpd[199096]: Auth strategy 'localhost' does not match client. Removing.
Oct 17 03:07:43 twilightnode nnrpd[199096]: 174.96.78.81 res <anonymous>
Oct 17 03:07:43 twilightnode nnrpd[199096]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 17 03:07:43 twilightnode nnrpd[199096]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 17 03:07:43 twilightnode nnrpd[199096]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 17 03:07:43 twilightnode nnrpd[199096]: 174.96.78.81 no_post anonymous-read
Oct 17 03:14:37 twilightnode nnrpd[199460]: Reading access from /usr/local/news/etc/readers.conf
Oct 17 03:14:37 twilightnode nnrpd[199460]: Auth strategy 'localhost' does not match client. Removing.
Oct 17 03:14:37 twilightnode nnrpd[199460]: 174.96.78.81 res <anonymous>
Oct 17 03:14:37 twilightnode nnrpd[199460]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 17 03:14:37 twilightnode nnrpd[199460]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 17 03:14:37 twilightnode nnrpd[199460]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 17 03:14:37 twilightnode nnrpd[199460]: 174.96.78.81 no_post anonymous-read
Oct 17 03:14:38 twilightnode nnrpd[199461]: Reading access from /usr/local/news/etc/readers.conf
Oct 17 03:14:38 twilightnode nnrpd[199461]: Auth strategy 'localhost' does not match client. Removing.
Oct 17 03:14:38 twilightnode nnrpd[199461]: 174.96.78.81 res <anonymous>
Oct 17 03:14:38 twilightnode nnrpd[199461]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 17 03:14:38 twilightnode nnrpd[199461]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 17 03:14:38 twilightnode nnrpd[199461]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 17 03:14:38 twilightnode nnrpd[199461]: 174.96.78.81 no_post anonymous-read
Oct 17 03:49:04 twilightnode nnrpd[201032]: Reading access from /usr/local/news/etc/readers.conf
Oct 17 03:49:04 twilightnode nnrpd[201032]: Auth strategy 'localhost' does not match client. Removing.
Oct 17 03:49:04 twilightnode nnrpd[201032]: 174.96.78.81 res <anonymous>
Oct 17 03:49:04 twilightnode nnrpd[201032]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 17 03:49:04 twilightnode nnrpd[201032]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 17 03:49:04 twilightnode nnrpd[201032]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 17 03:49:04 twilightnode nnrpd[201032]: 174.96.78.81 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 11877 48.2%1.0 MB 32.8%
inn 8498 34.5%1.5 MB 47.8%
innd 3024 12.3%415.4 KB 13.0%
innfeed 1249 5.1%204.7 KB 6.4%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 24649 100.0%3.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 21780 51.1%
Negative hits 12400 29.1%
Do not exist 8408 19.7%
Cache misses 4 0.0%
TOTAL: 4 42592 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.019 0.0%9 1.500 2.111 3.000
article cleanup00:00:00.163 0.0%8474 0.000 0.019 0.104
article logging00:00:00.480 0.0%8496 0.000 0.056 0.600
article parse00:00:00.244 0.0%14438 0.000 0.017 0.092
article write00:00:09.411 0.0%7134 0.500 1.319 2.429
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.294 0.0%48877 0.000 0.006 0.044
hisgrep/artcncl00:00:00.006 0.0%9 0.000 0.667 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.921 0.0%42676 0.084 0.162 0.516
history sync00:00:00.089 0.0%336 0.000 0.265 2.000
history write00:00:04.850 0.0%8423 0.246 0.576 1.394
idle23:59:25.111 99.9%48175 157.154 1792.737 7314.561
nntp read00:00:01.421 0.0%47131 0.000 0.030 0.063
overview write00:00:06.443 0.0%7134 0.214 0.903 2.500
perl filter00:00:21.054 0.0%8423 1.063 2.500 9.303
python filter00:00:01.935 0.0%8423 0.097 0.230 0.879
site send00:00:00.602 0.0%14200 0.000 0.042 0.158
TOTAL: 1824:00:19.043100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.059 0.0%7309 0.000 0.008 0.059
article prepare00:00:00.004 0.0%28184 0.000 0.000 0.006
article read00:00:01.640 0.0%4585 0.111 0.358 1.500
backlog stats00:00:00.089 0.0%91542 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.001 0.0%52144 0.000 0.019 0.042
data write00:00:01.475 0.0%45135 0.007 0.033 0.104
idle23:49:54.312100.0%91542 359.255 937.213 2707.786
status file00:00:00.186 0.0%158 0.000 1.177 6.000
TOTAL: 923:49:58.766100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:38:40.450 99.9%12283 44.500 188.916 9834.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.682 0.0%32264 0.000 0.021 0.500
readart00:00:00.788 0.0%1449 0.000 0.544 1.000
TOTAL: 400:38:41.920100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 6 13741 4921 8770 50 35%50:44:39
2usenet.blueworldhosting.com 288 8085 1827 5012 1246 22%23:44:26
3newsfeed.endofthelinebbs.com 3 3054 343 2669 42 11%14:41:36
4news.sklaffkom.se 45 100 67 33 0 67%11:14:38
5news.tebibyte.org 2 4518 22 4496 0 0%23:59:16
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 369 29498 7180 20980 1338 24%124:24:35
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.endofthelinebbs.com19.3 MB77.7 KB65.8 KB19.5 MB 99%51.7 KB
2twilightnode-out.news.weretis.net15.7 MB5.7 KB154.4 KB15.9 MB 99%3.3 KB
3usenet.blueworldhosting.com6.5 MB142.7 KB2.2 MB8.8 MB 73%2.9 KB
4news.tebibyte.org295.4 KB0.0 KB0.0 KB295.4 KB100%13.4 KB
5news.sklaffkom.se233.4 KB0.0 KB0.0 KB233.4 KB100%3.5 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 642.1 MB226.0 KB2.4 MB44.7 MB 94%5.4 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 17 03:00:05 - 03:59:59 192 2.7% 0.051.2 MB 2.8% 0.34
Oct 17 04:00:00 - 04:59:59 380 5.3% 0.1118.7 MB 44.0% 5.32
Oct 17 05:00:00 - 05:59:59 160 2.2% 0.04723.9 KB 1.7% 0.20
Oct 17 06:00:00 - 06:59:59 164 2.3% 0.05372.1 KB 0.9% 0.10
Oct 17 07:00:00 - 07:59:59 229 3.2% 0.06808.7 KB 1.9% 0.22
Oct 17 08:00:00 - 08:59:59 239 3.3% 0.07573.5 KB 1.3% 0.16
Oct 17 09:00:00 - 09:59:59 262 3.7% 0.07708.5 KB 1.6% 0.20
Oct 17 10:00:00 - 10:59:59 293 4.1% 0.081.2 MB 2.8% 0.34
Oct 17 11:00:00 - 11:59:59 406 5.7% 0.111.1 MB 2.6% 0.31
Oct 17 12:00:00 - 12:59:59 332 4.7% 0.091.3 MB 3.0% 0.37
Oct 17 13:00:00 - 13:59:59 370 5.2% 0.101.0 MB 2.4% 0.29
Oct 17 14:00:00 - 14:59:59 365 5.1% 0.101.2 MB 2.8% 0.34
Oct 17 15:00:00 - 15:59:59 354 5.0% 0.10970.6 KB 2.2% 0.27
Oct 17 16:00:00 - 16:59:59 332 4.7% 0.091.3 MB 3.1% 0.38
Oct 17 17:00:00 - 17:59:59 309 4.3% 0.09883.3 KB 2.0% 0.25
Oct 17 18:00:00 - 18:59:59 325 4.6% 0.091.2 MB 2.7% 0.33
Oct 17 19:00:00 - 19:59:59 362 5.1% 0.101.7 MB 4.0% 0.49
Oct 17 20:00:00 - 20:59:59 362 5.1% 0.101.1 MB 2.6% 0.32
Oct 17 21:00:00 - 21:59:59 346 4.8% 0.101.2 MB 2.7% 0.33
Oct 17 22:00:00 - 22:59:59 319 4.5% 0.09970.0 KB 2.2% 0.27
Oct 17 23:00:00 - 23:59:59 285 4.0% 0.081.2 MB 2.8% 0.34
Oct 18 00:00:00 - 00:59:59 292 4.1% 0.081.5 MB 3.6% 0.43
Oct 18 01:00:00 - 01:59:59 241 3.4% 0.07921.6 KB 2.1% 0.26
Oct 18 02:00:00 - 02:59:59 207 2.9% 0.06906.9 KB 2.1% 0.25
Oct 18 03:00:00 - 03:00:05 10 0.1% 2.0011.2 KB 0.0% 2.24
TOTAL: 24:00:00 7136 100.0% 0.0842.5 MB 100.0% 0.50
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1246 325 0 24 0 0 0 0 897
2twilightnode-out.news.weretis.net 65 6 0 2 0 0 0 0 57
3newsfeed.endofthelinebbs.com 50 2 0 25 0 0 0 0 23
4news.tebibyte.org 1 0 0 0 0 0 0 0 1
TOTAL: 4 1362 333 0 51 0 0 0 0 978

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 20
hispagatos.mastodon.tag.hacking 9
grenzland.club 2
pl.listserv.chomor-l 2
alt.autos.rolls-royce-bentley 1
alt.bbs.files-announce 1
alt.fan.usertwo 1
alt.pl.zbluzgaj 1
biz.mlm 1
brasil.ciencia.fisica 1
chmurka.statystyki 1
fido.english_tutor 1
fido.su.pol 1
hispagatos.test 1
undernet.general 1
za.test 1
TOTAL: 17 333

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 816
Too many newsgroups 133
User-issued cancel 5
HTML Multipart 2
TOTAL: 4 956

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 9944 2535 4462 69 0 31 25%23:59:56
2sklaffkom.se 7513 911 2671 3483 0 3 12%23:59:26
3newsfeed.endofthelinebbs.com 11875 47 6643 15 0 250 0%23:59:53
4usenet.blueworldhosting.com 8007 6 4902 0 0 11 0%23:59:56
5weretis.net 2296 6 2269 1 0 1 0%23:59:56
TOTAL: 5 39635 3505 20947 3568 0 296 8%119:59:07
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org6.5 MB1.5 MB8.0 MB0.1 KB/s3.1 KB23:59:56
2sklaffkom.se1.4 MB31.8 MB33.2 MB0.4 KB/s7.7 KB23:59:26
3newsfeed.endofthelinebbs.com153.3 KB50.9 KB204.2 KB0.0 KB/s3.3 KB23:59:53
4usenet.blueworldhosting.com20.1 KB0.0 KB20.1 KB0.0 KB/s3.3 KB23:59:56
5weretis.net13.4 KB1.5 KB14.9 KB0.0 KB/s2.1 KB23:59:56
TOTAL: 58.1 MB33.3 MB41.4 MB0.1 KB/s6.0 KB119:59:07
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1174.96.78.81 264 144938.8 MB 167 0 000:38:23
TOTAL: 1 264 144938.8 MB 167 0 000:38:23

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 265 144938.8 MB 167 0 000:38:33
2*.167.censys-scanner.com 3 00.0 KB 0 0 000:00:01
3*.infrawat.ch 2 00.0 KB 0 0 000:00:00
4*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
5*.scan.bufferover.run 2 00.0 KB 0 0 000:00:00
6*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 6 275 144938.8 MB 167 0 000:38:41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
174.96.78.81 2.945 9.048 0.00000:38:23
20.15.166.132 0.007 0.019 0.00000:00:09
hansen.probe.onyphe.net 0.005 0.007 0.00000:00:03
r4-156-9c.monitoring.internet-measurement.com 0.005 0.020 0.00000:00:01
50.146.94.167.censys-scanner.com 0.035 0.043 0.00000:00:01
venice.scan.bufferover.run 0.008 0.023 0.00000:00:00
brady.probe.onyphe.net 0.005 0.010 0.00000:00:00
185-216-145-181.infrawat.ch 0.011 0.016 0.00000:00:00
5-226-140-25.infrawat.ch 0.006 0.024 0.00000:00:00
TOTAL: 9 3.027 9.210 0.00000:38:41

Curious NNRP explorers [Top 20]:

SystemConn
50.146.94.167.censys-scanner.com 3
venice.scan.bufferover.run 2
185-216-145-181.infrawat.ch 1
20.15.166.132 1
5-226-140-25.infrawat.ch 1
brady.probe.onyphe.net 1
hansen.probe.onyphe.net 1
r4-156-9c.monitoring.internet-measurement.com 1
TOTAL: 8 11

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

SystemConn
venice.scan.bufferover.run 8
brady.probe.onyphe.net 2
50.146.94.167.censys-scanner.com 1
TOTAL: 3 11

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
185-216-145-181.infrawat.ch 1 1
50.146.94.167.censys-scanner.com 1 2
TOTAL: 2 2 4

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

HierarchyCountPct
1free 469 32.4%
2alt 416 28.7%
3microsoft 273 18.8%
4lada 100 6.9%
5fr 45 3.1%
6linux 28 1.9%
7de 20 1.4%
8pl 20 1.4%
9uk 18 1.2%
10aus 16 1.1%
11comp 14 1.0%
12eternal-september 6 0.4%
13ger 5 0.3%
14it 4 0.3%
15junk 4 0.3%
16sac 3 0.2%
17news 2 0.1%
18rec 2 0.1%
19soc 2 0.1%
20sci 1 0.1%
21talk 1 0.1%
TOTAL: 21 1449100.0%

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

NewsgroupCount
1free.usenet 398
2alt.anonymous.messages 273
3microsoft.public.windowsxp.general 182
4alt.test 115
5lada.talk 100
6microsoft.public.windowsxp.help_and_support 91
7free.pt 71
8fr.soc.politique 40
9alt.food.fast-food 17
10linux.debian.changes.devel 17
11aus.cars 13
12pl.soc.polityka 12
13uk.railway 10
14linux.kernel.git 8
15comp.os.linux.misc 7
16de.soc.politik.misc 7
17ger.ct 5
18junk 4
19pl.misc.samochody 4
20comp.compilers 3
21de.comp.os.unix.linux.misc 3
22de.talk.tagesgeschehen 3
23eternal-september.config 3
24eternal-september.talk 3
25fr.bio.medecine 3
26pl.soc.prawo 3
27sac.politics 3
28uk.current-events.terrorism 3
29uk.telecom 3
30alt.usage.english 2
31aus.politics 2
32de.etc.fahrzeug.auto 2
33de.rec.fahrrad 2
34it.sport.calcio.inter-fc 2
35linux.kernel.netdev 2
36news.lists.filters 2
37rec.food.cooking 2
38soc.culture.israel 2
39uk.d-i-y 2
40alt.abortion 1
41alt.arts.poetry.comments 1
42alt.buddha.short.fat.guy 1
43alt.fan.furry 1
44alt.fan.rush-limbaugh 1
45alt.politics 1
46alt.recovery.aa 1
47alt.religion.christian.roman-catholic 1
48alt.religion.scientology 1
49aus.general 1
50comp.arch 1
51comp.sys.acorn.announce 1
52comp.sys.raspberry-pi 1
53comp.theory 1
54de.alt.folklore.computer 1
55de.comp.hardware.massenspeicher 1
56de.sci.astronomie 1
57fr.sci.physique 1
58fr.sci.zetetique 1
59it.comp.os.win.windows10 1
60it.sport.formula1 1
61linux.debian.bugs.rc 1
62pl.biznes.banki 1
63sci.electronics.design 1
64talk.politics.misc 1
TOTAL: 64 1449
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