Daily Usenet report for news.niel.me

Mar 10 04:15:01 -- Mar 11 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Mar 10 18:15:41 rpi-studio innd: filter: No Cancel-Key[sha1:cm/RHjOWQe+D2dIyyzBxLhKHaQY=] matches Cancel-Lock[sha1:laFIBh/4fr4E/w36QuK/pUdehTY=] target=<640b5c86$0$24816$426a34cc@news.free.fr>
Mar 11 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:9jz/GbZNHrkF2BizJ5hTQ/Jnswo=] matches Cancel-Lock[sha1:fthSqOC9CyBzfSnYtKRXqka/MSg=] target=<de-gruppen-finden-04.03.2023@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 3933 37.8%744.3 KB 44.1%
innd 2439 23.5%412.6 KB 24.4%
nnrpd 2280 21.9%244.8 KB 14.5%
innfeed 1745 16.8%287.6 KB 17.0%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 10399 100.0%1.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 21611 59.8%
Negative hits 10658 29.5%
Do not exist 3896 10.8%
Cache misses 2 0.0%
TOTAL: 4 36167 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.012 0.0%10 1.000 1.200 2.000
article cancel00:00:00.004 0.0%11 0.000 0.364 1.000
article cleanup00:00:00.091 0.0%3911 0.000 0.023 0.158
article logging00:00:00.292 0.0%3920 0.000 0.074 0.333
article parse00:00:00.557 0.0%7192 0.000 0.077 0.286
article write00:00:06.225 0.0%3394 0.231 1.834 4.417
artlog/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.002 0.0%10 0.000 0.200 1.000
data move00:00:00.111 0.0%38448 0.000 0.003 0.020
hisgrep/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%10 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%12 0.000 0.083 1.000
hishave/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%10 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.449 0.0%36294 0.000 0.012 0.031
history sync00:00:00.060 0.0%409 0.000 0.147 1.333
history write00:00:00.825 0.0%3911 0.000 0.211 0.485
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:29.508100.0%39758 763.801 2173.890 9092.848
nntp read00:00:01.171 0.0%39236 0.000 0.030 0.087
overview write00:00:01.898 0.0%3394 0.000 0.559 5.231
perl filter00:00:17.216 0.0%3911 2.640 4.402 7.921
python filter00:00:00.006 0.0%3911 0.000 0.002 0.067
site send00:00:01.355 0.0%6898 0.000 0.196 0.449
TOTAL: 24:01:11.38724:00:59.783100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%3378 0.000 0.006 0.071
article prepare00:00:00.000 0.0%288 0.000 0.000 0.000
article read00:00:00.016 0.0%62 0.000 0.258 6.000
backlog stats00:00:00.125 0.0%44635 0.000 0.003 0.015
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.647 0.0%26708 0.000 0.024 0.065
data write00:00:01.380 0.0%23449 0.000 0.059 0.108
idle23:49:57.372100.0%44635 917.275 1922.199 5323.558
status file00:00:00.418 0.0%188 1.000 2.223 7.000
TOTAL: 23:50:08.11123:49:59.977100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:34.174 28.4%1483 11.800 23.044 8439.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.090 0.1%3420 0.000 0.026 1.000
readart00:00:00.015 0.0%4 3.500 3.750 4.000
TOTAL: 00:02:00.17300:00:34.279 28.5%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 170

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1i2pn.org 3 3831 1173 2473 185 30%24:57:19
2feed-out.gegeweb.org 2 2140 1129 1011 0 52%23:59:47
3usenet.pasdenom.info 1 4164 345 3769 50 8%39:44:50
4news.nntp4.net 2 3619 191 3237 191 5%22:37:28
5news.glou.org 1 1609 186 1396 27 11%14:04:25
6nntp.terraraq.uk 1 3174 162 2965 47 5%22:32:35
7news.samoylyk.net 2 5519 158 5343 18 2%38:46:57
8gegeweb-out.news.tnetconsulting.net 1 3355 123 3225 7 3%23:59:58
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 38 27411 3467 23419 525 12%210:43:19

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1i2pn.org3.5 MB0.0 KB477.4 KB4.0 MB 88%3.0 KB
2feed-out.gegeweb.org3.2 MB0.0 KB0.0 KB3.2 MB100%2.9 KB
3news.samoylyk.net1.3 MB0.0 KB69.7 KB1.4 MB 95%8.2 KB
4news.glou.org1.0 MB0.0 KB89.1 KB1.1 MB 92%5.4 KB
5news.nntp4.net845.2 KB0.0 KB472.8 KB1.3 MB 64%3.5 KB
6usenet.pasdenom.info789.2 KB0.0 KB83.6 KB872.8 KB 90%2.2 KB
7gegeweb-out.news.tnetconsulting.net620.0 KB0.0 KB64.2 KB684.1 KB 90%5.3 KB
8nntp.terraraq.uk525.2 KB0.0 KB184.1 KB709.3 KB 74%3.4 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 911.8 MB0.0 KB1.4 MB13.2 MB 89%3.4 KB

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 10 04:15:01 - 04:59:59 62 1.8% 0.02212.5 KB 1.6% 0.08
Mar 10 05:00:00 - 05:59:59 74 2.2% 0.02203.5 KB 1.6% 0.06
Mar 10 06:00:00 - 06:59:59 93 2.7% 0.03334.2 KB 2.6% 0.09
Mar 10 07:00:00 - 07:59:59 73 2.2% 0.02252.8 KB 2.0% 0.07
Mar 10 08:00:00 - 08:59:59 78 2.3% 0.02215.5 KB 1.7% 0.06
Mar 10 09:00:00 - 09:59:59 136 4.0% 0.04353.8 KB 2.7% 0.10
Mar 10 10:00:00 - 10:59:59 134 4.0% 0.04457.6 KB 3.5% 0.13
Mar 10 11:00:00 - 11:59:59 151 4.5% 0.04645.2 KB 5.0% 0.18
Mar 10 12:00:00 - 12:59:59 102 3.0% 0.03310.9 KB 2.4% 0.09
Mar 10 13:00:00 - 13:59:59 142 4.2% 0.04409.4 KB 3.2% 0.11
Mar 10 14:00:00 - 14:59:59 139 4.1% 0.04651.3 KB 5.0% 0.18
Mar 10 15:00:00 - 15:59:59 165 4.9% 0.05698.2 KB 5.4% 0.19
Mar 10 16:00:00 - 16:59:59 177 5.2% 0.05680.4 KB 5.2% 0.19
Mar 10 17:00:00 - 17:59:59 198 5.8% 0.06689.5 KB 5.3% 0.19
Mar 10 18:00:00 - 18:59:59 204 6.0% 0.06613.3 KB 4.7% 0.17
Mar 10 19:00:00 - 19:59:59 157 4.6% 0.04468.5 KB 3.6% 0.13
Mar 10 20:00:00 - 20:59:59 167 4.9% 0.05564.6 KB 4.4% 0.16
Mar 10 21:00:00 - 21:59:59 211 6.2% 0.061.5 MB 11.7% 0.42
Mar 10 22:00:00 - 22:59:59 208 6.1% 0.06832.3 KB 6.4% 0.23
Mar 10 23:00:00 - 23:59:59 178 5.3% 0.05636.9 KB 4.9% 0.18
Mar 11 00:00:00 - 00:59:59 141 4.2% 0.04703.6 KB 5.4% 0.20
Mar 11 01:00:00 - 01:59:59 148 4.4% 0.04495.8 KB 3.8% 0.14
Mar 11 02:00:00 - 02:59:59 121 3.6% 0.03439.9 KB 3.4% 0.12
Mar 11 03:00:00 - 03:59:59 108 3.2% 0.03410.8 KB 3.2% 0.11
Mar 11 04:00:00 - 04:15:01 19 0.6% 0.02168.5 KB 1.3% 0.19
TOTAL: 24:00:00 3386 100.0% 0.0412.7 MB 100.0% 0.15

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1i2pn.org 186 0 0 0 0 0 0 0 186
2news.nntp4.net 186 0 0 0 0 0 0 0 186
3news.glou.org 51 0 0 0 0 0 0 0 51
4nntp.terraraq.uk 47 0 0 0 0 0 0 0 47
5usenet.pasdenom.info 35 0 0 0 0 0 0 0 35
6gegeweb-out.news.tnetconsulting.net 13 2 0 0 0 0 0 0 11
7feed-out.gegeweb.org 8 0 0 0 0 0 0 0 8
TOTAL: 7 526 2 0 0 0 0 0 0 524

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.petites-annonces.informatique.materiel 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
Bad path (news.giganews.com.POSTED) 112
EMP (phn path) 110
Too many newsgroups 108
EMP (phl) 73
EMP (phn nph) 63
EMP (md5) 46
Cancel for rejected article 1
No Cancel-Key matches Cancel-Lock. target=<640b5c86$0$24816$426a34cc@news.free.fr> 1
Cancels abusifs 1
TOTAL: 9 515

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 8
news.nntp4.net 1
TOTAL: 2 9
TOTAL: 1 9

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3718 24 2221 1 0 4 0%23:59:51
2news.tnetconsulting.net 4994 13 3370 1 0 1 0%23:59:17
3news.gegeweb.org 2358 12 2258 4 0 0 0%23:59:51
4news.nntp4.net 3194 12 3062 0 0 0 0%23:59:51
5nntp.terraraq.uk 2450 2 2272 3 0 0 0%23:59:51
6news.aioe.org 0 0 0 0 0 2706 0%23:59:51
7news.samoylyk.net 3748 0 3300 0 0 0 0%23:59:51
8news.pasdenom.info 3061 0 2957 0 0 0 0%23:59:51
TOTAL: 8 23523 63 19440 9 0 2711 0%191:58:14

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.terraraq.uk91.8 KB100.2 KB192.0 KB0.0 KB/s38.4 KB23:59:51
2i2pn.org56.6 KB5.5 KB62.1 KB0.0 KB/s2.5 KB23:59:51
3news.tnetconsulting.net36.8 KB1.4 KB38.2 KB0.0 KB/s2.7 KB23:59:17
4news.nntp4.net31.7 KB0.0 KB31.7 KB0.0 KB/s2.6 KB23:59:51
5news.gegeweb.org20.0 KB22.0 KB42.0 KB0.0 KB/s2.6 KB23:59:51
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
7news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
TOTAL: 8237.0 KB129.0 KB366.0 KB0.0 KB/s5.1 KB191:58:14

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.241.207.88 1 00.0 KB 0 0 000:00:00
2divine.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:06
3erudite.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
446.17.96.40 81 00.0 KB 0 0 000:00:09
5champion.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
6162.243.136.27 1 00.0 KB 0 0 000:00:09
7mail.gegeweb.eu 289 00.0 KB 0 0 000:01:27
8106.75.178.84 1 00.0 KB 0 0 000:00:01
946.219.192.81 2 00.0 KB 0 0 000:00:04
10vivid.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
TOTAL: 10 379 00.0 KB 0 0 000:01:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 289 00.0 KB 0 0 000:01:27
2*.monitoring.internet-measurement.com 4 00.0 KB 0 0 000:00:06
3unresolved 86 00.0 KB 0 0 000:00:25
TOTAL: 3 379 00.0 KB 0 0 000:01:59

NNRP auth users [Top 20]:

UserConn
mailman 289
TOTAL: 1 289

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 4.284 4.704 1.92600:01:27
162.243.136.27 0.018 0.035 0.00000:00:09
46.17.96.40 2.129 1.210 0.00000:00:09
divine.monitoring.internet-measurement.com 0.042 0.042 0.00000:00:06
46.219.192.81 0.078 0.068 0.00000:00:04
106.75.178.84 0.019 0.028 0.00000:00:01
192.241.207.88 0.023 0.023 0.00000:00:00
vivid.monitoring.internet-measurement.com 0.029 0.039 0.00000:00:00
erudite.monitoring.internet-measurement.com 0.034 0.034 0.00000:00:00
champion.monitoring.internet-measurement.com 0.031 0.031 0.00000:00:00
TOTAL: 10 6.687 6.214 1.92600:01:59

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
192.241.207.88 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_45.13.105.36_119 1
TOTAL: 1 1