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

Mar 9 00:03:05 -- Mar 9 23:00:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Mar 9 02:06:05 goja innd[43164]: filter: No Cancel-Key[sha1:5MbeSe/Y6mYeEtWDiZIYJpv511A= sha256:OMYx6nUpLkV+SgQ25TgR831S5xx6JF4RAbD+VrFdpuk=] matches Cancel-Lock[sha1:fjV4gLBPWN4mw/bHd+5VKpH3N+U= sha256:BZLTJ6AA6xBSsjy8pmV70tW+HtCn6KkvwVbpElxCQNU=] target=<10ol6bj$1s5bl$1@gwaiyur.mb-net.net>
Mar 9 22:18:41 goja innd[43164]: filter: No Cancel-Key[sha1:9VCo25sVWBICUDTHcFfHcl8kG/I= sha256:dPLwsbKdxy/YgbAZ6rRXVDSDeiRFTF9/74twNfXP31A=] matches Cancel-Lock[sha1:vZupUMb0LnwG1Uf0IkOVeYq2INQ= sha256:iz6FuN99Ph84LcYs0RIM9VeauDcyEbqIUHfmIsDEin0=] target=<10ondc0$2314b$1@gwaiyur.mb-net.net>

Log entries by program:

Program nameLines%LinesSize%Size
inn 14002 35.1%3.6 MB 54.3%
nnrpd 12055 30.2%1.3 MB 18.9%
innd 10027 25.1%1.3 MB 20.1%
innfeed 3752 9.4%448.1 KB 6.5%
nocem 44 0.1%4.7 KB 0.1%
TOTAL: 5 39880 100.0%6.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 83909 65.6%
Negative hits 30255 23.7%
Do not exist 13532 10.6%
Cache misses 183 0.1%
TOTAL: 4 127879 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.007 0.0%12 0.000 0.583 1.000
article cancel00:00:00.000 0.0%31 0.000 0.000 0.000
article cleanup00:00:00.135 0.0%13535 0.000 0.010 0.048
article logging00:00:00.212 0.0%13560 0.000 0.016 0.055
article parse00:00:00.493 0.0%31513 0.000 0.016 0.035
article write00:00:02.326 0.0%11879 0.047 0.196 1.235
artlog/artcncl/perl00:00:00.000 0.0%12 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.148 0.0%128370 0.000 0.001 0.005
hisgrep/artcncl/perl00:00:00.000 0.0%12 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%38 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.001 0.0%12 0.000 0.083 1.000
hishave/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.868 0.0%127866 0.001 0.007 0.017
history sync00:00:00.107 0.0%360 0.000 0.297 2.333
history write00:00:01.075 0.0%13529 0.014 0.079 0.238
hiswrite/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
idle21:46:34.053 98.9%135834 297.238 577.131 1372.157
nntp read00:00:03.559 0.0%136224 0.004 0.026 0.100
overview write00:00:01.909 0.0%11879 0.029 0.161 0.435
perl filter00:00:24.945 0.0%13527 1.190 1.844 2.795
python filter00:00:00.688 0.0%13527 0.000 0.051 0.169
site send00:00:01.118 0.0%23799 0.000 0.047 0.190
TOTAL: 2421:47:11.644 99.0%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.061 0.0%14538 0.000 0.004 0.100
article prepare00:00:00.012 0.0%120308 0.000 0.000 0.002
article read00:00:00.990 0.0%11690 0.000 0.085 0.256
backlog stats00:00:00.477 0.0%264044 0.000 0.002 0.067
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:15.903 0.0%159704 0.008 0.100 0.520
data write00:00:04.438 0.0%150841 0.010 0.029 0.177
idle22:04:37.363 99.9%264044 164.698 301.000 685.982
status file00:00:00.484 0.0%679 0.000 0.713 8.000
TOTAL: 922:04:59.728 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle22:19:06.479 98.0%13461 65.000 5968.834 10099.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:27:05.856 2.0%21670597 0.000 0.075 0.500
readart00:00:00.048 0.0%124 0.000 0.387 0.426
TOTAL: 422:46:12.383100.0%----

Control commands to innd:

