usenet.goja.nl.eu.org Daily Usenet report

Dec 15 00:03:00 -- Dec 16 00:03:00

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Dec 15 01:32:04 goja innd[58649]: filter: No Cancel-Key[sha1:+0JxjMzNoeqytjs0/d3bUcCZlZQ= sha256:eSi/3Th/lh4r7RL5QOtc06I40M3nifX3Gv/a0QEPxdI=] matches Cancel-Lock[sha1:2jiwtLZDpL+iF41uBGY5PVPPfdI= sha256:DXdtRpHbdMK1HBg1tF0Gxg6eIt7tGCxW3djKlcbuLhY=] target=<10hnks6$1qquq$1@gwaiyur.mb-net.net>
Dec 15 01:33:03 goja innd[58649]: filter: No Cancel-Key[sha1:G6n8NNdsQJtfE5je/4TPUTqqxik= sha256:LiNhnV6/x9vZy0IYIil9xEZO3mRRvfAVfFbWXMSChVU=] matches Cancel-Lock[sha1:xw6qHNzxaHHsfW+vFUwDKhLzC8g= sha256:W5bR+/16qnrFVPjKKHvMTE05n5pOQegtzu1K2vv02r0=] target=<10hnku2$1qquq$2@gwaiyur.mb-net.net>
Dec 15 02:13:04 goja innd[58649]: filter: No Cancel-Key[sha1:meZrbvTGIlzXVXCQPKS5v5pvuNc= sha256:/hZ6HVa6TSd6r4TjyTchWKgqTh9quwMmzGQgBpADni8=] matches Cancel-Lock[sha1:uzTPKP9cUv3pOV7bOXvqPighC5k= sha256:FEw/pmcywpYmumJ9hT5lifAiJYNX87g4XaB77CPanCo=] target=<10hnkvu$1qquq$4@gwaiyur.mb-net.net>
Dec 15 17:00:06 goja pgpverify[72916]: pgpverify: verification failed
Dec 15 17:00:11 goja pgpverify[88719]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 15554 32.4%4.4 MB 53.6%
nnrpd 14995 31.3%1.6 MB 19.9%
innd 13086 27.3%1.6 MB 20.3%
innfeed 4223 8.8%508.5 KB 6.1%
nocem 54 0.1%7.2 KB 0.1%
controlchan 23 0.0%4.7 KB 0.1%
pgpverify 2 0.0%0.4 KB 0.0%
TOTAL: 7 47937 100.0%8.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 99460 63.4%
Negative hits 41580 26.5%
Do not exist 15465 9.9%
Cache misses 310 0.2%
TOTAL: 4 156815 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.110 0.0%5 0.000 22.000 108.000
article cancel00:00:00.000 0.0%30 0.000 0.000 0.000
article cleanup00:00:00.209 0.0%15509 0.000 0.013 0.056
article logging00:00:00.227 0.0%15544 0.000 0.015 0.060
article parse00:00:00.508 0.0%33444 0.000 0.015 0.060
article write00:00:03.044 0.0%14420 0.047 0.211 1.099
artlog/artcncl/perl00:00:00.000 0.0%5 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%6 0.000 0.000 0.000
data move00:00:00.124 0.0%142681 0.000 0.001 0.006
hisgrep/artcncl/perl00:00:00.000 0.0%5 0.000 0.000 0.000
hisgrep/perl00:00:00.007 0.0%32 0.000 0.219 7.000
hishave/artcncl/perl00:00:00.001 0.0%5 0.000 0.200 1.000
hishave/artparse00: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.939 0.0%157640 0.001 0.006 0.013
history sync00:00:00.241 0.0%410 0.000 0.588 8.667
history write00:00:01.355 0.0%15505 0.021 0.087 0.295
hiswrite/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:31:54.082 98.0%152043 328.355 557.172 966.484
nntp read00:00:04.834 0.0%151480 0.004 0.032 0.074
overview write00:00:02.972 0.0%14420 0.043 0.206 1.267
perl filter00:00:34.435 0.0%15503 1.856 2.221 3.453
python filter00:00:00.815 0.0%15503 0.000 0.053 0.125
site send00:00:02.324 0.0%28892 0.019 0.080 0.308
TOTAL: 2423:32:46.227 98.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.245 0.0%15656 0.000 0.016 1.157
article prepare00:00:00.032 0.0%195028 0.000 0.000 0.001
article read00:00:01.229 0.0%13564 0.012 0.091 0.609
backlog stats00:00:00.560 0.0%366523 0.000 0.002 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:26.216 0.0%227537 0.011 0.115 0.340
data write00:00:05.388 0.0%219318 0.009 0.025 0.090
idle23:49:38.199 99.8%366523 138.220 234.032 428.018
status file00:00:00.542 0.0%764 0.000 0.709 1.750
TOTAL: 923:50:12.411 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle23:45:59.700 98.0%15321 78.532 5584.472 10308.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:29:34.722 2.0%26190847 0.000 0.068 0.823
readart00:00:00.028 0.0%70 0.200 0.400 0.458
TOTAL: 424:15:34.450100.0%----

