DnsSubscription warning

Staking & Delegation Setup a Stake Pool
,
21

I dont seem to have a logs folder although logging is turned to true but there is no path that I can see in the config. I just added a path in the config but still no logs folder…

22

share your logging settings from the config

23

I managed to get the logging to work ill share the log file now

24

First 10 logs
{“at”:“2021-03-28T20:51:48.85Z”,“env”:“1.25.1:9a733”,“ns”:[“cardano.node.networkMagic”],“data”:{“kind”:“LogMessage”,“message”:“NetworkMagic 764824073”},“app”:,“msg”:"",“pid”:“3295”,“loc”:null,“host”:“chris-Po”,“sev”:“Notice”,“thread”:“5”}
{“at”:“2021-03-28T20:51:48.85Z”,“env”:“1.25.1:9a733”,“ns”:[“cardano.node.basicInfo.protocol”],“data”:{“kind”:“LogMessage”,“message”:“Byron; Shelley”},“app”:,“msg”:"",“pid”:“3295”,“loc”:null,“host”:“chris-Po”,“sev”:“Notice”,“thread”:“5”}
{“at”:“2021-03-28T20:51:48.85Z”,“env”:“1.25.1:9a733”,“ns”:[“cardano.node.basicInfo.version”],“data”:{“kind”:“LogMessage”,“message”:“1.25.1”},“app”:,“msg”:"",“pid”:“3295”,“loc”:null,“host”:“chris-Po”,“sev”:“Notice”,“thread”:“5”}
{“at”:“2021-03-28T20:51:48.85Z”,“env”:“1.25.1:9a733”,“ns”:[“cardano.node.basicInfo.commit”],“data”:{“kind”:“LogMessage”,“message”:“9a7331cce5e8bc0ea9c6bfa1c28773f4c5a7000f”},“app”:,“msg”:"",“pid”:“3295”,“loc”:null,“host”:“chris-Po”,“sev”:“Notice”,“thread”:“5”}
{“at”:“2021-03-28T20:51:48.85Z”,“env”:“1.25.1:9a733”,“ns”:[“cardano.node.basicInfo.nodeStartTime”],“data”:{“kind”:“LogMessage”,“message”:“2021-03-28 20:51:48.857259417 UTC”},“app”:,“msg”:"",“pid”:“3295”,“loc”:null,“host”:“chris-Po”,“sev”:“Notice”,“thread”:“5”}
{“at”:“2021-03-28T20:51:48.85Z”,“env”:“1.25.1:9a733”,“ns”:[“cardano.node.basicInfo.systemStartTime”],“data”:{“kind”:“LogMessage”,“message”:“2017-09-23 21:44:51 UTC”},“app”:,“msg”:"",“pid”:“3295”,“loc”:null,“host”:“chris-Po”,“sev”:“Notice”,“thread”:“5”}
{“at”:“2021-03-28T20:51:48.85Z”,“env”:“1.25.1:9a733”,“ns”:[“cardano.node.basicInfo.slotLengthByron”],“data”:{“kind”:“LogMessage”,“message”:“20s”},“app”:,“msg”:"",“pid”:“3295”,“loc”:null,“host”:“chris-Po”,“sev”:“Notice”,“thread”:“5”}
{“at”:“2021-03-28T20:51:48.85Z”,“env”:“1.25.1:9a733”,“ns”:[“cardano.node.basicInfo.epochLengthByron”],“data”:{“kind”:“LogMessage”,“message”:“21600”},“app”:,“msg”:"",“pid”:“3295”,“loc”:null,“host”:“chris-Po”,“sev”:“Notice”,“thread”:“5”}
{“at”:“2021-03-28T20:51:48.85Z”,“env”:“1.25.1:9a733”,“ns”:[“cardano.node.basicInfo.slotLengthShelley”],“data”:{“kind”:“LogMessage”,“message”:“1s”},“app”:,“msg”:"",“pid”:“3295”,“loc”:null,“host”:“chris-Po”,“sev”:“Notice”,“thread”:“5”}
{“at”:“2021-03-28T20:51:48.85Z”,“env”:“1.25.1:9a733”,“ns”:[“cardano.node.basicInfo.epochLengthShelley”],“data”:{“kind”:“LogMessage”,“message”:“432000”},“app”:,“msg”:"",“pid”:“3295”,“loc”:null,“host”:“chris-Po”,“sev”:“Notice”,“thread”:“5”}

25

we need something like this:

[dell:cardano.node.dns-producers:Notice:5] [2021-02-28 21:52:14.06 UTC] [DnsSubscriptionTarget {dstDomain = “relays-new.launchpad.dev.cardano.org”, dstPort = 3001, dstValency = 2}]

