Daily Usenet report for news.niel.me

Nov 29 04:15:02 -- Nov 30 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 29 19:16:07 rpi-studio innd: filter: No Cancel-Key[sha1:rrskx439SjxTTLbjsnuce0IK9YE=#015#012#011sha1:UDACKlD8DaZFMffJ/2CLBHqNNBg= sha256:J6jrM6nFchSRmJKic8e2WfDIIczQDdDy99liacetbNQ=] matches Cancel-Lock[sha1:9PwbQ+dQkC/hZXHRdAIFuYL2HXw= sha256:lJCckcAHHtRdVVfn1xLP/LGysIG5amHzoTMRqruIa4w=] target=<uk7v33$rqm$1@rasp.pasdenom.info>

Log entries by program:

Program nameLines%LinesSize%Size
inn 63575 78.5%12.1 MB 84.5%
innd 13471 16.6%1.7 MB 11.7%
innfeed 2125 2.6%357.6 KB 2.4%
nnrpd 1825 2.3%198.7 KB 1.4%
nocem 1 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 80998 100.0%14.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 75745 37.0%
Positive hits 65907 32.2%
Do not exist 63002 30.8%
Cache misses 22 0.0%
TOTAL: 4 204676 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.087 0.0%63 0.000 1.381 7.000
article cancel00:00:00.013 0.0%64 0.000 0.203 1.000
article cleanup00:00:01.325 0.0%63118 0.004 0.021 0.044
article logging00:00:04.818 0.0%63118 0.048 0.076 0.115
article parse00:00:19.489 0.0%376934 0.033 0.052 0.083
article write00:00:37.800 0.0%51937 0.496 0.728 2.367
artlog/artcncl00:00:00.002 0.0%64 0.000 0.031 1.000
artlog/artcncl/perl00:00:00.006 0.0%63 0.000 0.095 1.000
data move00:00:04.209 0.0%615486 0.003 0.007 0.015
hisgrep/artcncl00:00:00.003 0.0%64 0.000 0.047 0.250
hisgrep/artcncl/perl00:00:00.003 0.0%63 0.000 0.048 1.000
hisgrep/perl00:00:00.008 0.0%65 0.000 0.123 4.000
hishave/artcncl00:00:00.000 0.0%64 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.001 0.0%63 0.000 0.016 0.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.759 0.0%204944 0.011 0.018 0.032
history sync00:00:00.062 0.0%362 0.000 0.171 0.667
history write00:00:14.907 0.0%63118 0.142 0.236 0.419
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:42:42.582 99.4%516928 104.376 165.134 387.629
nntp read00:00:15.982 0.0%517026 0.022 0.031 0.044
overview write00:00:27.029 0.0%51937 0.206 0.520 46.493
perl filter00:04:31.384 0.3%63118 3.379 4.300 5.054
python filter00:00:00.291 0.0%63118 0.000 0.005 0.014
site send00:00:13.154 0.0%105525 0.042 0.125 0.212
TOTAL: 23:50:52.01523:49:36.914 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.487 0.0%54179 0.000 0.009 0.032
article prepare00:00:00.110 0.0%35628 0.000 0.003 0.029
article read00:00:01.104 0.0%6809 0.000 0.162 0.636
backlog stats00:00:03.846 0.0%838217 0.002 0.005 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:13.405 0.0%568680 0.014 0.024 0.039
data write00:00:22.132 0.0%450600 0.037 0.049 0.060
idle23:50:20.212 99.9%838217 62.384 102.384 207.747
status file00:00:00.532 0.0%259 1.000 2.054 9.000
TOTAL: 23:51:39.38223:51:01.828100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.006 0.0%82 0.000 0.073 0.182
idle00:00:47.297 20.5%1450 24.500 32.619 987.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.115 0.0%3382 0.000 0.034 0.273
TOTAL: 00:03:50.88600:00:47.418 20.5%----

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.glou.org 3 31517 24676 5317 1524 78%24:11:49
2news.nntp4.net 8 61598 24619 27607 9372 39%24:52:57
3feed-out.gegeweb.org 2 3528 1081 2447 0 30%23:58:45
4nntp.terraraq.uk 5 19282 1048 17966 268 5%23:06:39
5usenet.pasdenom.info 2 2222 308 1910 4 13%22:40:12
6i2pn.org 2 4181 190 3990 1 4%28:41:36
7gegeweb-out.news.tnetconsulting.net 3 1020 52 960 8 5%10:15:01
8news.samoylyk.net 2 4043 14 4029 0 0%29:41:09
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 52 127391 51988 64226 11177 40%187:28:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net246.9 MB0.0 KB88.8 MB335.8 MB 73%10.1 KB
2news.glou.org234.6 MB0.0 KB10.5 MB245.2 MB 95%9.6 KB
3feed-out.gegeweb.org13.8 MB0.0 KB0.0 KB13.8 MB100%13.0 KB
4nntp.terraraq.uk7.8 MB0.0 KB1.9 MB9.6 MB 80%7.5 KB
5i2pn.org3.8 MB24.3 KB24.3 KB3.8 MB 98%20.6 KB
6usenet.pasdenom.info1.1 MB0.0 KB4.8 KB1.1 MB 99%3.5 KB
7gegeweb-out.news.tnetconsulting.net165.2 KB0.0 KB27.8 KB193.1 KB 85%3.2 KB
8news.samoylyk.net88.7 KB0.0 KB0.0 KB88.7 KB100%6.3 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 9508.2 MB24.3 KB101.3 MB609.5 MB 83%9.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 29 04:15:02 - 04:59:59 1179 2.3% 0.4411.7 MB 2.3% 4.45
Nov 29 05:00:00 - 05:59:59 2053 3.9% 0.5719.1 MB 3.8% 5.43
Nov 29 06:00:00 - 06:59:59 1752 3.4% 0.4917.2 MB 3.4% 4.90
Nov 29 07:00:00 - 07:59:59 2340 4.5% 0.6522.3 MB 4.4% 6.33
Nov 29 08:00:00 - 08:59:59 2552 4.9% 0.7124.1 MB 4.7% 6.85
Nov 29 09:00:00 - 09:59:59 3108 5.9% 0.8630.0 MB 5.9% 8.54
Nov 29 10:00:00 - 10:59:59 3014 5.8% 0.8429.4 MB 5.8% 8.36
Nov 29 11:00:00 - 11:59:59 2840 5.4% 0.7926.8 MB 5.3% 7.62
Nov 29 12:00:00 - 12:59:59 2972 5.7% 0.8328.1 MB 5.5% 7.99
Nov 29 13:00:00 - 13:59:59 3145 6.0% 0.8730.1 MB 5.9% 8.56
Nov 29 14:00:00 - 14:59:59 2931 5.6% 0.8128.7 MB 5.6% 8.16
Nov 29 15:00:00 - 15:59:59 2675 5.1% 0.7427.7 MB 5.4% 7.88
Nov 29 16:00:00 - 16:59:59 2408 4.6% 0.6725.5 MB 5.0% 7.26
Nov 29 17:00:00 - 17:59:59 1983 3.8% 0.5521.1 MB 4.1% 6.00
Nov 29 18:00:00 - 18:59:59 1956 3.7% 0.5420.1 MB 3.9% 5.70
Nov 29 19:00:00 - 19:59:59 2310 4.4% 0.6426.0 MB 5.1% 7.39
Nov 29 20:00:00 - 20:59:59 1704 3.3% 0.4715.0 MB 3.0% 4.28
Nov 29 21:00:00 - 21:59:59 1501 2.9% 0.4212.9 MB 2.5% 3.66
Nov 29 22:00:00 - 22:59:59 1709 3.3% 0.4717.1 MB 3.4% 4.85
Nov 29 23:00:00 - 23:59:59 1356 2.6% 0.3810.8 MB 2.1% 3.08
Nov 30 00:00:00 - 00:59:59 1347 2.6% 0.3711.9 MB 2.3% 3.38
Nov 30 01:00:00 - 01:59:59 1535 2.9% 0.4314.5 MB 2.8% 4.11
Nov 30 02:00:00 - 02:59:59 1595 3.1% 0.4416.0 MB 3.1% 4.54
Nov 30 03:00:00 - 03:59:59 1798 3.4% 0.5018.2 MB 3.6% 5.17
Nov 30 04:00:00 - 04:15:01 478 0.9% 0.535.2 MB 1.0% 5.86
TOTAL: 23:59:59 52241 100.0% 0.60509.2 MB 100.0% 6.04
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 9352 13 0 0 0 0 0 0 9339
2news.glou.org 1524 0 0 0 0 0 0 0 1524
3nntp.terraraq.uk 277 0 0 0 0 0 0 0 277
4gegeweb-out.news.tnetconsulting.net 47 0 0 0 0 0 0 0 47
5usenet.pasdenom.info 7 0 0 0 0 0 0 0 7
TOTAL: 5 11207 13 0 0 0 0 0 011194

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.misc.gestion 7
fr.education.entraide.maths 5
fr.education.superieur 1
TOTAL: 3 13

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 10860
EMP (phl) 205
Bad path (news.giganews.com.POSTED) 76
Too many newsgroups 37
Binary: misplaced binary 8
Cancels abusifs 5
Cancel for rejected article 2
Cancel of non-existing ID <uk6thp$o477$1@dont-email.me> 1
TOTAL: 8 11194

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.terraraq.uk 63580 1075 48344 601 0 22 1%23:59:55
2news.nntp4.net 38241 951 26669 2 0 1 2%23:59:55
3i2pn.org 81780 240 46929 4624 0 2082 0%23:59:50
4news.samoylyk.net 80874 18 51441 757 0 59 0%23:59:54
5news.gegeweb.org 52869 9 51112 0 0 0 0%23:59:54
6news.tnetconsulting.net 76704 6 51542 688 0 47 0%23:59:52
7news.pasdenom.info 59215 0 51728 9 0 1 0%23:59:55
8news.aioe.org 0 0 0 0 0 6613 0%23:59:55
TOTAL: 8 453263 2299 327765 6681 0 8825 0%191:59:10
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.terraraq.uk12.7 MB7.2 MB20.0 MB0.2 KB/s12.2 KB23:59:55
2news.nntp4.net10.9 MB10.5 KB10.9 MB0.1 KB/s11.7 KB23:59:55
3i2pn.org1.8 MB44.9 MB46.7 MB0.6 KB/s9.8 KB23:59:50
4news.gegeweb.org264.1 KB0.0 KB264.1 KB0.0 KB/s29.3 KB23:59:54
5news.tnetconsulting.net62.1 KB8.4 MB8.4 MB0.1 KB/s12.5 KB23:59:52
6news.samoylyk.net43.6 KB7.9 MB7.9 MB0.1 KB/s10.5 KB23:59:54
7news.pasdenom.info0.0 KB141.7 KB141.7 KB0.0 KB/s15.7 KB23:59:55
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 825.8 MB68.6 MB94.3 MB0.1 KB/s10.8 KB191:59:10
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mail.gegeweb.eu 289 00.0 KB 0 0 000:01:56
2162.243.150.18 1 00.0 KB 0 0 000:00:01
380.66.88.211 1 00.0 KB 0 0 000:00:00
4mighty.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
5great.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
6blissful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
7appealing.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:06
8181.215.176.76 8 00.0 KB 0 0 000:01:43
9207.90.244.6 1 00.0 KB 0 0 000:00:01
TOTAL: 9 304 00.0 KB 0 0 000:03:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 289 00.0 KB 0 0 000:01:56
2unresolved 11 00.0 KB 0 0 000:01:46
3*.monitoring.internet-measurement.com 4 00.0 KB 0 0 000:00:07
TOTAL: 3 304 00.0 KB 0 0 000:03:50

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.454 4.363 1.64300:01:56
181.215.176.76 0.410 0.152 0.00000:01:43
appealing.monitoring.internet-measurement.com 0.049 0.038 0.00000:00:06
207.90.244.6 0.024 0.020 0.00000:00:01
162.243.150.18 0.018 0.007 0.00000:00:01
great.monitoring.internet-measurement.com 0.036 0.020 0.00000:00:00
mighty.monitoring.internet-measurement.com 0.012 0.016 0.00000:00:00
blissful.monitoring.internet-measurement.com 0.033 0.022 0.00000:00:00
80.66.88.211 0.029 0.021 0.00000:00:00
TOTAL: 9 5.065 4.659 1.64300:03:50

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
80.66.88.211 1
162.243.150.18 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_45.13.105.36_119 1
#003 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
80.66.88.211 1 1
TOTAL: 1 1 1
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me