Daily Usenet report

Oct 30 03:00:05 -- Oct 31 03:00:05

Unknown entries from news log file:

First 50 / 24149 lines (0.2%)

Oct 30 03:01:17 twilightnode nnrpd[713661]: Reading access from /usr/local/news/etc/readers.conf
Oct 30 03:01:17 twilightnode nnrpd[713661]: Auth strategy 'localhost' does not match client. Removing.
Oct 30 03:01:17 twilightnode nnrpd[713661]: 174.96.78.81 res <anonymous>
Oct 30 03:01:17 twilightnode nnrpd[713661]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 30 03:01:17 twilightnode nnrpd[713661]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 30 03:01:17 twilightnode nnrpd[713661]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 30 03:01:17 twilightnode nnrpd[713661]: 174.96.78.81 no_post anonymous-read
Oct 30 03:01:18 twilightnode nnrpd[713662]: Reading access from /usr/local/news/etc/readers.conf
Oct 30 03:01:18 twilightnode nnrpd[713662]: Auth strategy 'localhost' does not match client. Removing.
Oct 30 03:01:18 twilightnode nnrpd[713662]: 174.96.78.81 res <anonymous>
Oct 30 03:01:18 twilightnode nnrpd[713662]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 30 03:01:18 twilightnode nnrpd[713662]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 30 03:01:18 twilightnode nnrpd[713662]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 30 03:01:18 twilightnode nnrpd[713662]: 174.96.78.81 no_post anonymous-read
Oct 30 03:01:26 twilightnode innd: message repeated 2 times: [ ctlinnd command s]
Oct 30 03:04:17 twilightnode nnrpd[713900]: Reading access from /usr/local/news/etc/readers.conf
Oct 30 03:04:17 twilightnode nnrpd[713900]: Auth strategy 'localhost' does not match client. Removing.
Oct 30 03:04:17 twilightnode nnrpd[713900]: 174.96.78.81 res <anonymous>
Oct 30 03:04:17 twilightnode nnrpd[713900]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 30 03:04:17 twilightnode nnrpd[713900]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 30 03:04:17 twilightnode nnrpd[713900]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 30 03:04:17 twilightnode nnrpd[713900]: 174.96.78.81 no_post anonymous-read
Oct 30 03:04:17 twilightnode nnrpd[713901]: Reading access from /usr/local/news/etc/readers.conf
Oct 30 03:04:17 twilightnode nnrpd[713901]: Auth strategy 'localhost' does not match client. Removing.
Oct 30 03:04:17 twilightnode nnrpd[713901]: 174.96.78.81 res <anonymous>
Oct 30 03:04:17 twilightnode nnrpd[713901]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 30 03:04:17 twilightnode nnrpd[713901]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 30 03:04:17 twilightnode nnrpd[713901]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 30 03:04:17 twilightnode nnrpd[713901]: 174.96.78.81 no_post anonymous-read
Oct 30 03:05:02 twilightnode nnrpd[713993]: Reading access from /usr/local/news/etc/readers.conf
Oct 30 03:05:02 twilightnode nnrpd[713993]: Auth strategy 'localhost' does not match client. Removing.
Oct 30 03:05:02 twilightnode nnrpd[713993]: 174.96.78.81 res <anonymous>
Oct 30 03:05:02 twilightnode nnrpd[713993]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 30 03:05:02 twilightnode nnrpd[713993]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 30 03:05:02 twilightnode nnrpd[713993]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 30 03:05:02 twilightnode nnrpd[713993]: 174.96.78.81 no_post anonymous-read
Oct 30 03:05:02 twilightnode nnrpd[713995]: Reading access from /usr/local/news/etc/readers.conf
Oct 30 03:05:02 twilightnode nnrpd[713995]: Auth strategy 'localhost' does not match client. Removing.
Oct 30 03:05:02 twilightnode nnrpd[713995]: 174.96.78.81 res <anonymous>
Oct 30 03:05:02 twilightnode nnrpd[713995]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 30 03:05:02 twilightnode nnrpd[713995]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 30 03:05:02 twilightnode nnrpd[713995]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 30 03:05:02 twilightnode nnrpd[713995]: 174.96.78.81 no_post anonymous-read
Oct 30 03:05:18 twilightnode nnrpd[714002]: Reading access from /usr/local/news/etc/readers.conf
Oct 30 03:05:18 twilightnode nnrpd[714002]: Auth strategy 'localhost' does not match client. Removing.
Oct 30 03:05:18 twilightnode nnrpd[714002]: 174.96.78.81 res <anonymous>
Oct 30 03:05:18 twilightnode nnrpd[714002]: 174.96.78.81 no_match_user <anonymous> <localhost>
Oct 30 03:05:18 twilightnode nnrpd[714002]: 174.96.78.81 no_match_user <anonymous> *,!<anonymous>,!<localhost>
Oct 30 03:05:18 twilightnode nnrpd[714002]: 174.96.78.81 match_user <anonymous> <anonymous>
Oct 30 03:05:18 twilightnode nnrpd[714002]: 174.96.78.81 no_post anonymous-read

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 50629 76.5%4.7 MB 66.5%
innd 7237 10.9%967.0 KB 13.4%
inn 7070 10.7%1.2 MB 17.4%
innfeed 1279 1.9%194.0 KB 2.7%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 66216 100.0%7.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 18200 52.1%
Negative hits 9640 27.6%
Do not exist 6988 20.0%
Cache misses 86 0.2%
TOTAL: 4 34914 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.045 0.0%20 0.500 2.250 5.000
article cleanup00:00:00.082 0.0%7016 0.000 0.012 0.200
article logging00:00:00.282 0.0%7060 0.000 0.040 0.286
article parse00:00:00.104 0.0%9920 0.000 0.010 0.091
article write00:00:08.136 0.0%5706 0.689 1.426 4.840
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.426 0.0%39304 0.000 0.011 0.126
hisgrep/artcncl00:00:00.012 0.0%20 0.000 0.600 1.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.466 0.0%35048 0.070 0.156 0.397
history sync00:00:00.083 0.0%348 0.000 0.239 1.500
history write00:00:04.036 0.0%7016 0.158 0.575 1.080
idle23:59:41.129 99.9%47842 957.445 1805.550 9376.438
nntp read00:00:01.065 0.0%39371 0.000 0.027 0.108
overview write00:00:06.644 0.0%5706 0.467 1.164 5.556
perl filter00:00:15.083 0.0%7016 1.089 2.150 26.286
python filter00:00:01.273 0.0%7016 0.029 0.181 2.400
site send00:00:00.423 0.0%11380 0.000 0.037 0.131
TOTAL: 1824:00:24.289100.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.043 0.0%5986 0.000 0.007 0.228
article prepare00:00:00.003 0.0%25316 0.000 0.000 0.011
article read00:00:01.350 0.0%3982 0.091 0.339 2.000
backlog stats00:00:00.051 0.0%77461 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.560 0.0%43049 0.000 0.013 0.051
data write00:00:01.268 0.0%37422 0.000 0.034 0.110
idle23:57:01.267100.0%77461 370.722 1113.093 7003.384
status file00:00:00.242 0.0%174 0.000 1.391 4.000
TOTAL: 923:57:04.784100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:02:20.467100.0%17557 13.667 213.047 9861.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.619 0.0%41095 0.000 0.039 2.602
readart00:00:00.026 0.0%77 0.000 0.338 1.000
TOTAL: 401:02:22.112100.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 3 10729 4497 6189 43 41%47:50:36
2usenet.blueworldhosting.com 1348 6687 826 4724 1137 12%23:52:35
3newsfeed.endofthelinebbs.com 2 2747 156 2506 85 5%13:14:09
4news.tebibyte.org 1 3381 110 3269 2 3%24:00:02
5news.sklaffkom.se 44 97 95 2 0 97%10:59:02
6localhost 25 0 0 0 0 0%00:00:00
TOTAL: 6 1423 23641 5684 16690 1267 24%119:56:24
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1twilightnode-out.news.weretis.net16.3 MB0.0 KB303.1 KB16.6 MB 98%3.7 KB
2usenet.blueworldhosting.com4.8 MB0.0 KB1.5 MB6.3 MB 76%3.3 KB
3newsfeed.endofthelinebbs.com1.9 MB0.0 KB136.6 KB2.0 MB 93%8.6 KB
4news.tebibyte.org377.6 KB0.0 KB2.4 KB379.9 KB 99%3.4 KB
5news.sklaffkom.se300.8 KB0.0 KB0.0 KB300.8 KB100%3.2 KB
6localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 623.6 MB0.0 KB1.9 MB25.5 MB 92%3.8 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 30 03:00:05 - 03:59:59 114 2.0% 0.03582.1 KB 2.3% 0.16
Oct 30 04:00:00 - 04:59:59 65 1.1% 0.02347.1 KB 1.4% 0.10
Oct 30 05:00:00 - 05:59:59 90 1.6% 0.03402.2 KB 1.6% 0.11
Oct 30 06:00:00 - 06:59:59 91 1.6% 0.03333.1 KB 1.3% 0.09
Oct 30 07:00:00 - 07:59:59 157 2.7% 0.04503.6 KB 2.0% 0.14
Oct 30 08:00:00 - 08:59:59 183 3.2% 0.051011.2 KB 4.0% 0.28
Oct 30 09:00:00 - 09:59:59 331 5.8% 0.091.2 MB 4.7% 0.33
Oct 30 10:00:00 - 10:59:59 351 6.1% 0.101.5 MB 5.8% 0.41
Oct 30 11:00:00 - 11:59:59 333 5.8% 0.091.4 MB 5.8% 0.41
Oct 30 12:00:00 - 12:59:59 404 7.1% 0.112.0 MB 7.9% 0.56
Oct 30 13:00:00 - 13:59:59 327 5.7% 0.091.2 MB 4.8% 0.34
Oct 30 14:00:00 - 14:59:59 365 6.4% 0.101.9 MB 7.7% 0.55
Oct 30 15:00:00 - 15:59:59 343 6.0% 0.101.2 MB 4.8% 0.34
Oct 30 16:00:00 - 16:59:59 372 6.5% 0.102.1 MB 8.3% 0.59
Oct 30 17:00:00 - 17:59:59 353 6.2% 0.101.3 MB 5.3% 0.38
Oct 30 18:00:00 - 18:59:59 290 5.1% 0.081.1 MB 4.4% 0.31
Oct 30 19:00:00 - 19:59:59 277 4.8% 0.081.4 MB 5.8% 0.41
Oct 30 20:00:00 - 20:59:59 206 3.6% 0.06709.3 KB 2.8% 0.20
Oct 30 21:00:00 - 21:59:59 234 4.1% 0.07840.5 KB 3.3% 0.23
Oct 30 22:00:00 - 22:59:59 220 3.9% 0.061.2 MB 5.0% 0.35
Oct 30 23:00:00 - 23:59:59 240 4.2% 0.071.0 MB 4.2% 0.30
Oct 31 00:00:00 - 00:59:59 171 3.0% 0.05629.6 KB 2.5% 0.17
Oct 31 01:00:00 - 01:59:59 81 1.4% 0.02322.9 KB 1.3% 0.09
Oct 31 02:00:00 - 02:59:59 115 2.0% 0.03848.4 KB 3.3% 0.24
Oct 31 03:00:00 - 03:00:05 1 0.0% 0.202.0 KB 0.0% 0.40
TOTAL: 24:00:00 5714 100.0% 0.0724.9 MB 100.0% 0.30
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1137 344 0 0 0 0 0 0 793
2newsfeed.endofthelinebbs.com 133 0 0 0 0 0 0 0 133
3twilightnode-out.news.weretis.net 86 18 0 0 0 0 0 0 68
TOTAL: 3 1356 362 0 0 0 0 0 0 994

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.test.ping 288
hispagatos.hacking.ransomware 40
hispagatos.mastodon.tag.hacking 11
alt.ads.forsale 3
alt.test.test.jojo 3
fr.misc.finance 3
alt.ads 1
alt.bbs.files-announce 1
alt.religion.christian.last-days 1
alt.religion.end-times.prophecies 1
alt.sports.football.pro.houston-oilers 1
alt.sports.football.pro.la-raiders 1
alt.sports.football.pro.ne-patriots 1
alt.sports.football.pro.tennessee 1
alt.test.9 1
chmurka.statystyki 1
fr.misc.finance.immobilier 1
hamster.de.tools 1
hispagatos.test 1
israel.likud 1
TOTAL: 20 362

