Daily Usenet report for news.niel.me

Jan 3 04:15:01 -- Jan 4 04:15:01

Unknown entries from news log file:

First 50 / 4185 lines (1.2%)

Jan 3 06:56:00 rpi-studio nnrpd[1276]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:00:08 rpi-studio nnrpd[1296]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:00:23 rpi-studio nnrpd[1300]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:00:30 rpi-studio nnrpd[1306]: 2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 noperm ihave without permission
Jan 3 07:00:38 rpi-studio nnrpd[1460]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:00:54 rpi-studio nnrpd[1475]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:01:09 rpi-studio nnrpd[1478]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:01:24 rpi-studio nnrpd[1479]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:01:39 rpi-studio nnrpd[1487]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:01:54 rpi-studio nnrpd[1489]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:02:09 rpi-studio nnrpd[1517]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:02:24 rpi-studio nnrpd[1694]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:02:39 rpi-studio nnrpd[1697]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:02:55 rpi-studio nnrpd[1698]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:03:10 rpi-studio nnrpd[1702]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:03:11 rpi-studio nnrpd[1701]: i2pn.org noperm ihave without permission
Jan 3 07:03:25 rpi-studio nnrpd[1705]: 2a03:f80:ed31:8c5a::1 noperm ihave without permission
Jan 3 07:18:42 rpi-studio nnrpd[1310]: i2pn.org noperm ihave without permission
Jan 3 07:22:50 rpi-studio nnrpd[1275]: i2pn.org noperm ihave without permission
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for soc.culture.israel
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for 2D7B95264254198D393E4F255891263D
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for soc.culture.jewish
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for 5327AB9516A7BE0C43EA80CFF5829792
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for misc.transport.road
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for 3B123212FC863A7B61F67E18DA03861B
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for rec.food.cooking
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for E5956BC655032E900DAC776BE3F97CA2
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for talk.politics.guns
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for 1633143D8B4EAA301E9353C605555667
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for talk.origins
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for D099A2E8DA366E25B8B3BBF4F4300E5F
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for D099A2E8DA366E25B8B3BBF4F4300E5F
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for rec.bicycles.tech
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for 43A26371D155AEAAAF24467FA2B29D06
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for 1633143D8B4EAA301E9353C605555667
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for sci.math
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for DC1DEFB77601B6EBA1AF059E4A05184A
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for rec.arts.sf.written
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for A7105B0B110DFB9901102462B406B31A
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for rec.aviation.soaring
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for D580E190DB1FC2D19059D61DE43634C1
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for soc.culture.indian
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for 073B1E7DC984EE1113914E20F0B15F7D
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for fr.misc.actualite.covid19
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for 6836D788431CB90ADEED7BC2B5D9FB07
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for 1633143D8B4EAA301E9353C605555667
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for 43A26371D155AEAAAF24467FA2B29D06
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for rec.music.classical.recordings
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for 20ED7ECC134B507C9DB32B571CE089AA
Jan 3 07:23:21 rpi-studio innd: tradindexed: index inode mismatch for DC1DEFB77601B6EBA1AF059E4A05184A

Log entries by program:

Program nameLines%LinesSize%Size
innd 6544 45.2%825.8 KB 39.9%
inn 3824 26.4%750.4 KB 36.2%
nnrpd 2193 15.2%235.2 KB 11.4%
innfeed 1902 13.1%260.1 KB 12.6%
nocem 4 0.0%0.2 KB 0.0%
controlchan 4 0.0%0.2 KB 0.0%
rnews 1 0.0%0.1 KB 0.0%
TOTAL: 7 14472 100.0%2.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 24449 64.7%
Negative hits 9585 25.4%
Do not exist 3733 9.9%
Cache misses 24 0.1%
TOTAL: 4 37791 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.027 0.0%14 1.000 1.929 3.000
article cancel00:00:00.003 0.0%15 0.000 0.200 1.000
article cleanup00:00:00.076 0.0%3746 0.000 0.020 0.143
article logging00:00:00.252 0.0%3769 0.000 0.067 0.300
article parse00:00:00.748 0.0%8816 0.000 0.085 0.250
article write00:00:06.001 0.0%3575 0.250 1.679 3.462
artlog/artcncl00:00:00.002 0.0%15 0.000 0.133 1.000
artlog/artcncl/perl00:00:00.002 0.0%14 0.000 0.143 1.000
data move00:00:00.131 0.0%41449 0.000 0.003 0.019
hisgrep/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%14 0.000 0.000 0.000
hisgrep/perl00:00:00.007 0.0%17 0.000 0.412 4.000
hishave/artcncl00:00:00.000 0.0%15 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:03.739 0.0%37924 0.000 0.099 0.384
history sync00:00:00.055 0.0%397 0.000 0.139 1.000
history write00:00:01.982 0.0%3746 0.050 0.529 1.314
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:40:20.001 99.9%42124 865.033 2023.075621238.000
nntp read00:00:01.355 0.0%41674 0.009 0.033 0.087
overview write00:00:03.770 0.0%3575 0.154 1.055 3.111
perl filter00:00:16.537 0.0%3746 2.727 4.415 14.059
python filter00:00:00.008 0.0%3747 0.000 0.002 0.111
site send00:00:01.527 0.0%7218 0.000 0.212 0.471
TOTAL: 23:41:29.00823:40:56.223100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%3933 0.000 0.006 0.105
article prepare00:00:00.000 0.0%136 0.000 0.000 0.000
article read00:00:00.018 0.0%28 0.000 0.643 8.000
backlog stats00:00:00.114 0.0%34747 0.000 0.003 0.023
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.449 0.0%18615 0.000 0.024 0.092
data write00:00:00.970 0.0%15331 0.000 0.063 0.263
idle23:19:38.335100.0%34747 914.991 2416.851 9101.455
status file00:00:00.712 0.0%308 1.000 2.312 7.000
TOTAL: 23:19:51.23623:19:40.620100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:09.278 61.2%1537 11.600 123.148 5238.545
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.106 0.0%4163 0.000 0.025 0.273
readart00:00:00.064 0.0%55 0.000 1.164 5.000
TOTAL: 00:05:09.43400:03:09.448 61.2%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 148
name 2
pause 2
paused 2
reload 6
reserve 2
shutdown 3
TOTAL: 12 177

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 2 3192 1536 1617 39 48%20:36:35
2i2pn.org 2 3790 979 2749 62 25%24:44:26
3news.glou.org 3 3769 438 3312 19 11%28:02:09
4feed-out.gegeweb.org 6 2059 255 1804 0 12%20:12:53
5usenet.pasdenom.info 3 2630 248 2381 1 9%25:46:10
6nntp.terraraq.uk 3 2232 101 2131 0 4%17:44:07
7news.nntp4.net 3 2418 32 2322 64 1%16:44:06
8news.samoylyk.net 3 2293 22 2271 0 0%16:36:14
92001:41d0:2:abb2::119 1 12 12 0 0 100%00:03:10
10gegeweb-out.news.tnetconsulting.net 4 2399 9 2390 0 0%18:43:23
11localhost 25 1 1 0 0 100%00:00:00
1246.165.242.75 1 2 1 1 0 50%00:02:58
TOTAL: 12 56 24797 3634 20978 185 14%189:16:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org5.7 MB0.0 KB137.8 KB5.9 MB 97%3.8 KB
2news.glou.org5.0 MB0.0 KB172.2 KB5.2 MB 96%11.6 KB
3i2pn.org3.3 MB0.0 KB202.2 KB3.5 MB 94%3.4 KB
4news.samoylyk.net2.2 MB0.0 KB0.0 KB2.2 MB100%100.2 KB
5feed-out.gegeweb.org859.6 KB0.0 KB0.0 KB859.6 KB100%3.4 KB
6usenet.pasdenom.info596.4 KB0.0 KB1.2 KB597.6 KB 99%2.4 KB
7news.nntp4.net405.7 KB0.0 KB533.6 KB939.3 KB 43%9.8 KB
8nntp.terraraq.uk298.3 KB0.0 KB0.0 KB298.3 KB100%3.0 KB
92001:41d0:2:abb2::11947.0 KB0.0 KB0.0 KB47.0 KB100%3.9 KB
10gegeweb-out.news.tnetconsulting.net26.0 KB0.0 KB0.0 KB26.0 KB100%2.9 KB
1146.165.242.755.5 KB0.0 KB0.0 KB5.5 KB100%5.5 KB
12localhost1.1 KB0.0 KB0.0 KB1.1 KB100%1.1 KB
TOTAL: 1218.3 MB0.0 KB1.0 MB19.4 MB 94%5.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 3 04:15:01 - 04:59:59 76 2.1% 0.03465.5 KB 2.5% 0.17
Jan 3 05:00:00 - 05:59:59 94 2.6% 0.03384.9 KB 2.0% 0.11
Jan 3 06:00:00 - 06:59:59 115 3.2% 0.03318.3 KB 1.7% 0.09
Jan 3 07:00:00 - 07:59:59 108 3.0% 0.03375.6 KB 2.0% 0.10
Jan 3 08:00:00 - 08:59:59 100 2.8% 0.03375.6 KB 2.0% 0.10
Jan 3 09:00:00 - 09:59:59 136 3.8% 0.04542.4 KB 2.9% 0.15
Jan 3 10:00:00 - 10:59:59 140 3.9% 0.04547.2 KB 2.9% 0.15
Jan 3 11:00:00 - 11:59:59 111 3.1% 0.03362.3 KB 1.9% 0.10
Jan 3 12:00:00 - 12:59:59 140 3.9% 0.04624.9 KB 3.3% 0.17
Jan 3 13:00:00 - 13:59:59 158 4.4% 0.04503.1 KB 2.7% 0.14
Jan 3 14:00:00 - 14:59:59 140 3.9% 0.04438.6 KB 2.3% 0.12
Jan 3 15:00:00 - 15:59:59 128 3.6% 0.04853.9 KB 4.5% 0.24
Jan 3 16:00:00 - 16:59:59 172 4.8% 0.051.6 MB 9.0% 0.47
Jan 3 17:00:00 - 17:59:59 266 7.4% 0.07973.2 KB 5.2% 0.27
Jan 3 18:00:00 - 18:59:59 180 5.0% 0.05769.0 KB 4.1% 0.21
Jan 3 19:00:00 - 19:59:59 170 4.7% 0.05742.0 KB 3.9% 0.21
Jan 3 20:00:00 - 20:59:59 201 5.6% 0.06751.0 KB 4.0% 0.21
Jan 3 21:00:00 - 21:59:59 181 5.0% 0.05870.6 KB 4.6% 0.24
Jan 3 22:00:00 - 22:59:59 185 5.1% 0.05627.6 KB 3.3% 0.17
Jan 3 23:00:00 - 23:59:59 180 5.0% 0.051.4 MB 7.6% 0.39
Jan 4 00:00:00 - 00:59:59 213 5.9% 0.061.4 MB 7.6% 0.40
Jan 4 01:00:00 - 01:59:59 154 4.3% 0.041.0 MB 5.7% 0.30
Jan 4 02:00:00 - 02:59:59 112 3.1% 0.031.3 MB 6.9% 0.36
Jan 4 03:00:00 - 03:59:59 110 3.1% 0.031.2 MB 6.5% 0.34
Jan 4 04:00:00 - 04:15:01 28 0.8% 0.03143.3 KB 0.8% 0.16
TOTAL: 24:00:00 3598 100.0% 0.0418.4 MB 100.0% 0.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 69 0 0 0 0 0 0 0 69
2i2pn.org 54 0 0 0 0 0 0 0 54
3news-out.aioe.org 43 2 0 0 0 0 0 0 41
4news.glou.org 15 0 0 0 0 0 0 0 15
5news.samoylyk.net 12 0 0 0 0 0 0 0 12
6feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
7nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
8usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
TOTAL: 8 197 2 0 0 0 0 0 0 195

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
fr.petites-annonces.divers 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 95
Bad path (news.giganews.com.POSTED) 66
Too many newsgroups 6
Cancel of <dalton-B6721B.03083803012023@news.eternal-september.org> without Cancel-Key 1
Cancels abusifs 1
No Cancel-Key matches Cancel-Lock. target=<63b3e959$0$22269$426a74cc@news.free.fr> 1
EMP (phl) 1
TOTAL: 7 171

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.samoylyk.net 12
news-out.aioe.org 7
feed-out.gegeweb.org 2
news.nntp4.net 2
i2pn.org 1
TOTAL: 5 24
TOTAL: 1 24

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 4713 13 2606 1 0 45 0%23:43:48
2news.tnetconsulting.net 2468 3 1537 1 0 2098 0%23:43:44
3news.nntp4.net 1706 2 1525 0 0 2089 0%23:43:48
4nntp.terraraq.uk 1125 2 986 0 0 1464 0%23:43:37
5news.aioe.org 1575 2 1469 1 0 43 0%23:35:07
6news.gegeweb.org 1428 1 1391 8 0 1970 0%23:43:48
7news.samoylyk.net 1797 0 1549 1 0 2075 0%23:43:36
8news.pasdenom.info 1382 0 1253 0 0 1782 0%23:43:48
TOTAL: 8 16194 23 12316 12 0 11566 0%189:41:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org41.0 KB4.3 KB45.3 KB0.0 KB/s3.2 KB23:43:48
2news.aioe.org32.8 KB1.9 KB34.7 KB0.0 KB/s11.6 KB23:35:07
3news.tnetconsulting.net9.0 KB4.3 KB13.3 KB0.0 KB/s3.3 KB23:43:44
4news.nntp4.net8.0 KB0.0 KB8.0 KB0.0 KB/s4.0 KB23:43:48
5nntp.terraraq.uk5.7 KB0.0 KB5.7 KB0.0 KB/s2.9 KB23:43:37
6news.gegeweb.org1.1 KB18.0 KB19.1 KB0.0 KB/s2.1 KB23:43:48
7news.samoylyk.net0.0 KB4.3 KB4.3 KB0.0 KB/s4.3 KB23:43:36
8news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:43:48
TOTAL: 897.7 KB32.7 KB130.4 KB0.0 KB/s3.7 KB189:41:16
Outgoing feeds (innfeed) by Volume

