Daily Usenet report for news.niel.me

May 19 04:15:02 -- May 20 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 19 21:09:34 rpi-studio innd: filter: No Cancel-Key[sha1:6abtUU0b/OPLy4aFGz0yElwXX+8=] matches Cancel-Lock[sha1:YWjBn5CpwTY7G6Ag3nWw2D+AKKM=] target=<682b6373$0$16845$426a74cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 3016 31.9%353.3 KB 24.3%
inn 2526 26.8%451.0 KB 31.1%
innd 2102 22.3%388.9 KB 26.8%
innfeed 1796 19.0%258.5 KB 17.8%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 9442 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 11830 57.0%
Negative hits 6438 31.0%
Do not exist 2494 12.0%
Cache misses 2 0.0%
TOTAL: 4 20764 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.011 0.0%11 0.000 1.000 2.000
article cancel00:00:00.001 0.0%11 0.000 0.091 1.000
article cleanup00:00:00.058 0.0%2502 0.000 0.023 0.300
article logging00:00:00.187 0.0%2503 0.000 0.075 0.250
article parse00:00:00.418 0.0%6621 0.000 0.063 0.333
article write00:00:01.013 0.0%2027 0.000 0.500 1.000
artlog/artcncl00:00:00.001 0.0%11 0.000 0.091 1.000
artlog/artcncl/perl00:00:00.002 0.0%11 0.000 0.182 1.000
data move00:00:00.141 0.0%23942 0.000 0.006 0.026
hisgrep/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
hisgrep/perl00:00:00.002 0.0%17 0.000 0.118 1.000
hishave/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.335 0.0%20809 0.000 0.016 0.051
history sync00:00:00.050 0.0%393 0.000 0.127 0.667
history write00:00:00.444 0.0%2501 0.000 0.178 1.000
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:44.813100.0%25834 1076.661 3346.164 33348.500
nntp read00:00:00.709 0.0%24613 0.000 0.029 0.071
overview write00:00:00.670 0.0%2027 0.000 0.331 4.750
perl filter00:00:13.268 0.0%2501 1.875 5.305 19.000
python filter00:00:00.018 0.0%2501 0.000 0.007 0.143
site send00:00:00.688 0.0%4142 0.000 0.166 0.500
TOTAL: 24:01:14.66724:01:02.829100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%2091 0.000 0.009 0.500
article prepare00:00:00.000 0.0%180 0.000 0.000 0.000
article read00:00:00.017 0.0%45 0.000 0.378 8.000
backlog stats00:00:00.133 0.0%28787 0.000 0.005 0.016
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.489 0.0%15557 0.000 0.031 0.125
data write00:00:00.788 0.0%13430 0.013 0.059 0.135
idle23:58:05.625100.0%28787 1195.707 2997.382 9231.877
status file00:00:06.501 0.0%248 1.000 26.214 91.000
TOTAL: 23:58:19.04923:58:13.572100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:20:58.865 95.6%17240 0.000 281.837 25851.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:13.085 0.3%65706 0.000 0.199 16.043
readart00:00:02.672 0.1%15115 0.000 0.177 1.000
TOTAL: 01:24:43.87801:21:14.622 95.9%----

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 2268 765 1068 435 33%21:58:45
2feed-out.gegeweb.org 3 2019 531 1488 0 26%23:57:47
3i2pn.org 1 3577 370 3196 11 10%45:58:40
4news.samoylyk.net 6 2415 256 2156 3 10%29:35:46
5usenet.pasdenom.info 8 971 31 940 0 3%24:47:05
6gegeweb-out.news.tnetconsulting.net 1 384 28 355 1 7%08:51:46
7news.glou.org 2 113 3 110 0 2%02:25:35
8localhost 25 0 0 0 0 0%00:00:00
9nntp.terraraq.uk 2 242 0 242 0 0%06:27:09
TOTAL: 9 49 11989 1984 9555 450 16%164:02:33
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net3.9 MB0.0 KB3.6 MB7.5 MB 52%6.4 KB
2news.samoylyk.net2.8 MB3.9 KB6.7 KB2.8 MB 99%11.0 KB
3feed-out.gegeweb.org1.5 MB0.0 KB0.0 KB1.5 MB100%3.0 KB
4i2pn.org794.5 KB0.0 KB23.0 KB817.5 KB 97%2.1 KB
5gegeweb-out.news.tnetconsulting.net147.6 KB0.0 KB3.0 KB150.5 KB 98%5.2 KB
6usenet.pasdenom.info71.6 KB0.0 KB0.0 KB71.6 KB100%2.3 KB
7news.glou.org11.5 KB0.0 KB0.0 KB11.5 KB100%3.8 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 99.3 MB3.9 KB3.6 MB12.9 MB 71%5.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 19 04:15:02 - 04:59:59 62 3.1% 0.02289.4 KB 3.0% 0.11
May 19 05:00:00 - 05:59:59 40 2.0% 0.01110.5 KB 1.2% 0.03
May 19 06:00:00 - 06:59:59 39 1.9% 0.01103.3 KB 1.1% 0.03
May 19 07:00:00 - 07:59:59 28 1.4% 0.0170.9 KB 0.7% 0.02
May 19 08:00:00 - 08:59:59 34 1.7% 0.0187.5 KB 0.9% 0.02
May 19 09:00:00 - 09:59:59 68 3.4% 0.02306.6 KB 3.2% 0.09
May 19 10:00:00 - 10:59:59 87 4.3% 0.02477.0 KB 5.0% 0.13
May 19 11:00:00 - 11:59:59 82 4.0% 0.02230.5 KB 2.4% 0.06
May 19 12:00:00 - 12:59:59 111 5.5% 0.03750.0 KB 7.8% 0.21
May 19 13:00:00 - 13:59:59 110 5.4% 0.03479.8 KB 5.0% 0.13
May 19 14:00:00 - 14:59:59 92 4.5% 0.03309.1 KB 3.2% 0.09
May 19 15:00:00 - 15:59:59 122 6.0% 0.03744.3 KB 7.8% 0.21
May 19 16:00:00 - 16:59:59 95 4.7% 0.03819.3 KB 8.5% 0.23
May 19 17:00:00 - 17:59:59 77 3.8% 0.02245.7 KB 2.6% 0.07
May 19 18:00:00 - 18:59:59 108 5.3% 0.03517.9 KB 5.4% 0.14
May 19 19:00:00 - 19:59:59 114 5.6% 0.03668.6 KB 7.0% 0.19
May 19 20:00:00 - 20:59:59 116 5.7% 0.03416.8 KB 4.3% 0.12
May 19 21:00:00 - 21:59:59 128 6.3% 0.04905.8 KB 9.4% 0.25
May 19 22:00:00 - 22:59:59 109 5.4% 0.03430.6 KB 4.5% 0.12
May 19 23:00:00 - 23:59:59 88 4.3% 0.02291.0 KB 3.0% 0.08
May 20 00:00:00 - 00:59:59 79 3.9% 0.02374.3 KB 3.9% 0.10
May 20 01:00:00 - 01:59:59 79 3.9% 0.02464.5 KB 4.8% 0.13
May 20 02:00:00 - 02:59:59 84 4.1% 0.02243.8 KB 2.5% 0.07
May 20 03:00:00 - 03:59:59 54 2.7% 0.01163.4 KB 1.7% 0.05
May 20 04:00:00 - 04:15:01 22 1.1% 0.0287.5 KB 0.9% 0.10
TOTAL: 23:59:59 2028 100.0% 0.029.4 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 452 330 0 0 0 0 0 0 122
2news.glou.org 13 0 0 0 0 0 0 0 13
3i2pn.org 5 0 0 0 0 0 0 0 5
4news.samoylyk.net 3 0 0 1 0 0 0 0 2
5gegeweb-out.news.tnetconsulting.net 2 0 0 0 0 0 0 0 2
6feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 6 476 330 0 1 0 0 0 0 145

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 261
linux.kernel.git 68
news.test 1
TOTAL: 3 330

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 80
Bad path (news.giganews.com.POSTED) 58
Cancel of non-existing ID <100fdgv$1lb27$1@dont-email.me> 2
Cancel of non-existing ID <m8vvoqFog27U1@mid.individual.net> 1
Cancel of <100f43p$1jd2g$1@dont-email.me> without Cancel-Key 1
Cancel of <100f5r7$afd$4@news.chmurka.net> without Cancel-Key 1
No Cancel-Key matches Cancel-Lock. target=<682b6373$0$16845$426a74cc@news.free.fr> 1
TOTAL: 7 144

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 1
TOTAL: 1 1
TOTAL: 1 1

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 2866 18 1991 9 0 14 0%23:58:43
2news.gegeweb.org 1655 12 1494 0 0 0 0%23:59:12
3i2pn.org 2646 2 1789 2 0 15 0%23:59:56
4news.pasdenom.info 1672 2 1558 0 0 0 0%23:55:06
5news.samoylyk.net 2119 0 1833 0 0 35 0%23:56:20
6news.nntp4.net 1266 0 1173 0 0 0 0%23:46:58
7news.aioe.org 0 0 0 0 0 1688 0%23:59:59
8nntp.terraraq.uk 1427 0 1312 0 0 0 0%23:49:52
TOTAL: 8 13651 34 11150 11 0 1752 0%191:26:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net66.4 KB20.6 KB87.0 KB0.0 KB/s3.2 KB23:58:43
2news.gegeweb.org28.3 KB0.0 KB28.3 KB0.0 KB/s2.4 KB23:59:12
3i2pn.org16.4 KB39.7 KB56.1 KB0.0 KB/s14.0 KB23:59:56
4news.pasdenom.info5.4 KB0.0 KB5.4 KB0.0 KB/s2.7 KB23:55:06
5news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:20
6news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:46:58
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
8nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:49:52
TOTAL: 8116.4 KB60.3 KB176.7 KB0.0 KB/s3.9 KB191:26:06
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 177 1511567.1 MB 47 0 001:20:44
TOTAL: 1 177 1511567.1 MB 47 0 001:24:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 177 1511567.1 MB 47 0 001:20:44
2*.ip.linodeusercontent.com 98 00.0 KB 0 0 000:00:28
3unresolved 41 00.0 KB 0 0 000:01:18
4*.stretchoid.com 1 00.0 KB 0 0 000:00:09
5*.gegeweb.eu 288 00.0 KB 0 0 000:01:56
6*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
7*.scan.bufferover.run 1 00.0 KB 0 0 000:00:00
8*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 8 608 1511567.1 MB 47 0 001:24:42

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
syn-066-061-096-239.res.spectrum.com 6.734 10.349 0.00001:20:44
mail.gegeweb.eu 4.978 4.426 1.90800:01:56
172-105-246-139.ip.linodeusercontent.com 2.321 1.222 0.00000:00:28
206.168.34.196 0.220 0.099 0.00000:00:18
206.168.34.84 0.216 0.118 0.00000:00:13
206.168.34.53 0.198 0.108 0.00000:00:11
azpdwsb51uo6.stretchoid.com 0.020 0.028 0.00000:00:09
206.168.34.76 0.218 0.119 0.00000:00:09
206.168.34.117 0.098 0.071 0.00000:00:06
206.168.34.62 0.037 0.018 0.00000:00:06
206.168.34.66 0.257 0.092 0.00000:00:04
91.238.181.96 0.019 0.009 0.00000:00:03
trustful.monitoring.internet-measurement.com 0.010 0.013 0.00000:00:01
198.235.24.202 0.026 0.018 0.00000:00:01
205.210.31.86 0.019 0.005 0.00000:00:01
149.210.203.35.bc.googleusercontent.com 0.048 0.028 0.00000:00:01
vilnius.scan.bufferover.run 0.075 0.012 0.00000:00:00
45-79-211-97.ip.linodeusercontent.com 0.008 0.015 0.00000:00:00
147.185.132.224 0.056 0.016 0.00000:00:00
20.64.105.91 0.026 0.026 0.00000:00:00
TOTAL: 21 15.608 16.812 1.90801:24:42

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
172-105-246-139.ip.linodeusercontent.com 97
206.168.34.84 7
206.168.34.196 6
206.168.34.76 6
206.168.34.66 6
206.168.34.53 6
206.168.34.117 3
205.210.31.86 1
vilnius.scan.bufferover.run 1
91.238.181.96 1
azpdwsb51uo6.stretchoid.com 1
198.235.24.135 1
45-79-211-97.ip.linodeusercontent.com 1
trustful.monitoring.internet-measurement.com 1
149.210.203.35.bc.googleusercontent.com 1
198.235.24.202 1
147.185.132.224 1
20.64.105.91 1
206.168.34.62 1
TOTAL: 20 431

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
vilnius.scan.bufferover.run 5
147.185.132.224 4
149.210.203.35.bc.googleusercontent.com 4
206.168.34.196 3
206.168.34.62 1
20.64.105.91 1
206.168.34.76 1
206.168.34.84 1
206.168.34.53 1
206.168.34.66 1
TOTAL: 10 22

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 6
Host: 45.13.105.36:563 4
GET / HTTP/1.1 4
Accept-Encoding: gzip 3
User-Agent: Expanse, a Palo Alto Network... 2
Accept: */* 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
MGLNDD_45.13.105.36_119 1
TOTAL: 8 22

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 13859 91.7%
2local 1256 8.3%
TOTAL: 2 15115100.0%

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

NewsgroupCount
1grisbi.test 4167
2grisbi.bugsreports 4119
3grisbi.user.french 3336
4grisbi.devel 1907
5local.test 1132
6grisbi.cvs 192
7grisbi.user 134
8local.gegeweb.support 124
9grisbi.admin 4
TOTAL: 9 15115
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me