Perl filter (innd) [Top 20]:

ReasonCount
EMP (md5) 808
Too many newsgroups 116
User-issued cancel 19
HTML Multipart 6
Binary: misplaced binary 1
TOTAL: 5 950

Miscellaneous innd statistics [Top 10]:

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

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tebibyte.org 7289 2243 3304 134 0 38 30%23:59:56
2sklaffkom.se 5758 1093 1785 2804 0 0 18%23:59:41
3newsfeed.endofthelinebbs.com 10280 56 5319 16 0 283 0%23:59:56
4weretis.net 1310 10 1230 0 0 0 0%23:33:57
5usenet.blueworldhosting.com 7625 0 4494 0 0 10 0%23:59:33
TOTAL: 5 32262 3402 16132 2954 0 331 10%119:33:03
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tebibyte.org6.3 MB2.6 MB8.9 MB0.1 KB/s3.9 KB23:59:56
2sklaffkom.se1.8 MB16.6 MB18.3 MB0.2 KB/s4.8 KB23:59:41
3newsfeed.endofthelinebbs.com189.6 KB260.9 KB450.5 KB0.0 KB/s6.3 KB23:59:56
4weretis.net29.4 KB0.0 KB29.4 KB0.0 KB/s2.9 KB23:33:57
5usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:33
TOTAL: 58.3 MB19.5 MB27.8 MB0.1 KB/s4.5 KB119:33:03
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1174.96.78.813436 77514.7 KB 39 0 001:01:56
TOTAL: 13436 77514.7 KB 39 0 001:01:56

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved3445 77514.7 KB 39 0 001:02:15
2*.infrawat.ch 2 00.0 KB 0 0 000:00:00
3*.66.censys-scanner.com 1 00.0 KB 0 0 000:00:04
4*.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
TOTAL: 43449 77514.7 KB 39 0 001:02:21

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
174.96.78.81 17.461 30.446 0.00001:01:56
20.118.227.208 0.006 0.010 0.00000:00:09
188.166.116.235 0.033 0.033 0.00000:00:08
78.159.132.66.censys-scanner.com 0.031 0.007 0.00000:00:04
216.226.77.30 0.003 0.012 0.00000:00:00
159.211.203.35.bc.googleusercontent.com 0.006 0.008 0.00000:00:00
5-226-140-47.infrawat.ch 0.003 0.012 0.00000:00:00
5-226-140-115.infrawat.ch 0.003 0.007 0.00000:00:00
TOTAL: 8 17.546 30.535 0.00001:02:21

