Daily Usenet report

Nov 2 03:00:05 -- Nov 3 03:00:04

Unknown entries from news log file:

First 50 / 1322 lines (3.8%)

Nov 2 03:01:15 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Nov 2 03:15:42 twilightnode nnrpd[932835]: Reading access from /usr/local/news/etc/readers.conf
Nov 2 03:15:42 twilightnode nnrpd[932835]: Auth strategy 'localhost' does not match client. Removing.
Nov 2 03:15:42 twilightnode nnrpd[932835]: azpdsgssndwo.stretchoid.com res <anonymous>
Nov 2 03:15:42 twilightnode nnrpd[932835]: azpdsgssndwo.stretchoid.com no_match_user <anonymous> <localhost>
Nov 2 03:15:42 twilightnode nnrpd[932835]: azpdsgssndwo.stretchoid.com no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 2 03:15:42 twilightnode nnrpd[932835]: azpdsgssndwo.stretchoid.com match_user <anonymous> <anonymous>
Nov 2 03:15:42 twilightnode nnrpd[932835]: azpdsgssndwo.stretchoid.com no_post anonymous-read
Nov 2 04:16:40 twilightnode nnrpd[935515]: Reading access from /usr/local/news/etc/readers.conf
Nov 2 04:16:40 twilightnode nnrpd[935515]: Auth strategy 'localhost' does not match client. Removing.
Nov 2 04:16:40 twilightnode nnrpd[935515]: 174.96.78.81 res <anonymous>
Nov 2 04:16:40 twilightnode nnrpd[935515]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 2 04:16:40 twilightnode nnrpd[935515]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 2 04:16:40 twilightnode nnrpd[935515]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 2 04:16:40 twilightnode nnrpd[935515]: 174.96.78.81 no_post anonymous-read
Nov 2 04:16:40 twilightnode nnrpd[935516]: Reading access from /usr/local/news/etc/readers.conf
Nov 2 04:16:40 twilightnode nnrpd[935516]: Auth strategy 'localhost' does not match client. Removing.
Nov 2 04:16:40 twilightnode nnrpd[935516]: 174.96.78.81 res <anonymous>
Nov 2 04:16:40 twilightnode nnrpd[935516]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 2 04:16:40 twilightnode nnrpd[935516]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 2 04:16:40 twilightnode nnrpd[935516]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 2 04:16:40 twilightnode nnrpd[935516]: 174.96.78.81 no_post anonymous-read
Nov 2 04:48:54 twilightnode nnrpd[936896]: Reading access from /usr/local/news/etc/readers.conf
Nov 2 04:48:54 twilightnode nnrpd[936896]: Auth strategy 'localhost' does not match client. Removing.
Nov 2 04:48:54 twilightnode nnrpd[936896]: 174.96.78.81 res <anonymous>
Nov 2 04:48:54 twilightnode nnrpd[936896]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 2 04:48:54 twilightnode nnrpd[936896]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 2 04:48:54 twilightnode nnrpd[936896]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 2 04:48:54 twilightnode nnrpd[936896]: 174.96.78.81 no_post anonymous-read
Nov 2 04:48:55 twilightnode nnrpd[936897]: Reading access from /usr/local/news/etc/readers.conf
Nov 2 04:48:55 twilightnode nnrpd[936897]: Auth strategy 'localhost' does not match client. Removing.
Nov 2 04:48:55 twilightnode nnrpd[936897]: 174.96.78.81 res <anonymous>
Nov 2 04:48:55 twilightnode nnrpd[936897]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 2 04:48:55 twilightnode nnrpd[936897]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 2 04:48:55 twilightnode nnrpd[936897]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 2 04:48:55 twilightnode nnrpd[936897]: 174.96.78.81 no_post anonymous-read
Nov 2 04:54:52 twilightnode nnrpd[937065]: Reading access from /usr/local/news/etc/readers.conf
Nov 2 04:54:52 twilightnode nnrpd[937065]: Auth strategy 'localhost' does not match client. Removing.
Nov 2 04:54:52 twilightnode nnrpd[937065]: 174.96.78.81 res <anonymous>
Nov 2 04:54:52 twilightnode nnrpd[937065]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 2 04:54:52 twilightnode nnrpd[937065]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 2 04:54:52 twilightnode nnrpd[937065]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 2 04:54:52 twilightnode nnrpd[937065]: 174.96.78.81 no_post anonymous-read
Nov 2 04:54:52 twilightnode nnrpd[937066]: Reading access from /usr/local/news/etc/readers.conf
Nov 2 04:54:52 twilightnode nnrpd[937066]: Auth strategy 'localhost' does not match client. Removing.
Nov 2 04:54:52 twilightnode nnrpd[937066]: 174.96.78.81 res <anonymous>
Nov 2 04:54:52 twilightnode nnrpd[937066]: 174.96.78.81 no_match_user <anonymous> <localhost>
Nov 2 04:54:52 twilightnode nnrpd[937066]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Nov 2 04:54:52 twilightnode nnrpd[937066]: 174.96.78.81 match_user <anonymous> <anonymous>
Nov 2 04:54:52 twilightnode nnrpd[937066]: 174.96.78.81 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 8993 41.7%783.3 KB 27.6%
inn 7798 36.2%1.3 MB 48.6%
innd 3488 16.2%464.0 KB 16.4%
innfeed 1275 5.9%209.8 KB 7.4%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 21555 100.0%2.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 20436 51.8%
Negative hits 11299 28.6%
Do not exist 7735 19.6%
Cache misses 1 0.0%
TOTAL: 4 39471 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.033 0.0%25 0.000 1.320 3.000
article cleanup00:00:00.083 0.0%7758 0.000 0.011 0.156
article logging00:00:00.319 0.0%7786 0.000 0.041 0.167
article parse00:00:00.125 0.0%11270 0.000 0.011 0.067
article write00:00:08.646 0.0%6340 0.836 1.364 2.778
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.389 0.0%43649 0.000 0.009 0.095
hisgrep/artcncl00:00:00.008 0.0%25 0.000 0.320 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.790 0.0%39556 0.082 0.146 0.399
history sync00:00:00.092 0.0%360 0.000 0.256 5.000
history write00:00:04.467 0.0%7758 0.273 0.576 1.267
idle24:00:03.116 99.9%43536 1036.185 1984.636 9838.393
nntp read00:00:01.091 0.0%42530 0.000 0.026 0.156
overview write00:00:07.152 0.0%6340 0.419 1.128 3.593
perl filter00:00:13.811 0.0%7758 0.812 1.780 10.667
python filter00:00:01.222 0.0%7758 0.000 0.158 1.917
site send00:00:00.392 0.0%12643 0.000 0.031 0.275
TOTAL: 1824:00:46.736100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%6625 0.000 0.005 0.125
article prepare00:00:00.002 0.0%26632 0.000 0.000 0.018
article read00:00:01.531 0.0%4465 0.097 0.343 2.000
backlog stats00:00:00.041 0.0%84030 0.000 0.000 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.737 0.0%47382 0.000 0.016 0.135
data write00:00:01.421 0.0%41003 0.000 0.035 0.133
idle23:58:18.255100.0%84030 385.507 1026.993 7697.833
status file00:00:00.353 0.0%171 0.000 2.064 11.000
TOTAL: 923:58:22.370100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:24:57.497 99.9%8464 122.000 176.925 9840.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.955 0.1%20427 0.000 0.047 0.500
readart00:00:00.245 0.0%569 0.000 0.431 1.070
TOTAL: 400:24:58.697100.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 2 11165 4432 6666 67 39%47:46:10
2usenet.blueworldhosting.com 378 7643 1197 5188 1258 15%23:51:36
3newsfeed.endofthelinebbs.com 1 5301 370 4835 96 6%22:08:37
4news.sklaffkom.se 39 122 118 3 1 96%11:18:16
5news.tebibyte.org 1 3874 88 3786 0 2%23:59:56
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 446 28105 6205 20478 1422 22%129:04:35
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net14.6 MB0.0 KB252.2 KB14.8 MB 98%3.4 KB
2usenet.blueworldhosting.com7.9 MB0.0 KB2.4 MB10.3 MB 76%4.3 KB
3newsfeed.endofthelinebbs.com4.4 MB0.0 KB150.4 KB4.6 MB 96%10.1 KB
4news.sklaffkom.se295.9 KB0.0 KB0.9 KB296.9 KB 99%2.5 KB
5news.tebibyte.org289.0 KB0.0 KB0.0 KB289.0 KB100%3.3 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 627.5 MB0.0 KB2.8 MB30.3 MB 90%4.1 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 2 03:00:05 - 03:59:59 132 2.1% 0.04665.7 KB 2.3% 0.19
Nov 2 04:00:00 - 04:59:59 82 1.3% 0.02663.7 KB 2.3% 0.18
Nov 2 05:00:00 - 05:59:59 80 1.3% 0.02510.4 KB 1.8% 0.14
Nov 2 06:00:00 - 06:59:59 138 2.2% 0.04393.5 KB 1.4% 0.11
Nov 2 07:00:00 - 07:59:59 149 2.3% 0.04574.2 KB 2.0% 0.16
Nov 2 08:00:00 - 08:59:59 226 3.6% 0.061.4 MB 4.9% 0.39
Nov 2 09:00:00 - 09:59:59 328 5.2% 0.091.3 MB 4.8% 0.38
Nov 2 10:00:00 - 10:59:59 319 5.0% 0.09968.5 KB 3.4% 0.27
Nov 2 11:00:00 - 11:59:59 355 5.6% 0.101.4 MB 5.0% 0.40
Nov 2 12:00:00 - 12:59:59 286 4.5% 0.081.2 MB 4.4% 0.35
Nov 2 13:00:00 - 13:59:59 291 4.6% 0.081.0 MB 3.7% 0.29
Nov 2 14:00:00 - 14:59:59 322 5.1% 0.091.3 MB 4.6% 0.37
Nov 2 15:00:00 - 15:59:59 439 6.9% 0.121.7 MB 6.0% 0.48
Nov 2 16:00:00 - 16:59:59 423 6.7% 0.122.1 MB 7.4% 0.59
Nov 2 17:00:00 - 17:59:59 360 5.7% 0.101.7 MB 6.0% 0.48
Nov 2 18:00:00 - 18:59:59 402 6.3% 0.111.8 MB 6.5% 0.52
Nov 2 19:00:00 - 19:59:59 371 5.8% 0.101.8 MB 6.6% 0.52
Nov 2 20:00:00 - 20:59:59 353 5.6% 0.101.6 MB 5.5% 0.44
Nov 2 21:00:00 - 21:59:59 289 4.5% 0.081.2 MB 4.1% 0.33
Nov 2 22:00:00 - 22:59:59 275 4.3% 0.081.5 MB 5.5% 0.44
Nov 2 23:00:00 - 23:59:59 272 4.3% 0.081.3 MB 4.8% 0.38
Nov 3 00:00:00 - 00:59:59 197 3.1% 0.05942.2 KB 3.3% 0.26
Nov 3 01:00:00 - 01:59:59 127 2.0% 0.04557.7 KB 1.9% 0.15
Nov 3 02:00:00 - 03:00:04 136 2.1% 0.04567.4 KB 2.0% 0.16
TOTAL: 23:59:59 6352 100.0% 0.0728.1 MB 100.0% 0.33
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1260 337 0 0 0 0 0 0 923
2twilightnode-out.news.weretis.net 93 11 0 0 0 0 0 0 82
3newsfeed.endofthelinebbs.com 92 3 0 0 0 0 0 0 89
4news.sklaffkom.se 1 0 0 0 0 0 0 0 1
TOTAL: 4 1446 351 0 0 0 0 0 0 1095

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 22
hispagatos.mastodon.tag.hacking 12
local.general 6
3dfx.d3d 3
hispagatos.test 3
3dfx.game.discussion 2
alt.idiot.will-dockery 2
dk.fritid.jernbaner.model 2
free.munch.onions 2
3dfx.game 1
alt.bbs.files-announce 1
alt.sports.basketball.nba.la-lakers 1
alt.sports.football.pro.wash-redskins 1
chmurka.statystyki 1
dk.edb.internet.software.browser 1
dk.edb.programmering.dotnet 1
fr.misc.finance 1
newsgrouper.support 1
TOTAL: 19 351

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 888
Too many newsgroups 121
User-issued cancel 39
HTML Multipart 17
Too many newsgroups (meow) 2
TOTAL: 5 1067

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
twilightnode-out.news.weretis.net 27
usenet.blueworldhosting.com 1
TOTAL: 2 28
TOTAL: 1 28

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 8561 2079 4089 147 0 6 24%23:59:55
2sklaffkom.se 6419 1148 1955 3212 0 0 17%23:59:55
3newsfeed.endofthelinebbs.com 10841 49 5859 21 0 295 0%23:59:04
4weretis.net 1952 3 1877 0 0 0 0%23:53:53
5usenet.blueworldhosting.com 7624 1 4645 0 0 11 0%23:59:55
TOTAL: 5 35397 3280 18425 3380 0 312 9%119:52:42
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org5.7 MB1.3 MB7.0 MB0.1 KB/s3.2 KB23:59:55
2sklaffkom.se2.0 MB18.8 MB20.8 MB0.2 KB/s4.9 KB23:59:55
3newsfeed.endofthelinebbs.com128.7 KB45.7 KB174.4 KB0.0 KB/s2.5 KB23:59:04
4weretis.net12.9 KB0.0 KB12.9 KB0.0 KB/s4.3 KB23:53:53
5usenet.blueworldhosting.com0.9 KB0.0 KB0.9 KB0.0 KB/s0.9 KB23:59:55
TOTAL: 57.8 MB20.1 MB27.9 MB0.1 KB/s4.3 KB119:52:42
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1174.96.78.81 180 5691.9 MB 200 0 000:24:31
TOTAL: 1 180 5691.9 MB 200 0 000:24:31

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 181 5691.9 MB 200 0 000:24:31
2*.infrawat.ch 2 00.0 KB 0 0 000:00:00
3*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
4*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:02
5*.internet-census.org 1 00.0 KB 0 0 000:00:10
6*.stretchoid.com 1 00.0 KB 0 0 000:00:09
TOTAL: 6 188 5691.9 MB 200 0 000:24:58

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
174.96.78.81 1.540 4.198 0.00000:24:31
sh-ams-nl-gp1-wk114d.internet-census.org 0.008 0.007 0.00000:00:10
azpdsgssndwo.stretchoid.com 0.006 0.014 0.00000:00:09
cordelia.probe.onyphe.net 0.006 0.004 0.00000:00:02
131.172.132.66.censys-scanner.com 0.045 0.022 0.00000:00:02
rosemary.probe.onyphe.net 0.005 0.012 0.00000:00:00
198.235.24.88 0.006 0.015 0.00000:00:00
188-240-59-38.infrawat.ch 0.006 0.005 0.00000:00:00
2-57-17-135.infrawat.ch 0.004 0.010 0.00000:00:00
TOTAL: 9 1.626 4.287 0.00000:24:58

