Daily Usenet report

Sep 12 03:00:03 -- Sep 13 03:00:04

Unknown entries from news log file:

First 50 / 258 lines (19.4%)

Sep 12 03:01:14 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Sep 12 04:22:38 twilightnode nnrpd[3300259]: Reading access from /usr/local/news/etc/readers.conf
Sep 12 04:22:38 twilightnode nnrpd[3300259]: Auth strategy 'localhost' does not match client. Removing.
Sep 12 04:22:38 twilightnode nnrpd[3300259]: 94.154.43.21 res <anonymous>
Sep 12 04:22:38 twilightnode nnrpd[3300259]: 94.154.43.21 no_match_user <anonymous> <localhost>
Sep 12 04:22:38 twilightnode nnrpd[3300259]: 94.154.43.21 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 12 04:22:38 twilightnode nnrpd[3300259]: 94.154.43.21 match_user <anonymous> <anonymous>
Sep 12 04:22:38 twilightnode nnrpd[3300259]: 94.154.43.21 no_post anonymous-read
Sep 12 04:47:23 twilightnode nnrpd[3301263]: Reading access from /usr/local/news/etc/readers.conf
Sep 12 04:47:23 twilightnode nnrpd[3301263]: Auth strategy 'localhost' does not match client. Removing.
Sep 12 04:47:23 twilightnode nnrpd[3301263]: 66.61.98.95 res <anonymous>
Sep 12 04:47:23 twilightnode nnrpd[3301263]: 66.61.98.95 no_match_user <anonymous> <localhost>
Sep 12 04:47:23 twilightnode nnrpd[3301263]: 66.61.98.95 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 12 04:47:23 twilightnode nnrpd[3301263]: 66.61.98.95 match_user <anonymous> <anonymous>
Sep 12 04:47:23 twilightnode nnrpd[3301263]: 66.61.98.95 no_post anonymous-read
Sep 12 04:47:23 twilightnode nnrpd[3301264]: Reading access from /usr/local/news/etc/readers.conf
Sep 12 04:47:23 twilightnode nnrpd[3301264]: Auth strategy 'localhost' does not match client. Removing.
Sep 12 04:47:23 twilightnode nnrpd[3301264]: 66.61.98.95 res <anonymous>
Sep 12 04:47:23 twilightnode nnrpd[3301264]: 66.61.98.95 no_match_user <anonymous> <localhost>
Sep 12 04:47:23 twilightnode nnrpd[3301264]: 66.61.98.95 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 12 04:47:23 twilightnode nnrpd[3301264]: 66.61.98.95 match_user <anonymous> <anonymous>
Sep 12 04:47:23 twilightnode nnrpd[3301264]: 66.61.98.95 no_post anonymous-read
Sep 12 05:44:05 twilightnode nnrpd[3303866]: Reading access from /usr/local/news/etc/readers.conf
Sep 12 05:44:05 twilightnode nnrpd[3303866]: Auth strategy 'localhost' does not match client. Removing.
Sep 12 05:44:05 twilightnode nnrpd[3303866]: 66.61.98.95 res <anonymous>
Sep 12 05:44:05 twilightnode nnrpd[3303866]: 66.61.98.95 no_match_user <anonymous> <localhost>
Sep 12 05:44:05 twilightnode nnrpd[3303866]: 66.61.98.95 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 12 05:44:05 twilightnode nnrpd[3303866]: 66.61.98.95 match_user <anonymous> <anonymous>
Sep 12 05:44:05 twilightnode nnrpd[3303866]: 66.61.98.95 no_post anonymous-read
Sep 12 05:53:34 twilightnode nnrpd[3304333]: Reading access from /usr/local/news/etc/readers.conf
Sep 12 05:53:34 twilightnode nnrpd[3304333]: Auth strategy 'localhost' does not match client. Removing.
Sep 12 05:53:34 twilightnode nnrpd[3304333]: 66.61.98.95 res <anonymous>
Sep 12 05:53:34 twilightnode nnrpd[3304333]: 66.61.98.95 no_match_user <anonymous> <localhost>
Sep 12 05:53:34 twilightnode nnrpd[3304333]: 66.61.98.95 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 12 05:53:34 twilightnode nnrpd[3304333]: 66.61.98.95 match_user <anonymous> <anonymous>
Sep 12 05:53:34 twilightnode nnrpd[3304333]: 66.61.98.95 no_post anonymous-read
Sep 12 05:53:35 twilightnode nnrpd[3304334]: Reading access from /usr/local/news/etc/readers.conf
Sep 12 05:53:35 twilightnode nnrpd[3304334]: Auth strategy 'localhost' does not match client. Removing.
Sep 12 05:53:35 twilightnode nnrpd[3304334]: 66.61.98.95 res <anonymous>
Sep 12 05:53:35 twilightnode nnrpd[3304334]: 66.61.98.95 no_match_user <anonymous> <localhost>
Sep 12 05:53:35 twilightnode nnrpd[3304334]: 66.61.98.95 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 12 05:53:35 twilightnode nnrpd[3304334]: 66.61.98.95 match_user <anonymous> <anonymous>
Sep 12 05:53:35 twilightnode nnrpd[3304334]: 66.61.98.95 no_post anonymous-read
Sep 12 06:18:10 twilightnode nnrpd[3305551]: Reading access from /usr/local/news/etc/readers.conf
Sep 12 06:18:10 twilightnode nnrpd[3305551]: Auth strategy 'localhost' does not match client. Removing.
Sep 12 06:18:10 twilightnode nnrpd[3305551]: 66.61.98.95 res <anonymous>
Sep 12 06:18:10 twilightnode nnrpd[3305551]: 66.61.98.95 no_match_user <anonymous> <localhost>
Sep 12 06:18:10 twilightnode nnrpd[3305551]: 66.61.98.95 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Sep 12 06:18:10 twilightnode nnrpd[3305551]: 66.61.98.95 match_user <anonymous> <anonymous>
Sep 12 06:18:10 twilightnode nnrpd[3305551]: 66.61.98.95 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
inn 9206 42.6%1.7 MB 55.7%
nnrpd 6523 30.2%556.8 KB 17.6%
innd 4600 21.3%648.2 KB 20.4%
innfeed 1292 6.0%197.9 KB 6.2%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 21622 100.0%3.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24172 49.5%
Negative hits 15484 31.7%
Do not exist 9135 18.7%
Cache misses 67 0.1%
TOTAL: 4 48858 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.036 0.0%23 0.000 1.565 12.000
article cleanup00:00:00.073 0.0%9162 0.000 0.008 0.136
article logging00:00:00.250 0.0%9206 0.000 0.027 0.500
article parse00:00:00.214 0.0%18191 0.000 0.012 0.080
article write00:00:06.682 0.0%8011 0.382 0.834 1.909
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.232 0.0%57842 0.000 0.004 0.052
hisgrep/artcncl00:00:00.015 0.0%23 0.000 0.652 4.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.545 0.0%48983 0.050 0.093 0.425
history sync00:00:00.042 0.0%352 0.000 0.119 2.000
history write00:00:03.577 0.0%9162 0.176 0.390 1.273
idle24:00:06.214 99.9%56484 293.970 1529.747 10014.117
nntp read00:00:01.040 0.0%55452 0.000 0.019 0.086
overview write00:00:03.654 0.0%8011 0.124 0.456 3.316
perl filter00:00:14.289 0.0%9162 0.897 1.560 11.950
python filter00:00:00.966 0.0%9162 0.017 0.105 0.682
site send00:00:00.351 0.0%15980 0.000 0.022 0.133
TOTAL: 1824:00:42.180100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.049 0.0%8221 0.000 0.006 0.091
article prepare00:00:00.003 0.0%42492 0.000 0.000 0.007
article read00:00:00.992 0.0%6175 0.000 0.161 1.000
backlog stats00:00:00.050 0.0%100673 0.000 0.000 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.716 0.0%58656 0.000 0.012 0.057
data write00:00:01.227 0.0%50929 0.000 0.024 0.082
idle23:59:40.189100.0%100673 219.944 858.027 4422.581
status file00:00:00.166 0.0%181 0.000 0.917 7.000
TOTAL: 923:59:43.392100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:28:54.126 99.8%7998 75.000 216.820 20927.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.031 0.2%24949 0.000 0.121 1.575
readart00:00:00.422 0.0%694 0.000 0.608 0.687
TOTAL: 400:28:57.579100.0%----

