Daily Usenet report for news.niel.me

Nov 19 04:15:02 -- Nov 20 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 19 14:39:13 rpi-studio innd: filter: No Cancel-Key[sha1:c+/aNBIYO89FRbckpQPK7q9HEcg=] matches Cancel-Lock[sha1:IfNQ+93QqyVkwU+xxHfiWLKeY/g=] target=<673c945a$0$28482$426a34cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2220 26.8%439.1 KB 33.0%
innd 2173 26.2%357.5 KB 26.8%
nnrpd 2082 25.1%227.2 KB 17.1%
innfeed 1813 21.9%308.1 KB 23.1%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8290 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12688 55.2%
Negative hits 8079 35.2%
Do not exist 2207 9.6%
Cache misses 1 0.0%
TOTAL: 4 22975 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.002 0.0%4 0.000 0.500 1.000
article cancel00:00:00.000 0.0%4 0.000 0.000 0.000
article cleanup00:00:00.057 0.0%2207 0.000 0.026 0.143
article logging00:00:00.140 0.0%2208 0.000 0.063 0.500
article parse00:00:00.279 0.0%4764 0.000 0.059 0.300
article write00:00:01.008 0.0%2040 0.000 0.494 2.500
artlog/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.136 0.0%24192 0.000 0.006 0.031
hisgrep/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%5 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.336 0.0%22967 0.000 0.015 0.061
history sync00:00:00.052 0.0%360 0.000 0.144 1.000
history write00:00:00.382 0.0%2207 0.000 0.173 0.692
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:43.016100.0%25805 1361.855 3349.855 26098.913
nntp read00:00:00.644 0.0%24940 0.000 0.026 0.067
overview write00:00:00.584 0.0%2040 0.000 0.286 3.000
perl filter00:00:07.029 0.0%2207 1.410 3.185 8.250
python filter00:00:00.013 0.0%2207 0.000 0.006 0.250
site send00:00:00.963 0.0%4327 0.000 0.223 0.591
TOTAL: 24:01:01.76724:00:54.641100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.018 0.0%2210 0.000 0.008 0.125
article prepare00:00:00.000 0.0%760 0.000 0.000 0.000
article read00:00:00.038 0.0%186 0.000 0.204 4.000
backlog stats00:00:00.135 0.0%29092 0.000 0.005 0.021
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.348 0.0%16005 0.000 0.022 0.071
data write00:00:00.729 0.0%14090 0.000 0.052 0.143
idle23:57:46.051 99.8%29092 1217.661 2965.284 10371.069
status file00:00:00.454 0.0%250 0.000 1.816 7.000
TOTAL: 23:59:57.71623:57:47.773 99.8%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:24:51.282 91.4%9589 3.500 155.520 10041.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.122 0.1%34686 0.000 0.032 0.333
readart00:00:01.033 0.1%7587 0.103 0.136 0.155
TOTAL: 00:27:10.80600:24:53.437 91.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
1gegeweb-out.news.tnetconsulting.net 3 1851 850 966 35 45%25:03:16
2news.samoylyk.net 2 3383 413 2968 2 12%32:37:29
3feed-out.gegeweb.org 4 2000 376 1624 0 18%24:36:05
4i2pn.org 2 3436 350 3085 1 10%33:47:29
5news.nntp4.net 3 2840 222 2522 96 7%30:46:47
6usenet.pasdenom.info 3 2390 168 2213 9 7%34:59:32
7nntp.terraraq.uk 3 3440 128 3309 3 3%36:22:52
8news.glou.org 1 3019 53 2875 91 1%37:43:30
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 46 22359 2560 19562 237 11%255:57:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net3.4 MB7.1 KB7.1 KB3.4 MB 99%8.3 KB
2gegeweb-out.news.tnetconsulting.net3.0 MB0.0 KB136.2 KB3.2 MB 95%3.7 KB
3news.nntp4.net1.3 MB0.0 KB296.8 KB1.6 MB 81%5.0 KB
4feed-out.gegeweb.org1.2 MB0.0 KB0.0 KB1.2 MB100%3.4 KB
5i2pn.org1.1 MB0.0 KB2.4 KB1.1 MB 99%3.1 KB
6nntp.terraraq.uk921.0 KB0.0 KB26.9 KB947.9 KB 97%7.2 KB
7usenet.pasdenom.info471.7 KB0.0 KB18.5 KB490.2 KB 96%2.8 KB
8news.glou.org174.5 KB0.0 KB265.8 KB440.4 KB 39%3.1 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 911.5 MB7.1 KB753.7 KB12.2 MB 93%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 19 04:15:02 - 04:59:59 42 2.1% 0.02131.2 KB 1.5% 0.05
Nov 19 05:00:00 - 05:59:59 56 2.7% 0.02207.7 KB 2.4% 0.06
Nov 19 06:00:00 - 06:59:59 52 2.5% 0.01181.3 KB 2.1% 0.05
Nov 19 07:00:00 - 07:59:59 40 2.0% 0.01123.8 KB 1.4% 0.03
Nov 19 08:00:00 - 08:59:59 43 2.1% 0.01221.4 KB 2.6% 0.06
Nov 19 09:00:00 - 09:59:59 73 3.6% 0.02317.7 KB 3.7% 0.09
Nov 19 10:00:00 - 10:59:59 91 4.5% 0.03503.8 KB 5.9% 0.14
Nov 19 11:00:00 - 11:59:59 73 3.6% 0.02244.8 KB 2.9% 0.07
Nov 19 12:00:00 - 12:59:59 87 4.3% 0.02262.5 KB 3.1% 0.07
Nov 19 13:00:00 - 13:59:59 89 4.4% 0.02683.1 KB 8.0% 0.19
Nov 19 14:00:00 - 14:59:59 98 4.8% 0.03340.8 KB 4.0% 0.09
Nov 19 15:00:00 - 15:59:59 90 4.4% 0.03335.7 KB 3.9% 0.09
Nov 19 16:00:00 - 16:59:59 111 5.4% 0.03360.2 KB 4.2% 0.10
Nov 19 17:00:00 - 17:59:59 136 6.7% 0.04481.0 KB 5.6% 0.13
Nov 19 18:00:00 - 18:59:59 131 6.4% 0.04423.8 KB 4.9% 0.12
Nov 19 19:00:00 - 19:59:59 174 8.5% 0.051.0 MB 12.0% 0.29
Nov 19 20:00:00 - 20:59:59 87 4.3% 0.02343.1 KB 4.0% 0.10
Nov 19 21:00:00 - 21:59:59 88 4.3% 0.02311.1 KB 3.6% 0.09
Nov 19 22:00:00 - 22:59:59 119 5.8% 0.03455.0 KB 5.3% 0.13
Nov 19 23:00:00 - 23:59:59 113 5.5% 0.03419.5 KB 4.9% 0.12
Nov 20 00:00:00 - 00:59:59 72 3.5% 0.02254.4 KB 3.0% 0.07
Nov 20 01:00:00 - 01:59:59 64 3.1% 0.02480.5 KB 5.6% 0.13
Nov 20 02:00:00 - 02:59:59 40 2.0% 0.01207.7 KB 2.4% 0.06
Nov 20 03:00:00 - 03:59:59 57 2.8% 0.02205.2 KB 2.4% 0.06
Nov 20 04:00:00 - 04:15:02 17 0.8% 0.0255.0 KB 0.6% 0.06
TOTAL: 24:00:00 2043 100.0% 0.028.4 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 76 0 0 0 0 0 0 0 76
2news.glou.org 54 0 0 0 0 0 0 0 54
3gegeweb-out.news.tnetconsulting.net 32 0 0 0 0 0 0 0 32
4usenet.pasdenom.info 6 0 0 0 0 0 0 0 6
5feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 5 169 0 0 0 0 0 0 0 169

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 77
Too many newsgroups 50
Bad path (news.giganews.com.POSTED) 35
HTML Multipart 2
EMP (md5) 2
No Cancel-Key matches Cancel-Lock. target=<673c945a$0$28482$426a34cc@news.free.fr> 1
Too many newsgroups (meow) 1
TOTAL: 7 168

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 1
TOTAL: 1 1
TOTAL: 1 1

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 2497 127 1682 5 0 43 5%23:59:49
2news.gegeweb.org 1866 43 1629 0 0 32 2%23:59:50
3news.tnetconsulting.net 2776 8 2026 3 0 30 0%23:59:49
4news.pasdenom.info 1732 0 1566 1 0 18 0%23:56:40
5nntp.terraraq.uk 1288 0 1232 0 0 16 0%23:56:40
6news.aioe.org 0 0 0 0 0 1738 0%24:00:00
7news.nntp4.net 2083 0 1900 0 0 10 0%23:59:50
8news.samoylyk.net 2043 0 1715 3 0 19 0%23:56:40
TOTAL: 8 14285 178 11750 12 0 1906 1%191:49:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org442.6 KB21.0 KB463.6 KB0.0 KB/s3.5 KB23:59:49
2news.gegeweb.org96.5 KB0.0 KB96.5 KB0.0 KB/s2.2 KB23:59:50
3news.tnetconsulting.net21.7 KB8.7 KB30.4 KB0.0 KB/s2.8 KB23:59:49
4news.pasdenom.info0.0 KB291.5 KB291.5 KB0.0 KB/s291.5 KB23:56:40
5nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:40
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
8news.samoylyk.net0.0 KB9.2 KB9.2 KB0.0 KB/s3.1 KB23:56:40
TOTAL: 8560.9 KB330.3 KB891.2 KB0.0 KB/s4.7 KB191:49:18
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1162.250.122.68 24 758713.3 MB 94 0 000:24:14
TOTAL: 1 24 758713.3 MB 94 0 000:27:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 35 758713.3 MB 94 0 000:25:01
2? 3 00.0 KB 0 0 000:00:03
3*.gegeweb.eu 287 00.0 KB 0 0 000:01:54
4*.stretchoid.com 1 00.0 KB 0 0 000:00:01
5*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:07
6*.census.shodan.io 1 00.0 KB 0 0 000:00:00
7*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
TOTAL: 7 333 758713.3 MB 94 0 000:27:10