[dell:cardano.node:Debug:5] [2021-02-28 21:52:14.05 UTC] tracing verbosity = normal verbosity 
[dell:cardano.node.networkMagic:Notice:5] [2021-02-28 21:52:14.05 UTC] NetworkMagic 3
[dell:cardano.node.basicInfo.protocol:Notice:5] [2021-02-28 21:52:14.05 UTC] Byron; Shelley
[dell:cardano.node.basicInfo.version:Notice:5] [2021-02-28 21:52:14.05 UTC] 1.25.1
[dell:cardano.node.basicInfo.commit:Notice:5] [2021-02-28 21:52:14.05 UTC] 9a7331cce5e8bc0ea9c6bfa1c28773f4c5a7000f
[dell:cardano.node.basicInfo.nodeStartTime:Notice:5] [2021-02-28 21:52:14.05 UTC] 2021-02-28 21:52:14.055880672 UTC
[dell:cardano.node.basicInfo.systemStartTime:Notice:5] [2021-02-28 21:52:14.05 UTC] 2020-10-22 15:00:00 UTC
[dell:cardano.node.basicInfo.slotLengthByron:Notice:5] [2021-02-28 21:52:14.05 UTC] 20s
[dell:cardano.node.basicInfo.epochLengthByron:Notice:5] [2021-02-28 21:52:14.05 UTC] 360
[dell:cardano.node.basicInfo.slotLengthShelley:Notice:5] [2021-02-28 21:52:14.05 UTC] 1s
[dell:cardano.node.basicInfo.epochLengthShelley:Notice:5] [2021-02-28 21:52:14.05 UTC] 7200
[dell:cardano.node.basicInfo.slotsPerKESPeriodShelley:Notice:5] [2021-02-28 21:52:14.05 UTC] 129600
[dell:cardano.node.basicInfo.slotLengthAllegra:Notice:5] [2021-02-28 21:52:14.05 UTC] 1s
[dell:cardano.node.basicInfo.epochLengthAllegra:Notice:5] [2021-02-28 21:52:14.05 UTC] 7200
[dell:cardano.node.basicInfo.slotsPerKESPeriodAllegra:Notice:5] [2021-02-28 21:52:14.05 UTC] 129600
[dell:cardano.node.basicInfo.slotLengthMary:Notice:5] [2021-02-28 21:52:14.05 UTC] 1s
[dell:cardano.node.basicInfo.epochLengthMary:Notice:5] [2021-02-28 21:52:14.05 UTC] 7200
[dell:cardano.node.basicInfo.slotsPerKESPeriodMary:Notice:5] [2021-02-28 21:52:14.05 UTC] 129600
[dell:cardano.node.addresses:Notice:5] [2021-02-28 21:52:14.06 UTC] [SocketInfo 192.168.4.3:3003]
[dell:cardano.node.diffusion-mode:Notice:5] [2021-02-28 21:52:14.06 UTC] InitiatorAndResponderDiffusionMode
[dell:cardano.node.dns-producers:Notice:5] [2021-02-28 21:52:14.06 UTC] [DnsSubscriptionTarget {dstDomain = "relays-new.launchpad.dev.cardano.org", dstPort = 3001, dstValency = 2}]
[dell:cardano.node.ip-producers:Notice:5] [2021-02-28 21:52:14.06 UTC] IPSubscriptionTarget {ispIps = [], ispValency = 0}
[dell:cardano.node.ChainDB:Debug:5] [2021-02-28 21:52:15.00 UTC] TraceImmutableDBEvent
[dell:cardano.node.ChainDB:Debug:5] [2021-02-28 21:52:15.42 UTC] TraceImmutableDBEvent
[dell:cardano.node.ChainDB:Info:5] [2021-02-28 21:52:15.42 UTC] Opened imm db with immutable tip at d0b97c3601664c1671148acb1202b0dede821f31f739d6853d277247cbc80c3c at slot 7229800 and chunk 20082
[dell:cardano.node.ChainDB:Info:5] [2021-02-28 21:52:15.44 UTC] Opened vol db
26

This is the only mention of dns in the file:

{"at":"2021-03-28T21:20:43.96Z","env":"1.25.1:9a733","ns":["cardano.node.dns-producers"],"data":{"kind":"LogMessage","message":"[]"},"app":[],"msg":"","pid":"5226","loc":null,"host":"chris-Po","sev":"Notice","thread":"5"}
{"at":"2021-03-28T21:20:43.96Z","env":"1.25.1:9a733","ns":["cardano.node.ip-producers"],"data":{"kind":"LogMessage","message":"IPSubscriptionTarget {ispIps = [169.239.9.26:6000], ispValency = 1}"},"app":[],"msg":"","pid":"5226","loc":null,"host":"chris-Po","sev":"Notice","thread":"5"}
27

Great - so this node now only will connect to 169.239.9.26:6000

