Daily Usenet report for news.niel.me

Sep 13 04:15:01 -- Sep 14 04:15:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Sep 13 08:03:08 rpi-studio innd: filter: No Cancel-Key[sha1:CAQJrmdfwb2UV/QRflcgfNSTLi0= sha256:zNthAvG1ymim8BXGPnMfFfuUakHko1nG+Q/dXr8+fmo=] matches Cancel-Lock[sha1:CWNEgVo5vxip1TIrz9LToapO7BI= sha256:ZJey5xuA9rK/2nHwWxwuYBOSs28+ZkaTUremtqNTYZ4=] target=<aolsfaq-1-1788415381@therockgarden.ca>
Sep 13 19:12:51 rpi-studio innd: filter: No Cancel-Key[sha1:ZCk4kNomQtqmDx7safbkB3yoKxA= sha256:oH5R1scrXgsdQVFzaiO9E5XBWuHN1YkXwHUgvozpbFo=] matches Cancel-Lock[sha1:C3y/4+ah/JFsRj7pTy6jz6i53Ts= sha256:6i1JQdDaW+9VwL04UQ9FprRYa3jUn/l1jfqkNGmLGXQ=] target=<6gldaldbuo96res7215uoe5brotf94v9fc@kgbh.org>
Sep 13 19:29:24 rpi-studio innd: filter: No Cancel-Key[sha1:tdyMdoCR9C5ySjYu2YWR0GLDbzo= sha256:TiEsb5WW6nvDR6hrOr9YcH7OsuXebqgZAOoYQiBeI/4=] matches Cancel-Lock[sha1:eOoSRDYcFD/F3hzKFeMXNRryxnw= sha256:ivlhGp3NPAPocprii4ShYLEsdqK65Ip88ZO5sRSHHic=] target=<1186m7t$qcc9$1@dont-email.me>
Sep 13 19:29:35 rpi-studio innd: filter: No Cancel-Key[sha1:tdyMdoCR9C5ySjYu2YWR0GLDbzo= sha256:TiEsb5WW6nvDR6hrOr9YcH7OsuXebqgZAOoYQiBeI/4=] matches Cancel-Lock[sha1:eOoSRDYcFD/F3hzKFeMXNRryxnw= sha256:ivlhGp3NPAPocprii4ShYLEsdqK65Ip88ZO5sRSHHic=] target=<1186m7t$qcc9$1@dont-email.me>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2253 27.2%406.4 KB 31.9%
nnrpd 2223 26.9%252.1 KB 19.8%
innd 1962 23.7%341.4 KB 26.8%
innfeed 1830 22.1%274.5 KB 21.5%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 8270 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 8795 49.7%
Negative hits 6676 37.7%
Do not exist 2231 12.6%
Cache misses 2 0.0%
TOTAL: 4 17704 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.002 0.0%2 1.000 1.000 1.000
article cancel00:00:00.003 0.0%4 0.000 0.750 1.000
article cleanup00:00:00.063 0.0%2232 0.000 0.028 0.200
article logging00:00:00.168 0.0%2232 0.000 0.075 0.353
article parse00:00:00.361 0.0%5459 0.000 0.066 0.235
article write00:00:01.019 0.0%1933 0.000 0.527 1.333
artlog/artcncl00:00:00.001 0.0%4 0.000 0.250 1.000
artlog/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.096 0.0%19496 0.000 0.005 0.037
hisgrep/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%7 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%2 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.286 0.0%17706 0.000 0.016 0.087
history sync00:00:00.054 0.0%342 0.000 0.158 1.000
history write00:00:00.399 0.0%2232 0.000 0.179 0.889
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:28.125100.0%21343 1386.758 4021.371 15801.342
nntp read00:00:00.609 0.0%20557 0.000 0.030 0.105
overview write00:00:00.706 0.0%1933 0.000 0.365 2.200
perl filter00:00:13.472 0.0%2231 2.263 6.039 26.200
python filter00:00:00.010 0.0%2231 0.000 0.004 0.200
site send00:00:00.849 0.0%3900 0.000 0.218 0.667
TOTAL: 23:51:04.51023:50:46.223100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.016 0.0%1945 0.000 0.008 0.111
article prepare00:00:00.001 0.0%28 0.000 0.036 0.250
article read00:00:00.008 0.0%7 0.000 1.143 7.000
backlog stats00:00:00.143 0.0%24026 0.000 0.006 0.030
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.306 0.0%12158 0.000 0.025 0.167
data write00:00:00.630 0.0%10248 0.000 0.061 0.179
idle23:57:50.238100.0%24026 1561.049 3590.703 10731.054
status file00:00:04.944 0.0%295 0.000 16.759 86.000
TOTAL: 23:58:01.29523:57:56.286100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:39.059 38.9%1534 0.000 25.462 1931.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.130 0.1%3562 0.000 0.036 1.000
readart00:00:00.000 0.0%1 0.000 0.000 0.000
TOTAL: 00:01:40.51300:00:39.189 39.0%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feed-out.gegeweb.org 4 1982 685 1297 0 34%24:37:06
2news.samoylyk.net 2 2039 558 1481 0 27%24:33:48
3news.nntp4.net 1 2342 486 1604 252 20%25:47:32
4nntp.terraraq.uk 4 1260 72 1187 1 5%21:56:06
5usenet.pasdenom.info 13 821 17 803 1 2%23:29:10
6news.glou.org 1 77 5 72 0 6%01:47:35
7gegeweb-out.news.tnetconsulting.net 1 349 3 345 1 0%08:48:21
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 51 8870 1826 6789 255 20%130:59:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org2.3 MB0.0 KB0.0 KB2.3 MB100%3.5 KB
2news.samoylyk.net2.3 MB0.0 KB0.0 KB2.3 MB100%4.1 KB
3news.nntp4.net1.8 MB0.0 KB2.3 MB4.1 MB 43%5.7 KB
4nntp.terraraq.uk194.5 KB0.0 KB42.2 KB236.7 KB 82%3.2 KB
5usenet.pasdenom.info34.6 KB0.0 KB1.2 KB35.8 KB 96%2.0 KB
6news.glou.org11.6 KB0.0 KB0.0 KB11.6 KB100%2.3 KB
7gegeweb-out.news.tnetconsulting.net6.4 KB0.0 KB3.3 KB9.7 KB 65%2.4 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 86.6 MB0.0 KB2.4 MB9.0 MB 73%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 13 04:15:01 - 04:59:59 41 2.1% 0.02109.3 KB 1.5% 0.04
Sep 13 05:00:00 - 05:59:59 51 2.6% 0.01198.1 KB 2.8% 0.06
Sep 13 06:00:00 - 06:59:59 28 1.4% 0.0197.8 KB 1.4% 0.03
Sep 13 07:00:00 - 07:59:59 47 2.4% 0.01181.0 KB 2.6% 0.05
Sep 13 08:00:00 - 08:59:59 63 3.2% 0.02311.3 KB 4.4% 0.09
Sep 13 09:00:00 - 09:59:59 78 4.0% 0.02273.6 KB 3.9% 0.08
Sep 13 10:00:00 - 10:59:59 93 4.8% 0.03320.4 KB 4.5% 0.09
Sep 13 11:00:00 - 11:59:59 94 4.8% 0.03310.2 KB 4.4% 0.09
Sep 13 12:00:00 - 12:59:59 89 4.6% 0.02264.1 KB 3.7% 0.07
Sep 13 13:00:00 - 13:59:59 80 4.1% 0.02300.9 KB 4.2% 0.08
Sep 13 14:00:00 - 14:59:59 115 5.9% 0.03303.0 KB 4.3% 0.08
Sep 13 15:00:00 - 15:59:59 122 6.3% 0.03431.8 KB 6.1% 0.12
Sep 13 16:00:00 - 16:59:59 84 4.3% 0.02343.7 KB 4.8% 0.10
Sep 13 17:00:00 - 17:59:59 132 6.8% 0.04465.5 KB 6.6% 0.13
Sep 13 18:00:00 - 18:59:59 90 4.6% 0.03452.9 KB 6.4% 0.13
Sep 13 19:00:00 - 19:59:59 91 4.7% 0.03292.2 KB 4.1% 0.08
Sep 13 20:00:00 - 20:59:59 146 7.5% 0.04518.0 KB 7.3% 0.14
Sep 13 21:00:00 - 21:59:59 66 3.4% 0.02269.6 KB 3.8% 0.07
Sep 13 22:00:00 - 22:59:59 98 5.0% 0.03342.4 KB 4.8% 0.10
Sep 13 23:00:00 - 23:59:59 89 4.6% 0.02332.2 KB 4.7% 0.09
Sep 14 00:00:00 - 00:59:59 80 4.1% 0.02259.7 KB 3.7% 0.07
Sep 14 01:00:00 - 01:59:59 57 2.9% 0.02203.8 KB 2.9% 0.06
Sep 14 02:00:00 - 02:59:59 67 3.4% 0.02345.9 KB 4.9% 0.10
Sep 14 03:00:00 - 03:59:59 31 1.6% 0.01121.2 KB 1.7% 0.03
Sep 14 04:00:00 - 04:15:01 11 0.6% 0.0149.1 KB 0.7% 0.05
TOTAL: 24:00:00 1943 100.0% 0.026.9 MB 100.0% 0.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 249 153 0 0 0 1 0 0 95
2news.glou.org 51 0 0 0 1 0 0 0 50
3nntp.terraraq.uk 2 0 0 0 0 0 0 0 2
4usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
5gegeweb-out.news.tnetconsulting.net 1 0 0 0 0 0 0 0 1
TOTAL: 5 304 153 0 0 1 1 0 0 149

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 132
linux.kernel.git 21
TOTAL: 2 153

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 91
Bad path (news.giganews.com.POSTED) 53
No Cancel-Key matches Cancel-Lock. target=<6gldaldbuo96res7215uoe5brotf94v9fc@kgbh.org> 1
Cancel of non-existing ID <117cctd$3u8jc$1@dont-email.me> 1
No Cancel-Key matches Cancel-Lock. target=<1186m7t$qcc9$1@dont-email.me> 1
Cancels abusifs 1
HTML Multipart 1
TOTAL: 7 149

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1369 2 1268 0 0 0 0%23:49:45
2news.samoylyk.net 1421 2 1343 0 0 0 0%23:47:56
3news.tnetconsulting.net 3353 1 1938 2 0 0 0%23:53:35
4news.nntp4.net 1506 0 1460 0 0 1 0%23:43:58
5news.aioe.org 0 0 0 0 0 1640 0%24:00:00
6i2pn.org 0 0 0 0 0 1942 0%24:00:00
7nntp.terraraq.uk 1145 0 1111 0 0 1 0%23:52:56
8news.pasdenom.info 1494 0 1450 0 0 0 0%23:53:24
TOTAL: 8 10288 5 8570 2 0 3584 0%191:01:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org5.9 KB0.0 KB5.9 KB0.0 KB/s3.0 KB23:49:45
2news.samoylyk.net5.8 KB0.0 KB5.8 KB0.0 KB/s2.9 KB23:47:56
3news.tnetconsulting.net1.9 KB9.0 KB10.9 KB0.0 KB/s3.6 KB23:53:35
4news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:43:58
5news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
6i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:52:56
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:24
TOTAL: 813.6 KB9.0 KB22.6 KB0.0 KB/s3.2 KB191:01:34
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12603:6010:6802:4ca5:1a03:73ff:fe28:be0f 6 10.8 KB 1 0 000:00:05
TOTAL: 1 6 10.8 KB 1 0 000:01:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 10 10.8 KB 1 0 000:00:06
2*.monitoring.internet-measurement.com 40 00.0 KB 0 0 000:00:27
3*.ip.linodeusercontent.com 5 00.0 KB 0 0 000:00:03
4*.scanner.modat.io 9 00.0 KB 0 0 000:00:04
5*.scan.bufferover.run 2 00.0 KB 0 0 000:00:00
6unresolved 16 00.0 KB 0 0 000:00:25
7*.gegeweb.eu 288 00.0 KB 0 0 000:00:34
TOTAL: 7 370 10.8 KB 1 0 000:01:41

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.031 4.384 1.69900:00:34
71.6.235.204 0.220 0.156 0.00000:00:09
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f 0.142 0.121 0.00000:00:05
193.46.255.156 0.025 0.025 0.00000:00:04
66.61.98.95 0.085 0.077 0.00000:00:04
104.152.52.215 0.015 0.008 0.00000:00:03
r5-92-5c.monitoring.internet-measurement.com 0.032 0.032 0.00000:00:03
r3-106-6a.monitoring.internet-measurement.com 0.094 0.012 0.00000:00:03
r4-210-d2.monitoring.internet-measurement.com 0.036 0.011 0.00000:00:03
r4-186-ba.monitoring.internet-measurement.com 0.038 0.023 0.00000:00:03
104.152.52.224 0.012 0.012 0.00000:00:01
r4-55-37.monitoring.internet-measurement.com 0.039 0.009 0.00000:00:01
45-33-12-122.ip.linodeusercontent.com 0.017 0.034 0.00000:00:01
r4-89-59.monitoring.internet-measurement.com 0.112 0.028 0.00000:00:01
r5-49-31.monitoring.internet-measurement.com 0.062 0.036 0.00000:00:01
r4-68-44.monitoring.internet-measurement.com 0.134 0.052 0.00000:00:01
r4-82-52.monitoring.internet-measurement.com 0.082 0.012 0.00000:00:01
r4-52-34.monitoring.internet-measurement.com 0.066 0.030 0.00000:00:01
o066.scanner.modat.io 0.123 0.030 0.00000:00:00
r4-41-29.monitoring.internet-measurement.com 0.074 0.016 0.00000:00:00
TOTAL: 61 7.887 5.822 1.69900:01:41

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
71.6.235.204 7
66.61.98.95 4
o066.scanner.modat.io 2
r4-82-52.monitoring.internet-measurement.com 2
r4-89-59.monitoring.internet-measurement.com 2
jersey.scan.bufferover.run 2
r4-38-26.monitoring.internet-measurement.com 1
45-79-8-221.ip.linodeusercontent.com 1
r4-68-44.monitoring.internet-measurement.com 1
r5-252-fc.monitoring.internet-measurement.com 1
104.152.52.215 1
r3-74-4a.monitoring.internet-measurement.com 1
o032.scanner.modat.io 1
104.152.52.228 1
104.152.52.221 1
r4-109-6d.monitoring.internet-measurement.com 1
r3-214-d6.monitoring.internet-measurement.com 1
r4-55-37.monitoring.internet-measurement.com 1
2a01:4020:1:1:101::361 1
TOTAL: 64 364

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
jersey.scan.bufferover.run 9
104.152.52.221 8
104.152.52.224 5
o066.scanner.modat.io 4
o032.scanner.modat.io 2
o038.scanner.modat.io 2
o053.scanner.modat.io 2
o049.scanner.modat.io 2
193.46.255.156 2
o048.scanner.modat.io 2
71.6.235.204 2
o050.scanner.modat.io 2
o026.scanner.modat.io 2
104.152.52.228 2
104.152.52.215 1
TOTAL: 15 47

