Daily Usenet report for news.niel.me

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

Unknown entries from news log file:

First 50 / 968 lines (5.2%)

May 4 04:15:05 rpi-studio nnrpd[7634]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:15:36 rpi-studio nnrpd[7769]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:16:06 rpi-studio nnrpd[7774]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:16:36 rpi-studio nnrpd[7802]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:17:07 rpi-studio nnrpd[7830]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:17:37 rpi-studio nnrpd[7884]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:18:12 rpi-studio nnrpd[7897]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:18:42 rpi-studio nnrpd[7901]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:19:12 rpi-studio nnrpd[7905]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:19:42 rpi-studio nnrpd[7925]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:20:12 rpi-studio nnrpd[7932]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:20:43 rpi-studio nnrpd[7935]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:21:13 rpi-studio nnrpd[7943]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:21:44 rpi-studio nnrpd[7951]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:22:16 rpi-studio nnrpd[7955]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:22:46 rpi-studio nnrpd[7959]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:23:27 rpi-studio nnrpd[8107]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:23:57 rpi-studio nnrpd[8115]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:24:27 rpi-studio nnrpd[8121]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:24:58 rpi-studio nnrpd[8128]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:25:28 rpi-studio nnrpd[8150]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:25:58 rpi-studio nnrpd[8155]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:26:28 rpi-studio nnrpd[8161]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:26:58 rpi-studio nnrpd[8169]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:27:28 rpi-studio nnrpd[8173]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:27:58 rpi-studio nnrpd[8177]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:28:28 rpi-studio nnrpd[8190]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:28:58 rpi-studio nnrpd[8192]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:29:28 rpi-studio nnrpd[8198]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:29:58 rpi-studio nnrpd[8200]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:30:28 rpi-studio nnrpd[8211]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:30:58 rpi-studio nnrpd[8219]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:31:29 rpi-studio nnrpd[8225]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:31:59 rpi-studio nnrpd[8228]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:32:29 rpi-studio nnrpd[8234]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:32:59 rpi-studio nnrpd[8379]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:33:29 rpi-studio nnrpd[8391]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:33:59 rpi-studio nnrpd[8394]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:34:29 rpi-studio nnrpd[8398]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:34:59 rpi-studio nnrpd[8402]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:35:29 rpi-studio nnrpd[8422]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:35:59 rpi-studio nnrpd[8437]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:36:29 rpi-studio nnrpd[8442]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:36:59 rpi-studio nnrpd[8445]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:37:30 rpi-studio nnrpd[8452]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:38:00 rpi-studio nnrpd[8455]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:38:30 rpi-studio nnrpd[8459]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:39:00 rpi-studio nnrpd[8464]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:39:31 rpi-studio nnrpd[8469]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission
May 4 04:40:01 rpi-studio nnrpd[8476]: 2a01:e0a:21:ea80:2045:496a:255c:cb5b noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 7916 46.9%1004.6 KB 39.8%
inn 4882 28.9%840.2 KB 33.3%
innd 2521 14.9%424.8 KB 16.8%
innfeed 1568 9.3%254.9 KB 10.1%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 16889 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24913 61.8%
Negative hits 7577 18.8%
Do not exist 4813 11.9%
Cache misses 3025 7.5%
TOTAL: 4 40328 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.017 0.0%15 0.833 1.133 3.000
article cancel00:00:00.004 0.0%16 0.000 0.250 1.000
article cleanup00:00:00.142 0.0%4829 0.000 0.029 0.143
article logging00:00:00.387 0.0%4852 0.000 0.080 1.000
article parse00:00:00.893 0.0%8918 0.000 0.100 0.185
article write00:00:05.239 0.0%4114 0.200 1.273 56.189
artlog/artcncl00:00:00.001 0.0%16 0.000 0.062 0.167
artlog/artcncl/perl00:00:00.001 0.0%15 0.000 0.067 0.167
data move00:00:00.159 0.0%41808 0.000 0.004 0.025
hisgrep/artcncl00:00:00.001 0.0%16 0.000 0.062 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%20 0.000 0.050 1.000
hishave/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.605 0.0%40419 0.000 0.015 0.050
history sync00:00:00.051 0.0%418 0.000 0.122 1.000
history write00:00:01.008 0.0%4829 0.000 0.209 0.500
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:14.854 99.9%43781 768.437 1973.798 5269.904
nntp read00:00:01.373 0.0%41334 0.009 0.033 0.096
overview write00:00:05.731 0.0%4114 0.077 1.393 54.960
perl filter00:00:24.852 0.0%4829 3.256 5.146 11.600
python filter00:00:00.022 0.0%8024 0.000 0.003 0.049
site send00:00:01.480 0.0%8231 0.000 0.180 0.500
TOTAL: 24:01:14.08424:00:56.821100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.052 0.0%4132 0.000 0.013 0.100
article prepare00:00:00.000 0.0%1528 0.000 0.000 0.000
article read00:00:00.055 0.0%327 0.000 0.168 7.000
backlog stats00:00:00.140 0.0%65330 0.000 0.002 0.020
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.863 0.0%36463 0.000 0.024 0.050
data write00:00:02.414 0.0%32281 0.016 0.075 0.137
idle23:50:06.226100.0%65330 538.146 1313.428 3800.399
status file00:00:00.399 0.0%178 1.000 2.242 6.000
TOTAL: 23:50:13.30223:50:10.149100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%2 0.000 0.000 0.000
idle00:13:20.835 94.1%4495 6.400 178.161 12688.472
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.346 0.0%9916 0.000 0.035 0.500
readart00:00:00.094 0.0%156 0.250 0.603 3.000
TOTAL: 00:14:11.32700:13:21.275 94.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
1news-out.aioe.org 2 4195 2295 1823 77 54%26:01:31
2feed-out.gegeweb.org 3 2868 757 2111 0 26%23:58:48
3usenet.pasdenom.info 7 11405 726 10670 9 6%54:35:43
4nntp.terraraq.uk 2 3249 337 2558 354 10%21:06:02
5news.nntp4.net 2 6327 198 5909 220 3%32:35:55
6i2pn.org 1 4018 71 3932 15 1%23:59:57
7gegeweb-out.news.tnetconsulting.net 2 3697 27 3619 51 0%23:59:40
8localhost 27 2 2 0 0 100%00:00:00
TOTAL: 8 46 35761 4413 30622 726 12%206:17:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org8.0 MB0.0 KB306.1 KB8.3 MB 96%3.6 KB
2nntp.terraraq.uk4.7 MB0.0 KB1.6 MB6.3 MB 74%9.4 KB
3news.nntp4.net3.5 MB0.0 KB574.5 KB4.1 MB 86%10.1 KB
4feed-out.gegeweb.org2.6 MB0.0 KB0.0 KB2.6 MB100%3.5 KB
5usenet.pasdenom.info1.8 MB0.0 KB26.5 KB1.8 MB 98%2.5 KB
6gegeweb-out.news.tnetconsulting.net186.2 KB0.0 KB410.7 KB596.9 KB 31%7.7 KB
7i2pn.org125.6 KB0.0 KB62.8 KB188.4 KB 66%2.2 KB
8localhost3.4 KB0.0 KB0.0 KB3.4 KB100%1.7 KB
TOTAL: 821.0 MB0.0 KB3.0 MB24.0 MB 87%4.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 4 04:15:02 - 04:59:59 80 1.9% 0.031.0 MB 5.7% 0.39
May 4 05:00:00 - 05:59:59 108 2.6% 0.03320.5 KB 1.7% 0.09
May 4 06:00:00 - 06:59:59 115 2.8% 0.03345.4 KB 1.8% 0.10
May 4 07:00:00 - 07:59:59 125 3.0% 0.03371.1 KB 2.0% 0.10
May 4 08:00:00 - 08:59:59 101 2.5% 0.03278.2 KB 1.5% 0.08
May 4 09:00:00 - 09:59:59 92 2.2% 0.03469.1 KB 2.5% 0.13
May 4 10:00:00 - 10:59:59 103 2.5% 0.03456.4 KB 2.4% 0.13
May 4 11:00:00 - 11:59:59 133 3.2% 0.04536.0 KB 2.8% 0.15
May 4 12:00:00 - 12:59:59 161 3.9% 0.04617.1 KB 3.3% 0.17
May 4 13:00:00 - 13:59:59 207 5.0% 0.06616.3 KB 3.3% 0.17
May 4 14:00:00 - 14:59:59 168 4.1% 0.05518.9 KB 2.8% 0.14
May 4 15:00:00 - 15:59:59 227 5.5% 0.06822.9 KB 4.4% 0.23
May 4 16:00:00 - 16:59:59 290 7.0% 0.081.9 MB 10.3% 0.54
May 4 17:00:00 - 17:59:59 235 5.7% 0.072.1 MB 11.3% 0.59
May 4 18:00:00 - 18:59:59 261 6.3% 0.07799.4 KB 4.2% 0.22
May 4 19:00:00 - 19:59:59 234 5.7% 0.071.5 MB 8.4% 0.44
May 4 20:00:00 - 20:59:59 180 4.4% 0.05582.8 KB 3.1% 0.16
May 4 21:00:00 - 21:59:59 263 6.4% 0.071013.9 KB 5.4% 0.28
May 4 22:00:00 - 22:59:59 223 5.4% 0.061.3 MB 7.3% 0.38
May 4 23:00:00 - 23:59:59 242 5.9% 0.07768.2 KB 4.1% 0.21
May 5 00:00:00 - 00:59:59 155 3.8% 0.04638.6 KB 3.4% 0.18
May 5 01:00:00 - 01:59:59 166 4.0% 0.05684.9 KB 3.6% 0.19
May 5 02:00:00 - 02:59:59 120 2.9% 0.03434.5 KB 2.3% 0.12
May 5 03:00:00 - 03:59:59 103 2.5% 0.03427.3 KB 2.3% 0.12
May 5 04:00:00 - 04:15:01 23 0.6% 0.0354.0 KB 0.3% 0.06
TOTAL: 23:59:59 4115 100.0% 0.0518.4 MB 100.0% 0.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 406 0 0 0 0 0 0 0 406
2news.nntp4.net 181 0 0 0 0 0 0 0 181
3news-out.aioe.org 93 2 0 0 0 0 0 0 91
4gegeweb-out.news.tnetconsulting.net 25 1 0 0 0 0 0 0 24
5i2pn.org 20 0 0 0 0 0 0 0 20
6usenet.pasdenom.info 9 0 0 0 0 0 0 0 9
7feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
TOTAL: 7 736 3 0 0 0 0 0 0 733

