Daily Usenet report for news.niel.me

Feb 19 04:15:02 -- Feb 20 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Feb 19 20:02:11 rpi-studio innd: filter: No Cancel-Key[sha1:uNCZ/ynW5o9yt3+WVC8/Pjg7hf8= sha256:cKXh61VPblPCVOLWx+W0TyVtB+xwRgaG7ZTx1FR+4uM=] matches Cancel-Lock[sha1:e3Lb+LKsOv9Yg9tUNLVdJ83T/fE= sha256:xv1gtAaqB4DEVT7wfAoabAGbg4pETJySrkb1cUNMEkk=] target=<tstrd1$1oaur$1@news.trigofacile.com>

Log entries by program:

Program nameLines%LinesSize%Size
inn 3975 38.2%760.0 KB 44.7%
innd 2389 23.0%409.0 KB 24.1%
nnrpd 2253 21.7%242.3 KB 14.3%
innfeed 1778 17.1%289.0 KB 17.0%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 10397 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 21433 58.7%
Negative hits 11212 30.7%
Do not exist 3867 10.6%
Cache misses 1 0.0%
TOTAL: 4 36513 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.043 0.0%36 0.800 1.194 3.500
article cancel00:00:00.007 0.0%37 0.000 0.189 1.000
article cleanup00:00:00.057 0.0%3898 0.000 0.015 0.167
article logging00:00:00.266 0.0%3914 0.000 0.068 0.364
article parse00:00:00.734 0.0%8804 0.000 0.083 0.391
article write00:00:04.278 0.0%3447 0.000 1.241 2.667
artlog/artcncl00:00:00.002 0.0%37 0.000 0.054 0.200
artlog/artcncl/perl00:00:00.008 0.0%36 0.000 0.222 1.000
data move00:00:00.137 0.0%40344 0.000 0.003 0.014
hisgrep/artcncl00:00:00.002 0.0%37 0.000 0.054 0.333
hisgrep/artcncl/perl00:00:00.001 0.0%36 0.000 0.028 0.111
hisgrep/perl00:00:00.001 0.0%40 0.000 0.025 1.000
hishave/artcncl00:00:00.001 0.0%37 0.000 0.027 0.200
hishave/artcncl/perl00:00:00.000 0.0%36 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.419 0.0%36711 0.000 0.011 0.036
history sync00:00:00.055 0.0%406 0.000 0.135 0.667
history write00:00:00.867 0.0%3898 0.000 0.222 0.600
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:31.153100.0%41413 795.930 2087.054 11780.255
nntp read00:00:01.260 0.0%40851 0.000 0.031 0.089
overview write00:00:01.835 0.0%3447 0.000 0.532 4.583
perl filter00:00:17.297 0.0%3898 2.875 4.437 18.000
python filter00:00:00.011 0.0%3898 0.000 0.003 0.111
site send00:00:01.245 0.0%7002 0.012 0.178 0.463
TOTAL: 24:01:10.75724:00:59.679100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%3450 0.000 0.007 0.158
article prepare00:00:00.001 0.0%212 0.000 0.005 0.250
article read00:00:00.012 0.0%49 0.000 0.245 3.000
backlog stats00:00:00.119 0.0%44600 0.000 0.003 0.026
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.584 0.0%26837 0.000 0.022 0.075
data write00:00:01.328 0.0%23644 0.000 0.056 0.121
idle23:50:15.321100.0%44600 840.232 1924.110 7720.000
status file00:00:00.454 0.0%209 1.000 2.172 6.000
TOTAL: 23:50:25.43523:50:17.842100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:27.421 22.8%1444 12.600 18.990 1935.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.060 0.0%3261 0.000 0.018 1.000
TOTAL: 00:02:00.16600:00:27.481 22.9%----

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
1i2pn.org 2 3906 1061 2709 136 27%26:01:19
2feed-out.gegeweb.org 5 2022 997 1025 0 49%23:34:04
3gegeweb-out.news.tnetconsulting.net 2 6234 467 5733 34 7%40:25:34
4news.glou.org 2 3138 342 2759 37 10%22:27:46
5news.nntp4.net 2 3674 244 3294 136 6%22:42:19
6usenet.pasdenom.info 3 1907 221 1671 15 11%18:52:36
7nntp.terraraq.uk 3 3259 149 3048 62 4%22:11:55
8news.samoylyk.net 1 295 5 290 0 1%02:14:59
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 45 24435 3486 20529 420 14%178:30:32

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.glou.org5.4 MB0.0 KB200.5 KB5.6 MB 96%15.0 KB
2i2pn.org3.9 MB0.0 KB385.5 KB4.3 MB 91%3.7 KB
3gegeweb-out.news.tnetconsulting.net3.0 MB1.9 KB151.1 KB3.2 MB 95%6.5 KB
4feed-out.gegeweb.org2.7 MB0.0 KB0.0 KB2.7 MB100%2.8 KB
5news.nntp4.net1.0 MB0.0 KB382.2 KB1.4 MB 73%3.7 KB
6nntp.terraraq.uk517.1 KB0.0 KB261.8 KB778.9 KB 66%3.7 KB
7usenet.pasdenom.info500.5 KB0.0 KB36.0 KB536.4 KB 93%2.3 KB
8news.samoylyk.net89.9 KB0.0 KB0.0 KB89.9 KB100%18.0 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 917.1 MB1.9 KB1.4 MB18.5 MB 92%4.8 KB

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 19 04:15:02 - 04:59:59 78 2.3% 0.03397.3 KB 2.4% 0.15
Feb 19 05:00:00 - 05:59:59 57 1.7% 0.02361.3 KB 2.2% 0.10
Feb 19 06:00:00 - 06:59:59 64 1.9% 0.02269.8 KB 1.6% 0.07
Feb 19 07:00:00 - 07:59:59 87 2.5% 0.02468.1 KB 2.8% 0.13
Feb 19 08:00:00 - 08:59:59 73 2.1% 0.02475.2 KB 2.8% 0.13
Feb 19 09:00:00 - 09:59:59 69 2.0% 0.02278.0 KB 1.7% 0.08
Feb 19 10:00:00 - 10:59:59 130 3.8% 0.04556.7 KB 3.3% 0.15
Feb 19 11:00:00 - 11:59:59 131 3.8% 0.04499.7 KB 3.0% 0.14
Feb 19 12:00:00 - 12:59:59 113 3.3% 0.03410.9 KB 2.5% 0.11
Feb 19 13:00:00 - 13:59:59 155 4.5% 0.04650.9 KB 3.9% 0.18
Feb 19 14:00:00 - 14:59:59 152 4.4% 0.04673.6 KB 4.0% 0.19
Feb 19 15:00:00 - 15:59:59 186 5.4% 0.05700.5 KB 4.2% 0.19
Feb 19 16:00:00 - 16:59:59 195 5.7% 0.051.9 MB 11.7% 0.54
Feb 19 17:00:00 - 17:59:59 134 3.9% 0.04658.0 KB 3.9% 0.18
Feb 19 18:00:00 - 18:59:59 182 5.3% 0.05606.7 KB 3.6% 0.17
Feb 19 19:00:00 - 19:59:59 240 7.0% 0.07811.4 KB 4.8% 0.23
Feb 19 20:00:00 - 20:59:59 218 6.3% 0.061.7 MB 10.3% 0.48
Feb 19 21:00:00 - 21:59:59 285 8.3% 0.081.2 MB 7.4% 0.35
Feb 19 22:00:00 - 22:59:59 240 7.0% 0.071.0 MB 6.1% 0.29
Feb 19 23:00:00 - 23:59:59 159 4.6% 0.041.0 MB 6.2% 0.29
Feb 20 00:00:00 - 00:59:59 156 4.5% 0.04640.2 KB 3.8% 0.18
Feb 20 01:00:00 - 01:59:59 121 3.5% 0.03522.0 KB 3.1% 0.15
Feb 20 02:00:00 - 02:59:59 113 3.3% 0.03420.7 KB 2.5% 0.12
Feb 20 03:00:00 - 03:59:59 73 2.1% 0.02251.0 KB 1.5% 0.07
Feb 20 04:00:00 - 04:15:01 29 0.8% 0.03101.7 KB 0.6% 0.11
TOTAL: 23:59:59 3440 100.0% 0.0416.4 MB 100.0% 0.19

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 143 0 0 0 0 0 0 0 143
2i2pn.org 129 0 0 0 0 0 0 0 129
3nntp.terraraq.uk 101 0 0 0 0 0 0 0 101
4news.glou.org 38 0 0 0 0 0 0 0 38
5gegeweb-out.news.tnetconsulting.net 26 2 0 0 0 0 0 0 24
6usenet.pasdenom.info 17 0 0 0 0 0 0 0 17
7feed-out.gegeweb.org 8 0 0 0 0 0 0 0 8
TOTAL: 7 462 2 0 0 0 0 0 0 460

