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

Dec 15 01:00:03 -- Dec 16 00:05:02

Unknown entries from news log file:

First 7 / 7 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
Dec 16 00:03:00 goja news2mail[46720]: end
Dec 16 00:03:00 goja news2mail[47785]: begin

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 14347 46.0%1.6 MB 42.6%
innd 12622 40.4%1.6 MB 43.7%
innfeed 4146 13.3%492.0 KB 13.2%
nocem 53 0.2%7.1 KB 0.2%
inn 24 0.1%6.3 KB 0.2%
controlchan 23 0.1%4.9 KB 0.1%
news2mail 2 0.0%0.2 KB 0.0%
pgpverify 2 0.0%0.4 KB 0.0%
TOTAL: 8 31219 100.0%3.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 96530 63.5%
Negative hits 40320 26.5%
Do not exist 14960 9.8%
Cache misses 303 0.2%
TOTAL: 4 152113 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.002 0.0%4 0.000 0.500 1.000
article cancel00:00:00.000 0.0%28 0.000 0.000 0.000
article cleanup00:00:00.202 0.0%14930 0.000 0.014 0.056
article logging00:00:00.218 0.0%14965 0.000 0.015 0.060
article parse00:00:00.496 0.0%32328 0.000 0.015 0.060
article write00:00:02.945 0.0%13897 0.072 0.212 1.099
artlog/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%6 0.000 0.000 0.000
data move00:00:00.121 0.0%137786 0.000 0.001 0.006
hisgrep/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%30 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.001 0.0%4 0.000 0.250 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.906 0.0%152105 0.001 0.006 0.013
history sync00:00:00.234 0.0%389 0.000 0.602 8.667
history write00:00:01.306 0.0%14926 0.021 0.087 0.295
hiswrite/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
idle22:33:00.391 98.0%146696 328.355 553.392 966.484
nntp read00:00:04.696 0.0%146257 0.004 0.032 0.074
overview write00:00:02.632 0.0%13897 0.043 0.189 1.082
perl filter00:00:32.923 0.0%14924 1.856 2.206 2.793
python filter00:00:00.787 0.0%14924 0.000 0.053 0.125
site send00:00:02.185 0.0%27844 0.019 0.078 0.285
TOTAL: 2422:33:50.045 98.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.244 0.0%15209 0.000 0.016 1.157
article prepare00:00:00.030 0.0%189180 0.000 0.000 0.001
article read00:00:01.154 0.0%13147 0.012 0.088 0.305
backlog stats00:00:00.530 0.0%356017 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:25.405 0.0%220994 0.011 0.115 0.340
data write00:00:05.233 0.0%213022 0.010 0.025 0.090
idle22:59:52.195 99.8%356017 138.220 232.551 428.018
status file00:00:00.509 0.0%724 0.000 0.703 1.750
TOTAL: 923:00:25.300 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle23:01:26.978 98.0%14888 78.532 5567.368 10308.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:28:38.286 2.0%25189284 0.000 0.068 0.823
readart00:00:00.028 0.0%70 0.200 0.400 0.458
TOTAL: 423:30:05.292100.0%----

Control commands to innd:

CommandNumber
flush 6
flushlogs 2
go 2
logmode 2
lowmark 1
mode 144
name 2
pause 2
paused 2
reload 693
reserve 2
TOTAL: 11 858

Control channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002202
TOTAL002202

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1goja-out.feeder.erje.net 1155 28040 7605 20029 406 27%102:03:15
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 4457 123 4181 153 2%20:22:31
11news.furie.org.uk 1 4227 57 4170 0 1%23:59:57
12goja-out.news.tnetconsulting.net 2 3275 35 3240 0 1%23:59:44
13news.bbs.nz 3 7516 32 7484 0 0%24:58:03
14nntp.terraraq.uk 1 361 5 356 0 1%04:46:20
15newsfeed.dotsrc.org 240 1431 2 1429 0 0%23:00:15
16localhost 1 0 0 0 0 0%00:00:00
TOTAL: 16 1418 118755 14072 103675 1008 11%475:12:40
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1goja-out.feeder.erje.net21.9 MB0.0 KB3.3 MB25.2 MB 86%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.us214.0 KB0.0 KB536.8 KB750.8 KB 28%2.7 KB
11goja-out.news.tnetconsulting.net118.5 KB0.0 KB0.0 KB118.5 KB100%3.4 KB
12news.furie.org.uk97.4 KB0.0 KB0.0 KB97.4 KB100%1.7 KB
13news.bbs.nz61.2 KB0.0 KB0.0 KB61.2 KB100%1.9 KB
14nntp.terraraq.uk20.2 KB0.0 KB0.0 KB20.2 KB100%4.0 KB
15newsfeed.dotsrc.org19.5 KB0.0 KB0.0 KB19.5 KB100%9.7 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1637.8 MB162.1 KB7.3 MB45.3 MB 83%3.1 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 16 00:00:03 - 00:05:02 19 100.0% 0.0632.5 KB 100.0% 0.11
TOTAL: 00:04:59 19 100.0% 0.0632.5 KB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1goja-out.feeder.erje.net 4 4 0 0 0 0 0 0 0
2news.nntp4.net 1 1 0 0 0 0 0 0 0
TOTAL: 2 5 5 0 0 0 0 0 0 0

