Daily Usenet report for news.niel.me

Nov 23 04:15:02 -- Nov 24 04:15:02

Unknown entries from news log file:

First 30 / 30 lines (100.0%)

Nov 23 09:42:59 rpi-studio innd: filter: No Cancel-Key[sha1:W1JJKLIxXgE1Mtz1o23hhO7n7l4=] matches Cancel-Lock[sha1:TVELVpYnvsx6b1RHwR8gIGkQk7I=] target=<sni8ve$e06$1@rasp.pasdenom.info>
Nov 23 10:16:57 rpi-studio innfeed[26956]: news.gegeweb.org:0 connect: Network is unreachable
Nov 23 10:19:05 rpi-studio innfeed[26956]: news.nntp4.net:0 connect: Network is unreachable
Nov 23 10:19:05 rpi-studio innfeed[26956]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 23 10:19:05 rpi-studio innfeed[26956]: news.pasdenom.info:0 connect: Network is unreachable
Nov 23 10:19:10 rpi-studio innfeed[26956]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 23 10:21:10 rpi-studio innfeed[26956]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 23 10:22:57 rpi-studio innfeed[26956]: news.gegeweb.org:0 connect: Network is unreachable
Nov 23 10:25:05 rpi-studio innfeed[26956]: news.nntp4.net:0 connect: Network is unreachable
Nov 23 10:25:05 rpi-studio innfeed[26956]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 23 10:25:05 rpi-studio innfeed[26956]: news.pasdenom.info:0 connect: Network is unreachable
Nov 23 10:33:10 rpi-studio innfeed[26956]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 23 10:46:57 rpi-studio innfeed[26956]: news.gegeweb.org:0 connect: Network is unreachable
Nov 23 10:49:05 rpi-studio innfeed[26956]: news.nntp4.net:0 connect: Network is unreachable
Nov 23 10:49:05 rpi-studio innfeed[26956]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 23 10:49:05 rpi-studio innfeed[26956]: news.pasdenom.info:0 connect: Network is unreachable
Nov 23 10:49:10 rpi-studio innfeed[26956]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 23 12:18:57 rpi-studio innfeed[26956]: news.gegeweb.org:0 connect: Network is unreachable
Nov 23 12:21:05 rpi-studio innfeed[26956]: news.nntp4.net:0 connect: Network is unreachable
Nov 23 12:21:05 rpi-studio innfeed[26956]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 23 12:21:05 rpi-studio innfeed[26956]: news.pasdenom.info:0 connect: Network is unreachable
Nov 23 12:21:10 rpi-studio innfeed[26956]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 23 13:21:10 rpi-studio innfeed[26956]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 23 14:18:57 rpi-studio innfeed[26956]: news.gegeweb.org:0 connect: Network is unreachable
Nov 23 14:21:05 rpi-studio innfeed[26956]: news.nntp4.net:0 connect: Network is unreachable
Nov 23 14:21:05 rpi-studio innfeed[26956]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 23 14:21:05 rpi-studio innfeed[26956]: news.pasdenom.info:0 connect: Network is unreachable
Nov 23 15:21:10 rpi-studio innfeed[26956]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 23 16:21:10 rpi-studio innfeed[26956]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 24 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:Yhuwef/Ih9WxbSvrg3hE5PlYicM=] matches Cancel-Lock[sha1:2d07WOb8KJ7/sN8l90g//k+sfrc=] target=<de-gruppen-finden-17.11.2021@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 4861 43.6%829.9 KB 48.4%
innd 3127 28.1%463.9 KB 27.1%
innfeed 1659 14.9%257.1 KB 15.0%
nnrpd 1487 13.4%162.7 KB 9.5%
nocem 3 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 11138 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 21496 64.1%
Negative hits 7089 21.1%
Do not exist 4767 14.2%
Cache misses 194 0.6%
TOTAL: 4 33546 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.027 0.0%13 0.000 2.077 4.333
article cancel00:00:00.004 0.0%19 0.000 0.211 1.000
article cleanup00:00:00.100 0.0%4766 0.000 0.021 0.125
article logging00:00:00.362 0.0%4798 0.000 0.075 0.176
article parse00:00:00.716 0.0%8369 0.000 0.086 0.250
article write00:00:03.918 0.0%4182 0.250 0.937 36.029
artlog/artcncl00:00:00.001 0.0%18 0.000 0.056 1.000
artlog/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
data move00:00:00.093 0.0%33152 0.000 0.003 0.020
hisgrep/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%19 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%19 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.464 0.0%33545 0.000 0.014 0.040
history sync00:00:00.034 0.0%381 0.000 0.089 0.667
history write00:00:00.966 0.0%4766 0.000 0.203 0.533
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:50:23.393 99.9%33919 320.126 2530.245300312.500
nntp read00:00:01.040 0.0%33267 0.000 0.031 0.073
overview write00:00:02.431 0.0%4182 0.077 0.581 5.450
perl filter00:00:19.666 0.0%4766 2.441 4.126 6.590
python filter00:00:00.009 0.0%4766 0.000 0.002 0.029
site send00:00:01.209 0.0%8370 0.000 0.144 0.458
TOTAL: 23:51:07.03623:50:54.433100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.047 0.0%5530 0.000 0.008 0.083
article prepare00:00:00.001 0.0%684 0.000 0.001 0.250
article read00:00:00.032 0.0%163 0.000 0.196 8.000
backlog stats00:00:00.114 0.0%54115 0.000 0.002 0.030
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.740 0.0%31172 0.000 0.024 0.050
data write00:00:01.888 0.0%28041 0.000 0.067 0.222
idle23:56:18.699100.0%54115 195.258 1592.510 18236.333
status file00:00:00.656 0.0%249 1.000 2.635 39.000
TOTAL: 23:56:26.09823:56:22.177100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%1 0.000 0.000 0.000
idle00:07:28.629 83.2%1016 21.500 441.564 5655.693
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.134 0.0%2475 0.000 0.054 0.333
readart00:00:00.045 0.0%105 0.429 0.429 0.429
TOTAL: 00:08:59.53900:07:28.808 83.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 2
reserve 2
TOTAL: 11 170

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 2 3336 1714 1570 52 51%18:29:23
2i2pn.org 2 4489 1048 3347 94 23%21:55:21
3news.nntp4.net 4 4651 815 3698 138 17%21:07:55
4feed-out.gegeweb.org 236 2999 313 2633 53 10%18:45:35
5nntp.terraraq.uk 2 4183 308 3610 265 7%19:28:44
6gegeweb-out.news.tnetconsulting.net 1 4005 45 3952 8 1%23:52:17
7usenet.pasdenom.info 2 541 9 531 1 1%06:52:17
8localhost 26 0 0 0 0 0%00:00:00
TOTAL: 8 275 24204 4252 19341 611 17%130:31:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org5.4 MB0.0 KB163.2 KB5.6 MB 97%3.3 KB
2news.nntp4.net4.7 MB0.0 KB384.5 KB5.1 MB 92%5.5 KB
3i2pn.org4.3 MB0.0 KB319.8 KB4.6 MB 93%4.1 KB
4nntp.terraraq.uk2.1 MB0.0 KB1003.0 KB3.1 MB 68%5.6 KB
5gegeweb-out.news.tnetconsulting.net1.4 MB0.0 KB34.8 KB1.4 MB 97%27.6 KB
6feed-out.gegeweb.org1.1 MB0.0 KB58.3 KB1.1 MB 94%3.2 KB
7usenet.pasdenom.info16.9 KB0.0 KB1.2 KB18.1 KB 93%1.8 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 819.0 MB0.0 KB1.9 MB20.9 MB 90%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 23 04:15:02 - 04:59:59 117 2.8% 0.04447.8 KB 0.0% 0.17
Nov 23 05:00:00 - 05:59:59 108 2.6% 0.03360.5 KB 0.0% 0.10
Nov 23 06:00:00 - 06:59:59 121 2.9% 0.03908.5 KB 0.0% 0.25
Nov 23 07:00:00 - 07:59:59 112 2.7% 0.03417.1 KB 0.0% 0.12
Nov 23 08:00:00 - 08:59:59 116 2.8% 0.03348.7 KB 4.7% 0.10
Nov 23 09:00:00 - 09:59:59 106 2.5% 0.03371.7 KB 5.0% 0.10
Nov 23 10:00:00 - 10:59:59 8 0.2% 0.00190.2 KB 2.5% 0.05
Nov 23 11:00:00 - 11:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 23 12:00:00 - 12:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 23 13:00:00 - 13:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 23 14:00:00 - 14:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 23 15:00:00 - 15:59:59 783 18.6% 0.223.4 MB 46.7% 0.97
Nov 23 16:00:00 - 16:59:59 282 6.7% 0.081017.0 KB 13.6% 0.28
Nov 23 17:00:00 - 17:59:59 245 5.8% 0.071.4 MB 19.5% 0.41
Nov 23 18:00:00 - 18:59:59 211 5.0% 0.06695.9 KB 9.3% 0.19
Nov 23 19:00:00 - 19:59:59 233 5.5% 0.06969.5 KB 12.9% 0.27
Nov 23 20:00:00 - 20:59:59 244 5.8% 0.07899.9 KB 12.0% 0.25
Nov 23 21:00:00 - 21:59:59 264 6.3% 0.07820.4 KB 11.0% 0.23
Nov 23 22:00:00 - 22:59:59 210 5.0% 0.06725.5 KB 9.7% 0.20
Nov 23 23:00:00 - 23:59:59 219 5.2% 0.06784.2 KB 10.5% 0.22
Nov 24 00:00:00 - 00:59:59 226 5.4% 0.06737.6 KB 9.9% 0.20
Nov 24 01:00:00 - 01:59:59 215 5.1% 0.06774.5 KB 10.3% 0.22
Nov 24 02:00:00 - 02:59:59 181 4.3% 0.05689.9 KB 9.2% 0.19
Nov 24 03:00:00 - 03:59:59 160 3.8% 0.04580.3 KB 7.7% 0.16
Nov 24 04:00:00 - 04:15:02 50 1.2% 0.06209.4 KB 2.8% 0.23
TOTAL: 24:00:00 4211 100.0% 0.057.3 MB 100.0% 0.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 222 0 0 0 0 0 0 0 222
2news.nntp4.net 166 0 0 0 0 0 0 0 166
3i2pn.org 86 0 0 0 0 0 0 0 86
4news-out.aioe.org 69 1 0 0 0 0 0 0 68
5feed-out.gegeweb.org 53 0 0 0 0 0 0 0 53
6gegeweb-out.news.tnetconsulting.net 18 0 0 0 0 0 0 0 18
7usenet.pasdenom.info 5 0 0 0 0 0 0 0 5
TOTAL: 7 619 1 0 0 0 0 0 0 618

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 173
Bad path (news.giganews.com.POSTED) 143
EMP (phn nph) 106
User-issued spam cancel 84
EMP (md5) 67
EMP (phl) 10
Cancel of non-existing ID <3cca438d-fd28-4b91-937f-4e157589c1ban@googlegroups.com> 1
Cancels abusifs 1
Cancel of non-existing ID <619cbfed$0$20253$426a74cc@news.free.fr> 1
TOTAL: 9 586

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com2022
TOTAL: 12022

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 17
news.nntp4.net 9
nntp.terraraq.uk 5
usenet.pasdenom.info 1
TOTAL: 4 32
TOTAL: 1 32

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 5530 42 3185 25 0 150 0%23:59:56
2news.gegeweb.org 3952 14 3732 68 0 20 0%23:59:56
3news.pasdenom.info 4788 9 3606 5 0 5 0%23:59:56
4news.tnetconsulting.net 6272 5 4200 3 0 1154 0%23:59:56
5news.nntp4.net 4017 1 3404 0 0 1 0%23:59:56
6news.aioe.org 1802 0 1732 0 0 0 0%18:56:26
7nntp.terraraq.uk 2795 0 2713 0 0 4 0%23:59:07
TOTAL: 7 29156 71 22572 101 0 1334 0%162:55:13
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org111.4 KB51.1 KB162.5 KB0.0 KB/s2.4 KB23:59:56
2news.gegeweb.org46.2 KB269.1 KB315.3 KB0.0 KB/s3.8 KB23:59:56
3news.pasdenom.info34.1 KB401.8 KB436.0 KB0.0 KB/s31.1 KB23:59:56
4news.tnetconsulting.net14.8 KB11.2 KB26.0 KB0.0 KB/s3.2 KB23:59:56
5news.nntp4.net2.9 KB0.0 KB2.9 KB0.0 KB/s2.9 KB23:59:56
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s018:56:26
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:07
TOTAL: 7209.5 KB733.2 KB942.7 KB0.0 KB/s5.5 KB162:55:13
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 1 43464.2 KB 5 0 000:07:04
TOTAL: 1 1 43464.2 KB 5 0 000:08:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 1 43464.2 KB 5 0 000:07:04
2unresolved 3 00.0 KB 0 0 000:00:04
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4*.gegeweb.eu 233 00.0 KB 0 0 000:01:49
TOTAL: 4 238 43464.2 KB 5 0 000:08:59

NNRP auth users [Top 20]:

UserConn
mailman 233
TOTAL: 1 233

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
108b-gniel 0.037 0.083 0.00000:07:04
sys.gegeweb.eu 6.378 7.422 2.36600:01:49
23.129.64.132 0.030 0.030 0.00000:00:03
88.165.5.23 0.083 0.038 0.00000:00:01
scanner-21.ch1.censys-scanner.com 0.026 0.035 0.00000:00:00
TOTAL: 5 6.554 7.608 2.36600:08:59

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 233
88.165.5.23 2
23.129.64.132 1
scanner-21.ch1.censys-scanner.com 1
TOTAL: 4 237

NNRP client timeouts [Top 20]:

SystemConnPeer
scanner-21.ch1.censys-scanner.com 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1fr 39 90.7%
2grisbi 4 9.3%
TOTAL: 2 43100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 36
2fr.usenet.distribution 2
3grisbi.devel 2
4grisbi.test 2
5fr.comp.usenet.serveurs 1
TOTAL: 5 43