Daily Usenet report for news.niel.me

Oct 1 04:15:01 -- Oct 2 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 1 14:01:51 rpi-studio innd: filter: No Cancel-Key[sha1:zhxZSx0ygO2SUWwvd5e9zBPLTzs=] matches Cancel-Lock[sha1:yLusQmt6qRmKeTfGMRL9huFkzgQ=] target=<6336e54d$0$24817$426a74cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
inn 4016 41.0%753.3 KB 46.1%
innd 2599 26.5%434.4 KB 26.6%
innfeed 1718 17.5%291.7 KB 17.9%
nnrpd 1456 14.9%154.3 KB 9.4%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 9791 100.0%1.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 25825 66.0%
Negative hits 9357 23.9%
Do not exist 3970 10.1%
Cache misses 6 0.0%
TOTAL: 4 39158 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.029 0.0%14 1.000 2.071 5.000
article cancel00:00:00.002 0.0%14 0.000 0.143 1.000
article cleanup00:00:00.095 0.0%3981 0.000 0.024 0.129
article logging00:00:00.294 0.0%3992 0.000 0.074 0.286
article parse00:00:00.774 0.0%8686 0.000 0.089 0.400
article write00:00:05.400 0.0%3466 0.000 1.558 91.571
artlog/artcncl00:00:00.001 0.0%14 0.000 0.071 1.000
artlog/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
data move00:00:00.114 0.0%42945 0.000 0.003 0.017
hisgrep/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%15 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.515 0.0%39241 0.000 0.013 0.039
history sync00:00:00.052 0.0%404 0.000 0.129 1.333
history write00:00:00.871 0.0%3981 0.000 0.219 0.789
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:35.021 99.9%43921 741.104 1967.966 15408.590
nntp read00:00:01.355 0.0%43397 0.009 0.031 0.084
overview write00:00:02.696 0.0%3466 0.111 0.778 4.200
perl filter00:00:17.620 0.0%3981 2.127 4.426 10.421
python filter00:00:00.003 0.0%3981 0.000 0.001 0.042
site send00:00:01.060 0.0%6998 0.000 0.151 0.526
TOTAL: 24:01:18.41624:01:05.902100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.056 0.0%3544 0.000 0.016 0.250
article prepare00:00:00.000 0.0%928 0.000 0.000 0.000
article read00:00:00.034 0.0%186 0.000 0.183 6.000
backlog stats00:00:00.128 0.0%55627 0.000 0.002 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.802 0.0%32685 0.000 0.025 0.081
data write00:00:01.945 0.0%29389 0.024 0.066 0.128
idle23:50:10.460100.0%55627 680.511 1542.604 6384.638
status file00:00:00.520 0.0%182 1.000 2.857 8.000
TOTAL: 23:50:17.12923:50:13.945100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:24.518 38.9%1443 11.400 16.991 1307.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.128 0.2%3175 0.000 0.040 0.273
TOTAL: 00:01:02.95700:00:24.646 39.1%----

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-out.aioe.org 1 3042 1139 1837 66 37%20:33:45
2i2pn.org 1 3721 900 2533 288 24%24:55:59
3news.glou.org 2 3239 603 2542 94 18%23:46:33
4feed-out.gegeweb.org 4 2337 336 2001 0 14%23:57:59
5usenet.pasdenom.info 3 2815 153 2641 21 5%27:06:39
6nntp.terraraq.uk 2 3214 45 3161 8 1%23:59:20
7gegeweb-out.news.tnetconsulting.net 2 3340 25 3312 3 0%23:59:26
8news.samoylyk.net 2 3661 18 3643 0 0%25:37:39
9news.nntp4.net 2 3920 10 3856 54 0%24:20:49
10localhost 25 0 0 0 0 0%00:00:00
TOTAL: 10 44 29289 3229 25526 534 11%218:18:09
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org3.9 MB0.0 KB205.2 KB4.1 MB 95%3.5 KB
2news.glou.org3.8 MB0.0 KB393.0 KB4.2 MB 90%6.2 KB
3i2pn.org3.3 MB0.0 KB633.3 KB3.9 MB 84%3.4 KB
4feed-out.gegeweb.org1.0 MB0.0 KB0.0 KB1.0 MB100%3.2 KB
5news.samoylyk.net996.1 KB0.0 KB0.0 KB996.1 KB100%55.3 KB
6usenet.pasdenom.info369.6 KB0.0 KB39.7 KB409.3 KB 90%2.4 KB
7news.nntp4.net359.7 KB0.0 KB834.1 KB1.2 MB 30%18.7 KB
8gegeweb-out.news.tnetconsulting.net271.5 KB0.0 KB59.2 KB330.6 KB 82%11.8 KB
9nntp.terraraq.uk237.5 KB0.0 KB80.1 KB317.6 KB 74%6.0 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1014.3 MB0.0 KB2.2 MB16.5 MB 86%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 1 04:15:01 - 04:59:59 70 2.0% 0.03404.9 KB 2.6% 0.15
Oct 1 05:00:00 - 05:59:59 72 2.1% 0.02884.6 KB 5.7% 0.25
Oct 1 06:00:00 - 06:59:59 55 1.6% 0.02163.5 KB 1.1% 0.05
Oct 1 07:00:00 - 07:59:59 76 2.2% 0.02243.8 KB 1.6% 0.07
Oct 1 08:00:00 - 08:59:59 96 2.8% 0.03429.7 KB 2.8% 0.12
Oct 1 09:00:00 - 09:59:59 115 3.3% 0.03601.5 KB 3.9% 0.17
Oct 1 10:00:00 - 10:59:59 100 2.9% 0.03915.2 KB 5.9% 0.25
Oct 1 11:00:00 - 11:59:59 184 5.3% 0.05675.1 KB 4.4% 0.19
Oct 1 12:00:00 - 12:59:59 95 2.7% 0.03761.9 KB 4.9% 0.21
Oct 1 13:00:00 - 13:59:59 130 3.8% 0.04996.2 KB 6.4% 0.28
Oct 1 14:00:00 - 14:59:59 227 6.6% 0.061.3 MB 8.5% 0.37
Oct 1 15:00:00 - 15:59:59 188 5.4% 0.05747.5 KB 4.8% 0.21
Oct 1 16:00:00 - 16:59:59 147 4.2% 0.04434.9 KB 2.8% 0.12
Oct 1 17:00:00 - 17:59:59 200 5.8% 0.06656.0 KB 4.2% 0.18
Oct 1 18:00:00 - 18:59:59 169 4.9% 0.05494.6 KB 3.2% 0.14
Oct 1 19:00:00 - 19:59:59 169 4.9% 0.05514.8 KB 3.3% 0.14
Oct 1 20:00:00 - 20:59:59 184 5.3% 0.05691.7 KB 4.5% 0.19
Oct 1 21:00:00 - 21:59:59 208 6.0% 0.06738.5 KB 4.8% 0.21
Oct 1 22:00:00 - 22:59:59 196 5.7% 0.05619.8 KB 4.0% 0.17
Oct 1 23:00:00 - 23:59:59 182 5.3% 0.051.1 MB 7.0% 0.30
Oct 2 00:00:00 - 00:59:59 154 4.4% 0.04633.5 KB 4.1% 0.18
Oct 2 01:00:00 - 01:59:59 167 4.8% 0.05477.6 KB 3.1% 0.13
Oct 2 02:00:00 - 02:59:59 134 3.9% 0.04457.3 KB 2.9% 0.13
Oct 2 03:00:00 - 03:59:59 131 3.8% 0.04495.9 KB 3.2% 0.14
Oct 2 04:00:00 - 04:15:01 14 0.4% 0.0260.6 KB 0.4% 0.07
TOTAL: 24:00:00 3463 100.0% 0.0415.1 MB 100.0% 0.18
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1i2pn.org 278 0 0 0 0 0 0 0 278
2news.glou.org 89 0 0 0 0 0 0 0 89
3news-out.aioe.org 78 1 0 0 0 0 0 0 77
4news.nntp4.net 54 0 0 0 0 0 0 0 54
5usenet.pasdenom.info 16 0 0 0 0 0 0 0 16
6nntp.terraraq.uk 4 0 0 0 0 0 0 0 4
7gegeweb-out.news.tnetconsulting.net 4 3 0 0 0 0 0 0 1
8news.samoylyk.net 2 0 0 0 0 0 0 0 2
TOTAL: 8 525 4 0 0 0 0 0 0 521

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.petites-annonces.informatique.materiel 3
news.test 1
TOTAL: 2 4

