Daily Usenet report for news.niel.me

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

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Aug 16 14:14:39 rpi-studio innd: filter: No Cancel-Key[sha1:8y8HWyxMZoAi/Sz5teC2lt9bTnQ= sha256:z/HurgBRS6zVISBu3sQ50T+m4Guqn7dnHAzqJwh1SAs=] matches Cancel-Lock[sha1:T0+NqFxCQSqRuyCsd/+SNma8Ah8= sha256:NTpMZTvSnAlP/yN+3TwHyx5x4Su3NdgLelvlvOT9u2A=] target=<115s9b6$5ctj$1@dont-email.me>
Aug 16 16:05:02 rpi-studio innd: filter: No Cancel-Key[sha1:d2IUXQlM0txKHS7ZxacY2InK+tA= sha256:pgK2Wt2pwDFYaz6MTiok99FG6eGqRPGWTkM4bUOdV04=] matches Cancel-Lock[sha1:KP39e2PPTHU4paBAfWk7HE8qeyY= sha256:pW+eySxv92y/wiz4FMs94qZ4vRT+3UoCAjXZ4RfkK+Q=] target=<115sg05$7hus$1@dont-email.me>
Aug 16 21:51:34 rpi-studio innd: filter: No Cancel-Key[sha1:oEl7zHWZ5Qr68e0R8GtIB4DB+mc= sha256:M6NF1p5dm4VukmGedc9CLj+/x7nBY57/FwKI8ieBOig=] matches Cancel-Lock[sha1:KQrtweLdHKpETItoNCutMOmcpRw= sha256:/LRBu5/SZvgU9498sRlALjBsRsaFVsGDGjvDugVaD1w=] target=<115t3ug$emco$1@dont-email.me>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2057 25.6%368.4 KB 29.9%
nnrpd 2048 25.5%227.2 KB 18.4%
innd 2022 25.1%354.2 KB 28.7%
innfeed 1916 23.8%282.0 KB 22.9%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8045 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 7925 49.9%
Negative hits 5910 37.2%
Do not exist 2040 12.8%
Cache misses 1 0.0%
TOTAL: 4 15876 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.005 0.0%5 0.000 1.000 2.000
article cancel00:00:00.002 0.0%7 0.000 0.286 1.000
article cleanup00:00:00.043 0.0%2042 0.000 0.021 0.333
article logging00:00:00.153 0.0%2046 0.000 0.075 0.500
article parse00:00:00.281 0.0%4916 0.000 0.057 1.000
article write00:00:00.952 0.0%1834 0.000 0.519 3.000
artlog/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%5 0.000 0.000 0.000
data move00:00:00.114 0.0%16568 0.000 0.007 0.037
hisgrep/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%5 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%9 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.001 0.0%5 0.000 0.200 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.256 0.0%15884 0.000 0.016 0.056
history sync00:00:00.039 0.0%352 0.000 0.111 1.000
history write00:00:00.379 0.0%2042 0.000 0.186 1.000
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:24.339100.0%18715 1376.489 4617.918 42867.714
nntp read00:00:00.486 0.0%17961 0.000 0.027 0.130
overview write00:00:00.602 0.0%1834 0.000 0.328 2.000
perl filter00:00:13.605 0.0%2042 2.236 6.663 66.000
python filter00:00:00.013 0.0%2042 0.000 0.006 0.333
site send00:00:00.793 0.0%3706 0.000 0.214 0.571
TOTAL: 24:01:06.41424:00:42.063100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%1908 0.000 0.010 0.143
article prepare00:00:00.000 0.0%20 0.000 0.000 0.000
article read00:00:00.004 0.0%5 0.000 0.800 3.000
backlog stats00:00:00.139 0.0%22142 0.000 0.006 0.045
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.294 0.0%10917 0.000 0.027 0.107
data write00:00:00.534 0.0%9231 0.000 0.058 0.167
idle23:58:03.413100.0%22142 1701.082 3896.821 10628.136
status file00:00:09.776 0.0%343 1.000 28.501 82.000
TOTAL: 23:58:18.79323:58:14.179100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:44.141 48.0%1484 10.600 29.745 5209.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.141 0.2%3411 0.000 0.041 1.000
readart00:00:00.000 0.0%4 0.000 0.000 0.000
TOTAL: 00:01:31.95300:00:44.282 48.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.samoylyk.net 3 1880 575 1305 0 30%23:53:06
2feed-out.gegeweb.org 4 1857 496 1361 0 26%23:53:41
3news.nntp4.net 3 2051 471 1404 176 22%24:03:28
4nntp.terraraq.uk 7 2294 266 2024 4 11%43:01:56
5news.glou.org 7 2239 188 2002 49 8%44:46:55
6usenet.pasdenom.info 16 690 34 655 1 4%24:04:14
7gegeweb-out.news.tnetconsulting.net 5 2011 28 1982 1 1%37:01:38
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 70 13022 2058 10733 231 15%220:44:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net2.6 MB0.0 KB0.0 KB2.6 MB100%4.7 KB
2news.nntp4.net2.0 MB0.0 KB1.1 MB3.1 MB 64%5.0 KB
3feed-out.gegeweb.org1.6 MB0.0 KB0.0 KB1.6 MB100%3.4 KB
4nntp.terraraq.uk920.8 KB0.0 KB51.2 KB972.0 KB 94%3.6 KB
5news.glou.org622.5 KB0.0 KB188.1 KB810.6 KB 76%3.4 KB
6gegeweb-out.news.tnetconsulting.net104.7 KB0.0 KB8.0 KB112.7 KB 92%3.9 KB
7usenet.pasdenom.info74.5 KB0.0 KB1.2 KB75.7 KB 98%2.2 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 88.0 MB0.0 KB1.4 MB9.3 MB 85%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 16 04:15:01 - 04:59:59 21 1.1% 0.0164.4 KB 0.9% 0.02
Aug 16 05:00:00 - 05:59:59 33 1.8% 0.0199.3 KB 1.4% 0.03
Aug 16 06:00:00 - 06:59:59 18 1.0% 0.0151.7 KB 0.7% 0.01
Aug 16 07:00:00 - 07:59:59 49 2.7% 0.01240.4 KB 3.3% 0.07
Aug 16 08:00:00 - 08:59:59 45 2.5% 0.01191.5 KB 2.6% 0.05
Aug 16 09:00:00 - 09:59:59 60 3.3% 0.02200.2 KB 2.7% 0.06
Aug 16 10:00:00 - 10:59:59 66 3.6% 0.02253.5 KB 3.5% 0.07
Aug 16 11:00:00 - 11:59:59 54 2.9% 0.01204.7 KB 2.8% 0.06
Aug 16 12:00:00 - 12:59:59 108 5.9% 0.03395.7 KB 5.4% 0.11
Aug 16 13:00:00 - 13:59:59 79 4.3% 0.02305.3 KB 4.2% 0.08
Aug 16 14:00:00 - 14:59:59 121 6.6% 0.03476.6 KB 6.5% 0.13
Aug 16 15:00:00 - 15:59:59 124 6.8% 0.03426.5 KB 5.8% 0.12
Aug 16 16:00:00 - 16:59:59 109 5.9% 0.03375.8 KB 5.2% 0.10
Aug 16 17:00:00 - 17:59:59 71 3.9% 0.02208.0 KB 2.9% 0.06
Aug 16 18:00:00 - 18:59:59 110 6.0% 0.03405.1 KB 5.6% 0.11
Aug 16 19:00:00 - 19:59:59 128 7.0% 0.04420.0 KB 5.8% 0.12
Aug 16 20:00:00 - 20:59:59 98 5.3% 0.03308.1 KB 4.2% 0.09
Aug 16 21:00:00 - 21:59:59 133 7.3% 0.04747.1 KB 10.2% 0.21
Aug 16 22:00:00 - 22:59:59 113 6.2% 0.03603.7 KB 8.3% 0.17
Aug 16 23:00:00 - 23:59:59 71 3.9% 0.02309.4 KB 4.2% 0.09
Aug 17 00:00:00 - 00:59:59 62 3.4% 0.02199.8 KB 2.7% 0.06
Aug 17 01:00:00 - 01:59:59 86 4.7% 0.02467.7 KB 6.4% 0.13
Aug 17 02:00:00 - 02:59:59 39 2.1% 0.01179.1 KB 2.5% 0.05
Aug 17 03:00:00 - 03:59:59 31 1.7% 0.01144.5 KB 2.0% 0.04
Aug 17 04:00:00 - 04:15:02 4 0.2% 0.0014.3 KB 0.2% 0.02
TOTAL: 24:00:01 1833 100.0% 0.027.1 MB 100.0% 0.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 178 73 0 0 4 0 0 0 101
2news.glou.org 29 0 0 0 4 0 0 0 25
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
6feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 6 212 73 0 0 8 0 0 0 131

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 69
linux.kernel.git 4
TOTAL: 2 73

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

