Daily Usenet report

Oct 29 03:00:04 -- Oct 30 03:00:04

Unknown entries from news log file:

First 50 / 23134 lines (0.2%)

Oct 29 03:01:16 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Oct 29 03:19:53 twilightnode nnrpd[640641]: Reading access from /usr/local/news/etc/readers.conf
Oct 29 03:19:53 twilightnode nnrpd[640641]: Auth strategy 'localhost' does not match client. Removing.
Oct 29 03:19:53 twilightnode nnrpd[640641]: 174.96.78.81 res <anonymous>
Oct 29 03:19:53 twilightnode nnrpd[640641]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 29 03:19:53 twilightnode nnrpd[640641]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 29 03:19:53 twilightnode nnrpd[640641]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 29 03:19:53 twilightnode nnrpd[640641]: 174.96.78.81 no_post anonymous-read
Oct 29 03:19:54 twilightnode nnrpd[640642]: Reading access from /usr/local/news/etc/readers.conf
Oct 29 03:19:54 twilightnode nnrpd[640642]: Auth strategy 'localhost' does not match client. Removing.
Oct 29 03:19:54 twilightnode nnrpd[640642]: 174.96.78.81 res <anonymous>
Oct 29 03:19:54 twilightnode nnrpd[640642]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 29 03:19:54 twilightnode nnrpd[640642]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 29 03:19:54 twilightnode nnrpd[640642]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 29 03:19:54 twilightnode nnrpd[640642]: 174.96.78.81 no_post anonymous-read
Oct 29 03:34:59 twilightnode nnrpd[641862]: Reading access from /usr/local/news/etc/readers.conf
Oct 29 03:34:59 twilightnode nnrpd[641862]: Auth strategy 'localhost' does not match client. Removing.
Oct 29 03:34:59 twilightnode nnrpd[641862]: 174.96.78.81 res <anonymous>
Oct 29 03:34:59 twilightnode nnrpd[641862]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 29 03:34:59 twilightnode nnrpd[641862]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 29 03:34:59 twilightnode nnrpd[641862]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 29 03:34:59 twilightnode nnrpd[641862]: 174.96.78.81 no_post anonymous-read
Oct 29 03:34:59 twilightnode nnrpd[641863]: Reading access from /usr/local/news/etc/readers.conf
Oct 29 03:34:59 twilightnode nnrpd[641863]: Auth strategy 'localhost' does not match client. Removing.
Oct 29 03:34:59 twilightnode nnrpd[641863]: 174.96.78.81 res <anonymous>
Oct 29 03:34:59 twilightnode nnrpd[641863]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 29 03:34:59 twilightnode nnrpd[641863]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 29 03:34:59 twilightnode nnrpd[641863]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 29 03:34:59 twilightnode nnrpd[641863]: 174.96.78.81 no_post anonymous-read
Oct 29 04:03:21 twilightnode nnrpd[643150]: Reading access from /usr/local/news/etc/readers.conf
Oct 29 04:03:21 twilightnode nnrpd[643150]: Auth strategy 'localhost' does not match client. Removing.
Oct 29 04:03:21 twilightnode nnrpd[643150]: 174.96.78.81 res <anonymous>
Oct 29 04:03:21 twilightnode nnrpd[643150]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 29 04:03:21 twilightnode nnrpd[643150]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 29 04:03:21 twilightnode nnrpd[643150]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 29 04:03:21 twilightnode nnrpd[643150]: 174.96.78.81 no_post anonymous-read
Oct 29 04:03:22 twilightnode nnrpd[643151]: Reading access from /usr/local/news/etc/readers.conf
Oct 29 04:03:22 twilightnode nnrpd[643151]: Auth strategy 'localhost' does not match client. Removing.
Oct 29 04:03:22 twilightnode nnrpd[643151]: 174.96.78.81 res <anonymous>
Oct 29 04:03:22 twilightnode nnrpd[643151]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 29 04:03:22 twilightnode nnrpd[643151]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 29 04:03:22 twilightnode nnrpd[643151]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 29 04:03:22 twilightnode nnrpd[643151]: 174.96.78.81 no_post anonymous-read
Oct 29 04:31:19 twilightnode nnrpd[644306]: Reading access from /usr/local/news/etc/readers.conf
Oct 29 04:31:19 twilightnode nnrpd[644306]: Auth strategy 'localhost' does not match client. Removing.
Oct 29 04:31:19 twilightnode nnrpd[644306]: 174.96.78.81 res <anonymous>
Oct 29 04:31:19 twilightnode nnrpd[644306]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 29 04:31:19 twilightnode nnrpd[644306]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 29 04:31:19 twilightnode nnrpd[644306]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 29 04:31:19 twilightnode nnrpd[644306]: 174.96.78.81 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 48561 75.3%4.5 MB 64.8%
inn 7384 11.4%1.3 MB 18.6%
innd 7302 11.3%979.3 KB 13.8%
innfeed 1274 2.0%195.2 KB 2.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 64522 100.0%6.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 19289 52.8%
Negative hits 9924 27.2%
Do not exist 7282 20.0%
Cache misses 4 0.0%
TOTAL: 4 36499 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.070 0.0%44 0.000 1.591 3.000
article cleanup00:00:00.071 0.0%7318 0.000 0.010 0.111
article logging00:00:00.323 0.0%7374 0.000 0.044 0.231
article parse00:00:00.173 0.0%10837 0.000 0.016 0.111
article write00:00:08.247 0.0%6059 0.800 1.361 2.438
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.404 0.0%41590 0.000 0.010 0.059
hisgrep/artcncl00:00:00.039 0.0%44 0.000 0.886 1.714
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.850 0.0%36572 0.092 0.160 0.283
history sync00:00:00.089 0.0%327 0.000 0.272 7.000
history write00:00:04.109 0.0%7297 0.306 0.563 1.103
idle23:59:42.597 99.9%49767 855.077 1735.740 8697.188
nntp read00:00:01.191 0.0%41609 0.009 0.029 0.114
overview write00:00:06.921 0.0%6059 0.600 1.142 3.750
perl filter00:00:14.827 0.0%7297 1.037 2.032 20.067
python filter00:00:01.157 0.0%7297 0.000 0.159 1.467
site send00:00:00.397 0.0%12083 0.000 0.033 0.179
TOTAL: 1824:00:26.465100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.059 0.0%6201 0.000 0.010 0.655
article prepare00:00:00.003 0.0%27448 0.000 0.000 0.005
article read00:00:01.518 0.0%4218 0.095 0.360 1.524
backlog stats00:00:00.045 0.0%82208 0.000 0.001 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.693 0.0%45862 0.000 0.015 0.067
data write00:00:01.345 0.0%39869 0.000 0.034 0.103
idle23:50:22.404100.0%82208 382.088 1043.967 4305.529
status file00:00:00.293 0.0%172 0.000 1.703 9.000
TOTAL: 923:50:26.360100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:37:58.926100.0%17837 106.000 329.592 10391.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.729 0.0%48547 0.000 0.036 2.500
readart00:00:00.534 0.0%842 0.000 0.634 1.000
TOTAL: 401:38:01.189100.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 5 11529 4849 6606 74 42%49:43:09
2usenet.blueworldhosting.com 1380 6828 853 4935 1040 12%23:50:23
3newsfeed.endofthelinebbs.com 2 5220 304 4765 151 5%24:35:50
4news.sklaffkom.se 41 114 102 12 0 89%11:06:32
5news.tebibyte.org 2 3447 80 3367 0 2%23:59:46
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 1455 27138 6188 19685 1265 22%133:15:40
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net20.2 MB45.8 KB164.3 KB20.4 MB 98%4.2 KB
2usenet.blueworldhosting.com5.7 MB10.5 KB1.3 MB7.0 MB 81%3.8 KB
3newsfeed.endofthelinebbs.com4.9 MB0.0 KB236.0 KB5.1 MB 95%11.5 KB
4news.sklaffkom.se295.7 KB0.0 KB0.0 KB295.7 KB100%2.9 KB
5news.tebibyte.org294.2 KB0.0 KB0.0 KB294.2 KB100%3.7 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 631.3 MB56.3 KB1.7 MB33.0 MB 94%4.5 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 29 03:00:04 - 03:59:59 111 1.8% 0.03766.8 KB 2.5% 0.21
Oct 29 04:00:00 - 04:59:59 110 1.8% 0.03626.4 KB 2.0% 0.17
Oct 29 05:00:00 - 05:59:59 109 1.8% 0.03557.9 KB 1.8% 0.15
Oct 29 06:00:00 - 06:59:59 125 2.1% 0.03553.8 KB 1.8% 0.15
Oct 29 07:00:00 - 07:59:59 151 2.5% 0.04582.3 KB 1.9% 0.16
Oct 29 08:00:00 - 08:59:59 216 3.6% 0.06896.2 KB 2.9% 0.25
Oct 29 09:00:00 - 09:59:59 279 4.6% 0.081.1 MB 3.5% 0.30
Oct 29 10:00:00 - 10:59:59 339 5.6% 0.091.3 MB 4.3% 0.37
Oct 29 11:00:00 - 11:59:59 377 6.2% 0.101.4 MB 4.7% 0.41
Oct 29 12:00:00 - 12:59:59 304 5.0% 0.081.0 MB 3.4% 0.29
Oct 29 13:00:00 - 13:59:59 334 5.5% 0.091.4 MB 4.6% 0.39
Oct 29 14:00:00 - 14:59:59 329 5.4% 0.092.7 MB 8.9% 0.76
Oct 29 15:00:00 - 15:59:59 294 4.8% 0.081.3 MB 4.2% 0.37
Oct 29 16:00:00 - 16:59:59 315 5.2% 0.091.1 MB 3.7% 0.32
Oct 29 17:00:00 - 17:59:59 386 6.4% 0.112.2 MB 7.4% 0.64
Oct 29 18:00:00 - 18:59:59 322 5.3% 0.093.0 MB 9.8% 0.84
Oct 29 19:00:00 - 19:59:59 377 6.2% 0.103.0 MB 10.0% 0.86
Oct 29 20:00:00 - 20:59:59 279 4.6% 0.08951.4 KB 3.1% 0.26
Oct 29 21:00:00 - 21:59:59 300 4.9% 0.081.4 MB 4.7% 0.41
Oct 29 22:00:00 - 22:59:59 240 4.0% 0.071.0 MB 3.5% 0.30
Oct 29 23:00:00 - 23:59:59 224 3.7% 0.061.0 MB 3.4% 0.29
Oct 30 00:00:00 - 00:59:59 238 3.9% 0.071.3 MB 4.3% 0.37
Oct 30 01:00:00 - 01:59:59 169 2.8% 0.05682.3 KB 2.2% 0.19
Oct 30 02:00:00 - 03:00:04 144 2.4% 0.04532.8 KB 1.7% 0.15
TOTAL: 24:00:00 6072 100.0% 0.0730.3 MB 100.0% 0.36
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1041 336 0 5 0 0 0 0 700
2newsfeed.endofthelinebbs.com 149 2 0 0 0 0 0 0 147
3twilightnode-out.news.weretis.net 120 13 0 16 0 0 0 0 91
4news.tebibyte.org 2 1 0 0 0 0 0 0 1
TOTAL: 4 1312 352 0 21 0 0 0 0 939

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 30
tw.bbs.talk 7
hispagatos.mastodon.tag.hacking 6
hispagatos.mastodon.tag.hackers 3
3dfx.test 1
alt.2600.madrid 1
alt.ads 1
alt.bbs.files-announce 1
alt.business.ads 1
alt.music.eminem 1
alt.religion.jewish 1
alt.sexy.bald.captains 1
alt.soc.germans 1
alt.sports.basketball.nba.la-lakers 1
alt.sports.football.pro.cinci-bengals 1
alt.sports.football.pro.no-saints 1
alt.test.9 1
chmurka.statystyki 1
pl.listserv.chomor-l 1
TOTAL: 23 352

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 773
Too many newsgroups 75
User-issued cancel 23
EMP (phn path) 8
HTML Multipart 2
Too many newsgroups (meow) 2
TOTAL: 6 883

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 7691 2524 3345 169 0 15 32%23:59:23
2sklaffkom.se 6134 1061 1959 3017 0 0 17%23:59:36
3newsfeed.endofthelinebbs.com 10724 104 5623 17 0 168 0%23:59:57
4usenet.blueworldhosting.com 8153 6 4824 0 0 5 0%23:59:57
5weretis.net 1423 5 1340 0 0 0 0%23:42:24
TOTAL: 5 34125 3700 17091 3203 0 188 10%119:41:17
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org7.6 MB4.5 MB12.1 MB0.1 KB/s4.6 KB23:59:23
2sklaffkom.se1.8 MB19.2 MB21.0 MB0.2 KB/s5.3 KB23:59:36
3newsfeed.endofthelinebbs.com311.4 KB40.8 KB352.2 KB0.0 KB/s2.9 KB23:59:57
4usenet.blueworldhosting.com22.1 KB0.0 KB22.1 KB0.0 KB/s3.7 KB23:59:57
5weretis.net10.8 KB0.0 KB10.8 KB0.0 KB/s2.2 KB23:42:24
TOTAL: 59.7 MB23.8 MB33.5 MB0.1 KB/s5.0 KB119:41:17
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1174.96.78.813290 84240.0 MB 76 0 001:37:25
TOTAL: 13290 84240.0 MB 76 0 001:37:25

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved3295 84240.0 MB 76 0 001:37:33
2*.infrawat.ch 2 00.0 KB 0 0 000:00:00
3*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
4*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
5*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:09
6*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
7*.stretchoid.com 1 00.0 KB 0 0 000:00:09
TOTAL: 73304 84240.0 MB 76 0 001:38:00

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
174.96.78.81 17.771 34.816 0.00001:37:25
azpdwsngfhox.stretchoid.com 0.005 0.008 0.00000:00:09
73.159.132.66.censys-scanner.com 0.042 0.024 0.00000:00:09
47.250.151.109 0.003 0.008 0.00000:00:03
104.37.185.25 0.010 0.037 0.00000:00:03
edith.probe.onyphe.net 0.003 0.006 0.00000:00:03
r4-165-a5.monitoring.internet-measurement.com 0.008 0.006 0.00000:00:01
r5-79-4f.monitoring.internet-measurement.com 0.006 0.007 0.00000:00:01
205.210.31.185 0.010 0.025 0.00000:00:00
meadows.probe.onyphe.net 0.005 0.008 0.00000:00:00
205.210.31.210 0.003 0.012 0.00000:00:00
193-32-209-254.infrawat.ch 0.004 0.013 0.00000:00:00
o325.scanner.modat.io 0.004 0.009 0.00000:00:00
81-19-219-230.infrawat.ch 0.009 0.025 0.00000:00:00
TOTAL: 14 17.883 35.004 0.00001:38:00

