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

Sep 6 01:00:02 -- Sep 7 00:05:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Sep 6 10:30:57 goja innd[59605]: filter: No Cancel-Key[sha1:a44naKg+5P6JSKqueGaN+OR+o/8= sha256:PRiSxDKuWC53OiiTdXY/RW3kh2+tDRMwRreksUoZV2g=] matches Cancel-Lock[sha1:mYFRGd2mw12QSUmt/b8ITcHWwuQ= sha256:XSBHPJo7SkuyCNcKL9J9mYNZW3bzQ0+PCdsyuZYqDFo=] target=<117j8a0$25pt0$2@dont-email.me>
Sep 7 00:03:00 goja news2mail[15031]: begin
Sep 7 00:03:00 goja news2mail[50046]: end

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 21459 60.8%2.2 MB 56.4%
innd 9742 27.6%1.2 MB 31.6%
innfeed 4004 11.4%469.1 KB 11.7%
nocem 54 0.2%6.3 KB 0.2%
inn 14 0.0%3.8 KB 0.1%
news2mail 2 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 35276 100.0%3.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 87304 64.1%
Negative hits 32321 23.7%
Do not exist 13717 10.1%
Cache misses 2772 2.0%
TOTAL: 4 136114 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.001 0.0%6 0.000 0.167 1.000
article cancel00:00:00.001 0.0%19 0.000 0.053 0.500
article cleanup00:00:00.186 0.0%13681 0.000 0.014 0.072
article logging00:00:00.263 0.0%13762 0.000 0.019 0.056
article parse00:00:00.661 0.0%33766 0.000 0.020 0.053
article write00:00:03.229 0.0%12587 0.085 0.257 1.152
artlog/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%6 0.000 0.000 0.000
artlog/artparse00:00:00.001 0.0%39 0.000 0.026 1.000
data move00:00:00.271 0.0%139712 0.000 0.002 0.008
hisgrep/artcncl00:00:00.000 0.0%19 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%6 0.000 0.000 0.000
hisgrep/perl00:00:00.004 0.0%22 0.000 0.182 1.000
hishave/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%6 0.000 0.000 0.000
hishave/artparse00:00:00.000 0.0%38 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.053 0.0%136070 0.001 0.008 0.019
history sync00:00:00.101 0.0%382 0.000 0.264 1.000
history write00:00:01.373 0.0%13679 0.037 0.100 0.522
hiswrite/artparse00:00:00.001 0.0%38 0.000 0.026 0.038
idle22:41:16.202 98.6%142393 192.225 573.597 1489.489
nntp read00:00:02.313 0.0%144144 0.002 0.016 0.062
overview write00:00:02.818 0.0%12587 0.077 0.224 2.038
perl filter00:00:45.917 0.1%13678 2.130 3.357 5.048
python filter00:00:00.930 0.0%13678 0.019 0.068 0.148
site send00:00:01.023 0.0%25220 0.009 0.041 0.075
TOTAL: 2722:42:16.348 98.6%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.070 0.0%13574 0.000 0.005 0.034
article prepare00:00:00.031 0.0%119232 0.000 0.000 0.003
article read00:00:01.284 0.0%12050 0.012 0.107 0.232
backlog stats00:00:00.453 0.0%259608 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.637 0.0%158298 0.011 0.023 0.125
data write00:00:03.086 0.0%149339 0.005 0.021 0.042
idle23:05:50.519 99.9%259608 192.702 320.293 748.624
status file00:00:00.624 0.0%686 0.000 0.910 3.000
TOTAL: 923:05:59.704 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.039 0.0%1317 0.000 0.030 1.000
idle25:22:16.188 98.6%24017 39.750 3802.981 16917.857
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:21:54.681 1.4%25323530 0.000 0.052 0.500
readart00:00:00.330 0.0%242 0.000 1.364 44.000
TOTAL: 525:44:11.238100.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

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1goja-out.feeder.erje.net 578 26551 7774 18302 475 29%130:03:37
2goja-out.news.weretis.net 2 10705 1569 8947 189 14%43:50:40
3news.nntp4.net 2 6427 1476 4840 111 22%22:41:53
4newsfeed.bofh.team 11 11653 468 11181 4 4%46:56:38
5news.samoylyk.net 2 9640 295 9345 0 3%19:39:00
6news.quux.org 2 4501 185 4315 1 4%23:59:34
7news.1d4.us 1 3651 140 3311 200 3%23:14:57
8pasdenom.info 2 3315 93 3222 0 2%23:48:15
9newsfeed.endofthelinebbs.com 2 4468 63 4398 7 1%23:57:57
10news.bbs.nz 2 5400 59 5341 0 1%23:59:37
11news.chmurka.net 1 2622 59 2563 0 2%23:33:42
12news.furie.org.uk 1 2196 45 2138 13 2%23:59:58
13nntp.terraraq.uk 1 2978 17 2961 0 0%23:59:57
14newsfeed.dotsrc.org 211 784 3 781 0 0%22:58:13
15goja-out.news.tnetconsulting.net 1 3329 0 3329 0 0%23:59:31
16localhost 1 0 0 0 0 0%00:00:00
TOTAL: 16 820 98220 12246 84974 1000 12%500:43:29
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1goja-out.feeder.erje.net28.7 MB0.0 KB1.3 MB30.0 MB 95%3.7 KB
2goja-out.news.weretis.net4.6 MB0.0 KB454.0 KB5.0 MB 91%2.9 KB
3news.nntp4.net4.1 MB0.0 KB919.5 KB5.0 MB 82%3.2 KB
4news.samoylyk.net1.3 MB0.0 KB0.0 KB1.3 MB100%4.6 KB
5newsfeed.bofh.team1.3 MB0.0 KB6.3 KB1.3 MB 99%2.9 KB
6news.quux.org558.8 KB0.0 KB3.9 KB562.6 KB 99%3.0 KB
7newsfeed.endofthelinebbs.com361.7 KB0.0 KB37.3 KB399.0 KB 90%5.7 KB
8news.1d4.us332.1 KB0.0 KB584.1 KB916.2 KB 36%2.7 KB
9pasdenom.info255.8 KB0.0 KB0.0 KB255.8 KB100%2.8 KB
10news.bbs.nz171.9 KB0.0 KB0.0 KB171.9 KB100%2.9 KB
11news.chmurka.net149.4 KB0.0 KB0.0 KB149.4 KB100%2.5 KB
12news.furie.org.uk131.0 KB0.0 KB8.9 KB139.9 KB 93%2.4 KB
13newsfeed.dotsrc.org113.7 KB0.0 KB0.0 KB113.7 KB100%37.9 KB
14nntp.terraraq.uk40.7 KB0.0 KB0.0 KB40.7 KB100%2.4 KB
15goja-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1642.1 MB0.0 KB3.3 MB45.4 MB 92%3.5 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 7 00:00:02 - 00:05:02 14 100.0% 0.0525.7 KB 100.0% 0.09
TOTAL: 00:05:00 14 100.0% 0.0525.7 KB 100.0% 0.09
Incoming articles
Incoming articles (size)

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 302
EMP (md5) 93
Too many newsgroups 90
Binary: misplaced binary 9
HTML Multipart 6
Cancel of non-existing ID <117k5dt$k8$1@reader1.panix.com> 2
No Cancel-Key matches Cancel-Lock. target=<117j8a0$25pt0$2@dont-email.me> 1
Too many newsgroups (meow) 1
TOTAL: 8 504

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
nocem@eternal-september.org (misplaced_binary)8004747
robot@pasdenom.info (spam3)6001515
robot@pasdenom.info (spam4)6001212
robot@pasdenom.info (spam2)11001111
TOTAL: 431008585

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad command received
newsfeed.dotsrc.org 40
TOTAL: 1 40
Huge articles
newsfeed.bofh.team 37
news.1d4.us 1
TOTAL: 2 38
TOTAL: 2 78

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.nz 17301 6549 5905 45 0 157 37%23:09:27
2news.chmurka.net 10018 6421 2695 20 0 15 64%23:08:13
3news.1d4.us 6974 3204 2699 1 0 56 45%23:08:14
4newsfeed.dotsrc.org 6571 2483 1203 2352 0 2 37%23:07:20
5news.furie.org.uk 2210 858 1062 1 0 4 38%23:01:28
6nntp.terraraq.uk 2375 271 1727 80 0 0 11%23:03:56
7newsfeed.bofh.team 5665 198 5226 0 0 0 3%23:04:19
8feeder.erje.net 4992 174 4257 119 0 25 3%23:06:29
9pasdenom.info 7588 161 4372 33 0 81 2%23:06:34
10news.nntp4.net 13234 87 4468 6566 0 32 0%23:08:47
11newsfeed.endofthelinebbs.com 10840 60 5828 39 0 264 0%23:06:40
12news.samoylyk.net 8433 34 5581 3 0 3 0%23:07:05
13weretis.net 4448 27 4202 2 0 32 0%23:04:44
14news.quux.org 9861 24 5811 13 0 133 0%23:06:18
15tnetconsulting.net 10233 18 6008 16 0 140 0%23:07:46
16gijs.erje.net 0 0 0 0 0 5983 0%23:09:56
17usenet.blueworldhosting.com 0 0 0 0 0 8091 0%23:09:56
TOTAL: 17 120743 20569 61044 9290 0 15018 17%392:57:12
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.chmurka.net24.9 MB190.4 KB25.1 MB0.3 KB/s4.0 KB23:08:13
2news.bbs.nz18.6 MB157.5 KB18.7 MB0.2 KB/s2.9 KB23:09:27
3news.1d4.us9.0 MB5.2 KB9.0 MB0.1 KB/s2.9 KB23:08:14
4newsfeed.dotsrc.org6.8 MB6.2 MB13.0 MB0.2 KB/s2.8 KB23:07:20
5news.furie.org.uk2.8 MB0.9 KB2.8 MB0.0 KB/s3.4 KB23:01:28
6nntp.terraraq.uk873.7 KB236.0 KB1.1 MB0.0 KB/s3.2 KB23:03:56
7pasdenom.info814.2 KB84.3 KB898.5 KB0.0 KB/s4.6 KB23:06:34
8feeder.erje.net564.3 KB396.8 KB961.1 KB0.0 KB/s3.3 KB23:06:29
9newsfeed.bofh.team512.1 KB0.0 KB512.1 KB0.0 KB/s2.6 KB23:04:19
10news.nntp4.net259.4 KB26.0 MB26.3 MB0.3 KB/s4.0 KB23:08:47
11newsfeed.endofthelinebbs.com187.3 KB119.4 KB306.7 KB0.0 KB/s3.1 KB23:06:40
12tnetconsulting.net147.2 KB52.6 KB199.8 KB0.0 KB/s5.9 KB23:07:46
13news.quux.org109.9 KB24.1 KB133.9 KB0.0 KB/s3.6 KB23:06:18
14weretis.net96.4 KB2.4 KB98.9 KB0.0 KB/s3.4 KB23:04:44
15news.samoylyk.net87.9 KB3.8 KB91.7 KB0.0 KB/s2.5 KB23:07:05
16gijs.erje.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:09:56
17usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:09:56
TOTAL: 1765.7 MB33.5 MB99.2 MB0.1 KB/s3.4 KB392:57:12
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
12603:6010:6802:4ca5:1a03:73ff:fe28:be0f 108 134513.0 KB 21 0 000:18:18
266.61.98.95 84 66216.2 KB 11 0 000:05:32
381-207-72-128.fixed.kpn.net 125 43284.5 KB 35 0 002:14:03
TOTAL: 3 317 2431013.6 KB 67 0 002:37:53

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 468 200729.1 KB 32 0 000:43:52
2*.fixed.kpn.net 125 43284.5 KB 35 0 002:14:03
3*.stehlik.co.uk 480 00.0 KB 0 0 022:54:52
4*.erje.net 15 00.0 KB 0 0 000:00:07
5*.fixed6.kpn.net 10 00.0 KB 0 0 000:00:07
6*.66.censys-scanner.com 9 00.0 KB 0 0 000:00:30
7*.infrawat.ch 2 00.0 KB 0 0 000:00:00
8*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
9*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
10*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 101114 2431013.6 KB 67 0 025:53:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
toma-03.stehlik.co.uk 63.462 32.146 123.51722:54:52
81-207-72-128.fixed.kpn.net 11.688 2.417 72.21502:14:03
2a03:cfc0:8000:b::c303:dce8 34.210 18.275 0.00000:19:56
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f 10.064 2.723 209.78400:18:18
66.61.98.95 7.099 1.665 62.66200:05:32
188.172.132.66.censys-scanner.com 0.255 0.040 0.00000:00:12
179.186.132.66.censys-scanner.com 0.237 0.063 0.00000:00:12
kotz.erje.net 1.192 0.300 0.00000:00:07
2a02-a452-390d-0-10a7-7406-8e9c-6a07.fixed6.kpn.net 0.782 0.239 0.00000:00:07
186.172.132.66.censys-scanner.com 0.234 0.078 0.00000:00:06
195.3.220.232 0.234 0.179 0.00000:00:04
molina.probe.onyphe.net 0.085 0.008 0.00000:00:03
r5-153-99.monitoring.internet-measurement.com 0.089 0.032 0.00000:00:01
198.235.24.223 0.071 0.040 0.00000:00:00
moshe.probe.onyphe.net 0.083 0.017 0.00000:00:00
o010.scanner.modat.io 0.084 0.023 0.00000:00:00
o011.scanner.modat.io 0.080 0.008 0.00000:00:00
45-133-173-240.infrawat.ch 0.091 0.017 0.00000:00:00
80.66.83.80 0.094 0.000 0.00000:00:00
194.165.16.123 0.070 0.031 0.00000:00:00
TOTAL: 21 130.276 58.333 468.17825:53:42

