Daily Usenet report for news.niel.me

May 25 04:15:01 -- May 26 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 25 19:48:52 rpi-studio innd: filter: No Cancel-Key[sha1:hipUZWwSSXHnmCMRI54O/uEmT2o=] matches Cancel-Lock[sha1:G54mG7C4rL8g+IHNmv06kkwx0WA=] target=<628e6a8c$0$9165$426a34cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
inn 4175 42.9%815.7 KB 48.9%
innd 2253 23.1%388.8 KB 23.3%
innfeed 1685 17.3%308.8 KB 18.5%
nnrpd 1618 16.6%154.5 KB 9.3%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 9733 100.0%1.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24763 63.9%
Negative hits 9853 25.4%
Do not exist 4128 10.7%
Cache misses 2 0.0%
TOTAL: 4 38746 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:01.670 0.0%11 0.333 151.818 831.500
article cancel00:00:00.002 0.0%11 0.000 0.182 0.667
article cleanup00:00:00.091 0.0%4132 0.000 0.022 0.143
article logging00:00:00.310 0.0%4154 0.000 0.075 0.222
article parse00:00:00.860 0.0%8896 0.000 0.097 0.296
article write00:00:04.545 0.0%3830 0.143 1.187 42.615
artlog/artcncl00:00:00.001 0.0%11 0.000 0.091 0.333
artlog/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
data move00:00:00.112 0.0%42998 0.000 0.003 0.017
hisgrep/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%13 0.000 0.077 1.000
hishave/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.521 0.0%38751 0.000 0.013 0.042
history sync00:00:00.063 0.0%406 0.000 0.155 1.000
history write00:00:00.876 0.0%4131 0.053 0.212 0.727
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:22.855 99.9%42955 628.601 2011.939 7232.771
nntp read00:00:01.354 0.0%42481 0.000 0.032 0.080
overview write00:00:02.599 0.0%3830 0.043 0.679 6.615
perl filter00:00:20.423 0.0%4131 2.288 4.944 53.882
python filter00:00:00.005 0.0%4131 0.000 0.001 0.043
site send00:00:01.464 0.0%7713 0.000 0.190 0.477
TOTAL: 24:01:09.74524:00:57.752100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.039 0.0%3998 0.000 0.010 0.125
article prepare00:00:00.000 0.0%136 0.000 0.000 0.000
article read00:00:00.012 0.0%30 0.000 0.400 7.000
backlog stats00:00:00.118 0.0%54933 0.000 0.002 0.016
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.796 0.0%34047 0.000 0.023 0.054
data write00:00:02.012 0.0%30532 0.000 0.066 0.109
idle23:58:18.709100.0%54933 580.250 1570.981 4659.465
status file00:00:00.457 0.0%169 0.000 2.704 7.000
TOTAL: 23:58:25.21423:58:22.143100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:43.958 11.5%1464 16.600 30.026 9084.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.100 0.0%3601 0.000 0.028 0.273
readart00:00:00.029 0.0%42 0.690 0.690 0.690
TOTAL: 00:06:21.24600:00:44.087 11.6%----

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-out.aioe.org 3 4157 2248 1879 30 54%26:10:10
2i2pn.org 2 3624 835 2666 123 23%21:13:43
3usenet.pasdenom.info 6 3174 322 2828 24 10%25:12:36
4feed-out.gegeweb.org 2 2419 255 2164 0 10%23:59:47
5nntp.terraraq.uk 3 3858 75 3705 78 1%24:21:14
6news.samoylyk.net 1 5221 54 5164 3 1%31:48:35
7gegeweb-out.news.tnetconsulting.net 1 3708 36 3664 8 0%23:59:55
8news.nntp4.net 1 15 0 15 0 0%00:13:19
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 44 26176 3825 22085 266 14%176:59:19
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org9.2 MB0.0 KB147.4 KB9.3 MB 98%4.2 KB
2i2pn.org3.0 MB0.0 KB982.2 KB4.0 MB 75%4.3 KB
3news.samoylyk.net2.4 MB0.0 KB18.5 KB2.4 MB 99%43.3 KB
4usenet.pasdenom.info960.3 KB0.0 KB46.2 KB1006.5 KB 95%2.9 KB
5feed-out.gegeweb.org725.7 KB0.0 KB0.0 KB725.7 KB100%2.8 KB
6gegeweb-out.news.tnetconsulting.net578.0 KB108.0 KB133.8 KB819.7 KB 70%18.6 KB
7nntp.terraraq.uk456.3 KB0.0 KB419.1 KB875.4 KB 52%5.7 KB
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 917.3 MB108.0 KB1.7 MB19.1 MB 90%4.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 25 04:15:01 - 04:59:59 85 2.2% 0.03280.9 KB 1.5% 0.10
May 25 05:00:00 - 05:59:59 72 1.9% 0.02370.3 KB 2.0% 0.10
May 25 06:00:00 - 06:59:59 82 2.1% 0.02436.2 KB 2.4% 0.12
May 25 07:00:00 - 07:59:59 113 3.0% 0.03423.7 KB 2.3% 0.12
May 25 08:00:00 - 08:59:59 147 3.8% 0.041.0 MB 5.7% 0.29
May 25 09:00:00 - 09:59:59 147 3.8% 0.04847.7 KB 4.6% 0.24
May 25 10:00:00 - 10:59:59 166 4.3% 0.05617.2 KB 3.4% 0.17
May 25 11:00:00 - 11:59:59 136 3.6% 0.04564.1 KB 3.1% 0.16
May 25 12:00:00 - 12:59:59 141 3.7% 0.04681.2 KB 3.7% 0.19
May 25 13:00:00 - 13:59:59 117 3.1% 0.03423.1 KB 2.3% 0.12
May 25 14:00:00 - 14:59:59 125 3.3% 0.03498.4 KB 2.7% 0.14
May 25 15:00:00 - 15:59:59 250 6.5% 0.071.0 MB 5.6% 0.29
May 25 16:00:00 - 16:59:59 193 5.0% 0.05711.0 KB 3.9% 0.20
May 25 17:00:00 - 17:59:59 288 7.5% 0.081.9 MB 10.4% 0.53
May 25 18:00:00 - 18:59:59 196 5.1% 0.05866.3 KB 4.7% 0.24
May 25 19:00:00 - 19:59:59 204 5.3% 0.06773.7 KB 4.2% 0.21
May 25 20:00:00 - 20:59:59 263 6.9% 0.071.4 MB 8.0% 0.41
May 25 21:00:00 - 21:59:59 206 5.4% 0.061.0 MB 5.6% 0.29
May 25 22:00:00 - 22:59:59 181 4.7% 0.05796.8 KB 4.3% 0.22
May 25 23:00:00 - 23:59:59 167 4.4% 0.05581.7 KB 3.2% 0.16
May 26 00:00:00 - 00:59:59 142 3.7% 0.04726.8 KB 4.0% 0.20
May 26 01:00:00 - 01:59:59 113 3.0% 0.03619.2 KB 3.4% 0.17
May 26 02:00:00 - 02:59:59 126 3.3% 0.04991.4 KB 5.4% 0.28
May 26 03:00:00 - 03:59:59 133 3.5% 0.04548.5 KB 3.0% 0.15
May 26 04:00:00 - 04:15:02 36 0.9% 0.04130.8 KB 0.7% 0.15
TOTAL: 24:00:01 3829 100.0% 0.0417.9 MB 100.0% 0.21
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1i2pn.org 139 0 0 0 0 0 0 0 139
2nntp.terraraq.uk 81 0 0 0 0 0 0 0 81
3news-out.aioe.org 49 1 0 0 0 0 0 0 48
4news.nntp4.net 30 0 0 1 0 0 0 0 29
5usenet.pasdenom.info 17 0 0 0 0 0 0 0 17
6gegeweb-out.news.tnetconsulting.net 6 0 0 0 0 0 0 0 6
7news.samoylyk.net 2 0 0 0 0 0 0 0 2
TOTAL: 7 324 1 0 1 0 0 0 0 322

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Bad path (news.giganews.com.POSTED) 152
EMP (phn nph) 73
EMP (md5) 38
EMP (phl) 27
Too many newsgroups 8
No Cancel-Key matches Cancel-Lock. target=<628e6a8c$0$9165$426a34cc@news.free.fr> 1
Cancel of non-existing ID <jf74cjFfd8eU1@mid.individual.net> 1
TOTAL: 7 300

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 22
TOTAL: 1 22
TOTAL: 1 22

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 6507 13 3815 1 0 84 0%23:59:57
2i2pn.org 5511 9 2891 0 0 81 0%23:59:57
3news.gegeweb.org 3641 4 3564 1 0 0 0%23:59:57
4news.pasdenom.info 3363 3 3275 1 0 2 0%23:59:57
5news.aioe.org 1342 1 1297 0 0 0 0%23:56:14
6news.nntp4.net 4060 1 3806 0 0 5 0%23:59:57
7nntp.terraraq.uk 2759 0 2703 0 0 0 0%23:59:57
8news.samoylyk.net 3869 0 3788 0 0 0 0%23:59:57
TOTAL: 8 31052 31 25139 3 0 172 0%191:55:53
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net58.1 KB61.6 KB119.7 KB0.0 KB/s8.5 KB23:59:57
2news.pasdenom.info30.5 KB4.3 KB34.8 KB0.0 KB/s8.7 KB23:59:57
3i2pn.org27.9 KB0.0 KB27.9 KB0.0 KB/s3.1 KB23:59:57
4news.gegeweb.org16.4 KB1.9 KB18.3 KB0.0 KB/s3.7 KB23:59:57
5news.nntp4.net12.8 KB0.0 KB12.8 KB0.0 KB/s12.8 KB23:59:57
6news.aioe.org5.2 KB0.0 KB5.2 KB0.0 KB/s5.2 KB23:56:14
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
8news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 8150.9 KB67.8 KB218.7 KB0.0 KB/s6.4 KB191:55:53
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12a0e:e701:1154:0:2ccc:4bfc:f104:f62a 1 2798.1 KB 5 0 000:04:57
TOTAL: 1 1 2798.1 KB 5 0 000:06:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 1 2798.1 KB 5 0 000:04:57
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:08
3unresolved 12 00.0 KB 0 0 000:00:14
TOTAL: 3 301 2798.1 KB 5 0 000:06:20

