Daily Usenet report for news.niel.me

Feb 12 04:15:01 -- Feb 13 04:15:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Feb 12 14:55:28 rpi-studio innd: filter: No Cancel-Key[sha1:5+sEMwzOwpWkWfSSLxTDTLrQW74= sha256:fr2ytz97feY6cqILDa0x3wIxFi4fsfqbvwVXzBYMKA4=] matches Cancel-Lock[sha1:amxQkyodu/yXGhKn76ylV8CgIyU= sha256:EsHLUITHes5Oh7wEt7ZNhXQvLYQI+V/IxKnc1JRlNGg=] target=<10mi3c9$8bgh$1@gwaiyur.mb-net.net>
Feb 12 14:58:13 rpi-studio innd: filter: No Cancel-Key[sha1:wJLeLHd5QP7Y59jJxKLFjwVjzec= sha256:Lfwn5rpJnwdTpzGOBYl1TBerLE+4AdlJxIVqcNx3sZQ=] matches Cancel-Lock[sha1:iJMJVL91S7CXNI59xF47EftCQbI= sha256:B2HFj34s3Wax9WMNyg0fIRKe/3VbT0NvoFyVzOrihhE=] target=<10miaan$8kr0$1@gwaiyur.mb-net.net>
Feb 12 15:24:06 rpi-studio innd: filter: No Cancel-Key[sha1:VL0Fnwn066EX4L4RUUudtcjlwps= sha256:SiT8tVHsf9lPVADfzEKiTnnYpk9ffshgO53bk2ExBus=] matches Cancel-Lock[sha1:DEDbNM28Q6Aak/xwnUxkb4Sh2oE= sha256:uyE+Bx+bGk2JbG+q8WuC6YYNC7FOVNufHyNmCcHe53k=] target=<10mknok$fo6t$1@gwaiyur.mb-net.net>
Feb 13 00:33:11 rpi-studio innd: filter: No Cancel-Key[sha1:kso2y3aYs9nNIazLzu8cA4Rq/iQ= sha256:qD2F9xLBIcgYEsi5K0YRr0J3S+O4Q7WHv7wiMVm6Pj0=] matches Cancel-Lock[sha1:d8BPqBEezyGIWGu/+VGeaAcAx3c= sha256:SeuS7YyYKYJtZYLHcltEPLe41VexppTj6jtvs4m3u8E=] target=<10mlicl$gq5e$1@gwaiyur.mb-net.net>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2587 29.2%427.4 KB 32.1%
innd 2394 27.0%398.1 KB 29.9%
nnrpd 1982 22.4%220.7 KB 16.6%
innfeed 1897 21.4%286.9 KB 21.5%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8862 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 8721 49.1%
Negative hits 6452 36.4%
Do not exist 2566 14.5%
Cache misses 7 0.0%
TOTAL: 4 17746 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.007 0.0%8 0.333 0.875 2.000
article cancel00:00:00.009 0.0%12 0.000 0.750 4.000
article cleanup00:00:00.063 0.0%2566 0.000 0.025 0.250
article logging00:00:00.199 0.0%2566 0.000 0.078 0.400
article parse00:00:00.783 0.0%10475 0.000 0.075 0.333
article write00:00:00.937 0.0%1829 0.000 0.512 1.462
artlog/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.004 0.0%8 0.000 0.500 1.000
data move00:00:00.206 0.0%24216 0.000 0.009 0.043
hisgrep/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%13 0.000 0.077 0.500
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.298 0.0%17726 0.000 0.017 0.200
history sync00:00:00.047 0.0%357 0.000 0.132 1.000
history write00:00:00.453 0.0%2566 0.000 0.177 0.727
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:36.483100.0%25748 613.264 3357.017 23093.192
nntp read00:00:00.754 0.0%24985 0.000 0.030 0.143
overview write00:00:00.597 0.0%1829 0.000 0.326 3.600
perl filter00:00:13.224 0.0%2566 2.231 5.154 18.500
python filter00:00:00.014 0.0%2566 0.000 0.005 0.250
site send00:00:00.901 0.0%3759 0.000 0.240 0.625
TOTAL: 24:01:03.80924:00:54.980100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%1850 0.000 0.012 1.000
article prepare00:00:00.001 0.0%88 0.000 0.011 0.250
article read00:00:00.012 0.0%22 0.000 0.545 7.000
backlog stats00:00:00.159 0.0%23248 0.000 0.007 0.059
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.286 0.0%11368 0.000 0.025 0.093
data write00:00:00.643 0.0%9550 0.000 0.067 0.167
idle23:59:20.148100.0%23248 1818.103 3714.735 9539.746
status file00:00:05.418 0.0%290 0.000 18.683 82.000
TOTAL: 23:59:32.14923:59:26.689100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:46.545 44.2%1493 11.000 31.175 10014.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.118 0.1%3442 0.000 0.034 0.500
TOTAL: 00:01:45.35300:00:46.663 44.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 3 1827 585 1242 0 32%23:57:27
2news.nntp4.net 2 2662 494 1479 689 18%24:25:36
3news.samoylyk.net 3 1912 470 1397 45 24%23:47:48
4news.glou.org 4 2283 218 1974 91 9%38:39:24
5gegeweb-out.news.tnetconsulting.net 4 1268 48 1220 0 3%23:47:16
6nntp.terraraq.uk 5 1244 45 1199 0 3%21:04:20
7usenet.pasdenom.info 7 1232 18 1214 0 1%30:05:06
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 53 12428 1878 9725 825 15%185:46:57
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net2.8 MB0.0 KB19.0 MB21.8 MB 12%18.9 KB
2news.samoylyk.net2.4 MB0.0 KB103.9 KB2.5 MB 95%5.0 KB
3feed-out.gegeweb.org2.1 MB0.0 KB0.0 KB2.1 MB100%3.7 KB
4nntp.terraraq.uk790.0 KB0.0 KB0.0 KB790.0 KB100%17.6 KB
5news.glou.org603.1 KB1.2 KB243.7 KB848.0 KB 71%2.7 KB
6gegeweb-out.news.tnetconsulting.net136.7 KB0.0 KB0.0 KB136.7 KB100%2.8 KB
7usenet.pasdenom.info39.1 KB0.0 KB0.0 KB39.1 KB100%2.2 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 88.8 MB1.2 KB19.3 MB28.2 MB 31%10.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 12 04:15:01 - 04:59:59 49 2.7% 0.02266.3 KB 3.0% 0.10
Feb 12 05:00:00 - 05:59:59 52 2.8% 0.01307.9 KB 3.5% 0.09
Feb 12 06:00:00 - 06:59:59 50 2.7% 0.01270.8 KB 3.0% 0.08
Feb 12 07:00:00 - 07:59:59 28 1.5% 0.01247.3 KB 2.8% 0.07
Feb 12 08:00:00 - 08:59:59 59 3.2% 0.02301.0 KB 3.4% 0.08
Feb 12 09:00:00 - 09:59:59 70 3.8% 0.02397.3 KB 4.5% 0.11
Feb 12 10:00:00 - 10:59:59 63 3.4% 0.02244.8 KB 2.7% 0.07
Feb 12 11:00:00 - 11:59:59 70 3.8% 0.02287.6 KB 3.2% 0.08
Feb 12 12:00:00 - 12:59:59 75 4.1% 0.02466.6 KB 5.2% 0.13
Feb 12 13:00:00 - 13:59:59 78 4.3% 0.02363.3 KB 4.1% 0.10
Feb 12 14:00:00 - 14:59:59 81 4.4% 0.02305.7 KB 3.4% 0.08
Feb 12 15:00:00 - 15:59:59 81 4.4% 0.02378.2 KB 4.2% 0.11
Feb 12 16:00:00 - 16:59:59 86 4.7% 0.02377.2 KB 4.2% 0.10
Feb 12 17:00:00 - 17:59:59 84 4.6% 0.02358.8 KB 4.0% 0.10
Feb 12 18:00:00 - 18:59:59 94 5.1% 0.03385.9 KB 4.3% 0.11
Feb 12 19:00:00 - 19:59:59 112 6.1% 0.03575.1 KB 6.5% 0.16
Feb 12 20:00:00 - 20:59:59 93 5.1% 0.03359.9 KB 4.0% 0.10
Feb 12 21:00:00 - 21:59:59 129 7.0% 0.04428.7 KB 4.8% 0.12
Feb 12 22:00:00 - 22:59:59 103 5.6% 0.03567.3 KB 6.4% 0.16
Feb 12 23:00:00 - 23:59:59 82 4.5% 0.02484.9 KB 5.4% 0.13
Feb 13 00:00:00 - 00:59:59 85 4.6% 0.02465.7 KB 5.2% 0.13
Feb 13 01:00:00 - 01:59:59 83 4.5% 0.02356.4 KB 4.0% 0.10
Feb 13 02:00:00 - 02:59:59 58 3.2% 0.02237.3 KB 2.7% 0.07
Feb 13 03:00:00 - 03:59:59 56 3.1% 0.02283.3 KB 3.2% 0.08
Feb 13 04:00:00 - 04:15:01 9 0.5% 0.01187.4 KB 2.1% 0.21
TOTAL: 24:00:00 1830 100.0% 0.028.7 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 629 179 0 0 0 0 0 0 450
2news.glou.org 59 0 0 0 0 0 0 0 59
3news.samoylyk.net 45 0 0 0 0 0 0 0 45
4gegeweb-out.news.tnetconsulting.net 4 0 0 0 0 0 0 0 4
TOTAL: 4 737 179 0 0 0 0 0 0 558

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 116
linux.kernel.git 61
alt.slack 1
news.test 1
TOTAL: 4 179

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 439
EMP (phn path) 78
Bad path (news.giganews.com.POSTED) 38
EMP (md5) 1
Cancel of non-existing ID <10mkoqk$1hhfd$1@dont-email.me> 1
Cancels abusifs 1
TOTAL: 6 558

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 3350 10 1808 11 0 20 0%23:57:01
2news.samoylyk.net 1401 1 1256 0 0 0 0%23:56:05
3news.pasdenom.info 1273 0 1184 0 0 0 0%23:53:46
4i2pn.org 0 0 0 0 0 1814 0%24:00:00
5nntp.terraraq.uk 1009 0 960 0 0 0 0%23:34:28
6news.aioe.org 0 0 0 0 0 1477 0%24:00:00
7news.gegeweb.org 1285 0 1240 0 0 1 0%23:56:19
8news.nntp4.net 1385 0 1336 0 0 0 0%23:45:13
TOTAL: 8 9703 11 7784 11 0 3312 0%191:02:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net66.6 KB82.2 KB148.8 KB0.0 KB/s7.1 KB23:57:01
2news.samoylyk.net3.0 KB0.0 KB3.0 KB0.0 KB/s3.0 KB23:56:05
3news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:46
4i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
5nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:34:28
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:19
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:45:13
TOTAL: 869.6 KB82.2 KB151.8 KB0.0 KB/s6.9 KB191:02:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
148.217.64.148 2 00.0 KB 0 0 000:00:10
22a06:4882:5000::66 1 00.0 KB 0 0 000:00:03
32603:6010:6800:36:1a03:73ff:fe28:be0f 8 00.0 KB 0 0 000:00:06
4yousef.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
5katelyn.probe.onyphe.net 1 00.0 KB 0 0 000:00:00
62a06:4883:5000::6d 1 00.0 KB 0 0 000:00:02
7205.210.31.40 1 00.0 KB 0 0 000:00:00
8147.185.133.60 2 00.0 KB 0 0 000:01:03
9195.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
10davila.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
11193.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
1235.34.168.206.censys-scanner.com 1 00.0 KB 0 0 000:00:01
1331.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
14150.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
1596.155.45.199.censys-scanner.com 3 00.0 KB 0 0 000:00:00
1645.227.254.152 1 00.0 KB 0 0 000:00:00
17traci.probe.onyphe.net 1 00.0 KB 0 0 000:00:02
18mail.gegeweb.eu 288 00.0 KB 0 0 000:00:27
19240e:108:4bc6:fffe::3 2 00.0 KB 0 0 000:00:01
20150.154.45.199.censys-scanner.com 7 00.0 KB 0 0 000:00:06
21198.235.24.71 1 00.0 KB 0 0 000:00:01
TOTAL: 21 326 00.0 KB 0 0 000:02:16

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.34.168.206.censys-scanner.com 1 00.0 KB 0 0 000:00:01
2*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
3unresolved 7 00.0 KB 0 0 000:01:16
4*.155.45.199.censys-scanner.com 3 00.0 KB 0 0 000:00:00
5*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
6? 12 00.0 KB 0 0 000:00:14
7*.154.45.199.censys-scanner.com 7 00.0 KB 0 0 000:00:06
8*.149.216.162.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:00
9*.probe.onyphe.net 4 00.0 KB 0 0 000:00:09
10*.gegeweb.eu 288 00.0 KB 0 0 000:00:27
TOTAL: 10 326 00.0 KB 0 0 000:02:16

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.60 0.316 0.086 0.00000:01:03
mail.gegeweb.eu 5.175 4.217 1.65700:00:27
48.217.64.148 0.041 0.028 0.00000:00:10
150.154.45.199.censys-scanner.com 0.281 0.083 0.00000:00:06
2603:6010:6800:36:1a03:73ff:fe28:be0f 0.210 0.147 0.00000:00:06
2a06:4882:5000::66 0.014 0.010 0.00000:00:03
davila.probe.onyphe.net 0.033 0.019 0.00000:00:03
yousef.probe.onyphe.net 0.029 0.017 0.00000:00:03
traci.probe.onyphe.net 0.018 0.025 0.00000:00:02
2a06:4883:5000::6d 0.035 0.012 0.00000:00:02
198.235.24.71 0.025 0.025 0.00000:00:01
240e:108:4bc6:fffe::3 0.058 0.031 0.00000:00:01
35.34.168.206.censys-scanner.com 0.044 0.018 0.00000:00:01
195.149.216.162.bc.googleusercontent.com 0.075 0.024 0.00000:00:00
96.155.45.199.censys-scanner.com 0.122 0.052 0.00000:00:00
205.210.31.40 0.011 0.011 0.00000:00:00
193.149.216.162.bc.googleusercontent.com 0.044 0.004 0.00000:00:00
150.210.203.35.bc.googleusercontent.com 0.066 0.021 0.00000:00:00
katelyn.probe.onyphe.net 0.025 0.025 0.00000:00:00
45.227.254.152 0.044 0.020 0.00000:00:00
TOTAL: 21 6.691 4.900 1.65700:02:16

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
2a06:4882:5000::66 6
195.149.216.162.bc.googleusercontent.com 4
147.185.133.60 4
150.210.203.35.bc.googleusercontent.com 4
31.211.203.35.bc.googleusercontent.com 4
193.149.216.162.bc.googleusercontent.com 4
katelyn.probe.onyphe.net 2
davila.probe.onyphe.net 2
150.154.45.199.censys-scanner.com 1
35.34.168.206.censys-scanner.com 1
48.217.64.148 1
TOTAL: 11 33

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 6
Accept-Encoding: gzip 5
Host: 45.13.105.36:563 4
User-Agent: Hello from Palo Alto Network... 4
EHLO www.censys.io 2
Accept: */* 2
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 2
#026#003#003#001½#001 1
User-Agent: Mozilla/5.0 (compatible; Int... 1
#026#003#003#001¥#001 1
Host: 45.13.105.36:119 1
User-Agent: curl/7.68.0 1
Host: [2a0e:e701:1154:0:4e10:5c89:4af0:d... 1
Connection: close 1
MGLNDD_45.13.105.36_119 1
TOTAL: 15 33

NNRP client timeouts [Top 20]:

SystemConnPeer
147.185.133.60 1 2
TOTAL: 1 1 4