Control commands to innd:

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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1twilightnode-out.news.weretis.net 9 14430 5274 9056 100 36%42:52:23
2usenet.blueworldhosting.com 717 9050 2087 6006 957 23%23:45:47
3news.tebibyte.org 1 29561 210 29350 1 0%23:04:55
4news.sklaffkom.se 47 92 77 15 0 83%10:32:39
5newsfeed.endofthelinebbs.com 1 1583 76 1481 26 4%10:23:52
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 800 54716 7724 45908 1084 14%110:39:36
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net33.7 MB0.0 KB124.6 KB33.8 MB 99%6.4 KB
2usenet.blueworldhosting.com22.9 MB0.0 KB1.4 MB24.3 MB 94%8.2 KB
3newsfeed.endofthelinebbs.com1.1 MB0.0 KB40.7 KB1.1 MB 96%11.1 KB
4news.tebibyte.org989.1 KB0.0 KB1.0 KB990.0 KB 99%4.7 KB
5news.sklaffkom.se260.9 KB0.0 KB0.0 KB260.9 KB100%3.4 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 658.8 MB0.0 KB1.6 MB60.4 MB 97%7.0 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 12 03:00:03 - 03:59:59 123 1.5% 0.03497.1 KB 0.8% 0.14
Sep 12 04:00:00 - 04:59:59 145 1.8% 0.04672.8 KB 1.1% 0.19
Sep 12 05:00:00 - 05:59:59 111 1.4% 0.03474.3 KB 0.7% 0.13
Sep 12 06:00:00 - 06:59:59 106 1.3% 0.03454.0 KB 0.7% 0.13
Sep 12 07:00:00 - 07:59:59 128 1.6% 0.04541.9 KB 0.9% 0.15
Sep 12 08:00:00 - 08:59:59 214 2.7% 0.06843.6 KB 1.3% 0.23
Sep 12 09:00:00 - 09:59:59 198 2.5% 0.06615.5 KB 1.0% 0.17
Sep 12 10:00:00 - 10:59:59 306 3.8% 0.094.9 MB 7.9% 1.40
Sep 12 11:00:00 - 11:59:59 344 4.3% 0.101.5 MB 2.4% 0.43
Sep 12 12:00:00 - 12:59:59 333 4.2% 0.091.2 MB 1.9% 0.33
Sep 12 13:00:00 - 13:59:59 275 3.4% 0.08875.7 KB 1.4% 0.24
Sep 12 14:00:00 - 14:59:59 286 3.6% 0.081018.8 KB 1.6% 0.28
Sep 12 15:00:00 - 15:59:59 320 4.0% 0.091.1 MB 1.8% 0.31
Sep 12 16:00:00 - 16:59:59 363 4.5% 0.102.1 MB 3.4% 0.60
Sep 12 17:00:00 - 17:59:59 439 5.5% 0.123.0 MB 4.8% 0.85
Sep 12 18:00:00 - 18:59:59 661 8.3% 0.186.3 MB 10.1% 1.78
Sep 12 19:00:00 - 19:59:59 322 4.0% 0.091.0 MB 1.6% 0.28
Sep 12 20:00:00 - 20:59:59 918 11.5% 0.2610.7 MB 17.2% 3.04
Sep 12 21:00:00 - 21:59:59 1178 14.7% 0.3315.3 MB 24.7% 4.36
Sep 12 22:00:00 - 22:59:59 588 7.3% 0.166.6 MB 10.6% 1.87
Sep 12 23:00:00 - 23:59:59 227 2.8% 0.061.3 MB 2.1% 0.37
Sep 13 00:00:00 - 00:59:59 162 2.0% 0.04510.2 KB 0.8% 0.14
Sep 13 01:00:00 - 01:59:59 149 1.9% 0.04512.4 KB 0.8% 0.14
Sep 13 02:00:00 - 02:59:59 105 1.3% 0.03396.2 KB 0.6% 0.11
Sep 13 03:00:00 - 03:00:04 10 0.1% 2.5027.8 KB 0.0% 6.95
TOTAL: 24:00:01 8011 100.0% 0.0962.2 MB 100.0% 0.74
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 957 330 0 0 0 0 0 0 627
2twilightnode-out.news.weretis.net 149 6 0 0 0 0 0 0 143
3newsfeed.endofthelinebbs.com 88 10 0 0 0 0 0 0 78
4news.tebibyte.org 1 0 0 0 0 0 0 0 1
TOTAL: 4 1195 346 0 0 0 0 0 0 849

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 22
fido.ru.golded 6
fido.golded 5
fido.r50.sysop 5
alt.test.group 3
hispagatos.mastodon.tag.hacking 3
alt.sex.pedophilia 2
Alt.test 1
alt.bbs.files-announce 1
alt.sports.football.pro.sf-49ers 1
alt.test.9 1
alt.test.two 1
at.usenet.gruppen 1
chmurka.statystyki 1
fido.8912.local 1
fido.crimea.talk 1
fido.ru.fidonet.today 1
fido.ru.modem 1
fido.young.pioneers 1
TOTAL: 20 346

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 618
Too many newsgroups 85
User-issued cancel 84
EMP (phn path) 12
HTML Multipart 4
Too many newsgroups (meow) 2
TOTAL: 6 805

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
twilightnode-out.news.weretis.net 43
newsfeed.endofthelinebbs.com 1
TOTAL: 2 44
TOTAL: 1 44

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 10072 4419 3461 84 0 51 43%23:59:55
2sklaffkom.se 8082 902 1935 5129 0 3 11%23:59:03
3newsfeed.endofthelinebbs.com 12706 44 7782 36 0 188 0%23:59:55
4weretis.net 2629 10 2477 0 0 0 0%23:41:44
5usenet.blueworldhosting.com 7963 6 4868 0 0 27 0%23:59:42
TOTAL: 5 41452 5381 20523 5249 0 269 12%119:40:19
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org38.0 MB2.3 MB40.3 MB0.5 KB/s9.2 KB23:59:55
2sklaffkom.se1.4 MB49.6 MB51.0 MB0.6 KB/s8.7 KB23:59:03
3newsfeed.endofthelinebbs.com119.4 KB128.8 KB248.2 KB0.0 KB/s3.1 KB23:59:55
4weretis.net20.4 KB0.0 KB20.4 KB0.0 KB/s2.0 KB23:41:44
5usenet.blueworldhosting.com16.4 KB0.0 KB16.4 KB0.0 KB/s2.7 KB23:59:42
TOTAL: 539.6 MB52.0 MB91.6 MB0.2 KB/s8.8 KB119:40:19
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 29 69449.3 MB 73 0 000:28:52
TOTAL: 1 29 69449.3 MB 73 0 000:28:52

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 31 69449.3 MB 73 0 000:28:53
2*.infrawat.ch 4 00.0 KB 0 0 000:00:01
3*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
TOTAL: 3 36 69449.3 MB 73 0 000:28:57

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.61.98.95 1.842 7.475 0.00000:28:52
188.172.132.66.censys-scanner.com 0.033 0.021 0.00000:00:03
69-5-169-37.infrawat.ch 0.006 0.009 0.00000:00:00
94.154.43.21 0.004 0.012 0.00000:00:00
216.226.77.20 0.006 0.008 0.00000:00:00
194-88-98-85.infrawat.ch 0.005 0.010 0.00000:00:00
69-5-169-186.infrawat.ch 0.005 0.011 0.00000:00:00
69-5-169-241.infrawat.ch 0.005 0.009 0.00000:00:00
TOTAL: 8 1.906 7.555 0.00000:28:57

