Daily Usenet report for news.niel.me

Jul 14 04:15:02 -- Jul 15 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jul 15 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:0Uk6HMtrPkFotVyX+bdlLHqa8hw=] matches Cancel-Lock[sha1:EnD9O2lJXVQdFmcoxoF27G7K3e0=] target=<de-gruppen-finden-08.07.2023@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 4687 43.2%900.5 KB 49.6%
innd 2476 22.8%397.5 KB 21.9%
nnrpd 1930 17.8%207.5 KB 11.4%
innfeed 1760 16.2%311.3 KB 17.1%
nocem 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 10856 100.0%1.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24058 61.2%
Negative hits 10603 27.0%
Do not exist 4625 11.8%
Cache misses 10 0.0%
TOTAL: 4 39296 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.017 0.0%20 0.000 0.850 2.000
article cancel00:00:00.009 0.0%28 0.000 0.321 1.000
article cleanup00:00:00.084 0.0%4656 0.000 0.018 0.188
article logging00:00:00.296 0.0%4658 0.000 0.064 0.227
article parse00:00:00.647 0.0%12933 0.000 0.050 0.149
article write00:00:02.170 0.0%4150 0.188 0.523 1.846
artlog/artcncl00:00:00.001 0.0%28 0.000 0.036 1.000
artlog/artcncl/perl00:00:00.003 0.0%20 0.000 0.150 1.000
data move00:00:00.232 0.0%45278 0.000 0.005 0.021
hisgrep/artcncl00:00:00.001 0.0%27 0.000 0.037 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%20 0.000 0.000 0.000
hisgrep/perl00:00:00.002 0.0%22 0.000 0.091 0.500
hishave/artcncl00:00:00.000 0.0%28 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%20 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.617 0.0%39483 0.000 0.016 0.043
history sync00:00:00.047 0.0%414 0.000 0.114 1.000
history write00:00:00.790 0.0%4651 0.000 0.170 0.536
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle24:00:34.934100.0%47460 442.966 1821.216 20700.207
nntp read00:00:01.174 0.0%46760 0.000 0.025 0.051
overview write00:00:01.140 0.0%4150 0.000 0.275 1.800
perl filter00:00:15.264 0.0%4651 1.765 3.282 6.271
python filter00:00:00.017 0.0%4657 0.000 0.004 0.043
site send00:00:01.347 0.0%8444 0.000 0.160 0.453
TOTAL: 24:01:10.02024:00:58.792100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%4170 0.000 0.007 0.333
article prepare00:00:00.006 0.0%2440 0.000 0.002 0.042
article read00:00:00.084 0.0%401 0.000 0.209 6.000
backlog stats00:00:00.294 0.0%60692 0.000 0.005 0.021
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.828 0.0%35487 0.000 0.023 0.053
data write00:00:01.707 0.0%31737 0.000 0.054 0.099
idle23:59:20.629100.0%60692 570.355 1422.933 7231.084
status file00:00:00.386 0.0%204 0.000 1.892 7.000
TOTAL: 23:59:27.41823:59:23.964100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:18.691 4.5%1463 10.600 12.776 204.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.123 0.0%3585 0.000 0.034 1.000
readart00:00:00.092 0.0%33 2.788 2.788 2.788
TOTAL: 00:06:53.05800:00:18.906 4.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
1feed-out.gegeweb.org 3 2506 953 1544 9 38%23:59:02
2news.nntp4.net 2 5150 923 3761 466 17%23:30:59
3news.glou.org 1 3284 749 2484 51 22%20:36:06
4i2pn.org 5 7413 587 6765 61 7%20:14:08
5usenet.pasdenom.info 2 5131 279 4848 4 5%24:44:23
6gegeweb-out.news.tnetconsulting.net 1 7676 263 7407 6 3%21:52:08
7nntp.terraraq.uk 1 3456 190 3247 19 5%23:02:14
8news.samoylyk.net 2 7599 66 7531 2 0%23:22:57
9localhost 32 6 6 0 0 100%00:00:00
TOTAL: 9 49 42221 4016 37587 618 9%181:21:57
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org4.5 MB46.5 KB46.5 KB4.6 MB 98%4.9 KB
2news.glou.org4.2 MB0.0 KB153.5 KB4.4 MB 96%5.6 KB
3news.nntp4.net3.5 MB42.7 KB1.1 MB4.6 MB 75%3.4 KB
4i2pn.org2.0 MB14.2 KB201.8 KB2.2 MB 90%3.4 KB
5gegeweb-out.news.tnetconsulting.net1.8 MB2.6 KB33.2 KB1.9 MB 98%7.1 KB
6usenet.pasdenom.info793.2 KB0.0 KB5.0 KB798.2 KB 99%2.8 KB
7nntp.terraraq.uk729.7 KB8.5 KB61.0 KB799.2 KB 91%3.8 KB
8news.samoylyk.net290.4 KB2.4 KB9.6 KB302.3 KB 96%4.4 KB
9localhost8.3 KB0.0 KB0.0 KB8.3 KB100%1.4 KB
TOTAL: 917.8 MB116.9 KB1.6 MB19.5 MB 91%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 14 04:15:02 - 04:59:59 97 2.3% 0.04686.7 KB 3.7% 0.25
Jul 14 05:00:00 - 05:59:59 102 2.5% 0.03352.7 KB 1.9% 0.10
Jul 14 06:00:00 - 06:59:59 137 3.3% 0.04719.1 KB 3.8% 0.20
Jul 14 07:00:00 - 07:59:59 164 4.0% 0.05667.9 KB 3.6% 0.19
Jul 14 08:00:00 - 08:59:59 111 2.7% 0.03677.4 KB 3.6% 0.19
Jul 14 09:00:00 - 09:59:59 139 3.4% 0.04651.8 KB 3.5% 0.18
Jul 14 10:00:00 - 10:59:59 169 4.1% 0.05628.5 KB 3.3% 0.17
Jul 14 11:00:00 - 11:59:59 131 3.2% 0.04402.7 KB 2.1% 0.11
Jul 14 12:00:00 - 12:59:59 164 4.0% 0.05760.9 KB 4.0% 0.21
Jul 14 13:00:00 - 13:59:59 227 5.5% 0.06744.3 KB 4.0% 0.21
Jul 14 14:00:00 - 14:59:59 165 4.0% 0.05649.1 KB 3.5% 0.18
Jul 14 15:00:00 - 15:59:59 197 4.8% 0.051.1 MB 6.0% 0.32
Jul 14 16:00:00 - 16:59:59 241 5.8% 0.071.6 MB 8.5% 0.44
Jul 14 17:00:00 - 17:59:59 238 5.8% 0.07910.9 KB 4.8% 0.25
Jul 14 18:00:00 - 18:59:59 217 5.2% 0.06791.8 KB 4.2% 0.22
Jul 14 19:00:00 - 19:59:59 227 5.5% 0.06714.5 KB 3.8% 0.20
Jul 14 20:00:00 - 20:59:59 202 4.9% 0.062.1 MB 11.5% 0.60
Jul 14 21:00:00 - 21:59:59 220 5.3% 0.06754.2 KB 4.0% 0.21
Jul 14 22:00:00 - 22:59:59 236 5.7% 0.07740.9 KB 3.9% 0.21
Jul 14 23:00:00 - 23:59:59 195 4.7% 0.05712.6 KB 3.8% 0.20
Jul 15 00:00:00 - 00:59:59 163 3.9% 0.05883.9 KB 4.7% 0.25
Jul 15 01:00:00 - 01:59:59 135 3.3% 0.04482.4 KB 2.6% 0.13
Jul 15 02:00:00 - 02:59:59 106 2.6% 0.03319.4 KB 1.7% 0.09
Jul 15 03:00:00 - 03:59:59 131 3.2% 0.04592.3 KB 3.2% 0.16
Jul 15 04:00:00 - 04:15:01 22 0.5% 0.0263.1 KB 0.3% 0.07
TOTAL: 23:59:59 4136 100.0% 0.0518.4 MB 100.0% 0.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 352 0 0 0 0 0 0 0 352
2i2pn.org 67 0 0 0 0 0 0 0 67
3news.glou.org 55 0 0 0 0 0 0 0 55
4nntp.terraraq.uk 17 0 0 0 0 0 0 0 17
5gegeweb-out.news.tnetconsulting.net 5 0 0 0 0 0 0 0 5
6usenet.pasdenom.info 4 0 0 0 0 0 0 0 4
7feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
8news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 8 503 0 0 0 0 0 0 0 503

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 173
EMP (phn nph) 104
EMP (md5) 71
EMP (phl) 67
Bad path (news.giganews.com.POSTED) 62
EMP (phr nph) 18
Cancels abusifs 4
Cancel of non-existing ID <khc4niFm34vU1@mid.individual.net> 1
HTML Multipart 1
TOTAL: 9 501

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1011
TOTAL: 11011

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.terraraq.uk 3018 239 2361 36 0 0 7%23:59:38
2news.nntp4.net 3522 70 3042 1 0 0 1%23:59:57
3news.tnetconsulting.net 6163 69 4044 19 0 1 1%23:59:23
4i2pn.org 5689 68 3308 13 0 20 1%23:59:57
5news.samoylyk.net 5916 55 3998 14 0 13 0%23:59:55
6news.gegeweb.org 3513 13 3323 5 0 0 0%23:59:57
7news.pasdenom.info 3651 1 3436 7 0 0 0%23:59:15
8news.aioe.org 0 0 0 0 0 3319 0%23:59:55
TOTAL: 8 31472 515 23512 95 0 3353 1%191:57:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.terraraq.uk897.0 KB728.4 KB1.6 MB0.0 KB/s5.9 KB23:59:38
2news.nntp4.net494.1 KB5.8 KB500.0 KB0.0 KB/s7.0 KB23:59:57
3news.tnetconsulting.net347.7 KB92.8 KB440.4 KB0.0 KB/s5.0 KB23:59:23
4news.samoylyk.net255.7 KB68.4 KB324.1 KB0.0 KB/s4.7 KB23:59:55
5i2pn.org239.0 KB72.0 KB311.0 KB0.0 KB/s3.8 KB23:59:57
6news.gegeweb.org48.9 KB5.4 KB54.3 KB0.0 KB/s3.0 KB23:59:57
7news.pasdenom.info1.9 KB10.6 KB12.5 KB0.0 KB/s1.6 KB23:59:15
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 82.2 MB983.3 KB3.2 MB0.0 KB/s5.4 KB191:57:57
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12a0e:e701:1154:0:e08b:f712:62b9:b828 1 25108.4 KB 7 6 000:05:21
TOTAL: 1 1 25108.4 KB 7 6 000:06:52

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 10 25108.4 KB 7 6 000:05:30
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:10
3*.monitoring.internet-measurement.com 4 00.0 KB 0 0 000:00:06
4unresolved 5 00.0 KB 0 0 000:00:04
TOTAL: 4 307 25108.4 KB 7 6 000:06:52

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:e08b:f712:62b9:b828 0.090 0.043 0.00400:05:21
mail.gegeweb.eu 4.416 3.768 1.54700:01:10
2607:ff10:c8:594::6 0.217 0.127 0.00000:00:09
motivating.monitoring.internet-measurement.com 0.039 0.022 0.00000:00:06
111.162.158.205 0.027 0.023 0.00000:00:02
94.102.61.39 0.036 0.028 0.00000:00:00
107.170.235.9 0.028 0.017 0.00000:00:00
45.227.254.55 0.017 0.026 0.00000:00:00
ingenious.monitoring.internet-measurement.com 0.041 0.022 0.00000:00:00
45.227.254.49 0.036 0.020 0.00000:00:00
gorgeous.monitoring.internet-measurement.com 0.021 0.008 0.00000:00:00
fascinating.monitoring.internet-measurement.com 0.020 0.008 0.00000:00:00
TOTAL: 12 4.988 4.112 1.55100:06:52

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
2607:ff10:c8:594::6 9
45.227.254.55 1
94.102.61.39 1
111.162.158.205 1
fascinating.monitoring.internet-measurement.com 1
45.227.254.49 1
107.170.235.9 1
motivating.monitoring.internet-measurement.com 1
gorgeous.monitoring.internet-measurement.com 1
ingenious.monitoring.internet-measurement.com 1
TOTAL: 11 306

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
2607:ff10:c8:594::6 21
107.170.235.9 1
45.227.254.55 1
TOTAL: 3 23

NNRP unrecognized commands (by command):

CommandCount
#026#003#001 3
Accept-Encoding: gzip 3
Host: [2a0e:e701:1154:0:4e10:5c89:4af0:d... 3
GET / HTTP/1.1 3
#023#003#023#001#023#002#001 3
Accept: */* 3
User-Agent: Mozilla/5.0 (Windows NT 10.0... 3
#003 1
MGLNDD_45.13.105.36_119 1
TOTAL: 9 23

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.55 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 17 68.0%
2fr 8 32.0%
TOTAL: 2 25100.0%

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

NewsgroupCount
1grisbi.user.french 10
2fr.usenet.documents 6
3grisbi.devel 4
4grisbi.test 2
5fr.comp.sys.raspberry-pi 2
6grisbi.user 1
TOTAL: 6 25
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me