Unwanted newsgroups [Top 20]:

NewsgroupCount
fido7.nodex.tech 3
alt.slack.goathead 1
linux.kernel.netdev 1
TOTAL: 3 5

Perl filter (innd) [Top 20]:

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

NoCeM on spool:

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

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
TOTAL: 2 26

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 15193 10707 2489 787 0 4 70%23:09:00
2news.chmurka.net 13869 6259 4586 7 0 1 45%23:08:43
3news.bbs.nz 19787 5969 7655 169 0 428 30%22:56:25
4newsfeed.dotsrc.org 8912 4322 1607 2391 0 361 48%23:06:09
5news.1d4.us 9291 4017 4151 0 0 9 43%23:07:55
6pasdenom.info 8925 1816 4413 401 0 7 20%23:06:46
7news.furie.org.uk 2031 1102 700 2 0 0 54%22:56:23
8news.nntp4.net 14507 939 6414 5656 0 6 6%23:08:34
9feeder.erje.net 7035 413 5749 91 0 1 5%23:08:34
10nntp.terraraq.uk 6179 308 3542 1034 0 1 4%22:54:43
11news.samoylyk.net 11587 199 7725 52 0 21 1%23:06:35
12news.quux.org 12856 188 7668 98 0 76 1%23:05:52
13weretis.net 5204 144 4437 31 0 2 2%23:07:23
14newsfeed.bofh.team 10924 116 7620 0 0 61 1%23:06:55
15tnetconsulting.net 13333 39 8101 186 0 94 0%23:06:29
16newsfeed.endofthelinebbs.com 13602 34 7986 19 0 242 0%23:06:05
17i2pn.org 0 0 0 0 0 8321 0%23:10:00
TOTAL: 17 173235 36572 84843 10924 0 9635 21%392:32:31
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net28.8 MB1.3 MB30.1 MB0.4 KB/s2.7 KB23:09:00
2news.chmurka.net18.0 MB100.7 KB18.1 MB0.2 KB/s3.0 KB23:08:43
3news.bbs.nz13.6 MB342.9 KB13.9 MB0.2 KB/s2.3 KB22:56:25
4news.1d4.us9.9 MB0.0 KB9.9 MB0.1 KB/s2.5 KB23:07:55
5newsfeed.dotsrc.org8.4 MB6.6 MB15.0 MB0.2 KB/s2.3 KB23:06:09
6news.furie.org.uk4.0 MB1.4 KB4.0 MB0.1 KB/s3.8 KB22:56:23
7pasdenom.info3.8 MB1017.6 KB4.8 MB0.1 KB/s2.2 KB23:06:46
8news.nntp4.net2.0 MB17.3 MB19.4 MB0.2 KB/s3.0 KB23:08:34
9feeder.erje.net830.9 KB369.6 KB1.2 MB0.0 KB/s2.4 KB23:08:34
10nntp.terraraq.uk814.4 KB1.1 MB1.9 MB0.0 KB/s1.5 KB22:54:43
11news.quux.org521.4 KB146.6 KB668.0 KB0.0 KB/s2.3 KB23:05:52
12news.samoylyk.net349.4 KB90.3 KB439.7 KB0.0 KB/s1.8 KB23:06:35
13weretis.net299.4 KB38.5 KB337.9 KB0.0 KB/s1.9 KB23:07:23
14newsfeed.bofh.team264.0 KB0.0 KB264.0 KB0.0 KB/s2.3 KB23:06:55
15tnetconsulting.net122.0 KB357.1 KB479.1 KB0.0 KB/s2.1 KB23:06:29
16newsfeed.endofthelinebbs.com106.2 KB48.3 KB154.5 KB0.0 KB/s2.9 KB23:06:05
17i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:10:00
TOTAL: 1791.8 MB28.8 MB120.6 MB0.1 KB/s2.6 KB392:32:31
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
12603:6010:6800:36:1a03:73ff:fe28:be0f 298 4689.9 KB 2 0 000:08:02
266.61.98.95 186 2438.2 KB 1 0 000:04:23
TOTAL: 2 484 70128.1 KB 3 0 000:12:26

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 762 70128.1 KB 3 0 000:33:50
2*.stehlik.co.uk 469 00.0 KB 0 0 022:55:51
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: 41234 70128.1 KB 3 0 023:29:54

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
toma-03.stehlik.co.uk 56.978 26.917 113.54322:55:51
2a03:cfc0:8000:b::c303:dce8 32.738 16.752 0.00000:21:07
2603:6010:6800:36:1a03:73ff:fe28:be0f 22.906 4.122 10.44000:08:02
66.61.98.95 14.261 2.805 4.62600:04:23
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 127.608 50.760 128.60923:29:54

Curious NNRP explorers [Top 20]:

SystemConn
toma-03.stehlik.co.uk 469
2a03:cfc0:8000:b::c303:dce8 271
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 750

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