{"at":"2021-03-28T21:20:43.96Z","env":"1.25.1:9a733","ns":["cardano.node.ip-producers"],"data":{"kind":"LogMessage","message":"IPSubscriptionTarget {ispIps = [169.239.9.26:6000], ispValency = 1}"},"app":[],"msg":"","pid":"5226","loc":null,"host":"chris-Po","sev":"Notice","thread":"5"}

So I guess this is the log of the block producer, and the address belongs to the relay node
so keep run your BP node, and now start the relay and see the netstat of the BP node - now only 1 remote address should be listed there - towards the relay node

28

Before starting the relay on BP:

Active Internet connections (servers and established)
Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name Timer
tcp 0 0 127.0.0.1:12788 0.0.0.0:* LISTEN 5226/cardano-node off (0.00/0/0)
tcp 0 0 127.0.0.53:53 0.0.0.0:* LISTEN 697/systemd-resolve off (0.00/0/0)
tcp 0 0 127.0.0.1:631 0.0.0.0:* LISTEN 735/cupsd off (0.00/0/0)
tcp 0 0 127.0.0.1:12798 0.0.0.0:* LISTEN 5226/cardano-node off (0.00/0/0)
tcp 0 0 0.0.0.0:6000 0.0.0.0:* LISTEN 5226/cardano-node off (0.00/0/0)
tcp 0 0 169.239.9.26:6000 169.239.9.26:45075 ESTABLISHED 5226/cardano-node off (0.00/0/0)
tcp 0 0 169.239.9.26:45075 169.239.9.26:6000 ESTABLISHED 5226/cardano-node off (0.00/0/0)
tcp6 0 0 ::1:3350 :::* LISTEN 884/xrdp-sesman off (0.00/0/0)
tcp6 0 0 ::1:631 :::* LISTEN 735/cupsd off (0.00/0/0)
tcp6 0 0 :::3389 :::* LISTEN 910/xrdp off (0.00/0/0)
tcp6 0 0 169.239.9.26:3389 197.245.136.7:56004 ESTABLISHED 1085/xrdp keepalive (4263.32/0/0

29

After:

Active Internet connections (servers and established)
Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name Timer
tcp 0 0 127.0.0.1:12788 0.0.0.0:* LISTEN 5226/cardano-node off (0.00/0/0)
tcp 0 0 127.0.0.53:53 0.0.0.0:* LISTEN 697/systemd-resolve off (0.00/0/0)
tcp 0 0 127.0.0.1:631 0.0.0.0:* LISTEN 735/cupsd off (0.00/0/0)
tcp 0 0 127.0.0.1:12798 0.0.0.0:* LISTEN 5226/cardano-node off (0.00/0/0)
tcp 0 0 0.0.0.0:6000 0.0.0.0:* LISTEN 5226/cardano-node off (0.00/0/0)
tcp 0 0 169.239.9.26:6000 169.239.9.26:45075 ESTABLISHED 5226/cardano-node off (0.00/0/0)
tcp 0 0 169.239.9.26:45075 169.239.9.26:6000 ESTABLISHED 5226/cardano-node off (0.00/0/0)
tcp6 0 0 ::1:3350 :::* LISTEN 884/xrdp-sesman off (0.00/0/0)
tcp6 0 0 ::1:631 :::* LISTEN 735/cupsd off (0.00/0/0)
tcp6 0 0 :::3389 :::* LISTEN 910/xrdp off (0.00/0/0)
tcp6 0 0 169.239.9.26:3389 197.245.136.7:56004 ESTABLISHED 1085/xrdp keepalive (4107.73/0/0)

30

come on… this node connects to itself…
tcp 0 0 169.239.9.26:6000 169.239.9.26:45075 ESTABLISHED 5226/cardano-node off (0.00/0/0)
tcp 0 0 169.239.9.26:45075 169.239.9.26:6000 ESTABLISHED 5226/cardano-node off (0.00/0/0)

what is the topology file content of BP node? also lets figure it out what is the IP of the BP node with ip addr command

31

Screenshot 2021-03-28 at 23.42.23
Screenshot 2021-03-28 at 23.42.232522×1454 98.6 KB

33

Ok - soooo just found something!
the topology file should contains the address where the node will try to connect - and it is definitely not itself.
what is the address of relay node? sure it is 169.239.9.27 so update the topology file of the BP node with this address - which is the address of relay node

35

Great!

So update the topology file of relay node as well with the correct BP address. if ready, start only the relay node and see what address it is trying to connect - with netstat

37

Send the log after TIME_WAIT disappears…

39

looks just perfect, now start BP node, and send relay node netstat again after it

41

Established!

consider mark one of the answer as solution to indicate other no need more attention

2 Likes
42

Thank you so much! No more dns warning and i can now see the amount of ada in payment.addr. You are a legend!

2 Likes
43

yeah - this was a good example of how to debug… maybe I will create a topic about this kind of activities…
see you!

1 Like