Daily Usenet report for news.niel.me

May 23 04:15:02 -- May 24 04:15:01

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

May 24 04:06:41 rpi-studio nnrpd[7338]: 2001:41d0:a:280::1 noperm ihave without permission
May 24 04:07:34 rpi-studio nnrpd[7354]: 2001:41d0:a:280::1 noperm ihave without permission
May 24 04:08:27 rpi-studio nnrpd[7369]: 2001:41d0:a:280::1 noperm ihave without permission
May 24 04:09:20 rpi-studio nnrpd[7388]: 2001:41d0:a:280::1 noperm ihave without permission
May 24 04:10:08 rpi-studio nnrpd[7412]: 2001:41d0:a:280::1 noperm ihave without permission
May 24 04:10:56 rpi-studio nnrpd[7428]: 2001:41d0:a:280::1 noperm ihave without permission
May 24 04:11:44 rpi-studio nnrpd[7587]: 2001:41d0:a:280::1 noperm ihave without permission
May 24 04:12:32 rpi-studio nnrpd[7607]: 2001:41d0:a:280::1 noperm ihave without permission
May 24 04:13:20 rpi-studio nnrpd[7632]: 2001:41d0:a:280::1 noperm ihave without permission
May 24 04:14:08 rpi-studio nnrpd[7654]: 2001:41d0:a:280::1 noperm ihave without permission
May 24 04:14:56 rpi-studio nnrpd[7667]: 2001:41d0:a:280::1 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
inn 3908 37.5%741.2 KB 43.6%
innd 2423 23.2%395.9 KB 23.3%
nnrpd 2358 22.6%258.2 KB 15.2%
innfeed 1735 16.6%303.7 KB 17.9%
nocem 4 0.0%0.4 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 10429 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 20314 59.6%
Negative hits 9953 29.2%
Do not exist 3844 11.3%
Cache misses 1 0.0%
TOTAL: 4 34112 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.021 0.0%17 0.000 1.235 3.000
article cancel00:00:00.005 0.0%19 0.000 0.263 1.000
article cleanup00:00:00.086 0.0%3863 0.000 0.022 0.154
article logging00:00:00.281 0.0%3877 0.000 0.072 0.278
article parse00:00:00.776 0.0%10812 0.000 0.072 0.269
article write00:00:02.881 0.0%3380 0.250 0.852 1.762
artlog/artcncl00:00:00.002 0.0%19 0.000 0.105 1.000
artlog/artcncl/perl00:00:00.001 0.0%17 0.000 0.059 1.000
data move00:00:00.151 0.0%39265 0.000 0.004 0.025
hisgrep/artcncl00:00:00.002 0.0%19 0.000 0.105 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%17 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%20 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%19 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%17 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.448 0.0%34253 0.000 0.013 0.051
history sync00:00:00.045 0.0%399 0.000 0.113 1.000
history write00:00:00.780 0.0%3861 0.000 0.202 0.538
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:05.815 99.9%40887 513.674 2113.283 7061.553
nntp read00:00:01.286 0.0%40396 0.000 0.032 0.086
overview write00:00:02.160 0.0%3380 0.050 0.639 3.100
perl filter00:00:18.339 0.0%3861 2.286 4.750 9.675
python filter00:00:00.006 0.0%3861 0.000 0.002 0.083
site send00:00:01.124 0.0%6829 0.000 0.165 0.467
TOTAL: 24:01:13.14524:00:34.209100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%3379 0.000 0.007 0.125
article prepare00:00:00.000 0.0%364 0.000 0.000 0.000
article read00:00:00.017 0.0%89 0.000 0.191 7.000
backlog stats00:00:00.134 0.0%44803 0.000 0.003 0.014
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.610 0.0%26577 0.000 0.023 0.075
data write00:00:01.272 0.0%23507 0.000 0.054 0.099
idle23:59:36.021100.0%44803 508.506 1927.907 4549.144
status file00:00:00.435 0.0%197 1.000 2.208 8.000
TOTAL: 23:59:42.86723:59:38.511100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:26.678 7.4%1495 11.400 17.845 6875.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.061 0.0%3408 0.000 0.018 1.000
readart00:00:00.013 0.0%2 6.500 6.500 6.500
TOTAL: 00:05:58.99600:00:26.752 7.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
1i2pn.org 2 3219 755 2333 131 23%22:12:21
2feed-out.gegeweb.org 2 2297 715 1582 0 31%23:59:43
3news.nntp4.net 1 3938 651 2987 300 16%25:28:08
4gegeweb-out.news.tnetconsulting.net 2 5914 420 5472 22 7%39:16:00
5news.samoylyk.net 2 4437 419 4006 12 9%28:58:30
6nntp.terraraq.uk 2 3243 323 2894 26 9%25:20:13
7news.glou.org 2 2911 252 2621 38 8%23:58:53
8usenet.pasdenom.info 1 1916 161 1740 15 8%19:32:16
92001:41d0:a:280::1 0 130 28 85 17 21%01:08:45
10localhost 26 0 0 0 0 0%00:00:00
TOTAL: 10 40 28005 3724 23720 561 13%209:54:49

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1gegeweb-out.news.tnetconsulting.net9.1 MB96.1 KB172.3 KB9.4 MB 97%21.7 KB
2news.samoylyk.net4.0 MB0.0 KB27.9 KB4.1 MB 99%9.7 KB
3news.nntp4.net3.2 MB3.1 KB1.2 MB4.4 MB 72%4.8 KB
4i2pn.org2.8 MB0.0 KB424.8 KB3.3 MB 87%3.8 KB
5feed-out.gegeweb.org1.9 MB0.0 KB0.0 KB1.9 MB100%2.7 KB
6nntp.terraraq.uk1.5 MB0.0 KB105.0 KB1.6 MB 93%4.6 KB
7news.glou.org1.0 MB0.0 KB102.5 KB1.1 MB 91%4.0 KB
8usenet.pasdenom.info380.1 KB0.0 KB29.2 KB409.3 KB 92%2.3 KB
92001:41d0:a:280::1110.8 KB0.0 KB119.8 KB230.6 KB 48%5.1 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1024.1 MB99.2 KB2.2 MB26.4 MB 91%6.3 KB

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 23 04:15:02 - 04:59:59 85 2.5% 0.03414.8 KB 2.3% 0.15
May 23 05:00:00 - 05:59:59 93 2.8% 0.03667.0 KB 3.8% 0.19
May 23 06:00:00 - 06:59:59 104 3.1% 0.03337.2 KB 1.9% 0.09
May 23 07:00:00 - 07:59:59 112 3.3% 0.03645.1 KB 3.6% 0.18
May 23 08:00:00 - 08:59:59 178 5.3% 0.05397.7 KB 2.2% 0.11
May 23 09:00:00 - 09:59:59 111 3.3% 0.03368.9 KB 2.1% 0.10
May 23 10:00:00 - 10:59:59 127 3.8% 0.04382.4 KB 2.2% 0.11
May 23 11:00:00 - 11:59:59 115 3.4% 0.03320.5 KB 1.8% 0.09
May 23 12:00:00 - 12:59:59 108 3.2% 0.03460.5 KB 2.6% 0.13
May 23 13:00:00 - 13:59:59 141 4.2% 0.04512.8 KB 2.9% 0.14
May 23 14:00:00 - 14:59:59 135 4.0% 0.04412.8 KB 2.3% 0.11
May 23 15:00:00 - 15:59:59 165 4.9% 0.051.7 MB 10.0% 0.49
May 23 16:00:00 - 16:59:59 157 4.7% 0.04667.1 KB 3.8% 0.19
May 23 17:00:00 - 17:59:59 185 5.5% 0.05665.1 KB 3.8% 0.18
May 23 18:00:00 - 18:59:59 126 3.7% 0.04632.8 KB 3.6% 0.18
May 23 19:00:00 - 19:59:59 176 5.2% 0.051.2 MB 7.0% 0.35
May 23 20:00:00 - 20:59:59 223 6.6% 0.062.2 MB 12.4% 0.61
May 23 21:00:00 - 21:59:59 177 5.2% 0.05831.3 KB 4.7% 0.23
May 23 22:00:00 - 22:59:59 181 5.4% 0.051.5 MB 8.7% 0.43
May 23 23:00:00 - 23:59:59 185 5.5% 0.051.2 MB 7.1% 0.35
May 24 00:00:00 - 00:59:59 110 3.3% 0.03437.3 KB 2.5% 0.12
May 24 01:00:00 - 01:59:59 128 3.8% 0.04457.8 KB 2.6% 0.13
May 24 02:00:00 - 02:59:59 119 3.5% 0.03486.1 KB 2.7% 0.14
May 24 03:00:00 - 03:59:59 102 3.0% 0.03465.6 KB 2.6% 0.13
May 24 04:00:00 - 04:15:01 31 0.9% 0.03144.5 KB 0.8% 0.16
TOTAL: 23:59:59 3374 100.0% 0.0417.3 MB 100.0% 0.21

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 239 0 0 1 0 0 0 0 238
2i2pn.org 136 0 0 0 0 0 0 0 136
3news.glou.org 38 0 0 0 0 0 0 0 38
4news.samoylyk.net 29 0 0 0 0 0 0 0 29
5nntp.terraraq.uk 16 0 0 0 0 0 0 0 16
6gegeweb-out.news.tnetconsulting.net 16 1 0 1 0 0 0 0 14
72001:41d0:a:280::1 16 0 0 0 0 0 0 0 16
8usenet.pasdenom.info 8 0 0 0 0 0 0 0 8
TOTAL: 8 498 1 0 2 0 0 0 0 495