NNRP auth users [Top 20]:

UserConn
mailman 288
gerald 1
TOTAL: 2 289

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2a0e:e701:1154:0:2ccc:4bfc:f104:f62a 0.135 0.011 0.00600:04:57
mail.gegeweb.eu 7.873 8.055 2.29300:01:08
192.241.219.178 0.011 0.042 0.00000:00:09
164.92.112.152 0.256 0.176 0.00000:00:02
79.124.62.106 0.027 0.014 0.00000:00:01
88.165.5.23 0.045 0.011 0.00000:00:00
185.191.34.211 0.022 0.034 0.00000:00:00
TOTAL: 7 8.369 8.343 2.29900:06:20

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
164.92.112.152 8
79.124.62.106 1
185.191.34.211 1
88.165.5.23 1
192.241.219.178 1
TOTAL: 6 300

NNRP unrecognized commands (by host):

SystemConn
164.92.112.152 42
79.124.62.106 1
TOTAL: 2 43

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:119 7
Accept: */* 7
Connection: keep-alive 7
Accept-Encoding: gzip, deflate 7
User-Agent: Mozilla/5.0 (Windows NT 10.0... 6
GET /streaming/clients_live.php HTTP/1.1 1
GET /stream/live.php HTTP/1.1 1
#003 1
GET /system_api.php HTTP/1.1 1
GET /flu/403.html HTTP/1.1 1
GET / HTTP/1.1 1
User-Agent: VLC/3.0.8 LibVLC/3.0.8 1
GET /c/version.js HTTP/1.1 1
GET /stalker_portal/c/version.js HTTP/1.... 1
TOTAL: 14 43

NNRP client timeouts [Top 20]:

SystemConnPeer
79.124.62.106 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1fr 27100.0%
TOTAL: 1 27100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1fr.misc.domotique 12
2fr.usenet.distribution 10
3fr.usenet.forums.annonces 2
4fr.usenet.documents 2
5fr.usenet.divers 1
TOTAL: 5 27