Daily Usenet report for news.niel.me

May 16 04:15:02 -- May 17 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 16 19:58:37 rpi-studio innd: filter: No Cancel-Key[sha1:pyEvUI+D225YB1rp8B28iosRpRA=] matches Cancel-Lock[sha1:WnvR915iWdljy44n7Nb4UKAgP54=] target=<68277c4a$0$16850$426a74cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2111 26.6%368.3 KB 29.7%
innd 2078 26.1%382.8 KB 30.8%
nnrpd 1914 24.1%209.0 KB 16.8%
innfeed 1845 23.2%281.4 KB 22.7%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 7950 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 9073 58.0%
Negative hits 4489 28.7%
Do not exist 2091 13.4%
Cache misses 2 0.0%
TOTAL: 4 15655 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.003 0.0%3 1.000 1.000 1.000
article cancel00:00:00.000 0.0%3 0.000 0.000 0.000
article cleanup00:00:00.043 0.0%2103 0.000 0.020 0.200
article logging00:00:00.162 0.0%2103 0.000 0.077 0.500
article parse00:00:00.432 0.0%5955 0.000 0.073 0.500
article write00:00:00.847 0.0%1601 0.000 0.529 1.500
artlog/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%3 0.000 0.333 1.000
data move00:00:00.159 0.0%19647 0.000 0.008 0.036
hisgrep/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%3 0.000 0.000 0.000
hisgrep/perl00:00:00.002 0.0%4 0.000 0.500 1.000
hishave/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%3 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.266 0.0%15756 0.000 0.017 0.074
history sync00:00:00.058 0.0%405 0.000 0.143 1.000
history write00:00:00.394 0.0%2102 0.000 0.187 0.636
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:56.180100.0%20368 1199.570 4244.706 23078.538
nntp read00:00:00.564 0.0%19525 0.000 0.029 0.094
overview write00:00:00.580 0.0%1601 0.000 0.362 4.000
perl filter00:00:07.259 0.0%2102 1.000 3.453 11.667
python filter00:00:00.013 0.0%2102 0.000 0.006 0.111
site send00:00:00.531 0.0%3283 0.000 0.162 0.727
TOTAL: 24:01:15.43624:01:07.494100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.014 0.0%1596 0.000 0.009 0.167
article prepare00:00:00.006 0.0%832 0.000 0.007 0.250
article read00:00:00.045 0.0%197 0.000 0.228 8.000
backlog stats00:00:00.143 0.0%26422 0.000 0.005 0.024
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.372 0.0%12783 0.000 0.029 0.125
data write00:00:00.708 0.0%11526 0.000 0.061 0.152
idle23:50:41.922100.0%26422 1358.698 3248.881 7693.205
status file00:00:00.597 0.0%245 0.000 2.437 86.000
TOTAL: 23:50:47.97023:50:43.807100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:22.087 36.4%1604 9.400 51.176 9194.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.244 0.1%3908 0.000 0.062 1.000
readart00:00:00.604 0.3%11903 0.050 0.051 0.197
TOTAL: 00:03:45.20500:01:22.935 36.8%----

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.nntp4.net 1 2062 811 772 479 39%23:59:57
2feed-out.gegeweb.org 2 1582 462 1119 1 29%23:59:23
3i2pn.org 1 1581 140 1439 2 8%22:43:01
4news.glou.org 4 1219 82 1117 20 6%23:52:06
5usenet.pasdenom.info 9 1266 60 1206 0 4%37:10:16
6gegeweb-out.news.tnetconsulting.net 1 426 26 400 0 6%10:43:28
7news.samoylyk.net 2 3053 7 3046 0 0%42:53:16
8nntp.terraraq.uk 3 475 1 474 0 0%10:42:05
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 48 11664 1589 9573 502 13%196:03:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net4.9 MB0.0 KB4.5 MB9.4 MB 52%7.4 KB
2feed-out.gegeweb.org1.5 MB6.3 KB6.3 KB1.5 MB 99%3.4 KB
3news.samoylyk.net1.0 MB0.0 KB0.0 KB1.0 MB100%153.0 KB
4i2pn.org293.9 KB0.0 KB2.9 KB296.8 KB 99%2.1 KB
5news.glou.org261.3 KB0.0 KB60.5 KB321.8 KB 81%3.2 KB
6usenet.pasdenom.info164.6 KB0.0 KB0.0 KB164.6 KB100%2.7 KB
7gegeweb-out.news.tnetconsulting.net109.4 KB0.0 KB0.0 KB109.4 KB100%4.2 KB
8nntp.terraraq.uk1.9 KB0.0 KB0.0 KB1.9 KB100%1.9 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 98.3 MB6.3 KB4.6 MB12.8 MB 64%6.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 16 04:15:02 - 04:59:59 28 1.7% 0.01294.9 KB 3.4% 0.11
May 16 05:00:00 - 05:59:59 26 1.6% 0.0180.5 KB 0.9% 0.02
May 16 06:00:00 - 06:59:59 32 2.0% 0.0183.6 KB 1.0% 0.02
May 16 07:00:00 - 07:59:59 38 2.4% 0.01340.3 KB 4.0% 0.09
May 16 08:00:00 - 08:59:59 33 2.1% 0.01103.4 KB 1.2% 0.03
May 16 09:00:00 - 09:59:59 53 3.3% 0.01406.2 KB 4.7% 0.11
May 16 10:00:00 - 10:59:59 40 2.5% 0.01130.0 KB 1.5% 0.04
May 16 11:00:00 - 11:59:59 45 2.8% 0.01325.8 KB 3.8% 0.09
May 16 12:00:00 - 12:59:59 60 3.7% 0.02284.0 KB 3.3% 0.08
May 16 13:00:00 - 13:59:59 72 4.5% 0.02255.0 KB 3.0% 0.07
May 16 14:00:00 - 14:59:59 97 6.1% 0.03390.2 KB 4.5% 0.11
May 16 15:00:00 - 15:59:59 85 5.3% 0.02411.7 KB 4.8% 0.11
May 16 16:00:00 - 16:59:59 109 6.8% 0.03337.9 KB 3.9% 0.09
May 16 17:00:00 - 17:59:59 126 7.9% 0.04890.4 KB 10.4% 0.25
May 16 18:00:00 - 18:59:59 76 4.7% 0.02357.5 KB 4.2% 0.10
May 16 19:00:00 - 19:59:59 72 4.5% 0.02290.9 KB 3.4% 0.08
May 16 20:00:00 - 20:59:59 99 6.2% 0.03470.0 KB 5.5% 0.13
May 16 21:00:00 - 21:59:59 92 5.7% 0.03277.2 KB 3.2% 0.08
May 16 22:00:00 - 22:59:59 63 3.9% 0.021.2 MB 14.1% 0.34
May 16 23:00:00 - 23:59:59 72 4.5% 0.02493.8 KB 5.7% 0.14
May 17 00:00:00 - 00:59:59 88 5.5% 0.02302.8 KB 3.5% 0.08
May 17 01:00:00 - 01:59:59 74 4.6% 0.02205.0 KB 2.4% 0.06
May 17 02:00:00 - 02:59:59 49 3.1% 0.01148.1 KB 1.7% 0.04
May 17 03:00:00 - 03:59:59 58 3.6% 0.02436.4 KB 5.1% 0.12
May 17 04:00:00 - 04:15:01 15 0.9% 0.0269.4 KB 0.8% 0.08
TOTAL: 23:59:59 1602 100.0% 0.028.4 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 479 370 0 0 0 0 0 0 109
2news.glou.org 20 1 0 0 0 0 0 0 19
3i2pn.org 2 0 0 0 0 0 0 0 2
4gegeweb-out.news.tnetconsulting.net 1 0 0 0 0 0 0 0 1
5feed-out.gegeweb.org 1 0 0 1 0 0 0 0 0
TOTAL: 5 503 371 0 1 0 0 0 0 131

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 275
linux.kernel.git 91
alt.slack 2
comp.lang.go 1
soc.culture.iran 1
news.test 1
TOTAL: 6 371

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 93
Bad path (news.giganews.com.POSTED) 36
EMP (md5) 1
No Cancel-Key matches Cancel-Lock. target=<68277c4a$0$16850$426a74cc@news.free.fr> 1
TOTAL: 4 131

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 2282 25 1545 18 0 1 1%23:59:39
2i2pn.org 2139 19 1414 1 0 0 0%23:59:56
3news.samoylyk.net 2934 15 1460 119 0 5 0%23:59:56
4news.gegeweb.org 1208 12 1132 0 0 0 0%23:57:58
5news.pasdenom.info 1282 0 1193 0 0 0 0%23:54:47
6news.nntp4.net 876 0 769 0 0 0 0%23:18:05
7nntp.terraraq.uk 1086 0 1017 0 0 0 0%23:45:45
8news.aioe.org 0 0 0 0 0 1309 0%23:59:59
TOTAL: 8 11807 71 8530 138 0 1315 0%190:56:05
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net174.3 KB153.1 KB327.4 KB0.0 KB/s7.6 KB23:59:39
2i2pn.org59.9 KB4.5 KB64.4 KB0.0 KB/s3.2 KB23:59:56
3news.samoylyk.net58.6 KB685.2 KB743.8 KB0.0 KB/s5.6 KB23:59:56
4news.gegeweb.org31.5 KB0.0 KB31.5 KB0.0 KB/s2.6 KB23:57:58
5news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:47
6news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:18:05
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:45:45
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
TOTAL: 8324.3 KB842.8 KB1.1 MB0.0 KB/s5.6 KB190:56:05
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 4 98280.2 KB 4 0 000:00:34
TOTAL: 1 4 98280.2 KB 4 0 000:03:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 4 98280.2 KB 4 0 000:00:34
2*.stretchoid.com 2 00.0 KB 0 0 000:00:10
3*.probe.onyphe.net 2 00.0 KB 0 0 000:00:06
4*.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
5*.nycmny.fios.verizon.net 1 00.0 KB 0 0 000:00:12
6*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
7? 5 00.0 KB 0 0 000:00:10
8unresolved 6 00.0 KB 0 0 000:00:17
9*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:10
10*.gegeweb.eu 288 00.0 KB 0 0 000:02:00
TOTAL: 10 316 98280.2 KB 4 0 000:03:44

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.741 4.506 1.85700:02:00
syn-066-061-096-239.res.spectrum.com 0.103 0.150 0.00000:00:34
pool-100-38-239-226.nycmny.fios.verizon.net 0.278 0.715 0.00000:00:12
240e:108:4aa1:fffe::2 0.211 0.131 0.00000:00:10
azpdcsoltzol.stretchoid.com 0.028 0.021 0.00000:00:09
206.168.34.218 0.014 0.014 0.00000:00:08
205.210.31.206 0.028 0.020 0.00000:00:04
famous.monitoring.internet-measurement.com 0.028 0.014 0.00000:00:04
dynamic.monitoring.internet-measurement.com 0.044 0.016 0.00000:00:03
brewer.probe.onyphe.net 0.038 0.017 0.00000:00:03
gibson.probe.onyphe.net 0.078 0.012 0.00000:00:03
198.235.24.217 0.027 0.023 0.00000:00:02
enthralling.monitoring.internet-measurement.com 0.036 0.016 0.00000:00:01
88.214.25.124 0.031 0.020 0.00000:00:01
90.150.216.162.bc.googleusercontent.com 0.057 0.022 0.00000:00:00
147.185.132.209 0.032 0.008 0.00000:00:00
198.235.24.181 0.020 0.020 0.00000:00:00
45-79-207-252.ip.linodeusercontent.com 0.036 0.028 0.00000:00:00
azpdcgu78oze.stretchoid.com 0.029 0.025 0.00000:00:00
beneficial.monitoring.internet-measurement.com 0.021 0.008 0.00000:00:00
TOTAL: 22 5.929 5.823 1.85700:03:44

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
240e:108:4aa1:fffe::2 5
dynamic.monitoring.internet-measurement.com 1
willing.monitoring.internet-measurement.com 1
198.235.24.181 1
88.214.25.124 1
206.168.34.218 1
pool-100-38-239-226.nycmny.fios.verizon.net 1
45-79-207-252.ip.linodeusercontent.com 1
205.210.31.206 1
gibson.probe.onyphe.net 1
azpdcsoltzol.stretchoid.com 1
enthralling.monitoring.internet-measurement.com 1
beneficial.monitoring.internet-measurement.com 1
198.235.24.217 1
90.150.216.162.bc.googleusercontent.com 1
famous.monitoring.internet-measurement.com 1
147.185.132.209 1
brewer.probe.onyphe.net 1
azpdcgu78oze.stretchoid.com 1
TOTAL: 21 312

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
147.185.132.209 4
90.150.216.162.bc.googleusercontent.com 4
88.214.25.124 1
206.168.34.218 1
azpdcgu78oze.stretchoid.com 1
TOTAL: 5 11

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
88.214.25.124 1 1
TOTAL: 1 1 4

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 98100.0%
TOTAL: 1 98100.0%

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

NewsgroupCount
1grisbi.bugsreports 86
2grisbi.test 12
TOTAL: 2 98
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me