Daily Usenet report for news.niel.me

May 11 04:15:01 -- May 12 04:15:01

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

May 11 13:41:47 rpi-studio innd: filter: No Cancel-Key[sha1:Eda1aSCkmhF8fGaPN2oasdzus3c=] matches Cancel-Lock[sha1:I7mU9gJSEhGozv+rb07037awQio= sha256:3a/kJ09cp0dFM+c9ztZvPzS5m/C7+nkbr/LE/0vJnHc=] target=<10tsf4b$12rup$1@dont-email.me>
May 11 15:35:05 rpi-studio innd: filter: No Cancel-Key[sha1:O+//gVmiDPfccOnscGQGivDEgRQ= sha256:Mzzwy1yB6vgq8xKxFcTh0PKEe6R89RkIyZDi9AnEmrQ=] matches Cancel-Lock[sha1:8HoAAD2vKTm2IXtChKmfbfx8xIc= sha256:PuOTUuxqbuLvXYUdZIKN6O5nEYX7mKUkib8cbJVEerE=] target=<10tslt2$9gt$2@rasp.pasdenom.info>
May 12 00:04:54 rpi-studio innd: filter: No Cancel-Key[sha1:5767I4t1ZQjHH6ER5+3f1AGbK6c=] matches Cancel-Lock[sha1:tFC/Ukq5D5mN7215BokeItYR3Ts= sha256:iLK+5fuHzlQy8OF/G8H5oTMCxbeKl9bjWozmMptIIxg=] target=<10ttjn3$1fijn$1@dont-email.me>
May 12 00:49:56 rpi-studio innd: filter: No Cancel-Key[sha1:lA76P2r12FuDWuDik81nVqXccc0=] matches Cancel-Lock[sha1:wKt2KTDKiDsrr3CymmvvbSbxnd4= sha256:Jd/+ob/mlvhjq6tQYzc/vXe/fFMp5TjXW7v1pGcwD1w=] target=<10ttmav$1gctv$1@dont-email.me>
May 12 00:52:53 rpi-studio innd: filter: No Cancel-Key[sha1:4BU79ZIKlurw5Jtm4MXB2kCwnXA=] matches Cancel-Lock[sha1:CuECSMEWztshjjqI6c5BzgFEalM= sha256:qovUHWSaGKV5SbQH/7UhyGWBdlucDFTPfsIrdUXoSg4=] target=<UBI20260510@dont-email.me>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2603 31.5%455.4 KB 35.5%
nnrpd 1958 23.7%218.9 KB 17.1%
innd 1885 22.8%319.0 KB 24.9%
innfeed 1806 21.9%288.7 KB 22.5%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8254 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 9602 53.0%
Negative hits 5953 32.8%
Do not exist 2570 14.2%
Cache misses 1 0.0%
TOTAL: 4 18126 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.017 0.0%8 0.000 2.125 7.000
article cancel00:00:00.005 0.0%12 0.000 0.417 1.000
article cleanup00:00:00.053 0.0%2580 0.000 0.021 0.125
article logging00:00:00.211 0.0%2580 0.000 0.082 0.300
article parse00:00:00.555 0.0%7303 0.000 0.076 0.185
article write00:00:00.969 0.0%1998 0.000 0.485 2.500
artlog/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.002 0.0%8 0.000 0.250 1.000
data move00:00:00.139 0.0%22304 0.000 0.006 0.033
hisgrep/artcncl00:00:00.001 0.0%12 0.000 0.083 1.000
hisgrep/artcncl/perl00:00:00.001 0.0%8 0.000 0.125 1.000
hisgrep/perl00:00:00.001 0.0%17 0.000 0.059 1.000
hishave/artcncl00:00:00.000 0.0%12 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.300 0.0%18191 0.000 0.016 0.067
history sync00:00:00.055 0.0%404 0.000 0.136 0.667
history write00:00:00.523 0.0%2580 0.000 0.203 0.636
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:41.654100.0%23522 1583.770 3674.928 15800.789
nntp read00:00:00.654 0.0%22719 0.000 0.029 0.091
overview write00:00:00.670 0.0%1998 0.000 0.335 2.667
perl filter00:00:11.073 0.0%2580 1.708 4.292 17.000
python filter00:00:00.010 0.0%2580 0.000 0.004 0.083
site send00:00:00.897 0.0%4070 0.000 0.220 0.615
TOTAL: 24:01:06.04024:00:57.790100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.010 0.0%2009 0.000 0.005 0.111
article prepare00:00:00.000 0.0%156 0.000 0.000 0.000
article read00:00:00.013 0.0%38 0.000 0.342 3.000
backlog stats00:00:00.126 0.0%25770 0.000 0.005 0.033
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.363 0.0%12907 0.000 0.028 0.103
data write00:00:00.685 0.0%10997 0.000 0.062 0.135
idle23:50:08.427100.0%25770 1508.796 3329.780 8116.486
status file00:00:05.711 0.0%267 0.000 21.390 80.000
TOTAL: 23:50:20.19723:50:15.335100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:48.472 19.0%1460 6.667 33.200 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.107 0.0%3380 0.000 0.032 0.500
TOTAL: 00:04:15.31300:00:48.579 19.0%----

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 3 1971 890 1081 0 45%23:57:46
2news.nntp4.net 2 2622 631 1462 529 24%25:24:01
3news.glou.org 2 2581 264 2254 63 10%40:13:19
4news.samoylyk.net 1 2120 212 1907 1 10%25:39:20
5nntp.terraraq.uk 2 1706 53 1652 1 3%25:31:17
6usenet.pasdenom.info 11 953 36 915 2 3%22:15:46
7gegeweb-out.news.tnetconsulting.net 3 2355 34 2321 0 1%38:37:04
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 49 14308 2120 11592 596 14%201:38:33
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net2.8 MB0.0 KB6.8 MB9.6 MB 29%8.5 KB
2feed-out.gegeweb.org2.8 MB0.0 KB0.0 KB2.8 MB100%3.2 KB
3news.samoylyk.net1.7 MB0.0 KB1.7 KB1.7 MB 99%8.4 KB
4news.glou.org894.2 KB0.0 KB253.6 KB1.1 MB 77%3.5 KB
5nntp.terraraq.uk140.8 KB0.0 KB2.0 KB142.8 KB 98%2.6 KB
6gegeweb-out.news.tnetconsulting.net114.3 KB0.0 KB0.0 KB114.3 KB100%3.4 KB
7usenet.pasdenom.info77.7 KB0.0 KB2.5 KB80.2 KB 96%2.1 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 88.5 MB0.0 KB7.1 MB15.6 MB 54%5.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 11 04:15:01 - 04:59:59 38 1.9% 0.01281.0 KB 3.4% 0.10
May 11 05:00:00 - 05:59:59 41 2.1% 0.01158.5 KB 1.9% 0.04
May 11 06:00:00 - 06:59:59 62 3.1% 0.02254.5 KB 3.0% 0.07
May 11 07:00:00 - 07:59:59 53 2.7% 0.01532.1 KB 6.4% 0.15
May 11 08:00:00 - 08:59:59 61 3.1% 0.02170.2 KB 2.0% 0.05
May 11 09:00:00 - 09:59:59 58 2.9% 0.02193.5 KB 2.3% 0.05
May 11 10:00:00 - 10:59:59 84 4.2% 0.02282.7 KB 3.4% 0.08
May 11 11:00:00 - 11:59:59 82 4.1% 0.02460.8 KB 5.5% 0.13
May 11 12:00:00 - 12:59:59 86 4.3% 0.02745.1 KB 8.9% 0.21
May 11 13:00:00 - 13:59:59 87 4.4% 0.02285.8 KB 3.4% 0.08
May 11 14:00:00 - 14:59:59 102 5.1% 0.03327.1 KB 3.9% 0.09
May 11 15:00:00 - 15:59:59 96 4.8% 0.03283.8 KB 3.4% 0.08
May 11 16:00:00 - 16:59:59 112 5.6% 0.03595.8 KB 7.1% 0.17
May 11 17:00:00 - 17:59:59 106 5.3% 0.03484.6 KB 5.8% 0.13
May 11 18:00:00 - 18:59:59 96 4.8% 0.03303.3 KB 3.6% 0.08
May 11 19:00:00 - 19:59:59 106 5.3% 0.03336.9 KB 4.0% 0.09
May 11 20:00:00 - 20:59:59 120 6.0% 0.03439.8 KB 5.3% 0.12
May 11 21:00:00 - 21:59:59 116 5.8% 0.03371.9 KB 4.5% 0.10
May 11 22:00:00 - 22:59:59 79 4.0% 0.02253.0 KB 3.0% 0.07
May 11 23:00:00 - 23:59:59 102 5.1% 0.03367.3 KB 4.4% 0.10
May 12 00:00:00 - 00:59:59 108 5.4% 0.03441.8 KB 5.3% 0.12
May 12 01:00:00 - 01:59:59 73 3.7% 0.02264.9 KB 3.2% 0.07
May 12 02:00:00 - 02:59:59 39 2.0% 0.01142.6 KB 1.7% 0.04
May 12 03:00:00 - 03:59:59 77 3.9% 0.02313.8 KB 3.8% 0.09
May 12 04:00:00 - 04:15:01 13 0.7% 0.0156.5 KB 0.7% 0.06
TOTAL: 24:00:00 1997 100.0% 0.028.2 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 537 525 0 0 0 0 0 0 12
2news.glou.org 45 0 0 0 0 0 0 0 45
3usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
4news.samoylyk.net 1 0 0 0 0 0 0 0 1
5nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
TOTAL: 5 586 525 0 0 0 0 0 0 61

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 419
linux.kernel.git 105
news.test 1
TOTAL: 3 525

INND Perl filter [Top 20]:

ReasonCount
Bad path (news.giganews.com.POSTED) 50
Cancels abusifs 3
Cancel of non-existing ID <10ttmav$1gctv$1@dont-email.me> 2
Too many newsgroups 2
Cancel of non-existing ID <10tsf4b$12rup$1@dont-email.me> 2
EMP (md5) 1
No Cancel-Key matches Cancel-Lock. target=<10tslt2$9gt$2@rasp.pasdenom.info> 1
TOTAL: 7 61

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 3574 12 1968 13 0 14 0%23:59:57
2news.samoylyk.net 2256 3 1772 11 0 6 0%23:59:56
3i2pn.org 0 0 0 0 0 1991 0%24:00:00
4news.aioe.org 0 0 0 0 0 1496 0%24:00:00
5news.gegeweb.org 1146 0 1087 0 0 0 0%23:59:34
6nntp.terraraq.uk 1174 0 1109 0 0 1 0%23:53:54
7news.pasdenom.info 1613 0 1482 0 0 0 0%23:59:15
8news.nntp4.net 1418 0 1360 0 0 1 0%23:41:34
TOTAL: 8 11181 15 8778 24 0 3509 0%191:34:10
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net65.8 KB48.7 KB114.6 KB0.0 KB/s4.6 KB23:59:57
2news.samoylyk.net4.1 KB43.0 KB47.1 KB0.0 KB/s3.4 KB23:59:56
3i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
4news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
5news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:34
6nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:54
7news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:15
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:41:34
TOTAL: 869.9 KB91.8 KB161.7 KB0.0 KB/s4.1 KB191:34:10
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1composed.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
2poetic.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
32a06:4883:b000::b6 1 00.0 KB 0 0 000:00:01
4villegas.probe.onyphe.net 1 00.0 KB 0 0 000:00:00
5108.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:30
6193.124.20.247 1 00.0 KB 0 0 000:00:00
7skilful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
8ready.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
9185.93.89.170 2 00.0 KB 0 0 000:00:00
10auspicious.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
11creative.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
12104.152.52.222 1 00.0 KB 0 0 000:00:00
13147.185.132.110 4 00.0 KB 0 0 000:01:48
14magnificent.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
15azpdwstrxqyz.stretchoid.com 2 00.0 KB 0 0 000:00:10
16zl-amsc-nl-gp1-wk127a.internet-census.org 1 00.0 KB 0 0 000:00:10
17178.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:30
18197.186.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:05
19mail.gegeweb.eu 288 00.0 KB 0 0 000:00:28
20principled.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
21impeccable.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
22energetic.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
23foundational.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
24karina.probe.onyphe.net 1 00.0 KB 0 0 000:00:02
25upstanding.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
26cozy.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:04
27affectionate.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
28content.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:07
29wise.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
30163.186.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:30
3137.10.113.216 1 00.0 KB 0 0 000:00:00
TOTAL: 31 326 00.0 KB 0 0 000:05:02

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:30
2*.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:30
3unresolved 9 00.0 KB 0 0 000:01:50
4*.internet-census.org 1 00.0 KB 0 0 000:00:10
5*.monitoring.internet-measurement.com 17 00.0 KB 0 0 000:00:41
6*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
7*.gegeweb.eu 288 00.0 KB 0 0 000:00:28
8*.186.132.66.censys-scanner.com 4 00.0 KB 0 0 000:00:36
9*.stretchoid.com 2 00.0 KB 0 0 000:00:10
10? 1 00.0 KB 0 0 000:00:01
TOTAL: 10 326 00.0 KB 0 0 000:05: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
147.185.132.110 0.516 0.121 0.00000:01:48
163.186.132.66.censys-scanner.com 0.040 0.016 0.00000:00:30
178.172.132.66.censys-scanner.com 0.044 0.018 0.00000:00:30
108.195.132.66.censys-scanner.com 0.043 0.020 0.00000:00:30
mail.gegeweb.eu 5.010 4.245 1.69900:00:28
azpdwstrxqyz.stretchoid.com 0.062 0.042 0.00000:00:10
zl-amsc-nl-gp1-wk127a.internet-census.org 0.028 0.020 0.00000:00:10
content.monitoring.internet-measurement.com 0.070 0.024 0.00000:00:07
197.186.132.66.censys-scanner.com 0.098 0.062 0.00000:00:05
cozy.monitoring.internet-measurement.com 0.069 0.049 0.00000:00:04
creative.monitoring.internet-measurement.com 0.068 0.013 0.00000:00:03
ready.monitoring.internet-measurement.com 0.031 0.015 0.00000:00:03
impeccable.monitoring.internet-measurement.com 0.160 0.056 0.00000:00:03
energetic.monitoring.internet-measurement.com 0.036 0.023 0.00000:00:03
magnificent.monitoring.internet-measurement.com 0.032 0.016 0.00000:00:03
karina.probe.onyphe.net 0.078 0.016 0.00000:00:02
affectionate.monitoring.internet-measurement.com 0.043 0.004 0.00000:00:02
auspicious.monitoring.internet-measurement.com 0.086 0.023 0.00000:00:02
2a06:4883:b000::b6 0.023 0.027 0.00000:00:01
poetic.monitoring.internet-measurement.com 0.034 0.017 0.00000:00:01
TOTAL: 31 7.071 5.035 1.69900:05:02

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
185.93.89.170 9
147.185.132.110 8
104.152.52.222 2
azpdwstrxqyz.stretchoid.com 1
197.186.132.66.censys-scanner.com 1
TOTAL: 5 21

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 3
Host: 45.13.105.36:563 2
Accept: */* 2
User-Agent: curl/7.68.0 2
MGLNDD_45.13.105.36_119 1
MAIL FROM:<relaycheck_please_ignore@prot... 1
Accept-Encoding: gzip, deflate, br 1
Accept-Language: en-US,en;q=0.9 1
Host: 45.13.105.36:119 1
Connection: close 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
EHLO www.censys.io 1
À#024À#011À#023 1
EHLO 45.13.105.36 1
Accept: text/html,application/xhtml+xml,... 1
#026#003#001#002 1
TOTAL: 16 21

NNRP client timeouts [Top 20]:

SystemConnPeer
147.185.132.110 2 4
197.186.132.66.censys-scanner.com 1 2
193.124.20.247 1 1
TOTAL: 3 4 8
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me