Control commands to innd:

CommandNumber
flush 6
flushlogs 2
go 2
logmode 2
lowmark 1
mode 150
name 2
pause 2
paused 2
reload 720
reserve 2
TOTAL: 11 891

Control channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002202
TOTAL002202

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1goja-out.feeder.erje.net 1199 29033 7891 20719 423 27%105:43:37
2goja-out.news.weretis.net 2 16030 3277 12540 213 20%47:28:21
3news.nntp4.net 2 6027 869 5019 139 14%22:58:14
4news.quux.org 2 9838 484 9353 1 4%33:08:37
5news.samoylyk.net 2 13654 419 13227 8 3%41:34:38
6pasdenom.info 1 3035 314 2720 1 10%17:39:57
7news.chmurka.net 1 7701 293 7408 0 3%42:09:49
8newsfeed.bofh.team 2 8197 282 7859 56 3%21:31:14
9newsfeed.endofthelinebbs.com 2 4966 275 4660 31 5%25:31:45
10news.1d4.us 1 6657 251 6181 225 3%29:12:57
11news.furie.org.uk 1 4227 57 4170 0 1%23:59:57
12nntp.terraraq.uk 2 2626 47 2579 0 1%21:21:16
13goja-out.news.tnetconsulting.net 2 3275 35 3240 0 1%23:59:44
14news.bbs.nz 3 7516 32 7484 0 0%24:58:03
15newsfeed.dotsrc.org 251 1477 3 1474 0 0%23:55:13
16localhost 1 0 0 0 0 0%00:00:00
TOTAL: 16 1474 124259 14529 108633 1097 11%505:13:22
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1goja-out.feeder.erje.net22.5 MB0.0 KB3.3 MB25.9 MB 87%3.2 KB
2goja-out.news.weretis.net7.5 MB19.7 KB657.4 KB8.2 MB 91%2.4 KB
3news.nntp4.net2.8 MB0.0 KB1.7 MB4.5 MB 62%4.6 KB
4news.samoylyk.net1.8 MB107.5 KB6.7 KB1.9 MB 94%4.5 KB
5news.quux.org892.5 KB19.7 KB0.0 KB912.1 KB 97%1.9 KB
6news.chmurka.net730.7 KB0.0 KB0.0 KB730.7 KB100%2.5 KB
7newsfeed.endofthelinebbs.com655.4 KB0.0 KB148.8 KB804.2 KB 81%2.6 KB
8newsfeed.bofh.team572.6 KB15.3 KB1.0 MB1.6 MB 34%4.9 KB
9pasdenom.info508.9 KB0.0 KB1.5 KB510.4 KB 99%1.6 KB
10news.1d4.us413.3 KB1.2 KB644.3 KB1.0 MB 39%2.2 KB
11nntp.terraraq.uk174.1 KB0.0 KB0.0 KB174.1 KB100%3.7 KB
12goja-out.news.tnetconsulting.net118.5 KB0.0 KB0.0 KB118.5 KB100%3.4 KB
13news.furie.org.uk97.4 KB0.0 KB0.0 KB97.4 KB100%1.7 KB
14news.bbs.nz61.2 KB0.0 KB0.0 KB61.2 KB100%1.9 KB
15newsfeed.dotsrc.org21.9 KB0.0 KB0.0 KB21.9 KB100%7.3 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1638.8 MB163.2 KB7.5 MB46.4 MB 83%3.0 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 15 00:03:00 - 00:59:59 499 3.5% 0.151.1 MB 2.8% 0.33
Dec 15 01:00:00 - 01:59:59 517 3.6% 0.14950.5 KB 2.4% 0.26
Dec 15 02:00:00 - 02:59:59 476 3.3% 0.13887.1 KB 2.2% 0.25
Dec 15 03:00:00 - 03:59:59 472 3.3% 0.131.3 MB 3.3% 0.37
Dec 15 04:00:00 - 04:59:59 457 3.2% 0.131.0 MB 2.6% 0.29
Dec 15 05:00:00 - 05:59:59 459 3.2% 0.13772.4 KB 1.9% 0.21
Dec 15 06:00:00 - 06:59:59 495 3.4% 0.14884.7 KB 2.2% 0.25
Dec 15 07:00:00 - 07:59:59 539 3.7% 0.152.7 MB 7.0% 0.77
Dec 15 08:00:00 - 08:59:59 536 3.7% 0.151.7 MB 4.4% 0.49
Dec 15 09:00:00 - 09:59:59 606 4.2% 0.172.1 MB 5.3% 0.59
Dec 15 10:00:00 - 10:59:59 647 4.5% 0.181.5 MB 3.8% 0.42
Dec 15 11:00:00 - 11:59:59 643 4.5% 0.181.5 MB 3.9% 0.44
Dec 15 12:00:00 - 12:59:59 651 4.5% 0.181.5 MB 3.9% 0.43
Dec 15 13:00:00 - 13:59:59 667 4.6% 0.191.9 MB 4.9% 0.54
Dec 15 14:00:00 - 14:59:59 642 4.5% 0.181.7 MB 4.3% 0.47
Dec 15 15:00:00 - 15:59:59 642 4.5% 0.181.6 MB 4.1% 0.46
Dec 15 16:00:00 - 16:59:59 707 4.9% 0.201.6 MB 4.0% 0.45
Dec 15 17:00:00 - 17:59:59 761 5.3% 0.212.4 MB 6.2% 0.68
Dec 15 18:00:00 - 18:59:59 701 4.9% 0.192.0 MB 5.0% 0.56
Dec 15 19:00:00 - 19:59:59 707 4.9% 0.202.7 MB 6.9% 0.77
Dec 15 20:00:00 - 20:59:59 653 4.5% 0.181.4 MB 3.6% 0.40
Dec 15 21:00:00 - 21:59:59 704 4.9% 0.202.0 MB 5.2% 0.58
Dec 15 22:00:00 - 22:59:59 597 4.1% 0.172.2 MB 5.6% 0.62
Dec 15 23:00:00 - 23:59:59 604 4.2% 0.171.6 MB 4.1% 0.46
Dec 16 00:00:00 - 00:03:00 39 0.3% 0.2297.0 KB 0.2% 0.54
TOTAL: 24:00:00 14421 100.0% 0.1739.0 MB 100.0% 0.46
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1goja-out.feeder.erje.net 435 163 0 0 4 0 0 0 268
2goja-out.news.weretis.net 234 72 0 1 0 0 0 0 161
3news.1d4.us 182 10 0 0 0 0 0 0 172
4news.nntp4.net 155 117 0 0 0 0 0 0 38
5newsfeed.bofh.team 80 15 0 1 0 0 0 0 64
6newsfeed.endofthelinebbs.com 33 28 0 0 0 0 0 0 5
7news.samoylyk.net 5 1 0 2 0 0 0 0 2
8news.furie.org.uk 1 0 0 1 0 0 0 0 0
9news.quux.org 1 0 0 1 0 0 0 0 0
10nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
11pasdenom.info 1 1 0 0 0 0 0 0 0
TOTAL: 11 1128 407 0 6 4 0 0 0 711

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 118
lada.talk 63
fido7.ukrnews 50
linux.kernel.git 43
it-alt.sport.calcio.juventus 28
hispagatos.hacking.ransomware 21
fido7.lorapvt.horo 12
hispagatos.mastodon.tag.hacking 12
spline.fli4l.dev 12
fido7.f715.techinfo 8
alt.slack.goathead 6
fido7.crimea.robots 5
fido7.pushkin.local 5
fido7.fidonet.online 3
fido7.nodex.tech 3
alt.binaries.pictures.purebeauty 2
hispagatos.hacking.news 2
a.b.mp3.audiobooks 1
alt.bbs.files-announce 1
alt.binaries.comics 1
TOTAL: 31 407

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

