Daily Usenet report for news.niel.me

Oct 3 04:15:01 -- Oct 4 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Oct 3 08:03:08 rpi-studio innd: filter: No Cancel-Key[sha1:plYSTq/qnH4HbGYthtjRDgDmxLU= sha256:M5HkpwOLNRAeeXMafQDcpVvtoXDvp1k+6rCEWpvphHg=] matches Cancel-Lock[sha1:lzr3qygSrZV/b5akGIeKRWa+ZxU= sha256:puu9AFI3UQWobiLCNyDL88+4RoxbkW15Iob8/TqzyHQ=] target=<aolsfaq-1-1790143381@therockgarden.ca>
Oct 3 18:21:38 rpi-studio innd: filter: No Cancel-Key[sha1:HWMI7/rwu0N9SVET7pkPQkU08lM= sha256:vA/43q/qJrYijaWGXSGEgT6FIsO1ZQuttBbHK8S0tJE=] matches Cancel-Lock[sha1:uH6gUdpbgAXt+fX021vywWQHI3c= sha256:jgGZCn6qspzpSNdp3cs+R5ZcxpcnW+G4tiPpgEL8YW4=] target=<119r9gl$35cun$1@dont-email.me>
Oct 3 19:09:16 rpi-studio innd: filter: No Cancel-Key[sha1:1JsFr4m2kbp8DzKcJN69EgEs4JI= sha256:sLOzT1eHIV5nnVCDSbVwolCHl5h28n7BYqioD5F8FVw=] matches Cancel-Lock[sha1:Fg8BV4YswqRWLd6pVxK3WCzElWk= sha256:6BnIP4jzUgG7HadJF19zAjCeFcpZlPRgZGjrjf8g6Po=] target=<slrn11c2deg.usn.lhh+news-no_spam@hercule.home.arpa>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2426 28.9%430.3 KB 33.2%
nnrpd 2028 24.2%232.3 KB 17.9%
innd 2000 23.9%340.9 KB 26.3%
innfeed 1927 23.0%290.4 KB 22.4%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 8383 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 9008 50.2%
Negative hits 6558 36.5%
Do not exist 2387 13.3%
Cache misses 2 0.0%
TOTAL: 4 17955 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.008 0.0%9 0.000 0.889 2.000
article cancel00:00:00.004 0.0%12 0.000 0.333 1.000
article cleanup00:00:00.060 0.0%2389 0.000 0.025 0.333
article logging00:00:00.193 0.0%2390 0.000 0.081 0.375
article parse00:00:00.377 0.0%6561 0.000 0.057 0.222
article write00:00:01.099 0.0%2032 0.000 0.541 2.000
artlog/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%9 0.000 0.000 0.000
data move00:00:00.140 0.0%20844 0.000 0.007 0.040
hisgrep/artcncl00:00:00.002 0.0%12 0.000 0.167 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%9 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%13 0.000 0.077 1.000
hishave/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%9 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.304 0.0%17955 0.000 0.017 0.066
history sync00:00:00.048 0.0%351 0.000 0.137 1.000
history write00:00:00.410 0.0%2389 0.000 0.172 1.000
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:31.639100.0%22231 1626.228 3887.888 27302.409
nntp read00:00:00.605 0.0%21476 0.000 0.028 0.073
overview write00:00:00.655 0.0%2032 0.000 0.322 5.400
perl filter00:00:12.407 0.0%2389 2.304 5.193 19.429
python filter00:00:00.013 0.0%2389 0.000 0.005 0.100
site send00:00:00.884 0.0%4093 0.000 0.216 0.625
TOTAL: 24:01:06.94124:00:48.849100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.012 0.0%2063 0.000 0.006 0.167
article prepare00:00:00.000 0.0%16 0.000 0.000 0.000
article read00:00:00.003 0.0%4 0.000 0.750 3.000
backlog stats00:00:00.137 0.0%25000 0.000 0.005 0.029
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.354 0.0%12641 0.000 0.028 0.115
data write00:00:00.605 0.0%10682 0.000 0.057 0.182
idle23:50:09.894100.0%25000 1474.150 3432.396 9523.444
status file00:00:06.476 0.0%292 0.000 22.178 86.000
TOTAL: 23:50:21.34823:50:17.481100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:52.018 41.3%1502 0.000 34.632 9772.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.113 0.1%3444 0.000 0.033 0.500
TOTAL: 00:02:05.89000:00:52.131 41.4%----

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 2396 714 1681 1 29%29:26:07
2news.nntp4.net 1 2234 558 1393 283 24%22:12:55
3feed-out.gegeweb.org 4 2042 405 1637 0 19%23:56:02
4news.glou.org 6 1366 212 1112 42 15%23:48:07
5nntp.terraraq.uk 6 1023 55 962 6 5%18:25:18
6usenet.pasdenom.info 9 852 50 795 7 5%22:33:37
7gegeweb-out.news.tnetconsulting.net 5 484 3 477 4 0%11:42:22
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 58 10397 1997 8057 343 19%152:04:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net3.6 MB0.0 KB2.0 KB3.6 MB 99%5.2 KB
2news.nntp4.net2.9 MB0.0 KB2.7 MB5.6 MB 52%6.8 KB
3feed-out.gegeweb.org1.4 MB0.0 KB0.0 KB1.4 MB100%3.6 KB
4news.glou.org611.1 KB0.0 KB141.6 KB752.7 KB 81%3.0 KB
5nntp.terraraq.uk253.7 KB0.0 KB15.0 KB268.8 KB 94%4.4 KB
6usenet.pasdenom.info119.7 KB0.0 KB8.5 KB128.2 KB 93%2.2 KB
7gegeweb-out.news.tnetconsulting.net7.6 KB0.0 KB9.4 KB17.0 KB 44%2.4 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 88.9 MB0.0 KB2.8 MB11.8 MB 75%5.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 3 04:15:01 - 04:59:59 31 1.5% 0.01111.6 KB 1.2% 0.04
Oct 3 05:00:00 - 05:59:59 31 1.5% 0.0194.8 KB 1.0% 0.03
Oct 3 06:00:00 - 06:59:59 20 1.0% 0.01233.0 KB 2.5% 0.06
Oct 3 07:00:00 - 07:59:59 57 2.8% 0.02201.0 KB 2.2% 0.06
Oct 3 08:00:00 - 08:59:59 54 2.6% 0.01260.1 KB 2.8% 0.07
Oct 3 09:00:00 - 09:59:59 78 3.8% 0.02307.5 KB 3.3% 0.09
Oct 3 10:00:00 - 10:59:59 126 6.2% 0.04479.5 KB 5.2% 0.13
Oct 3 11:00:00 - 11:59:59 87 4.3% 0.02397.1 KB 4.3% 0.11
Oct 3 12:00:00 - 12:59:59 63 3.1% 0.02465.6 KB 5.1% 0.13
Oct 3 13:00:00 - 13:59:59 94 4.6% 0.03362.5 KB 3.9% 0.10
Oct 3 14:00:00 - 14:59:59 54 2.6% 0.01315.4 KB 3.4% 0.09
Oct 3 15:00:00 - 15:59:59 103 5.0% 0.03315.2 KB 3.4% 0.09
Oct 3 16:00:00 - 16:59:59 124 6.1% 0.03522.2 KB 5.7% 0.15
Oct 3 17:00:00 - 17:59:59 113 5.5% 0.03774.9 KB 8.4% 0.22
Oct 3 18:00:00 - 18:59:59 155 7.6% 0.04862.8 KB 9.4% 0.24
Oct 3 19:00:00 - 19:59:59 108 5.3% 0.03624.7 KB 6.8% 0.17
Oct 3 20:00:00 - 20:59:59 121 5.9% 0.03446.3 KB 4.8% 0.12
Oct 3 21:00:00 - 21:59:59 127 6.2% 0.04498.7 KB 5.4% 0.14
Oct 3 22:00:00 - 22:59:59 115 5.6% 0.03373.5 KB 4.1% 0.10
Oct 3 23:00:00 - 23:59:59 111 5.4% 0.03595.1 KB 6.5% 0.17
Oct 4 00:00:00 - 00:59:59 79 3.9% 0.02267.1 KB 2.9% 0.07
Oct 4 01:00:00 - 01:59:59 64 3.1% 0.02259.8 KB 2.8% 0.07
Oct 4 02:00:00 - 02:59:59 77 3.8% 0.02255.0 KB 2.8% 0.07
Oct 4 03:00:00 - 03:59:59 36 1.8% 0.01128.6 KB 1.4% 0.04
Oct 4 04:00:00 - 04:15:02 18 0.9% 0.0263.2 KB 0.7% 0.07
TOTAL: 24:00:01 2046 100.0% 0.029.0 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 294 212 0 0 0 0 0 0 82
2news.glou.org 42 0 0 0 0 0 0 0 42
3gegeweb-out.news.tnetconsulting.net 8 0 0 0 0 0 0 0 8
4nntp.terraraq.uk 7 0 0 0 0 0 0 0 7
5usenet.pasdenom.info 7 0 0 0 0 0 0 0 7
6news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 6 359 212 0 0 0 0 0 0 147

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 162
linux.kernel.git 50
TOTAL: 2 212

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 75
Bad path (news.giganews.com.POSTED) 62
Cancels abusifs 8
Cancel of non-existing ID <119r9gl$35cun$1@dont-email.me> 1
TOTAL: 4 146

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.nntp4.net 1
TOTAL: 1 1
TOTAL: 1 1

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 3597 1 2036 3 0 33 0%23:59:58
2news.aioe.org 0 0 0 0 0 1740 0%24:00:01
3i2pn.org 0 0 0 0 0 2036 0%24:00:01
4nntp.terraraq.uk 1063 0 1020 0 0 1 0%23:30:52
5news.pasdenom.info 1459 0 1400 0 0 0 0%23:50:57
6news.samoylyk.net 1522 0 1339 0 0 0 0%23:55:41
7news.nntp4.net 1459 0 1403 0 0 0 0%23:54:14
8news.gegeweb.org 1854 0 1644 0 0 0 0%23:56:07
TOTAL: 8 10954 1 8842 3 0 3810 0%191:07:51
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net3.1 KB11.9 KB15.0 KB0.0 KB/s3.7 KB23:59:58
2news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
3i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
4nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:30:52
5news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:57
6news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:55:41
7news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:14
8news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:07
TOTAL: 83.1 KB11.9 KB15.0 KB0.0 KB/s3.7 KB191:07:51
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1104.152.52.223 1 00.0 KB 0 0 000:00:01
231-14-254-74.infrawat.ch 1 00.0 KB 0 0 000:00:01
3104.152.52.227 1 00.0 KB 0 0 000:00:00
42a01:4020:2:b:101::64 1 00.0 KB 0 0 000:00:00
5195-140-214-29.infrawat.ch 1 00.0 KB 0 0 000:00:00
6180.186.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
7ec2-52-53-180-34.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:01
8r3-104-68.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
9194-88-98-87.infrawat.ch 1 00.0 KB 0 0 000:00:00
105-226-140-111.infrawat.ch 1 00.0 KB 0 0 000:00:00
1169-5-169-184.infrawat.ch 1 00.0 KB 0 0 000:00:00
12104.152.52.226 1 00.0 KB 0 0 000:00:01
13104.152.52.217 7 00.0 KB 0 0 000:00:06
14azpdesjyiugd.stretchoid.com 2 00.0 KB 0 0 000:00:10
15104.152.52.206 2 00.0 KB 0 0 000:00:01
16104.152.52.200 1 00.0 KB 0 0 000:00:01
172a01:4020:31:0:102::57a 1 00.0 KB 0 0 000:00:00
18mail.gegeweb.eu 288 00.0 KB 0 0 000:00:49
192603:6010:6802:4ca5:1a03:73ff:fe28:be0f 8 00.0 KB 0 0 000:00:04
202a01:4020:31:0:102::5a0 1 00.0 KB 0 0 000:00:00
21o002.scanner.modat.io 1 00.0 KB 0 0 000:00:29
22104.152.52.229 1 00.0 KB 0 0 000:00:00
23104.152.52.201 1 00.0 KB 0 0 000:00:03
2445.82.78.105 4 00.0 KB 0 0 000:00:00
25198.235.24.220 1 00.0 KB 0 0 000:00:00
2666.61.98.95 4 00.0 KB 0 0 000:00:02
27104.152.52.222 2 00.0 KB 0 0 000:00:00
2869-5-169-11.infrawat.ch 1 00.0 KB 0 0 000:00:00
292a01:4020:1:1:102::8 1 00.0 KB 0 0 000:00:00
TOTAL: 29 338 00.0 KB 0 0 000:02:05

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.stretchoid.com 2 00.0 KB 0 0 000:00:10
2? 12 00.0 KB 0 0 000:00:04
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
4unresolved 26 00.0 KB 0 0 000:00:19
5*.186.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:03
6*.infrawat.ch 6 00.0 KB 0 0 000:00:03
7*.gegeweb.eu 288 00.0 KB 0 0 000:00:49
8*.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:01
9*.scanner.modat.io 1 00.0 KB 0 0 000:00:29
TOTAL: 9 338 00.0 KB 0 0 000:02:05

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.402 4.681 1.73200:00:49
o002.scanner.modat.io 0.038 0.020 0.00000:00:29
azpdesjyiugd.stretchoid.com 0.017 0.030 0.00000:00:10
104.152.52.217 0.264 0.104 0.00000:00:06
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f 0.203 0.130 0.00000:00:04
104.152.52.201 0.014 0.010 0.00000:00:03
180.186.132.66.censys-scanner.com 0.035 0.026 0.00000:00:03
r3-104-68.monitoring.internet-measurement.com 0.027 0.019 0.00000:00:03
66.61.98.95 0.115 0.096 0.00000:00:02
ec2-52-53-180-34.us-west-1.compute.amazonaws.com 0.008 0.017 0.00000:00:01
104.152.52.206 0.026 0.021 0.00000:00:01
104.152.52.223 0.044 0.004 0.00000:00:01
104.152.52.226 0.022 0.009 0.00000:00:01
104.152.52.200 0.017 0.008 0.00000:00:01
31-14-254-74.infrawat.ch 0.026 0.026 0.00000:00:01
5-226-140-111.infrawat.ch 0.014 0.009 0.00000:00:00
195-140-214-29.infrawat.ch 0.031 0.023 0.00000:00:00
45.82.78.105 0.057 0.033 0.00000:00:00
69-5-169-184.infrawat.ch 0.029 0.025 0.00000:00:00
104.152.52.227 0.029 0.018 0.00000:00:00
TOTAL: 29 6.631 5.479 1.73200:02:05

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
45.82.78.105 19
104.152.52.206 7
104.152.52.223 5
104.152.52.217 2
azpdesjyiugd.stretchoid.com 1
104.152.52.201 1
180.186.132.66.censys-scanner.com 1
TOTAL: 7 36

