Daily Usenet report for news.niel.me

Jun 8 04:15:01 -- Jun 9 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jun 8 09:57:06 rpi-studio innd: filter: No Cancel-Key[sha1:0GWWfCiT1cGaTUK4GyHgt20RUxk=] matches Cancel-Lock[sha1:bycAa7NJ5id8JMwyCPKIJe8NqkE=] target=<684541df$0$413$426a34cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
innd 2151 26.8%374.4 KB 29.8%
nnrpd 2030 25.3%229.0 KB 18.3%
inn 1999 24.9%367.5 KB 29.3%
innfeed 1833 22.9%283.0 KB 22.6%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 8015 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 10191 58.2%
Negative hits 5339 30.5%
Do not exist 1961 11.2%
Cache misses 6 0.0%
TOTAL: 4 17497 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.002 0.0%6 0.000 0.333 1.000
article cancel00:00:00.000 0.0%6 0.000 0.000 0.000
article cleanup00:00:00.054 0.0%1962 0.000 0.028 0.333
article logging00:00:00.170 0.0%1962 0.000 0.087 0.667
article parse00:00:00.393 0.0%5599 0.000 0.070 0.250
article write00:00:00.852 0.0%1638 0.000 0.520 1.667
artlog/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%6 0.000 0.000 0.000
data move00:00:00.135 0.0%19922 0.000 0.007 0.051
hisgrep/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%6 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%8 0.000 0.125 1.000
hishave/artcncl00:00:00.000 0.0%6 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.283 0.0%17488 0.000 0.016 0.061
history sync00:00:00.066 0.0%392 0.000 0.168 1.000
history write00:00:00.304 0.0%1962 0.000 0.155 0.529
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:56.186100.0%21614 1852.917 3972.249 23096.423
nntp read00:00:00.647 0.0%20852 0.000 0.031 0.107
overview write00:00:00.546 0.0%1638 0.000 0.333 3.167
perl filter00:00:09.494 0.0%1962 1.364 4.839 18.091
python filter00:00:00.017 0.0%1962 0.000 0.009 0.333
site send00:00:00.634 0.0%3331 0.000 0.190 0.528
TOTAL: 23:51:17.11323:51:09.784100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.016 0.0%1861 0.000 0.009 0.250
article prepare00:00:00.001 0.0%124 0.000 0.008 0.042
article read00:00:00.006 0.0%31 0.000 0.194 3.000
backlog stats00:00:00.142 0.0%24281 0.000 0.006 0.024
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.356 0.0%12498 0.000 0.028 0.091
data write00:00:00.600 0.0%10898 0.000 0.055 0.214
idle23:49:53.455100.0%24281 1912.850 3533.358 9245.508
status file00:00:02.398 0.0%247 0.000 9.709 50.000
TOTAL: 23:50:02.05623:49:56.974100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:49.827 25.4%1473 4.000 33.827 3809.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.155 0.1%3386 0.000 0.046 1.000
TOTAL: 00:03:15.86000:00:49.982 25.5%----

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
1feed-out.gegeweb.org 2 1631 588 1043 0 36%23:58:32
2news.nntp4.net 1 1962 395 1314 253 20%24:33:31
3gegeweb-out.news.tnetconsulting.net 2 1559 167 1378 14 10%23:50:15
4news.glou.org 2 1484 133 1249 102 8%22:49:57
5i2pn.org 3 1936 105 1829 2 5%27:32:55
6news.samoylyk.net 6 521 56 465 0 10%06:22:53
7nntp.terraraq.uk 3 2628 4 2623 1 0%42:10:08
8usenet.pasdenom.info 3 890 1 889 0 0%21:28:54
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 47 12611 1449 10790 372 11%192:47:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net2.5 MB0.0 KB1.9 MB4.4 MB 57%6.9 KB
2feed-out.gegeweb.org1.9 MB0.0 KB0.0 KB1.9 MB100%3.4 KB
3news.samoylyk.net742.7 KB0.0 KB0.0 KB742.7 KB100%13.3 KB
4gegeweb-out.news.tnetconsulting.net509.5 KB0.0 KB43.8 KB553.3 KB 92%3.1 KB
5news.glou.org370.1 KB0.0 KB679.2 KB1.0 MB 35%4.5 KB
6i2pn.org213.2 KB0.0 KB3.2 KB216.4 KB 98%2.0 KB
7nntp.terraraq.uk87.2 KB0.0 KB47.4 KB134.6 KB 64%26.9 KB
8usenet.pasdenom.info2.9 KB0.0 KB0.0 KB2.9 KB100%2.9 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 96.3 MB0.0 KB2.6 MB9.0 MB 70%5.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 8 04:15:01 - 04:59:59 25 1.5% 0.01554.9 KB 6.8% 0.21
Jun 8 05:00:00 - 05:59:59 41 2.5% 0.01117.2 KB 1.4% 0.03
Jun 8 06:00:00 - 06:59:59 27 1.6% 0.01112.6 KB 1.4% 0.03
Jun 8 07:00:00 - 07:59:59 46 2.8% 0.01142.0 KB 1.7% 0.04
Jun 8 08:00:00 - 08:59:59 42 2.5% 0.01584.5 KB 7.1% 0.16
Jun 8 09:00:00 - 09:59:59 18 1.1% 0.0159.2 KB 0.7% 0.02
Jun 8 10:00:00 - 10:59:59 59 3.6% 0.02311.5 KB 3.8% 0.09
Jun 8 11:00:00 - 11:59:59 80 4.9% 0.02299.3 KB 3.6% 0.08
Jun 8 12:00:00 - 12:59:59 72 4.4% 0.02576.9 KB 7.0% 0.16
Jun 8 13:00:00 - 13:59:59 108 6.5% 0.03355.8 KB 4.3% 0.10
Jun 8 14:00:00 - 14:59:59 73 4.4% 0.02432.5 KB 5.3% 0.12
Jun 8 15:00:00 - 15:59:59 80 4.9% 0.02291.9 KB 3.6% 0.08
Jun 8 16:00:00 - 16:59:59 58 3.5% 0.02248.0 KB 3.0% 0.07
Jun 8 17:00:00 - 17:59:59 88 5.3% 0.02503.4 KB 6.1% 0.14
Jun 8 18:00:00 - 18:59:59 104 6.3% 0.03474.3 KB 5.8% 0.13
Jun 8 19:00:00 - 19:59:59 70 4.2% 0.02293.9 KB 3.6% 0.08
Jun 8 20:00:00 - 20:59:59 88 5.3% 0.02374.2 KB 4.6% 0.10
Jun 8 21:00:00 - 21:59:59 84 5.1% 0.02245.0 KB 3.0% 0.07
Jun 8 22:00:00 - 22:59:59 77 4.7% 0.02243.9 KB 3.0% 0.07
Jun 8 23:00:00 - 23:59:59 104 6.3% 0.03322.7 KB 3.9% 0.09
Jun 9 00:00:00 - 00:59:59 77 4.7% 0.02427.1 KB 5.2% 0.12
Jun 9 01:00:00 - 01:59:59 97 5.9% 0.03392.8 KB 4.8% 0.11
Jun 9 02:00:00 - 02:59:59 66 4.0% 0.02183.5 KB 2.2% 0.05
Jun 9 03:00:00 - 03:59:59 50 3.0% 0.01634.7 KB 7.7% 0.18
Jun 9 04:00:00 - 04:15:01 15 0.9% 0.0236.8 KB 0.4% 0.04
TOTAL: 24:00:00 1649 100.0% 0.028.0 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 248 112 0 0 0 0 0 0 136
2news.glou.org 82 0 0 0 0 0 0 0 82
3gegeweb-out.news.tnetconsulting.net 7 0 0 0 0 0 0 0 7
4nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
TOTAL: 4 338 112 0 0 0 0 0 0 226

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 69
linux.kernel.git 42
news.test 1
TOTAL: 3 112

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 116
Bad path (news.giganews.com.POSTED) 98
Too many newsgroups (meow) 7
Cancels abusifs 2
No Cancel-Key matches Cancel-Lock. target=<684541df$0$413$426a34cc@news.free.fr> 1
Cancel of non-existing ID <malps1Fqch6U1@mid.individual.net> 1
HTML Multipart 1
TOTAL: 7 226

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1104 17 1024 0 0 0 1%23:58:34
2news.tnetconsulting.net 2283 5 1639 0 0 3 0%23:59:57
3i2pn.org 2034 3 1507 6 0 4 0%23:59:38
4news.nntp4.net 1368 0 1251 0 0 0 0%23:38:53
5news.samoylyk.net 1662 0 1485 0 0 215 0%23:59:57
6news.aioe.org 0 0 0 0 0 1371 0%24:00:00
7news.pasdenom.info 1479 0 1376 0 0 0 0%23:54:30
8nntp.terraraq.uk 1210 0 1114 0 0 1 0%23:47:13
TOTAL: 8 11140 25 9396 6 0 1594 0%191:18:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org34.1 KB0.0 KB34.1 KB0.0 KB/s2.0 KB23:58:34
2i2pn.org16.8 KB14.5 KB31.3 KB0.0 KB/s3.5 KB23:59:38
3news.tnetconsulting.net12.5 KB0.0 KB12.5 KB0.0 KB/s2.5 KB23:59:57
4news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:38:53
5news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:30
8nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:13
TOTAL: 863.4 KB14.5 KB77.9 KB0.0 KB/s2.5 KB191:18:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
145.227.254.152 1 00.0 KB 0 0 000:00:00
2118.210.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:02
3fun.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:00
4212.102.40.218 3 00.0 KB 0 0 000:00:00
5199.45.155.105 7 00.0 KB 0 0 000:00:14
62a06:4883:3000::2b 1 00.0 KB 0 0 000:00:00
7205.210.31.7 3 00.0 KB 0 0 000:00:07
8147.185.132.198 1 00.0 KB 0 0 000:00:02
9syn-066-061-096-239.res.spectrum.com 2 00.0 KB 0 0 000:00:03
10enviable.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
11154.149.216.162.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:03
12172-236-228-193.ip.linodeusercontent.com 2 00.0 KB 0 0 000:00:00
132a06:4882:3000::3b 1 00.0 KB 0 0 000:00:00
1491.238.181.91 1 00.0 KB 0 0 000:00:00
15206.168.34.212 1 00.0 KB 0 0 000:00:18
162a06:4883:3000::3d 1 00.0 KB 0 0 000:00:00
17plentiful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:04
18223.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
19198.235.24.74 1 00.0 KB 0 0 000:00:04
20172-236-228-222.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:00
21147.185.132.236 1 00.0 KB 0 0 000:00:00
222a06:4882:5000::5f 1 00.0 KB 0 0 000:00:04
23mail.gegeweb.eu 288 00.0 KB 0 0 000:01:47
24precise.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:03
25azpdsgu2vs9r.stretchoid.com 1 00.0 KB 0 0 000:00:01
26205.210.31.4 3 00.0 KB 0 0 000:00:10
272a06:4882:5000::56 1 00.0 KB 0 0 000:00:03
TOTAL: 27 331 00.0 KB 0 0 000:03:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.210.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:02
2*.149.216.162.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:03
3*.ip.linodeusercontent.com 3 00.0 KB 0 0 000:00:01
4*.gegeweb.eu 288 00.0 KB 0 0 000:01:47
5*.stretchoid.com 1 00.0 KB 0 0 000:00:01
6unresolved 22 00.0 KB 0 0 000:01:02
7? 5 00.0 KB 0 0 000:00:07
8*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
9*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:07
10*.res.spectrum.com 2 00.0 KB 0 0 000:00:03
TOTAL: 10 331 00.0 KB 0 0 000:03:17

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.076 4.577 1.96400:01:47
206.168.34.212 0.040 0.025 0.00000:00:18
199.45.155.105 0.298 0.130 0.00000:00:14
205.210.31.4 0.048 0.047 0.00000:00:10
205.210.31.7 0.074 0.049 0.00000:00:07
198.235.24.74 0.033 0.017 0.00000:00:04
2a06:4882:5000::5f 0.057 0.018 0.00000:00:04
plentiful.monitoring.internet-measurement.com 0.052 0.020 0.00000:00:04
syn-066-061-096-239.res.spectrum.com 0.049 0.034 0.00000:00:03
precise.monitoring.internet-measurement.com 0.042 0.020 0.00000:00:03
154.149.216.162.bc.googleusercontent.com 0.172 0.070 0.00000:00:03
2a06:4882:5000::56 0.044 0.016 0.00000:00:03
147.185.132.198 0.033 0.018 0.00000:00:02
118.210.203.35.bc.googleusercontent.com 0.180 0.082 0.00000:00:02
azpdsgu2vs9r.stretchoid.com 0.026 0.023 0.00000:00:01
223.211.203.35.bc.googleusercontent.com 0.053 0.025 0.00000:00:01
172-236-228-193.ip.linodeusercontent.com 0.080 0.050 0.00000:00:00
91.238.181.91 0.035 0.018 0.00000:00:00
172-236-228-222.ip.linodeusercontent.com 0.042 0.029 0.00000:00:00
147.185.132.236 0.067 0.012 0.00000:00:00
TOTAL: 24 6.656 5.419 1.96400:03:17

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
172-236-228-193.ip.linodeusercontent.com 5
154.149.216.162.bc.googleusercontent.com 4
223.211.203.35.bc.googleusercontent.com 4
118.210.203.35.bc.googleusercontent.com 4
147.185.132.236 4
206.168.34.212 1
205.210.31.4 1
azpdsgu2vs9r.stretchoid.com 1
91.238.181.91 1
199.45.155.105 1
205.210.31.7 1
TOTAL: 11 27

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:563 5
GET / HTTP/1.1 5
Accept: */* 3
Accept-Encoding: gzip 3
User-Agent: Expanse, a Palo Alto Network... 2
User-Agent: curl/7.68.0 2
EHLO www.censys.io 2
#026#003 2
#003 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
MGLNDD_45.13.105.36_119 1
TOTAL: 11 27

NNRP client timeouts [Top 20]:

SystemConnPeer
205.210.31.4 2 3
205.210.31.7 2 3
91.238.181.91 1 1
118.210.203.35.bc.googleusercontent.com 1 2
154.149.216.162.bc.googleusercontent.com 1 2
TOTAL: 5 7 13