GroupsCount
soc.culture.hawaii 8
TOTAL: 1 8

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 94
Bad path (news.giganews.com.POSTED) 29
No Cancel-Key matches Cancel-Lock. target=<115s9b6$5ctj$1@dont-email.me> 1
Cancels abusifs 1
HTML Multipart 1
Cancel of non-existing ID <115sg05$7hus$1@dont-email.me> 1
TOTAL: 6 127

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.nntp4.net 3
feed-out.gegeweb.org 1
TOTAL: 2 4
TOTAL: 1 4

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 3034 1 1829 0 0 75 0%23:54:40
2news.samoylyk.net 1316 1 1157 3 0 0 0%23:44:45
3news.nntp4.net 1390 0 1349 0 0 0 0%23:22:29
4news.aioe.org 0 0 0 0 0 1565 0%24:00:01
5news.gegeweb.org 1395 0 1342 0 0 0 0%23:38:03
6i2pn.org 0 0 0 0 0 1830 0%24:00:01
7nntp.terraraq.uk 919 0 886 0 0 0 0%23:17:24
8news.pasdenom.info 1253 0 1219 0 0 0 0%23:42:16
TOTAL: 8 9307 2 7782 3 0 3470 0%189:39:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net4.6 KB0.0 KB4.6 KB0.0 KB/s4.6 KB23:54:40
2news.samoylyk.net3.2 KB9.8 KB13.0 KB0.0 KB/s3.3 KB23:44:45
3news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:22:29
4news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
5news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:38:03
6i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:17:24
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:42:16
TOTAL: 87.8 KB9.8 KB17.6 KB0.0 KB/s3.5 KB189:39:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12603:6010:6802:4ca5:1a03:73ff:fe28:be0f 2 417.8 KB 3 0 000:00:04
TOTAL: 1 2 417.8 KB 3 0 000:01:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 2 417.8 KB 3 0 000:00:04
2*.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:05
3*.internet-census.org 1 00.0 KB 0 0 000:00:11
4*.gegeweb.eu 288 00.0 KB 0 0 000:00:34
5*.ip.linodeusercontent.com 5 00.0 KB 0 0 000:00:03
6*.monitoring.internet-measurement.com 21 00.0 KB 0 0 000:00:14
7*.scanner.modat.io 2 00.0 KB 0 0 000:00:01
8unresolved 20 00.0 KB 0 0 000:00:18
TOTAL: 8 340 417.8 KB 3 0 000:01:33

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.113 5.055 1.83100:00:34
zl-dala-us-gp1-wk122a.internet-census.org 0.034 0.021 0.00000:00:11
182.172.132.66.censys-scanner.com 0.045 0.020 0.00000:00:05
104.152.52.135 0.078 0.037 0.00000:00:04
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f 0.071 0.046 0.00000:00:04
r5-189-bd.monitoring.internet-measurement.com 0.021 0.007 0.00000:00:03
r5-208-d0.monitoring.internet-measurement.com 0.085 0.023 0.00000:00:03
147.185.132.25 0.032 0.020 0.00000:00:02
69.5.169.28 0.021 0.005 0.00000:00:02
104.152.52.138 0.038 0.011 0.00000:00:01
104.152.52.141 0.018 0.015 0.00000:00:01
104.152.52.140 0.035 0.021 0.00000:00:01
104.152.52.147 0.014 0.010 0.00000:00:01
r3-126-7e.monitoring.internet-measurement.com 0.181 0.032 0.00000:00:01
r3-143-8f.monitoring.internet-measurement.com 0.172 0.016 0.00000:00:01
r4-137-89.monitoring.internet-measurement.com 0.068 0.026 0.00000:00:01
45-33-12-214.ip.linodeusercontent.com 0.016 0.008 0.00000:00:01
50-116-26-161.ip.linodeusercontent.com 0.036 0.020 0.00000:00:01
69-164-217-245.ip.linodeusercontent.com 0.027 0.027 0.00000:00:00
217.146.80.102 0.027 0.027 0.00000:00:00
TOTAL: 45 7.127 5.959 1.83100:01:33

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
104.152.52.142 4
104.152.52.135 2
104.152.52.125 2
45-33-12-214.ip.linodeusercontent.com 1
r4-137-89.monitoring.internet-measurement.com 1
104.152.52.134 1
45-33-109-8.ip.linodeusercontent.com 1
104.152.52.133 1
r3-32-20.monitoring.internet-measurement.com 1
r5-144-90.monitoring.internet-measurement.com 1
r4-138-8a.monitoring.internet-measurement.com 1
50-116-26-161.ip.linodeusercontent.com 1
104.152.52.140 1
45-79-211-97.ip.linodeusercontent.com 1
r3-168-a8.monitoring.internet-measurement.com 1
r4-153-99.monitoring.internet-measurement.com 1
r4-21-15.monitoring.internet-measurement.com 1
r4-26-1a.monitoring.internet-measurement.com 1
r3-169-a9.monitoring.internet-measurement.com 1
TOTAL: 46 338

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
104.152.52.146 8
104.152.52.138 5
104.152.52.147 5
104.152.52.135 3
104.152.52.127 2
182.172.132.66.censys-scanner.com 1
o019.scanner.modat.io 1
TOTAL: 7 25

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36 2
Connection: close 2
GET / HTTP/1.1 2
Accept: */* 2
EHLO 45.13.105.36 2
User-Agent: curl/7.61.1 2
MAIL FROM:<relaycheck_please_ignore@prot... 2
¦“#005^»`¬Û°#003#033ÌÁ#006#0200ú`0Czˆ 1
#026#003#001#005Ê#001 1
À#024#023#001#023#002#023#003#001 1
]ûQ™›R¶G¢]#016s­ã·*#002CƒåpO†ü#033ÀhdFJ#032ežÝd#022~Ê|... 1
#010†’f":3´¾ðÂ|P~©0 êq+‚3É#025J ÙS1ÒÃg‡#035‰ÚN@K... 1
SSH-2.0-Go 1
EHLO www.censys.io 1
º91e÷Š£–#037JÓ¤zkY˜ª#002äif#026Q‚£Xi)#036ÍP±+” Ö3#024... 1
³U#lóG#025#036î«h#031RiX#036fw!]2#004Yœ#013¸7#034–F 1
HELO 1
ï#025#025#033#006Îx@ð _ 1
TOTAL: 18 25

NNRP client timeouts [Top 20]:

SystemConnPeer
69.5.169.28 1 1
TOTAL: 1 1 6

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 4100.0%
TOTAL: 1 4100.0%

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

NewsgroupCount
1grisbi.bugsreports 2
2grisbi.user.french 1
3grisbi.test 1
TOTAL: 3 4