Daily Usenet report for news.niel.me

May 17 04:15:02 -- May 18 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 17 22:19:27 rpi-studio innd: filter: No Cancel-Key[sha1:kzoe93AACIYHH/p6DBXBz8Ieopw= sha256:o7PvFIK02Bq6Lq+slxdUClUzYKQI2U6O5x2Ubu6Tnck=] matches Cancel-Lock[sha1:w/Rt4GTVhrmRMvW2g+sT+QbuSSQ= sha256:Sm6p2pDtyUk35laq46oBK5v+xrn85xUxMUxgnNTv8G0=] target=<10ud6q8$ig7$1@csiph.com>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2106 26.0%374.8 KB 30.2%
innd 2069 25.5%358.9 KB 28.9%
nnrpd 2019 24.9%233.7 KB 18.8%
innfeed 1919 23.6%273.9 KB 22.1%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 8115 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 8541 53.2%
Negative hits 5437 33.9%
Do not exist 2079 12.9%
Cache misses 2 0.0%
TOTAL: 4 16059 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.011 0.0%11 0.000 1.000 2.000
article cancel00:00:00.001 0.0%11 0.000 0.091 1.000
article cleanup00:00:00.043 0.0%2078 0.000 0.021 0.333
article logging00:00:00.149 0.0%2078 0.000 0.072 0.500
article parse00:00:00.361 0.0%5176 0.000 0.070 0.321
article write00:00:00.893 0.0%1799 0.000 0.496 1.600
artlog/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
data move00:00:00.113 0.0%18355 0.000 0.006 0.040
hisgrep/artcncl00:00:00.001 0.0%11 0.000 0.091 1.000
hisgrep/artcncl/perl00:00:00.002 0.0%11 0.000 0.182 1.000
hisgrep/perl00:00:00.000 0.0%12 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.253 0.0%16037 0.000 0.016 0.091
history sync00:00:00.055 0.0%355 0.000 0.155 1.000
history write00:00:00.369 0.0%2078 0.000 0.178 0.625
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:39.962100.0%19563 1662.706 4387.873 22232.963
nntp read00:00:00.505 0.0%18780 0.000 0.027 0.103
overview write00:00:00.643 0.0%1799 0.000 0.357 3.800
perl filter00:00:12.032 0.0%2078 1.875 5.790 32.000
python filter00:00:00.011 0.0%2078 0.000 0.005 0.167
site send00:00:00.713 0.0%3646 0.000 0.196 0.556
TOTAL: 23:51:04.20223:50:56.117100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.014 0.0%1842 0.000 0.008 0.125
article prepare00:00:00.001 0.0%164 0.000 0.006 0.250
article read00:00:00.007 0.0%41 0.000 0.171 3.000
backlog stats00:00:00.126 0.0%23543 0.000 0.005 0.038
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.333 0.0%11472 0.000 0.029 0.167
data write00:00:00.612 0.0%9826 0.000 0.062 0.167
idle23:57:15.718100.0%23543 1554.762 3662.903 10026.717
status file00:00:07.562 0.0%333 0.000 22.709 82.000
TOTAL: 23:57:28.76723:57:24.373100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:08.497 36.4%1507 11.400 85.267 10034.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.139 0.0%3495 0.000 0.040 0.500
readart00:00:00.000 0.0%2 0.000 0.000 0.000
TOTAL: 00:05:53.30900:02:08.636 36.4%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 170

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.nntp4.net 1 2080 1014 815 251 48%23:59:57
2feed-out.gegeweb.org 3 1778 410 1368 0 23%23:58:22
3news.samoylyk.net 2 2533 270 2262 1 10%29:26:11
4nntp.terraraq.uk 13 2611 89 2521 1 3%40:37:03
5news.glou.org 5 1329 85 1225 19 6%23:53:14
6usenet.pasdenom.info 25 785 48 730 7 6%23:24:11
7gegeweb-out.news.tnetconsulting.net 2 1460 26 1434 0 1%23:58:24
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 76 12576 1942 10355 279 15%189:17:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net6.2 MB0.0 KB1.8 MB7.9 MB 77%6.4 KB
2news.samoylyk.net2.1 MB0.0 KB3.3 KB2.1 MB 99%8.0 KB
3feed-out.gegeweb.org1.3 MB0.0 KB0.0 KB1.3 MB100%3.2 KB
4news.glou.org254.2 KB0.0 KB61.5 KB315.7 KB 80%3.0 KB
5nntp.terraraq.uk232.0 KB0.0 KB15.1 KB247.1 KB 93%2.7 KB
6usenet.pasdenom.info111.4 KB0.0 KB8.6 KB120.0 KB 92%2.2 KB
7gegeweb-out.news.tnetconsulting.net109.7 KB0.0 KB0.0 KB109.7 KB100%4.2 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 810.2 MB0.0 KB1.9 MB12.1 MB 84%5.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 17 04:15:02 - 04:59:59 36 2.0% 0.01200.6 KB 2.1% 0.07
May 17 05:00:00 - 05:59:59 35 1.9% 0.01398.8 KB 4.3% 0.11
May 17 06:00:00 - 06:59:59 58 3.2% 0.02207.1 KB 2.2% 0.06
May 17 07:00:00 - 07:59:59 22 1.2% 0.0190.0 KB 1.0% 0.02
May 17 08:00:00 - 08:59:59 34 1.9% 0.01104.1 KB 1.1% 0.03
May 17 09:00:00 - 09:59:59 49 2.7% 0.01475.7 KB 5.1% 0.13
May 17 10:00:00 - 10:59:59 55 3.0% 0.02241.1 KB 2.6% 0.07
May 17 11:00:00 - 11:59:59 48 2.7% 0.01381.6 KB 4.1% 0.11
May 17 12:00:00 - 12:59:59 101 5.6% 0.03576.1 KB 6.1% 0.16
May 17 13:00:00 - 13:59:59 97 5.4% 0.03348.8 KB 3.7% 0.10
May 17 14:00:00 - 14:59:59 100 5.5% 0.03568.9 KB 6.1% 0.16
May 17 15:00:00 - 15:59:59 96 5.3% 0.03391.4 KB 4.2% 0.11
May 17 16:00:00 - 16:59:59 91 5.0% 0.03783.1 KB 8.3% 0.22
May 17 17:00:00 - 17:59:59 101 5.6% 0.03335.1 KB 3.6% 0.09
May 17 18:00:00 - 18:59:59 98 5.4% 0.03328.8 KB 3.5% 0.09
May 17 19:00:00 - 19:59:59 102 5.7% 0.03387.7 KB 4.1% 0.11
May 17 20:00:00 - 20:59:59 125 6.9% 0.03407.3 KB 4.3% 0.11
May 17 21:00:00 - 21:59:59 127 7.0% 0.04441.7 KB 4.7% 0.12
May 17 22:00:00 - 22:59:59 93 5.2% 0.03298.6 KB 3.2% 0.08
May 17 23:00:00 - 23:59:59 115 6.4% 0.03687.2 KB 7.3% 0.19
May 18 00:00:00 - 00:59:59 85 4.7% 0.02774.3 KB 8.3% 0.22
May 18 01:00:00 - 01:59:59 34 1.9% 0.01349.9 KB 3.7% 0.10
May 18 02:00:00 - 02:59:59 47 2.6% 0.01140.4 KB 1.5% 0.04
May 18 03:00:00 - 03:59:59 48 2.7% 0.01441.7 KB 4.7% 0.12
May 18 04:00:00 - 04:15:02 8 0.4% 0.0122.3 KB 0.2% 0.02
TOTAL: 24:00:00 1805 100.0% 0.029.2 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 251 118 0 0 0 0 0 0 133
2news.glou.org 19 0 0 0 1 0 0 0 18
3usenet.pasdenom.info 7 0 0 0 0 0 0 0 7
4nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
5news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 5 279 118 0 0 1 0 0 0 160

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 99
linux.kernel.git 18
news.test 1
TOTAL: 3 118

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
soc.culture.hawaii 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 72
Bad path (news.giganews.com.POSTED) 41
EMP (phn path) 37
Cancels abusifs 7
HTML Multipart 1
Cancel for rejected article 1
No Cancel-Key matches Cancel-Lock. target=<10ud6q8$ig7$1@csiph.com> 1
TOTAL: 7 160

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.samoylyk.net 2166 6 1605 17 0 16 0%23:59:44
2news.tnetconsulting.net 3147 6 1774 11 0 22 0%23:56:36
3news.gegeweb.org 1468 1 1390 0 0 0 0%23:53:22
4i2pn.org 0 0 0 0 0 1791 0%23:59:59
5nntp.terraraq.uk 1111 0 1052 0 0 0 0%23:42:48
6news.aioe.org 0 0 0 0 0 1543 0%23:59:59
7news.nntp4.net 813 0 776 0 0 0 0%22:11:57
8news.pasdenom.info 1328 0 1277 0 0 0 0%23:58:47
TOTAL: 8 10033 13 7874 28 0 3372 0%189:43:12
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net18.5 KB38.2 KB56.7 KB0.0 KB/s3.3 KB23:56:36
2news.samoylyk.net15.1 KB46.3 KB61.5 KB0.0 KB/s2.7 KB23:59:44
3news.gegeweb.org2.9 KB0.0 KB2.9 KB0.0 KB/s2.9 KB23:53:22
4i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
5nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:42:48
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
7news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s022:11:57
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:47
TOTAL: 836.5 KB84.5 KB121.0 KB0.0 KB/s3.0 KB189:43:12
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
168.168.223.140 10 212.0 KB 1 0 000:03:44
TOTAL: 1 10 212.0 KB 1 0 000:06:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 15 212.0 KB 1 0 000:04:42
2*.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3*.211.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:31
4*.195.132.66.censys-scanner.com 7 00.0 KB 0 0 000:00:04
5*.monitoring.internet-measurement.com 17 00.0 KB 0 0 000:00:25
6*.probe.onyphe.net 2 00.0 KB 0 0 000:00:05
7*.gegeweb.eu 288 00.0 KB 0 0 000:00:27
8*.stretchoid.com 2 00.0 KB 0 0 000:00:10
TOTAL: 8 334 212.0 KB 1 0 000:06:29

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
68.168.223.140 0.266 0.236 0.00000:03:44
147.185.133.37 0.362 0.080 0.00000:00:34
177.211.203.35.bc.googleusercontent.com 0.212 0.066 0.00000:00:31
mail.gegeweb.eu 4.982 4.446 1.71400:00:27
45.227.254.152 0.031 0.018 0.00000:00:22
azpdesrz0wxn.stretchoid.com 0.044 0.031 0.00000:00:10
55.195.132.66.censys-scanner.com 0.322 0.111 0.00000:00:04
r5-224-e0.monitoring.internet-measurement.com 0.044 0.004 0.00000:00:03
parks.probe.onyphe.net 0.041 0.008 0.00000:00:03
r4-169-a9.monitoring.internet-measurement.com 0.014 0.018 0.00000:00:03
r5-174-ae.monitoring.internet-measurement.com 0.084 0.023 0.00000:00:03
r5-246-f6.monitoring.internet-measurement.com 0.061 0.020 0.00000:00:02
moshe.probe.onyphe.net 0.034 0.013 0.00000:00:02
r3-243-f3.monitoring.internet-measurement.com 0.052 0.028 0.00000:00:02
r3-113-71.monitoring.internet-measurement.com 0.016 0.008 0.00000:00:01
r4-220-dc.monitoring.internet-measurement.com 0.065 0.032 0.00000:00:01
r3-232-e8.monitoring.internet-measurement.com 0.044 0.052 0.00000:00:01
r3-227-e3.monitoring.internet-measurement.com 0.128 0.048 0.00000:00:01
r3-220-dc.monitoring.internet-measurement.com 0.088 0.008 0.00000:00:01
r5-228-e4.monitoring.internet-measurement.com 0.094 0.019 0.00000:00:01
TOTAL: 27 7.270 5.389 1.71400:06:29

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
55.195.132.66.censys-scanner.com 7
177.211.203.35.bc.googleusercontent.com 2
147.185.133.37 2
azpdesrz0wxn.stretchoid.com 2
r4-69-45.monitoring.internet-measurement.com 1
r3-237-ed.monitoring.internet-measurement.com 1
r4-220-dc.monitoring.internet-measurement.com 1
r3-220-dc.monitoring.internet-measurement.com 1
r3-243-f3.monitoring.internet-measurement.com 1
r3-113-71.monitoring.internet-measurement.com 1
r4-169-a9.monitoring.internet-measurement.com 1
r3-232-e8.monitoring.internet-measurement.com 1
parks.probe.onyphe.net 1
moshe.probe.onyphe.net 1
r5-246-f6.monitoring.internet-measurement.com 1
r5-230-e6.monitoring.internet-measurement.com 1
45.227.254.152 1
r5-228-e4.monitoring.internet-measurement.com 1
r3-227-e3.monitoring.internet-measurement.com 1
TOTAL: 28 324

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
147.185.132.215 4
177.211.203.35.bc.googleusercontent.com 4
147.185.133.37 4
55.195.132.66.censys-scanner.com 1
143.172.132.66.censys-scanner.com 1
azpdesrz0wxn.stretchoid.com 1
45.227.254.152 1
TOTAL: 7 16

NNRP unrecognized commands (by command):

CommandCount
Host: 45.13.105.36:563 3
GET / HTTP/1.1 3
Accept: */* 2
User-Agent: curl/7.68.0 2
EHLO www.censys.io 2
MGLNDD_45.13.105.36_119 1
Accept-Encoding: gzip 1
#003 1
User-Agent: Hello from Palo Alto Network... 1
TOTAL: 9 16

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.152 1 1
147.185.133.37 1 2
177.211.203.35.bc.googleusercontent.com 1 2
TOTAL: 3 3 5

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1grisbi.user.french 2
TOTAL: 1 2
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me