Unwanted newsgroups [Top 20]:

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 170
EMP (phn nph) 84
EMP (phn path) 68
Bad path (news.giganews.com.POSTED) 64
EMP (phl) 47
Too many newsgroups 5
HTML Multipart 2
Cancels abusifs 1
Cancel of non-existing ID <54f761ab-054a-412e-b18d-a330650779f4n@googlegroups.com> 1
Cancel of non-existing ID <d2b58d69-c96b-458a-a487-2978b2458259n@googlegroups.com> 1
Cancel of non-existing ID <e8ea400e-b259-4cd1-b2b4-cdd92d068201n@googlegroups.com> 1
TOTAL: 11 444

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 8
news.nntp4.net 6
usenet.pasdenom.info 1
nntp.terraraq.uk 1
TOTAL: 4 16
TOTAL: 1 16

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3865 23 2449 0 0 6 0%23:56:13
2news.nntp4.net 3195 9 3085 0 0 0 0%23:58:48
3news.gegeweb.org 2534 8 2443 0 0 0 0%23:59:31
4news.tnetconsulting.net 5068 8 3431 0 0 9 0%23:57:55
5nntp.terraraq.uk 2384 4 2133 0 0 3 0%23:59:51
6news.samoylyk.net 3820 1 3339 0 0 5 0%23:59:51
7news.pasdenom.info 3007 0 2879 0 0 0 0%23:59:49
8news.aioe.org 0 0 0 0 0 2712 0%23:59:51
TOTAL: 8 23873 53 19759 0 0 2735 0%191:51:49

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.terraraq.uk133.6 KB0.0 KB133.6 KB0.0 KB/s33.4 KB23:59:51
2i2pn.org56.5 KB0.0 KB56.5 KB0.0 KB/s2.5 KB23:56:13
3news.gegeweb.org24.8 KB0.0 KB24.8 KB0.0 KB/s3.1 KB23:59:31
4news.tnetconsulting.net16.6 KB0.0 KB16.6 KB0.0 KB/s2.1 KB23:57:55
5news.nntp4.net15.5 KB0.0 KB15.5 KB0.0 KB/s1.7 KB23:58:48
6news.samoylyk.net2.8 KB0.0 KB2.8 KB0.0 KB/s2.8 KB23:59:51
7news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
TOTAL: 8249.7 KB0.0 KB249.7 KB0.0 KB/s4.7 KB191:51:49

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1valued.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
2104.156.155.24 81 00.0 KB 0 0 000:00:16
3mail.gegeweb.eu 288 00.0 KB 0 0 000:01:32
4celebrated.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
5192.241.230.22 1 00.0 KB 0 0 000:00:00
6agreeable.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:05
7acclaimed.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:00
8natural.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
TOTAL: 8 376 00.0 KB 0 0 000:01:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 288 00.0 KB 0 0 000:01:32
2*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:10
3unresolved 82 00.0 KB 0 0 000:00:16
TOTAL: 3 376 00.0 KB 0 0 000:01:59

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.741 4.236 1.93500:01:32
104.156.155.24 2.474 1.219 0.00000:00:16
agreeable.monitoring.internet-measurement.com 0.054 0.036 0.00000:00:05
natural.monitoring.internet-measurement.com 0.031 0.021 0.00000:00:02
celebrated.monitoring.internet-measurement.com 0.031 0.021 0.00000:00:01
192.241.230.22 0.031 0.021 0.00000:00:00
acclaimed.monitoring.internet-measurement.com 0.055 0.034 0.00000:00:00
valued.monitoring.internet-measurement.com 0.019 0.010 0.00000:00:00
TOTAL: 8 7.436 5.598 1.93500:01:59

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
192.241.230.22 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_45.13.105.36_119 1
TOTAL: 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