Daily Usenet report for news.niel.me

Oct 10 04:15:01 -- Oct 11 04:15:01

Unknown entries from news log file:

First 50 / 1023 lines (4.9%)

Oct 10 18:21:32 rpi-studio nnrpd[6837]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:22:19 rpi-studio nnrpd[6848]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:22:49 rpi-studio nnrpd[6867]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:23:19 rpi-studio nnrpd[6878]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:23:49 rpi-studio nnrpd[6924]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:24:19 rpi-studio nnrpd[7079]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:24:49 rpi-studio nnrpd[7087]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:25:20 rpi-studio nnrpd[7100]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:25:51 rpi-studio nnrpd[7110]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:28:55 rpi-studio nnrpd[7197]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:29:25 rpi-studio nnrpd[7250]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:30:00 rpi-studio nnrpd[7263]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:30:30 rpi-studio nnrpd[7278]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:31:00 rpi-studio nnrpd[7318]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:31:30 rpi-studio nnrpd[7328]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:32:00 rpi-studio nnrpd[7336]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:32:30 rpi-studio nnrpd[7347]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:33:01 rpi-studio nnrpd[7354]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:33:20 rpi-studio nnrpd[7367]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:37:00 rpi-studio nnrpd[7410]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:37:30 rpi-studio nnrpd[7650]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:38:00 rpi-studio nnrpd[7668]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:38:30 rpi-studio nnrpd[7710]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:39:00 rpi-studio nnrpd[7717]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:39:30 rpi-studio nnrpd[7726]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:40:00 rpi-studio nnrpd[7746]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:40:30 rpi-studio nnrpd[7755]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:41:00 rpi-studio nnrpd[7795]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:41:30 rpi-studio nnrpd[7806]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:42:00 rpi-studio nnrpd[7816]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:42:30 rpi-studio nnrpd[7826]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:43:00 rpi-studio nnrpd[7839]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:43:30 rpi-studio nnrpd[7882]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:44:00 rpi-studio nnrpd[7889]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:44:30 rpi-studio nnrpd[8039]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:45:00 rpi-studio nnrpd[8048]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:45:31 rpi-studio nnrpd[8066]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:46:01 rpi-studio nnrpd[8106]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:46:31 rpi-studio nnrpd[8116]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:47:01 rpi-studio nnrpd[8127]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:47:31 rpi-studio nnrpd[8134]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:48:01 rpi-studio nnrpd[8146]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:48:31 rpi-studio nnrpd[8203]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:49:02 rpi-studio nnrpd[8212]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:49:32 rpi-studio nnrpd[8230]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:50:02 rpi-studio nnrpd[8246]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:50:32 rpi-studio nnrpd[8253]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:51:02 rpi-studio nnrpd[8296]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:51:32 rpi-studio nnrpd[8306]: mantic.terraraq.uk noperm ihave without permission
Oct 10 18:52:02 rpi-studio nnrpd[8319]: mantic.terraraq.uk noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 7551 53.9%872.8 KB 45.4%
inn 2488 17.7%432.4 KB 22.5%
innd 2030 14.5%342.0 KB 17.8%
innfeed 1947 13.9%276.3 KB 14.4%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 14018 100.0%1.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 8753 51.2%
Negative hits 5838 34.1%
Do not exist 2478 14.5%
Cache misses 33 0.2%
TOTAL: 4 17102 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%4 0.000 0.250 1.000
article cleanup00:00:00.042 0.0%2484 0.000 0.017 0.188
article logging00:00:00.216 0.0%2484 0.000 0.087 0.400
article parse00:00:00.435 0.0%6881 0.000 0.063 0.400
article write00:00:01.017 0.0%1918 0.000 0.530 1.900
artlog/artcncl00:00:00.000 0.0%4 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.115 0.0%19356 0.000 0.006 0.030
hisgrep/artcncl00:00:00.000 0.0%4 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%4 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.285 0.0%17160 0.000 0.017 0.055
history sync00:00:00.046 0.0%380 0.000 0.121 1.000
history write00:00:00.485 0.0%2484 0.000 0.195 1.000
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:23.984100.0%23557 1296.635 3668.718 24017.880
nntp read00:00:00.668 0.0%20647 0.000 0.032 0.125
overview write00:00:00.623 0.0%1918 0.000 0.325 4.000
perl filter00:00:14.335 0.0%2484 1.714 5.771 24.333
python filter00:00:00.021 0.0%2484 0.000 0.008 0.250
site send00:00:00.785 0.0%3908 0.000 0.201 0.500
TOTAL: 24:01:06.65424:00:43.061100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.020 0.0%1962 0.000 0.010 0.333
article prepare00:00:00.001 0.0%52 0.000 0.019 0.250
article read00:00:00.007 0.0%13 0.000 0.538 3.000
backlog stats00:00:00.126 0.0%24462 0.000 0.005 0.031
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.339 0.0%12146 0.000 0.028 0.182
data write00:00:00.577 0.0%10264 0.000 0.056 0.182
idle23:59:45.772100.0%24462 1415.939 3531.427 10537.544
status file00:00:07.717 0.0%334 1.000 23.105 84.000
TOTAL: 23:59:58.32023:59:54.559100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:06:32.768 66.7%4760 0.000 82.514 63380.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.416 0.1%10362 0.000 0.040 1.000
readart00:00:00.001 0.0%2 0.500 0.500 0.500
TOTAL: 00:09:48.50400:06:33.185 66.8%----

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 4 1902 716 1185 1 37%23:55:41
2news.samoylyk.net 2 2051 516 1535 0 25%26:08:27
3news.nntp4.net 2 2531 410 1622 499 16%24:45:24
4news.glou.org 4 2465 227 2129 109 9%44:15:01
5nntp.terraraq.uk 5 809 84 719 6 10%16:23:00
6usenet.pasdenom.info 11 788 33 754 1 4%21:42:38
7gegeweb-out.news.tnetconsulting.net 5 1310 26 1282 2 1%23:37:37
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 58 11856 2012 9226 618 16%180:47:48
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.samoylyk.net2.6 MB0.0 KB0.0 KB2.6 MB100%5.2 KB
2feed-out.gegeweb.org2.2 MB0.0 KB1.9 KB2.2 MB 99%3.1 KB
3news.nntp4.net1.6 MB0.0 KB6.1 MB7.7 MB 20%8.7 KB
4news.glou.org728.0 KB0.0 KB473.6 KB1.2 MB 60%3.6 KB
5nntp.terraraq.uk236.6 KB0.0 KB12.6 KB249.2 KB 94%2.8 KB
6gegeweb-out.news.tnetconsulting.net85.9 KB0.0 KB5.4 KB91.3 KB 94%3.3 KB
7usenet.pasdenom.info72.8 KB0.0 KB1.2 KB74.0 KB 98%2.2 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 87.5 MB0.0 KB6.6 MB14.1 MB 53%5.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 10 04:15:01 - 04:59:59 28 1.5% 0.0189.8 KB 1.2% 0.03
Oct 10 05:00:00 - 05:59:59 32 1.7% 0.01203.1 KB 2.8% 0.06
Oct 10 06:00:00 - 06:59:59 17 0.9% 0.0043.0 KB 0.6% 0.01
Oct 10 07:00:00 - 07:59:59 39 2.0% 0.01116.3 KB 1.6% 0.03
Oct 10 08:00:00 - 08:59:59 43 2.2% 0.01162.3 KB 2.2% 0.05
Oct 10 09:00:00 - 09:59:59 61 3.2% 0.02258.9 KB 3.6% 0.07
Oct 10 10:00:00 - 10:59:59 68 3.6% 0.02228.2 KB 3.1% 0.06
Oct 10 11:00:00 - 11:59:59 89 4.6% 0.02246.6 KB 3.4% 0.07
Oct 10 12:00:00 - 12:59:59 63 3.3% 0.02206.1 KB 2.8% 0.06
Oct 10 13:00:00 - 13:59:59 166 8.7% 0.05702.8 KB 9.7% 0.20
Oct 10 14:00:00 - 14:59:59 108 5.6% 0.03438.2 KB 6.0% 0.12
Oct 10 15:00:00 - 15:59:59 72 3.8% 0.02272.3 KB 3.7% 0.08
Oct 10 16:00:00 - 16:59:59 65 3.4% 0.02209.9 KB 2.9% 0.06
Oct 10 17:00:00 - 17:59:59 59 3.1% 0.02222.8 KB 3.1% 0.06
Oct 10 18:00:00 - 18:59:59 98 5.1% 0.03309.4 KB 4.3% 0.09
Oct 10 19:00:00 - 19:59:59 162 8.5% 0.04676.9 KB 9.3% 0.19
Oct 10 20:00:00 - 20:59:59 105 5.5% 0.03360.2 KB 5.0% 0.10
Oct 10 21:00:00 - 21:59:59 132 6.9% 0.04418.7 KB 5.8% 0.12
Oct 10 22:00:00 - 22:59:59 130 6.8% 0.04487.3 KB 6.7% 0.14
Oct 10 23:00:00 - 23:59:59 96 5.0% 0.03360.6 KB 5.0% 0.10
Oct 11 00:00:00 - 00:59:59 94 4.9% 0.03438.9 KB 6.0% 0.12
Oct 11 01:00:00 - 01:59:59 60 3.1% 0.02197.8 KB 2.7% 0.05
Oct 11 02:00:00 - 02:59:59 55 2.9% 0.02352.2 KB 4.8% 0.10
Oct 11 03:00:00 - 03:59:59 51 2.7% 0.01185.5 KB 2.6% 0.05
Oct 11 04:00:00 - 04:15:01 21 1.1% 0.0281.4 KB 1.1% 0.09
TOTAL: 24:00:00 1914 100.0% 0.027.1 MB 100.0% 0.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 493 334 0 0 0 0 0 0 159
2news.glou.org 64 0 0 0 0 0 0 0 64
3nntp.terraraq.uk 5 0 0 0 0 0 0 0 5
4gegeweb-out.news.tnetconsulting.net 2 0 0 0 0 0 0 0 2
5usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
6feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 6 566 334 0 0 0 0 0 0 232

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 305
linux.kernel.git 29
TOTAL: 2 334

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 102
Bad path (news.giganews.com.POSTED) 63
Too many newsgroups (low_xpost) 33
Binary: misplaced binary 21
EMP (phn path) 12
Cancels abusifs 1
TOTAL: 6 232

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 3378 8 1902 4 0 45 0%23:56:42
2news.samoylyk.net 1606 1 1380 0 0 0 0%23:36:37
3i2pn.org 0 0 0 0 0 1911 0%24:00:00
4news.gegeweb.org 1329 0 1189 0 0 0 0%23:55:42
5news.nntp4.net 1615 0 1516 0 0 0 0%23:53:00
6nntp.terraraq.uk 1050 0 968 0 0 2 0%23:27:23
7news.aioe.org 0 0 0 0 0 1619 0%24:00:00
8news.pasdenom.info 1392 0 1351 0 0 0 0%23:41:11
TOTAL: 8 10370 9 8306 4 0 3577 0%190:30:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net19.8 KB51.2 KB71.0 KB0.0 KB/s5.9 KB23:56:42
2news.samoylyk.net2.8 KB0.0 KB2.8 KB0.0 KB/s2.8 KB23:36:37
3i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
4news.gegeweb.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:55:42
5news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:00
6nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:27:23
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:41:11
TOTAL: 822.7 KB51.2 KB73.9 KB0.0 KB/s5.7 KB190:30:35
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12603:6010:6802:4ca5:1a03:73ff:fe28:be0f 34 228.9 KB 1 0 000:00:43
TOTAL: 1 34 228.9 KB 1 0 000:09:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 37 228.9 KB 1 0 000:00:46
2*.infrawat.ch 4 00.0 KB 0 0 000:00:01
3*.172.132.66.censys-scanner.com 8 00.0 KB 0 0 000:00:13
4unresolved 39 00.0 KB 0 0 000:00:28
5*.ip.linodeusercontent.com 16 00.0 KB 0 0 000:00:19
6*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
7*.gegeweb.eu 288 00.0 KB 0 0 000:00:39
8*.scanner.modat.io 1 00.0 KB 0 0 000:00:29
9*.terraraq.uk1023 00.0 KB 0 0 000:06:32
10*.monitoring.internet-measurement.com 21 00.0 KB 0 0 000:00:18
TOTAL: 101438 228.9 KB 1 0 000:09:50

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mantic.terraraq.uk 24.477 20.386 0.00000:06:32
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f 1.142 0.965 0.00000:00:43
mail.gegeweb.eu 4.839 4.628 1.72900:00:39
o032.scanner.modat.io 0.042 0.021 0.00000:00:29
172-104-209-26.ip.linodeusercontent.com 0.208 0.096 0.00000:00:16
205.172.132.66.censys-scanner.com 0.135 0.084 0.00000:00:09
20.169.84.56 0.011 0.011 0.00000:00:09
66.61.98.95 0.384 0.360 0.00000:00:08
215.172.132.66.censys-scanner.com 0.092 0.056 0.00000:00:03
104.152.52.236 0.158 0.069 0.00000:00:03
r5-240-f0.monitoring.internet-measurement.com 0.087 0.026 0.00000:00:03
r4-227-e3.monitoring.internet-measurement.com 0.025 0.030 0.00000:00:03
r3-128-80.monitoring.internet-measurement.com 0.035 0.018 0.00000:00:02
104.152.52.241 0.194 0.050 0.00000:00:02
104.152.52.237 0.020 0.008 0.00000:00:01
104.152.52.235 0.016 0.012 0.00000:00:01
r3-84-54.monitoring.internet-measurement.com 0.172 0.038 0.00000:00:01
2a01:4020:1:1:102::71b 0.009 0.014 0.00000:00:01
r3-96-60.monitoring.internet-measurement.com 0.146 0.056 0.00000:00:01
r5-109-6d.monitoring.internet-measurement.com 0.058 0.036 0.00000:00:01
TOTAL: 52 33.488 27.496 1.72900:09:50