Curious NNRP explorers [Top 20]:

SystemConn
131.172.132.66.censys-scanner.com 1
188-240-59-38.infrawat.ch 1
198.235.24.88 1
2-57-17-135.infrawat.ch 1
azpdsgssndwo.stretchoid.com 1
cordelia.probe.onyphe.net 1
rosemary.probe.onyphe.net 1
sh-ams-nl-gp1-wk114d.internet-census.org 1
TOTAL: 8 8

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

SystemConn
rosemary.probe.onyphe.net 2
131.172.132.66.censys-scanner.com 1
TOTAL: 2 3

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

CommandCount
#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: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
188-240-59-38.infrawat.ch 1 1
TOTAL: 1 1 3

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

HierarchyCountPct
1free 233 40.9%
2linux 71 12.5%
3alt 64 11.2%
4it 54 9.5%
5fr 44 7.7%
6de 25 4.4%
7uk 19 3.3%
8news 14 2.5%
9rec 9 1.6%
10comp 8 1.4%
11pl 6 1.1%
12dk 5 0.9%
13nl 4 0.7%
14eternal-september 3 0.5%
15junk 3 0.5%
16spline 3 0.5%
17microsoft 2 0.4%
18ger 1 0.2%
19talk 1 0.2%
TOTAL: 19 569100.0%

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