Curious NNRP explorers [Top 20]:

SystemConn
104.37.185.25 2
193-32-209-254.infrawat.ch 1
205.210.31.185 1
205.210.31.210 1
47.250.151.109 1
73.159.132.66.censys-scanner.com 1
81-19-219-230.infrawat.ch 1
azpdwsngfhox.stretchoid.com 1
edith.probe.onyphe.net 1
meadows.probe.onyphe.net 1
o325.scanner.modat.io 1
r4-165-a5.monitoring.internet-measurement.com 1
r5-79-4f.monitoring.internet-measurement.com 1
TOTAL: 13 14

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

SystemConn
47.250.151.109 3
meadows.probe.onyphe.net 2
73.159.132.66.censys-scanner.com 1
TOTAL: 3 6

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
193-32-209-254.infrawat.ch 1 1
47.250.151.109 1 1
TOTAL: 2 2 5

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

HierarchyCountPct
1microsoft 486 57.7%
2alt 263 31.2%
3free 21 2.5%
4it 13 1.5%
5de 11 1.3%
6lada 7 0.8%
7linux 6 0.7%
8sci 6 0.7%
9news 4 0.5%
10rec 4 0.5%
11it-alt 3 0.4%
12nl 3 0.4%
13aus 2 0.2%
14comp 2 0.2%
15dk 2 0.2%
16fr 2 0.2%
17hfx 2 0.2%
18uk 2 0.2%
19eternal-september 1 0.1%
20junk 1 0.1%
21soc 1 0.1%
TOTAL: 21 842100.0%

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

