Daily Usenet report for news.niel.me

Aug 18 04:15:01 -- Aug 19 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 18 15:15:53 rpi-studio innd: filter: No Cancel-Key[sha1:Vis8likuWKY9hMzdiI++COzOGGU= sha256:JAExfZgsUhKvxxA49kaIvUDRWeV9cG0QXwqRTn/VJp0=] matches Cancel-Lock[sha1:kWm+Cb+5lFrZIOey/iqKWJjfeXc= sha256:vSgTo9R61/dnwJA0xNmk9pj5yke62yeFP+2XDPoagEQ=] target=<1s01l8q.zld598a7i25gN%g4fleurot@free.invalid>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2355 27.8%407.6 KB 31.7%
nnrpd 2213 26.1%257.5 KB 20.0%
innd 1990 23.5%335.4 KB 26.1%
innfeed 1916 22.6%286.2 KB 22.2%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8476 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 8386 49.1%
Negative hits 6359 37.2%
Do not exist 2338 13.7%
Cache misses 2 0.0%
TOTAL: 4 17085 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.001 0.0%3 0.000 0.333 1.000
article cancel00:00:00.002 0.0%4 0.000 0.500 2.000
article cleanup00:00:00.046 0.0%2346 0.000 0.020 0.167
article logging00:00:00.172 0.0%2346 0.000 0.073 0.500
article parse00:00:00.425 0.0%6231 0.000 0.068 0.333
article write00:00:01.024 0.0%1831 0.000 0.559 1.750
artlog/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:00:00.111 0.0%19355 0.000 0.006 0.044
hisgrep/artcncl00:00:00.000 0.0%4 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.000 0.0%4 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%4 0.000 0.250 1.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.265 0.0%17155 0.000 0.015 0.055
history sync00:00:00.048 0.0%373 0.000 0.129 1.000
history write00:00:00.437 0.0%2346 0.000 0.186 0.636
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:30.030100.0%21266 1604.701 4064.235 20010.767
nntp read00:00:00.631 0.0%20447 0.000 0.031 0.104
overview write00:00:00.650 0.0%1831 0.000 0.355 3.875
perl filter00:00:13.857 0.0%2346 1.733 5.907 28.500
python filter00:00:00.010 0.0%2346 0.000 0.004 0.200
site send00:00:00.790 0.0%3717 0.000 0.213 0.529
TOTAL: 24:01:06.75324:00:48.500100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.016 0.0%1843 0.000 0.009 0.333
article prepare00:00:00.000 0.0%12 0.000 0.000 0.000
article read00:00:00.006 0.0%3 2.000 2.000 2.000
backlog stats00:00:00.149 0.0%22497 0.000 0.007 0.034
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.292 0.0%11168 0.000 0.026 0.143
data write00:00:00.574 0.0%9417 0.000 0.061 0.154
idle23:56:51.819100.0%22497 1993.638 3832.147 10012.283
status file00:00:07.232 0.0%311 1.000 23.254 83.000
TOTAL: 23:57:05.39323:57:00.088100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:59.961 46.4%1529 10.400 39.216 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.130 0.1%3592 0.000 0.036 1.000
readart00:00:00.000 0.0%1 0.000 0.000 0.000
TOTAL: 00:02:09.20200:01:00.091 46.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
1news.samoylyk.net 2 1789 539 1247 3 30%22:08:46
2feed-out.gegeweb.org 4 1798 488 1310 0 27%23:04:42
3news.nntp4.net 1 1976 369 1176 431 18%19:28:08
4usenet.pasdenom.info 10 779 25 753 1 3%23:22:26
5news.glou.org 3 163 17 131 15 10%05:01:02
6nntp.terraraq.uk 3 156 14 139 3 8%05:01:14
7gegeweb-out.news.tnetconsulting.net 4 277 8 269 0 2%07:46:58
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 52 6938 1460 5025 453 21%105:53:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net2.6 MB0.0 KB6.8 KB2.6 MB 99%5.0 KB
2news.nntp4.net2.1 MB0.0 KB3.8 MB5.9 MB 35%7.6 KB
3feed-out.gegeweb.org1.5 MB0.0 KB0.0 KB1.5 MB100%3.2 KB
4usenet.pasdenom.info56.3 KB0.0 KB1.2 KB57.5 KB 97%2.2 KB
5news.glou.org53.5 KB0.0 KB36.6 KB90.2 KB 59%2.8 KB
6nntp.terraraq.uk29.3 KB0.0 KB6.2 KB35.5 KB 82%2.1 KB
7gegeweb-out.news.tnetconsulting.net17.3 KB0.0 KB0.0 KB17.3 KB100%2.2 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 86.4 MB0.0 KB3.9 MB10.3 MB 62%5.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 18 04:15:01 - 04:59:59 21 1.1% 0.0157.6 KB 0.7% 0.02
Aug 18 05:00:00 - 05:59:59 43 2.3% 0.01112.3 KB 1.4% 0.03
Aug 18 06:00:00 - 06:59:59 34 1.9% 0.01114.1 KB 1.5% 0.03
Aug 18 07:00:00 - 07:59:59 37 2.0% 0.01326.7 KB 4.2% 0.09
Aug 18 08:00:00 - 08:59:59 51 2.8% 0.01369.4 KB 4.7% 0.10
Aug 18 09:00:00 - 09:59:59 108 5.9% 0.03360.8 KB 4.6% 0.10
Aug 18 10:00:00 - 10:59:59 61 3.3% 0.02184.4 KB 2.4% 0.05
Aug 18 11:00:00 - 11:59:59 89 4.9% 0.02328.6 KB 4.2% 0.09
Aug 18 12:00:00 - 12:59:59 65 3.6% 0.02206.4 KB 2.6% 0.06
Aug 18 13:00:00 - 13:59:59 78 4.3% 0.02498.8 KB 6.4% 0.14
Aug 18 14:00:00 - 14:59:59 117 6.4% 0.03443.9 KB 5.7% 0.12
Aug 18 15:00:00 - 15:59:59 103 5.6% 0.03358.5 KB 4.6% 0.10
Aug 18 16:00:00 - 16:59:59 102 5.6% 0.03353.0 KB 4.5% 0.10
Aug 18 17:00:00 - 17:59:59 90 4.9% 0.03658.3 KB 8.4% 0.18
Aug 18 18:00:00 - 18:59:59 102 5.6% 0.03542.6 KB 6.9% 0.15
Aug 18 19:00:00 - 19:59:59 88 4.8% 0.02353.2 KB 4.5% 0.10
Aug 18 20:00:00 - 20:59:59 84 4.6% 0.02267.3 KB 3.4% 0.07
Aug 18 21:00:00 - 21:59:59 96 5.2% 0.03336.0 KB 4.3% 0.09
Aug 18 22:00:00 - 22:59:59 75 4.1% 0.02433.8 KB 5.5% 0.12
Aug 18 23:00:00 - 23:59:59 104 5.7% 0.03426.1 KB 5.4% 0.12
Aug 19 00:00:00 - 00:59:59 80 4.4% 0.02335.9 KB 4.3% 0.09
Aug 19 01:00:00 - 01:59:59 112 6.1% 0.03473.7 KB 6.0% 0.13
Aug 19 02:00:00 - 02:59:59 47 2.6% 0.01133.0 KB 1.7% 0.04
Aug 19 03:00:00 - 03:59:59 32 1.7% 0.01103.0 KB 1.3% 0.03
Aug 19 04:00:00 - 04:15:01 11 0.6% 0.0155.3 KB 0.7% 0.06
TOTAL: 24:00:00 1830 100.0% 0.027.6 MB 100.0% 0.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 476 345 0 0 0 0 0 0 131
2news.glou.org 33 0 0 0 1 0 0 0 32
3nntp.terraraq.uk 4 0 0 0 0 0 0 0 4
4news.samoylyk.net 3 0 0 0 0 0 0 0 3
5usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
6gegeweb-out.news.tnetconsulting.net 1 0 0 0 0 0 0 0 1
TOTAL: 6 518 345 0 0 1 0 0 0 172

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 301
linux.kernel.git 43
comp.lang.go 1
TOTAL: 3 345

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
soc.culture.hawaii 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 129
Bad path (news.giganews.com.POSTED) 41
Cancels abusifs 2
TOTAL: 3 172

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1385 3 1321 0 0 0 0%23:56:00
2news.pasdenom.info 1308 0 1285 0 0 0 0%23:30:37
3news.samoylyk.net 1286 0 1211 0 0 0 0%23:36:27
4i2pn.org 0 0 0 0 0 1826 0%23:59:59
5nntp.terraraq.uk 1015 0 973 0 0 0 0%23:35:47
6news.nntp4.net 1382 0 1339 0 0 0 0%23:39:51
7news.tnetconsulting.net 3070 0 1825 0 0 13 0%23:50:00
8news.aioe.org 0 0 0 0 0 1424 0%23:59:59
TOTAL: 8 9446 3 7954 0 0 3263 0%190:08:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org8.3 KB0.0 KB8.3 KB0.0 KB/s2.8 KB23:56:00
2news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:30:37
3news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:36:27
4i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
5nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:35:47
6news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:39:51
7news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:00
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
TOTAL: 88.3 KB0.0 KB8.3 KB0.0 KB/s2.8 KB190:08:40
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 6 18.3 KB 1 0 000:00:09
TOTAL: 1 6 18.3 KB 1 0 000:02:11

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 29 18.3 KB 1 0 000:00:38
2*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
3*.stretchoid.com 2 00.0 KB 0 0 000:00:10
4? 6 00.0 KB 0 0 000:00:09
5*.gegeweb.eu 288 00.0 KB 0 0 000:00:34
6*.172.132.66.censys-scanner.com 4 00.0 KB 0 0 000:00:04
7*.scanner.modat.io 4 00.0 KB 0 0 000:00:01
8*.ip.linodeusercontent.com 11 00.0 KB 0 0 000:00:09
9*.monitoring.internet-measurement.com 21 00.0 KB 0 0 000:00:19
TOTAL: 9 367 18.3 KB 1 0 000:02: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 5.487 4.670 1.80100:00:34
152.32.139.96 0.090 0.060 0.00000:00:11
azpdsgwcwodu.stretchoid.com 0.043 0.051 0.00000:00:10
66.61.98.95 0.142 0.119 0.00000:00:09
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f 0.161 0.121 0.00000:00:09
r4-209-d1.monitoring.internet-measurement.com 0.087 0.017 0.00000:00:04
47.172.132.66.censys-scanner.com 0.074 0.062 0.00000:00:03
r3-191-bf.monitoring.internet-measurement.com 0.043 0.021 0.00000:00:03
212.102.40.218 0.046 0.039 0.00000:00:03
104.152.52.147 0.063 0.015 0.00000:00:03
hutchinson.probe.onyphe.net 0.034 0.013 0.00000:00:02
104.152.52.149 0.112 0.068 0.00000:00:02
45-33-12-122.ip.linodeusercontent.com 0.071 0.042 0.00000:00:02
r3-57-39.monitoring.internet-measurement.com 0.008 0.016 0.00000:00:01
45-56-79-53.ip.linodeusercontent.com 0.033 0.020 0.00000:00:01
198.235.24.48 0.036 0.016 0.00000:00:01
104.152.52.127 0.045 0.008 0.00000:00:01
71.6.134.230 0.016 0.032 0.00000:00:01
172-236-228-202.ip.linodeusercontent.com 0.079 0.028 0.00000:00:01
r4-10-a.monitoring.internet-measurement.com 0.170 0.048 0.00000:00:01
TOTAL: 51 8.289 6.116 1.80100:02:11

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f 6
104.152.52.149 4
47.172.132.66.censys-scanner.com 3
212.102.40.218 3
152.32.139.96 3
o020.scanner.modat.io 2
104.152.52.129 2
104.152.52.147 2
azpdsgwcwodu.stretchoid.com 2
173-255-225-15.ip.linodeusercontent.com 2
45-33-12-122.ip.linodeusercontent.com 2
o012.scanner.modat.io 2
172-236-228-202.ip.linodeusercontent.com 2
r5-37-25.monitoring.internet-measurement.com 1
r4-10-a.monitoring.internet-measurement.com 1
104.152.52.136 1
r5-12-c.monitoring.internet-measurement.com 1
104.152.52.127 1
172-235-41-245.ip.linodeusercontent.com 1
TOTAL: 52 361

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
173-255-225-15.ip.linodeusercontent.com 7
172-235-41-245.ip.linodeusercontent.com 5
172-236-228-202.ip.linodeusercontent.com 5
104.152.52.147 5
152.32.139.96 3
104.152.52.128 2
139.172.132.66.censys-scanner.com 1
o020.scanner.modat.io 1
azpdsgwcwodu.stretchoid.com 1
o012.scanner.modat.io 1
47.172.132.66.censys-scanner.com 1
TOTAL: 11 32

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 4
Accept: */* 4
Accept-Encoding: gzip 3
User-Agent: Mozilla/5.0 (Macintosh; Inte... 3
#026#003#001 2
HELO 2
Host: 45.13.105.36:563 2
EHLO www.censys.io 2
Connection: close 1
IJ³#021ž]3#010˜ç#010¬è ޝë¾o7˜/ÜÙ’g«N÷#023#035pód•—„‚Ï... 1
MAIL FROM:<relaycheck_please_ignore@prot... 1
#001 1
À#024 1
Host: 45.13.105.36:119 1
User-Agent: curl/7.61.1 1
MGLNDD_45.13.105.36_119 1
Host: 45.13.105.36 1
EHLO 45.13.105.36 1
TOTAL: 18 32

NNRP client timeouts [Top 20]:

SystemConnPeer
45-79-115-59.ip.linodeusercontent.com 1 1
47.172.132.66.censys-scanner.com 1 2
69.5.169.95 1 1
TOTAL: 3 3 8

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 1100.0%
TOTAL: 1 1100.0%

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

NewsgroupCount
1grisbi.user.french 1
TOTAL: 1 1