NewsgroupCount
1free.usenet 200
2free.pt 31
3alt.fan.rush-limbaugh 27
4fr.soc.politique 25
5linux.kernel.netdev 25
6it.sport.calcio.milan 23
7linux.debian.changes.devel 17
8linux.debian.bugs.dist 16
9news.lists.filters 14
10uk.railway 12
11it.tlc.cellulari.android 11
12alt.usage.english 9
13de.alt.folklore.computer 8
14it.hobby.cucina 7
15linux.debian.bugs.rc 6
16alt.checkmate 5
17dk.politik 5
18fr.comp.sys.mac.communication 5
19fr.lettres.langue.francaise 5
20fr.soc.environnement 4
21it.hobby.fai-da-te 4
22linux.kernel.git 4
23nl.politiek 4
24alt.anonymous.messages 3
25alt.atheism 3
26comp.os.linux.misc 3
27de.alt.talk.unmut 3
28de.sci.electronics 3
29eternal-september.talk 3
30fr.bio.medecine 3
31it.test 3
32junk 3
33rec.sport.soccer 3
34spline.eisfair 3
35uk.legal.moderated 3
36alt.comp.software.thunderbird 2
37alt.computer.workshop 2
38alt.folklore.computers 2
39alt.os.linux.mint 2
40alt.test 2
41comp.text.tex 2
42de.alt.folklore.ddr 2
43de.comm.provider.t-online 2
44de.etc.bahn.tarif+service 2
45de.etc.finanz.banken+broker 2
46fr.comp.os.mac-os.x 2
47free.it.scienza.fisica 2
48pl.biznes.banki 2
49pl.soc.prawo 2
50rec.arts.tv 2
51uk.telecom.broadband 2
52alt.abortion 1
53alt.christnet.bible 1
54alt.comp.os.windows-10 1
55alt.comp.software.firefox 1
56alt.jobs.offered 1
57alt.os.linux 1
58alt.test.test 1
59comp.lang.forth 1
60comp.os.linux.advocacy 1
61comp.unix.shell 1
62de.comp.hardware.massenspeicher 1
63de.rec.fahrrad 1
64de.rec.mampf 1
65ger.ct 1
66it.comp.giochi.strategici 1
67it.comp.hardware 1
68it.comp.retrocomputing 1
69it.discussioni.geometri 1
70it.politica 1
71it.sport.formula1 1
72linux.debian.devel.qa 1
73linux.debian.maint.emacsen 1
74linux.debian.user.french 1
75microsoft.public.windowsxp.general 1
76microsoft.public.windowsxp.help_and_support 1
77pl.misc.elektronika 1
78pl.soc.polityka 1
79rec.autos.sport.f1 1
80rec.bicycles.tech 1
81rec.food.cooking 1
82rec.pets.cats.anecdotes 1
83talk.politics.guns 1
84uk.rec.sheds 1
85uk.sci.weather 1
TOTAL: 85 569
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