NNRP unrecognized commands (by command):

CommandCount
Connection: close 2
#021ì 2
#026#003#001#005Â#001 2
GET / HTTP/1.1 2
À#024#023#001#023#002#023#003#001 2
EHLO 45.13.105.36 2
User-Agent: curl/7.61.1 2
MAIL FROM:<relaycheck_please_ignore@prot... 2
Host: 45.13.105.36 2
Accept: */* 2
.\Ä<ÈÑ£SeÇJ›š0¢£#034+i6À#015^„#006:©¬«Æ§¦ó¶ÊPšî9P... 1
LEèsre#013Ü0 ÐwAõsËÓ#0057l#033#025®*–¼X™Ðt<çÉ w#001#030«‰... 1
SSH-2.0-Go 1
J.ìˆ~Æ™f¨˜$·+’ò¢èÛ¥q›yU#002¹ó{#021+#003‘¯T#014#022¦­#020¼­... 1
ŨÛª§#002̸ùÜ#022ŸWDùfKnK#010ËB³÷œ¨ß ¨ƒ»6#011£ªÝL#023#020... 1
#020²#026‡wc†¬#031}%#015ý„*I¸±©U#016íQ#021ÀKs#024#026#017#027 1
@»*\² ¯—ÀùgUÜ(#016_X´r‘À#021©‡DŠrFæ#0378õ²¹#020q#023æM•... 1
MGLNDD_45.13.105.36_119 1
K,(#006›#031Y#003Ç<¤F%O«#027¹@e¡J=#011”Î#011*¡ùi³#024ƒ–5Á|œ#037... 1
#023O€#010#027¦ñžñª"-õ»Dì"©6%Å£¯l«N#0177¥\x7fŠ5]{/…“... 1
ãâ#025W 1
E‘N2:Ô|µt|VœÂ ¯L 1
É#£±]R‘Älw~6³ 1
UÄ@#0025„€ÿ7#d#001/öf§äŠ}#030Ù#026#023BÍœ•wk#031&Ýw#013#034(¹¹—s... 1
EHLO www.censys.io 1
ã#022S:-[(#015VQÍgƒ…©#005“»whE4«i«J®˜#002ïW¢Ëê|#003¬a±... 1
TOTAL: 26 36

NNRP client timeouts [Top 20]:

SystemConnPeer
31-14-254-74.infrawat.ch 1 1
2a01:4020:31:0:102::5a0 1 1
5-226-140-111.infrawat.ch 1 1
2a01:4020:31:0:102::57a 1 1
TOTAL: 4 4 9