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

Apr 16 01:00:01 -- Apr 17 00:05:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Apr 16 22:07:05 goja innd[43164]: filter: No Cancel-Key[sha1:aaiDp8YPD9num3oypnStDl7VdLk= sha256:OATftKUwQeULqsNGP8Mihop1lpyslOYyb3IW7W4Q8XE=] matches Cancel-Lock[sha1:XOEWqLbVFzn837UcDD37iCS6rV0= sha256:hBR1EcmlnIpBe1tcAQuWdSc/2rBphW2wwG8wJoVw890=] target=<10rrfde$q4k$1@rasp.pasdenom.info>
Apr 17 00:03:00 goja news2mail[87346]: end
Apr 17 00:03:00 goja news2mail[56666]: begin

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 13071 44.0%1.3 MB 39.8%
innd 12614 42.5%1.6 MB 46.7%
innfeed 3956 13.3%455.9 KB 13.3%
nocem 41 0.1%4.0 KB 0.1%
inn 9 0.0%2.1 KB 0.1%
news2mail 2 0.0%0.4 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 29694 100.0%3.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 79394 65.9%
Negative hits 29007 24.1%
Do not exist 12103 10.0%
Cache misses 29 0.0%
TOTAL: 4 120533 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.017 0.0%15 0.000 1.133 2.000
article cancel00:00:00.000 0.0%35 0.000 0.000 0.000
article cleanup00:00:00.193 0.0%12106 0.000 0.016 0.086
article logging00:00:00.257 0.0%12130 0.000 0.021 0.085
article parse00:00:00.503 0.0%26606 0.000 0.019 0.047
article write00:00:02.892 0.0%10923 0.094 0.265 1.029
artlog/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.153 0.0%115819 0.000 0.001 0.008
hisgrep/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
hisgrep/perl00:00:00.008 0.0%37 0.000 0.216 1.000
hishave/artcncl/perl00:00:00.000 0.0%15 0.000 0.000 0.000
hishave/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.969 0.0%120518 0.002 0.008 0.020
history sync00:00:00.331 0.0%384 0.000 0.862 14.000
history write00:00:01.280 0.0%12103 0.030 0.106 0.229
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:34:34.899 98.1%122990 201.409 660.825 1572.657
nntp read00:00:07.648 0.0%124669 0.014 0.061 0.177
overview write00:00:02.331 0.0%10923 0.057 0.213 1.523
perl filter00:00:34.932 0.0%12101 1.274 2.887 4.552
python filter00:00:00.854 0.0%12101 0.017 0.071 0.188
site send00:00:03.049 0.0%21885 0.000 0.139 0.483
TOTAL: 2422:35:30.316 98.1%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.232 0.0%12265 0.000 0.019 0.771
article prepare00:00:00.024 0.0%101700 0.000 0.000 0.003
article read00:00:01.324 0.0%10473 0.014 0.126 1.333
backlog stats00:00:00.771 0.0%231633 0.000 0.003 0.100
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:01:02.168 0.1%140838 0.012 0.441 2.019
data write00:00:08.606 0.0%131672 0.015 0.065 0.339
idle23:02:53.479 99.8%231633 141.388 358.211 796.067
status file00:00:00.542 0.0%667 0.000 0.813 2.750
TOTAL: 923:04:07.146 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle23:00:39.510 97.4%15147 85.357 5469.037 10208.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:36:17.265 2.6%24961202 0.000 0.087 0.541
readart00:00:00.000 0.0%2 0.000 0.000 0.000
TOTAL: 423:36:56.775100.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 1117 22122 7266 14370 486 32%95:43:01
2goja-out.news.weretis.net 2 11745 1610 9896 239 13%48:15:58
3newsfeed.bofh.team 11 12157 657 11358 142 5%47:33:55
4news.nntp4.net 2 6931 290 6487 154 4%22:41:30
5newsfeed.endofthelinebbs.com 2 3586 218 3363 5 6%17:15:02
6news.samoylyk.net 2 2245 206 2038 1 9%11:39:49
7news.1d4.us 1 4897 185 4546 166 3%26:30:03
8news.bbs.nz 2 5532 106 5425 1 1%23:59:44
9news.chmurka.net 2 2932 102 2830 0 3%23:59:49
10pasdenom.info 2 3424 78 3338 8 2%23:59:44
11news.quux.org 2 4583 55 4527 1 1%23:57:47
12nntp.terraraq.uk 1 2640 30 2610 0 1%23:59:56
13news.furie.org.uk 2 2242 23 2218 1 1%23:59:43
14newsfeed.dotsrc.org 217 823 12 811 0 1%22:55:51
15goja-out.news.tnetconsulting.net 1 3215 3 3212 0 0%23:57:09
16localhost 1 0 0 0 0 0%00:00:00
TOTAL: 16 1367 89074 10841 77029 1204 12%460:29:01
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1goja-out.feeder.erje.net17.6 MB1.2 KB2.2 MB19.9 MB 88%2.6 KB
2goja-out.news.weretis.net4.3 MB0.0 KB617.9 KB4.9 MB 87%2.7 KB
3newsfeed.bofh.team2.3 MB1.2 KB3.4 MB5.7 MB 40%7.3 KB
4news.nntp4.net968.7 KB1.2 KB1.6 MB2.5 MB 37%5.8 KB
5news.samoylyk.net905.5 KB0.0 KB1.2 KB906.8 KB 99%4.4 KB
6newsfeed.endofthelinebbs.com466.9 KB0.0 KB18.1 KB485.0 KB 96%2.2 KB
7news.chmurka.net465.9 KB0.0 KB0.0 KB465.9 KB100%4.6 KB
8news.1d4.us331.3 KB0.0 KB558.3 KB889.6 KB 37%2.5 KB
9news.bbs.nz290.5 KB0.0 KB2.2 KB292.7 KB 99%2.7 KB
10pasdenom.info204.6 KB0.0 KB9.4 KB214.0 KB 95%2.5 KB
11news.quux.org144.9 KB0.0 KB2.8 KB147.7 KB 98%2.6 KB
12newsfeed.dotsrc.org103.8 KB0.0 KB0.0 KB103.8 KB100%8.6 KB
13nntp.terraraq.uk97.9 KB0.0 KB0.0 KB97.9 KB100%3.3 KB
14news.furie.org.uk49.6 KB0.0 KB9.9 KB59.4 KB 83%2.5 KB
15goja-out.news.tnetconsulting.net9.4 KB0.0 KB0.0 KB9.4 KB100%3.1 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1628.2 MB3.6 KB8.3 MB36.6 MB 77%3.1 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 17 00:00:01 - 00:05:01 9 100.0% 0.0317.0 KB 100.0% 0.06
TOTAL: 00:05:00 9 100.0% 0.0317.0 KB 100.0% 0.06
Incoming articles
Incoming articles (size)

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 484
Binary: misplaced binary 97
Too many newsgroups 78
EMP (md5) 66
Too many newsgroups (meow) 14
HTML Multipart 6
Cancel of non-existing ID <10rqk82$1vv$5@news.kraft-s.ru> 1
Cancel of non-existing ID <WaUcNkXozdePcvtvFGyaW1SDFb8@jntp> 1
TOTAL: 8 747

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
nocem@eternal-september.org (misplaced_binary)1000208208
robot@pasdenom.info (spam2)18002121
robot@pasdenom.info (spam3)30055
robot@pasdenom.info (spam4)30044
TOTAL: 43400238238

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad command received
newsfeed.dotsrc.org 37
TOTAL: 1 37
TOTAL: 1 37

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.nz 15872 4977 5856 63 0 169 31%23:08:56
2news.chmurka.net 8520 4885 2719 1 0 1 57%23:08:05
3news.1d4.us 7320 2948 3018 7 0 157 40%23:08:05
4newsfeed.dotsrc.org 6631 2569 990 2538 0 231 38%23:06:02
5news.furie.org.uk 2042 965 813 6 0 42 47%22:52:30
6nntp.terraraq.uk 2944 446 1600 229 0 1 15%23:03:22
7feeder.erje.net 3955 197 3295 41 0 29 4%23:02:12
8news.nntp4.net 12785 169 5786 4673 0 8 1%23:09:15
9pasdenom.info 8061 167 4485 70 0 114 2%23:05:06
10news.quux.org 10124 157 5780 124 0 180 1%23:07:55
11newsfeed.bofh.team 5586 104 5223 0 0 39 1%23:06:53
12news.samoylyk.net 9571 52 5631 8 0 0 0%23:06:56
13weretis.net 4782 36 4433 2 0 66 0%23:04:01
14newsfeed.endofthelinebbs.com 10647 31 5732 17 0 290 0%23:08:15
15i2pn.org 0 0 0 0 0 6099 0%23:10:00
16peer.alt119.net 0 0 0 0 0 10966 0%23:08:40
17tnetconsulting.net 0 0 0 0 0 6098 0%23:09:40
TOTAL: 17 108840 17703 55361 7779 0 24490 16%392:45:53
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.bbs.nz12.1 MB99.8 KB12.2 MB0.2 KB/s2.5 KB23:08:56
2news.chmurka.net11.8 MB2.5 KB11.8 MB0.1 KB/s2.5 KB23:08:05
3news.1d4.us8.0 MB54.9 KB8.1 MB0.1 KB/s2.8 KB23:08:05
4newsfeed.dotsrc.org6.6 MB6.6 MB13.2 MB0.2 KB/s2.7 KB23:06:02
5news.furie.org.uk3.2 MB62.2 KB3.3 MB0.0 KB/s3.5 KB22:52:30
6nntp.terraraq.uk1.2 MB320.0 KB1.5 MB0.0 KB/s2.3 KB23:03:22
7pasdenom.info782.4 KB114.1 KB896.5 KB0.0 KB/s3.8 KB23:05:06
8feeder.erje.net629.4 KB265.7 KB895.0 KB0.0 KB/s3.8 KB23:02:12
9news.quux.org448.5 KB183.1 KB631.6 KB0.0 KB/s2.2 KB23:07:55
10news.nntp4.net409.9 KB11.4 MB11.8 MB0.1 KB/s2.5 KB23:09:15
11newsfeed.bofh.team349.7 KB0.0 KB349.7 KB0.0 KB/s3.4 KB23:06:53
12news.samoylyk.net185.2 KB9.9 KB195.2 KB0.0 KB/s3.3 KB23:06:56
13weretis.net131.7 KB2.4 KB134.1 KB0.0 KB/s3.5 KB23:04:01
14newsfeed.endofthelinebbs.com91.2 KB126.7 KB218.0 KB0.0 KB/s4.5 KB23:08:15
15i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:10:00
16peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:08:40
17tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:09:40
TOTAL: 1746.0 MB19.2 MB65.2 MB0.0 KB/s2.6 KB392:45:53
Outgoing feeds (innfeed) by volume

