Daily Usenet report for news.niel.me

Oct 16 04:15:01 -- Oct 17 04:15:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Oct 16 16:23:53 rpi-studio innd: filter: No Cancel-Key[sha1:ypFBMJVxxcBBqHHW9TzzAy0RoL4= sha256:nNQ0mn6PIe4TqddalACtqv3VmGOSyGo0PLgHPgCSeCc=] matches Cancel-Lock[sha1:p92s8vLRblosLF/5iL663YD/Wlw= sha256:13osudgIO4fVInMNyTu2QkqldBNlmoMvatuK1DkXfio=] target=<11atbed$3c006$1@dont-email.me>
Oct 16 16:25:30 rpi-studio innd: filter: No Cancel-Key[sha1:ypFBMJVxxcBBqHHW9TzzAy0RoL4= sha256:nNQ0mn6PIe4TqddalACtqv3VmGOSyGo0PLgHPgCSeCc=] matches Cancel-Lock[sha1:p92s8vLRblosLF/5iL663YD/Wlw= sha256:13osudgIO4fVInMNyTu2QkqldBNlmoMvatuK1DkXfio=] target=<11atbed$3c006$1@dont-email.me>
Oct 16 22:40:05 rpi-studio innd: filter: No Cancel-Key[sha1:zFmt3ciDt7/Y3xnhehZrXKRmq9o= sha256:OoMDh1KdefS8Ti8yjPRkGHvmmxXNVbGhDvdriinaEmc=] matches Cancel-Lock[sha1:ACgMW8M8OpxG9ykT/kb2dY6nhmo= sha256:qKJiBrDf9LS9MwLRth3kiMF8pbug9zwnRPq+xEae+eM=] target=<11au1vu$3ks5m$2@dont-email.me>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2650 30.3%451.7 KB 34.0%
nnrpd 2117 24.2%243.3 KB 18.3%
innd 2059 23.5%357.9 KB 26.9%
innfeed 1932 22.1%276.9 KB 20.8%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 8760 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 8577 48.5%
Negative hits 6477 36.6%
Do not exist 2643 14.9%
Cache misses 1 0.0%
TOTAL: 4 17698 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.007 0.0%2 1.000 3.500 6.000
article cancel00:00:00.001 0.0%3 0.000 0.333 1.000
article cleanup00:00:00.058 0.0%2647 0.000 0.022 0.188
article logging00:00:00.224 0.0%2647 0.000 0.085 0.417
article parse00:00:00.517 0.0%7096 0.000 0.073 0.214
article write00:00:01.072 0.0%1941 0.000 0.552 1.667
artlog/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.127 0.0%20156 0.000 0.006 0.033
hisgrep/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%5 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.306 0.0%17712 0.000 0.017 0.074
history sync00:00:00.064 0.0%371 0.000 0.173 1.000
history write00:00:00.525 0.0%2647 0.000 0.198 0.500
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:31.133100.0%22343 762.019 3868.376 46155.308
nntp read00:00:00.667 0.0%21564 0.000 0.031 0.092
overview write00:00:00.613 0.0%1941 0.000 0.316 3.000
perl filter00:00:11.917 0.0%2647 1.327 4.502 16.333
python filter00:00:00.016 0.0%2647 0.000 0.006 0.167
site send00:00:00.949 0.0%3938 0.000 0.241 0.500
TOTAL: 24:01:05.51724:00:48.196100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%2045 0.000 0.009 0.200
article prepare00:00:00.000 0.0%52 0.000 0.000 0.000
article read00:00:00.010 0.0%12 0.000 0.833 8.000
backlog stats00:00:00.147 0.0%23438 0.000 0.006 0.037
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.283 0.0%11706 0.000 0.024 0.080
data write00:00:00.536 0.0%9872 0.000 0.054 0.167
idle23:57:01.915100.0%23438 822.258 3678.723 9833.852
status file00:00:04.939 0.0%313 0.000 15.780 67.000
TOTAL: 23:57:11.61023:57:07.849100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:42.243 29.2%1510 7.800 27.975 9250.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.137 0.1%3484 0.000 0.039 1.000
TOTAL: 00:02:24.91200:00:42.380 29.2%----

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 1924 644 1280 0 33%23:57:15
2news.samoylyk.net 6 1821 561 1258 2 30%22:01:02
3news.nntp4.net 2 2718 415 1619 684 15%24:55:44
4nntp.terraraq.uk 4 156 20 132 4 12%04:57:41
5usenet.pasdenom.info 13 817 18 798 1 2%23:45:42
6news.glou.org 4 135 4 120 11 2%04:55:43
7gegeweb-out.news.tnetconsulting.net 3 1195 3 1191 1 0%24:27:08
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 61 8766 1665 6398 703 18%129:00:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net2.8 MB0.0 KB4.2 KB2.8 MB 99%5.2 KB
2feed-out.gegeweb.org2.1 MB0.0 KB0.0 KB2.1 MB100%3.3 KB
3news.nntp4.net1.6 MB0.0 KB7.1 MB8.7 MB 18%8.1 KB
4nntp.terraraq.uk81.1 KB0.0 KB10.7 KB91.8 KB 88%3.8 KB
5usenet.pasdenom.info43.4 KB0.0 KB1.2 KB44.6 KB 97%2.3 KB
6news.glou.org11.5 KB0.0 KB27.5 KB39.0 KB 29%2.6 KB
7gegeweb-out.news.tnetconsulting.net10.5 KB0.0 KB3.0 KB13.6 KB 77%3.4 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 86.7 MB0.0 KB7.1 MB13.9 MB 48%6.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 16 04:15:01 - 04:59:59 38 2.0% 0.01189.8 KB 2.4% 0.07
Oct 16 05:00:00 - 05:59:59 42 2.2% 0.01434.9 KB 5.5% 0.12
Oct 16 06:00:00 - 06:59:59 43 2.2% 0.01164.3 KB 2.1% 0.05
Oct 16 07:00:00 - 07:59:59 45 2.3% 0.01191.1 KB 2.4% 0.05
Oct 16 08:00:00 - 08:59:59 55 2.8% 0.02149.8 KB 1.9% 0.04
Oct 16 09:00:00 - 09:59:59 56 2.9% 0.02234.3 KB 3.0% 0.07
Oct 16 10:00:00 - 10:59:59 103 5.3% 0.03333.3 KB 4.2% 0.09
Oct 16 11:00:00 - 11:59:59 80 4.1% 0.02269.4 KB 3.4% 0.07
Oct 16 12:00:00 - 12:59:59 85 4.4% 0.02411.5 KB 5.2% 0.11
Oct 16 13:00:00 - 13:59:59 73 3.8% 0.02244.6 KB 3.1% 0.07
Oct 16 14:00:00 - 14:59:59 79 4.1% 0.02298.5 KB 3.8% 0.08
Oct 16 15:00:00 - 15:59:59 101 5.2% 0.03334.3 KB 4.3% 0.09
Oct 16 16:00:00 - 16:59:59 74 3.8% 0.02267.1 KB 3.4% 0.07
Oct 16 17:00:00 - 17:59:59 84 4.3% 0.02414.3 KB 5.3% 0.12
Oct 16 18:00:00 - 18:59:59 94 4.8% 0.03353.4 KB 4.5% 0.10
Oct 16 19:00:00 - 19:59:59 93 4.8% 0.03293.6 KB 3.7% 0.08
Oct 16 20:00:00 - 20:59:59 87 4.5% 0.02274.8 KB 3.5% 0.08
Oct 16 21:00:00 - 21:59:59 69 3.6% 0.02239.0 KB 3.0% 0.07
Oct 16 22:00:00 - 22:59:59 252 13.0% 0.071.1 MB 14.2% 0.31
Oct 16 23:00:00 - 23:59:59 112 5.8% 0.03364.8 KB 4.6% 0.10
Oct 17 00:00:00 - 00:59:59 69 3.6% 0.02328.0 KB 4.2% 0.09
Oct 17 01:00:00 - 01:59:59 78 4.0% 0.02235.0 KB 3.0% 0.07
Oct 17 02:00:00 - 02:59:59 65 3.3% 0.02273.6 KB 3.5% 0.08
Oct 17 03:00:00 - 03:59:59 55 2.8% 0.02359.8 KB 4.6% 0.10
Oct 17 04:00:00 - 04:15:01 10 0.5% 0.0178.5 KB 1.0% 0.09
TOTAL: 24:00:00 1942 100.0% 0.027.7 MB 100.0% 0.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 645 503 0 0 0 0 0 0 142
2news.glou.org 34 0 0 0 0 0 0 0 34
3nntp.terraraq.uk 20 0 0 0 0 0 0 0 20
4news.samoylyk.net 2 0 0 0 0 0 0 0 2
5usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
6gegeweb-out.news.tnetconsulting.net 1 0 0 0 0 0 0 0 1
TOTAL: 6 703 503 0 0 0 0 0 0 200

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 429
linux.kernel.git 74
TOTAL: 2 503

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 139
Bad path (news.giganews.com.POSTED) 57
Cancels abusifs 1
No Cancel-Key matches Cancel-Lock. target=<11atbed$3c006$1@dont-email.me> 1
HTML Multipart 1
No Cancel-Key matches Cancel-Lock. target=<11au1vu$3ks5m$2@dont-email.me> 1
TOTAL: 6 200

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 3280 8 1837 2 0 186 0%23:59:17
2news.pasdenom.info 1328 2 1288 0 0 0 0%23:55:34
3nntp.terraraq.uk 1003 1 952 0 0 0 0%23:41:07
4news.samoylyk.net 1450 0 1296 0 0 11 0%23:57:09
5i2pn.org 0 0 0 0 0 1939 0%24:00:00
6news.gegeweb.org 1359 0 1291 0 0 1 0%23:46:59
7news.nntp4.net 1572 0 1526 0 0 0 0%23:59:12
8news.aioe.org 0 0 0 0 0 1538 0%24:00:00
TOTAL: 8 9992 11 8190 2 0 3675 0%191:19:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net70.1 KB15.9 KB86.0 KB0.0 KB/s8.6 KB23:59:17
2news.pasdenom.info19.0 KB0.0 KB19.0 KB0.0 KB/s9.5 KB23:55:34
3nntp.terraraq.uk4.2 KB0.0 KB4.2 KB0.0 KB/s4.2 KB23:41:07
4news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:09
5i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
6news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:46:59
7news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:12
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 893.3 KB15.9 KB109.2 KB0.0 KB/s8.4 KB191:19:18
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
180.66.83.80 1 00.0 KB 0 0 000:00:01
2174.96.78.81 10 00.0 KB 0 0 000:00:09
3r3-127-7f.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
4198.235.24.254 1 00.0 KB 0 0 000:00:00
5238.224.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
6104.152.52.211 1 00.0 KB 0 0 000:00:00
7104.152.52.210 1 00.0 KB 0 0 000:00:00
8185.253.160.149 1 00.0 KB 0 0 000:00:04
92a01:4020:1:1:102::60e 1 00.0 KB 0 0 000:00:00
10147.185.133.205 2 00.0 KB 0 0 000:00:36
11r5-172-ac.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
12delilah.probe.onyphe.net 1 00.0 KB 0 0 000:00:04
13reese.probe.onyphe.net 1 00.0 KB 0 0 000:00:02
14r4-149-95.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
15blackburn.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
1645-79-207-110.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:01
17200.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
18azpdws8xyrej.stretchoid.com 1 00.0 KB 0 0 000:00:09
19r5-158-9e.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
20r3-147-93.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
21r4-177-b1.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
22194-88-98-119.infrawat.ch 1 00.0 KB 0 0 000:00:00
23mail.gegeweb.eu 288 00.0 KB 0 0 000:00:28
24karl.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
2562.133.46.26 4 00.0 KB 0 0 000:00:03
26104.152.52.208 3 00.0 KB 0 0 000:00:01
27172-236-228-245.ip.linodeusercontent.com 2 00.0 KB 0 0 000:00:00
2871.6.134.228 1 00.0 KB 0 0 000:00:00
29r5-156-9c.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
30104.152.52.212 5 00.0 KB 0 0 000:00:05
312a01:4020:2:b:101::4ec 1 00.0 KB 0 0 000:00:00
32104.152.52.205 2 00.0 KB 0 0 000:00:01
33o026.scanner.modat.io 1 00.0 KB 0 0 000:00:29
34194-88-98-94.infrawat.ch 1 00.0 KB 0 0 000:00:00
3569-5-169-21.infrawat.ch 1 00.0 KB 0 0 000:00:00
36104.152.52.201 1 00.0 KB 0 0 000:00:00
37r5-119-77.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
3831-14-254-66.infrawat.ch 1 00.0 KB 0 0 000:00:00
39r3-163-a3.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
TOTAL: 39 347 00.0 KB 0 0 000:02:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 2 00.0 KB 0 0 000:00:00
2unresolved 33 00.0 KB 0 0 000:01:07
3*.monitoring.internet-measurement.com 9 00.0 KB 0 0 000:00:06
4*.224.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
5*.infrawat.ch 4 00.0 KB 0 0 000:00:01
6*.probe.onyphe.net 4 00.0 KB 0 0 000:00:14
7*.scanner.modat.io 1 00.0 KB 0 0 000:00:29
8*.stretchoid.com 1 00.0 KB 0 0 000:00:09
9*.gegeweb.eu 288 00.0 KB 0 0 000:00:28
10*.ip.linodeusercontent.com 3 00.0 KB 0 0 000:00:01
11*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
TOTAL: 11 347 00.0 KB 0 0 000:02:42

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.133.205 0.227 0.042 0.00000:00:36
o026.scanner.modat.io 0.051 0.013 0.00000:00:29
mail.gegeweb.eu 5.216 4.538 1.81400:00:28
azpdws8xyrej.stretchoid.com 0.036 0.013 0.00000:00:09
174.96.78.81 0.284 0.227 0.00000:00:09
104.152.52.212 0.234 0.056 0.00000:00:05
delilah.probe.onyphe.net 0.089 0.021 0.00000:00:04
185.253.160.149 0.036 0.028 0.00000:00:04
62.133.46.26 0.078 0.099 0.00000:00:03
karl.probe.onyphe.net 0.103 0.004 0.00000:00:03
blackburn.probe.onyphe.net 0.031 0.022 0.00000:00:03
238.224.132.66.censys-scanner.com 0.014 0.014 0.00000:00:03
r3-127-7f.monitoring.internet-measurement.com 0.038 0.027 0.00000:00:03
r5-119-77.monitoring.internet-measurement.com 0.057 0.023 0.00000:00:03
reese.probe.onyphe.net 0.018 0.029 0.00000:00:02
104.152.52.205 0.077 0.025 0.00000:00:01
104.152.52.208 0.062 0.024 0.00000:00:01
45-79-207-110.ip.linodeusercontent.com 0.020 0.007 0.00000:00:01
80.66.83.80 0.019 0.005 0.00000:00:01
71.6.134.228 0.025 0.021 0.00000:00:00
TOTAL: 37 7.323 5.590 1.81400:02:42

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
62.133.46.26 13
104.152.52.212 5
172-236-228-245.ip.linodeusercontent.com 5
147.185.133.205 4
200.211.203.35.bc.googleusercontent.com 4
reese.probe.onyphe.net 3
104.152.52.210 2
80.66.83.80 1
238.224.132.66.censys-scanner.com 1
TOTAL: 9 38

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 5
Accept: */* 4
Host: 45.13.105.36:563 3
#001 2
Accept-Encoding: gzip 2
À#011À#024À#023 2
#026#003#003 2
s™n÷ÞËä<#002BýjK/#020±@êÇ#002v#035ƒ­¢‘Âr#037n+ »#030û¼ó#035µ+... 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
User-Agent: Hello from Palo Alto Network... 1
Accept-Language: en-US;q=0.8,en;q=0.7,uk... 1
MAIL FROM:<relaycheck_please_ignore@prot... 1
Accept-Encoding: br 1
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 1
Host: 45.13.105.36:119 1
Connection: close 1
#003 1
User-Agent: curl/7.68.0 1
#026#003#003#002a#001 1
User-Agent: curl/7.61.1 1
Connection: Keep-Alive 1
Host: 45.13.105.36 1
EHLO 45.13.105.36 1
EHLO www.censys.io 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
TOTAL: 25 38

NNRP client timeouts [Top 20]:

SystemConnPeer
62.133.46.26 2 3
80.66.83.80 1 1
194-88-98-119.infrawat.ch 1 1
147.185.133.205 1 2
2a01:4020:1:1:102::60e 1 1
TOTAL: 5 6 11