GroupsCount
uk.legal.moderated 4
TOTAL: 1 4

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 293
Too many newsgroups 158
EMP (md5) 123
Too many newsgroups (meow) 58
Angle-bracket bot 28
HTML Multipart 7
Cancel of non-existing ID <10hp9md$78u$2@reader2.panix.com> 2
Scoring filter 1
TOTAL: 8 670

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
robot@pasdenom.info (spam2)33004141
robot@pasdenom.info (spam3)7002626
robot@pasdenom.info (spam4)6001313
nocem@eternal-september.org (misplaced_binary)50088
TOTAL: 451008888

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad command received
newsfeed.dotsrc.org 22
TOTAL: 1 22
Huge articles
goja-out.feeder.erje.net 4
TOTAL: 1 4
Including strange strings
goja-out.news.weretis.net 14
goja-out.feeder.erje.net 14
newsfeed.endofthelinebbs.com 4
news.nntp4.net 2
newsfeed.bofh.team 1
TOTAL: 5 35
TOTAL: 3 61

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 15654 11051 2555 808 0 4 70%23:59:00
2news.chmurka.net 14337 6486 4728 7 0 1 45%23:58:44
3news.bbs.nz 20395 6190 7874 170 0 432 30%23:46:25
4newsfeed.dotsrc.org 9150 4458 1641 2448 0 361 48%23:56:09
5news.1d4.us 9553 4114 4275 0 0 9 43%23:57:56
6pasdenom.info 9161 1856 4538 415 0 7 20%23:56:46
7news.furie.org.uk 2071 1131 711 2 0 0 54%23:46:23
8news.nntp4.net 14953 954 6606 5860 0 6 6%23:58:34
9feeder.erje.net 7226 420 5908 93 0 1 5%23:58:34
10nntp.terraraq.uk 6415 318 3678 1064 0 1 4%23:50:39
11news.samoylyk.net 11915 203 7940 53 0 22 1%23:56:35
12news.quux.org 13205 199 7876 98 0 76 1%23:55:53
13weretis.net 5377 145 4577 32 0 2 2%23:57:23
14newsfeed.bofh.team 11180 116 7806 0 0 61 1%23:56:55
15tnetconsulting.net 13696 39 8326 188 0 94 0%23:56:30
16newsfeed.endofthelinebbs.com 13945 34 8207 19 0 242 0%23:56:06
17i2pn.org 0 0 0 0 0 8548 0%24:00:00
TOTAL: 17 178233 37714 87246 11257 0 9867 21%406:48:32
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net29.6 MB1.3 MB30.9 MB0.4 KB/s2.7 KB23:59:00
2news.chmurka.net18.5 MB100.7 KB18.5 MB0.2 KB/s2.9 KB23:58:44
3news.bbs.nz13.9 MB344.2 KB14.3 MB0.2 KB/s2.3 KB23:46:25
4news.1d4.us10.1 MB0.0 KB10.1 MB0.1 KB/s2.5 KB23:57:56
5newsfeed.dotsrc.org8.6 MB6.8 MB15.4 MB0.2 KB/s2.3 KB23:56:09
6news.furie.org.uk4.1 MB1.4 KB4.1 MB0.0 KB/s3.7 KB23:46:23
7pasdenom.info3.9 MB1.0 MB4.9 MB0.1 KB/s2.2 KB23:56:46
8news.nntp4.net2.1 MB17.8 MB19.8 MB0.2 KB/s3.0 KB23:58:34
9feeder.erje.net847.4 KB374.4 KB1.2 MB0.0 KB/s2.4 KB23:58:34
10nntp.terraraq.uk840.2 KB1.2 MB2.0 MB0.0 KB/s1.5 KB23:50:39
11news.quux.org541.5 KB146.6 KB688.1 KB0.0 KB/s2.3 KB23:55:53
12news.samoylyk.net355.2 KB92.3 KB447.4 KB0.0 KB/s1.7 KB23:56:35
13weretis.net301.6 KB39.6 KB341.2 KB0.0 KB/s1.9 KB23:57:23
14newsfeed.bofh.team264.0 KB0.0 KB264.0 KB0.0 KB/s2.3 KB23:56:55
15tnetconsulting.net122.0 KB358.7 KB480.8 KB0.0 KB/s2.1 KB23:56:30
16newsfeed.endofthelinebbs.com106.2 KB48.3 KB154.5 KB0.0 KB/s2.9 KB23:56:06
17i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 1794.1 MB29.5 MB123.7 MB0.1 KB/s2.6 KB406:48:32
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
12603:6010:6800:36:1a03:73ff:fe28:be0f 306 4689.9 KB 2 0 000:08:05
266.61.98.95 228 2438.2 KB 1 0 000:05:08
TOTAL: 2 534 70128.1 KB 3 0 000:13:13

