Daily Usenet report for news.niel.me

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

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Apr 25 09:23:06 rpi-studio innd: filter: No Cancel-Key[sha1:0JAR+zFh5tl3M5yHHpGxhFLw0t4= sha256:dkDq89+KmPMipJ1NsMdFqLiZ5KSaM+kaeiHi1nYkTOs=] matches Cancel-Lock[sha1:BqT584Yd5+aa3Sgt7D/BrdmtKxw= sha256:1cFIj2o5oT2oLEps24pYJrl61qLQ7cxAAn/FSiCXkw8=] target=<vudvdl$d38$1@rasp.pasdenom.info>
Apr 26 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:DsYBx1nDSWnVJ2BLY3w5RQXchcc=] matches Cancel-Lock[sha1:tGqjvhYPw2x0D9L1nFZHXl9X+SI=] target=<de-gruppen-finden-19.04.2025@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2409 29.1%423.0 KB 32.5%
innd 2116 25.6%371.3 KB 28.5%
innfeed 1877 22.7%299.6 KB 23.0%
nnrpd 1863 22.5%208.0 KB 16.0%
nocem 1 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 8267 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 10379 56.3%
Negative hits 5656 30.7%
Do not exist 2398 13.0%
Cache misses 4 0.0%
TOTAL: 4 18437 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.001 0.0%2 0.000 0.500 1.000
article cancel00:00:00.002 0.0%4 0.000 0.500 1.000
article cleanup00:00:00.046 0.0%2403 0.000 0.019 0.250
article logging00:00:00.200 0.0%2405 0.000 0.083 0.400
article parse00:00:00.403 0.0%6219 0.000 0.065 0.333
article write00:00:00.906 0.0%1869 0.000 0.485 1.222
artlog/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.128 0.0%21472 0.000 0.006 0.032
hisgrep/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%5 0.000 0.200 1.000
hishave/artcncl00:00:00.001 0.0%4 0.000 0.250 1.000
hishave/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.328 0.0%18468 0.000 0.018 0.100
history sync00:00:00.061 0.0%352 0.000 0.173 1.000
history write00:00:00.439 0.0%2403 0.000 0.183 0.636
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:39.335100.0%22537 1353.896 3835.441 20689.862
nntp read00:00:00.617 0.0%21859 0.000 0.028 0.094
overview write00:00:00.590 0.0%1869 0.000 0.316 3.500
perl filter00:00:10.382 0.0%2403 1.629 4.320 18.000
python filter00:00:00.009 0.0%2403 0.000 0.004 0.143
site send00:00:00.545 0.0%3804 0.000 0.143 0.500
TOTAL: 24:01:02.70224:00:53.994100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.020 0.0%1919 0.000 0.010 0.105
article prepare00:00:00.001 0.0%284 0.000 0.004 0.250
article read00:00:00.017 0.0%70 0.000 0.243 8.000
backlog stats00:00:00.142 0.0%26499 0.000 0.005 0.023
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.390 0.0%13845 0.000 0.028 0.094
data write00:00:00.707 0.0%12155 0.000 0.058 0.222
idle23:49:58.394100.0%26499 1496.853 3237.797 9683.532
status file00:00:04.483 0.0%259 1.000 17.309 92.000
TOTAL: 23:50:07.64923:50:04.154100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:32:12.935 96.6%21029 9.400 263.110 12179.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.370 0.1%81075 0.000 0.054 0.500
readart00:00:03.456 0.1%19293 0.179 0.179 0.179
TOTAL: 01:35:29.72801:32:20.761 96.7%----

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.nntp4.net 2 2335 569 1273 493 24%23:59:39
2feed-out.gegeweb.org 2 1878 524 1354 0 27%23:59:55
3news.samoylyk.net 2 3177 314 2862 1 9%30:57:58
4nntp.terraraq.uk 2 1286 150 1134 2 11%21:35:39
5gegeweb-out.news.tnetconsulting.net 2 1475 125 1347 3 8%23:49:18
6i2pn.org 1 1877 121 1753 3 6%23:59:57
7usenet.pasdenom.info 14 854 3 851 0 0%24:48:04
8news.glou.org 2 102 2 97 3 1%02:02:45
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 52 12984 1808 10671 505 13%175:13:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net3.4 MB0.0 KB4.5 MB7.9 MB 43%7.6 KB
2news.samoylyk.net1.7 MB0.0 KB1.4 KB1.7 MB 99%5.6 KB
3feed-out.gegeweb.org1.4 MB0.0 KB0.0 KB1.4 MB100%2.8 KB
4gegeweb-out.news.tnetconsulting.net526.3 KB0.0 KB11.9 KB538.2 KB 97%4.2 KB
5i2pn.org318.4 KB0.0 KB5.8 KB324.2 KB 98%2.6 KB
6nntp.terraraq.uk305.1 KB0.0 KB3.9 KB308.9 KB 98%2.0 KB
7usenet.pasdenom.info5.0 KB0.0 KB0.0 KB5.0 KB100%1.7 KB
8news.glou.org4.5 KB0.0 KB35.4 KB39.8 KB 11%8.0 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 97.7 MB0.0 KB4.5 MB12.3 MB 63%5.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 25 04:15:02 - 04:59:59 47 2.5% 0.02174.3 KB 2.2% 0.06
Apr 25 05:00:00 - 05:59:59 52 2.8% 0.01136.1 KB 1.7% 0.04
Apr 25 06:00:00 - 06:59:59 46 2.5% 0.01182.3 KB 2.3% 0.05
Apr 25 07:00:00 - 07:59:59 49 2.6% 0.01551.4 KB 6.9% 0.15
Apr 25 08:00:00 - 08:59:59 58 3.1% 0.02389.5 KB 4.9% 0.11
Apr 25 09:00:00 - 09:59:59 59 3.2% 0.02297.5 KB 3.7% 0.08
Apr 25 10:00:00 - 10:59:59 79 4.2% 0.02287.8 KB 3.6% 0.08
Apr 25 11:00:00 - 11:59:59 96 5.1% 0.03590.7 KB 7.4% 0.16
Apr 25 12:00:00 - 12:59:59 52 2.8% 0.01145.2 KB 1.8% 0.04
Apr 25 13:00:00 - 13:59:59 81 4.3% 0.02237.1 KB 3.0% 0.07
Apr 25 14:00:00 - 14:59:59 101 5.4% 0.03300.1 KB 3.8% 0.08
Apr 25 15:00:00 - 15:59:59 88 4.7% 0.02490.8 KB 6.2% 0.14
Apr 25 16:00:00 - 16:59:59 91 4.9% 0.03416.4 KB 5.2% 0.12
Apr 25 17:00:00 - 17:59:59 106 5.7% 0.03319.0 KB 4.0% 0.09
Apr 25 18:00:00 - 18:59:59 94 5.0% 0.03317.6 KB 4.0% 0.09
Apr 25 19:00:00 - 19:59:59 103 5.5% 0.03776.9 KB 9.8% 0.22
Apr 25 20:00:00 - 20:59:59 105 5.6% 0.03327.8 KB 4.1% 0.09
Apr 25 21:00:00 - 21:59:59 132 7.1% 0.04355.0 KB 4.5% 0.10
Apr 25 22:00:00 - 22:59:59 75 4.0% 0.02226.0 KB 2.8% 0.06
Apr 25 23:00:00 - 23:59:59 93 5.0% 0.03328.2 KB 4.1% 0.09
Apr 26 00:00:00 - 00:59:59 86 4.6% 0.02273.2 KB 3.4% 0.08
Apr 26 01:00:00 - 01:59:59 51 2.7% 0.01157.4 KB 2.0% 0.04
Apr 26 02:00:00 - 02:59:59 59 3.2% 0.02474.8 KB 6.0% 0.13
Apr 26 03:00:00 - 03:59:59 45 2.4% 0.01119.8 KB 1.5% 0.03
Apr 26 04:00:00 - 04:15:01 19 1.0% 0.0279.5 KB 1.0% 0.09
TOTAL: 23:59:59 1867 100.0% 0.027.8 MB 100.0% 0.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 493 384 0 0 0 0 0 0 109
2news.glou.org 32 0 0 0 0 0 0 0 32
3nntp.terraraq.uk 6 0 0 0 0 0 0 0 6
4gegeweb-out.news.tnetconsulting.net 2 0 0 0 0 0 0 0 2
5i2pn.org 2 0 0 0 0 0 0 0 2
6feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 6 536 384 0 0 0 0 0 0 152

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 310
linux.kernel.git 72
news.test 1
soc.culture.iran 1
TOTAL: 4 384

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 82
Bad path (news.giganews.com.POSTED) 66
Cancel of non-existing ID <250420251548195639%Kuypers@address.invalid> 1
HTML Multipart 1
TOTAL: 4 150

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 1
nntp.terraraq.uk 1
TOTAL: 2 2
TOTAL: 1 2

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 2511 35 1670 2 0 30 1%23:51:25
2news.gegeweb.org 1523 13 1327 0 0 0 0%23:56:38
3news.samoylyk.net 1844 4 1549 9 0 1 0%23:57:47
4news.tnetconsulting.net 2710 3 1855 5 0 26 0%23:58:59
5news.pasdenom.info 1399 0 1322 0 0 0 0%23:48:22
6news.aioe.org 0 0 0 0 0 1628 0%23:59:59
7nntp.terraraq.uk 1071 0 989 0 0 0 0%23:39:38
8news.nntp4.net 1395 0 1294 0 0 0 0%23:41:09
TOTAL: 8 12453 55 10006 16 0 1685 0%190:53:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org141.5 KB5.0 KB146.4 KB0.0 KB/s4.0 KB23:51:25
2news.gegeweb.org32.5 KB0.0 KB32.5 KB0.0 KB/s2.5 KB23:56:38
3news.samoylyk.net10.2 KB44.3 KB54.4 KB0.0 KB/s4.2 KB23:57:47
4news.tnetconsulting.net4.3 KB26.0 KB30.2 KB0.0 KB/s3.8 KB23:58:59
5news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:48:22
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:39:38
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:41:09
TOTAL: 8188.3 KB75.2 KB263.5 KB0.0 KB/s3.7 KB190:53:57
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 6 1929376.2 MB 9 0 001:31:31
TOTAL: 1 6 1929376.2 MB 9 0 001:35:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 6 1929376.2 MB 9 0 001:31:31
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:57
3*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
4unresolved 13 00.0 KB 0 0 000:01:56
5*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
6*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 6 310 1929376.2 MB 9 0 001:35:29

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
syn-066-061-096-239.res.spectrum.com 3.619 9.588 0.00001:31:31
mail.gegeweb.eu 4.762 4.428 1.91200:01:57
206.168.34.79 0.031 0.023 0.00000:00:35
206.168.34.78 0.024 0.005 0.00000:00:32
150.107.36.236 0.019 0.027 0.00000:00:24
20.171.30.175 0.028 0.024 0.00000:00:09
199.45.155.89 0.079 0.087 0.00000:00:04
198.235.24.216 0.032 0.016 0.00000:00:02
147.185.132.174 0.030 0.022 0.00000:00:02
approachable.monitoring.internet-measurement.com 0.019 0.016 0.00000:00:01
194.165.16.163 0.037 0.015 0.00000:00:01
198.235.24.75 0.033 0.016 0.00000:00:01
147.185.132.194 0.066 0.023 0.00000:00:01
197.210.203.35.bc.googleusercontent.com 0.028 0.014 0.00000:00:01
228.149.216.162.bc.googleusercontent.com 0.061 0.016 0.00000:00:00
194.165.16.166 0.023 0.005 0.00000:00:00
TOTAL: 16 8.891 14.325 1.91201:35:29

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
199.45.155.89 3
20.171.30.175 1
198.235.24.216 1
194.165.16.163 1
206.168.34.79 1
206.168.34.78 1
150.107.36.236 1
198.235.24.75 1
approachable.monitoring.internet-measurement.com 1
197.210.203.35.bc.googleusercontent.com 1
147.185.132.174 1
147.185.132.194 1
228.149.216.162.bc.googleusercontent.com 1
194.165.16.166 1
TOTAL: 15 304

NNRP unrecognized commands (by host):

SystemConn
228.149.216.162.bc.googleusercontent.com 4
197.210.203.35.bc.googleusercontent.com 4
147.185.132.194 4
194.165.16.163 1
199.45.155.89 1
TOTAL: 5 14

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:563 3
GET / HTTP/1.1 3
Accept-Encoding: gzip 3
User-Agent: Expanse, a Palo Alto Network... 3
EHLO www.censys.io 1
#003 1
TOTAL: 6 14

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.163 1 1
199.45.155.89 1 2
TOTAL: 2 2 6

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 18040 93.5%
2local 1253 6.5%
TOTAL: 2 19293100.0%

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

NewsgroupCount
1grisbi.bugsreports 6290
2grisbi.test 6290
3grisbi.user.french 3325
4grisbi.devel 1901
5local.test 1129
6grisbi.user 134
7local.gegeweb.support 124
8grisbi.cvs 96
9grisbi.admin 4
TOTAL: 9 19293
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me