Daily Usenet report for news.niel.me

Jun 7 04:15:01 -- Jun 8 04:15:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jun 7 18:01:49 rpi-studio innd: filter: No Cancel-Key[sha1:22FSqP9H+qlZAmTaHGM1K0CvyTU=] matches Cancel-Lock[sha1:V2Xw5eXV8HWxTQO+AXxstRg36aA=] target=<6663279d$0$2563$426a74cc@news.free.fr>
Jun 8 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:AxlagpTYwM8ZmATSG9ZOULDqW20=] matches Cancel-Lock[sha1:R6h6FY+ov5ZYtt6FeEFO4bf453Q=] target=<de-gruppen-finden-01.06.2024@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2468 29.6%452.1 KB 34.0%
innd 2189 26.2%368.7 KB 27.7%
nnrpd 1950 23.4%213.3 KB 16.0%
innfeed 1733 20.8%296.1 KB 22.3%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 8342 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 13641 59.4%
Negative hits 6859 29.9%
Do not exist 2447 10.7%
Cache misses 6 0.0%
TOTAL: 4 22953 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.016 0.0%8 1.000 2.000 4.000
article cancel00:00:00.001 0.0%9 0.000 0.111 1.000
article cleanup00:00:00.057 0.0%2451 0.000 0.023 1.000
article logging00:00:00.167 0.0%2452 0.000 0.068 0.286
article parse00:00:00.340 0.0%6394 0.000 0.053 0.294
article write00:00:01.122 0.0%2184 0.000 0.514 1.750
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.144 0.0%24574 0.000 0.006 0.034
hisgrep/artcncl00:00:00.000 0.0%9 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%11 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:00.367 0.0%22947 0.000 0.016 0.058
history sync00:00:00.058 0.0%358 0.000 0.162 1.000
history write00:00:00.399 0.0%2448 0.000 0.163 0.600
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:37.418100.0%27156 957.065 3182.995 42879.714
nntp read00:00:00.653 0.0%26477 0.000 0.025 0.111
overview write00:00:00.952 0.0%2184 0.000 0.436 4.800
perl filter00:00:10.372 0.0%2448 2.556 4.237 17.000
python filter00:00:00.014 0.0%2448 0.000 0.006 0.111
site send00:00:00.759 0.0%4383 0.000 0.173 0.500
TOTAL: 24:01:00.48124:00:52.840100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.013 0.0%2195 0.000 0.006 0.100
article prepare00:00:00.000 0.0%652 0.000 0.000 0.000
article read00:00:00.028 0.0%154 0.000 0.182 3.000
backlog stats00:00:00.170 0.0%33337 0.000 0.005 0.024
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.428 0.0%17731 0.000 0.024 0.093
data write00:00:00.821 0.0%15704 0.000 0.052 0.119
idle23:51:22.167100.0%33337 1204.048 2576.182 7813.506
status file00:00:00.417 0.0%216 0.000 1.931 7.000
TOTAL: 23:51:29.03523:51:24.044100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:50:45.033 96.7%14853 19.000 205.011 878.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.445 0.1%55916 0.000 0.044 1.000
readart00:00:01.871 0.1%12948 0.120 0.145 0.400
TOTAL: 00:52:29.42200:50:49.349 96.8%----

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
1feed-out.gegeweb.org 3 2116 1157 959 0 54%23:58:12
2news.nntp4.net 2 2021 224 1744 53 11%23:18:26
3gegeweb-out.news.tnetconsulting.net 2 1535 205 1299 31 13%23:59:42
4i2pn.org 1 1898 125 1749 24 6%23:59:57
5news.glou.org 1 3073 108 2739 226 3%37:22:05
6nntp.terraraq.uk 2 1573 72 1496 5 4%23:42:02
7news.samoylyk.net 1 571 21 544 6 3%07:12:04
8usenet.pasdenom.info 3 164 1 162 1 0%04:59:28
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 40 12951 1913 10692 346 14%168:31:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org3.9 MB0.0 KB0.0 KB3.9 MB100%3.4 KB
2news.nntp4.net1.2 MB22.6 KB198.9 KB1.4 MB 84%5.1 KB
3gegeweb-out.news.tnetconsulting.net640.8 KB3.0 KB114.4 KB758.3 KB 84%3.2 KB
4nntp.terraraq.uk472.8 KB3.0 KB12.9 KB488.6 KB 96%6.3 KB
5i2pn.org437.1 KB0.0 KB40.8 KB477.9 KB 91%3.2 KB
6news.glou.org418.2 KB0.0 KB757.4 KB1.1 MB 35%3.5 KB
7news.samoylyk.net125.9 KB0.0 KB29.9 KB155.8 KB 80%5.8 KB
8usenet.pasdenom.info1.7 KB0.0 KB3.1 KB4.8 KB 35%2.4 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 97.1 MB28.6 KB1.1 MB8.2 MB 85%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 7 04:15:01 - 04:59:59 36 1.6% 0.01181.2 KB 2.1% 0.07
Jun 7 05:00:00 - 05:59:59 47 2.2% 0.01192.3 KB 2.3% 0.05
Jun 7 06:00:00 - 06:59:59 39 1.8% 0.01101.3 KB 1.2% 0.03
Jun 7 07:00:00 - 07:59:59 45 2.1% 0.01167.1 KB 2.0% 0.05
Jun 7 08:00:00 - 08:59:59 62 2.8% 0.02272.7 KB 3.2% 0.08
Jun 7 09:00:00 - 09:59:59 62 2.8% 0.02204.2 KB 2.4% 0.06
Jun 7 10:00:00 - 10:59:59 93 4.3% 0.03406.9 KB 4.8% 0.11
Jun 7 11:00:00 - 11:59:59 86 3.9% 0.02328.6 KB 3.9% 0.09
Jun 7 12:00:00 - 12:59:59 86 3.9% 0.02238.9 KB 2.8% 0.07
Jun 7 13:00:00 - 13:59:59 101 4.6% 0.03280.7 KB 3.3% 0.08
Jun 7 14:00:00 - 14:59:59 74 3.4% 0.02306.8 KB 3.6% 0.09
Jun 7 15:00:00 - 15:59:59 95 4.4% 0.03397.9 KB 4.7% 0.11
Jun 7 16:00:00 - 16:59:59 105 4.8% 0.03353.2 KB 4.2% 0.10
Jun 7 17:00:00 - 17:59:59 126 5.8% 0.04800.3 KB 9.4% 0.22
Jun 7 18:00:00 - 18:59:59 96 4.4% 0.03308.6 KB 3.6% 0.09
Jun 7 19:00:00 - 19:59:59 121 5.5% 0.03469.2 KB 5.5% 0.13
Jun 7 20:00:00 - 20:59:59 133 6.1% 0.04448.7 KB 5.3% 0.12
Jun 7 21:00:00 - 21:59:59 174 8.0% 0.05607.6 KB 7.1% 0.17
Jun 7 22:00:00 - 22:59:59 104 4.8% 0.03450.1 KB 5.3% 0.13
Jun 7 23:00:00 - 23:59:59 117 5.4% 0.03318.1 KB 3.7% 0.09
Jun 8 00:00:00 - 00:59:59 134 6.1% 0.04671.1 KB 7.9% 0.19
Jun 8 01:00:00 - 01:59:59 99 4.5% 0.03426.2 KB 5.0% 0.12
Jun 8 02:00:00 - 02:59:59 79 3.6% 0.02229.4 KB 2.7% 0.06
Jun 8 03:00:00 - 03:59:59 58 2.7% 0.02291.0 KB 3.4% 0.08
Jun 8 04:00:00 - 04:15:02 11 0.5% 0.0149.5 KB 0.6% 0.05
TOTAL: 24:00:01 2183 100.0% 0.038.3 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.glou.org 141 0 0 0 0 0 0 0 141
2news.nntp4.net 44 0 0 3 0 0 0 0 41
3i2pn.org 33 0 0 0 0 0 0 0 33
4gegeweb-out.news.tnetconsulting.net 22 0 0 0 0 0 0 0 22
5news.samoylyk.net 21 0 0 0 0 0 0 0 21
6usenet.pasdenom.info 4 0 0 0 0 0 0 0 4
7nntp.terraraq.uk 3 0 0 0 0 0 0 0 3
TOTAL: 7 268 0 0 3 0 0 0 0 265

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 188
Bad path (news.giganews.com.POSTED) 38
Too many newsgroups 33
No Cancel-Key matches Cancel-Lock. target=<6663279d$0$2563$426a74cc@news.free.fr> 1
Cancel of non-existing ID <v3vg26$25iqj$1@dont-email.me> 1
EMP (md5) 1
Cancel for rejected article 1
Cancels abusifs 1
TOTAL: 8 264

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.pasdenom.info 1
TOTAL: 1 1
TOTAL: 1 1

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3244 88 1919 13 0 4 2%23:59:57
2news.gegeweb.org 1057 40 969 0 0 0 3%23:32:16
3news.tnetconsulting.net 3769 8 2166 7 0 12 0%23:56:41
4news.samoylyk.net 2422 2 2094 0 0 1 0%23:59:57
5news.pasdenom.info 1947 1 1785 1 0 0 0%23:59:48
6nntp.terraraq.uk 1442 1 1311 1 0 0 0%23:59:53
7news.nntp4.net 1939 1 1881 0 0 0 0%23:59:58
8news.aioe.org 0 0 0 0 0 1653 0%24:00:00
TOTAL: 8 15820 141 12125 22 0 1670 0%191:28:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org320.0 KB70.4 KB390.4 KB0.0 KB/s3.9 KB23:59:57
2news.gegeweb.org251.4 KB0.0 KB251.4 KB0.0 KB/s6.3 KB23:32:16
3news.tnetconsulting.net59.8 KB15.7 KB75.5 KB0.0 KB/s5.0 KB23:56:41
4news.samoylyk.net35.3 KB0.0 KB35.3 KB0.0 KB/s17.6 KB23:59:57
5news.nntp4.net32.8 KB0.0 KB32.8 KB0.0 KB/s32.8 KB23:59:58
6news.pasdenom.info21.5 KB32.8 KB54.4 KB0.0 KB/s27.2 KB23:59:48
7nntp.terraraq.uk21.5 KB32.8 KB54.4 KB0.0 KB/s27.2 KB23:59:53
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 8742.4 KB151.8 KB894.2 KB0.0 KB/s5.5 KB191:28:30
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
169.10.48.174 13 1294826.5 MB 56 0 000:50:24
TOTAL: 1 13 1294826.5 MB 56 0 000:52:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 19 1294826.5 MB 56 0 000:50:45
2*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:08
3*.gegeweb.eu 289 00.0 KB 0 0 000:01:34
TOTAL: 3 314 1294826.5 MB 56 0 000:52:29