NewsgroupCount
1microsoft.public.windowsxp.general 243
2microsoft.public.windowsxp.help_and_support 243
3alt.anonymous.messages 240
4free.pt 13
5alt.buddha.short.fat.guy 10
6free.usenet 8
7lada.talk 7
8news.lists.filters 4
9de.comp.os.unix.linux.misc 3
10it-alt.sport.calcio.juventus 3
11nl.politiek 3
12sci.electronics.design 3
13alt.comp.os.windows-11 2
14alt.usage.english 2
15alt.usenet.legends.lester-mosley 2
16aus.politics 2
17de.etc.fahrzeug.auto 2
18de.sci.electronics 2
19dk.politik 2
20hfx.general 2
21it.sport.calcio.inter-fc 2
22linux.kernel.git 2
23linux.kernel.netdev 2
24rec.games.trivia 2
25sci.physics 2
26alt.atheism 1
27alt.bible.prophecy 1
28alt.christnet.bible 1
29alt.christnet.christianlife 1
30alt.fan.rush-limbaugh 1
31alt.test 1
32alt.tv.survivor 1
33comp.sys.mac.advocacy 1
34comp.sys.mac.misc 1
35de.comp.text.tex 1
36de.rec.fahrrad 1
37de.rec.mampf 1
38de.sci.mathematik 1
39eternal-september.config 1
40fr.soc.politique 1
41fr.test 1
42it.arti.musica.polifonia 1
43it.comp.giochi.simulatori 1
44it.comp.hardware.overclock 1
45it.comp.hardware.palmari.gps 1
46it.comp.reti.locali 1
47it.comp.virtualizzazione 1
48it.economia.analisi-tecn 1
49it.economia.carte-di-credito 1
50it.hobby.radio-cb 1
51it.hobby.totoscommesse 1
52it.sport.calcio.milan 1
53junk 1
54linux.debian.bugs.rc 1
55linux.debian.maint.emacsen 1
56rec.arts.tv 1
57rec.food.cooking 1
58sci.physics.relativity 1
59soc.culture.bulgaria 1
60uk.current-events.terrorism 1
61uk.d-i-y 1
TOTAL: 61 842
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