Daily Usenet report for news.niel.me

Oct 27 04:15:01 -- Oct 28 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 27 06:18:33 rpi-studio innd: filter: No Cancel-Key[sha1:8kOnlwfqcdXM3xenMYNm3GMqn08= sha256:fnC3fuu+JmUKl79fEQQZYN3h0Z9+NqiUikJHPHvsqs4=] matches Cancel-Lock[sha1:yaR2LAiPW8EWGMSeWAds8rW+shU= sha256:jx97duDgUnTTRNGBhh4rbafGYp1JFeY4rgnvvjxtwb4=] target=<11bpc50$1822k$1@dont-email.me>
Oct 27 13:08:21 rpi-studio innd: filter: No Cancel-Key[sha1:C8jGV7DfgffMoF7NzQSAFQ3i138= sha256:Jq2wLTZhbraJInXqWdENtnZ4VIl8a6MxQNp+22zqGzI=] matches Cancel-Lock[sha1:pY4Aax2NtSBPN8sIL0R2vGz3aUo= sha256:pZ9Pjtvqm7HMgaEX6CC/ElSylpAJ6i7LFIIzww80cTA=] target=<mn.db037eaa80da2ab9.119180@invalid.pasdepub>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2732 32.8%468.5 KB 36.7%
innd 2056 24.7%361.7 KB 28.3%
innfeed 1895 22.7%274.0 KB 21.5%
nnrpd 1650 19.8%172.7 KB 13.5%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8335 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 9497 49.5%
Negative hits 6960 36.3%
Do not exist 2721 14.2%
Cache misses 1 0.0%
TOTAL: 4 19179 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.005 0.0%5 1.000 1.000 1.000
article cancel00:00:00.000 0.0%6 0.000 0.000 0.000
article cleanup00:00:00.059 0.0%2723 0.000 0.022 0.143
article logging00:00:00.190 0.0%2724 0.000 0.070 0.400
article parse00:00:00.595 0.0%7641 0.000 0.078 0.222
article write00:00:01.035 0.0%2008 0.000 0.515 1.250
artlog/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%5 0.000 0.000 0.000
data move00:00:00.241 0.0%23007 0.000 0.010 0.058
hisgrep/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%5 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%7 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%5 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.328 0.0%19190 0.000 0.017 0.083
history sync00:00:00.062 0.0%400 0.000 0.155 0.667
history write00:00:00.564 0.0%2723 0.000 0.207 0.714
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:29.795100.0%24429 948.283 3538.000 15799.211
nntp read00:00:00.715 0.0%23669 0.000 0.030 0.086
overview write00:00:00.672 0.0%2008 0.000 0.335 3.250
perl filter00:00:13.033 0.0%2723 2.125 4.786 16.667
python filter00:00:00.014 0.0%2723 0.000 0.005 0.143
site send00:00:00.712 0.0%4080 0.000 0.175 0.500
TOTAL: 24:01:06.68024:00:48.020100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.015 0.0%2007 0.000 0.007 0.333
article prepare00:00:00.000 0.0%40 0.000 0.000 0.000
article read00:00:00.010 0.0%10 0.000 1.000 8.000
backlog stats00:00:00.167 0.0%24494 0.000 0.007 0.027
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.360 0.0%12395 0.000 0.029 0.143
data write00:00:00.643 0.0%10495 0.000 0.061 0.143
idle23:49:59.175100.0%24494 1357.785 3502.865 10012.767
status file00:00:04.019 0.0%313 0.000 12.840 84.000
TOTAL: 23:50:07.81323:50:04.389100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:57.037 43.8%1468 9.400 38.854 10038.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.103 0.1%3323 0.000 0.031 0.500
TOTAL: 00:02:10.23400:00:57.140 43.9%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 171

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.nntp4.net 2 2918 575 1655 688 19%26:15:49
2feed-out.gegeweb.org 2 1996 558 1438 0 27%23:59:56
3news.samoylyk.net 3 1896 505 1386 5 26%22:27:47
4nntp.terraraq.uk 5 1719 226 1487 6 13%26:57:32
5news.glou.org 7 2681 200 2367 114 7%44:10:12
6usenet.pasdenom.info 9 1236 40 1193 3 3%24:38:32
7gegeweb-out.news.tnetconsulting.net 5 1235 6 1229 0 0%25:33:11
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 58 13681 2110 10755 816 15%194:02:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net2.4 MB0.0 KB7.8 MB10.2 MB 23%8.2 KB
2news.samoylyk.net2.3 MB0.0 KB19.5 KB2.3 MB 99%4.7 KB
3feed-out.gegeweb.org1.8 MB0.0 KB0.0 KB1.8 MB100%3.4 KB
4nntp.terraraq.uk763.0 KB0.0 KB13.3 KB776.3 KB 98%3.3 KB
5news.glou.org604.6 KB0.0 KB478.5 KB1.1 MB 55%3.4 KB
6usenet.pasdenom.info81.7 KB0.0 KB3.6 KB85.3 KB 95%2.0 KB
7gegeweb-out.news.tnetconsulting.net16.3 KB0.0 KB0.0 KB16.3 KB100%2.7 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 88.0 MB0.0 KB8.3 MB16.3 MB 48%5.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 27 04:15:01 - 04:59:59 27 1.3% 0.01116.7 KB 1.4% 0.04
Oct 27 05:00:00 - 05:59:59 19 0.9% 0.0166.3 KB 0.8% 0.02
Oct 27 06:00:00 - 06:59:59 29 1.4% 0.01111.9 KB 1.3% 0.03
Oct 27 07:00:00 - 07:59:59 41 2.0% 0.01213.7 KB 2.5% 0.06
Oct 27 08:00:00 - 08:59:59 34 1.7% 0.01148.1 KB 1.8% 0.04
Oct 27 09:00:00 - 09:59:59 68 3.4% 0.02228.5 KB 2.7% 0.06
Oct 27 10:00:00 - 10:59:59 63 3.1% 0.02230.2 KB 2.7% 0.06
Oct 27 11:00:00 - 11:59:59 84 4.2% 0.02352.7 KB 4.2% 0.10
Oct 27 12:00:00 - 12:59:59 59 2.9% 0.02200.5 KB 2.4% 0.06
Oct 27 13:00:00 - 13:59:59 101 5.0% 0.03299.4 KB 3.5% 0.08
Oct 27 14:00:00 - 14:59:59 93 4.6% 0.03290.0 KB 3.4% 0.08
Oct 27 15:00:00 - 15:59:59 141 7.0% 0.04546.2 KB 6.5% 0.15
Oct 27 16:00:00 - 16:59:59 88 4.4% 0.02597.5 KB 7.1% 0.17
Oct 27 17:00:00 - 17:59:59 124 6.2% 0.03451.7 KB 5.4% 0.13
Oct 27 18:00:00 - 18:59:59 150 7.5% 0.04479.8 KB 5.7% 0.13
Oct 27 19:00:00 - 19:59:59 118 5.9% 0.03499.8 KB 5.9% 0.14
Oct 27 20:00:00 - 20:59:59 113 5.6% 0.03362.8 KB 4.3% 0.10
Oct 27 21:00:00 - 21:59:59 132 6.6% 0.04753.7 KB 8.9% 0.21
Oct 27 22:00:00 - 22:59:59 83 4.1% 0.02316.1 KB 3.7% 0.09
Oct 27 23:00:00 - 23:59:59 132 6.6% 0.04700.1 KB 8.3% 0.19
Oct 28 00:00:00 - 00:59:59 102 5.1% 0.03610.8 KB 7.2% 0.17
Oct 28 01:00:00 - 01:59:59 77 3.8% 0.02307.1 KB 3.6% 0.09
Oct 28 02:00:00 - 02:59:59 49 2.4% 0.01171.6 KB 2.0% 0.05
Oct 28 03:00:00 - 03:59:59 61 3.0% 0.02295.4 KB 3.5% 0.08
Oct 28 04:00:00 - 04:15:01 18 0.9% 0.0289.3 KB 1.1% 0.10
TOTAL: 24:00:00 2006 100.0% 0.028.2 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 643 513 0 0 0 0 0 0 130
2news.glou.org 56 0 0 0 0 0 0 0 56
3nntp.terraraq.uk 6 0 0 0 0 0 0 0 6
4gegeweb-out.news.tnetconsulting.net 5 0 0 0 0 0 0 0 5
5usenet.pasdenom.info 3 0 0 0 0 0 0 0 3
6news.samoylyk.net 2 0 0 0 0 0 0 0 2
TOTAL: 6 715 513 0 0 0 0 0 0 202

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 392
linux.kernel.git 121
TOTAL: 2 513

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 107
Bad path (news.giganews.com.POSTED) 80
EMP (phn path) 6
Cancels abusifs 5
Too many newsgroups (meow) 2
No Cancel-Key matches Cancel-Lock. target=<11bpc50$1822k$1@dont-email.me> 1
TOTAL: 6 201

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
gegeweb-out.news.tnetconsulting.net 1
TOTAL: 1 1
TOTAL: 1 1

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1519 3 1457 0 0 0 0%23:59:24
2news.nntp4.net 1587 2 1516 0 0 0 0%23:25:05
3news.tnetconsulting.net 3323 1 1998 3 0 11 0%23:59:57
4news.samoylyk.net 1588 1 1364 0 0 0 0%23:47:03
5nntp.terraraq.uk 1017 0 963 0 0 0 0%23:32:20
6news.aioe.org 0 0 0 0 0 1556 0%24:00:00
7i2pn.org 0 0 0 0 0 1999 0%24:00:00
8news.pasdenom.info 1481 0 1430 0 0 0 0%23:36:26
TOTAL: 8 10515 7 8728 3 0 3566 0%190:20:15
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org14.1 KB0.0 KB14.1 KB0.0 KB/s4.7 KB23:59:24
2news.nntp4.net7.1 KB0.0 KB7.1 KB0.0 KB/s3.5 KB23:25:05
3news.samoylyk.net2.8 KB0.0 KB2.8 KB0.0 KB/s2.8 KB23:47:03
4news.tnetconsulting.net2.4 KB7.1 KB9.5 KB0.0 KB/s2.4 KB23:59:57
5nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:32:20
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:36:26
TOTAL: 826.4 KB7.1 KB33.5 KB0.0 KB/s3.4 KB190:20:15
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1187.186.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:10
22a01:4020:31:0:102::103 1 00.0 KB 0 0 000:00:00
3190.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
4r3-210-d2.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
5r4-187-bb.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
6r4-179-b3.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
7moyer.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
8r4-172-ac.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
9r5-30-1e.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
1045-133-173-22.infrawat.ch 1 00.0 KB 0 0 000:00:00
1145-133-173-113.infrawat.ch 1 00.0 KB 0 0 000:00:00
12183.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
13r5-221-dd.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
14nur.probe.onyphe.net 1 00.0 KB 0 0 000:00:00
15gale.probe.onyphe.net 1 00.0 KB 0 0 000:00:00
16donell.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
17r4-249-f9.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
18203.55.131.3 1 00.0 KB 0 0 000:00:00
19147.185.133.80 2 00.0 KB 0 0 000:00:35
2069-5-169-253.infrawat.ch 1 00.0 KB 0 0 000:00:00
21205.210.31.10 1 00.0 KB 0 0 000:00:00
225-252-83-92.infrawat.ch 1 00.0 KB 0 0 000:00:00
2366-228-62-150.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:03
24mail.gegeweb.eu 288 00.0 KB 0 0 000:00:28
2534.211.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:49
2697.79.29.163 1 00.0 KB 0 0 000:00:01
27r3-197-c5.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
28165.154.182.221 3 00.0 KB 0 0 000:00:12
292a01:4020:1:1:102::26d 1 00.0 KB 0 0 000:00:00
30r3-253-fd.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
31azpdsg7sgux2.stretchoid.com 1 00.0 KB 0 0 000:00:09
32r3-200-c8.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
TOTAL: 32 323 00.0 KB 0 0 000:02:52

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.probe.onyphe.net 4 00.0 KB 0 0 000:00:07
2unresolved 8 00.0 KB 0 0 000:00:49
3*.211.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:49
4*.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
5*.186.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:10
6*.stretchoid.com 1 00.0 KB 0 0 000:00:09
7*.gegeweb.eu 288 00.0 KB 0 0 000:00:28
8*.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:03
9? 2 00.0 KB 0 0 000:00:00
10*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
11*.monitoring.internet-measurement.com 10 00.0 KB 0 0 000:00:08
12*.infrawat.ch 4 00.0 KB 0 0 000:00:00
TOTAL: 12 323 00.0 KB 0 0 000:02:52

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
34.211.203.35.bc.googleusercontent.com 0.239 0.064 0.00000:00:49
147.185.133.80 0.347 0.024 0.00000:00:35
mail.gegeweb.eu 5.280 4.707 1.75400:00:28
165.154.182.221 0.056 0.041 0.00000:00:12
187.186.132.66.censys-scanner.com 0.038 0.013 0.00000:00:10
azpdsg7sgux2.stretchoid.com 0.016 0.036 0.00000:00:09
66-228-62-150.ip.linodeusercontent.com 0.011 0.011 0.00000:00:03
190.172.132.66.censys-scanner.com 0.022 0.015 0.00000:00:03
moyer.probe.onyphe.net 0.043 0.004 0.00000:00:03
donell.probe.onyphe.net 0.008 0.015 0.00000:00:03
r4-172-ac.monitoring.internet-measurement.com 0.095 0.016 0.00000:00:03
r4-179-b3.monitoring.internet-measurement.com 0.008 0.020 0.00000:00:03
r5-30-1e.monitoring.internet-measurement.com 0.022 0.022 0.00000:00:01
97.79.29.163 0.037 0.016 0.00000:00:01
nur.probe.onyphe.net 0.011 0.011 0.00000:00:00
183.149.216.162.bc.googleusercontent.com 0.077 0.019 0.00000:00:00
gale.probe.onyphe.net 0.038 0.008 0.00000:00:00
205.210.31.10 0.035 0.016 0.00000:00:00
45-133-173-22.infrawat.ch 0.009 0.014 0.00000:00:00
203.55.131.3 0.029 0.018 0.00000:00:00
TOTAL: 31 6.718 5.271 1.75400:02:52

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 13
TOTAL: 1 13

NNRP unrecognized commands (by host):

SystemConn
66-228-62-150.ip.linodeusercontent.com 5
183.149.216.162.bc.googleusercontent.com 4
34.211.203.35.bc.googleusercontent.com 4
147.185.133.80 4
nur.probe.onyphe.net 2
165.154.182.221 2
190.172.132.66.censys-scanner.com 1
TOTAL: 7 22

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 4
Accept: */* 3
Host: 45.13.105.36:563 3
Accept-Encoding: gzip 2
User-Agent: curl/7.68.0 2
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 1
EHLO www.censys.io 1
User-Agent: Mozilla/5.0 zgrab/0.x 1
#026#003#001 1
Host: 45.13.105.36 1
À#024 1
#026#003#003#002a#001 1
User-Agent: Hello from Palo Alto Network... 1
TOTAL: 13 22

NNRP client timeouts [Top 20]:

SystemConnPeer
66-228-62-150.ip.linodeusercontent.com 1 1
34.211.203.35.bc.googleusercontent.com 1 2
147.185.133.80 1 2
2a01:4020:1:1:102::26d 1 1
45-133-173-22.infrawat.ch 1 1
TOTAL: 5 5 10
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me