Daily Usenet report for news.niel.me

Jan 10 04:15:01 -- Jan 11 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jan 10 21:05:34 rpi-studio innd: filter: No Cancel-Key[sha1:PCXg/PBkvM9Q9G6HnacaTa+smOY= sha256:2YKpKfTiXWhftSGfxMo+/3En+UZlMET0SQ3xHNg7vz0=] matches Cancel-Lock[sha1:IbAzasZ+WdRsxi+3++6S2vsOsZs= sha256:23gIsRjvU9N4PUDyjgFdOcHB4q+1ZMlIIE6/vLUGTXI=] target=<unmrvp$2u21r$1@news.trigofacile.com>

Log entries by program:

Program nameLines%LinesSize%Size
inn 12972 66.8%2.6 MB 73.5%
innd 2817 14.5%454.5 KB 12.5%
innfeed 1835 9.4%313.1 KB 8.6%
nnrpd 1794 9.2%194.0 KB 5.3%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 19420 100.0%3.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 29078 46.6%
Negative hits 20641 33.1%
Do not exist 12672 20.3%
Cache misses 9 0.0%
TOTAL: 4 62400 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.163 0.0%124 0.000 1.315 6.000
article cancel00:00:00.024 0.0%125 0.000 0.192 1.000
article cleanup00:00:00.248 0.0%12741 0.000 0.019 0.059
article logging00:00:00.963 0.0%12741 0.014 0.076 0.163
article parse00:00:02.843 0.0%57693 0.022 0.049 0.089
article write00:00:07.878 0.0%11804 0.386 0.667 1.268
artlog/artcncl00:00:00.003 0.0%125 0.000 0.024 1.000
artlog/artcncl/perl00:00:00.007 0.0%124 0.000 0.056 1.000
data move00:00:00.621 0.0%118827 0.000 0.005 0.012
hisgrep/artcncl00:00:00.004 0.0%125 0.000 0.032 1.000
hisgrep/artcncl/perl00:00:00.004 0.0%124 0.000 0.032 0.500
hisgrep/perl00:00:00.005 0.0%127 0.000 0.039 1.000
hishave/artcncl00:00:00.000 0.0%125 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%124 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.327 0.0%62495 0.004 0.021 0.467
history sync00:00:00.058 0.0%386 0.000 0.150 1.000
history write00:00:02.310 0.0%12741 0.042 0.181 0.466
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:59:13.427 99.9%107129 396.827 806.070 1572.094
nntp read00:00:02.934 0.0%106607 0.015 0.028 0.051
overview write00:00:05.699 0.0%11804 0.136 0.483 9.738
perl filter00:00:52.867 0.1%12741 2.984 4.149 6.143
python filter00:00:00.068 0.0%12741 0.000 0.005 0.031
site send00:00:03.549 0.0%24916 0.034 0.142 0.321
TOTAL: 24:00:55.24824:00:35.002100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.095 0.0%11975 0.000 0.008 0.040
article prepare00:00:00.019 0.0%5748 0.000 0.003 0.125
article read00:00:00.197 0.0%1197 0.000 0.165 0.571
backlog stats00:00:00.895 0.0%194443 0.000 0.005 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.947 0.0%127833 0.010 0.023 0.039
data write00:00:05.196 0.0%99728 0.030 0.052 0.076
idle23:55:28.927100.0%194443 273.481 442.952 1026.387
status file00:00:00.527 0.0%200 1.000 2.635 9.000
TOTAL: 23:55:49.02423:55:38.803100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:47.102 37.0%1455 21.500 32.373 727.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.103 0.1%3226 0.000 0.032 0.364
TOTAL: 00:02:07.36000:00:47.205 37.1%----

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.glou.org 3 7715 4675 2869 171 60%24:08:59
2news.nntp4.net 2 11877 4576 6598 703 38%23:27:20
3feed-out.gegeweb.org 3 3639 1144 2495 0 31%23:58:47
4usenet.pasdenom.info 2 4324 739 3571 14 17%33:09:22
5gegeweb-out.news.tnetconsulting.net 2 3758 282 3439 37 7%26:38:45
6nntp.terraraq.uk 1 3224 231 2993 0 7%19:39:37
7i2pn.org 1 335 52 283 0 15%02:30:03
8news.samoylyk.net 2 3716 28 3688 0 0%23:02:05
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 41 38588 11727 25936 925 30%176:34:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net41.2 MB0.0 KB5.4 MB46.5 MB 88%9.0 KB
2news.glou.org31.9 MB0.0 KB491.1 KB32.4 MB 98%6.8 KB
3feed-out.gegeweb.org5.2 MB0.0 KB0.0 KB5.2 MB100%4.7 KB
4usenet.pasdenom.info2.0 MB0.0 KB18.2 KB2.0 MB 99%2.7 KB
5nntp.terraraq.uk1.0 MB0.0 KB0.0 KB1.0 MB100%4.5 KB
6gegeweb-out.news.tnetconsulting.net769.6 KB0.0 KB105.3 KB874.9 KB 87%2.7 KB
7i2pn.org384.1 KB0.0 KB0.0 KB384.1 KB100%7.4 KB
8news.samoylyk.net211.6 KB0.0 KB0.0 KB211.6 KB100%7.6 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 982.6 MB0.0 KB6.0 MB88.6 MB 93%7.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 10 04:15:01 - 04:59:59 343 2.9% 0.132.7 MB 3.2% 1.02
Jan 10 05:00:00 - 05:59:59 531 4.5% 0.154.5 MB 5.3% 1.28
Jan 10 06:00:00 - 06:59:59 463 3.9% 0.134.0 MB 4.7% 1.13
Jan 10 07:00:00 - 07:59:59 545 4.6% 0.154.4 MB 5.2% 1.25
Jan 10 08:00:00 - 08:59:59 753 6.4% 0.215.8 MB 6.9% 1.65
Jan 10 09:00:00 - 09:59:59 553 4.7% 0.154.1 MB 4.9% 1.17
Jan 10 10:00:00 - 10:59:59 468 4.0% 0.133.2 MB 3.8% 0.91
Jan 10 11:00:00 - 11:59:59 578 4.9% 0.164.0 MB 4.7% 1.13
Jan 10 12:00:00 - 12:59:59 522 4.4% 0.143.8 MB 4.5% 1.07
Jan 10 13:00:00 - 13:59:59 407 3.5% 0.113.1 MB 3.7% 0.88
Jan 10 14:00:00 - 14:59:59 384 3.3% 0.112.7 MB 3.2% 0.76
Jan 10 15:00:00 - 15:59:59 361 3.1% 0.102.4 MB 2.8% 0.67
Jan 10 16:00:00 - 16:59:59 394 3.3% 0.112.8 MB 3.3% 0.80
Jan 10 17:00:00 - 17:59:59 590 5.0% 0.164.5 MB 5.4% 1.29
Jan 10 18:00:00 - 18:59:59 469 4.0% 0.133.2 MB 3.9% 0.92
Jan 10 19:00:00 - 19:59:59 446 3.8% 0.122.8 MB 3.3% 0.80
Jan 10 20:00:00 - 20:59:59 594 5.0% 0.173.9 MB 4.6% 1.11
Jan 10 21:00:00 - 21:59:59 461 3.9% 0.133.2 MB 3.8% 0.92
Jan 10 22:00:00 - 22:59:59 385 3.3% 0.112.3 MB 2.8% 0.66
Jan 10 23:00:00 - 23:59:59 549 4.7% 0.153.7 MB 4.3% 1.04
Jan 11 00:00:00 - 00:59:59 490 4.2% 0.143.3 MB 3.9% 0.94
Jan 11 01:00:00 - 01:59:59 414 3.5% 0.122.6 MB 3.1% 0.74
Jan 11 02:00:00 - 02:59:59 513 4.4% 0.143.4 MB 4.0% 0.97
Jan 11 03:00:00 - 03:59:59 476 4.0% 0.133.3 MB 3.9% 0.94
Jan 11 04:00:00 - 04:15:01 98 0.8% 0.11605.6 KB 0.7% 0.67
TOTAL: 24:00:00 11787 100.0% 0.1484.2 MB 100.0% 1.00
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 709 97 0 0 0 0 0 0 612
2news.glou.org 171 0 0 0 0 0 0 0 171
3gegeweb-out.news.tnetconsulting.net 45 0 0 0 0 0 0 0 45
4usenet.pasdenom.info 11 0 0 0 0 0 0 0 11
TOTAL: 4 936 97 0 0 0 0 0 0 839

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.misc.gestion 54
fr.lettres.langue.allemande 42
fr.petites-annonces.informatique.materiel 1
TOTAL: 3 97

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 394
Too many newsgroups 262
EMP (phn path) 117
Bad path (news.giganews.com.POSTED) 52
Cancels abusifs 4
User-issued spam cancel 4
Cancel for rejected article 2
hierarchy violation - crosspost outside sdnet 1
Cancel of <mn.52757e817a5b92fe.145333@Capistrano.ru.invalid> without Cancel-Key 1
Cancel of <mn.52827e81697012a5.145333@Capistrano.ru.invalid> without Cancel-Key 1
HTML post 1
TOTAL: 11 839

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 18564 229 10632 718 0 67 1%23:59:40
2news.nntp4.net 9009 92 7009 0 0 0 1%23:59:36
3news.gegeweb.org 11694 57 10576 0 0 0 0%23:59:56
4news.samoylyk.net 17621 14 11675 68 0 26 0%23:59:56
5nntp.terraraq.uk 12033 14 10049 155 0 37 0%23:59:56
6news.tnetconsulting.net 17181 10 11701 74 0 48 0%23:59:51
7news.pasdenom.info 13245 4 11231 3 0 38 0%23:59:55
8news.aioe.org 0 0 0 0 0 5801 0%23:59:55
TOTAL: 8 99347 420 72873 1018 0 6017 0%191:58:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org931.8 KB6.1 MB7.0 MB0.1 KB/s7.6 KB23:59:40
2news.nntp4.net738.6 KB0.0 KB738.6 KB0.0 KB/s8.0 KB23:59:36
3news.gegeweb.org623.9 KB0.0 KB623.9 KB0.0 KB/s10.9 KB23:59:56
4nntp.terraraq.uk71.4 KB1.4 MB1.5 MB0.0 KB/s9.1 KB23:59:56
5news.samoylyk.net35.2 KB518.6 KB553.8 KB0.0 KB/s6.8 KB23:59:56
6news.pasdenom.info32.4 KB21.4 KB53.8 KB0.0 KB/s7.7 KB23:59:55
7news.tnetconsulting.net23.6 KB584.3 KB607.9 KB0.0 KB/s7.2 KB23:59:51
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 82.4 MB8.7 MB11.1 MB0.0 KB/s7.9 KB191:58:45
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
145.227.254.8 2 00.0 KB 0 0 000:00:00
2mail.gegeweb.eu 288 00.0 KB 0 0 000:01:47
3ec2-54-183-245-66.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:01
42607:ff10:c8:594::d 3 00.0 KB 0 0 000:00:06
52607:ff10:c8:594::e 3 00.0 KB 0 0 000:00:07
6spirited.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
TOTAL: 6 298 00.0 KB 0 0 000:02:06

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 288 00.0 KB 0 0 000:01:47
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
3unresolved 2 00.0 KB 0 0 000:00:00
4*.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:01
5? 6 00.0 KB 0 0 000:00:14
TOTAL: 5 298 00.0 KB 0 0 000:02:06

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.485 4.234 1.61300:01:47
2607:ff10:c8:594::e 0.046 0.057 0.00000:00:07
2607:ff10:c8:594::d 0.090 0.064 0.00000:00:06
spirited.monitoring.internet-measurement.com 0.009 0.018 0.00000:00:02
ec2-54-183-245-66.us-west-1.compute.amazonaws.com 0.074 0.016 0.00000:00:01
45.227.254.8 0.054 0.027 0.00000:00:00
TOTAL: 6 4.758 4.416 1.61300:02:06

NNRP unrecognized commands (by host):

SystemConn
2607:ff10:c8:594::d 7
2607:ff10:c8:594::e 7
45.227.254.8 1
TOTAL: 3 15

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.8 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