Daily Usenet report for news.niel.me

Oct 8 04:15:02 -- Oct 9 04:15:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Oct 8 06:56:36 rpi-studio innd: filter: No Cancel-Key[sha1:tdVzMpz3xL1+Gsw/dR/f1GY1tSA= sha256:ja/V6ZQ+4pin9wRL+fbySjeQ1xAhM+cfLsuf74Nkkis=] matches Cancel-Lock[sha1:6pbeDy3PcY36jhRiMyQvrcvSDo8= sha256:XzflPakSuLcVxg4C6SRCl3WcFuKC30EnJJ5IwMAsiPE=] target=<11a6que$1gq8j$1@gwaiyur.mb-net.net>
Oct 9 01:07:06 rpi-studio innd: filter: No Cancel-Key[sha1:ujQfH+BSwdGj+LwvGP1lk9c2AJs= sha256:t9fxKBkaIrDl8Sgq7XUMJojfm5U7xz1a6IA3mfs32bY=] matches Cancel-Lock[sha1:YoUsRwTFLUmsI4sbn3/HT0DgmP8= sha256:gD1VGhNPURQTQ5jp3+wOhnkqqC4DEpqGBNOjNCMMb9E=] target=<11a97cj$9ma5$1@dont-email.me>
Oct 9 01:07:25 rpi-studio innd: filter: No Cancel-Key[sha1:ujQfH+BSwdGj+LwvGP1lk9c2AJs= sha256:t9fxKBkaIrDl8Sgq7XUMJojfm5U7xz1a6IA3mfs32bY=] matches Cancel-Lock[sha1:YoUsRwTFLUmsI4sbn3/HT0DgmP8= sha256:gD1VGhNPURQTQ5jp3+wOhnkqqC4DEpqGBNOjNCMMb9E=] target=<11a97cj$9ma5$1@dont-email.me>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2600 30.1%439.8 KB 33.5%
nnrpd 2209 25.6%266.3 KB 20.3%
innd 1977 22.9%347.0 KB 26.4%
innfeed 1844 21.4%260.0 KB 19.8%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8632 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 8133 48.9%
Negative hits 5930 35.6%
Do not exist 2580 15.5%
Cache misses 4 0.0%
TOTAL: 4 16647 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.013 0.0%7 1.000 1.857 6.000
article cancel00:00:00.002 0.0%8 0.000 0.250 1.000
article cleanup00:00:00.051 0.0%2588 0.000 0.020 0.167
article logging00:00:00.204 0.0%2588 0.000 0.079 0.308
article parse00:00:00.596 0.0%7375 0.000 0.081 0.273
article write00:00:00.925 0.0%1744 0.000 0.530 2.500
artlog/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
data move00:00:00.149 0.0%19665 0.000 0.008 0.047
hisgrep/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%10 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.297 0.0%16693 0.000 0.018 0.094
history sync00:00:00.037 0.0%348 0.000 0.106 1.000
history write00:00:00.491 0.0%2588 0.000 0.190 0.647
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:30.705100.0%21957 1392.480 3936.362 15394.718
nntp read00:00:00.622 0.0%21172 0.000 0.029 0.069
overview write00:00:00.598 0.0%1744 0.000 0.343 2.643
perl filter00:00:12.872 0.0%2586 1.810 4.978 16.000
python filter00:00:00.018 0.0%2586 0.000 0.007 0.095
site send00:00:00.797 0.0%3533 0.000 0.226 0.562
TOTAL: 24:01:05.97624:00:48.377100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.017 0.0%1755 0.000 0.010 0.250
article prepare00:00:00.000 0.0%36 0.000 0.000 0.000
article read00:00:00.004 0.0%9 0.000 0.444 3.000
backlog stats00:00:00.136 0.0%22648 0.000 0.006 0.028
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.303 0.0%10986 0.000 0.028 0.125
data write00:00:00.508 0.0%9264 0.000 0.055 0.171
idle23:50:42.269100.0%22648 1461.022 3790.280 10008.183
status file00:00:06.187 0.0%287 0.000 21.557 82.000
TOTAL: 23:50:53.06623:50:49.424100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:55.913 37.2%1520 7.000 36.785 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.120 0.1%3532 0.000 0.034 0.500
TOTAL: 00:02:30.40500:00:56.033 37.3%----

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 2 1730 618 1112 0 35%23:58:04
2news.samoylyk.net 2 1700 368 1332 0 21%22:22:51
3news.nntp4.net 2 2256 303 1232 721 13%19:54:48
4nntp.terraraq.uk 4 1249 188 1050 11 15%22:25:56
5news.glou.org 3 1157 107 1025 25 9%21:05:04
6usenet.pasdenom.info 11 789 26 759 4 3%24:36:56
7gegeweb-out.news.tnetconsulting.net 3 1180 21 1158 1 1%22:27:22
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 52 10061 1631 7668 762 16%156:51:01
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org2.1 MB0.0 KB0.0 KB2.1 MB100%3.4 KB
2news.samoylyk.net2.0 MB0.0 KB0.0 KB2.0 MB100%5.7 KB
3news.nntp4.net1.0 MB0.0 KB7.9 MB8.9 MB 11%8.9 KB
4nntp.terraraq.uk616.5 KB0.0 KB25.4 KB641.9 KB 96%3.2 KB
5news.glou.org388.9 KB0.0 KB111.0 KB499.9 KB 77%3.8 KB
6usenet.pasdenom.info73.5 KB0.0 KB4.9 KB78.4 KB 93%2.6 KB
7gegeweb-out.news.tnetconsulting.net69.8 KB0.0 KB3.6 KB73.4 KB 95%3.3 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 86.2 MB0.0 KB8.0 MB14.2 MB 43%6.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 8 04:15:02 - 04:59:59 41 2.4% 0.02170.2 KB 2.5% 0.06
Oct 8 05:00:00 - 05:59:59 30 1.7% 0.01119.7 KB 1.7% 0.03
Oct 8 06:00:00 - 06:59:59 40 2.3% 0.01167.9 KB 2.4% 0.05
Oct 8 07:00:00 - 07:59:59 38 2.2% 0.01111.7 KB 1.6% 0.03
Oct 8 08:00:00 - 08:59:59 39 2.2% 0.01125.9 KB 1.8% 0.03
Oct 8 09:00:00 - 09:59:59 80 4.6% 0.02321.9 KB 4.7% 0.09
Oct 8 10:00:00 - 10:59:59 61 3.5% 0.02208.8 KB 3.0% 0.06
Oct 8 11:00:00 - 11:59:59 83 4.8% 0.02293.1 KB 4.2% 0.08
Oct 8 12:00:00 - 12:59:59 96 5.5% 0.03373.9 KB 5.4% 0.10
Oct 8 13:00:00 - 13:59:59 82 4.7% 0.02240.5 KB 3.5% 0.07
Oct 8 14:00:00 - 14:59:59 90 5.2% 0.03530.3 KB 7.7% 0.15
Oct 8 15:00:00 - 15:59:59 118 6.8% 0.03444.0 KB 6.4% 0.12
Oct 8 16:00:00 - 16:59:59 64 3.7% 0.02380.9 KB 5.5% 0.11
Oct 8 17:00:00 - 17:59:59 103 5.9% 0.03350.0 KB 5.1% 0.10
Oct 8 18:00:00 - 18:59:59 72 4.1% 0.02261.3 KB 3.8% 0.07
Oct 8 19:00:00 - 19:59:59 74 4.2% 0.02261.9 KB 3.8% 0.07
Oct 8 20:00:00 - 20:59:59 95 5.5% 0.03288.8 KB 4.2% 0.08
Oct 8 21:00:00 - 21:59:59 69 4.0% 0.02332.3 KB 4.8% 0.09
Oct 8 22:00:00 - 22:59:59 69 4.0% 0.02260.5 KB 3.8% 0.07
Oct 8 23:00:00 - 23:59:59 110 6.3% 0.03410.6 KB 5.9% 0.11
Oct 9 00:00:00 - 00:59:59 112 6.4% 0.03422.0 KB 6.1% 0.12
Oct 9 01:00:00 - 01:59:59 62 3.6% 0.02204.2 KB 3.0% 0.06
Oct 9 02:00:00 - 02:59:59 46 2.6% 0.01289.3 KB 4.2% 0.08
Oct 9 03:00:00 - 03:59:59 52 3.0% 0.01288.3 KB 4.2% 0.08
Oct 9 04:00:00 - 04:15:01 16 0.9% 0.0259.5 KB 0.9% 0.07
TOTAL: 23:59:59 1742 100.0% 0.026.8 MB 100.0% 0.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 797 684 0 0 0 2 0 0 111
2news.glou.org 29 0 0 0 0 0 0 0 29
3nntp.terraraq.uk 12 0 0 0 0 0 0 0 12
4usenet.pasdenom.info 4 0 0 0 0 0 0 0 4
5gegeweb-out.news.tnetconsulting.net 1 0 0 0 0 0 0 0 1
TOTAL: 5 843 684 0 0 0 2 0 0 157

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 608
linux.kernel.git 76
TOTAL: 2 684

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 89
Bad path (news.giganews.com.POSTED) 44
Binary: misplaced binary 17
Cancels abusifs 4
No Cancel-Key matches Cancel-Lock. target=<11a97cj$9ma5$1@dont-email.me> 2
HTML Multipart 1
TOTAL: 6 157

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 3050 3 1734 3 0 21 0%23:59:57
2news.samoylyk.net 1535 1 1317 1 0 0 0%23:57:49
3news.pasdenom.info 1337 1 1272 0 0 0 0%23:58:58
4news.aioe.org 0 0 0 0 0 1472 0%23:59:59
5i2pn.org 0 0 0 0 0 1738 0%23:59:59
6news.nntp4.net 1440 0 1360 0 0 0 0%23:55:38
7news.gegeweb.org 1194 0 1129 0 0 0 0%23:55:17
8nntp.terraraq.uk 818 0 783 0 0 0 0%23:31:44
TOTAL: 8 9374 5 7595 4 0 3231 0%191:19:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net4.9 KB5.9 KB10.8 KB0.0 KB/s1.8 KB23:59:57
2news.pasdenom.info4.1 KB0.0 KB4.1 KB0.0 KB/s4.1 KB23:58:58
3news.samoylyk.net2.9 KB3.9 KB6.8 KB0.0 KB/s3.4 KB23:57:49
4news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
5i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
6news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:55:38
7news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:55:17
8nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:31:44
TOTAL: 811.9 KB9.8 KB21.8 KB0.0 KB/s2.4 KB191:19:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12a01:4020:1:1:101::5ee 1 00.0 KB 0 0 000:00:00
2104.152.52.242 4 00.0 KB 0 0 000:00:00
3243.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
445-79-211-97.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
5wiggins.probe.onyphe.net 1 00.0 KB 0 0 000:00:02
645-79-207-129.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
766.61.98.95 6 00.0 KB 0 0 000:00:04
8mail.gegeweb.eu 288 00.0 KB 0 0 000:00:27
9172-104-13-149.ip.linodeusercontent.com 11 00.0 KB 0 0 000:00:25
10194-195-210-47.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:04
11riga.scan.bufferover.run 1 00.0 KB 0 0 000:00:01
1245-33-14-197.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
13104.152.52.234 4 00.0 KB 0 0 000:00:03
1450-116-26-161.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
15193-176-31-232.infrawat.ch 1 00.0 KB 0 0 000:00:00
1669-5-169-53.infrawat.ch 1 00.0 KB 0 0 000:00:00
17212.102.40.218 4 00.0 KB 0 0 000:00:00
18104.152.52.241 1 00.0 KB 0 0 000:00:00
19101.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:00
20198.235.24.67 1 00.0 KB 0 0 000:00:00
2169-5-169-122.infrawat.ch 1 00.0 KB 0 0 000:00:00
2220.118.203.112 2 00.0 KB 0 0 000:00:10
23118.193.56.184 3 00.0 KB 0 0 000:00:12
24o020.scanner.modat.io 1 00.0 KB 0 0 000:00:30
25o011.scanner.modat.io 1 00.0 KB 0 0 000:00:01
26104.152.52.236 3 00.0 KB 0 0 000:00:03
272a01:4020:1:1:102::77 1 00.0 KB 0 0 000:00:00
282603:6010:6802:4ca5:1a03:73ff:fe28:be0f 24 00.0 KB 0 0 000:00:10
29youssef.probe.onyphe.net 1 00.0 KB 0 0 000:00:00
30154-16-44-67.infrawat.ch 1 00.0 KB 0 0 000:00:00
31193.195.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:03
3245-33-12-122.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
33104.152.52.232 1 00.0 KB 0 0 000:00:01
TOTAL: 33 374 00.0 KB 0 0 000:02:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 29 00.0 KB 0 0 000:00:36
2? 26 00.0 KB 0 0 000:00:11
3*.scanner.modat.io 2 00.0 KB 0 0 000:00:31
4*.scan.bufferover.run 1 00.0 KB 0 0 000:00:01
5*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
6*.infrawat.ch 4 00.0 KB 0 0 000:00:00
7*.195.132.66.censys-scanner.com 4 00.0 KB 0 0 000:00:04
8*.gegeweb.eu 288 00.0 KB 0 0 000:00:27
9*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
10*.ip.linodeusercontent.com 17 00.0 KB 0 0 000:00:32
TOTAL: 10 374 00.0 KB 0 0 000:02:29

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
o020.scanner.modat.io 0.015 0.015 0.00000:00:30
mail.gegeweb.eu 5.430 4.406 1.76800:00:27
172-104-13-149.ip.linodeusercontent.com 0.525 0.207 0.00000:00:25
118.193.56.184 0.083 0.067 0.00000:00:12
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f 0.512 0.430 0.00000:00:10
20.118.203.112 0.027 0.017 0.00000:00:10
194-195-210-47.ip.linodeusercontent.com 0.021 0.024 0.00000:00:04
66.61.98.95 0.145 0.117 0.00000:00:04
193.195.132.66.censys-scanner.com 0.077 0.061 0.00000:00:03
104.152.52.236 0.089 0.043 0.00000:00:03
104.152.52.234 0.095 0.077 0.00000:00:03
wiggins.probe.onyphe.net 0.008 0.016 0.00000:00:02
riga.scan.bufferover.run 0.040 0.012 0.00000:00:01
104.152.52.232 0.021 0.005 0.00000:00:01
o011.scanner.modat.io 0.033 0.019 0.00000:00:01
45-79-207-129.ip.linodeusercontent.com 0.022 0.030 0.00000:00:00
101.195.132.66.censys-scanner.com 0.034 0.030 0.00000:00:00
104.152.52.242 0.095 0.034 0.00000:00:00
45-79-211-97.ip.linodeusercontent.com 0.039 0.012 0.00000:00:00
198.235.24.67 0.018 0.029 0.00000:00:00
TOTAL: 33 7.855 5.893 1.76800:02:29

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
104.152.52.236 5
243.210.203.35.bc.googleusercontent.com 4
194-195-210-47.ip.linodeusercontent.com 2
118.193.56.184 2
104.152.52.242 2
youssef.probe.onyphe.net 2
45-79-207-129.ip.linodeusercontent.com 2
101.195.132.66.censys-scanner.com 1
193.195.132.66.censys-scanner.com 1
20.118.203.112 1
TOTAL: 10 22

NNRP unrecognized commands (by command):

CommandCount
#026#003#001 3
EHLO www.censys.io 2
#001 2
GET / HTTP/1.1 2
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 1
#026#003#003#002a#001 1
Host: 45.13.105.36 1
MGLNDD_45.13.105.36_119 1
User-Agent: curl/7.61.1 1
Accept: */* 1
MAIL FROM:<relaycheck_please_ignore@prot... 1
EHLO 45.13.105.36 1
Accept-Encoding: gzip 1
Connection: close 1
À#024 1
User-Agent: Hello from Palo Alto Network... 1
Host: 45.13.105.36:119 1
TOTAL: 17 22

NNRP client timeouts [Top 20]:

SystemConnPeer
45-79-207-129.ip.linodeusercontent.com 1 1
193.195.132.66.censys-scanner.com 1 2
193-176-31-232.infrawat.ch 1 1
2a01:4020:1:1:102::77 1 1
194-195-210-47.ip.linodeusercontent.com 1 1
TOTAL: 5 5 10