Daily Usenet report for news.niel.me

Nov 22 04:15:01 -- Nov 23 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 22 23:59:53 rpi-studio innd: filter: No Cancel-Key[sha1:1iApLfWuXEhDaDJ/sh1gEyjZCuQ= sha256:QMotJQB90iRqtjcczEOGqChr5YOe58XmX5uTqzpauTY=] matches Cancel-Lock[sha1:2NOSNeOfgTzfWRGYDZqPi5ECFMk= sha256:kFODX0UM8DXUff9d/HTuPJvEZtrCGY50BNSgKjAWntY=] target=<10ftf58$8mbg$2@gwaiyur.mb-net.net>

Log entries by program:

Program nameLines%LinesSize%Size
innd 2076 26.0%343.9 KB 28.1%
inn 2055 25.8%363.1 KB 29.7%
nnrpd 2031 25.5%232.1 KB 19.0%
innfeed 1811 22.7%284.7 KB 23.3%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 7975 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 7801 55.6%
Negative hits 4201 29.9%
Do not exist 2020 14.4%
Cache misses 6 0.0%
TOTAL: 4 14028 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.012 0.0%10 0.667 1.200 2.000
article cancel00:00:00.002 0.0%11 0.000 0.182 1.000
article cleanup00:00:00.040 0.0%2031 0.000 0.020 0.250
article logging00:00:00.148 0.0%2031 0.000 0.073 0.333
article parse00:00:00.477 0.0%6749 0.000 0.071 0.250
article write00:00:00.896 0.0%1676 0.000 0.535 1.000
artlog/artcncl00:00:00.001 0.0%11 0.000 0.091 0.333
artlog/artcncl/perl00:00:00.001 0.0%10 0.000 0.100 1.000
data move00:00:00.109 0.0%17432 0.000 0.006 0.031
hisgrep/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%10 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%13 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%10 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.252 0.0%14092 0.000 0.018 0.059
history sync00:00:00.058 0.0%399 0.000 0.145 1.000
history write00:00:00.378 0.0%2030 0.000 0.186 0.667
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:40.526100.0%19292 643.753 4480.641 24018.080
nntp read00:00:00.541 0.0%18625 0.000 0.029 0.109
overview write00:00:00.563 0.0%1676 0.000 0.336 2.500
perl filter00:00:12.765 0.0%2030 2.727 6.288 22.000
python filter00:00:00.009 0.0%2030 0.000 0.004 0.125
site send00:00:00.745 0.0%3437 0.000 0.217 0.583
TOTAL: 24:01:05.48524:00:57.523100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.020 0.0%1680 0.000 0.012 0.167
article prepare00:00:00.000 0.0%192 0.000 0.000 0.000
article read00:00:00.017 0.0%48 0.000 0.354 8.000
backlog stats00:00:00.140 0.0%22693 0.000 0.006 0.054
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.319 0.0%10933 0.000 0.029 0.091
data write00:00:00.569 0.0%9240 0.000 0.062 0.182
idle23:55:57.910100.0%22693 1967.902 3796.673 8242.041
status file00:00:06.615 0.0%280 1.000 23.625 81.000
TOTAL: 23:56:22.66223:56:05.590100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:39.240 11.3%1493 10.600 26.283 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.142 0.0%3401 0.000 0.042 0.500
readart00:00:00.001 0.0%2 0.500 0.500 0.500
TOTAL: 00:05:48.10600:00:39.383 11.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
1news.nntp4.net 1 2006 639 1044 323 31%23:59:55
2feed-out.gegeweb.org 2 1650 541 1109 0 32%23:59:46
3news.samoylyk.net 1 1158 203 953 2 17%16:48:41
4nntp.terraraq.uk 2 1010 60 950 0 5%19:26:26
5usenet.pasdenom.info 8 776 29 747 0 3%25:08:11
6gegeweb-out.news.tnetconsulting.net 3 1956 27 1929 0 1%37:10:44
7news.glou.org 2 100 13 85 2 13%02:09:41
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 44 8656 1512 6817 327 17%148:43:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net2.5 MB0.0 KB7.0 MB9.5 MB 26%10.1 KB
2feed-out.gegeweb.org1.9 MB0.0 KB0.0 KB1.9 MB100%3.6 KB
3news.samoylyk.net1.3 MB0.0 KB97.8 KB1.4 MB 93%7.0 KB
4nntp.terraraq.uk180.7 KB0.0 KB0.0 KB180.7 KB100%3.0 KB
5gegeweb-out.news.tnetconsulting.net137.1 KB0.0 KB0.0 KB137.1 KB100%5.1 KB
6usenet.pasdenom.info68.0 KB0.0 KB0.0 KB68.0 KB100%2.3 KB
7news.glou.org51.4 KB0.0 KB22.0 KB73.4 KB 70%4.9 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 86.2 MB0.0 KB7.1 MB13.3 MB 46%7.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 22 04:15:01 - 04:59:59 37 2.2% 0.01160.9 KB 2.3% 0.06
Nov 22 05:00:00 - 05:59:59 67 4.0% 0.02262.7 KB 3.8% 0.07
Nov 22 06:00:00 - 06:59:59 22 1.3% 0.0178.8 KB 1.1% 0.02
Nov 22 07:00:00 - 07:59:59 51 3.0% 0.01223.6 KB 3.2% 0.06
Nov 22 08:00:00 - 08:59:59 49 2.9% 0.01184.7 KB 2.7% 0.05
Nov 22 09:00:00 - 09:59:59 51 3.0% 0.01195.0 KB 2.8% 0.05
Nov 22 10:00:00 - 10:59:59 64 3.8% 0.02175.1 KB 2.5% 0.05
Nov 22 11:00:00 - 11:59:59 81 4.8% 0.02285.5 KB 4.1% 0.08
Nov 22 12:00:00 - 12:59:59 90 5.4% 0.03365.9 KB 5.3% 0.10
Nov 22 13:00:00 - 13:59:59 49 2.9% 0.01210.9 KB 3.0% 0.06
Nov 22 14:00:00 - 14:59:59 76 4.5% 0.02293.1 KB 4.2% 0.08
Nov 22 15:00:00 - 15:59:59 129 7.7% 0.04447.7 KB 6.4% 0.12
Nov 22 16:00:00 - 16:59:59 107 6.4% 0.03452.1 KB 6.5% 0.13
Nov 22 17:00:00 - 17:59:59 70 4.2% 0.02314.6 KB 4.5% 0.09
Nov 22 18:00:00 - 18:59:59 78 4.6% 0.02374.8 KB 5.4% 0.10
Nov 22 19:00:00 - 19:59:59 69 4.1% 0.02553.4 KB 8.0% 0.15
Nov 22 20:00:00 - 20:59:59 101 6.0% 0.03358.0 KB 5.1% 0.10
Nov 22 21:00:00 - 21:59:59 79 4.7% 0.02309.4 KB 4.4% 0.09
Nov 22 22:00:00 - 22:59:59 96 5.7% 0.03370.4 KB 5.3% 0.10
Nov 22 23:00:00 - 23:59:59 77 4.6% 0.02427.9 KB 6.1% 0.12
Nov 23 00:00:00 - 00:59:59 46 2.7% 0.01175.3 KB 2.5% 0.05
Nov 23 01:00:00 - 01:59:59 45 2.7% 0.01216.1 KB 3.1% 0.06
Nov 23 02:00:00 - 02:59:59 62 3.7% 0.02176.8 KB 2.5% 0.05
Nov 23 03:00:00 - 03:59:59 57 3.4% 0.02258.2 KB 3.7% 0.07
Nov 23 04:00:00 - 04:15:01 26 1.5% 0.0389.7 KB 1.3% 0.10
TOTAL: 24:00:00 1679 100.0% 0.026.8 MB 100.0% 0.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 323 68 0 0 0 0 0 0 255
2news.glou.org 30 0 0 1 0 0 0 0 29
3news.samoylyk.net 2 0 0 0 0 0 0 0 2
TOTAL: 3 355 68 0 1 0 0 0 0 286

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 58
linux.kernel.git 8
news.test 1
nl.politiek 1
TOTAL: 4 68

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 189
Bad path (news.giganews.com.POSTED) 50
EMP (phn path) 39
Cancels abusifs 5
No Cancel-Key matches Cancel-Lock. target=<10ftf58$8mbg$2@gwaiyur.mb-net.net> 1
Too many newsgroups 1
Cancel of non-existing ID <10fq8ed$3rupp$1@dont-email.me> 1
TOTAL: 7 286

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 2611 24 1636 17 0 7 0%23:58:47
2news.samoylyk.net 1655 2 1381 0 0 0 0%23:57:09
3news.gegeweb.org 1304 1 1124 0 0 0 0%23:59:46
4news.nntp4.net 1270 1 1035 0 0 0 0%23:36:30
5news.aioe.org 0 0 0 0 0 1325 0%24:00:00
6news.pasdenom.info 1433 0 1193 3 0 0 0%23:56:02
7i2pn.org 0 0 0 0 0 1677 0%24:00:00
8nntp.terraraq.uk 1096 0 1027 0 0 0 0%23:50:41
TOTAL: 8 9369 28 7396 20 0 3009 0%191:18:55
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net114.1 KB109.4 KB223.6 KB0.0 KB/s5.5 KB23:58:47
2news.samoylyk.net10.7 KB0.0 KB10.7 KB0.0 KB/s5.3 KB23:57:09
3news.gegeweb.org4.1 KB0.0 KB4.1 KB0.0 KB/s4.1 KB23:59:46
4news.nntp4.net3.2 KB0.0 KB3.2 KB0.0 KB/s3.2 KB23:36:30
5news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
6news.pasdenom.info0.0 KB16.9 KB16.9 KB0.0 KB/s5.6 KB23:56:02
7i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:41
TOTAL: 8132.1 KB126.3 KB258.4 KB0.0 KB/s5.4 KB191:18:55
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 4 21.5 KB 1 0 000:00:06
TOTAL: 1 4 21.5 KB 1 0 000:07:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 17 21.5 KB 1 0 000:03:55
2? 7 00.0 KB 0 0 000:00:07
3*.stretchoid.com 2 00.0 KB 0 0 000:00:10
4*.probe.onyphe.net 4 00.0 KB 0 0 000:00:09
5*.scan.bufferover.run 2 00.0 KB 0 0 000:00:00
6*.gegeweb.eu 288 00.0 KB 0 0 000:02:03
7*.149.216.162.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:27
8*.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
9*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
10*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:03
11*.scanner.modat.io 5 00.0 KB 0 0 000:00:00
TOTAL: 11 330 21.5 KB 1 0 000:07:00

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.540 4.320 2.07400:02:03
147.185.133.55 0.388 0.181 0.00000:01:57
206.168.34.192 0.052 0.043 0.00000:00:38
206.168.34.117 0.029 0.033 0.00000:00:31
66.132.153.120 0.008 0.021 0.00000:00:30
196.149.216.162.bc.googleusercontent.com 0.190 0.076 0.00000:00:27
azpdsgqpqgcy.stretchoid.com 0.057 0.041 0.00000:00:10
66.61.98.95 0.114 0.045 0.00000:00:06
147.185.133.36 0.028 0.014 0.00000:00:05
205.210.31.86 0.027 0.022 0.00000:00:04
mirko.probe.onyphe.net 0.058 0.025 0.00000:00:03
86.150.216.162.bc.googleusercontent.com 0.050 0.021 0.00000:00:03
2a06:4883:d000::f8 0.068 0.015 0.00000:00:03
2a06:4883:d000::fc 0.015 0.011 0.00000:00:03
hayley.probe.onyphe.net 0.025 0.014 0.00000:00:03
zahida.probe.onyphe.net 0.058 0.025 0.00000:00:02
unforgettable.monitoring.internet-measurement.com 0.036 0.016 0.00000:00:01
2603:6010:6800:36:1a03:73ff:fe28:be0f 0.027 0.019 0.00000:00:01
205.210.31.91 0.021 0.021 0.00000:00:01
silas.probe.onyphe.net 0.041 0.028 0.00000:00:00
TOTAL: 27 7.169 5.198 2.07400:07:00

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
n31.scanner.modat.io 5
147.185.133.55 4
206.168.34.192 2
2603:6010:6800:36:1a03:73ff:fe28:be0f 2
2a06:4882:9000::97 2
riga.scan.bufferover.run 2
azpdsgqpqgcy.stretchoid.com 2
196.149.216.162.bc.googleusercontent.com 2
205.210.31.86 1
2a06:4883:d000::fc 1
mirko.probe.onyphe.net 1
147.185.133.36 1
2a06:4883:d000::f8 1
hayley.probe.onyphe.net 1
205.210.31.91 1
207.90.244.14 1
194.165.16.167 1
66.132.153.120 1
unforgettable.monitoring.internet-measurement.com 1
TOTAL: 26 326

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
147.185.133.55 8
riga.scan.bufferover.run 7
86.150.216.162.bc.googleusercontent.com 4
147.185.133.36 4
196.149.216.162.bc.googleusercontent.com 4
azpdsgqpqgcy.stretchoid.com 1
n31.scanner.modat.io 1
206.168.34.192 1
TOTAL: 8 30

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 6
Host: 45.13.105.36:563 5
Accept: */* 4
User-Agent: curl/7.68.0 3
Accept-Encoding: gzip 3
User-Agent: Hello from Palo Alto Network... 2
Host: 45.13.105.36:119 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
MGLNDD_45.13.105.36_119 1
#001 1
EHLO www.censys.io 1
HELO 1
#026#003#001 1
TOTAL: 13 30

NNRP client timeouts [Top 20]:

SystemConnPeer
147.185.133.55 2 4
196.149.216.162.bc.googleusercontent.com 1 2
TOTAL: 2 3 8

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 2100.0%
TOTAL: 1 2100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1grisbi.test 2
TOTAL: 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