NNRP connection statistics (by domain) [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 823 70128.1 KB 3 0 000:35:27
2*.stehlik.co.uk 484 00.0 KB 0 0 023:39:44
3*.stretchoid.com 2 00.0 KB 0 0 000:00:10
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 41310 70128.1 KB 3 0 024:15:23

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
toma-03.stehlik.co.uk 58.813 27.874 115.60023:39:44
2a03:cfc0:8000:b::c303:dce8 33.926 17.362 0.00000:21:55
2603:6010:6800:36:1a03:73ff:fe28:be0f 23.399 4.196 10.44000:08:05
66.61.98.95 17.148 3.380 4.62600:05:08
206.168.34.33 0.234 0.072 0.00000:00:14
azpdesegi1kf.stretchoid.com 0.136 0.038 0.00000:00:10
205.210.31.141 0.065 0.016 0.00000:00:02
optimistic.monitoring.internet-measurement.com 0.069 0.015 0.00000:00:01
185.242.226.72 0.143 0.015 0.00000:00:00
198.235.24.217 0.078 0.008 0.00000:00:00
TOTAL: 10 134.011 52.976 130.66624:15:23

Curious NNRP explorers [Top 20]:

SystemConn
toma-03.stehlik.co.uk 484
2a03:cfc0:8000:b::c303:dce8 282
206.168.34.33 3
185.242.226.72 2
azpdesegi1kf.stretchoid.com 2
198.235.24.217 1
205.210.31.141 1
optimistic.monitoring.internet-measurement.com 1
TOTAL: 8 776

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
185.242.226.72 5
azpdesegi1kf.stretchoid.com 1
TOTAL: 2 6

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
Accept-Encoding: gzip 1
Accept: */* 1
GET / HTTP/1.1 1
Host: 116.202.108.142:119 1
MGLNDD_116.202.108.142_119 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
TOTAL: 6 6

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

HierarchyCountPct
1it 36 51.4%
2nl 24 34.3%
3fr 10 14.3%
TOTAL: 3 70100.0%

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

NewsgroupCount
1it.comp.hardware 36
2nl.kunst.sf+fantasy 24
3fr.sci.psychanalyse 10
TOTAL: 3 70
innreport from INN 2.7.3 based on initial work (©) 1996-2001 by Fabien Tassin <fta@sofaraway.org> and enhanced by several contributors since then
Local contact: usenet@goja.nl.eu.org