Daily Usenet report for news.niel.me

Dec 4 04:15:01 -- Dec 5 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 4 13:53:50 rpi-studio innd: filter: No Cancel-Key[sha1:pX6wAaw3KflI0Ak4NfLpUrk0SzU=] matches Cancel-Lock[sha1:MD2GOYVjl06/43CE4YiwFB/xVL8=] target=<656dcb16$0$27075$426a74cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
inn 43564 74.7%8.3 MB 81.3%
innd 10383 17.8%1.4 MB 13.3%
nnrpd 2325 4.0%250.9 KB 2.4%
innfeed 2057 3.5%314.8 KB 3.0%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 58331 100.0%10.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 56143 36.6%
Negative hits 54329 35.4%
Do not exist 42869 27.9%
Cache misses 131 0.1%
TOTAL: 4 153472 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.302 0.0%291 0.000 1.038 7.000
article cancel00:00:00.068 0.0%291 0.000 0.234 1.000
article cleanup00:00:00.906 0.0%42998 0.004 0.021 0.045
article logging00:00:03.208 0.0%42998 0.032 0.075 0.116
article parse00:00:12.564 0.0%243655 0.026 0.052 0.076
article write00:00:39.021 0.0%34739 0.785 1.123 2.243
artlog/artcncl00:00:00.014 0.0%291 0.000 0.048 1.000
artlog/artcncl/perl00:00:00.025 0.0%291 0.000 0.086 1.000
data move00:00:02.303 0.0%411474 0.002 0.006 0.012
hisgrep/artcncl00:00:00.017 0.0%291 0.000 0.058 1.000
hisgrep/artcncl/perl00:00:00.011 0.0%291 0.000 0.038 0.286
hisgrep/perl00:00:00.020 0.0%292 0.000 0.068 1.000
hishave/artcncl00:00:00.003 0.0%291 0.000 0.010 0.167
hishave/artcncl/perl00:00:00.006 0.0%291 0.000 0.021 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.101 0.0%153388 0.009 0.020 0.050
history sync00:00:00.052 0.0%368 0.000 0.141 1.333
history write00:00:10.645 0.0%42998 0.120 0.248 0.514
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:54:59.556 99.6%352537 143.257 244.228 671.561
nntp read00:00:10.378 0.0%352446 0.020 0.029 0.045
overview write00:00:17.304 0.0%34739 0.127 0.498 20.791
perl filter00:03:09.913 0.2%42998 3.292 4.417 6.129
python filter00:00:00.208 0.0%42998 0.000 0.005 0.019
site send00:00:09.581 0.0%71411 0.040 0.134 0.245
TOTAL: 24:00:54.29423:59:59.206 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.368 0.0%41237 0.000 0.009 0.036
article prepare00:00:00.158 0.0%35934 0.000 0.004 0.042
article read00:00:00.962 0.0%6021 0.000 0.160 0.500
backlog stats00:00:02.620 0.0%553803 0.002 0.005 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:08.986 0.0%369639 0.011 0.024 0.044
data write00:00:15.567 0.0%297755 0.037 0.052 0.067
idle23:51:56.817 99.9%553803 89.386 155.140 405.541
status file00:00:00.522 0.0%252 1.000 2.071 8.000
TOTAL: 23:52:53.11923:52:26.000100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:05.396 0.0%110196 0.030 0.049 0.144
idle00:00:55.024 0.0%1453 0.000 37.869 9157.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:10.286 0.0%223702 0.000 0.046 1.000
TOTAL: 48:49:09.76700:01:10.706 0.0%----

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
1news.glou.org 5 25030 17758 5775 1497 70%24:30:12
2news.nntp4.net 3 40942 13227 21291 6424 32%23:57:01
3nntp.terraraq.uk 3 13895 1670 11987 238 12%24:55:29
4feed-out.gegeweb.org 2 4022 1221 2801 0 30%25:14:21
5usenet.pasdenom.info 5 3185 548 2584 53 17%20:31:59
6gegeweb-out.news.tnetconsulting.net 1 3797 294 3470 33 7%24:49:02
7i2pn.org 2 4338 207 4131 0 4%23:59:16
8news.samoylyk.net 3 2106 2 2104 0 0%11:15:06
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 49 97315 34927 54143 8245 35%179:12:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.glou.org151.2 MB0.0 KB9.5 MB160.7 MB 94%8.5 KB
2news.nntp4.net141.5 MB0.0 KB59.6 MB201.2 MB 70%10.5 KB
3feed-out.gegeweb.org16.4 MB0.0 KB0.0 KB16.4 MB100%13.7 KB
4nntp.terraraq.uk8.9 MB0.0 KB1.9 MB10.8 MB 82%5.8 KB
5i2pn.org3.2 MB0.0 KB0.0 KB3.2 MB100%15.7 KB
6usenet.pasdenom.info1.2 MB0.0 KB68.1 KB1.3 MB 94%2.2 KB
7gegeweb-out.news.tnetconsulting.net760.1 KB0.0 KB92.3 KB852.4 KB 89%2.6 KB
8news.samoylyk.net10.5 KB0.0 KB0.0 KB10.5 KB100%5.2 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 9323.2 MB0.0 KB71.2 MB394.4 MB 81%9.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 4 04:15:01 - 04:59:59 923 2.7% 0.348.1 MB 2.5% 3.07
Dec 4 05:00:00 - 05:59:59 1370 3.9% 0.3813.3 MB 4.1% 3.79
Dec 4 06:00:00 - 06:59:59 1473 4.2% 0.4113.9 MB 4.3% 3.95
Dec 4 07:00:00 - 07:59:59 1795 5.2% 0.5016.0 MB 5.0% 4.55
Dec 4 08:00:00 - 08:59:59 2011 5.8% 0.5619.2 MB 6.0% 5.46
Dec 4 09:00:00 - 09:59:59 1770 5.1% 0.4916.2 MB 5.0% 4.61
Dec 4 10:00:00 - 10:59:59 1855 5.3% 0.5217.0 MB 5.3% 4.84
Dec 4 11:00:00 - 11:59:59 1798 5.2% 0.5016.2 MB 5.0% 4.60
Dec 4 12:00:00 - 12:59:59 1791 5.2% 0.5014.4 MB 4.5% 4.11
Dec 4 13:00:00 - 13:59:59 1808 5.2% 0.5016.3 MB 5.0% 4.62
Dec 4 14:00:00 - 14:59:59 1725 5.0% 0.4815.4 MB 4.8% 4.37
Dec 4 15:00:00 - 15:59:59 1948 5.6% 0.5420.0 MB 6.2% 5.70
Dec 4 16:00:00 - 16:59:59 1649 4.7% 0.4615.2 MB 4.7% 4.33
Dec 4 17:00:00 - 17:59:59 1318 3.8% 0.3711.0 MB 3.4% 3.13
Dec 4 18:00:00 - 18:59:59 1224 3.5% 0.349.8 MB 3.0% 2.78
Dec 4 19:00:00 - 19:59:59 1164 3.4% 0.3212.8 MB 4.0% 3.63
Dec 4 20:00:00 - 20:59:59 1439 4.1% 0.4017.4 MB 5.4% 4.95
Dec 4 21:00:00 - 21:59:59 1329 3.8% 0.3717.0 MB 5.3% 4.85
Dec 4 22:00:00 - 22:59:59 953 2.7% 0.267.8 MB 2.4% 2.21
Dec 4 23:00:00 - 23:59:59 854 2.5% 0.246.9 MB 2.1% 1.96
Dec 5 00:00:00 - 00:59:59 773 2.2% 0.215.9 MB 1.8% 1.68
Dec 5 01:00:00 - 01:59:59 938 2.7% 0.267.6 MB 2.4% 2.18
Dec 5 02:00:00 - 02:59:59 1181 3.4% 0.339.5 MB 2.9% 2.69
Dec 5 03:00:00 - 03:59:59 1278 3.7% 0.3511.9 MB 3.7% 3.39
Dec 5 04:00:00 - 04:15:02 354 1.0% 0.393.3 MB 1.0% 3.72
TOTAL: 24:00:01 34721 100.0% 0.40322.1 MB 100.0% 3.82
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 6439 41 0 0 0 0 0 0 6398
2news.glou.org 1497 0 0 0 0 0 0 0 1497
3nntp.terraraq.uk 240 0 0 0 0 0 0 0 240
4usenet.pasdenom.info 52 0 0 0 0 0 0 0 52
5gegeweb-out.news.tnetconsulting.net 37 0 0 0 0 0 0 0 37
TOTAL: 5 8265 41 0 0 0 0 0 0 8224

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.lettres.langue.allemande 20
fr.education.entraide.maths 17
fr.petites-annonces.informatique.materiel 2
fr.misc.gestion 2
TOTAL: 4 41

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7909
EMP (phl) 130
Bad path (news.giganews.com.POSTED) 70
User-issued spam cancel 48
EMP (phn nph) 32
EMP (phn path) 15
Too many newsgroups 13
Cancel for rejected article 4
Cancels abusifs 2
No Cancel-Key matches Cancel-Lock. target=<656dcb16$0$27075$426a74cc@news.free.fr> 1
TOTAL: 10 8224

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.terraraq.uk 39236 2426 27649 1564 0 0 6%23:59:49
2news.nntp4.net 29711 1134 20269 1 0 2 3%23:59:56
3i2pn.org 54834 152 32167 2125 0 212 0%23:59:55
4news.tnetconsulting.net 50766 38 33920 759 0 48 0%23:59:55
5news.samoylyk.net 49869 13 33945 744 1 6343 0%23:59:35
6news.gegeweb.org 34239 6 33525 0 0 0 0%23:59:56
7news.pasdenom.info 40654 5 34124 22 0 71 0%23:59:56
8news.aioe.org 0 0 0 0 0 9182 0%23:59:56
TOTAL: 8 299309 3774 215599 5215 1 15858 1%191:58:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.terraraq.uk19.9 MB13.3 MB33.2 MB0.4 KB/s8.5 KB23:59:49
2news.nntp4.net10.9 MB22.7 KB10.9 MB0.1 KB/s9.8 KB23:59:56
3i2pn.org1.4 MB20.4 MB21.8 MB0.3 KB/s9.8 KB23:59:55
4news.tnetconsulting.net258.1 KB7.4 MB7.7 MB0.1 KB/s9.8 KB23:59:55
5news.gegeweb.org183.7 KB0.0 KB183.7 KB0.0 KB/s30.6 KB23:59:56
6news.samoylyk.net80.4 KB6.7 MB6.8 MB0.1 KB/s9.2 KB23:59:35
7news.pasdenom.info47.9 KB253.0 KB300.9 KB0.0 KB/s11.1 KB23:59:56
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 832.7 MB48.1 MB80.9 MB0.1 KB/s9.2 KB191:58:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1194.165.16.73 1 00.0 KB 0 0 000:00:00
2mail.gegeweb.eu 288 00.0 KB 0 0 000:01:49
380.66.88.204 1 00.0 KB 0 0 000:00:00
4138.199.29.3 8 00.0 KB 0 0 048:46:49
5104.156.155.18 85 00.0 KB 0 0 000:00:17
6245.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:02
7192.241.195.64 1 00.0 KB 0 0 000:00:09
TOTAL: 7 385 00.0 KB 0 0 048:49:09

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:02
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:49
3unresolved 96 00.0 KB 0 0 048:47:17
TOTAL: 3 385 00.0 KB 0 0 048:49:09

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
138.199.29.3 13.996 19.449 0.00048:46:49
mail.gegeweb.eu 4.639 4.537 1.60000:01:49
104.156.155.18 2.346 1.006 0.00000:00:17
192.241.195.64 0.025 0.029 0.00000:00:09
245.211.203.35.bc.googleusercontent.com 0.008 0.016 0.00000:00:02
194.165.16.73 0.019 0.031 0.00000:00:00
80.66.88.204 0.012 0.016 0.00000:00:00
TOTAL: 7 21.045 25.084 1.60048:49:09

NNRP unrecognized commands (by host):

SystemConn
245.211.203.35.bc.googleusercontent.com 3
194.165.16.73 1
TOTAL: 2 4

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:119 1
#003 1
User-Agent: Expanse, a Palo Alto Network... 1
GET / HTTP/1.1 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.73 1 1
TOTAL: 1 1 1