Daily Usenet report for news.niel.me

Feb 23 04:15:01 -- Feb 24 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Feb 23 16:22:28 rpi-studio innd: filter: No Cancel-Key[sha1:Y4crOYWRnuRtBN4sDfRmSQYPi44= sha256:dI82RMUK2FG8G4rJDsVMWYZv2Qij2W1/jC1GsCD9HCo=] matches Cancel-Lock[sha1:7VZv/4rXj9CMcA5APGgaZchNQVo= sha256:HzUcj+GIbFr/Zkisltf6g+pKfTHtvAtqxKTBE73Njao=] target=<uracse$9tv$3@rasp.pasdenom.info>
Feb 23 20:25:04 rpi-studio innd: filter: No Cancel-Key[sha1:UYK4QHxzfUpOdkFTcA684rymiZ8=] matches Cancel-Lock[sha1:get/dDSaosYogRRTz+qcbLcgW6Q=] target=<65d8f0e2$0$11923$426a74cc@news.free.fr>
Feb 24 01:30:03 rpi-studio innd: filter: No Cancel-Key[sha1:khQhei9u28ILn3NBETaTc6AYxyM=] matches Cancel-Lock[sha1:4unZ6usBfe7pYYY8FRqPMhiq9rI=] target=<de-gruppen-finden-17.02.2024@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 3499 36.2%638.1 KB 41.1%
innd 2606 27.0%435.4 KB 28.0%
innfeed 1800 18.6%291.4 KB 18.8%
nnrpd 1748 18.1%188.3 KB 12.1%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 9655 100.0%1.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 17453 61.0%
Negative hits 7715 27.0%
Do not exist 3450 12.1%
Cache misses 3 0.0%
TOTAL: 4 28621 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.021 0.0%12 1.000 1.750 5.000
article cancel00:00:00.004 0.0%13 0.000 0.308 1.000
article cleanup00:00:00.078 0.0%3472 0.000 0.022 0.158
article logging00:00:00.270 0.0%3472 0.000 0.078 0.273
article parse00:00:00.464 0.0%9144 0.000 0.051 0.235
article write00:00:01.737 0.0%2790 0.111 0.623 1.500
artlog/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.004 0.0%12 0.000 0.333 1.000
data move00:00:00.150 0.0%30971 0.000 0.005 0.032
hisgrep/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%12 0.000 0.000 0.000
hisgrep/perl00:00:00.002 0.0%23 0.000 0.087 1.000
hishave/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%12 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.433 0.0%28741 0.000 0.015 0.048
history sync00:00:00.049 0.0%410 0.000 0.120 0.667
history write00:00:00.682 0.0%3470 0.000 0.197 0.667
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:40.062100.0%34477 825.475 2507.180 8464.268
nntp read00:00:00.871 0.0%33754 0.000 0.026 0.081
overview write00:00:01.556 0.0%2790 0.077 0.558 4.067
perl filter00:00:13.558 0.0%3470 2.310 3.907 8.000
python filter00:00:00.017 0.0%3470 0.000 0.005 0.080
site send00:00:01.113 0.0%5981 0.000 0.186 0.500
TOTAL: 24:01:10.43524:01:01.071100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%2836 0.000 0.009 0.100
article prepare00:00:00.009 0.0%1008 0.000 0.009 0.250
article read00:00:00.047 0.0%240 0.000 0.196 7.000
backlog stats00:00:00.214 0.0%44845 0.000 0.005 0.031
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.612 0.0%25585 0.000 0.024 0.060
data write00:00:01.164 0.0%21156 0.016 0.055 0.108
idle23:58:42.564100.0%44845 968.077 1924.909 4560.697
status file00:00:00.400 0.0%200 1.000 2.000 7.000
TOTAL: 23:58:49.44723:58:45.035100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:47.741 40.0%1445 16.400 33.039 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.082 0.1%3178 0.000 0.026 0.273
TOTAL: 00:01:59.29200:00:47.823 40.1%----

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 4 2663 1321 1342 0 49%24:00:38
2usenet.pasdenom.info 3 2153 320 1816 17 14%27:37:28
3news.nntp4.net 2 4133 308 3186 639 7%29:44:31
4i2pn.org 1 2867 252 2615 0 8%24:12:49
5news.glou.org 1 2427 251 2115 61 10%23:59:58
6gegeweb-out.news.tnetconsulting.net 2 2310 219 2020 71 9%23:04:40
7nntp.terraraq.uk 1 59 9 50 0 15%01:16:05
8localhost 25 0 0 0 0 0%00:00:00
9news.samoylyk.net 1 11 0 11 0 0%00:09:01
TOTAL: 9 40 16623 2680 13155 788 16%154:05:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org4.0 MB0.0 KB0.0 KB4.0 MB100%3.1 KB
2news.nntp4.net1.5 MB0.0 KB5.1 MB6.5 MB 22%7.1 KB
3news.glou.org822.3 KB0.0 KB154.0 KB976.3 KB 84%3.1 KB
4usenet.pasdenom.info694.6 KB0.0 KB20.5 KB715.0 KB 97%2.1 KB
5gegeweb-out.news.tnetconsulting.net685.1 KB6.3 KB383.9 KB1.1 MB 63%3.7 KB
6i2pn.org642.1 KB0.0 KB0.0 KB642.1 KB100%2.5 KB
7nntp.terraraq.uk17.6 KB0.0 KB0.0 KB17.6 KB100%2.0 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 98.3 MB6.3 KB5.6 MB13.9 MB 59%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 23 04:15:01 - 04:59:59 55 2.0% 0.02158.4 KB 1.7% 0.06
Feb 23 05:00:00 - 05:59:59 67 2.4% 0.02172.3 KB 1.8% 0.05
Feb 23 06:00:00 - 06:59:59 75 2.7% 0.02209.6 KB 2.2% 0.06
Feb 23 07:00:00 - 07:59:59 76 2.7% 0.02243.6 KB 2.6% 0.07
Feb 23 08:00:00 - 08:59:59 58 2.1% 0.02191.4 KB 2.0% 0.05
Feb 23 09:00:00 - 09:59:59 86 3.1% 0.02238.5 KB 2.6% 0.07
Feb 23 10:00:00 - 10:59:59 128 4.6% 0.04332.7 KB 3.6% 0.09
Feb 23 11:00:00 - 11:59:59 137 4.9% 0.04396.2 KB 4.2% 0.11
Feb 23 12:00:00 - 12:59:59 112 4.0% 0.03304.5 KB 3.3% 0.08
Feb 23 13:00:00 - 13:59:59 114 4.1% 0.03320.1 KB 3.4% 0.09
Feb 23 14:00:00 - 14:59:59 108 3.9% 0.03289.4 KB 3.1% 0.08
Feb 23 15:00:00 - 15:59:59 101 3.6% 0.03340.8 KB 3.6% 0.09
Feb 23 16:00:00 - 16:59:59 173 6.2% 0.05508.8 KB 5.4% 0.14
Feb 23 17:00:00 - 17:59:59 194 6.9% 0.05722.4 KB 7.7% 0.20
Feb 23 18:00:00 - 18:59:59 165 5.9% 0.05468.3 KB 5.0% 0.13
Feb 23 19:00:00 - 19:59:59 157 5.6% 0.04774.9 KB 8.3% 0.22
Feb 23 20:00:00 - 20:59:59 196 7.0% 0.05728.7 KB 7.8% 0.20
Feb 23 21:00:00 - 21:59:59 119 4.3% 0.03350.8 KB 3.8% 0.10
Feb 23 22:00:00 - 22:59:59 154 5.5% 0.04499.4 KB 5.3% 0.14
Feb 23 23:00:00 - 23:59:59 121 4.3% 0.03391.4 KB 4.2% 0.11
Feb 24 00:00:00 - 00:59:59 115 4.1% 0.03528.6 KB 5.7% 0.15
Feb 24 01:00:00 - 01:59:59 86 3.1% 0.02247.6 KB 2.6% 0.07
Feb 24 02:00:00 - 02:59:59 83 3.0% 0.02272.7 KB 2.9% 0.08
Feb 24 03:00:00 - 03:59:59 94 3.4% 0.03584.8 KB 6.3% 0.16
Feb 24 04:00:00 - 04:15:02 24 0.9% 0.0376.6 KB 0.8% 0.08
TOTAL: 24:00:01 2798 100.0% 0.039.1 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 510 0 0 0 0 0 0 0 510
2gegeweb-out.news.tnetconsulting.net 79 0 0 2 0 0 0 0 77
3news.glou.org 61 0 0 0 0 0 0 0 61
4usenet.pasdenom.info 17 0 0 0 0 0 0 0 17
5news.samoylyk.net 6 0 0 0 0 0 0 0 6
6nntp.terraraq.uk 2 0 0 0 0 0 0 0 2
7i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 676 0 0 2 0 0 0 0 674

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 498
Bad path (news.giganews.com.POSTED) 93
EMP (phn path) 55
Cancels abusifs 8
Binary: misplaced binary 6
EMP (md5) 2
Cancel of <urargb$n3fh$1@dont-email.me> without Cancel-Key 1
Cancel of <urar7m$mvod$2@dont-email.me> without Cancel-Key 1
Cancel of <uratbf$ngjv$1@dont-email.me> without Cancel-Key 1
Cancel of <uras52$n7pc$1@dont-email.me> without Cancel-Key 1
Cancel of <urarnk$n49t$1@dont-email.me> without Cancel-Key 1
Cancel for rejected article 1
Cancel of <uraugm$ngjv$4@dont-email.me> without Cancel-Key 1
No Cancel-Key matches Cancel-Lock. target=<65d8f0e2$0$11923$426a74cc@news.free.fr> 1
No Cancel-Key matches Cancel-Lock. target=<uracse$9tv$3@rasp.pasdenom.info> 1
Cancel of <urb16l$obuj$1@dont-email.me> without Cancel-Key 1
HTML Multipart 1
Cancel of <urau7b$nn6j$1@dont-email.me> without Cancel-Key 1
TOTAL: 18 674

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 4179 139 2421 2 0 31 3%23:59:51
2news.gegeweb.org 1496 84 1380 0 0 0 5%23:59:56
3news.pasdenom.info 2450 4 2321 1 0 7 0%23:59:56
4news.tnetconsulting.net 4376 4 2778 12 0 2 0%23:59:56
5news.samoylyk.net 4114 3 2755 0 0 6 0%23:57:41
6nntp.terraraq.uk 1953 2 1713 0 0 0 0%23:58:37
7news.nntp4.net 2555 1 2454 0 0 0 0%23:59:39
8news.aioe.org 0 0 0 0 0 2453 0%23:59:56
TOTAL: 8 21123 237 15822 15 0 2499 1%191:55:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org317.5 KB34.6 KB352.1 KB0.0 KB/s2.5 KB23:59:51
2news.gegeweb.org250.1 KB0.0 KB250.1 KB0.0 KB/s3.0 KB23:59:56
3nntp.terraraq.uk8.9 KB0.0 KB8.9 KB0.0 KB/s4.4 KB23:58:37
4news.pasdenom.info6.3 KB3.4 KB9.7 KB0.0 KB/s1.9 KB23:59:56
5news.samoylyk.net5.9 KB0.0 KB5.9 KB0.0 KB/s2.0 KB23:57:41
6news.tnetconsulting.net5.7 KB49.4 KB55.2 KB0.0 KB/s3.4 KB23:59:56
7news.nntp4.net1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:39
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 8595.6 KB87.5 KB683.1 KB0.0 KB/s2.7 KB191:55:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1generous.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
2192.241.218.6 1 00.0 KB 0 0 000:00:09
3104.152.52.237 1 00.0 KB 0 0 000:00:10
4194.165.16.76 1 00.0 KB 0 0 000:00:01
5mail.gegeweb.eu 288 00.0 KB 0 0 000:01:35
TOTAL: 5 292 00.0 KB 0 0 000:01:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 288 00.0 KB 0 0 000:01:35
2unresolved 3 00.0 KB 0 0 000:00:21
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 3 292 00.0 KB 0 0 000:01:58

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 4.254 4.226 1.51300:01:35
104.152.52.237 0.016 0.008 0.00000:00:10
192.241.218.6 0.021 0.029 0.00000:00:09
generous.monitoring.internet-measurement.com 0.024 0.028 0.00000:00:01
194.165.16.76 0.037 0.017 0.00000:00:01
TOTAL: 5 4.352 4.308 1.51300:01:58

NNRP unrecognized commands (by host):

SystemConn
194.165.16.76 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
#003 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.76 1 1
TOTAL: 1 1 1