Daily Usenet report for news.niel.me

Apr 4 04:15:01 -- Apr 5 04:15:01

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Apr 4 19:46:24 rpi-studio innd: filter: No Cancel-Key[sha1:77CsIWq5bDACWMJ6dUYf2zZcQ0E=] matches Cancel-Lock[sha1:7Z6b7ftpDYp+xh5/nd1s3UwSsng=] target=<67f01784$0$28069$426a74cc@news.free.fr>
Apr 5 01:30:01 rpi-studio innd: filter: No Cancel-Key[sha1:z40H6R/hTdxJ9FZCArjFfuJPf5g=] matches Cancel-Lock[sha1:vaSR9NH3z4CcjCs5dtYKK8U74XI=] target=<de-gruppen-finden-29.03.2025@dnqmail.priggish.de>
Apr 5 03:41:30 rpi-studio nnrpd[12575]: rasp.pasdenom.info noperm ihave without permission
Apr 5 03:46:30 rpi-studio nnrpd[12666]: rasp.pasdenom.info noperm ihave without permission
Apr 5 03:51:31 rpi-studio nnrpd[12923]: rasp.pasdenom.info noperm ihave without permission
Apr 5 03:56:31 rpi-studio nnrpd[13010]: rasp.pasdenom.info noperm ihave without permission
Apr 5 04:01:31 rpi-studio nnrpd[13268]: rasp.pasdenom.info noperm ihave without permission
Apr 5 04:06:31 rpi-studio nnrpd[13367]: rasp.pasdenom.info noperm ihave without permission
Apr 5 04:11:31 rpi-studio nnrpd[13630]: rasp.pasdenom.info noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
inn 2430 28.8%450.9 KB 33.6%
innd 2122 25.1%351.6 KB 26.2%
nnrpd 2075 24.6%221.6 KB 16.5%
innfeed 1811 21.5%318.7 KB 23.7%
nocem 1 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 8440 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 11761 54.6%
Negative hits 7367 34.2%
Do not exist 2417 11.2%
Cache misses 3 0.0%
TOTAL: 4 21548 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.003 0.0%4 0.000 0.750 1.000
article cancel00:00:00.001 0.0%5 0.000 0.200 1.000
article cleanup00:00:00.047 0.0%2421 0.000 0.019 0.200
article logging00:00:00.181 0.0%2421 0.000 0.075 0.333
article parse00:00:00.299 0.0%5485 0.000 0.055 0.211
article write00:00:01.093 0.0%2076 0.000 0.526 1.154
artlog/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.132 0.0%23174 0.000 0.006 0.056
hisgrep/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%4 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%5 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.001 0.0%4 0.000 0.250 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.334 0.0%21583 0.000 0.015 0.067
history sync00:00:00.045 0.0%334 0.000 0.135 1.000
history write00:00:00.388 0.0%2421 0.000 0.160 0.611
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:35.953100.0%25051 1417.560 3450.399 16224.054
nntp read00:00:00.698 0.0%24333 0.000 0.029 0.080
overview write00:00:00.665 0.0%2076 0.000 0.320 2.211
perl filter00:00:12.444 0.0%2421 1.538 5.140 22.333
python filter00:00:00.011 0.0%2421 0.000 0.005 0.143
site send00:00:00.627 0.0%4236 0.000 0.148 0.462
TOTAL: 24:01:01.92624:00:52.922100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.018 0.0%2158 0.000 0.008 0.125
article prepare00:00:00.002 0.0%264 0.000 0.008 0.250
article read00:00:00.014 0.0%66 0.000 0.212 3.000
backlog stats00:00:00.154 0.0%29672 0.000 0.005 0.019
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.447 0.0%16084 0.000 0.028 0.093
data write00:00:00.786 0.0%14078 0.000 0.056 0.132
idle23:52:05.278100.0%29672 903.466 2895.837 8618.753
status file00:00:05.125 0.0%233 1.000 21.996 90.000
TOTAL: 23:52:15.32223:52:11.824100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:58:20.567 96.2%9764 0.000 358.518 3049.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.185 0.1%36271 0.000 0.088 0.667
readart00:00:01.440 0.0%8130 0.069 0.177 0.500
TOTAL: 01:00:40.49900:58:25.192 96.3%----

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 2648 674 1630 344 25%26:09:24
2gegeweb-out.news.tnetconsulting.net 3 1915 557 1315 43 29%28:58:06
3feed-out.gegeweb.org 3 2089 430 1659 0 20%23:57:04
4news.samoylyk.net 6 2758 367 2391 0 13%30:00:16
5i2pn.org 3 4131 260 3871 0 6%45:14:52
6usenet.pasdenom.info 2 1025 110 915 0 10%22:07:07
7nntp.terraraq.uk 3 1442 59 1379 4 4%24:49:57
8news.glou.org 2 1598 35 1550 13 2%23:44:46
982.66.60.35 0 74 5 69 0 6%02:26:16
10localhost 25 0 0 0 0 0%00:00:00
TOTAL: 10 50 17680 2497 14779 404 14%227:27:48
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net2.5 MB0.0 KB2.6 MB5.1 MB 49%5.1 KB
2news.samoylyk.net2.1 MB0.0 KB0.0 KB2.1 MB100%5.8 KB
3gegeweb-out.news.tnetconsulting.net1.9 MB0.0 KB135.8 KB2.0 MB 93%3.4 KB
4feed-out.gegeweb.org1.2 MB0.0 KB0.0 KB1.2 MB100%3.0 KB
5i2pn.org595.2 KB0.0 KB0.0 KB595.2 KB100%2.3 KB
6usenet.pasdenom.info276.5 KB0.0 KB0.0 KB276.5 KB100%2.5 KB
7nntp.terraraq.uk211.3 KB0.0 KB7.2 KB218.5 KB 96%3.5 KB
8news.glou.org126.9 KB0.0 KB39.4 KB166.2 KB 76%3.5 KB
982.66.60.3514.6 KB0.0 KB0.0 KB14.6 KB100%2.9 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 108.9 MB0.0 KB2.7 MB11.6 MB 76%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 4 04:15:01 - 04:59:59 63 3.0% 0.02222.0 KB 3.0% 0.08
Apr 4 05:00:00 - 05:59:59 50 2.4% 0.01181.0 KB 2.5% 0.05
Apr 4 06:00:00 - 06:59:59 60 2.9% 0.02198.3 KB 2.7% 0.06
Apr 4 07:00:00 - 07:59:59 75 3.6% 0.02220.4 KB 3.0% 0.06
Apr 4 08:00:00 - 08:59:59 84 4.0% 0.02217.9 KB 3.0% 0.06
Apr 4 09:00:00 - 09:59:59 78 3.8% 0.02251.4 KB 3.5% 0.07
Apr 4 10:00:00 - 10:59:59 77 3.7% 0.02228.1 KB 3.1% 0.06
Apr 4 11:00:00 - 11:59:59 94 4.5% 0.03326.3 KB 4.5% 0.09
Apr 4 12:00:00 - 12:59:59 71 3.4% 0.02231.0 KB 3.2% 0.06
Apr 4 13:00:00 - 13:59:59 83 4.0% 0.02259.3 KB 3.6% 0.07
Apr 4 14:00:00 - 14:59:59 94 4.5% 0.03365.4 KB 5.0% 0.10
Apr 4 15:00:00 - 15:59:59 88 4.2% 0.02484.3 KB 6.7% 0.13
Apr 4 16:00:00 - 16:59:59 66 3.2% 0.02205.6 KB 2.8% 0.06
Apr 4 17:00:00 - 17:59:59 133 6.4% 0.04525.5 KB 7.2% 0.15
Apr 4 18:00:00 - 18:59:59 92 4.4% 0.03229.6 KB 3.2% 0.06
Apr 4 19:00:00 - 19:59:59 105 5.1% 0.03344.9 KB 4.7% 0.10
Apr 4 20:00:00 - 20:59:59 137 6.6% 0.04443.8 KB 6.1% 0.12
Apr 4 21:00:00 - 21:59:59 122 5.9% 0.03545.1 KB 7.5% 0.15
Apr 4 22:00:00 - 22:59:59 93 4.5% 0.03341.5 KB 4.7% 0.09
Apr 4 23:00:00 - 23:59:59 135 6.5% 0.04505.6 KB 6.9% 0.14
Apr 5 00:00:00 - 00:59:59 92 4.4% 0.03339.3 KB 4.7% 0.09
Apr 5 01:00:00 - 01:59:59 81 3.9% 0.02314.0 KB 4.3% 0.09
Apr 5 02:00:00 - 02:59:59 69 3.3% 0.02194.0 KB 2.7% 0.05
Apr 5 03:00:00 - 03:59:59 28 1.3% 0.0189.4 KB 1.2% 0.02
Apr 5 04:00:00 - 04:15:01 7 0.3% 0.0116.2 KB 0.2% 0.02
TOTAL: 24:00:00 2077 100.0% 0.027.1 MB 100.0% 0.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 298 179 0 0 0 0 0 0 119
2gegeweb-out.news.tnetconsulting.net 29 2 0 0 0 0 0 0 27
3news.glou.org 13 0 0 0 0 0 0 0 13
4nntp.terraraq.uk 4 0 0 0 0 0 0 0 4
TOTAL: 4 344 181 0 0 0 0 0 0 163

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 133
linux.kernel.git 43
soc.culture.iran 4
news.test 1
TOTAL: 4 181

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 104
Bad path (news.giganews.com.POSTED) 50
EMP (md5) 5
No Cancel-Key matches Cancel-Lock. target=<67f01784$0$28069$426a74cc@news.free.fr> 1
Cancel of non-existing ID <67ef8daf$0$12918$426a34cc@news.free.fr> 1
HTML Multipart 1
Angle-bracket bot 1
TOTAL: 7 163

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1762 15 1633 0 0 0 0%23:59:31
2news.tnetconsulting.net 3040 12 2054 9 0 8 0%23:58:29
3i2pn.org 2863 10 1938 6 0 8 0%23:59:57
4news.samoylyk.net 2284 3 1641 0 0 182 0%23:59:57
5news.pasdenom.info 1658 1 1559 0 0 0 0%23:51:06
6news.nntp4.net 1549 0 1451 0 0 0 0%23:47:44
7news.aioe.org 0 0 0 0 0 1729 0%24:00:00
8nntp.terraraq.uk 1331 0 1271 0 0 0 0%23:51:06
TOTAL: 8 14487 41 11547 15 0 1927 0%191:27:50
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net34.7 KB84.1 KB118.8 KB0.0 KB/s5.7 KB23:58:29
2news.gegeweb.org30.4 KB0.0 KB30.4 KB0.0 KB/s2.0 KB23:59:31
3i2pn.org29.7 KB62.0 KB91.7 KB0.0 KB/s5.7 KB23:59:57
4news.samoylyk.net8.7 KB0.0 KB8.7 KB0.0 KB/s2.9 KB23:59:57
5news.pasdenom.info2.8 KB0.0 KB2.8 KB0.0 KB/s2.8 KB23:51:06
6news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:44
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:51:06
TOTAL: 8106.4 KB146.1 KB252.5 KB0.0 KB/s4.5 KB191:27:50
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 40 813012.9 MB 11 0 000:58:01
TOTAL: 1 40 813012.9 MB 11 0 001:00:39

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 40 813012.9 MB 11 0 000:58:01
2*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
3unresolved 18 00.0 KB 0 0 000:00:49
4? 1 00.0 KB 0 0 000:00:01
5*.gegeweb.eu 288 00.0 KB 0 0 000:01:39
6*.stretchoid.com 1 00.0 KB 0 0 000:00:00
7*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
8*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
9*.pasdenom.info 7 00.0 KB 0 0 000:00:01
TOTAL: 9 359 813012.9 MB 11 0 001:00:39

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
syn-066-061-096-239.res.spectrum.com 2.397 4.468 0.00000:58:01
mail.gegeweb.eu 4.930 4.240 1.87700:01:39
206.168.34.215 0.207 0.089 0.00000:00:18
206.168.34.60 0.228 0.110 0.00000:00:17
205.210.31.80 0.029 0.017 0.00000:00:03
206.168.34.125 0.023 0.014 0.00000:00:03
60.247.75.142 0.023 0.027 0.00000:00:03
198.235.24.3 0.020 0.024 0.00000:00:02
phillips.probe.onyphe.net 0.016 0.020 0.00000:00:02
81.211.203.35.bc.googleusercontent.com 0.056 0.017 0.00000:00:01
2607:ff10:c8:594::e 0.033 0.018 0.00000:00:01
rasp.pasdenom.info 0.105 0.092 0.00000:00:01
azpdsghjy2fi.stretchoid.com 0.026 0.022 0.00000:00:00
19.210.203.35.bc.googleusercontent.com 0.028 0.012 0.00000:00:00
205.210.31.149 0.018 0.004 0.00000:00:00
kaur.probe.onyphe.net 0.006 0.019 0.00000:00:00
TOTAL: 16 8.145 9.193 1.87701:00:39

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
rasp.pasdenom.info 7
206.168.34.215 6
206.168.34.60 6
60.247.75.142 2
81.211.203.35.bc.googleusercontent.com 1
19.210.203.35.bc.googleusercontent.com 1
azpdsghjy2fi.stretchoid.com 1
phillips.probe.onyphe.net 1
205.210.31.149 1
198.235.24.3 1
205.210.31.80 1
kaur.probe.onyphe.net 1
206.168.34.125 1
2607:ff10:c8:594::e 1
TOTAL: 15 319

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
81.211.203.35.bc.googleusercontent.com 4
19.210.203.35.bc.googleusercontent.com 4
206.168.34.215 3
kaur.probe.onyphe.net 2
206.168.34.125 1
206.168.34.60 1
azpdsghjy2fi.stretchoid.com 1
TOTAL: 7 16

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:563 3
EHLO www.censys.io 3
GET / HTTP/1.1 3
Accept-Encoding: gzip 2
User-Agent: Expanse, a Palo Alto Network... 2
#026#003#003#001¥#001 1
MGLNDD_45.13.105.36_119 1
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 1
TOTAL: 8 16

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 8069 99.2%
2local 61 0.8%
TOTAL: 2 8130100.0%

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

NewsgroupCount
1grisbi.bugsreports 4968
2grisbi.test 2294
3grisbi.devel 755
4local.gegeweb.support 61
5grisbi.user 52
TOTAL: 5 8130