CommandNumber
mode 132
reload 660
TOTAL: 2 792

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1goja-out.feeder.erje.net 1071 24255 7085 16550 620 29%93:25:50
2newsfeed.bofh.team 11 15314 1693 13470 151 11%51:45:46
3goja-out.news.weretis.net 4 11119 1638 9240 241 14%42:32:06
4news.samoylyk.net 1 10145 446 9693 6 4%38:54:44
5newsfeed.endofthelinebbs.com 2 5547 373 5150 24 6%24:10:22
6news.nntp4.net 2 8449 284 7866 299 3%23:47:22
7news.1d4.us 1 4004 239 3504 261 5%22:03:29
8pasdenom.info 1 3929 154 3772 3 3%23:59:57
9news.chmurka.net 2 3163 73 3090 0 2%23:56:23
10news.quux.org 2 5091 51 5039 1 1%23:58:47
11news.furie.org.uk 1 2134 21 2113 0 0%23:59:58
12goja-out.news.tnetconsulting.net 1 3500 14 3486 0 0%23:57:15
13newsfeed.dotsrc.org 217 954 10 944 0 1%22:01:37
14news.bbs.nz 1 6165 6 6158 1 0%23:59:50
15nntp.terraraq.uk 1 244 3 241 0 1%04:48:28
TOTAL: 15 1318 104013 12090 90316 1607 11%467:21:54
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1goja-out.feeder.erje.net23.4 MB1.3 KB2.7 MB26.1 MB 89%3.5 KB
2goja-out.news.weretis.net5.0 MB1.3 KB967.7 KB6.0 MB 84%3.3 KB
3newsfeed.bofh.team5.0 MB1.3 KB2.5 MB7.6 MB 66%4.2 KB
4news.samoylyk.net2.3 MB1.3 KB7.9 KB2.3 MB 99%5.3 KB
5newsfeed.endofthelinebbs.com1.1 MB0.0 KB150.2 KB1.3 MB 88%3.3 KB
6news.nntp4.net937.7 KB1.3 KB3.0 MB3.9 MB 23%6.8 KB
7news.1d4.us879.5 KB0.0 KB499.2 KB1.3 MB 63%2.8 KB
8pasdenom.info468.6 KB0.0 KB3.6 KB472.2 KB 99%3.0 KB
9news.chmurka.net192.3 KB0.0 KB0.0 KB192.3 KB100%2.6 KB
10news.quux.org111.0 KB0.0 KB6.2 KB117.2 KB 94%2.3 KB
11newsfeed.dotsrc.org108.9 KB0.0 KB0.0 KB108.9 KB100%10.9 KB
12news.furie.org.uk92.3 KB0.0 KB0.0 KB92.3 KB100%4.4 KB
13goja-out.news.tnetconsulting.net82.3 KB0.0 KB0.0 KB82.3 KB100%5.9 KB
14news.bbs.nz13.9 KB1.3 KB0.0 KB15.2 KB 91%2.2 KB
15nntp.terraraq.uk9.2 KB0.0 KB0.0 KB9.2 KB100%3.1 KB
TOTAL: 1539.7 MB7.9 KB9.8 MB49.5 MB 80%3.7 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 9 00:03:05 - 00:59:59 388 3.2% 0.111.2 MB 3.0% 0.36
Mar 9 01:00:00 - 01:59:59 424 3.5% 0.121.1 MB 2.8% 0.32
Mar 9 02:00:00 - 02:59:59 317 2.6% 0.09966.0 KB 2.3% 0.27
Mar 9 03:00:00 - 03:59:59 406 3.3% 0.111.1 MB 2.8% 0.32
Mar 9 04:00:00 - 04:59:59 337 2.7% 0.09737.6 KB 1.8% 0.20
Mar 9 05:00:00 - 05:59:59 403 3.3% 0.111.1 MB 2.6% 0.30
Mar 9 06:00:00 - 06:59:59 407 3.3% 0.111.0 MB 2.6% 0.30
Mar 9 07:00:00 - 07:59:59 476 3.9% 0.133.6 MB 9.0% 1.03
Mar 9 08:00:00 - 08:59:59 543 4.4% 0.152.3 MB 5.8% 0.66
Mar 9 09:00:00 - 09:59:59 628 5.1% 0.172.7 MB 6.7% 0.77
Mar 9 10:00:00 - 10:59:59 656 5.4% 0.182.3 MB 5.7% 0.65
Mar 9 11:00:00 - 11:59:59 599 4.9% 0.171.7 MB 4.3% 0.49
Mar 9 12:00:00 - 12:59:59 542 4.4% 0.151.6 MB 4.1% 0.47
Mar 9 13:00:00 - 13:59:59 609 5.0% 0.172.2 MB 5.5% 0.62
Mar 9 14:00:00 - 14:59:59 616 5.0% 0.171.8 MB 4.6% 0.52
Mar 9 15:00:00 - 15:59:59 602 4.9% 0.171.5 MB 3.8% 0.43
Mar 9 16:00:00 - 16:59:59 549 4.5% 0.151.9 MB 4.7% 0.54
Mar 9 17:00:00 - 17:59:59 676 5.5% 0.192.3 MB 5.8% 0.66
Mar 9 18:00:00 - 18:59:59 610 5.0% 0.171.6 MB 4.0% 0.46
Mar 9 19:00:00 - 19:59:59 656 5.4% 0.181.7 MB 4.3% 0.49
Mar 9 20:00:00 - 20:59:59 578 4.7% 0.161.7 MB 4.3% 0.49
Mar 9 21:00:00 - 21:59:59 726 5.9% 0.202.0 MB 5.0% 0.57
Mar 9 22:00:00 - 23:00:00 513 4.2% 0.141.9 MB 4.8% 0.54
TOTAL: 22:56:55 12261 100.0% 0.1540.2 MB 100.0% 0.50
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1goja-out.feeder.erje.net 638 213 0 1 0 0 0 0 424
2news.nntp4.net 349 322 0 1 0 0 0 0 26
3goja-out.news.weretis.net 301 8 0 1 0 0 0 0 292
4news.1d4.us 264 17 0 0 0 0 0 0 247
5newsfeed.bofh.team 144 40 0 2 0 0 0 0 102
6newsfeed.endofthelinebbs.com 24 18 0 0 0 1 0 0 5
7pasdenom.info 4 0 0 0 0 0 0 0 4
8news.samoylyk.net 3 2 0 1 0 0 0 0 0
9news.bbs.nz 1 0 0 1 0 0 0 0 0
10news.quux.org 1 0 0 0 0 0 0 0 1
TOTAL: 10 1729 620 0 7 0 1 0 0 1101

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 296
linux.kernel.git 94
fido7.ukrnews 74
lada.talk 24
fido7.pushkin.local 18
fido7.altyn.local 12
fido7.lorapvt.horo 12
hispagatos.talk 10
it-alt.sport.calcio.juventus 10
alt.binaries.ebook 9
newsreader.test 9
fido7.f715.techinfo 8
spline.eisfair 7
fido7.crimea.robots 5
ab.alt.binaries.moovee 4
alt.windows7.general 3
fido7.nodex.tech 3
hispagatos.hacking.news 3
a.b.erotica 2
alt.binaries.ebooks 2
TOTAL: 33 620

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 836
EMP (md5) 113
Angle-bracket bot 36
Too many newsgroups 34
Too many newsgroups (meow) 11
HTML Multipart 2
Cancel of non-existing ID <10ombuq$38ssq$1@dont-email.me> 1
Cancel of non-existing ID <10onb8g$35i$1@reader2.panix.com> 1
Cancel of non-existing ID <10onf79$k1q$1@reader2.panix.com> 1
Cancel of non-existing ID <4W1AS9kanLMcN52WZOJYEXSna24@jntp> 1
Cancel of non-existing ID <KLgVzNmhh3QZCuYB82HYhOD27XE@jntp> 1
Cancel of non-existing ID <MLfo_M7o-jXaA8ELqkXOsxmm6sQ@jntp> 1
Cancel of non-existing ID <b5-tOvJF1Oh-a79g22kN7cTxkno@jntp> 1
Scoring filter 1
TOTAL: 14 1040

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
nocem@eternal-september.org (misplaced_binary)10004242
robot@pasdenom.info (spam2)19002323
robot@pasdenom.info (spam3)50066
robot@pasdenom.info (spam4)30044
TOTAL: 437007575

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad command received
newsfeed.dotsrc.org 26
TOTAL: 1 26
Huge articles
newsfeed.bofh.team 1
TOTAL: 1 1
Including strange strings
goja-out.news.weretis.net 16
newsfeed.bofh.team 3
newsfeed.endofthelinebbs.com 3
news.1d4.us 2
goja-out.feeder.erje.net 2
TOTAL: 5 26
No colon-space in header field
goja-out.feeder.erje.net 1
TOTAL: 1 1
TOTAL: 4 54

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.nz 16963 5671 5974 122 0 295 33%22:00:43
2news.chmurka.net 9221 5484 2581 6 0 81 59%21:56:28
3news.1d4.us 6895 3736 2390 3 0 100 54%21:52:06
4newsfeed.dotsrc.org 6956 2553 1169 2647 0 589 36%21:57:42
5news.furie.org.uk 2094 931 831 4 0 21 44%21:58:14
6newsfeed.bofh.team 5282 537 4294 1 0 20 10%21:59:18
7nntp.terraraq.uk 2817 492 1495 230 0 56 17%21:56:17
8pasdenom.info 8055 485 4255 97 0 128 6%21:57:36
9feeder.erje.net 5182 457 4103 97 0 0 8%21:57:56
10news.nntp4.net 13792 322 5889 5342 0 116 2%21:57:06
11news.quux.org 10627 195 6013 126 0 222 1%21:57:02
12news.samoylyk.net 9971 72 5770 11 0 117 0%22:02:03
13tnetconsulting.net 10565 49 6118 193 0 400 0%21:39:54
14weretis.net 4960 42 4504 2 0 39 0%21:56:12
15newsfeed.endofthelinebbs.com 11321 9 6104 4 0 442 0%22:01:51
16i2pn.org 0 0 0 0 0 6380 0%22:00:06
17peer.alt119.net 0 0 0 0 0 11867 0%22:00:06
TOTAL: 17 124701 21035 61490 8885 0 20873 16%373:10:40
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.chmurka.net19.2 MB22.5 KB19.2 MB0.2 KB/s3.6 KB21:56:28
2news.bbs.nz13.6 MB177.8 KB13.8 MB0.2 KB/s2.4 KB22:00:43
3news.1d4.us10.7 MB15.9 KB10.7 MB0.1 KB/s2.9 KB21:52:06
4newsfeed.dotsrc.org6.7 MB7.4 MB14.2 MB0.2 KB/s2.8 KB21:57:42
5news.furie.org.uk3.1 MB41.7 KB3.1 MB0.0 KB/s3.4 KB21:58:14
6pasdenom.info2.0 MB152.8 KB2.2 MB0.0 KB/s3.8 KB21:57:36
7feeder.erje.net1.7 MB544.2 KB2.3 MB0.0 KB/s4.2 KB21:57:56
8newsfeed.bofh.team1.6 MB1.3 KB1.6 MB0.0 KB/s3.0 KB21:59:18
9nntp.terraraq.uk1.4 MB497.0 KB1.9 MB0.0 KB/s2.6 KB21:56:17
10news.quux.org749.2 KB196.4 KB945.6 KB0.0 KB/s2.9 KB21:57:02
11news.nntp4.net737.8 KB18.9 MB19.6 MB0.3 KB/s3.6 KB21:57:06
12news.samoylyk.net369.0 KB15.9 KB384.9 KB0.0 KB/s4.6 KB22:02:03
13tnetconsulting.net251.6 KB663.2 KB914.8 KB0.0 KB/s3.8 KB21:39:54
14weretis.net171.1 KB2.4 KB173.5 KB0.0 KB/s3.9 KB21:56:12
15newsfeed.endofthelinebbs.com49.8 KB13.1 KB62.9 KB0.0 KB/s4.8 KB22:01:51
16i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s022:00:06
17peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s022:00:06
TOTAL: 1762.2 MB28.6 MB90.8 MB0.1 KB/s3.1 KB373:10:40
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 42 124301.5 KB 7 0 000:10:32
TOTAL: 1 42 124301.5 KB 7 0 000:10:32

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 300 124301.5 KB 7 0 000:29:23
2*.stehlik.co.uk 382 00.0 KB 0 0 022:16:26
3*.199.censys-scanner.com 4 00.0 KB 0 0 000:00:15
4*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
TOTAL: 4 688 124301.5 KB 7 0 022:46:08

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
toma-03.stehlik.co.uk 30.677 21.665 9.49722:16:26
2a03:cfc0:8000:b::c303:dce8 15.645 10.184 0.00000:16:29
66.61.98.95 2.624 0.836 81.98000:10:32
2603:6010:6800:36:1a03:73ff:fe28:be0f 2.348 0.675 0.75100:02:19
105.155.45.199.censys-scanner.com 0.183 0.024 0.00000:00:15
elizabeth.probe.onyphe.net 0.041 0.014 0.00000:00:03
198.235.24.44 0.047 0.008 0.00000:00:01
conor.probe.onyphe.net 0.056 0.000 0.00000:00:00
198.235.24.142 0.049 0.008 0.00000:00:00
87.121.84.72 0.037 0.022 0.00000:00:00
TOTAL: 10 51.707 33.436 92.22822:46:08