NNRP auth users [Top 20]:

UserConn
mailman 287
TOTAL: 1 287

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
162.250.122.68 1.653 3.096 0.00000:24:14
mail.gegeweb.eu 4.481 3.659 1.55100:01:54
147.185.133.242 0.027 0.013 0.00000:00:12
198.235.24.193 0.030 0.019 0.00000:00:10
104.152.52.162 0.009 0.013 0.00000:00:10
198.235.24.244 0.027 0.022 0.00000:00:05
prominent.monitoring.internet-measurement.com 0.018 0.022 0.00000:00:04
instinctive.monitoring.internet-measurement.com 0.018 0.004 0.00000:00:02
91.238.181.31 0.029 0.016 0.00000:00:02
240e:108:4ac1:fffe::2 0.053 0.039 0.00000:00:01
2607:ff10:c8:594::e 0.029 0.021 0.00000:00:01
206.168.34.35 0.037 0.025 0.00000:00:01
azpdwg42.stretchoid.com 0.015 0.009 0.00000:00:01
71.6.134.233 0.009 0.014 0.00000:00:01
185.242.226.41 0.029 0.017 0.00000:00:01
41.149.216.162.bc.googleusercontent.com 0.025 0.014 0.00000:00:00
198.235.24.237 0.011 0.011 0.00000:00:00
104.152.52.137 0.015 0.007 0.00000:00:00
grand.monitoring.internet-measurement.com 0.018 0.009 0.00000:00:00
sky.census.shodan.io 0.018 0.004 0.00000:00:00
TOTAL: 22 6.597 7.066 1.55100:27:10

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 287
240e:108:4ac1:fffe::2 2
likeable.monitoring.internet-measurement.com 2
91.238.181.31 1
198.235.24.237 1
198.235.24.244 1
sky.census.shodan.io 1
206.168.34.35 1
41.149.216.162.bc.googleusercontent.com 1
prominent.monitoring.internet-measurement.com 1
104.152.52.137 1
185.242.226.41 1
azpdwg42.stretchoid.com 1
2607:ff10:c8:594::e 1
92.118.39.213 1
71.6.134.233 1
instinctive.monitoring.internet-measurement.com 1
104.152.52.162 1
grand.monitoring.internet-measurement.com 1
147.185.133.242 1
TOTAL: 21 309

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
185.242.226.41 5
41.149.216.162.bc.googleusercontent.com 4
147.185.133.242 4
azpdwg42.stretchoid.com 1
206.168.34.35 1
91.238.181.31 1
TOTAL: 6 16

NNRP unrecognized commands (by command):

CommandCount
Accept-Encoding: gzip 3
GET / HTTP/1.1 3
Host: 45.13.105.36:563 2
User-Agent: Expanse, a Palo Alto Network... 2
Host: 45.13.105.36:119 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
MGLNDD_45.13.105.36_119 1
EHLO www.censys.io 1
Accept: */* 1
#003 1
TOTAL: 10 16

NNRP client timeouts [Top 20]:

SystemConnPeer
185.242.226.41 1 1
91.238.181.31 1 1
TOTAL: 2 2 4

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 5888 77.6%
2local 1699 22.4%
TOTAL: 2 7587100.0%

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

NewsgroupCount
1grisbi.user.french 1200
2grisbi.bugsreports 1200
3grisbi.test 1200
4local.test 1141
5grisbi.devel 1000
6grisbi.cvs 864
7local.gegeweb.support 558
8grisbi.user 408
9grisbi.admin 16
TOTAL: 9 7587