NNRP readership statistics [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 4 22.5 KB 1 0 000:07:24
TOTAL: 1 4 22.5 KB 1 0 000:07:24

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 278 22.5 KB 1 0 000:27:07
2*.stehlik.co.uk 436 00.0 KB 0 0 023:09:10
3*.66.censys-scanner.com 4 00.0 KB 0 0 000:00:14
4*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
5*.stretchoid.com 2 00.0 KB 0 0 000:00:10
6*.e-n-c-r-y-p-t.cc 1 00.0 KB 0 0 000:00:00
7*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
8*.scanner.modat.io 1 00.0 KB 0 0 000:00:00
TOTAL: 8 725 22.5 KB 1 0 023:36:49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
toma-03.stehlik.co.uk 60.140 31.706 57.86423:09:10
2a03:cfc0:8000:b::c303:dce8 35.076 19.754 0.00000:19:32
66.61.98.95 0.768 0.436 2.78300:07:24
200.172.132.66.censys-scanner.com 0.352 0.095 0.00000:00:14
azpdsg0hrkum.stretchoid.com 0.165 0.046 0.00000:00:10
192.42.116.93 0.096 0.024 0.00000:00:07
christine.probe.onyphe.net 0.109 0.016 0.00000:00:03
147.185.133.155 0.102 0.024 0.00000:00:02
content.monitoring.internet-measurement.com 0.096 0.016 0.00000:00:01
server-03.e-n-c-r-y-p-t.cc 0.111 0.071 0.00000:00:00
barnaby.probe.onyphe.net 0.072 0.024 0.00000:00:00
o032.scanner.modat.io 0.075 0.008 0.00000:00:00
198.235.24.138 0.094 0.023 0.00000:00:00
TOTAL: 13 97.256 52.243 60.64723:36:49

Curious NNRP explorers [Top 20]:

SystemConn
toma-03.stehlik.co.uk 436
2a03:cfc0:8000:b::c303:dce8 271
200.172.132.66.censys-scanner.com 4
azpdsg0hrkum.stretchoid.com 2
147.185.133.155 1
192.42.116.93 1
198.235.24.138 1
barnaby.probe.onyphe.net 1
christine.probe.onyphe.net 1
content.monitoring.internet-measurement.com 1
o032.scanner.modat.io 1
server-03.e-n-c-r-y-p-t.cc 1
TOTAL: 12 721

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

SystemConn
147.185.133.155 4
barnaby.probe.onyphe.net 2
azpdsg0hrkum.stretchoid.com 1
TOTAL: 3 7

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

CommandCount
?$?,?r?s?^S^B^S^A?^T?^G?^R?^S?'?/?^T?(?0?`?a... 1
Accept-Encoding: gzip 1
GET / HTTP/1.1 1
Host: 116.202.108.142:119 1
MGLNDD_116.202.108.142_119 1
User-Agent: Hello from Palo Alto Network... 1
^V^C^C^A?^A 1
TOTAL: 7 7

NNRP client timeouts [Top 20]:

SystemConnPeer
200.172.132.66.censys-scanner.com 1 4
TOTAL: 1 1 6

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

HierarchyCountPct
1alt 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1alt.america 2
TOTAL: 1 2
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