Daily Usenet report for news.niel.me

Feb 1 04:15:01 -- Feb 2 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Feb 1 19:44:40 rpi-studio innd: filter: No Cancel-Key[sha1:5/4nIrdCoQV/KfI8BZCee3ESjpA= sha256:f7j7qCYqdNSFZDr/kc+e1Jl5uJrKc4/fiWGAMXflS50=] matches Cancel-Lock[sha1:uLaS5KfDx86EU7GWkkqS98R7P70= sha256:zGBIJYk5SAWeWw73afZBgVuSgUvY4j6/sAMoJkEOO+U=] target=<vnlhcq$ciq$1@rasp.pasdenom.info>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2366 28.9%445.1 KB 33.8%
innd 2164 26.5%365.0 KB 27.7%
nnrpd 1850 22.6%206.8 KB 15.7%
innfeed 1785 21.8%297.8 KB 22.6%
controlchan 8 0.1%1.6 KB 0.1%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 8174 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 11567 56.2%
Negative hits 6665 32.4%
Do not exist 2324 11.3%
Cache misses 13 0.1%
TOTAL: 4 20569 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.019 0.0%17 0.000 1.118 2.500
article cancel00:00:00.003 0.0%18 0.000 0.167 1.000
article cleanup00:00:00.049 0.0%2325 0.000 0.021 0.250
article logging00:00:00.179 0.0%2325 0.000 0.077 0.250
article parse00:00:00.341 0.0%6681 0.000 0.051 0.200
article write00:00:01.163 0.0%2095 0.000 0.555 1.600
artlog/artcncl00:00:00.000 0.0%18 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%17 0.000 0.000 0.000
data move00:00:00.132 0.0%22695 0.000 0.006 0.053
hisgrep/artcncl00:00:00.000 0.0%18 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%17 0.000 0.000 0.000
hisgrep/perl00:00:00.002 0.0%19 0.000 0.105 1.000
hishave/artcncl00:00:00.000 0.0%18 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.277 0.0%20550 0.000 0.013 0.073
history sync00:00:00.046 0.0%338 0.000 0.136 1.000
history write00:00:00.392 0.0%2325 0.000 0.169 0.667
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:41.635100.0%25356 965.926 3385.456 20696.241
nntp read00:00:00.632 0.0%24606 0.000 0.026 0.072
overview write00:00:00.633 0.0%2095 0.000 0.302 3.250
perl filter00:00:09.061 0.0%2325 1.640 3.897 14.200
python filter00:00:00.008 0.0%2325 0.000 0.003 0.059
site send00:00:00.611 0.0%4227 0.000 0.145 0.769
TOTAL: 23:51:02.28823:50:55.183100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%2164 0.000 0.009 0.250
article prepare00:00:00.002 0.0%552 0.000 0.004 0.250
article read00:00:00.024 0.0%130 0.000 0.185 3.000
backlog stats00:00:00.147 0.0%30409 0.000 0.005 0.027
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.384 0.0%16540 0.000 0.023 0.098
data write00:00:00.800 0.0%14561 0.000 0.055 0.103
idle23:58:05.391100.0%30409 1185.221 2837.495 9399.538
status file00:00:01.044 0.0%241 0.000 4.332 42.000
TOTAL: 23:58:13.00423:58:07.811100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:55.218 12.8%1450 9.400 38.081 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.099 0.0%3227 0.000 0.031 1.000
TOTAL: 00:07:12.03700:00:55.317 12.8%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feed-out.gegeweb.org 4 2071 683 1388 0 32%23:56:31
2news.samoylyk.net 2 2604 452 2152 0 17%27:38:42
3gegeweb-out.news.tnetconsulting.net 1 1393 426 945 22 30%22:11:50
4news.glou.org 2 3060 184 2818 58 6%42:32:08
5usenet.pasdenom.info 10 1039 134 900 5 12%24:11:03
6news.nntp4.net 1 1450 96 1247 107 6%17:00:12
7nntp.terraraq.uk 2 1401 27 1373 1 1%22:19:58
8i2pn.org 2 269 10 259 0 3%04:19:26
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 49 13287 2012 11082 193 15%184:09:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net3.7 MB0.0 KB0.0 KB3.7 MB100%8.4 KB
2feed-out.gegeweb.org2.3 MB0.0 KB0.0 KB2.3 MB100%3.4 KB
3gegeweb-out.news.tnetconsulting.net1.6 MB0.0 KB62.8 KB1.6 MB 96%3.7 KB
4news.glou.org750.6 KB0.0 KB192.8 KB943.4 KB 79%3.9 KB
5news.nntp4.net617.6 KB0.0 KB367.9 KB985.5 KB 62%4.9 KB
6usenet.pasdenom.info294.0 KB0.0 KB6.5 KB300.5 KB 97%2.2 KB
7nntp.terraraq.uk222.8 KB0.0 KB1.4 KB224.2 KB 99%8.0 KB
8i2pn.org25.2 KB0.0 KB0.0 KB25.2 KB100%2.5 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 99.4 MB0.0 KB631.4 KB10.0 MB 93%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 1 04:15:01 - 04:59:59 17 0.8% 0.0152.6 KB 0.5% 0.02
Feb 1 05:00:00 - 05:59:59 54 2.6% 0.01178.8 KB 1.8% 0.05
Feb 1 06:00:00 - 06:59:59 59 2.8% 0.02239.9 KB 2.4% 0.07
Feb 1 07:00:00 - 07:59:59 40 1.9% 0.01174.3 KB 1.8% 0.05
Feb 1 08:00:00 - 08:59:59 59 2.8% 0.02502.5 KB 5.1% 0.14
Feb 1 09:00:00 - 09:59:59 60 2.9% 0.02288.4 KB 2.9% 0.08
Feb 1 10:00:00 - 10:59:59 59 2.8% 0.02486.9 KB 4.9% 0.14
Feb 1 11:00:00 - 11:59:59 77 3.7% 0.02234.0 KB 2.4% 0.06
Feb 1 12:00:00 - 12:59:59 78 3.7% 0.02293.0 KB 3.0% 0.08
Feb 1 13:00:00 - 13:59:59 74 3.5% 0.02304.0 KB 3.1% 0.08
Feb 1 14:00:00 - 14:59:59 118 5.6% 0.03389.6 KB 3.9% 0.11
Feb 1 15:00:00 - 15:59:59 95 4.5% 0.031.0 MB 10.6% 0.29
Feb 1 16:00:00 - 16:59:59 86 4.1% 0.02299.2 KB 3.0% 0.08
Feb 1 17:00:00 - 17:59:59 114 5.4% 0.03389.7 KB 3.9% 0.11
Feb 1 18:00:00 - 18:59:59 125 5.9% 0.03562.6 KB 5.7% 0.16
Feb 1 19:00:00 - 19:59:59 177 8.4% 0.05836.0 KB 8.4% 0.23
Feb 1 20:00:00 - 20:59:59 163 7.8% 0.05709.4 KB 7.2% 0.20
Feb 1 21:00:00 - 21:59:59 124 5.9% 0.03767.6 KB 7.7% 0.21
Feb 1 22:00:00 - 22:59:59 147 7.0% 0.04614.8 KB 6.2% 0.17
Feb 1 23:00:00 - 23:59:59 75 3.6% 0.02307.8 KB 3.1% 0.09
Feb 2 00:00:00 - 00:59:59 106 5.0% 0.03364.7 KB 3.7% 0.10
Feb 2 01:00:00 - 01:59:59 81 3.9% 0.02427.4 KB 4.3% 0.12
Feb 2 02:00:00 - 02:59:59 51 2.4% 0.01183.2 KB 1.8% 0.05
Feb 2 03:00:00 - 03:59:59 52 2.5% 0.01225.6 KB 2.3% 0.06
Feb 2 04:00:00 - 04:15:01 10 0.5% 0.0134.5 KB 0.3% 0.04
TOTAL: 24:00:00 2101 100.0% 0.029.7 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 173 0 0 0 0 0 0 0 173
2news.glou.org 31 0 0 0 0 0 0 0 31
3gegeweb-out.news.tnetconsulting.net 19 10 0 0 0 0 0 0 9
4usenet.pasdenom.info 5 0 0 0 0 0 0 0 5
5i2pn.org 2 0 0 0 0 0 0 0 2
TOTAL: 5 230 10 0 0 0 0 0 0 220

