Daily Usenet report for news.niel.me

May 12 04:15:01 -- May 13 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 12 20:36:34 rpi-studio innd: filter: No Cancel-Key[sha1:b9zT5P6JG+5Z2FUmXC1a/cjkYQs=] matches Cancel-Lock[sha1:jn4x/0SU4DySbRDYZS0KbIlMeJA=] target=<68223dfa$0$12917$426a34cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2535 29.9%445.1 KB 33.9%
nnrpd 2067 24.4%231.8 KB 17.7%
innd 2035 24.0%367.6 KB 28.0%
innfeed 1827 21.6%266.9 KB 20.3%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 8466 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 11436 43.8%
Negative hits 6312 24.2%
Cache misses 5851 22.4%
Do not exist 2512 9.6%
TOTAL: 4 26111 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.007 0.0%7 0.000 1.000 2.000
article cancel00:00:00.000 0.0%8 0.000 0.000 0.000
article cleanup00:00:00.061 0.0%2522 0.000 0.024 0.200
article logging00:00:00.173 0.0%2522 0.000 0.069 0.300
article parse00:00:00.439 0.0%6290 0.000 0.070 0.200
article write00:00:00.975 0.0%1994 0.000 0.489 1.400
artlog/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
data move00:00:00.117 0.0%23980 0.000 0.005 0.025
hisgrep/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%11 0.000 0.091 0.333
hishave/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.001 0.0%7 0.000 0.143 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.485 0.0%26167 0.000 0.019 0.065
history sync00:00:00.047 0.0%404 0.000 0.116 1.000
history write00:00:00.461 0.0%2522 0.000 0.183 0.833
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle24:00:46.078100.0%25333 383.265 3412.390 13973.140
nntp read00:00:00.763 0.0%24457 0.000 0.031 0.076
overview write00:00:00.680 0.0%1994 0.000 0.341 2.800
perl filter00:00:08.403 0.0%2522 1.652 3.332 8.625
python filter00:00:00.009 0.0%2522 0.000 0.004 0.100
site send00:00:00.892 0.0%4085 0.000 0.218 0.500
TOTAL: 24:01:08.62924:00:59.592100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.058 0.0%8712 0.000 0.007 0.143
article prepare00:00:00.001 0.0%428 0.000 0.002 0.125
article read00:00:00.021 0.0%103 0.000 0.204 3.000
backlog stats00:00:00.173 0.0%29800 0.000 0.006 0.026
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.463 0.0%15890 0.000 0.029 0.095
data write00:00:00.745 0.0%14031 0.000 0.053 0.143
idle23:58:32.636100.0%29800 178.146 2896.397 10027.783
status file00:00:00.579 0.0%268 0.000 2.160 7.000
TOTAL: 23:58:46.75523:58:34.676100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:33.768 50.1%1736 9.200 88.576 2260.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.158 0.1%4297 0.000 0.037 1.000
readart00:00:00.034 0.0%205 0.000 0.166 0.250
TOTAL: 00:05:06.81400:02:33.960 50.2%----

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 2497 900 1149 448 36%24:56:22
2feed-out.gegeweb.org 3 1951 643 1308 0 32%23:58:23
3i2pn.org 1 1825 154 1667 4 8%23:03:59
4news.glou.org 2 1563 105 1441 17 6%25:48:54
5gegeweb-out.news.tnetconsulting.net 2 1368 87 1280 1 6%23:56:01
6nntp.terraraq.uk 2 275 12 263 0 4%05:45:51
7localhost 25 0 0 0 0 0%00:00:00
8news.samoylyk.net 1 0 0 0 0 0%00:00:00
9usenet.pasdenom.info 8 1120 0 1120 0 0%26:16:27
TOTAL: 9 45 10599 1901 8228 470 17%153:45:57
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net4.2 MB0.0 KB3.8 MB7.9 MB 52%6.0 KB
2feed-out.gegeweb.org2.4 MB0.0 KB0.0 KB2.4 MB100%3.8 KB
3gegeweb-out.news.tnetconsulting.net409.2 KB0.0 KB2.8 KB412.1 KB 99%4.7 KB
4news.glou.org394.1 KB0.0 KB59.9 KB454.0 KB 86%3.7 KB
5i2pn.org364.2 KB0.0 KB7.1 KB371.3 KB 98%2.3 KB
6nntp.terraraq.uk25.0 KB0.0 KB0.0 KB25.0 KB100%2.1 KB
7localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
8news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9usenet.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 97.7 MB0.0 KB3.8 MB11.5 MB 66%5.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 12 04:15:01 - 04:59:59 35 1.8% 0.01202.2 KB 2.4% 0.07
May 12 05:00:00 - 05:59:59 34 1.7% 0.01243.5 KB 2.9% 0.07
May 12 06:00:00 - 06:59:59 38 1.9% 0.01199.5 KB 2.4% 0.06
May 12 07:00:00 - 07:59:59 50 2.5% 0.01158.5 KB 1.9% 0.04
May 12 08:00:00 - 08:59:59 54 2.7% 0.01164.3 KB 2.0% 0.05
May 12 09:00:00 - 09:59:59 80 4.0% 0.02260.8 KB 3.1% 0.07
May 12 10:00:00 - 10:59:59 66 3.3% 0.02225.3 KB 2.7% 0.06
May 12 11:00:00 - 11:59:59 67 3.4% 0.02313.6 KB 3.7% 0.09
May 12 12:00:00 - 12:59:59 77 3.9% 0.02251.2 KB 3.0% 0.07
May 12 13:00:00 - 13:59:59 77 3.9% 0.02314.0 KB 3.7% 0.09
May 12 14:00:00 - 14:59:59 63 3.2% 0.02255.8 KB 3.0% 0.07
May 12 15:00:00 - 15:59:59 86 4.3% 0.02271.8 KB 3.2% 0.08
May 12 16:00:00 - 16:59:59 140 7.0% 0.04474.0 KB 5.6% 0.13
May 12 17:00:00 - 17:59:59 167 8.4% 0.05614.1 KB 7.3% 0.17
May 12 18:00:00 - 18:59:59 114 5.7% 0.03417.1 KB 5.0% 0.12
May 12 19:00:00 - 19:59:59 129 6.5% 0.04469.8 KB 5.6% 0.13
May 12 20:00:00 - 20:59:59 150 7.5% 0.04810.7 KB 9.6% 0.23
May 12 21:00:00 - 21:59:59 84 4.2% 0.02399.9 KB 4.8% 0.11
May 12 22:00:00 - 22:59:59 88 4.4% 0.02319.5 KB 3.8% 0.09
May 12 23:00:00 - 23:59:59 83 4.2% 0.02505.5 KB 6.0% 0.14
May 13 00:00:00 - 00:59:59 101 5.1% 0.03518.9 KB 6.2% 0.14
May 13 01:00:00 - 01:59:59 67 3.4% 0.02236.2 KB 2.8% 0.07
May 13 02:00:00 - 02:59:59 86 4.3% 0.02332.9 KB 4.0% 0.09
May 13 03:00:00 - 03:59:59 48 2.4% 0.01290.7 KB 3.5% 0.08
May 13 04:00:00 - 04:15:01 7 0.4% 0.01169.0 KB 2.0% 0.19
TOTAL: 24:00:00 1991 100.0% 0.028.2 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 496 362 0 0 0 0 0 0 134
2news.glou.org 21 0 0 0 0 0 0 0 21
3i2pn.org 6 0 0 0 0 0 0 0 6
4nntp.terraraq.uk 3 0 0 0 0 0 0 0 3
5gegeweb-out.news.tnetconsulting.net 3 0 0 0 0 0 0 0 3
TOTAL: 5 529 362 0 0 0 0 0 0 167

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 272
linux.kernel.git 85
soc.culture.iran 2
soc.culture.russia 1
alt.slack 1
news.test 1
TOTAL: 6 362

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 91
Bad path (news.giganews.com.POSTED) 71
Cancels abusifs 2
No Cancel-Key matches Cancel-Lock. target=<68223dfa$0$12917$426a34cc@news.free.fr> 1
Cancel of <vvs9m8$1a47$1@cabale.usenet-fr.net> without Cancel-Key 1
Cancel of non-existing ID <m8fd46F2bh6U1@mid.individual.net> 1
TOTAL: 6 167

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1446 45 1318 0 0 1 3%23:53:48
2i2pn.org 2602 15 1793 6 0 0 0%23:59:57
3news.tnetconsulting.net 2760 15 1959 12 0 0 0%23:54:53
4news.pasdenom.info 1674 10 1509 3 0 168 0%23:59:45
5news.nntp4.net 1290 0 1106 1 0 0 0%23:37:06
6news.samoylyk.net 7699 0 7514 0 0 946 0%23:59:57
7news.aioe.org 0 0 0 0 0 1625 0%24:00:00
8nntp.terraraq.uk 1310 0 1184 0 0 0 0%23:57:41
TOTAL: 8 18781 85 16383 22 0 2740 0%191:23:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net138.5 KB49.3 KB187.7 KB0.0 KB/s7.0 KB23:54:53
2news.gegeweb.org87.3 KB0.0 KB87.3 KB0.0 KB/s1.9 KB23:53:48
3i2pn.org55.8 KB18.0 KB73.8 KB0.0 KB/s3.5 KB23:59:57
4news.pasdenom.info34.8 KB5.9 KB40.7 KB0.0 KB/s3.1 KB23:59:45
5news.nntp4.net0.0 KB1.7 KB1.7 KB0.0 KB/s1.7 KB23:37:06
6news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:41
TOTAL: 8316.3 KB74.9 KB391.2 KB0.0 KB/s3.7 KB191:23:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 16 205779.7 KB 8 0 000:01:29
TOTAL: 1 16 205779.7 KB 8 0 000:05:06

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 16 205779.7 KB 8 0 000:01:29
2unresolved 16 00.0 KB 0 0 000:00:46
3? 1 00.0 KB 0 0 000:00:02
4*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:07
5*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
6*.ip.linodeusercontent.com 11 00.0 KB 0 0 000:00:05
7*.stretchoid.com 1 00.0 KB 0 0 000:00:00
8*.gegeweb.eu 288 00.0 KB 0 0 000:02:31
TOTAL: 8 339 205779.7 KB 8 0 000:05:06

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.990 4.372 1.89900:02:31
syn-066-061-096-239.res.spectrum.com 0.432 0.303 0.00000:01:29
45.82.78.254 0.083 0.032 0.00000:00:14
45.144.212.212 0.042 0.021 0.00000:00:10
147.185.133.233 0.054 0.025 0.00000:00:08
206.168.34.57 0.025 0.025 0.00000:00:07
194-195-215-162.ip.linodeusercontent.com 0.188 0.104 0.00000:00:04
stable.monitoring.internet-measurement.com 0.036 0.019 0.00000:00:03
valued.monitoring.internet-measurement.com 0.060 0.032 0.00000:00:03
2a06:4882:1000::18 0.025 0.024 0.00000:00:02
194.165.16.162 0.050 0.028 0.00000:00:01
198.235.24.88 0.034 0.017 0.00000:00:01
205.210.31.82 0.028 0.023 0.00000:00:01
172-236-228-115.ip.linodeusercontent.com 0.029 0.013 0.00000:00:01
132.211.203.35.bc.googleusercontent.com 0.050 0.027 0.00000:00:00
excellent.monitoring.internet-measurement.com 0.036 0.020 0.00000:00:00
185.243.96.117 0.101 0.088 0.00000:00:00
azpdegurjqn0.stretchoid.com 0.023 0.023 0.00000:00:00
45.227.254.156 0.023 0.023 0.00000:00:00
dazzling.monitoring.internet-measurement.com 0.018 0.011 0.00000:00:00
TOTAL: 21 6.355 5.255 1.89900:05:06

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
194-195-215-162.ip.linodeusercontent.com 10
185.243.96.117 5
194.165.16.162 2
45.82.78.254 2
azpdegurjqn0.stretchoid.com 1
147.185.133.233 1
2a06:4882:1000::18 1
206.168.34.57 1
stable.monitoring.internet-measurement.com 1
205.210.31.9 1
172-236-228-115.ip.linodeusercontent.com 1
205.210.31.82 1
132.211.203.35.bc.googleusercontent.com 1
willing.monitoring.internet-measurement.com 1
valued.monitoring.internet-measurement.com 1
45.144.212.212 1
45.227.254.156 1
excellent.monitoring.internet-measurement.com 1
198.235.24.88 1
TOTAL: 21 323

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
172-236-228-115.ip.linodeusercontent.com 5
132.211.203.35.bc.googleusercontent.com 4
147.185.133.233 4
185.243.96.117 3
45.227.254.156 1
194.165.16.162 1
206.168.34.57 1
azpdegurjqn0.stretchoid.com 1
TOTAL: 8 20

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
185.243.96.117 3 3
45.227.254.156 1 1
194.165.16.162 1 1
TOTAL: 3 5 8

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 205100.0%
TOTAL: 1 205100.0%

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

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