Daily Usenet report for news.niel.me

Oct 7 04:15:01 -- Oct 8 04:15:01

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Oct 7 12:07:57 rpi-studio innd: filter: No Cancel-Key[sha1:787h3l4yXqIboyO+4pd37hDoVQw= sha256:H9rJk1C3GO/SfsOQqnaOYtCEJDOKDZXk1vRdgiXvQV8=] matches Cancel-Lock[sha1:xrsEsDmmnce4v3OHKnsaLRLEnfM= sha256:dsjiFveZrOf3qBIojxSOeaghiOzUa7XvLPsDZ5uSxBc=] target=<11a4pl3$2k5as$1@dont-email.me>
Oct 7 12:09:21 rpi-studio innd: filter: No Cancel-Key[sha1:p0aeprc+hEhqzmnzkwj+oc3wtDo= sha256:Q5ogtMPgvZpJ6UlnpA3ARCXDJWWjbiJ3B/R3VKtHEJc=] matches Cancel-Lock[sha1:PC7xSS3Byauu4ioSNfx1Mprfon0= sha256:RYumuTfIuBHTDk/d3oKKf0LyZ9HA+ktSfVfA4ydFcFs=] target=<11a4pnr$2k5as$2@dont-email.me>
Oct 7 13:12:06 rpi-studio innd: filter: No Cancel-Key[sha1:UCsrWmNSUFZheHJoeW13LzZzbG5UejZHMnA4PQ==#015#012#011sha1:GRksy1tT0W+whUJFI3dD23dxNLo= sha256:NXpvpNkFiyFsrP2fRrb7UF0TAH/NW1Q6q3MO02DU+iY=] matches Cancel-Lock[sha1:WXYS0UD7QY6xesceGadMei35hpE=] target=<11a599b$27sq$1@csiph.com>
Oct 7 21:14:18 rpi-studio innd: filter: No Cancel-Key[sha1:KekguSiAkAFJZVkqgkdLBM74DMk= sha256:U/lYAxtBXDgsyx/2NTuJvyyYsV0IDP+CJXE3GAGWxR4=] matches Cancel-Lock[sha1:2SlC44qu59+xYTCUVLIHyApPV2Q= sha256:XuUTMxdAEJOM6hz1BTr4OWWiZcJXFNU9vEeBSaNCY/M=] target=<g2vcclt8c3f5529d7hct2bko14hsjmom2m@kgbh.org>
Oct 8 04:10:04 rpi-studio innd: filter: No Cancel-Key[sha1:zoHRveLVtpCouIms0IsXcO/7vwk= sha256:jwZFmhgBT2F0/I44dHUFy9JNq5hkldrHytHJuVsxxdU=] matches Cancel-Lock[sha1:IZNRT4jFUyBm2l6nivF4X92ejSA= sha256:eGl7mH0Cu8e3IpAtLCAFVTKjRiAtr8OuFp7oGA/r2QA=] target=<11a6s9u$1groq$1@gwaiyur.mb-net.net>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2711 31.1%472.2 KB 35.1%
nnrpd 2121 24.3%248.8 KB 18.5%
innd 2010 23.0%349.7 KB 26.0%
innfeed 1881 21.6%273.5 KB 20.3%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8725 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 9912 51.2%
Negative hits 6757 34.9%
Do not exist 2681 13.9%
Cache misses 5 0.0%
TOTAL: 4 19355 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.010 0.0%8 1.000 1.250 2.000
article cancel00:00:00.007 0.0%11 0.000 0.636 1.000
article cleanup00:00:00.068 0.0%2686 0.000 0.025 0.167
article logging00:00:00.199 0.0%2690 0.000 0.074 0.333
article parse00:00:00.505 0.0%6846 0.000 0.074 0.429
article write00:00:01.136 0.0%2073 0.000 0.548 1.222
artlog/artcncl00:00:00.002 0.0%11 0.000 0.182 0.500
artlog/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:00:00.150 0.0%22305 0.000 0.007 0.036
hisgrep/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%8 0.000 0.125 0.500
hisgrep/perl00:00:00.000 0.0%14 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.327 0.0%19377 0.000 0.017 0.080
history sync00:00:00.055 0.0%368 0.000 0.149 1.000
history write00:00:00.539 0.0%2686 0.000 0.201 0.600
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:28.157100.0%23839 1685.871 3625.494 23106.808
nntp read00:00:00.710 0.0%23152 0.000 0.031 0.125
overview write00:00:00.716 0.0%2073 0.000 0.345 1.556
perl filter00:00:15.202 0.0%2686 2.720 5.660 24.333
python filter00:00:00.017 0.0%2686 0.000 0.006 0.200
site send00:00:00.979 0.0%4197 0.000 0.233 0.750
TOTAL: 24:01:07.11524:00:48.780100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.017 0.0%2082 0.000 0.008 0.167
article prepare00:00:00.002 0.0%36 0.000 0.056 0.250
article read00:00:00.004 0.0%9 0.000 0.444 3.000
backlog stats00:00:00.180 0.0%25532 0.000 0.007 0.042
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.326 0.0%13092 0.000 0.025 0.082
data write00:00:00.692 0.0%11039 0.000 0.063 0.188
idle23:57:07.604100.0%25532 1405.054 3377.237 10561.825
status file00:00:06.644 0.0%293 0.000 22.676 82.000
TOTAL: 23:57:19.02223:57:15.469100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:39.531 33.0%1492 7.600 26.495 9484.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.118 0.1%3418 0.000 0.035 1.000
TOTAL: 00:01:59.74400:00:39.649 33.1%----

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
1feed-out.gegeweb.org 4 2028 723 1305 0 35%23:10:14
2news.nntp4.net 2 2687 495 1657 535 18%23:59:11
3news.samoylyk.net 3 2148 473 1674 1 22%23:54:47
4nntp.terraraq.uk 3 1548 186 1360 2 12%23:11:49
5news.glou.org 3 1615 109 1436 70 6%23:54:50
6usenet.pasdenom.info 10 943 37 904 2 3%22:04:48
7gegeweb-out.news.tnetconsulting.net 3 1488 33 1452 3 2%23:10:27
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 53 12457 2056 9788 613 16%163:26:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net2.6 MB0.0 KB5.1 KB2.6 MB 99%5.7 KB
2feed-out.gegeweb.org2.4 MB0.0 KB0.0 KB2.4 MB100%3.4 KB
3news.nntp4.net1.9 MB0.0 KB5.2 MB7.1 MB 26%7.0 KB
4nntp.terraraq.uk557.8 KB0.0 KB3.9 KB561.6 KB 99%3.0 KB
5news.glou.org372.9 KB0.0 KB222.4 KB595.3 KB 62%3.3 KB
6gegeweb-out.news.tnetconsulting.net118.8 KB0.0 KB9.1 KB127.9 KB 92%3.6 KB
7usenet.pasdenom.info88.6 KB0.0 KB2.4 KB91.1 KB 97%2.3 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 88.0 MB0.0 KB5.4 MB13.4 MB 59%5.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 7 04:15:01 - 04:59:59 26 1.3% 0.0179.8 KB 1.0% 0.03
Oct 7 05:00:00 - 05:59:59 43 2.1% 0.01185.8 KB 2.3% 0.05
Oct 7 06:00:00 - 06:59:59 26 1.3% 0.01138.3 KB 1.7% 0.04
Oct 7 07:00:00 - 07:59:59 48 2.3% 0.01203.3 KB 2.5% 0.06
Oct 7 08:00:00 - 08:59:59 51 2.5% 0.01171.6 KB 2.1% 0.05
Oct 7 09:00:00 - 09:59:59 108 5.2% 0.03536.5 KB 6.5% 0.15
Oct 7 10:00:00 - 10:59:59 81 3.9% 0.02317.3 KB 3.9% 0.09
Oct 7 11:00:00 - 11:59:59 77 3.7% 0.02232.8 KB 2.8% 0.06
Oct 7 12:00:00 - 12:59:59 110 5.3% 0.03385.7 KB 4.7% 0.11
Oct 7 13:00:00 - 13:59:59 119 5.7% 0.03480.1 KB 5.8% 0.13
Oct 7 14:00:00 - 14:59:59 104 5.0% 0.03368.3 KB 4.5% 0.10
Oct 7 15:00:00 - 15:59:59 134 6.5% 0.04517.4 KB 6.3% 0.14
Oct 7 16:00:00 - 16:59:59 103 5.0% 0.03399.5 KB 4.9% 0.11
Oct 7 17:00:00 - 17:59:59 114 5.5% 0.03401.5 KB 4.9% 0.11
Oct 7 18:00:00 - 18:59:59 109 5.3% 0.03481.1 KB 5.9% 0.13
Oct 7 19:00:00 - 19:59:59 119 5.7% 0.03428.5 KB 5.2% 0.12
Oct 7 20:00:00 - 20:59:59 115 5.5% 0.03425.6 KB 5.2% 0.12
Oct 7 21:00:00 - 21:59:59 129 6.2% 0.04486.8 KB 5.9% 0.14
Oct 7 22:00:00 - 22:59:59 123 5.9% 0.03529.2 KB 6.4% 0.15
Oct 7 23:00:00 - 23:59:59 102 4.9% 0.03456.8 KB 5.6% 0.13
Oct 8 00:00:00 - 00:59:59 70 3.4% 0.02380.2 KB 4.6% 0.11
Oct 8 01:00:00 - 01:59:59 61 2.9% 0.02254.2 KB 3.1% 0.07
Oct 8 02:00:00 - 02:59:59 40 1.9% 0.01161.2 KB 2.0% 0.04
Oct 8 03:00:00 - 03:59:59 45 2.2% 0.01154.3 KB 1.9% 0.04
Oct 8 04:00:00 - 04:15:01 17 0.8% 0.0243.9 KB 0.5% 0.05
TOTAL: 24:00:00 2074 100.0% 0.028.0 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 535 436 0 0 0 0 0 0 99
2news.glou.org 72 0 0 0 0 0 0 0 72
3gegeweb-out.news.tnetconsulting.net 5 0 0 0 0 0 0 0 5
4nntp.terraraq.uk 3 0 0 0 0 0 0 0 3
5usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
6news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 6 618 436 0 0 0 0 0 0 182

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 366
linux.kernel.git 70
TOTAL: 2 436

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 97
Bad path (news.giganews.com.POSTED) 76
Cancels abusifs 2
Cancel of non-existing ID <nim9gaF6s50U1@mid.individual.net> 1
No Cancel-Key matches Cancel-Lock. target=<11a599b$27sq$1@csiph.com> 1
No Cancel-Key matches Cancel-Lock. target=<g2vcclt8c3f5529d7hct2bko14hsjmom2m@kgbh.org> 1
TOTAL: 6 178

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
gegeweb-out.news.tnetconsulting.net 2
news.glou.org 2
TOTAL: 2 4
TOTAL: 1 4

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 3644 4 2067 2 0 12 0%23:46:03
2news.pasdenom.info 1609 2 1558 0 0 0 0%23:44:37
3news.samoylyk.net 1733 1 1556 0 0 0 0%23:44:37
4news.gegeweb.org 1437 0 1334 0 0 0 0%23:45:53
5nntp.terraraq.uk 1083 0 1030 0 0 0 0%23:39:11
6news.aioe.org 0 0 0 0 0 1638 0%23:59:59
7news.nntp4.net 1621 0 1574 0 0 0 0%23:25:47
8i2pn.org 0 0 0 0 0 2070 0%23:59:59
TOTAL: 8 11127 7 9119 2 0 3720 0%190:06:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.pasdenom.info7.4 KB0.0 KB7.4 KB0.0 KB/s3.7 KB23:44:37
2news.tnetconsulting.net7.1 KB4.7 KB11.8 KB0.0 KB/s2.0 KB23:46:03
3news.samoylyk.net2.8 KB0.0 KB2.8 KB0.0 KB/s2.8 KB23:44:37
4news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:45:53
5nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:39:11
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
7news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:25:47
8i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
TOTAL: 817.3 KB4.7 KB22.0 KB0.0 KB/s2.4 KB190:06:06
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
145.82.78.104 2 00.0 KB 0 0 000:00:05
2r5-203-cb.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
3o009.scanner.modat.io 1 00.0 KB 0 0 000:00:29
4147.185.132.68 1 00.0 KB 0 0 000:00:00
58.216.7.175 1 00.0 KB 0 0 000:00:03
666.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
7r3-246-f6.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
82a01:4020:1:1:102::76f 1 00.0 KB 0 0 000:00:00
9r5-17-11.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
1069-164-214-31.ip.linodeusercontent.com 11 00.0 KB 0 0 000:00:00
11r4-71-47.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
12r5-4-4.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
13104.152.52.108 1 00.0 KB 0 0 000:00:00
14147.185.133.78 1 00.0 KB 0 0 000:00:03
1587.251.64.19 2 00.0 KB 0 0 000:00:01
1666.61.98.95 2 00.0 KB 0 0 000:00:02
1731-14-254-61.infrawat.ch 1 00.0 KB 0 0 000:00:00
18r3-31-1f.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
19r5-233-e9.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
20238.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
21r4-190-be.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
222a01:4020:2:b:101::2c 1 00.0 KB 0 0 000:00:00
23193-176-31-212.infrawat.ch 1 00.0 KB 0 0 000:00:00
245-226-140-40.infrawat.ch 1 00.0 KB 0 0 000:00:00
25r3-15-f.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
26104.152.52.103 1 00.0 KB 0 0 000:00:03
27194-88-98-85.infrawat.ch 1 00.0 KB 0 0 000:00:00
28r5-20-14.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
29r4-201-c9.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
30r3-205-cd.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
31r5-68-44.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
32198.235.24.247 1 00.0 KB 0 0 000:00:00
33r3-23-17.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
34r5-26-1a.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3520.29.41.126 2 00.0 KB 0 0 000:00:10
36104.152.52.119 1 00.0 KB 0 0 000:00:01
37r5-21-15.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
382603:6010:6802:4ca5:1a03:73ff:fe28:be0f 6 00.0 KB 0 0 000:00:03
39r5-247-f7.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
40mail.gegeweb.eu 288 00.0 KB 0 0 000:00:23
41104.152.52.104 1 00.0 KB 0 0 000:00:01
42r5-31-1f.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
43r5-73-49.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
44r5-30-1e.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:10
TOTAL: 44 351 00.0 KB 0 0 000:02:02

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 288 00.0 KB 0 0 000:00:23
2*.infrawat.ch 4 00.0 KB 0 0 000:00:00
3*.scanner.modat.io 1 00.0 KB 0 0 000:00:29
4*.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
5*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
6*.monitoring.internet-measurement.com 21 00.0 KB 0 0 000:00:25
7*.ip.linodeusercontent.com 11 00.0 KB 0 0 000:00:00
8? 8 00.0 KB 0 0 000:00:03
9unresolved 16 00.0 KB 0 0 000:00:34
TOTAL: 9 351 00.0 KB 0 0 000:02:02

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
o009.scanner.modat.io 0.042 0.021 0.00000:00:29
mail.gegeweb.eu 5.293 4.693 1.79900:00:23
r5-30-1e.monitoring.internet-measurement.com 0.084 0.055 0.00000:00:10
20.29.41.126 0.029 0.015 0.00000:00:10
45.82.78.104 0.097 0.017 0.00000:00:05
104.152.52.103 0.008 0.016 0.00000:00:03
147.185.133.78 0.084 0.024 0.00000:00:03
66.195.132.66.censys-scanner.com 0.023 0.035 0.00000:00:03
8.216.7.175 0.021 0.030 0.00000:00:03
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f 0.136 0.103 0.00000:00:03
r3-246-f6.monitoring.internet-measurement.com 0.035 0.012 0.00000:00:03
r5-233-e9.monitoring.internet-measurement.com 0.039 0.016 0.00000:00:03
66.61.98.95 0.079 0.031 0.00000:00:02
104.152.52.119 0.008 0.017 0.00000:00:01
r5-247-f7.monitoring.internet-measurement.com 0.014 0.009 0.00000:00:01
104.152.52.104 0.007 0.030 0.00000:00:01
r5-17-11.monitoring.internet-measurement.com 0.086 0.008 0.00000:00:01
r5-4-4.monitoring.internet-measurement.com 0.070 0.024 0.00000:00:01
r5-26-1a.monitoring.internet-measurement.com 0.065 0.028 0.00000:00:01
r3-15-f.monitoring.internet-measurement.com 0.078 0.018 0.00000:00:01
TOTAL: 42 7.311 5.633 1.79900:02:02

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
87.251.64.19 10
104.152.52.104 5
147.185.133.78 4
147.185.132.68 4
238.210.203.35.bc.googleusercontent.com 4
8.216.7.175 3
104.152.52.108 2
104.152.52.103 1
20.29.41.126 1
66.195.132.66.censys-scanner.com 1
TOTAL: 10 35

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 5
Accept-Encoding: gzip 3
Host: 45.13.105.36:563 3
User-Agent: Hello from Palo Alto Network... 3
Connection: close 2
EHLO www.censys.io 1
MAIL FROM:<relaycheck_please_ignore@prot... 1
²êmlÌ#035¹…â#037#017ïs¶Ä+#016Õ9£Q¨`ˆ€Ö€’¥ 1
#026#003#001#002 1
MGLNDD_45.13.105.36_119 1
À#024À#011À#023 1
SSH-2.0-Go 1
#023#001#023#002#023#003#001 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Accept: text/html,application/xhtml+xml,... 1
#026#003#001 1
Host: 45.13.105.36:119 1
Host: 45.13.105.36 1
User-Agent: curl/7.61.1 1
À#024 1
Accept-Encoding: gzip, deflate, br 1
Accept-Language: en-US,en;q=0.9 1
EHLO 45.13.105.36 1
Accept: */* 1
TOTAL: 24 35

NNRP client timeouts [Top 20]:

SystemConnPeer
8.216.7.175 1 1
2a01:4020:1:1:102::76f 1 1
193-176-31-212.infrawat.ch 1 1
TOTAL: 3 3 6
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me