Unwanted newsgroups [Top 20]:

NewsgroupCount
france.poitou-charentes.niort 1
news.test 1
uk.politics.misc 1
TOTAL: 3 3

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 223
EMP (phn nph) 165
Bad path (news.giganews.com.POSTED) 141
EMP (md5) 107
EMP (phl) 62
User-issued spam cancel 8
Cancel of <s6rvp4$q65$10@dont-email.me> without Cancel-Key 1
Cancel of <s6s2ra$ne8$4@dont-email.me> without Cancel-Key 1
Cancel of <s6s7i8$q4n$4@dont-email.me> without Cancel-Key 1
Cancel of non-existing ID <609151c4$0$3729$426a74cc@news.free.fr> 1
TOTAL: 10 710

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 18
nntp.terraraq.uk 2
feed-out.gegeweb.org 2
news.nntp4.net 1
TOTAL: 4 23
TOTAL: 1 23

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 7632 183 3760 65 0 6 2%23:59:50
2news.tnetconsulting.net 7489 75 4019 16 0 0 1%23:59:56
3news.pasdenom.info 4783 20 3166 7 0 2 0%23:59:56
4nntp.terraraq.uk 2832 8 2595 0 0 0 0%23:59:44
5news.gegeweb.org 3461 4 3348 0 0 0 0%23:59:56
6news.aioe.org 1700 2 1572 0 0 0 0%23:51:52
7news.nntp4.net 4293 2 3967 0 0 25 0%23:59:56
TOTAL: 7 32190 294 22427 88 0 33 0%167:51:10
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org444.2 KB135.8 KB579.9 KB0.0 KB/s2.3 KB23:59:50
2news.tnetconsulting.net303.2 KB40.3 KB343.5 KB0.0 KB/s3.8 KB23:59:56
3news.pasdenom.info102.5 KB34.2 KB136.8 KB0.0 KB/s5.1 KB23:59:56
4nntp.terraraq.uk28.5 KB0.0 KB28.5 KB0.0 KB/s3.6 KB23:59:44
5news.gegeweb.org7.9 KB0.0 KB7.9 KB0.0 KB/s2.0 KB23:59:56
6news.aioe.org3.4 KB0.0 KB3.4 KB0.0 KB/s1.7 KB23:51:52
7news.nntp4.net3.4 KB0.0 KB3.4 KB0.0 KB/s1.7 KB23:59:56
TOTAL: 7893.0 KB210.4 KB1.1 MB0.0 KB/s2.9 KB167:51:10
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.168.1.41 5 1725.1 KB 8 2 000:11:48
TOTAL: 1 5 1725.1 KB 8 2 000:14:09

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 8 1725.1 KB 8 2 000:11:58
2? 968 00.0 KB 0 0 000:01:20
3*.gegeweb.eu 287 00.0 KB 0 0 000:00:23
4*.niel.me 1 00.0 KB 0 0 000:00:25
TOTAL: 41264 1725.1 KB 8 2 000:14:09

NNRP auth users [Top 20]:

UserConn
mailman 287
TOTAL: 1 287

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.168.1.41 0.281 0.234 0.00000:11:48
2a01:e0a:21:ea80:2045:496a:255c:cb5b 27.216 27.456 0.00000:01:20
mbp-gniel.niel.me 0.039 0.059 0.00000:00:25
mail.gegeweb.eu 8.068 8.620 3.08300:00:23
192.241.215.145 0.030 0.020 0.00000:00:09
88.165.5.23 0.075 0.040 0.00000:00:00
TOTAL: 6 35.709 36.429 3.08300:14:09

Curious NNRP server explorers [Top 20]:

SystemConn
2a01:e0a:21:ea80:2045:496a:255c:cb5b 968
mail.gegeweb.eu 287
88.165.5.23 2
mbp-gniel.niel.me 1
192.241.215.145 1
TOTAL: 5 1259

Newsgroup request counts (by category):

CategoryCountPct
1fr 14 82.4%
2grisbi 3 17.6%
TOTAL: 2 17100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1fr.usenet.distribution 9
2fr.usenet.documents 3
3grisbi.test 3
4fr.comp.usenet.serveurs 1
5fr.comp.lang.c 1
TOTAL: 5 17