Daily Usenet report for news.niel.me

Jul 24 04:15:01 -- Jul 25 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jul 24 18:37:37 rpi-studio innd: filter: No Cancel-Key[sha1:tpsHSr/lr6lDws8GvuXeZGz2Wn0= sha256:5GKYrQ964XV6HzR8OxhauQb28nj78Cxtp8NJAFm9/3g=] matches Cancel-Lock[sha1:1vc2qQtcd7cGE5facH37XY9+54s= sha256:PPrmtdunaaD8bTy6+pwcyJympq8/YXwrOH/I2X82TA4=] target=<105tnfs$8br$1@rasp.pasdenom.info>

Log entries by program:

Program nameLines%LinesSize%Size
innd 2281 27.0%367.3 KB 29.1%
inn 2243 26.6%372.7 KB 29.6%
nnrpd 1991 23.6%238.0 KB 18.9%
innfeed 1928 22.8%282.1 KB 22.4%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8445 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 7227 49.5%
Negative hits 5139 35.2%
Do not exist 2204 15.1%
Cache misses 30 0.2%
TOTAL: 4 14600 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.013 0.0%14 0.000 0.929 2.000
article cancel00:00:00.003 0.0%14 0.000 0.214 1.000
article cleanup00:00:00.057 0.0%2214 0.000 0.026 0.500
article logging00:00:00.157 0.0%2215 0.000 0.071 0.500
article parse00:00:00.452 0.0%6985 0.000 0.065 0.250
article write00:00:00.705 0.0%1522 0.000 0.463 1.364
artlog/artcncl00:00:00.001 0.0%14 0.000 0.071 1.000
artlog/artcncl/perl00:00:00.002 0.0%14 0.000 0.143 1.000
data move00:00:00.100 0.0%17944 0.000 0.006 0.071
hisgrep/artcncl00:00:00.001 0.0%14 0.000 0.071 0.333
hisgrep/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
hisgrep/perl00:00:00.004 0.0%19 0.000 0.211 1.000
hishave/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.269 0.0%14613 0.000 0.018 0.107
history sync00:00:00.049 0.0%334 0.000 0.147 1.000
history write00:00:00.391 0.0%2214 0.000 0.177 0.667
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:36.909100.0%20081 958.543 4304.413 20003.833
nntp read00:00:00.569 0.0%19314 0.000 0.029 0.085
overview write00:00:00.531 0.0%1522 0.000 0.349 1.800
perl filter00:00:12.870 0.0%2214 2.161 5.813 24.000
python filter00:00:00.012 0.0%2214 0.000 0.005 0.143
site send00:00:00.661 0.0%3083 0.000 0.214 0.583
TOTAL: 24:01:03.45524:00:53.756100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.014 0.0%1532 0.000 0.009 0.167
article prepare00:00:00.002 0.0%208 0.000 0.010 0.083
article read00:00:00.013 0.0%38 0.000 0.342 2.500
backlog stats00:00:00.124 0.0%20737 0.000 0.006 0.028
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.300 0.0%9780 0.000 0.031 0.109
data write00:00:00.510 0.0%8271 0.000 0.062 0.190
idle23:59:42.632100.0%20737 2115.423 4165.628 10508.810
status file00:00:09.168 0.0%322 1.000 28.472 92.000
TOTAL: 23:59:57.70923:59:52.763100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:09:09.346 74.3%1488 9.400 369.184156716.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.125 0.0%3381 0.000 0.037 1.000
TOTAL: 00:12:19.56300:09:09.471 74.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 2305 738 889 678 32%25:37:54
2feed-out.gegeweb.org 4 1442 361 1081 0 25%23:52:49
3news.samoylyk.net 5 1733 285 1443 5 16%27:40:04
4gegeweb-out.news.tnetconsulting.net 6 2124 154 1967 3 7%38:42:59
5news.glou.org 4 1246 94 1114 38 7%23:51:49
6nntp.terraraq.uk 6 2108 91 2016 1 4%39:46:39
7usenet.pasdenom.info 17 667 0 667 0 0%21:37:31
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 70 11625 1723 9177 725 14%201:09:45
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net2.2 MB0.0 KB23.8 KB2.2 MB 98%7.7 KB
2news.nntp4.net2.0 MB0.0 KB8.4 MB10.4 MB 19%7.5 KB
3feed-out.gegeweb.org1.2 MB0.0 KB0.0 KB1.2 MB100%3.4 KB
4gegeweb-out.news.tnetconsulting.net564.3 KB0.0 KB27.1 KB591.4 KB 95%3.8 KB
5nntp.terraraq.uk558.5 KB0.0 KB2.1 KB560.6 KB 99%6.1 KB
6news.glou.org314.8 KB0.0 KB133.0 KB447.8 KB 70%3.4 KB
7usenet.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 86.8 MB0.0 KB8.6 MB15.3 MB 44%6.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 24 04:15:01 - 04:59:59 58 3.8% 0.02173.4 KB 3.0% 0.06
Jul 24 05:00:00 - 05:59:59 55 3.6% 0.02307.0 KB 5.2% 0.09
Jul 24 06:00:00 - 06:59:59 16 1.1% 0.00103.4 KB 1.8% 0.03
Jul 24 07:00:00 - 07:59:59 30 2.0% 0.0174.7 KB 1.3% 0.02
Jul 24 08:00:00 - 08:59:59 31 2.0% 0.01130.6 KB 2.2% 0.04
Jul 24 09:00:00 - 09:59:59 31 2.0% 0.01164.3 KB 2.8% 0.05
Jul 24 10:00:00 - 10:59:59 61 4.0% 0.02191.0 KB 3.3% 0.05
Jul 24 11:00:00 - 11:59:59 59 3.9% 0.02192.8 KB 3.3% 0.05
Jul 24 12:00:00 - 12:59:59 69 4.5% 0.02193.1 KB 3.3% 0.05
Jul 24 13:00:00 - 13:59:59 89 5.9% 0.02286.7 KB 4.9% 0.08
Jul 24 14:00:00 - 14:59:59 70 4.6% 0.02233.0 KB 4.0% 0.06
Jul 24 15:00:00 - 15:59:59 72 4.7% 0.02258.5 KB 4.4% 0.07
Jul 24 16:00:00 - 16:59:59 87 5.7% 0.02543.4 KB 9.2% 0.15
Jul 24 17:00:00 - 17:59:59 87 5.7% 0.02577.0 KB 9.8% 0.16
Jul 24 18:00:00 - 18:59:59 82 5.4% 0.02421.5 KB 7.2% 0.12
Jul 24 19:00:00 - 19:59:59 74 4.9% 0.02251.3 KB 4.3% 0.07
Jul 24 20:00:00 - 20:59:59 61 4.0% 0.02161.7 KB 2.8% 0.04
Jul 24 21:00:00 - 21:59:59 97 6.4% 0.03278.3 KB 4.7% 0.08
Jul 24 22:00:00 - 22:59:59 78 5.1% 0.02267.2 KB 4.5% 0.07
Jul 24 23:00:00 - 23:59:59 75 4.9% 0.02299.0 KB 5.1% 0.08
Jul 25 00:00:00 - 00:59:59 91 6.0% 0.03260.5 KB 4.4% 0.07
Jul 25 01:00:00 - 01:59:59 56 3.7% 0.02155.5 KB 2.6% 0.04
Jul 25 02:00:00 - 02:59:59 30 2.0% 0.01115.5 KB 2.0% 0.03
Jul 25 03:00:00 - 03:59:59 48 3.2% 0.01194.6 KB 3.3% 0.05
Jul 25 04:00:00 - 04:15:01 14 0.9% 0.0240.9 KB 0.7% 0.05
TOTAL: 24:00:00 1521 100.0% 0.025.7 MB 100.0% 0.07
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 649 302 0 0 0 0 0 0 347
2news.glou.org 38 0 0 0 0 0 0 0 38
3news.samoylyk.net 3 0 0 0 0 0 0 0 3
4nntp.terraraq.uk 2 0 0 0 0 0 0 0 2
5gegeweb-out.news.tnetconsulting.net 2 0 0 0 0 0 0 0 2
TOTAL: 5 694 302 0 0 0 0 0 0 392

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 228
linux.kernel.git 70
news.test 3
soc.culture.iran 1
TOTAL: 4 302

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 144
Binary: misplaced binary 101
Too many newsgroups 93
Bad path (news.giganews.com.POSTED) 36
Cancels abusifs 6
Too many newsgroups (meow) 5
Cancel of <105u9vg$c69$11@news.chmurka.net> without Cancel-Key 1
HTML Multipart 1
Cancel of non-existing ID <mef72dFb2f7U1@mid.individual.net> 1
No Cancel-Key matches Cancel-Lock. target=<105tnfs$8br$1@rasp.pasdenom.info> 1
Cancel of <zpzq92b8rrc7$.1jdton1jp4n32.dlg@40tude.net> without Cancel-Key 1
Cancel of <ful53rnoykxz$.u8iennv43ub7$.dlg@40tude.net> without Cancel-Key 1
TOTAL: 12 391

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.nntp4.net 891 5 798 0 0 1 0%23:24:13
2news.tnetconsulting.net 2322 4 1507 7 0 0 0%23:52:43
3news.samoylyk.net 1542 3 1271 2 0 10 0%23:52:48
4news.gegeweb.org 1192 1 1160 0 0 0 0%23:47:31
5news.pasdenom.info 1277 0 1170 25 0 0 0%23:51:49
6news.aioe.org 0 0 0 0 0 1339 0%24:00:00
7nntp.terraraq.uk 935 0 858 5 0 0 0%23:10:35
8i2pn.org 0 0 0 0 0 1518 0%23:57:47
TOTAL: 8 8159 13 6764 39 0 2868 0%189:57:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net13.9 KB11.7 KB25.6 KB0.0 KB/s2.3 KB23:52:43
2news.samoylyk.net9.3 KB2.3 KB11.6 KB0.0 KB/s2.3 KB23:52:48
3news.nntp4.net7.2 KB0.0 KB7.2 KB0.0 KB/s1.4 KB23:24:13
4news.gegeweb.org3.2 KB0.0 KB3.2 KB0.0 KB/s3.2 KB23:47:31
5news.pasdenom.info0.0 KB26.1 KB26.1 KB0.0 KB/s1.0 KB23:51:49
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7nntp.terraraq.uk0.0 KB6.5 KB6.5 KB0.0 KB/s1.3 KB23:10:35
8i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 833.7 KB46.6 KB80.3 KB0.0 KB/s1.5 KB189:57:26
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1azpdegjz8e93.stretchoid.com 1 00.0 KB 0 0 000:00:01
2205.210.31.4 5 00.0 KB 0 0 000:05:15
345.149.216.162.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:03
4147.185.132.147 1 00.0 KB 0 0 000:00:02
5172-236-228-224.ip.linodeusercontent.com 2 00.0 KB 0 0 000:00:00
6147.185.133.236 1 00.0 KB 0 0 000:00:08
7212.102.40.218 3 00.0 KB 0 0 000:00:00
82603:6010:6800:36:1a03:73ff:fe28:be0f 8 00.0 KB 0 0 000:00:06
9206.168.34.120 1 00.0 KB 0 0 000:00:33
10102.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
11mail.gegeweb.eu 289 00.0 KB 0 0 000:01:41
12lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:10
13147.185.132.103 1 00.0 KB 0 0 000:00:07
14206.168.34.66 1 00.0 KB 0 0 000:00:49
15127.211.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:02
162a06:4882:1000::5 1 00.0 KB 0 0 000:00:02
17172-236-228-39.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:01
18194.180.48.168 1 00.0 KB 0 0 000:00:00
19205.210.31.160 3 00.0 KB 0 0 000:03:13
20194.165.16.167 1 00.0 KB 0 0 000:00:00
TOTAL: 20 326 00.0 KB 0 0 000:12:22

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 289 00.0 KB 0 0 000:01:41
2? 9 00.0 KB 0 0 000:00:09
3*.w92-154.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:10
4*.stretchoid.com 1 00.0 KB 0 0 000:00:01
5*.211.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:02
6*.149.216.162.bc.googleusercontent.com 3 00.0 KB 0 0 000:00:04
7unresolved 18 00.0 KB 0 0 000:10:10
8*.ip.linodeusercontent.com 3 00.0 KB 0 0 000:00:02
TOTAL: 8 326 00.0 KB 0 0 000:12:22

