Daily Usenet report for news.niel.me

Sep 28 04:15:01 -- Sep 29 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Sep 28 06:56:56 rpi-studio innd: filter: No Cancel-Key[sha1:skdvcJmHdVVFIAyKz2l2scs7DA4= sha256:ixeKG1naniLMu1dYgs+95ojHp2m+/QlKSSiEN+WFoKc=] matches Cancel-Lock[sha1:qsU3Wmo6SsB5OpupLkZo3RZgW/w= sha256:/ivQZZOGpBdncZAWrYfxCU+W3QQ0ijOVSmCTUW8h/m4=] target=<119crop$2jlr$1@nnrp.usenet.blueworldhosting.com>
Sep 28 12:32:04 rpi-studio innd: filter: No Cancel-Key[sha1:XAXicKLEtFHU+D0fMf08vsWGOWg= sha256:qmDzSceyTtKP+xI8hbpvj8KtNm0TJb1PeoqKNRXacgw=] matches Cancel-Lock[sha1:Ltt0Jbee2FaKK8dcDEch8lJrFlk= sha256:0cvksDtrbm8JXvrYjcc+l9f0fLPEVLcGuSjgy1FVBlw=] target=<119cglv$1ub55$2@dont-email.me>
Sep 28 13:12:49 rpi-studio innd: filter: No Cancel-Key[sha1:3eNum3XhU9Uj/l5EIFNed7V2398= sha256:2lFBDxP+CwAqHF7hIu6L9slORC3DHCvnvKwKSiuNGQg=] matches Cancel-Lock[sha1:nfZnjU9I9GkxS2A/zjKnO3Fcq7M= sha256:8lG+G7fCUNaXJfG8bVOGlGNc6QHm2OVOJLyelQi/2Bg=] target=<119dhs9$294jq$1@dont-email.me>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2752 31.6%463.4 KB 34.9%
nnrpd 2041 23.4%243.4 KB 18.3%
innd 2024 23.3%344.1 KB 25.9%
innfeed 1886 21.7%278.6 KB 20.9%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 8705 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 8811 48.6%
Negative hits 6581 36.3%
Do not exist 2737 15.1%
Cache misses 2 0.0%
TOTAL: 4 18131 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.004 0.0%3 1.000 1.333 2.000
article cancel00:00:00.003 0.0%6 0.000 0.500 2.000
article cleanup00:00:00.065 0.0%2738 0.000 0.024 0.188
article logging00:00:00.214 0.0%2741 0.000 0.078 0.312
article parse00:00:00.575 0.0%7978 0.000 0.072 0.222
article write00:00:00.974 0.0%1871 0.000 0.521 1.750
artlog/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:00:00.134 0.0%21286 0.000 0.006 0.030
hisgrep/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%3 0.000 0.333 1.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%3 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.315 0.0%18124 0.000 0.017 0.081
history sync00:00:00.061 0.0%364 0.000 0.168 1.000
history write00:00:00.544 0.0%2738 0.000 0.199 0.588
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:29.304100.0%23005 916.366 3756.979 21434.786
nntp read00:00:00.638 0.0%22226 0.000 0.029 0.150
overview write00:00:00.672 0.0%1871 0.000 0.359 2.125
perl filter00:00:13.506 0.0%2738 1.976 4.933 13.167
python filter00:00:00.013 0.0%2738 0.000 0.005 0.143
site send00:00:00.759 0.0%3774 0.000 0.201 0.500
TOTAL: 24:01:06.25624:00:47.782100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.011 0.0%2016 0.000 0.005 0.200
article prepare00:00:00.000 0.0%28 0.000 0.000 0.000
article read00:00:00.004 0.0%6 0.000 0.667 1.500
backlog stats00:00:00.134 0.0%22825 0.000 0.006 0.053
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.304 0.0%11310 0.000 0.027 0.167
data write00:00:00.538 0.0%9701 0.000 0.055 0.188
idle23:58:54.687100.0%22825 1128.612 3782.462 10193.000
status file00:00:06.756 0.0%328 0.000 20.598 80.000
TOTAL: 23:59:07.22723:59:02.434100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:50.848 18.6%1503 10.800 33.831 9745.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.119 0.0%3394 0.000 0.035 1.000
TOTAL: 00:04:33.22800:00:50.967 18.7%----

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 1860 747 1113 0 40%23:43:22
2news.samoylyk.net 4 1963 425 1536 2 21%25:00:37
3news.nntp4.net 3 2874 373 1658 843 12%26:17:22
4nntp.terraraq.uk 3 1424 173 1249 2 12%24:06:04
5news.glou.org 4 1452 134 1271 47 9%23:51:22
6usenet.pasdenom.info 12 926 29 896 1 3%23:08:48
7gegeweb-out.news.tnetconsulting.net 2 348 2 346 0 0%08:01:49
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 57 10847 1883 8069 895 17%154:09:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net2.5 MB0.0 KB5.5 KB2.5 MB 99%5.9 KB
2feed-out.gegeweb.org2.3 MB0.0 KB0.0 KB2.3 MB100%3.2 KB
3news.nntp4.net1.6 MB0.0 KB9.4 MB11.0 MB 14%9.3 KB
4news.glou.org426.1 KB0.0 KB146.4 KB572.5 KB 74%3.2 KB
5nntp.terraraq.uk425.5 KB0.0 KB3.6 KB429.1 KB 99%2.5 KB
6usenet.pasdenom.info72.2 KB0.0 KB1.2 KB73.4 KB 98%2.4 KB
7gegeweb-out.news.tnetconsulting.net5.2 KB0.0 KB0.0 KB5.2 KB100%2.6 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 87.3 MB0.0 KB9.6 MB16.9 MB 43%6.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 28 04:15:01 - 04:59:59 31 1.7% 0.01183.8 KB 2.5% 0.07
Sep 28 05:00:00 - 05:59:59 124 6.6% 0.03503.0 KB 6.8% 0.14
Sep 28 06:00:00 - 06:59:59 94 5.0% 0.03344.4 KB 4.7% 0.10
Sep 28 07:00:00 - 07:59:59 43 2.3% 0.01215.4 KB 2.9% 0.06
Sep 28 08:00:00 - 08:59:59 47 2.5% 0.01144.1 KB 2.0% 0.04
Sep 28 09:00:00 - 09:59:59 38 2.0% 0.01160.8 KB 2.2% 0.04
Sep 28 10:00:00 - 10:59:59 58 3.1% 0.02179.3 KB 2.4% 0.05
Sep 28 11:00:00 - 11:59:59 69 3.7% 0.02197.9 KB 2.7% 0.05
Sep 28 12:00:00 - 12:59:59 71 3.8% 0.02217.6 KB 2.9% 0.06
Sep 28 13:00:00 - 13:59:59 92 4.9% 0.03304.6 KB 4.1% 0.08
Sep 28 14:00:00 - 14:59:59 81 4.3% 0.02233.1 KB 3.2% 0.06
Sep 28 15:00:00 - 15:59:59 63 3.4% 0.02215.9 KB 2.9% 0.06
Sep 28 16:00:00 - 16:59:59 94 5.0% 0.03351.4 KB 4.8% 0.10
Sep 28 17:00:00 - 17:59:59 103 5.5% 0.03403.1 KB 5.5% 0.11
Sep 28 18:00:00 - 18:59:59 126 6.7% 0.04583.7 KB 7.9% 0.16
Sep 28 19:00:00 - 19:59:59 136 7.3% 0.04467.1 KB 6.3% 0.13
Sep 28 20:00:00 - 20:59:59 82 4.4% 0.02242.8 KB 3.3% 0.07
Sep 28 21:00:00 - 21:59:59 92 4.9% 0.03288.7 KB 3.9% 0.08
Sep 28 22:00:00 - 22:59:59 141 7.5% 0.04884.9 KB 12.0% 0.25
Sep 28 23:00:00 - 23:59:59 90 4.8% 0.03315.1 KB 4.3% 0.09
Sep 29 00:00:00 - 00:59:59 75 4.0% 0.02354.2 KB 4.8% 0.10
Sep 29 01:00:00 - 01:59:59 43 2.3% 0.01201.9 KB 2.7% 0.06
Sep 29 02:00:00 - 02:59:59 40 2.1% 0.01234.5 KB 3.2% 0.07
Sep 29 03:00:00 - 03:59:59 32 1.7% 0.01135.3 KB 1.8% 0.04
Sep 29 04:00:00 - 04:15:02 9 0.5% 0.0125.5 KB 0.3% 0.03
TOTAL: 24:00:01 1874 100.0% 0.027.2 MB 100.0% 0.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 813 692 0 0 1 0 0 0 120
2news.glou.org 47 0 0 0 0 0 0 0 47
3news.samoylyk.net 3 0 0 0 0 0 0 0 3
4nntp.terraraq.uk 2 0 0 0 0 0 0 0 2
5feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
6usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
7gegeweb-out.news.tnetconsulting.net 1 0 0 0 0 0 0 0 1
TOTAL: 7 869 692 0 0 1 0 0 0 176

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 600
linux.kernel.git 92
TOTAL: 2 692

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
soc.culture.hawaii 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 114
Bad path (news.giganews.com.POSTED) 57
Cancels abusifs 1
Cancel of non-existing ID <119dhs9$294jq$1@dont-email.me> 1
TOTAL: 4 173

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 2
news.samoylyk.net 1
TOTAL: 2 3
TOTAL: 1 3

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.samoylyk.net 1535 1 1385 0 0 0 0%23:47:54
2news.nntp4.net 1532 1 1496 0 0 0 0%23:49:01
3news.pasdenom.info 1571 0 1411 3 0 67 0%23:49:02
4nntp.terraraq.uk 922 0 875 0 0 2 0%23:35:53
5i2pn.org 0 0 0 0 0 1869 0%24:00:01
6news.aioe.org 0 0 0 0 0 1480 0%24:00:01
7news.tnetconsulting.net 3173 0 1870 2 0 73 0%23:57:10
8news.gegeweb.org 1163 0 1123 0 0 0 0%23:45:27
TOTAL: 8 9896 2 8160 5 0 3491 0%190:44:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.samoylyk.net2.3 KB0.0 KB2.3 KB0.0 KB/s2.3 KB23:47:54
2news.nntp4.net1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:49:01
3news.pasdenom.info0.0 KB6.4 KB6.4 KB0.0 KB/s2.1 KB23:49:02
4nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:35:53
5i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
7news.tnetconsulting.net0.0 KB5.2 KB5.2 KB0.0 KB/s2.6 KB23:57:10
8news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:45:27
TOTAL: 83.6 KB11.7 KB15.3 KB0.0 KB/s2.2 KB190:44:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12603:6010:6802:4ca5:1a03:73ff:fe28:be0f 18 00.0 KB 0 0 000:00:06
2azpdssiticcz.stretchoid.com 2 00.0 KB 0 0 000:00:10
3o005.scanner.modat.io 1 00.0 KB 0 0 000:00:30
4o018.scanner.modat.io 1 00.0 KB 0 0 000:00:30
5o009.scanner.modat.io 1 00.0 KB 0 0 000:00:30
6205.210.31.111 1 00.0 KB 0 0 000:00:01
7o033.scanner.modat.io 1 00.0 KB 0 0 000:00:00
8104.152.52.119 1 00.0 KB 0 0 000:00:00
9239.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
104.148.17.168 2 00.0 KB 0 0 000:00:09
112a01:4020:1:1:101::b 1 00.0 KB 0 0 000:00:00
12104.152.52.110 1 00.0 KB 0 0 000:00:01
132a01:4020:1:1:102::4cd 1 00.0 KB 0 0 000:00:00
14mail.gegeweb.eu 288 00.0 KB 0 0 000:00:24
1566.61.98.95 2 00.0 KB 0 0 000:00:00
1683.224.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:01
17o008.scanner.modat.io 2 00.0 KB 0 0 000:01:01
1869-5-169-251.infrawat.ch 1 00.0 KB 0 0 000:00:00
1936.255.97.194 2 00.0 KB 0 0 000:00:08
20o061.scanner.modat.io 1 00.0 KB 0 0 000:00:30
21147.185.133.102 2 00.0 KB 0 0 000:00:35
22104.152.52.107 1 00.0 KB 0 0 000:00:01
232a02-a452-390d-0-7822-828f-decc-c35e.fixed6.kpn.net 8 00.0 KB 0 0 000:00:00
24104.152.52.115 1 00.0 KB 0 0 000:00:03
252-57-17-236.infrawat.ch 1 00.0 KB 0 0 000:00:00
2681-207-72-128.fixed.kpn.net 2 00.0 KB 0 0 000:00:00
TOTAL: 26 344 00.0 KB 0 0 000:04:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 20 00.0 KB 0 0 000:00:06
2*.fixed6.kpn.net 8 00.0 KB 0 0 000:00:00
3*.gegeweb.eu 288 00.0 KB 0 0 000:00:24
4*.stretchoid.com 2 00.0 KB 0 0 000:00:10
5*.infrawat.ch 2 00.0 KB 0 0 000:00:00
6*.fixed.kpn.net 2 00.0 KB 0 0 000:00:00
7unresolved 13 00.0 KB 0 0 000:01:04
8*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
9*.scanner.modat.io 7 00.0 KB 0 0 000:03:01
10*.224.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:01
TOTAL: 10 344 00.0 KB 0 0 000:04:50

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
o008.scanner.modat.io 0.093 0.028 0.00000:01:01
147.185.133.102 0.264 0.078 0.00000:00:35
o061.scanner.modat.io 0.042 0.021 0.00000:00:30
o018.scanner.modat.io 0.045 0.012 0.00000:00:30
o009.scanner.modat.io 0.017 0.013 0.00000:00:30
o005.scanner.modat.io 0.031 0.024 0.00000:00:30
mail.gegeweb.eu 5.112 4.595 1.69300:00:24
azpdssiticcz.stretchoid.com 0.038 0.031 0.00000:00:10
4.148.17.168 0.040 0.033 0.00000:00:09
36.255.97.194 0.086 0.031 0.00000:00:08
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f 0.428 0.387 0.00000:00:06
104.152.52.115 0.027 0.016 0.00000:00:03
83.224.132.66.censys-scanner.com 0.019 0.010 0.00000:00:01
104.152.52.107 0.023 0.019 0.00000:00:01
104.152.52.110 0.032 0.020 0.00000:00:01
205.210.31.111 0.011 0.011 0.00000:00:01
66.61.98.95 0.059 0.047 0.00000:00:00
239.210.203.35.bc.googleusercontent.com 0.038 0.009 0.00000:00:00
2a02-a452-390d-0-7822-828f-decc-c35e.fixed6.kpn.net 0.095 0.102 0.00000:00:00
81-207-72-128.fixed.kpn.net 0.029 0.017 0.00000:00:00
TOTAL: 26 6.663 5.608 1.69300:04:50

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
2a02-a452-390d-0-7822-828f-decc-c35e.fixed6.kpn.net 11
104.152.52.107 5
147.185.133.102 4
239.210.203.35.bc.googleusercontent.com 4
81-207-72-128.fixed.kpn.net 2
104.152.52.119 2
azpdssiticcz.stretchoid.com 1
83.224.132.66.censys-scanner.com 1
104.152.52.115 1
4.148.17.168 1
TOTAL: 10 32

NNRP unrecognized commands (by command):

CommandCount
À#011À#024À#023 5
#026#003#001 5
GET / HTTP/1.1 3
XFEATURE COMPRESS GZIP 2
Host: 45.13.105.36:563 2
Accept: */* 2
MGLNDD_45.13.105.36_119 2
User-Agent: Hello from Palo Alto Network... 1
òW’z2A/Aï’)™q­ 1
Connection: close 1
User-Agent: curl/7.68.0 1
Accept-Encoding: gzip 1
EHLO www.censys.io 1
User-Agent: curl/7.61.1 1
SSH-2.0-Go 1
MAIL FROM:<relaycheck_please_ignore@prot... 1
Host: 45.13.105.36 1
EHLO 45.13.105.36 1
TOTAL: 18 32

NNRP client timeouts [Top 20]:

SystemConnPeer
2a02-a452-390d-0-7822-828f-decc-c35e.fixed6.kpn.net 5 5
2a01:4020:1:1:102::4cd 1 1
69-5-169-251.infrawat.ch 1 1
147.185.133.102 1 2
TOTAL: 4 8 12