Daily Usenet report for news.niel.me

Sep 24 04:15:02 -- Sep 25 04:15:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Sep 24 10:12:43 rpi-studio innd: filter: No Cancel-Key[sha1:lAdbrHGYEGfZFfRhhBytqcBGwxY= sha256:AzdC/KCwmqUULpzIkJXzWPUknmn5gnDrgS3zpWnSxUo=] matches Cancel-Lock[sha1:EarTwEKa7i29MQo+q6UBFeTVzh0= sha256:bn4Iz8nZanETjCS/Q3UG82YW/RFjG1+CDO+4YFNBYHI=] target=<1192idv$2f7v6$1@dont-email.me>
Sep 24 19:49:26 rpi-studio innd: filter: No Cancel-Key[sha1:Em1bul/zAszFwdXc3iUAbnzt9is= sha256:UuwRrUWctmYl55Ls997fno0J276nedSIElpfb6Kt5rw=] matches Cancel-Lock[sha1:Vt9jSnJWIc8zS42LgwPucWH2Roo= sha256:JIRcunKYoCY2cn8F0nYynMWDJZV77Rn5bbYvVS+CPj0=] target=<1192uto$2jlnt$1@dont-email.me>
Sep 24 23:47:32 rpi-studio innd: filter: No Cancel-Key[sha1:PwyA21v++Gi1putqGaCY4vN0Nrc= sha256:rymWa9aT2/AzlRxfGztczRktLSsQSISJDIzcZWg/GNY=] matches Cancel-Lock[sha1:US2cHwfNJUIZQJvOLx5MOKZtfV0= sha256:anHfdrl475YPO03v7w79gY5HQrIgREVvGvTcbQH+SDo=] target=<11945kh$l6ik$1@gwaiyur.mb-net.net>
Sep 25 03:41:08 rpi-studio innd: filter: No Cancel-Key[sha1:EBvveR2t6Bh8+ZxfTN6JddpqPhc= sha256:ft5loIblur2JqP1acY1OwVv4ZFMEbtqlA84ERQgQcOo=] matches Cancel-Lock[sha1:2EytqCY48tG6LnaM4Qdf60p2EcI= sha256:aJPQ3hvQcNeC1fv4ZLujWxyB/zNwXe0kVpoyxOKHSro=] target=<1194i7u$2tm8$1@nnrp.usenet.blueworldhosting.com>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2484 30.3%417.1 KB 33.3%
innd 2011 24.5%348.9 KB 27.9%
innfeed 1876 22.9%276.2 KB 22.1%
nnrpd 1820 22.2%208.7 KB 16.7%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 8193 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 7617 44.9%
Negative hits 6903 40.7%
Do not exist 2455 14.5%
Cache misses 5 0.0%
TOTAL: 4 16980 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.008 0.0%9 0.667 0.889 1.000
article cancel00:00:00.006 0.0%13 0.000 0.462 2.000
article cleanup00:00:00.053 0.0%2468 0.000 0.021 0.250
article logging00:00:00.198 0.0%2468 0.000 0.080 0.300
article parse00:00:00.515 0.0%7405 0.000 0.070 0.239
article write00:00:00.970 0.0%1747 0.000 0.555 2.167
artlog/artcncl00:00:00.001 0.0%13 0.000 0.077 1.000
artlog/artcncl/perl00:00:00.001 0.0%9 0.000 0.111 1.000
data move00:00:00.137 0.0%20547 0.000 0.007 0.032
hisgrep/artcncl00:00:00.002 0.0%13 0.000 0.154 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%9 0.000 0.000 0.000
hisgrep/perl00:00:00.003 0.0%15 0.000 0.200 1.000
hishave/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.001 0.0%9 0.000 0.111 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.291 0.0%17022 0.000 0.017 0.066
history sync00:00:00.047 0.0%341 0.000 0.138 1.000
history write00:00:00.474 0.0%2468 0.000 0.192 0.750
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:30.399100.0%22150 986.549 3902.050 31592.579
nntp read00:00:00.615 0.0%21370 0.000 0.029 0.083
overview write00:00:00.591 0.0%1747 0.000 0.338 2.000
perl filter00:00:13.595 0.0%2468 2.071 5.509 27.250
python filter00:00:00.013 0.0%2468 0.000 0.005 0.111
site send00:00:00.820 0.0%3519 0.000 0.233 0.562
TOTAL: 24:01:06.90524:00:48.740100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.009 0.0%1755 0.000 0.005 0.111
article prepare00:00:00.001 0.0%4 0.250 0.250 0.250
article read00:00:00.007 0.0%1 7.000 7.000 7.000
backlog stats00:00:00.124 0.0%21566 0.000 0.006 0.032
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.264 0.0%10451 0.000 0.025 0.136
data write00:00:00.533 0.0%8745 0.000 0.061 0.172
idle23:58:55.144100.0%21566 1253.409 4003.299 10192.102
status file00:00:05.524 0.0%278 0.000 19.871 77.000
TOTAL: 23:59:08.03623:59:01.606100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:07.951 61.4%1468 22.000 46.288 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.107 0.1%3259 0.000 0.033 1.000
TOTAL: 00:01:50.71000:01:08.058 61.5%----

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 1732 607 1125 0 35%23:56:39
2news.samoylyk.net 3 2283 517 1766 0 22%30:55:10
3news.nntp4.net 2 2335 478 1207 650 20%22:08:41
4nntp.terraraq.uk 5 1937 174 1758 5 8%39:56:30
5news.glou.org 4 1171 74 1073 24 6%23:49:54
6usenet.pasdenom.info 21 695 16 678 1 2%23:31:59
7gegeweb-out.news.tnetconsulting.net 6 2001 9 1990 2 0%40:50:49
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 69 12154 1875 9597 682 15%205:09:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net3.0 MB0.0 KB0.0 KB3.0 MB100%6.0 KB
2news.nntp4.net2.3 MB0.0 KB6.7 MB9.0 MB 25%8.2 KB
3feed-out.gegeweb.org2.2 MB0.0 KB0.0 KB2.2 MB100%3.7 KB
4nntp.terraraq.uk685.4 KB0.0 KB8.8 KB694.3 KB 98%3.9 KB
5news.glou.org282.3 KB0.0 KB75.4 KB357.7 KB 78%3.6 KB
6usenet.pasdenom.info33.8 KB0.0 KB1.2 KB35.1 KB 96%2.1 KB
7gegeweb-out.news.tnetconsulting.net18.7 KB0.0 KB10.9 KB29.6 KB 63%2.7 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 88.5 MB0.0 KB6.8 MB15.3 MB 55%6.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 24 04:15:02 - 04:59:59 69 3.9% 0.03395.5 KB 4.9% 0.15
Sep 24 05:00:00 - 05:59:59 48 2.7% 0.01158.5 KB 2.0% 0.04
Sep 24 06:00:00 - 06:59:59 40 2.3% 0.01120.5 KB 1.5% 0.03
Sep 24 07:00:00 - 07:59:59 67 3.8% 0.02213.3 KB 2.7% 0.06
Sep 24 08:00:00 - 08:59:59 28 1.6% 0.01112.4 KB 1.4% 0.03
Sep 24 09:00:00 - 09:59:59 77 4.4% 0.02307.8 KB 3.8% 0.09
Sep 24 10:00:00 - 10:59:59 60 3.4% 0.02212.9 KB 2.7% 0.06
Sep 24 11:00:00 - 11:59:59 97 5.5% 0.03387.1 KB 4.8% 0.11
Sep 24 12:00:00 - 12:59:59 98 5.6% 0.03390.0 KB 4.9% 0.11
Sep 24 13:00:00 - 13:59:59 60 3.4% 0.02193.2 KB 2.4% 0.05
Sep 24 14:00:00 - 14:59:59 81 4.6% 0.02313.4 KB 3.9% 0.09
Sep 24 15:00:00 - 15:59:59 73 4.2% 0.02375.0 KB 4.7% 0.10
Sep 24 16:00:00 - 16:59:59 80 4.6% 0.02255.0 KB 3.2% 0.07
Sep 24 17:00:00 - 17:59:59 75 4.3% 0.02866.5 KB 10.8% 0.24
Sep 24 18:00:00 - 18:59:59 79 4.5% 0.02480.8 KB 6.0% 0.13
Sep 24 19:00:00 - 19:59:59 95 5.4% 0.03323.4 KB 4.0% 0.09
Sep 24 20:00:00 - 20:59:59 94 5.4% 0.03345.8 KB 4.3% 0.10
Sep 24 21:00:00 - 21:59:59 108 6.2% 0.03407.9 KB 5.1% 0.11
Sep 24 22:00:00 - 22:59:59 94 5.4% 0.03487.6 KB 6.1% 0.14
Sep 24 23:00:00 - 23:59:59 79 4.5% 0.02458.4 KB 5.7% 0.13
Sep 25 00:00:00 - 00:59:59 69 3.9% 0.02361.4 KB 4.5% 0.10
Sep 25 01:00:00 - 01:59:59 73 4.2% 0.02278.7 KB 3.5% 0.08
Sep 25 02:00:00 - 02:59:59 41 2.3% 0.01225.4 KB 2.8% 0.06
Sep 25 03:00:00 - 03:59:59 51 2.9% 0.01198.5 KB 2.5% 0.06
Sep 25 04:00:00 - 04:15:01 15 0.9% 0.02162.6 KB 2.0% 0.18
TOTAL: 23:59:59 1751 100.0% 0.027.8 MB 100.0% 0.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 684 592 0 0 0 0 0 0 92
2news.glou.org 24 0 0 0 0 0 0 0 24
3usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
4nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
5gegeweb-out.news.tnetconsulting.net 1 0 0 0 0 0 0 0 1
TOTAL: 5 711 592 0 0 0 0 0 0 119

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 513
linux.kernel.git 79
TOTAL: 2 592

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 78
Bad path (news.giganews.com.POSTED) 35
Cancel of non-existing ID <1192idv$2f7v6$1@dont-email.me> 2
Cancels abusifs 2
HTML Multipart 2
TOTAL: 5 119

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.pasdenom.info 1203 0 1184 0 0 0 0%23:51:57
2news.tnetconsulting.net 3056 0 1747 1 0 6 0%23:59:57
3nntp.terraraq.uk 893 0 884 0 0 0 0%23:42:11
4i2pn.org 0 0 0 0 0 1746 0%23:59:59
5news.gegeweb.org 1224 0 1153 0 0 0 0%23:56:44
6news.aioe.org 0 0 0 0 0 1340 0%23:59:59
7news.samoylyk.net 1257 0 1208 0 0 0 0%23:54:06
8news.nntp4.net 1216 0 1207 0 0 0 0%23:51:07
TOTAL: 8 8849 0 7383 1 0 3092 0%191:16:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:51:57
2news.tnetconsulting.net0.0 KB1.9 KB1.9 KB0.0 KB/s1.9 KB23:59:57
3nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:42:11
4i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
5news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:44
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
7news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:06
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:51:07
TOTAL: 80.0 KB1.9 KB1.9 KB0.0 KB/s1.9 KB191:16:00
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
171.6.134.204 1 00.0 KB 0 0 000:00:00
2tara.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
3119.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:00
420.84.99.232 2 00.0 KB 0 0 000:00:10
5gordon.probe.onyphe.net 1 00.0 KB 0 0 000:00:00
6216.226.77.20 1 00.0 KB 0 0 000:00:00
7o001.scanner.modat.io 1 00.0 KB 0 0 000:00:00
8152.32.208.106 3 00.0 KB 0 0 000:00:11
9193-176-31-198.infrawat.ch 1 00.0 KB 0 0 000:00:00
10o029.scanner.modat.io 1 00.0 KB 0 0 000:00:00
1145-133-173-118.infrawat.ch 1 00.0 KB 0 0 000:00:00
12r5-202-ca.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
13mail.gegeweb.eu 288 00.0 KB 0 0 000:00:41
14244.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
15o033.scanner.modat.io 1 00.0 KB 0 0 000:00:30
1616.5.0.238 1 00.0 KB 0 0 000:00:03
17o040.scanner.modat.io 1 00.0 KB 0 0 000:00:00
1816.5.0.239 1 00.0 KB 0 0 000:00:03
TOTAL: 18 308 00.0 KB 0 0 000:01:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
2*.gegeweb.eu 288 00.0 KB 0 0 000:00:41
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
4*.infrawat.ch 2 00.0 KB 0 0 000:00:00
5*.195.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:00
6*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
7*.scanner.modat.io 4 00.0 KB 0 0 000:00:30
8unresolved 9 00.0 KB 0 0 000:00:30
TOTAL: 8 308 00.0 KB 0 0 000:01: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
mail.gegeweb.eu 5.182 4.816 1.60300:00:41
o033.scanner.modat.io 0.036 0.019 0.00000:00:30
152.32.208.106 0.082 0.063 0.00000:00:11
20.84.99.232 0.066 0.035 0.00000:00:10
16.5.0.239 0.016 0.024 0.00000:00:03
16.5.0.238 0.031 0.019 0.00000:00:03
tara.probe.onyphe.net 0.023 0.023 0.00000:00:03
r5-202-ca.monitoring.internet-measurement.com 0.028 0.024 0.00000:00:01
244.210.203.35.bc.googleusercontent.com 0.088 0.019 0.00000:00:01
71.6.134.204 0.034 0.011 0.00000:00:00
119.195.132.66.censys-scanner.com 0.043 0.017 0.00000:00:00
216.226.77.20 0.021 0.021 0.00000:00:00
gordon.probe.onyphe.net 0.021 0.031 0.00000:00:00
193-176-31-198.infrawat.ch 0.012 0.012 0.00000:00:00
o040.scanner.modat.io 0.027 0.030 0.00000:00:00
o029.scanner.modat.io 0.030 0.023 0.00000:00:00
o001.scanner.modat.io 0.010 0.013 0.00000:00:00
45-133-173-118.infrawat.ch 0.008 0.015 0.00000:00:00
TOTAL: 18 5.758 5.215 1.60300:01:50

NNRP unrecognized commands (by host):

SystemConn
244.210.203.35.bc.googleusercontent.com 4
152.32.208.106 3
gordon.probe.onyphe.net 2
20.84.99.232 1
119.195.132.66.censys-scanner.com 1
TOTAL: 5 11

NNRP unrecognized commands (by command):

CommandCount
User-Agent: Hello from Palo Alto Network... 1
#026#003#001 1
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 1
À#024 1
Host: 45.13.105.36:563 1
#026#003#003#002a#001 1
GET / HTTP/1.1 1
MGLNDD_45.13.105.36_119 1
#022=¦¤.©ë$qÚÕhÃ÷ 1
EHLO www.censys.io 1
Accept-Encoding: gzip 1
TOTAL: 11 11

NNRP client timeouts [Top 20]:

SystemConnPeer
193-176-31-198.infrawat.ch 1 1
TOTAL: 1 1 2
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me