NNRP unrecognized commands (by command):

CommandCount
HELO 5
NOOP 5
FEAT 4
SYST 4
#001 3
À$À(À#À' 2
À#024 2
#026#003#001 2
#026#003#001#001 2
À#024#023#001#023#002#023#003#001 1
#026#003#001#005Ê#001 1
#023#003#023#001#023#002#001 1
MAIL FROM:<relaycheck_please_ignore@prot... 1
Accept: */* 1
Connection: close 1
#020;’#011^S#032c$#013¶Òªq¬u#017 1
User-Agent: curl/7.61.1 1
;Û@W+n.€#005Ò À ì„#006,#030&ˆÉ ¸uå‚#036Ó 1
Host: 45.13.105.36 1
fÁ#014ä€#015 %žC¢•;C#026}ì|µõ‡#034¦„÷2­#027FgÌ»’þ¹–÷2uª... 1
EHLO 45.13.105.36 1
„“HÌPå1=fu_*iÃcX?Ë­íô#015€¹GåRNÉÑ¿Œ‹– `cíz... 1
GET / HTTP/1.1 1
¹KO†Ž#004s[#022–cÔ%}ä|#007³-#025ÅZÅ#002ldbÙÌLÕ—Y'%”·Á... 1
É´0Î#032#031‰#001™íÓ#031s¼BÁõz#030FΤ#010&USeã<#016¦H_b‰Á#030h#034³... 1
#003#004#003#003#003#002#003#001#003 1
SSH-2.0-Go 1
TOTAL: 27 47

NNRP client timeouts [Top 20]:

SystemConnPeer
2a01:4020:1:1:101::623 1 1
2a01:4020:1:1:101::361 1 1
TOTAL: 2 2 7

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 1100.0%
TOTAL: 1 1100.0%

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

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