Daily Usenet report for news.niel.me

Jan 12 04:15:02 -- Jan 13 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jan 12 11:14:50 rpi-studio innd: filter: No Cancel-Key[sha1:A+idkTEZfwhHhLSP9gZyvbl4jBQ= sha256:fQ8LkN4qvh4QoBOFIKlsDUKi13RzZtNISwsvtOiFjmI=#015#012#011sha1:a2R/FkrnsYT7YEb6sZn6PPE8Wa4= sha256:udnfWd1nQutUhBe4Hbhh56JMq6bL0nOIjVuhp2OmZXg=] matches Cancel-Lock[sha1:pcSyjEtFZ2krTPX2GWfPPukDDdo= sha256:ODR+EHEAOK3p/GPeDgFPFUcSvCUN1LFzTFl84NLwFQQ=] target=<unr3bj$jqo$1@rasp.pasdenom.info>
Jan 13 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:3A23ZzAL818sidggyblxH0OiIg8=] matches Cancel-Lock[sha1:xKMG2L+puROcmFjVu8a28SiBm5E=] target=<de-gruppen-finden-06.01.2024@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 15507 64.9%3.0 MB 71.9%
innd 4276 17.9%633.2 KB 15.0%
nnrpd 2188 9.2%236.6 KB 5.6%
innfeed 1919 8.0%319.1 KB 7.5%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 23892 100.0%4.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 22215 37.4%
Negative hits 21768 36.7%
Do not exist 15364 25.9%
Cache misses 5 0.0%
TOTAL: 4 59352 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.012 0.0%14 0.000 0.857 2.000
article cancel00:00:00.003 0.0%16 0.000 0.188 1.000
article cleanup00:00:00.294 0.0%15484 0.000 0.019 0.057
article logging00:00:01.152 0.0%15484 0.011 0.074 0.143
article parse00:00:04.618 0.0%80042 0.010 0.058 0.094
article write00:00:10.012 0.0%13196 0.494 0.759 1.247
artlog/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
data move00:00:00.768 0.0%141464 0.000 0.005 0.017
hisgrep/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%26 0.000 0.038 0.250
hishave/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.161 0.0%59726 0.004 0.019 0.046
history sync00:00:00.060 0.0%408 0.000 0.147 0.667
history write00:00:03.036 0.0%15484 0.053 0.196 0.357
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:59:08.920 99.9%124268 489.172 694.860 1507.613
nntp read00:00:03.497 0.0%123462 0.013 0.028 0.052
overview write00:00:12.100 0.0%13196 0.129 0.917 65.230
perl filter00:00:53.077 0.1%15484 2.642 3.428 8.413
python filter00:00:00.063 0.0%15484 0.000 0.004 0.024
site send00:00:03.905 0.0%27524 0.040 0.142 0.276
TOTAL: 24:01:05.75424:00:42.679100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.134 0.0%13293 0.000 0.010 0.069
article prepare00:00:00.025 0.0%6296 0.000 0.004 0.062
article read00:00:00.223 0.0%1478 0.000 0.151 1.000
backlog stats00:00:00.964 0.0%200297 0.000 0.005 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.240 0.0%133522 0.006 0.024 0.045
data write00:00:05.560 0.0%104237 0.028 0.053 0.080
idle23:54:21.761100.0%200297 291.771 429.671 765.446
status file00:00:00.537 0.0%205 0.500 2.620 9.000
TOTAL: 23:54:42.96923:54:32.444100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:54.241 35.8%1563 11.000 34.703 1078.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.133 0.1%3544 0.000 0.038 1.000
TOTAL: 00:02:31.57700:00:54.374 35.9%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 170

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.nntp4.net 2 15147 9673 3413 2061 63%24:13:46
2news.glou.org 2 3755 1517 2067 171 40%24:36:32
3feed-out.gegeweb.org 2 3260 1091 2169 0 33%23:59:18
4i2pn.org 1 6951 362 6589 0 5%45:59:57
5gegeweb-out.news.tnetconsulting.net 2 3335 305 2970 60 9%25:45:52
6usenet.pasdenom.info 1 2060 290 1761 9 14%20:02:44
7nntp.terraraq.uk 2 4134 197 3927 10 4%28:04:39
8news.samoylyk.net 1 3586 35 3551 0 0%23:59:37
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 38 42228 13470 26447 2311 31%216:42:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net114.4 MB0.0 KB13.0 MB127.4 MB 89%11.1 KB
2news.glou.org6.9 MB0.0 KB534.3 KB7.4 MB 92%4.5 KB
3feed-out.gegeweb.org5.0 MB0.0 KB0.0 KB5.0 MB100%4.7 KB
4i2pn.org3.1 MB0.0 KB0.0 KB3.1 MB100%8.9 KB
5usenet.pasdenom.info1.5 MB0.0 KB12.7 KB1.5 MB 99%5.0 KB
6nntp.terraraq.uk862.2 KB0.0 KB25.9 KB888.1 KB 97%4.3 KB
7gegeweb-out.news.tnetconsulting.net834.8 KB0.0 KB174.2 KB1009.0 KB 82%2.8 KB
8news.samoylyk.net176.5 KB0.0 KB0.0 KB176.5 KB100%5.0 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 9132.7 MB0.0 KB13.7 MB146.4 MB 90%9.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 12 04:15:02 - 04:59:59 353 2.7% 0.133.6 MB 2.8% 1.38
Jan 12 05:00:00 - 05:59:59 570 4.3% 0.166.5 MB 5.0% 1.85
Jan 12 06:00:00 - 06:59:59 526 4.0% 0.155.6 MB 4.3% 1.59
Jan 12 07:00:00 - 07:59:59 614 4.7% 0.176.2 MB 4.7% 1.76
Jan 12 08:00:00 - 08:59:59 636 4.8% 0.186.6 MB 5.0% 1.87
Jan 12 09:00:00 - 09:59:59 541 4.1% 0.155.2 MB 4.0% 1.47
Jan 12 10:00:00 - 10:59:59 639 4.8% 0.186.2 MB 4.8% 1.77
Jan 12 11:00:00 - 11:59:59 624 4.7% 0.176.1 MB 4.7% 1.73
Jan 12 12:00:00 - 12:59:59 585 4.4% 0.165.4 MB 4.2% 1.55
Jan 12 13:00:00 - 13:59:59 556 4.2% 0.155.6 MB 4.3% 1.59
Jan 12 14:00:00 - 14:59:59 484 3.7% 0.134.4 MB 3.4% 1.26
Jan 12 15:00:00 - 15:59:59 497 3.8% 0.144.2 MB 3.2% 1.19
Jan 12 16:00:00 - 16:59:59 552 4.2% 0.155.1 MB 3.9% 1.46
Jan 12 17:00:00 - 17:59:59 589 4.5% 0.165.6 MB 4.3% 1.59
Jan 12 18:00:00 - 18:59:59 484 3.7% 0.134.5 MB 3.5% 1.28
Jan 12 19:00:00 - 19:59:59 525 4.0% 0.155.6 MB 4.3% 1.59
Jan 12 20:00:00 - 20:59:59 510 3.9% 0.145.4 MB 4.1% 1.53
Jan 12 21:00:00 - 21:59:59 627 4.8% 0.176.6 MB 5.1% 1.89
Jan 12 22:00:00 - 22:59:59 558 4.2% 0.155.6 MB 4.3% 1.60
Jan 12 23:00:00 - 23:59:59 522 4.0% 0.144.5 MB 3.5% 1.29
Jan 13 00:00:00 - 00:59:59 501 3.8% 0.144.8 MB 3.6% 1.35
Jan 13 01:00:00 - 01:59:59 523 4.0% 0.155.4 MB 4.2% 1.55
Jan 13 02:00:00 - 02:59:59 549 4.2% 0.155.8 MB 4.4% 1.64
Jan 13 03:00:00 - 03:59:59 491 3.7% 0.145.1 MB 3.9% 1.44
Jan 13 04:00:00 - 04:15:01 129 1.0% 0.141.1 MB 0.9% 1.28
TOTAL: 23:59:59 13185 100.0% 0.15130.7 MB 100.0% 1.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 2051 0 0 0 0 0 0 0 2051
2news.glou.org 169 0 0 0 0 0 0 0 169
3gegeweb-out.news.tnetconsulting.net 48 0 0 0 0 0 0 0 48
4usenet.pasdenom.info 12 0 0 0 0 0 0 0 12
5nntp.terraraq.uk 12 0 0 0 0 0 0 0 12
TOTAL: 5 2292 0 0 0 0 0 0 0 2292

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1901
Too many newsgroups 190
EMP (phn path) 96
Bad path (news.giganews.com.POSTED) 92
Cancel of <mn.64567e81d1b5dcdb.145333@reduct.eu> without Cancel-Key 1
Cancel of <mn.62c17e819ec35f34.145333@reduct.eu> without Cancel-Key 1
Cancel of <mn.645e7e81630e3404.145333@reduct.eu> without Cancel-Key 1
Cancel of <mn.64537e819a43bee7.145333@reduct.eu> without Cancel-Key 1
Cancel of <mn.62c07e81ba9040ed.145333@reduct.eu> without Cancel-Key 1
Cancel of <mn.62c37e815f5d1269.145333@reduct.eu> without Cancel-Key 1
Cancel of <mn.62507e8122ffd819.145333@Capistrano.ru.invalid> without Cancel-Key 1
Cancel of <mn.645c7e814fe79232.145333@reduct.eu> without Cancel-Key 1
Cancel for rejected article 1
Cancels abusifs 1
Cancel of <mn.64527e8172f8b688.145333@reduct.eu> without Cancel-Key 1
Cancel of <mn.62c57e8190a4431a.145333@reduct.eu> without Cancel-Key 1
Too many newsgroups (meow) 1
TOTAL: 17 2292

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 22749 101 11551 1213 0 85 0%23:59:53
2news.gegeweb.org 14587 40 12044 0 0 0 0%23:59:53
3news.nntp4.net 4106 39 3542 0 0 0 0%23:58:53
4news.samoylyk.net 17442 24 13088 31 0 68 0%23:59:56
5nntp.terraraq.uk 12891 23 12064 40 0 0 0%23:59:56
6news.tnetconsulting.net 18760 5 13122 56 0 0 0%23:59:56
7news.pasdenom.info 13898 1 12700 2 0 0 0%23:59:47
8news.aioe.org 0 0 0 0 0 6168 0%23:59:54
TOTAL: 8 104433 233 78111 1342 0 6321 0%191:58:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org362.5 KB0.0 KB362.5 KB0.0 KB/s9.1 KB23:59:53
2i2pn.org359.6 KB13.8 MB14.2 MB0.2 KB/s11.0 KB23:59:53
3news.nntp4.net243.8 KB0.0 KB243.8 KB0.0 KB/s6.3 KB23:58:53
4nntp.terraraq.uk127.4 KB426.2 KB553.6 KB0.0 KB/s8.8 KB23:59:56
5news.samoylyk.net57.5 KB176.8 KB234.3 KB0.0 KB/s4.3 KB23:59:56
6news.tnetconsulting.net12.6 KB342.8 KB355.4 KB0.0 KB/s5.8 KB23:59:56
7news.pasdenom.info1.8 KB69.6 KB71.4 KB0.0 KB/s23.8 KB23:59:47
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
TOTAL: 81.1 MB14.8 MB15.9 MB0.0 KB/s10.4 KB191:58:08
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mail.gegeweb.eu 288 00.0 KB 0 0 000:01:58
2107.170.236.6 1 00.0 KB 0 0 000:00:01
371.6.134.235 3 00.0 KB 0 0 000:00:01
4194.165.16.10 2 00.0 KB 0 0 000:00:01
5208.100.26.236 10 00.0 KB 0 0 000:00:04
6imaginative.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
794.102.61.39 1 00.0 KB 0 0 000:00:00
8ns31410034.ip-145-239-154.eu 111 00.0 KB 0 0 000:00:21
TOTAL: 8 417 00.0 KB 0 0 000:02:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ip-145-239-154.eu 111 00.0 KB 0 0 000:00:21
2unresolved 17 00.0 KB 0 0 000:00:09
3*.gegeweb.eu 288 00.0 KB 0 0 000:01:58
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 4 417 00.0 KB 0 0 000:02:30

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 4.540 4.278 1.56700:01:58
ns31410034.ip-145-239-154.eu 2.802 1.547 0.00000:00:21
208.100.26.236 0.186 0.109 0.00000:00:04
imaginative.monitoring.internet-measurement.com 0.034 0.019 0.00000:00:01
71.6.134.235 0.049 0.072 0.00000:00:01
107.170.236.6 0.027 0.016 0.00000:00:01
194.165.16.10 0.075 0.040 0.00000:00:01
94.102.61.39 0.020 0.008 0.00000:00:00
TOTAL: 8 7.733 6.089 1.56700:02:30

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
71.6.134.235 7
194.165.16.10 1
107.170.236.6 1
TOTAL: 3 9

NNRP unrecognized commands (by command):

CommandCount
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Accept: */* 1
MGLNDD_45.13.105.36_119 1
#023#003#023#001#023#002#001 1
Host: 45.13.105.36:119 1
GET / HTTP/1.1 1
Accept-Encoding: gzip 1
#026#003#001 1
#003 1
TOTAL: 9 9

NNRP client timeouts [Top 20]:

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