Daily Usenet report for news.niel.me

Dec 28 04:15:02 -- Dec 29 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 29 00:42:59 rpi-studio innd: filter: No Cancel-Key[sha1:jN9xGUKU3MaAurJfWOggQiMayDw= sha256:m3ZTDDZQnqL9lUQ7LY0ctj3hHUMP2z2DNqgT7mQ5lC4=] matches Cancel-Lock[sha1:PgboNKHyGdlBmAY4AgE3RrKrCk8= sha256:n/ufo6oYNMczbFXv5NQmA7kvQHgC/cGHcKbKystrZU0=] target=<10iseqj$20c2p$1@gwaiyur.mb-net.net>

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 2539 28.3%289.3 KB 21.6%
innd 2309 25.7%389.0 KB 29.0%
inn 2105 23.5%363.7 KB 27.2%
innfeed 2021 22.5%297.2 KB 22.2%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 8976 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 7844 51.0%
Negative hits 5456 35.5%
Do not exist 2077 13.5%
Cache misses 2 0.0%
TOTAL: 4 15379 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.007 0.0%6 1.000 1.167 1.500
article cancel00:00:00.002 0.0%7 0.000 0.286 1.000
article cleanup00:00:00.055 0.0%2087 0.000 0.026 0.250
article logging00:00:00.167 0.0%2087 0.000 0.080 0.667
article parse00:00:00.661 0.0%7633 0.000 0.087 0.429
article write00:00:00.900 0.0%1643 0.000 0.548 1.286
artlog/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%6 0.000 0.167 0.500
data move00:00:00.108 0.0%20490 0.000 0.005 0.067
hisgrep/artcncl00:00:00.001 0.0%7 0.000 0.143 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%6 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.000 0.0%6 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.264 0.0%15458 0.000 0.017 0.078
history sync00:00:00.051 0.0%391 0.000 0.130 0.667
history write00:00:00.378 0.0%2087 0.000 0.181 1.000
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:45.353100.0%21406 617.388 4038.370 50025.167
nntp read00:00:00.649 0.0%20587 0.000 0.032 0.217
overview write00:00:00.550 0.0%1643 0.000 0.335 3.800
perl filter00:00:11.974 0.0%2087 2.000 5.737 32.000
python filter00:00:00.008 0.0%2087 0.000 0.004 0.143
site send00:00:00.568 0.0%3355 0.000 0.169 0.500
TOTAL: 24:01:09.49124:01:01.697100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.017 0.0%1701 0.000 0.010 0.333
article prepare00:00:00.000 0.0%32 0.000 0.000 0.000
article read00:00:00.007 0.0%8 0.000 0.875 6.000
backlog stats00:00:00.113 0.0%21478 0.000 0.005 0.032
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.267 0.0%10221 0.000 0.026 0.091
data write00:00:00.503 0.0%8635 0.000 0.058 0.200
idle23:59:20.475100.0%21478 1953.445 4020.881 12517.312
status file00:00:08.565 0.0%389 1.000 22.018 82.000
TOTAL: 23:59:34.54323:59:29.947100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:19.722 21.4%1526 0.000 52.242 10048.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.130 0.0%3626 0.000 0.036 1.000
readart00:00:00.001 0.0%2 0.500 0.500 0.500
TOTAL: 00:06:13.22400:01:19.853 21.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.nntp4.net 3 1972 754 804 414 38%22:14:40
2news.samoylyk.net 3 2874 414 2459 1 14%40:23:41
3feed-out.gegeweb.org 6 1691 408 1283 0 24%24:27:50
4news.glou.org 6 1245 116 1116 13 9%23:37:47
5nntp.terraraq.uk 9 2274 63 2211 0 2%39:33:08
6usenet.pasdenom.info 16 773 28 745 0 3%22:41:54
7gegeweb-out.news.tnetconsulting.net 8 1015 22 993 0 2%22:06:49
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 76 11844 1805 9611 428 15%195:05:49
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net3.1 MB0.0 KB1.0 KB3.1 MB 99%7.5 KB
2news.nntp4.net2.7 MB0.0 KB10.6 MB13.3 MB 20%11.7 KB
3feed-out.gegeweb.org1.4 MB0.0 KB0.0 KB1.4 MB100%3.6 KB
4nntp.terraraq.uk396.8 KB0.0 KB0.0 KB396.8 KB100%6.3 KB
5news.glou.org373.7 KB0.0 KB43.6 KB417.3 KB 89%3.2 KB
6gegeweb-out.news.tnetconsulting.net59.7 KB0.0 KB0.0 KB59.7 KB100%2.7 KB
7usenet.pasdenom.info57.9 KB0.0 KB0.0 KB57.9 KB100%2.1 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 88.1 MB0.0 KB10.7 MB18.7 MB 43%8.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 28 04:15:02 - 04:59:59 27 1.6% 0.01100.9 KB 1.4% 0.04
Dec 28 05:00:00 - 05:59:59 29 1.8% 0.0187.6 KB 1.2% 0.02
Dec 28 06:00:00 - 06:59:59 52 3.2% 0.01357.0 KB 4.9% 0.10
Dec 28 07:00:00 - 07:59:59 13 0.8% 0.0035.7 KB 0.5% 0.01
Dec 28 08:00:00 - 08:59:59 17 1.0% 0.0059.2 KB 0.8% 0.02
Dec 28 09:00:00 - 09:59:59 20 1.2% 0.01169.9 KB 2.3% 0.05
Dec 28 10:00:00 - 10:59:59 33 2.0% 0.01108.0 KB 1.5% 0.03
Dec 28 11:00:00 - 11:59:59 65 3.9% 0.02189.9 KB 2.6% 0.05
Dec 28 12:00:00 - 12:59:59 47 2.9% 0.01156.2 KB 2.2% 0.04
Dec 28 13:00:00 - 13:59:59 89 5.4% 0.02269.5 KB 3.7% 0.07
Dec 28 14:00:00 - 14:59:59 85 5.2% 0.02457.3 KB 6.3% 0.13
Dec 28 15:00:00 - 15:59:59 134 8.1% 0.04543.3 KB 7.5% 0.15
Dec 28 16:00:00 - 16:59:59 120 7.3% 0.03326.6 KB 4.5% 0.09
Dec 28 17:00:00 - 17:59:59 107 6.5% 0.03320.1 KB 4.4% 0.09
Dec 28 18:00:00 - 18:59:59 94 5.7% 0.03295.2 KB 4.1% 0.08
Dec 28 19:00:00 - 19:59:59 156 9.5% 0.041.3 MB 18.6% 0.38
Dec 28 20:00:00 - 20:59:59 83 5.0% 0.02332.0 KB 4.6% 0.09
Dec 28 21:00:00 - 21:59:59 102 6.2% 0.03439.5 KB 6.1% 0.12
Dec 28 22:00:00 - 22:59:59 82 5.0% 0.02346.3 KB 4.8% 0.10
Dec 28 23:00:00 - 23:59:59 72 4.4% 0.02245.9 KB 3.4% 0.07
Dec 29 00:00:00 - 00:59:59 66 4.0% 0.02272.9 KB 3.8% 0.08
Dec 29 01:00:00 - 01:59:59 72 4.4% 0.02253.2 KB 3.5% 0.07
Dec 29 02:00:00 - 02:59:59 37 2.2% 0.01248.0 KB 3.4% 0.07
Dec 29 03:00:00 - 03:59:59 27 1.6% 0.01226.0 KB 3.1% 0.06
Dec 29 04:00:00 - 04:15:01 17 1.0% 0.0264.7 KB 0.9% 0.07
TOTAL: 23:59:59 1646 100.0% 0.027.1 MB 100.0% 0.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 432 41 0 0 0 0 0 0 391
2news.glou.org 13 0 0 0 0 0 0 0 13
3news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 3 446 41 0 0 0 0 0 0 405

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 27
linux.kernel.git 13
news.test 1
TOTAL: 3 41

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 365
Bad path (news.giganews.com.POSTED) 34
Cancels abusifs 4
Cancel of non-existing ID <10irra5$dvgc$1@dont-email.me> 1
Cancel of <YIj4R.889744$Pf33.80418@fx18.iad> without Cancel-Key 1
TOTAL: 5 405

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 3038 2 1636 4 0 56 0%23:38:56
2news.pasdenom.info 1180 1 1165 1 0 0 0%23:31:28
3news.aioe.org 0 0 0 0 0 1379 0%23:59:59
4news.samoylyk.net 1480 0 1357 0 0 0 0%23:33:02
5news.nntp4.net 866 0 846 0 0 0 0%21:35:21
6news.gegeweb.org 1263 0 1242 0 0 0 0%23:35:58
7i2pn.org 0 0 0 0 0 1639 0%23:57:46
8nntp.terraraq.uk 799 0 779 0 0 0 0%22:04:14
TOTAL: 8 8626 3 7025 5 0 3074 0%185:56:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net5.3 KB88.7 KB94.0 KB0.0 KB/s15.7 KB23:38:56
2news.pasdenom.info2.0 KB4.2 KB6.2 KB0.0 KB/s3.1 KB23:31:28
3news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
4news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:33:02
5news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s021:35:21
6news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:35:58
7i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
8nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s022:04:14
TOTAL: 87.3 KB92.9 KB100.2 KB0.0 KB/s12.5 KB185:56:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 12 24.2 KB 1 0 000:00:11
TOTAL: 1 12 24.2 KB 1 0 000:07:43

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 26 24.2 KB 1 0 000:02:39
2*.census.shodan.io 1 00.0 KB 0 0 000:00:02
3*.150.216.162.bc.googleusercontent.com 5 00.0 KB 0 0 000:00:36
4*.gegeweb.eu 288 00.0 KB 0 0 000:01:19
5*.ip.linodeusercontent.com 87 00.0 KB 0 0 000:00:17
6*.scanner.modat.io 5 00.0 KB 0 0 000:00:01
7*.stretchoid.com 2 00.0 KB 0 0 000:00:11
8*.210.203.35.bc.googleusercontent.com 6 00.0 KB 0 0 000:02:26
9? 8 00.0 KB 0 0 000:00:07
TOTAL: 9 428 24.2 KB 1 0 000:07:43

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
33.210.203.35.bc.googleusercontent.com 0.539 0.166 0.00000:02:25
mail.gegeweb.eu 4.637 3.996 1.65100:01:19
140.150.216.162.bc.googleusercontent.com 0.475 0.213 0.00000:00:36
206.168.34.203 0.044 0.013 0.00000:00:31
66.132.153.121 0.033 0.025 0.00000:00:31
206.168.34.36 0.042 0.021 0.00000:00:30
206.168.34.34 0.048 0.013 0.00000:00:30
172-104-30-66.ip.linodeusercontent.com 3.151 1.014 0.00000:00:16
194.180.49.53 0.045 0.041 0.00000:00:12
66.61.98.95 0.230 0.193 0.00000:00:11
azpdes61qmq4.stretchoid.com 0.033 0.044 0.00000:00:11
2603:6010:6800:36:1a03:73ff:fe28:be0f 0.205 0.159 0.00000:00:07
198.235.24.67 0.028 0.016 0.00000:00:04
195.178.110.25 0.011 0.011 0.00000:00:02
206.168.34.204 0.045 0.020 0.00000:00:02
burger.census.shodan.io 0.026 0.026 0.00000:00:02
172-236-228-86.ip.linodeusercontent.com 0.088 0.020 0.00000:00:00
194.165.16.167 0.012 0.032 0.00000:00:00
o003.scanner.modat.io 0.139 0.056 0.00000:00:00
250.210.203.35.bc.googleusercontent.com 0.081 0.027 0.00000:00:00
TOTAL: 27 10.183 6.203 1.65100:07:43

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
172-104-30-66.ip.linodeusercontent.com 85
2603:6010:6800:36:1a03:73ff:fe28:be0f 8
33.210.203.35.bc.googleusercontent.com 4
o003.scanner.modat.io 4
140.150.216.162.bc.googleusercontent.com 4
azpdes61qmq4.stretchoid.com 2
194.180.49.53 2
172-236-228-86.ip.linodeusercontent.com 2
250.210.203.35.bc.googleusercontent.com 1
burger.census.shodan.io 1
206.168.34.34 1
194.165.16.167 1
198.235.24.67 1
195.178.110.25 1
214.150.216.162.bc.googleusercontent.com 1
198.235.24.176 1
194.180.49.51 1
180.210.203.35.bc.googleusercontent.com 1
206.168.34.203 1
TOTAL: 26 416

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
195.178.110.25 10
140.150.216.162.bc.googleusercontent.com 8
33.210.203.35.bc.googleusercontent.com 8
172-236-228-86.ip.linodeusercontent.com 5
214.150.216.162.bc.googleusercontent.com 4
250.210.203.35.bc.googleusercontent.com 4
180.210.203.35.bc.googleusercontent.com 4
206.168.34.204 1
o003.scanner.modat.io 1
66.132.153.113 1
azpdes61qmq4.stretchoid.com 1
194.165.16.167 1
TOTAL: 12 48

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:563 8
GET / HTTP/1.1 8
Accept: */* 6
Accept-Encoding: gzip 4
User-Agent: curl/7.68.0 4
User-Agent: Hello from Palo Alto Network... 3
Accept-Encoding: gzip, deflate 2
EHLO www.censys.io 2
#003 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
GET /dispatch.asp HTTP/1.1 1
MGLNDD_45.13.105.36_119 1
Connection: keep-alive 1
HELO 1
Accept-Language: en US,en;q=0.9,sv;q=0.8 1
Content-Type: application/x-www-form-url... 1
Host: 45.13.105.36:119 1
X-Requested-With: XMLHttpRequest 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
TOTAL: 19 48

NNRP client timeouts [Top 20]:

SystemConnPeer
33.210.203.35.bc.googleusercontent.com 2 4
140.150.216.162.bc.googleusercontent.com 2 4
194.165.16.167 1 1
TOTAL: 3 5 12

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1grisbi.bugsreports 2
TOTAL: 1 2