Curious NNRP explorers [Top 20]:

SystemConn
188.166.116.235 7
159.211.203.35.bc.googleusercontent.com 1
20.118.227.208 1
216.226.77.30 1
5-226-140-115.infrawat.ch 1
5-226-140-47.infrawat.ch 1
78.159.132.66.censys-scanner.com 1
TOTAL: 7 13

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

SystemConn
188.166.116.235 35
159.211.203.35.bc.googleusercontent.com 4
78.159.132.66.censys-scanner.com 1
TOTAL: 3 40

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

CommandCount
Accept-Encoding: gzip 2
GET / HTTP/1.1 2
Host: 172.234.115.63:119 2
#007Wk#025S?+c?9?#021[#005?#022?#024h?A?#010SDK? 1
#023#003#023#001#023#002#001 1
#026#003#001#005?#001 1
#035?3!}?#034?z#007caC?C_Lw0?2#013?#031g?B? 1
$4 1
'?7?h?l?a?X#014N#023 1
*1 1
=#030#025?Z?7X?BGdJm#014x2?l?G?#003Wp~\?}#014?T?x0?Ue... 1
?H#020?w?#003?y?#026?#011ai?Rli?#030?#025?#037?#004?... 1
?J?7?#026oiX<c?aK?GJl?]? :?#027?z?$Rg$?6... 1
Accept: */* 1
EHLO www.censys.io 1
PING 1
User-Agent: Hello from Palo Alto Network... 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
app.name=s:Workbench 1
app.version=s:3.7.44 1
TOTAL: 37 40

NNRP client timeouts [Top 20]:

SystemConnPeer
188.166.116.235 1 3
5-226-140-115.infrawat.ch 1 1
TOTAL: 2 2 5

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

HierarchyCountPct
1linux 22 28.6%
2junk 21 27.3%
3free 6 7.8%
4alt 5 6.5%
5aus 3 3.9%
6fr 3 3.9%
7it 3 3.9%
8comp 2 2.6%
9talk 2 2.6%
10de 1 1.3%
11dk 1 1.3%
12eternal-september 1 1.3%
13ger 1 1.3%
14grisbi 1 1.3%
15pl 1 1.3%
16rec 1 1.3%
17sci 1 1.3%
18soc 1 1.3%
19uk 1 1.3%
TOTAL: 19 77100.0%

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

NewsgroupCount
1junk 21
2linux.debian.changes.devel 14
3free.pt 4
4aus.cars 3
5it.hobby.cucina 3
6linux.kernel.netdev 3
7free.usenet 2
8linux.debian.bugs.dist 2
9linux.kernel.git 2
10talk.politics.guns 2
11alt.atheism 1
12alt.bible 1
13alt.bible.prophecy 1
14alt.christnet.bible 1
15alt.fan.rush-limbaugh 1
16comp.emacs 1
17comp.sys.amiga.misc 1
18de.soc.arbeitslos 1
19dk.politik 1
20eternal-september.test 1
21fr.rec.bricolage 1
22fr.soc.politique 1
23fr.test 1
24ger.ct 1
25grisbi.test 1
26linux.debian.devel 1
27pl.soc.prawo 1
28rec.food.cooking 1
29sci.astro 1
30soc.culture.israel 1
31uk.legal.moderated 1
TOTAL: 31 77
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