Daily Usenet report for news.niel.me

Oct 20 04:15:01 -- Oct 21 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 21 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:5dbc82kw7B2I8TasXHqGRwmzN9I=] matches Cancel-Lock[sha1:3PNFKEP+HHv7tE8Rwv8OHowMqhA=] target=<de-gruppen-finden-14.10.2023@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 47004 74.8%8.8 MB 81.3%
innd 11910 19.0%1.5 MB 13.9%
innfeed 2005 3.2%319.6 KB 2.9%
nnrpd 1894 3.0%207.9 KB 1.9%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 62815 100.0%10.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 63864 37.2%
Negative hits 60845 35.5%
Do not exist 46832 27.3%
Cache misses 4 0.0%
TOTAL: 4 171545 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.012 0.0%8 0.000 1.500 6.000
article cancel00:00:00.002 0.0%9 0.000 0.222 1.000
article cleanup00:00:00.983 0.0%47082 0.000 0.021 0.053
article logging00:00:03.565 0.0%47082 0.032 0.076 0.128
article parse00:00:10.483 0.0%186596 0.032 0.056 0.092
article write00:00:29.699 0.0%37195 0.557 0.798 1.340
artlog/artcncl00:00:00.000 0.0%9 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%8 0.000 0.125 0.500
data move00:00:01.824 0.0%346248 0.002 0.005 0.011
hisgrep/artcncl00:00:00.000 0.0%9 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.000 0.0%10 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%9 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:03.209 0.0%172384 0.009 0.019 0.031
history sync00:00:00.050 0.0%376 0.000 0.133 1.000
history write00:00:10.129 0.0%47082 0.146 0.215 0.299
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:02.778 99.7%311381 169.861 276.712 662.638
nntp read00:00:09.228 0.0%310862 0.017 0.030 0.046
overview write00:00:16.038 0.0%37195 0.180 0.431 21.677
perl filter00:02:25.004 0.2%47082 2.439 3.080 3.842
python filter00:00:00.238 0.0%47082 0.000 0.005 0.023
site send00:00:08.995 0.0%75486 0.019 0.119 0.281
TOTAL: 24:00:56.86524:00:02.238 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.357 0.0%37652 0.000 0.009 0.031
article prepare00:00:00.049 0.0%11272 0.000 0.004 0.083
article read00:00:00.326 0.0%1893 0.000 0.172 1.000
backlog stats00:00:02.040 0.0%440210 0.002 0.005 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:06.881 0.0%287683 0.009 0.024 0.052
data write00:00:12.635 0.0%252434 0.035 0.050 0.066
idle23:52:00.824 99.9%440210 119.947 195.181 597.171
status file00:00:00.435 0.0%249 0.000 1.747 7.000
TOTAL: 23:52:44.08223:52:23.547100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.185 0.0%1630 0.029 0.113 3.654
idle00:00:19.740 0.0%1467 0.000 13.456 1535.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.261 0.0%6500 0.000 0.040 1.000
TOTAL: 493:01:13.98100:00:20.186 0.0%----

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 7 45334 25781 11957 7596 56%24:36:41
2gegeweb-out.news.tnetconsulting.net 5 36205 4687 31454 64 12%24:08:09
3news.glou.org 2 11181 4432 5150 1599 39%24:51:24
4feed-out.gegeweb.org 2 2815 1863 952 0 66%23:59:54
5nntp.terraraq.uk 1 10715 314 9717 684 2%27:04:50
6i2pn.org 2 7060 117 6943 0 1%23:57:33
7usenet.pasdenom.info 3 5480 60 5418 2 1%17:55:41
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 47 118790 37254 71591 9945 31%166:34:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net183.8 MB0.0 KB48.8 MB232.6 MB 79%7.1 KB
2gegeweb-out.news.tnetconsulting.net33.2 MB0.0 KB215.3 KB33.4 MB 99%7.2 KB
3news.glou.org29.4 MB0.0 KB7.1 MB36.5 MB 80%6.2 KB
4feed-out.gegeweb.org13.7 MB0.0 KB0.0 KB13.7 MB100%7.5 KB
5i2pn.org3.3 MB0.0 KB0.0 KB3.3 MB100%28.9 KB
6nntp.terraraq.uk1.8 MB0.0 KB3.3 MB5.1 MB 35%5.2 KB
7usenet.pasdenom.info133.8 KB0.0 KB12.6 KB146.4 KB 91%2.4 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 8265.3 MB0.0 KB59.4 MB324.7 MB 81%7.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 20 04:15:01 - 04:59:59 1378 3.7% 0.519.6 MB 3.6% 3.63
Oct 20 05:00:00 - 05:59:59 1729 4.7% 0.4812.2 MB 4.6% 3.46
Oct 20 06:00:00 - 06:59:59 1420 3.8% 0.3910.5 MB 4.0% 3.00
Oct 20 07:00:00 - 07:59:59 1440 3.9% 0.4011.7 MB 4.4% 3.32
Oct 20 08:00:00 - 08:59:59 2160 5.8% 0.6015.2 MB 5.8% 4.32
Oct 20 09:00:00 - 09:59:59 2043 5.5% 0.5716.7 MB 6.4% 4.76
Oct 20 10:00:00 - 10:59:59 1457 3.9% 0.4012.8 MB 4.8% 3.63
Oct 20 11:00:00 - 11:59:59 1574 4.2% 0.4412.4 MB 4.7% 3.54
Oct 20 12:00:00 - 12:59:59 2060 5.6% 0.5715.1 MB 5.8% 4.31
Oct 20 13:00:00 - 13:59:59 1680 4.5% 0.4712.9 MB 4.9% 3.67
Oct 20 14:00:00 - 14:59:59 1348 3.6% 0.3710.3 MB 3.9% 2.94
Oct 20 15:00:00 - 15:59:59 1463 3.9% 0.4111.8 MB 4.5% 3.35
Oct 20 16:00:00 - 16:59:59 1776 4.8% 0.4913.7 MB 5.2% 3.89
Oct 20 17:00:00 - 17:59:59 1678 4.5% 0.4710.9 MB 4.1% 3.10
Oct 20 18:00:00 - 18:59:59 1425 3.8% 0.409.5 MB 3.6% 2.72
Oct 20 19:00:00 - 19:59:59 1263 3.4% 0.359.7 MB 3.7% 2.77
Oct 20 20:00:00 - 20:59:59 895 2.4% 0.256.0 MB 2.3% 1.70
Oct 20 21:00:00 - 21:59:59 1629 4.4% 0.4510.9 MB 4.1% 3.10
Oct 20 22:00:00 - 22:59:59 1862 5.0% 0.5211.4 MB 4.3% 3.24
Oct 20 23:00:00 - 23:59:59 1517 4.1% 0.429.1 MB 3.4% 2.58
Oct 21 00:00:00 - 00:59:59 1396 3.8% 0.398.4 MB 3.2% 2.40
Oct 21 01:00:00 - 01:59:59 1404 3.8% 0.397.9 MB 3.0% 2.25
Oct 21 02:00:00 - 02:59:59 1335 3.6% 0.377.2 MB 2.7% 2.05
Oct 21 03:00:00 - 03:59:59 883 2.4% 0.255.6 MB 2.1% 1.59
Oct 21 04:00:00 - 04:15:01 296 0.8% 0.331.7 MB 0.6% 1.92
TOTAL: 24:00:00 37111 100.0% 0.43263.2 MB 100.0% 3.12
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 7602 2 0 0 0 0 0 0 7600
2news.glou.org 1567 0 0 0 0 0 0 0 1567
3nntp.terraraq.uk 625 0 0 0 0 0 0 0 625
4gegeweb-out.news.tnetconsulting.net 71 1 0 0 0 0 0 0 70
5usenet.pasdenom.info 11 0 0 0 0 0 0 0 11
TOTAL: 5 9876 3 0 0 0 0 0 0 9873

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.petites-annonces.informatique.materiel 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7898
EMP (phr nph) 1643
EMP (phl) 101
Bad path (news.giganews.com.POSTED) 90
EMP (phn path) 89
Too many newsgroups 50
Cancels abusifs 1
Cancel of non-existing ID <ugu3k4$14vjv$1@stefan.eternal-september.org> 1
TOTAL: 8 9873

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.nntp4.net 13181 597 10587 1 0 0 4%23:59:52
2nntp.terraraq.uk 38821 534 35531 86 0 0 1%23:59:56
3news.tnetconsulting.net 63050 328 36666 114 0 74 0%23:59:57
4i2pn.org 62982 86 35971 874 0 404 0%23:59:51
5news.gegeweb.org 36767 21 35066 162 0 0 0%23:59:57
6news.pasdenom.info 38148 18 36762 8 0 149 0%23:59:57
7news.aioe.org 0 0 0 0 0 4234 0%23:59:55
8news.samoylyk.net 0 0 0 0 0 37111 0%23:59:57
TOTAL: 8 252949 1584 190583 1245 0 41972 0%191:59:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.nntp4.net5.1 MB13.0 KB5.1 MB0.1 KB/s8.8 KB23:59:52
2nntp.terraraq.uk3.7 MB1.8 MB5.5 MB0.1 KB/s9.1 KB23:59:56
3news.tnetconsulting.net2.7 MB535.1 KB3.2 MB0.0 KB/s7.4 KB23:59:57
4news.gegeweb.org700.9 KB1.0 MB1.7 MB0.0 KB/s9.6 KB23:59:57
5i2pn.org457.3 KB5.5 MB6.0 MB0.1 KB/s6.4 KB23:59:51
6news.pasdenom.info136.9 KB205.5 KB342.4 KB0.0 KB/s13.2 KB23:59:57
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
8news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 812.8 MB9.1 MB21.9 MB0.0 KB/s7.9 KB191:59:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1phenomenal.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
2107.170.252.18 1 00.0 KB 0 0 000:00:02
3194.165.16.37 1 00.0 KB 0 0 000:00:00
445.133.172.77 16 00.0 KB 0 0 0492:59:26
5intelligent.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
6mail.gegeweb.eu 288 00.0 KB 0 0 000:01:28
7194.165.16.73 1 00.0 KB 0 0 000:00:00
82607:ff10:c8:594::6 3 00.0 KB 0 0 000:00:03
9cool.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
10fabulous.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
11prudent.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:06
TOTAL: 11 315 00.0 KB 0 0 0493:01:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 19 00.0 KB 0 0 0492:59:29
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:28
3*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:12
4? 3 00.0 KB 0 0 000:00:03
TOTAL: 4 315 00.0 KB 0 0 0493:01:13

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
45.133.172.77 0.728 0.581 0.000492:59:26
mail.gegeweb.eu 4.227 4.056 1.56100:01:28
prudent.monitoring.internet-measurement.com 0.034 0.008 0.00000:00:06
fabulous.monitoring.internet-measurement.com 0.016 0.013 0.00000:00:03
2607:ff10:c8:594::6 0.064 0.053 0.00000:00:03
107.170.252.18 0.018 0.006 0.00000:00:02
intelligent.monitoring.internet-measurement.com 0.011 0.038 0.00000:00:01
194.165.16.73 0.033 0.025 0.00000:00:00
194.165.16.37 0.030 0.021 0.00000:00:00
phenomenal.monitoring.internet-measurement.com 0.040 0.028 0.00000:00:00
cool.monitoring.internet-measurement.com 0.012 0.016 0.00000:00:00
TOTAL: 11 5.213 4.845 1.561493:01:13

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
2607:ff10:c8:594::6 7
194.165.16.37 1
107.170.252.18 1
TOTAL: 3 9

NNRP unrecognized commands (by command):

CommandCount
#023#003#023#001#023#002#001 1
MGLNDD_45.13.105.36_119 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Host: [2a0e:e701:1154:0:4e10:5c89:4af0:d... 1
GET / HTTP/1.1 1
Accept-Encoding: gzip 1
#003 1
#026#003#001 1
Accept: */* 1
TOTAL: 9 9

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.37 1 1
TOTAL: 1 1 1