Unwanted newsgroups [Top 20]:

NewsgroupCount
soc.culture.iran 10
TOTAL: 1 10

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 168
Bad path (news.giganews.com.POSTED) 47
Cancels abusifs 4
Cancel of non-existing ID <vniu35$3j7fv$1@dont-email.me> 1
TOTAL: 4 220

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 2821 71 1849 12 0 30 2%23:54:20
2news.gegeweb.org 1584 24 1393 0 0 0 1%23:48:54
3news.tnetconsulting.net 3088 8 2076 12 0 28 0%23:53:27
4news.nntp4.net 2174 2 1955 0 0 0 0%23:53:18
5news.samoylyk.net 2066 1 1656 7 0 6 0%23:54:20
6news.pasdenom.info 1746 1 1612 0 0 0 0%23:54:03
7nntp.terraraq.uk 1296 0 1213 0 0 0 0%23:48:35
8news.aioe.org 0 0 0 0 0 1779 0%24:00:00
TOTAL: 8 14775 107 11754 31 0 1843 0%191:06:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org235.8 KB58.1 KB293.9 KB0.0 KB/s3.5 KB23:54:20
2news.gegeweb.org64.7 KB0.0 KB64.7 KB0.0 KB/s2.7 KB23:48:54
3news.tnetconsulting.net28.2 KB49.0 KB77.2 KB0.0 KB/s3.9 KB23:53:27
4news.nntp4.net13.5 KB0.0 KB13.5 KB0.0 KB/s6.7 KB23:53:18
5news.samoylyk.net2.7 KB56.9 KB59.6 KB0.0 KB/s7.5 KB23:54:20
6news.pasdenom.info1.5 KB0.0 KB1.5 KB0.0 KB/s1.5 KB23:54:03
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:48:35
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 8346.4 KB164.0 KB510.3 KB0.0 KB/s3.7 KB191:06:57
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1206.168.34.48 1 00.0 KB 0 0 000:00:36
2112.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
3206.168.34.45 1 00.0 KB 0 0 000:00:42
4206.168.34.65 1 00.0 KB 0 0 000:00:42
5heartfelt.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
6azpdcs85.stretchoid.com 1 00.0 KB 0 0 000:00:09
7mail.gegeweb.eu 288 00.0 KB 0 0 000:02:07
8ingenious.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
9101.36.107.65 3 00.0 KB 0 0 000:00:14
10206.168.34.67 1 00.0 KB 0 0 000:00:01
11glamorous.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
12205.210.31.244 1 00.0 KB 0 0 000:00:10
13206.168.34.77 1 00.0 KB 0 0 000:00:35
14generative.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
15206.168.34.85 1 00.0 KB 0 0 000:00:30
16206.168.34.36 1 00.0 KB 0 0 000:00:30
17206.168.34.75 1 00.0 KB 0 0 000:00:31
18135.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
19intuitive.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
20205.210.31.5 1 00.0 KB 0 0 000:00:11
TOTAL: 20 309 00.0 KB 0 0 000:07:11

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:04
2*.gegeweb.eu 288 00.0 KB 0 0 000:02:07
3*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
4unresolved 13 00.0 KB 0 0 000:04:47
5*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
6*.stretchoid.com 1 00.0 KB 0 0 000:00:09
TOTAL: 6 309 00.0 KB 0 0 000:07:11

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 4.594 3.898 1.61800:02:07
206.168.34.45 0.027 0.004 0.00000:00:42
206.168.34.65 0.008 0.023 0.00000:00:42
206.168.34.48 0.025 0.004 0.00000:00:36
206.168.34.77 0.036 0.022 0.00000:00:35
206.168.34.75 0.045 0.020 0.00000:00:31
206.168.34.36 0.037 0.009 0.00000:00:30
206.168.34.85 0.033 0.020 0.00000:00:30
101.36.107.65 0.072 0.063 0.00000:00:14
205.210.31.5 0.005 0.019 0.00000:00:11
205.210.31.244 0.027 0.023 0.00000:00:10
azpdcs85.stretchoid.com 0.011 0.011 0.00000:00:09
intuitive.monitoring.internet-measurement.com 0.044 0.028 0.00000:00:03
135.211.203.35.bc.googleusercontent.com 0.069 0.013 0.00000:00:01
206.168.34.67 0.020 0.008 0.00000:00:01
112.150.216.162.bc.googleusercontent.com 0.025 0.017 0.00000:00:00
generative.monitoring.internet-measurement.com 0.044 0.020 0.00000:00:00
heartfelt.monitoring.internet-measurement.com 0.018 0.009 0.00000:00:00
glamorous.monitoring.internet-measurement.com 0.034 0.021 0.00000:00:00
TOTAL: 19 5.174 4.232 1.61800:07:11

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
112.150.216.162.bc.googleusercontent.com 4
135.211.203.35.bc.googleusercontent.com 4
101.36.107.65 2
206.168.34.67 1
TOTAL: 4 11

NNRP unrecognized commands (by command):

CommandCount
Accept-Encoding: gzip 2
User-Agent: Expanse, a Palo Alto Network... 2
GET / HTTP/1.1 2
Host: 45.13.105.36:563 2
EHLO www.censys.io 1
À#024 1
#026#003#001#001#027#001 1
TOTAL: 7 11