NNRP auth users [Top 20]:

UserConn
mailman 289
TOTAL: 1 289

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
69.10.48.174 2.175 5.018 0.00000:50:24
mail.gegeweb.eu 4.210 4.125 1.45200:01:34
147.185.133.193 0.025 0.016 0.00000:00:09
147.185.133.233 0.063 0.029 0.00000:00:08
fascinating.monitoring.internet-measurement.com 0.044 0.022 0.00000:00:05
sensitive.monitoring.internet-measurement.com 0.019 0.005 0.00000:00:02
192.241.193.21 0.029 0.025 0.00000:00:01
194.165.16.10 0.017 0.007 0.00000:00:00
206.168.34.181 0.025 0.004 0.00000:00:00
80.66.76.121 0.052 0.004 0.00000:00:00
sprightly.monitoring.internet-measurement.com 0.035 0.027 0.00000:00:00
enchanting.monitoring.internet-measurement.com 0.045 0.016 0.00000:00:00
principled.monitoring.internet-measurement.com 0.019 0.008 0.00000:00:00
TOTAL: 13 6.758 9.306 1.45200:52:29

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 289
principled.monitoring.internet-measurement.com 2
fascinating.monitoring.internet-measurement.com 1
192.241.193.21 1
enchanting.monitoring.internet-measurement.com 1
194.165.16.10 1
147.185.133.233 1
sensitive.monitoring.internet-measurement.com 1
80.66.76.121 1
206.168.34.181 1
147.185.133.193 1
sprightly.monitoring.internet-measurement.com 1
TOTAL: 12 301

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
147.185.133.233 3
147.185.133.193 3
194.165.16.10 1
206.168.34.181 1
192.241.193.21 1
TOTAL: 5 9

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 2
User-Agent: Expanse, a Palo Alto Network... 2
Host: 45.13.105.36:563 2
EHLO www.censys.io 1
MGLNDD_45.13.105.36_119 1
#003 1
TOTAL: 6 9

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.10 1 1
69.10.48.174 1 1
TOTAL: 2 2 2

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 12098 93.4%
2local 850 6.6%
TOTAL: 2 12948100.0%

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

NewsgroupCount
1grisbi.test 4259
2grisbi.bugsreports 3927
3grisbi.user.french 2142
4grisbi.devel 1625
5local.test 788
6grisbi.cvs 96
7local.gegeweb.support 62
8grisbi.user 47
9grisbi.admin 2
TOTAL: 9 12948
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me