Curious NNRP explorers [Top 20]:

SystemConn
toma-03.stehlik.co.uk 382
2a03:cfc0:8000:b::c303:dce8 210
2603:6010:6800:36:1a03:73ff:fe28:be0f 45
105.155.45.199.censys-scanner.com 4
198.235.24.142 1
198.235.24.44 1
87.121.84.72 1
conor.probe.onyphe.net 1
elizabeth.probe.onyphe.net 1
TOTAL: 9 646

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

SystemConn
conor.probe.onyphe.net 3
TOTAL: 1 3

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

CommandCount
?$?,?r?s?^S^B^S^A?^T?^G?^R?^S?'?/?^T?(?0?`?a... 1
?N@?^L^OY? 1
^V^C^C^A?^A 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
105.155.45.199.censys-scanner.com 1 4
TOTAL: 1 1 7

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

HierarchyCountPct
1nl 108 87.1%
2alt 6 4.8%
3fr 4 3.2%
4comp 2 1.6%
5law 2 1.6%
6rec 2 1.6%
TOTAL: 6 124100.0%

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

NewsgroupCount
1nl.politiek 108
2alt.music 4
3fr.sci.maths 4
4alt.os.linux 2
5comp.text.tex 2
6law.court.federal 2
7rec.arts.drwho 2
TOTAL: 7 124