Unwanted newsgroups [Top 20]:

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

INND Perl filter [Top 20]:

ReasonCount
Bad path (news.giganews.com.POSTED) 127
EMP (phn nph) 91
EMP (md5) 91
EMP (phl) 62
Too many newsgroups 43
EMP (phn path) 31
EMP (phr nph) 12
hierarchy violation - crosspost outside sdnet 10
Too many newsgroups (meow) 5
Cancel of non-existing ID <u4hioq$2facb$1@dont-email.me> 2
Cancels abusifs 2
Malformed article 1
HTML Multipart 1
Cancel for rejected article 1
User-issued spam cancel 1
Cancel of non-existing ID <kd3nlqFejspU1@mid.individual.net> 1
TOTAL: 16 481

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com2022
news@uni-berlin.de0100
TOTAL: 22122

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.samoylyk.net 14
TOTAL: 1 14
TOTAL: 1 14

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 4203 23 2477 0 0 0 0%23:59:55
2news.gegeweb.org 2856 19 2598 33 0 0 0%23:59:55
3news.tnetconsulting.net 5067 12 3359 1 0 5 0%23:59:46
4nntp.terraraq.uk 2339 1 2195 0 0 0 0%23:59:36
5news.nntp4.net 2829 1 2745 0 0 0 0%23:59:55
6news.aioe.org 0 0 0 0 0 2647 0%23:59:55
7news.samoylyk.net 3375 0 3064 0 0 0 0%23:59:54
8news.pasdenom.info 2902 0 2831 1 0 0 0%23:59:40
TOTAL: 8 23571 56 19269 35 0 2652 0%191:58:36

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org72.1 KB133.5 KB205.6 KB0.0 KB/s4.0 KB23:59:55
2i2pn.org54.5 KB0.0 KB54.5 KB0.0 KB/s2.4 KB23:59:55
3news.tnetconsulting.net38.6 KB3.0 KB41.7 KB0.0 KB/s3.2 KB23:59:46
4news.nntp4.net3.4 KB0.0 KB3.4 KB0.0 KB/s3.4 KB23:59:55
5nntp.terraraq.uk2.6 KB0.0 KB2.6 KB0.0 KB/s2.6 KB23:59:36
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
7news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
8news.pasdenom.info0.0 KB3.5 KB3.5 KB0.0 KB/s3.5 KB23:59:40
TOTAL: 8171.1 KB140.1 KB311.3 KB0.0 KB/s3.4 KB191:58:36

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1venerated.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:06
2192.241.169.4 1 00.0 KB 0 0 000:00:07
3194.165.16.76 1 00.0 KB 0 0 000:00:00
4104.156.155.25 85 00.0 KB 0 0 000:00:24
5ecstatic.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
6107.170.230.8 1 00.0 KB 0 0 000:00:01
72001:41d0:a:280::1 11 00.0 KB 0 0 000:03:46
846.219.209.156 1 00.0 KB 0 0 000:00:02
9sensational.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
10motivated.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
11mail.gegeweb.eu 288 00.0 KB 0 0 000:01:30
TOTAL: 11 392 00.0 KB 0 0 000:05:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 89 00.0 KB 0 0 000:00:35
2? 11 00.0 KB 0 0 000:03:46
3*.gegeweb.eu 288 00.0 KB 0 0 000:01:30
4*.monitoring.internet-measurement.com 4 00.0 KB 0 0 000:00:06
TOTAL: 4 392 00.0 KB 0 0 000:05:58

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2001:41d0:a:280::1 0.209 0.310 0.00000:03:46
mail.gegeweb.eu 4.423 4.947 1.99200:01:30
104.156.155.25 2.550 1.459 0.00000:00:24
192.241.169.4 0.021 0.032 0.00000:00:07
venerated.monitoring.internet-measurement.com 0.041 0.020 0.00000:00:06
46.219.209.156 0.017 0.066 0.00000:00:02
107.170.230.8 0.016 0.032 0.00000:00:01
194.165.16.76 0.044 0.009 0.00000:00:00
motivated.monitoring.internet-measurement.com 0.044 0.022 0.00000:00:00
sensational.monitoring.internet-measurement.com 0.028 0.038 0.00000:00:00
ecstatic.monitoring.internet-measurement.com 0.022 0.045 0.00000:00:00
TOTAL: 11 7.415 6.980 1.99200:05:58

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
194.165.16.76 1
107.170.230.8 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.76 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