Curious NNRP explorers [Top 20]:

SystemConn
toma-03.stehlik.co.uk 480
2a03:cfc0:8000:b::c303:dce8 271
kotz.erje.net 15
2a02-a452-390d-0-10a7-7406-8e9c-6a07.fixed6.kpn.net 10
179.186.132.66.censys-scanner.com 3
186.172.132.66.censys-scanner.com 3
188.172.132.66.censys-scanner.com 3
195.3.220.232 2
194-88-98-107.infrawat.ch 1
194.165.16.123 1
198.235.24.223 1
45-133-173-240.infrawat.ch 1
80.66.83.80 1
molina.probe.onyphe.net 1
moshe.probe.onyphe.net 1
o010.scanner.modat.io 1
o011.scanner.modat.io 1
r5-153-99.monitoring.internet-measurement.com 1
TOTAL: 18 797

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

SystemConn
81-207-72-128.fixed.kpn.net 123
2a02-a452-390d-0-10a7-7406-8e9c-6a07.fixed6.kpn.net 17
moshe.probe.onyphe.net 2
o010.scanner.modat.io 2
o011.scanner.modat.io 2
194.165.16.123 1
80.66.83.80 1
TOTAL: 7 148

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

CommandCount
XFEATURE COMPRESS GZIP 123
?^T?^S 8
^V^C^A 8
FEAT 2
SYST 2
^C 2
?$?,?r?s?^S^B^S^A?^T?^G?^R?^S?'?/?^T?(?0?`?a... 1
?B?M-^RUM-^Y?U?`^[_n?^O/?M-^A2^] 1
^V^C^C^Bj^A 1
TOTAL: 9 148

NNRP client timeouts [Top 20]:

SystemConnPeer
81-207-72-128.fixed.kpn.net 19 19
2a02-a452-390d-0-10a7-7406-8e9c-6a07.fixed6.kpn.net 8 8
194.165.16.123 1 1
45-133-173-240.infrawat.ch 1 1
80.66.83.80 1 1
TOTAL: 5 30 39

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

HierarchyCountPct
1alt 74 30.5%
2linux 57 23.5%
3free 32 13.2%
4talk 22 9.1%
5fr 15 6.2%
6francom 15 6.2%
7nl 8 3.3%
8sfnet 8 3.3%
9sac 6 2.5%
10comp 4 1.6%
11news 2 0.8%
TOTAL: 11 243100.0%

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

NewsgroupCount
1linux.debian.changes.devel 55
2alt.checkmate 26
3free.usenet 22
4talk.politics.misc 22
5alt.atheism 15
6fr.soc.politique 15
7francom.esoterisme 15
8alt.binaries.ftd 11
9alt.computer.workshop 11
10free.pt 10
11sfnet.keskustelu.varaventtiili 8
12alt.fan.rush-limbaugh 7
13sac.politics 6
14comp.lang.c 4
15nl.kunst.sf+fantasy 4
16alt.usage.english 3
17news.admin.peering 2
18alt.music.s-mclachlan 1
19linux.debian.kernel 1
20linux.debian.maint.python 1
21nl.comp.software.newsreaders 1
22nl.defensie.marine 1
23nl.folklore 1
24nl.newsgroups.help 1
TOTAL: 24 243
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