NNRP auth users [Top 20]:

UserConn
mailman 289
TOTAL: 1 289

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
205.210.31.4 0.130 0.102 0.00000:05:15
205.210.31.160 0.063 0.061 0.00000:03:13
mail.gegeweb.eu 4.776 4.546 1.90100:01:41
206.168.34.66 0.022 0.010 0.00000:00:49
206.168.34.120 0.025 0.003 0.00000:00:33
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 0.018 0.005 0.00000:00:10
147.185.133.236 0.059 0.020 0.00000:00:08
147.185.132.103 0.019 0.027 0.00000:00:07
2603:6010:6800:36:1a03:73ff:fe28:be0f 0.179 0.137 0.00000:00:06
45.149.216.162.bc.googleusercontent.com 0.122 0.038 0.00000:00:03
2a06:4882:1000::5 0.019 0.005 0.00000:00:02
147.185.132.147 0.015 0.008 0.00000:00:02
127.211.203.35.bc.googleusercontent.com 0.150 0.086 0.00000:00:02
azpdegjz8e93.stretchoid.com 0.019 0.005 0.00000:00:01
172-236-228-39.ip.linodeusercontent.com 0.056 0.020 0.00000:00:01
172-236-228-224.ip.linodeusercontent.com 0.077 0.024 0.00000:00:00
102.149.216.162.bc.googleusercontent.com 0.061 0.017 0.00000:00:00
212.102.40.218 0.046 0.038 0.00000:00:00
194.165.16.167 0.042 0.008 0.00000:00:00
194.180.48.168 0.030 0.022 0.00000:00:00
TOTAL: 20 5.928 5.182 1.90100:12:22

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
172-236-228-224.ip.linodeusercontent.com 5
147.185.133.236 4
102.149.216.162.bc.googleusercontent.com 4
45.149.216.162.bc.googleusercontent.com 4
127.211.203.35.bc.googleusercontent.com 4
205.210.31.4 2
205.210.31.160 1
194.180.48.168 1
194.165.16.167 1
azpdegjz8e93.stretchoid.com 1
TOTAL: 10 27

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:563 5
GET / HTTP/1.1 5
Accept: */* 3
#026#003 3
Accept-Encoding: gzip 3
#003 2
User-Agent: curl/7.68.0 2
User-Agent: Hello from Palo Alto Network... 2
MGLNDD_45.13.105.36_119 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
TOTAL: 10 27

NNRP client timeouts [Top 20]:

SystemConnPeer
205.210.31.4 3 5
205.210.31.160 2 3
194.165.16.167 1 1
127.211.203.35.bc.googleusercontent.com 1 2
194.180.48.168 1 1
45.149.216.162.bc.googleusercontent.com 1 2
TOTAL: 6 9 16