Curious NNRP server explorers [Top 20]:

SystemConn
mantic.terraraq.uk 1023
mail.gegeweb.eu 288
66.61.98.95 20
172-104-209-26.ip.linodeusercontent.com 7
104.152.52.236 6
205.172.132.66.censys-scanner.com 5
212.102.40.218 3
215.172.132.66.censys-scanner.com 3
104.152.52.241 3
45-56-79-53.ip.linodeusercontent.com 2
172-239-64-84.ip.linodeusercontent.com 2
172-236-119-165.ip.linodeusercontent.com 2
r5-172-ac.monitoring.internet-measurement.com 1
r5-153-99.monitoring.internet-measurement.com 1
2602:f71d:400::20 1
173-255-225-25.ip.linodeusercontent.com 1
45-79-207-110.ip.linodeusercontent.com 1
64.205.72.182 1
45-79-115-134.ip.linodeusercontent.com 1
r5-77-4d.monitoring.internet-measurement.com 1
TOTAL: 52 1404

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
172-239-64-84.ip.linodeusercontent.com 7
104.152.52.241 5
172-236-119-165.ip.linodeusercontent.com 5
173-255-225-25.ip.linodeusercontent.com 5
120.210.203.35.bc.googleusercontent.com 4
104.152.52.238 2
172-104-209-26.ip.linodeusercontent.com 2
215.172.132.66.censys-scanner.com 1
205.172.132.66.censys-scanner.com 1
TOTAL: 9 32

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 5
Accept-Encoding: gzip 4
Accept: */* 4
Host: 45.13.105.36:563 3
User-Agent: Mozilla/5.0 (Macintosh; Inte... 3
#026#003#001 2
EHLO www.censys.io 2
Host: 45.13.105.36 1
EHLO 45.13.105.36 1
User-Agent: curl/7.61.1 1
#023#003#023#001#023#002#001 1
User-Agent: Hello from Palo Alto Network... 1
Host: 45.13.105.36:119 1
#001 1
Connection: close 1
MAIL FROM:<relaycheck_please_ignore@prot... 1
TOTAL: 16 32

NNRP client timeouts [Top 20]:

SystemConnPeer
205.172.132.66.censys-scanner.com 1 4
2a01:4020:1:1:102::71b 1 1
69-5-169-253.infrawat.ch 1 1
215.172.132.66.censys-scanner.com 1 2
TOTAL: 4 4 13

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