Curious NNRP explorers [Top 20]:

SystemConn
188.172.132.66.censys-scanner.com 1
194-88-98-85.infrawat.ch 1
216.226.77.20 1
69-5-169-186.infrawat.ch 1
69-5-169-241.infrawat.ch 1
69-5-169-37.infrawat.ch 1
94.154.43.21 1
TOTAL: 7 7

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

SystemConn
188.172.132.66.censys-scanner.com 1
TOTAL: 1 1

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

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
69-5-169-186.infrawat.ch 1 1
69-5-169-241.infrawat.ch 1 1
TOTAL: 2 2 4

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

HierarchyCountPct
1microsoft 324 46.7%
2alt 244 35.2%
3junk 51 7.3%
4free 24 3.5%
5linux 8 1.2%
6aus 7 1.0%
7rec 7 1.0%
8uk 5 0.7%
9it 4 0.6%
10misc 4 0.6%
11ger 3 0.4%
12comp 2 0.3%
13de 2 0.3%
14hispagatos 2 0.3%
15soc 2 0.3%
16fr 1 0.1%
17muc 1 0.1%
18nl 1 0.1%
19sci 1 0.1%
20talk 1 0.1%
TOTAL: 20 694100.0%

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

NewsgroupCount
1alt.anonymous.messages 166
2microsoft.public.windowsxp.general 163
3microsoft.public.windowsxp.help_and_support 161
4alt.test 51
5junk 51
6free.usenet 23
7aus.cars 7
8alt.arts.poetry.comments 6
9rec.arts.tv 5
10it.test 4
11linux.kernel.netdev 4
12uk.railway 4
13alt.fan.rush-limbaugh 3
14alt.russian.z1 3
15ger.ct 3
16misc.immigration.usa 3
17alt.christnet.christianlife 2
18alt.politics 2
19alt.privacy.anon-server 2
20comp.os.linux.misc 2
21de.etc.fahrzeug.auto 2
22hispagatos.hacking.news 2
23soc.culture.usa 2
24alt.buddha.short.fat.guy 1
25alt.checkmate 1
26alt.economics 1
27alt.france 1
28alt.messianic 1
29alt.politics.trump 1
30alt.tv.big-brother 1
31alt.tv.pol-incorrect 1
32alt.usenet.legends.lester-mosley 1
33fr.bio.medecine 1
34free.pt 1
35linux.debian.bugs.dist 1
36linux.debian.changes.devel 1
37linux.debian.devel 1
38linux.debian.user 1
39misc.test 1
40muc.lists.freebsd.bugs 1
41nl.test 1
42rec.arts.comics.dc.universe 1
43rec.arts.sf.tv 1
44sci.physics.relativity 1
45talk.politics.misc 1
46uk.comp.sys.mac 1
TOTAL: 46 694
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