INND Perl filter [Top 20]:

ReasonCount
EMP (phl) 227
Bad path (news.giganews.com.POSTED) 79
Too many newsgroups 65
EMP (phn path) 63
EMP (md5) 40
EMP (phn nph) 34
HTML Multipart 1
No Cancel-Key matches Cancel-Lock. target=<6336e54d$0$24817$426a74cc@news.free.fr> 1
TOTAL: 8 510

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 7
i2pn.org 2
news.samoylyk.net 2
TOTAL: 3 11
TOTAL: 1 11

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 4332 102 2443 2 0 44 2%23:52:17
2news.tnetconsulting.net 5372 25 3427 7 0 46 0%23:59:56
3nntp.terraraq.uk 2768 24 2197 15 0 0 0%23:58:31
4news.nntp4.net 4342 23 3425 0 0 0 0%23:59:56
5news.aioe.org 1924 11 1681 0 0 0 0%23:59:31
6news.gegeweb.org 3186 5 3107 11 0 0 0%23:59:49
7news.samoylyk.net 4211 1 3439 5 0 0 0%23:58:45
8news.pasdenom.info 3456 1 2955 0 0 0 0%23:59:17
TOTAL: 8 29591 192 22674 40 0 90 0%191:48:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.nntp4.net1.0 MB0.0 KB1.0 MB0.0 KB/s45.1 KB23:59:56
2i2pn.org304.4 KB57.5 KB361.8 KB0.0 KB/s3.5 KB23:52:17
3nntp.terraraq.uk297.3 KB1.3 MB1.6 MB0.0 KB/s42.7 KB23:58:31
4news.tnetconsulting.net86.9 KB357.8 KB444.7 KB0.0 KB/s13.9 KB23:59:56
5news.aioe.org63.7 KB0.0 KB63.7 KB0.0 KB/s5.8 KB23:59:31
6news.pasdenom.info25.2 KB0.0 KB25.2 KB0.0 KB/s25.2 KB23:59:17
7news.gegeweb.org16.9 KB81.0 KB97.9 KB0.0 KB/s6.1 KB23:59:49
8news.samoylyk.net1.4 KB349.8 KB351.2 KB0.0 KB/s58.5 KB23:58:45
TOTAL: 81.8 MB2.2 MB4.0 MB0.0 KB/s17.4 KB191:48:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1lively.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
2mail.gegeweb.eu 288 00.0 KB 0 0 000:00:59
3192.241.217.122 1 00.0 KB 0 0 000:00:00
462.233.50.133 1 00.0 KB 0 0 000:00:00
TOTAL: 4 291 00.0 KB 0 0 000:01:02

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 288 00.0 KB 0 0 000:00:59
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
3unresolved 2 00.0 KB 0 0 000:00:01
TOTAL: 3 291 00.0 KB 0 0 000:01:02

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 8.090 8.224 2.28700:00:59
lively.monitoring.internet-measurement.com 0.022 0.033 0.00000:00:02
192.241.217.122 0.036 0.018 0.00000:00:00
62.233.50.133 0.025 0.016 0.00000:00:00
TOTAL: 4 8.173 8.291 2.28700:01:02

NNRP unrecognized commands (by host):

SystemConn
192.241.217.122 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_45.13.105.36_119 1
TOTAL: 1 1