Daily Usenet report for news.niel.me

Apr 18 04:15:02 -- Apr 19 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Apr 18 18:40:49 rpi-studio innd: filter: No Cancel-Key[sha1:jVzybssM7aCUS+TNrOJl+PDe6w8= #015#012 sha256:ADbPkOhRek/3wGjLfkIFWWUt4Sq752EqQ3rQNGD1N4Q=] matches Cancel-Lock[sha1:1T3Iat1i4rIfDmlMscpM10AQJ/c=] target=<Bfe3epKuEqc@CanLock4all.invalid>

Log entries by program:

Program nameLines%LinesSize%Size
inn 20310 75.0%4.0 MB 80.4%
innd 2461 9.1%416.8 KB 8.2%
nnrpd 2306 8.5%246.2 KB 4.9%
innfeed 1988 7.3%326.7 KB 6.5%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 27067 100.0%4.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 110072 58.7%
Negative hits 48169 25.7%
Do not exist 20262 10.8%
Cache misses 8958 4.8%
TOTAL: 4 187461 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.009 0.0%8 1.000 1.125 1.500
article cancel00:00:00.002 0.0%9 0.000 0.222 1.000
article cleanup00:00:00.305 0.0%20285 0.000 0.015 0.154
article logging00:00:01.390 0.0%20292 0.000 0.068 0.222
article parse00:00:01.284 0.0%28170 0.000 0.046 0.250
article write00:00:11.998 0.0%19842 0.371 0.605 4.273
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:00.329 0.0%128832 0.000 0.003 0.015
hisgrep/artcncl00:00:00.000 0.0%8 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:01.438 0.0%187597 0.000 0.008 0.038
history sync00:00:00.046 0.0%406 0.000 0.113 1.000
history write00:00:03.112 0.0%20284 0.043 0.153 0.793
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:59:41.151 99.9%127606 23.467 676.936 5887.853
nntp read00:00:02.713 0.0%128928 0.009 0.021 0.066
overview write00:00:03.709 0.0%19842 0.045 0.187 3.955
perl filter00:00:37.056 0.0%20284 1.099 1.827 10.882
python filter00:00:00.039 0.0%20284 0.000 0.002 0.049
site send00:00:03.679 0.0%39744 0.000 0.093 0.522
TOTAL: 24:01:13.34524:00:48.261100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.218 0.0%59500 0.000 0.004 0.100
article prepare00:00:00.003 0.0%4036 0.000 0.001 0.002
article read00:00:00.090 0.0%947 0.000 0.095 3.500
backlog stats00:00:00.304 0.0%156611 0.000 0.002 0.022
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.802 0.0%108019 0.000 0.017 0.059
data write00:00:03.712 0.0%117149 0.009 0.032 0.112
idle23:59:07.984100.0%156611 17.565 551.353 3543.276
status file00:00:00.949 0.0%383 0.000 2.478 6.000
TOTAL: 23:59:27.28423:59:15.062100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:06:59.743 79.9%1468 11.400 285.928 49931.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.115 0.0%3337 0.000 0.034 6.000
TOTAL: 00:08:45.48100:06:59.858 79.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
1news.glou.org 4 19753 9617 10034 102 48%24:44:58
2feed-out.gegeweb.org 3 18443 4450 13992 1 24%23:59:55
3news.nntp4.net 2 19973 4407 15345 221 22%23:49:31
4i2pn.org 1 19836 621 19138 77 3%21:22:27
5news.samoylyk.net 2 19931 382 19530 19 1%23:39:36
6gegeweb-out.news.tnetconsulting.net 1 1270 50 1219 1 3%08:27:01
7nntp.terraraq.uk 1 605 28 573 4 4%03:26:00
8usenet.pasdenom.info 1 3909 2 3907 0 0%03:29:39
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 40 103720 19557 83738 425 18%132:59:07

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.glou.org12.1 MB0.0 KB261.2 KB12.4 MB 97%1.3 KB
2feed-out.gegeweb.org4.8 MB0.0 KB4.0 KB4.8 MB 99%1.1 KB
3news.nntp4.net4.4 MB0.0 KB3.3 MB7.8 MB 57%1.7 KB
4i2pn.org2.1 MB0.0 KB242.6 KB2.3 MB 89%3.4 KB
5news.samoylyk.net1.7 MB39.1 KB66.6 KB1.8 MB 94%4.5 KB
6gegeweb-out.news.tnetconsulting.net598.8 KB0.0 KB2.3 KB601.2 KB 99%11.8 KB
7nntp.terraraq.uk142.8 KB0.0 KB69.3 KB212.1 KB 67%6.6 KB
8usenet.pasdenom.info2.4 KB0.0 KB0.0 KB2.4 KB100%1.2 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 925.8 MB39.1 KB3.9 MB29.8 MB 86%1.5 KB

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 18 04:15:02 - 04:59:59 83 0.4% 0.031.5 MB 5.7% 0.58
Apr 18 05:00:00 - 05:59:59 87 0.4% 0.021.1 MB 4.1% 0.31
Apr 18 06:00:00 - 06:59:59 96 0.5% 0.03532.2 KB 2.0% 0.15
Apr 18 07:00:00 - 07:59:59 125 0.6% 0.03412.1 KB 1.5% 0.11
Apr 18 08:00:00 - 08:59:59 122 0.6% 0.03344.6 KB 1.3% 0.10
Apr 18 09:00:00 - 09:59:59 161 0.8% 0.041.0 MB 3.8% 0.29
Apr 18 10:00:00 - 10:59:59 114 0.6% 0.03495.7 KB 1.8% 0.14
Apr 18 11:00:00 - 11:59:59 151 0.8% 0.04462.7 KB 1.7% 0.13
Apr 18 12:00:00 - 12:59:59 121 0.6% 0.03418.3 KB 1.5% 0.12
Apr 18 13:00:00 - 13:59:59 171 0.9% 0.05758.1 KB 2.8% 0.21
Apr 18 14:00:00 - 14:59:59 591 3.0% 0.161.1 MB 4.0% 0.30
Apr 18 15:00:00 - 15:59:59 16102 81.2% 4.479.5 MB 35.8% 2.71
Apr 18 16:00:00 - 16:59:59 184 0.9% 0.05624.8 KB 2.3% 0.17
Apr 18 17:00:00 - 17:59:59 193 1.0% 0.05615.2 KB 2.3% 0.17
Apr 18 18:00:00 - 18:59:59 158 0.8% 0.04432.6 KB 1.6% 0.12
Apr 18 19:00:00 - 19:59:59 161 0.8% 0.04614.4 KB 2.3% 0.17
Apr 18 20:00:00 - 20:59:59 190 1.0% 0.051.9 MB 7.2% 0.55
Apr 18 21:00:00 - 21:59:59 171 0.9% 0.05702.3 KB 2.6% 0.20
Apr 18 22:00:00 - 22:59:59 159 0.8% 0.04649.8 KB 2.4% 0.18
Apr 18 23:00:00 - 23:59:59 185 0.9% 0.05682.9 KB 2.5% 0.19
Apr 19 00:00:00 - 00:59:59 157 0.8% 0.04835.2 KB 3.1% 0.23
Apr 19 01:00:00 - 01:59:59 116 0.6% 0.03914.7 KB 3.4% 0.25
Apr 19 02:00:00 - 02:59:59 113 0.6% 0.03709.2 KB 2.6% 0.20
Apr 19 03:00:00 - 03:59:59 93 0.5% 0.03366.2 KB 1.3% 0.10
Apr 19 04:00:00 - 04:15:02 37 0.2% 0.04144.0 KB 0.5% 0.16
TOTAL: 24:00:00 19841 100.0% 0.2326.6 MB 100.0% 0.32

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 203 0 0 0 0 0 0 0 203
2news.glou.org 102 0 0 0 0 0 0 0 102
3i2pn.org 89 0 0 0 0 0 0 0 89
4usenet.pasdenom.info 28 0 0 0 0 0 0 0 28
5nntp.terraraq.uk 19 0 0 0 0 0 0 0 19
6gegeweb-out.news.tnetconsulting.net 6 0 0 1 0 0 0 0 5
7feed-out.gegeweb.org 4 0 0 0 0 0 0 0 4
8news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 8 452 0 0 1 0 0 0 0 451

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 111
EMP (phn path) 96
EMP (phl) 80
Bad path (news.giganews.com.POSTED) 68
EMP (md5) 53
EMP (phr nph) 28
EMP (phn nph) 3
Cancels abusifs 2
hierarchy violation - crosspost outside sdnet 1
No Cancel-Key matches Cancel-Lock. target=<Bfe3epKuEqc@CanLock4all.invalid> 1
HTML Multipart 1
TOTAL: 11 444

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 3
news.nntp4.net 2
news.samoylyk.net 1
nntp.terraraq.uk 1
TOTAL: 4 7
TOTAL: 1 7

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.pasdenom.info 21698 381 18936 218 0 17612 1%23:59:52
2news.tnetconsulting.net 32109 97 19729 11 0 9618 0%23:59:52
3i2pn.org 33849 81 19040 0 0 11106 0%23:59:52
4news.nntp4.net 13493 46 12207 0 0 241 0%23:59:29
5nntp.terraraq.uk 19367 35 18798 25 0 0 0%23:59:52
6news.gegeweb.org 15876 25 15345 3 0 0 0%23:59:34
7news.samoylyk.net 22010 14 19587 1 0 1084 0%23:59:22
8news.aioe.org 0 0 0 0 0 18861 0%23:59:52
TOTAL: 8 158402 679 123642 258 0 58522 0%191:57:45

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.nntp4.net448.5 KB0.0 KB448.5 KB0.0 KB/s9.7 KB23:59:29
2news.pasdenom.info220.2 KB286.0 KB506.2 KB0.0 KB/s0.8 KB23:59:52
3nntp.terraraq.uk204.9 KB2.0 MB2.2 MB0.0 KB/s38.1 KB23:59:52
4i2pn.org166.3 KB0.0 KB166.3 KB0.0 KB/s2.1 KB23:59:52
5news.tnetconsulting.net97.5 KB9.8 KB107.4 KB0.0 KB/s1.0 KB23:59:52
6news.gegeweb.org39.3 KB7.9 KB47.2 KB0.0 KB/s1.7 KB23:59:34
7news.samoylyk.net38.5 KB1.8 KB40.3 KB0.0 KB/s2.7 KB23:59:22
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
TOTAL: 81.2 MB2.3 MB3.5 MB0.0 KB/s3.8 KB191:57:45

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12a02-8428-0e98-6001-0b95-6e6a-230c-89bf.rev.sfr.net 2 00.0 KB 0 0 000:06:41
288.165.5.23 5 00.0 KB 0 0 000:00:01
350.31.21.5 3 00.0 KB 0 0 000:00:12
480.66.77.238 1 00.0 KB 0 0 000:00:00
5mail.gegeweb.eu 288 00.0 KB 0 0 000:01:33
646.17.96.40 85 00.0 KB 0 0 000:00:12
7resounding.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
8198.199.92.115 1 00.0 KB 0 0 000:00:00
TOTAL: 8 386 00.0 KB 0 0 000:08:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:33
3unresolved 95 00.0 KB 0 0 000:00:27
4*.rev.sfr.net 2 00.0 KB 0 0 000:06:41
TOTAL: 4 386 00.0 KB 0 0 000:08:44

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2a02-8428-0e98-6001-0b95-6e6a-230c-89bf.rev.sfr.net 0.043 0.088 0.00000:06:41
mail.gegeweb.eu 4.322 4.824 1.95100:01:33
50.31.21.5 0.134 0.093 0.00000:00:12
46.17.96.40 2.341 1.143 0.00000:00:12
resounding.monitoring.internet-measurement.com 0.032 0.021 0.00000:00:01
88.165.5.23 0.088 0.143 0.00000:00:01
80.66.77.238 0.010 0.038 0.00000:00:00
198.199.92.115 0.010 0.042 0.00000:00:00
TOTAL: 8 6.980 6.392 1.95100:08:44

NNRP unrecognized commands (by host):

SystemConn
80.66.77.238 5
198.199.92.115 1
TOTAL: 2 6

NNRP unrecognized commands (by command):

CommandCount
User-Agent: Mozilla/5.0 zgrab/0.x 1
Accept-Encoding: gzip 1
GET / HTTP/1.1 1
Host: 45.13.105.36:119 1
Accept: */* 1
MGLNDD_45.13.105.36_119 1
TOTAL: 6 6