Rnews connections rejected:

ReasonConn
What server? 1
TOTAL: 1 1

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1news.niel.me 2 1010.5 KB 2 0 000:00:43
22a0e:e701:1154:0:e92d:9ddf:e4a7:af79 4 59.4 KB 4 0 000:01:17
32a0e:e701:1154:0:3a98:c3a7:259:800a 1 11.1 KB 1 1 000:01:56
TOTAL: 3 7 1621.0 KB 7 1 000:05:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.niel.me 2 1010.5 KB 2 0 000:00:43
2? 21 610.5 KB 5 1 000:03:17
3*.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:10
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
5unresolved 2 00.0 KB 0 0 000:00:14
6*.gegeweb.eu 284 00.0 KB 0 0 000:00:39
7*.org 3 00.0 KB 0 0 000:00:02
TOTAL: 7 314 1621.0 KB 7 1 000:05:08

NNRP auth users [Top 20]:

UserConn
mailman 284
gerald 4
TOTAL: 2 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2a0e:e701:1154:0:3a98:c3a7:259:800a 0.095 0.038 0.00000:01:56
2a0e:e701:1154:0:e92d:9ddf:e4a7:af79 0.316 0.146 0.03400:01:17
news.niel.me 0.053 0.062 0.00000:00:43
mail.gegeweb.eu 7.372 7.591 2.33400:00:33
ec2-18-144-66-158.us-west-1.compute.amazonaws.com 0.052 0.043 0.00000:00:10
107.170.251.5 0.012 0.036 0.00000:00:09
sys.gegeweb.eu 0.046 0.065 0.02100:00:05
107.170.235.10 0.021 0.031 0.00000:00:04
2a03:f80:ed31:8c5a::1 0.394 0.334 0.00000:00:02
i2pn.org 0.079 0.089 0.00000:00:02
compassionate.monitoring.internet-measurement.com 0.027 0.018 0.00000:00:01
2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 0.023 0.000 0.00000:00:00
TOTAL: 12 8.490 8.453 2.38900:05:08

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 282
2a03:f80:ed31:8c5a::1 15
i2pn.org 3
sys.gegeweb.eu 2
107.170.251.5 1
107.170.235.10 1
compassionate.monitoring.internet-measurement.com 1
ec2-18-144-66-158.us-west-1.compute.amazonaws.com 1
2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4 1
TOTAL: 9 307

NNRP unrecognized commands (by host):

SystemConn
107.170.235.10 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_45.13.105.36_119 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1local 12 75.0%
2comp 2 12.5%
3fr 1 6.2%
4grisbi 1 6.2%
TOTAL: 4 16100.0%

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

NewsgroupCount
1local.test 12
2comp.sys.raspberry-pi 2
3grisbi.test 1
4fr.usenet.forums.evolution 1
TOTAL: 4 16
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me