Skip to content

Conversation

@0pcom
Copy link
Collaborator

@0pcom 0pcom commented Jun 7, 2025

add utility to test dial remote dmsg client

@0pcom
Copy link
Collaborator Author

0pcom commented Jun 8, 2025

$ go run cmd/dmsg/dmsg.go server dial -e 7 -Z -w 300
[2025-06-07T19:45:30.213810655-05:00] DEBUG disc.NewHTTP [dmsgdial]: Created HTTP client. addr="http://dmsgd.skywire.skycoin.com"
[2025-06-07T19:45:30.213857771-05:00] DEBUG [dmsgdial]: Created dmsg client.
[2025-06-07T19:45:30.213869301-05:00] DEBUG [dmsgdial]: dmsgclient.Serve(context.Background())
[2025-06-07T19:45:30.213886579-05:00] DEBUG [dmsgdial]: Connecting to dmsg network...
 dmsg_disc="http://dmsgd.skywire.skycoin.com"
[2025-06-07T19:45:30.213897929-05:00] DEBUG [dmsgdial]: 
 client public_key="02d03b99e74d5a8593683db2a5335e88a1e137106e3c70e8d28250e0caa8395d69"
[2025-06-07T19:45:30.213924127-05:00] DEBUG [dmsg_client]: Discovering dmsg servers...
[2025-06-07T19:45:30.497468957-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
[2025-06-07T19:45:31.328861471-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
[2025-06-07T19:45:31.328920935-05:00] DEBUG [dmsg_client]: Serving session. remote_pk=0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
[2025-06-07T19:45:31.328892997-05:00] DEBUG [dmsgdial]: Dmsg network ready.
[2025-06-07T19:45:31.87519119-05:00] DEBUG [dmsg_client]: Updating entry.
 entry=	version: 0.0.1
	sequence: 0
	registered at: 1749343531191541592
	static public key: 02d03b99e74d5a8593683db2a5335e88a1e137106e3c70e8d28250e0caa8395d69
	signature: 4432bfd6b1cf5b0a3864fc9018db4f2462e2d4786839e3939060f0f3b75617eb25afa06a6a9e15a37158038469da0e6090afa35f04564c1259524c18fb92f80600
	entry is registered as client. Related info: 
		delegated servers: 
			0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
			02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd


[2025-06-07T19:45:32.012039978-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
[2025-06-07T19:45:32.012151896-05:00] DEBUG [dmsg_client]: Serving session. remote_pk=02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
[2025-06-07T19:45:32.569683752-05:00] DEBUG [dmsg_client]: Updating entry.
 entry=	version: 0.0.1
	sequence: 1
	registered at: 1749343531875295052
	static public key: 02d03b99e74d5a8593683db2a5335e88a1e137106e3c70e8d28250e0caa8395d69
	signature: 3be6a51fd5fc273c0226ace4399d1924f97924a2e5e4be15c0281f5dc636fbd762f00c234bbbc0c2993404964eca592b551b6b0cb3ad23a78a37dc240a6a057601
	entry is registered as client. Related info: 
		delegated servers: 
			02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
			02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
			0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7


[2025-06-07T19:45:32.707222546-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-07T19:45:32.707344707-05:00] DEBUG [dmsg_client]: Serving session. remote_pk=02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
[2025-06-07T19:45:33.267579798-05:00] DEBUG [dmsg_client]: Updating entry.
 entry=	version: 0.0.1
	sequence: 2
	registered at: 1749343532569817437
	static public key: 02d03b99e74d5a8593683db2a5335e88a1e137106e3c70e8d28250e0caa8395d69
	signature: 49973200b057fcff1aeda87869cb0d2c9d4ee6688fafdf4809893227bf0aa4175edd103708d19dd1b650460d1adb7ede685b2f27c2f4adc91af0dcb2e231b08500
	entry is registered as client. Related info: 
		delegated servers: 
			02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
			0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
			0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
			02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd


[2025-06-07T19:45:33.405040754-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96
[2025-06-07T19:45:33.405151567-05:00] DEBUG [dmsg_client]: Serving session. remote_pk=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-07T19:45:38.635864544-05:00] WARN [dmsg_client]: Failed to establish session. current_backoff="5s" error="deadline exceeded" remote_pk=030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96
[2025-06-07T19:45:43.639867506-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-07T19:45:44.201318811-05:00] DEBUG [dmsg_client]: Updating entry.
 entry=	version: 0.0.1
	sequence: 3
	registered at: 1749343533267674141
	static public key: 02d03b99e74d5a8593683db2a5335e88a1e137106e3c70e8d28250e0caa8395d69
	signature: e032f34b9d40746cf37659e8cfac4aa839cc3323375e6cfa822dd4061134d43f2ec3e8bc6105641f56a5e10889ff2d9c602e8f63f8ba627d36c560b8d4ef9a7b01
	entry is registered as client. Related info: 
		delegated servers: 
			0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
			03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
			0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
			02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
			02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0


[2025-06-07T19:45:44.340869212-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
[2025-06-07T19:45:44.341026657-05:00] DEBUG [dmsg_client]: Serving session. remote_pk=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-07T19:45:44.892511361-05:00] DEBUG [dmsg_client]: Updating entry.
 entry=	version: 0.0.1
	sequence: 4
	registered at: 1749343544201407559
	static public key: 02d03b99e74d5a8593683db2a5335e88a1e137106e3c70e8d28250e0caa8395d69
	signature: 2c6e2e4951a4ae9dbc1589b47ab6f58651f55f7046c8eb61e7fcade867132f2a57b9ce49e5dc10743b13598b6ee33f6c432a6814c0062aef448d63f2982cdede01
	entry is registered as client. Related info: 
		delegated servers: 
			02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
			02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
			0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
			03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
			0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
			0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7


[2025-06-07T19:45:45.033900344-05:00] DEBUG [dmsg_client]: Serving session. remote_pk=0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
[2025-06-07T19:46:30.21406425-05:00] DEBUG [dmsg_client]: Discovering dmsg servers...
[2025-06-07T19:46:30.483544327-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96
[2025-06-07T19:46:35.713827092-05:00] WARN [dmsg_client]: Failed to establish session. current_backoff="6.5s" error="deadline exceeded" remote_pk=030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96
[2025-06-07T19:46:42.21887362-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-07T19:46:42.21896209-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
[2025-06-07T19:46:42.218995564-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
[2025-06-07T19:46:42.219023164-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
[2025-06-07T19:46:42.219049982-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
[2025-06-07T19:46:42.219078189-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-07T19:46:45.308634778-05:00] DEBUG [dmsg_client]: Updating entry.
 entry=	version: 0.0.1
	sequence: 5
	registered at: 1749343544892707918
	static public key: 02d03b99e74d5a8593683db2a5335e88a1e137106e3c70e8d28250e0caa8395d69
	signature: 4546173e6cb151b472085006d3f714479f50d3334d7d87cd9962cb6c068c11d81bd40af14dcd2ed5cde21674088cd823be3a742893d31544ff81472d9d3af51f01
	entry is registered as client. Related info: 
		delegated servers: 
			03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
			0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
			0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
			02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
			02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
			0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb


[2025-06-07T19:47:30.218962319-05:00] DEBUG [dmsg_client]: Discovering dmsg servers...
[2025-06-07T19:47:30.492858273-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-07T19:47:30.49291574-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
[2025-06-07T19:47:30.492980636-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
[2025-06-07T19:47:30.492992636-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-07T19:47:30.493001341-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96
[2025-06-07T19:47:35.723820879-05:00] WARN [dmsg_client]: Failed to establish session. current_backoff="8.45s" error="deadline exceeded" remote_pk=030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96
[2025-06-07T19:47:44.177475578-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
[2025-06-07T19:47:44.177544339-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
[2025-06-07T19:47:45.721269672-05:00] DEBUG [dmsg_client]: Updating entry.
 entry=	version: 0.0.1
	sequence: 6
	registered at: 1749343605308759573
	static public key: 02d03b99e74d5a8593683db2a5335e88a1e137106e3c70e8d28250e0caa8395d69
	signature: 194580ac19197ed5de96e7a41e7f24fbd649f4a640b2ae9e00edc17e6fea03560a6e63192b429eb9faca2e76f8e69ce5d0ce5ad8da35bb35f40125a3d85fd0b301
	entry is registered as client. Related info: 
		delegated servers: 
			02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
			02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
			0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
			03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
			0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
			0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7


[2025-06-07T19:48:30.218132494-05:00] DEBUG [dmsg_client]: Discovering dmsg servers...
[2025-06-07T19:48:30.492404223-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
[2025-06-07T19:48:30.492482598-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
[2025-06-07T19:48:30.492501428-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96
[2025-06-07T19:48:35.71637908-05:00] WARN [dmsg_client]: Failed to establish session. current_backoff="10.985s" error="deadline exceeded" remote_pk=030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96
[2025-06-07T19:48:46.137040647-05:00] DEBUG [dmsg_client]: Updating entry.
 entry=	version: 0.0.1
	sequence: 7
	registered at: 1749343665721367671
	static public key: 02d03b99e74d5a8593683db2a5335e88a1e137106e3c70e8d28250e0caa8395d69
	signature: c49f933ec7091f66f41f9c12fc3bfe0087ad9214a70118ac8921ed27a7b285dd51bd7e24cea2c2169315c880c9f4cb133de10f97c08518d4ec319835e01b950101
	entry is registered as client. Related info: 
		delegated servers: 
			0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
			02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
			02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
			0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
			03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
			0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13


[2025-06-07T19:48:46.702202432-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-07T19:48:46.70228631-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-07T19:48:46.702310978-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
[2025-06-07T19:48:46.702344093-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
[2025-06-07T19:49:30.218106578-05:00] DEBUG [dmsg_client]: Discovering dmsg servers...
[2025-06-07T19:49:30.483093374-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
[2025-06-07T19:49:30.483156797-05:00] DEBUG [dmsg_client]: Session already exists... remote_pk=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-07T19:49:30.483188023-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96
[2025-06-07T19:49:31.120634786-05:00] DEBUG [dmsg_client]: Updating entry.
 entry=	version: 0.0.1
	sequence: 8
	registered at: 1749343726137129769
	static public key: 02d03b99e74d5a8593683db2a5335e88a1e137106e3c70e8d28250e0caa8395d69
	signature: 769ca386ee6bc47d5cdf5a9a6b08bb5ac89788bd8e30e2d054b063c4b9f032bc6f7e8985d35bb684800e29a4a83f2f7941aadcb7448bf2092b908f174e19feb601
	entry is registered as client. Related info: 
		delegated servers: 
			0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
			02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
			02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
			0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
			03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
			0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
			030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96


[2025-06-07T19:49:31.260253348-05:00] DEBUG [dmsg_client]: Serving session. remote_pk=030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96
[2025-06-07T19:50:31.329560724-05:00] INFO [dmsgdial]: Disconnecting from dmsg network
[2025-06-07T19:50:31.329675523-05:00] DEBUG [dmsg_client]: Stopped serving client!
[2025-06-07T19:50:31.33235986-05:00] ERROR [dmsgdial]: Failed to perform request. endpoint="http://dmsgd.skywire.skycoin.com/dmsg-discovery/entry/" error="Post "http://dmsgd.skywire.skycoin.com/dmsg-discovery/entry/": context canceled"
[2025-06-07T19:50:31.332413742-05:00] WARN [dmsg_client]: Failed to update discovery entry.
 error="Post "http://dmsgd.skywire.skycoin.com/dmsg-discovery/entry/": context canceled"
[2025-06-07T19:50:31.332502074-05:00] DEBUG [dmsg_client]: Stopped accepting streams. error="session shutdown" session=02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
[2025-06-07T19:50:31.332565177-05:00] DEBUG [dmsg_client]: Session closed. error=<nil>
[2025-06-07T19:50:31.332653512-05:00] DEBUG [dmsg_client]: Stopped accepting streams. error="session shutdown" session=02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
[2025-06-07T19:50:31.332695009-05:00] DEBUG [dmsg_client]: Session closed. error=<nil>
[2025-06-07T19:50:31.33285147-05:00] DEBUG [dmsg_client]: Stopped accepting streams. error="session shutdown" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-07T19:50:31.332899832-05:00] DEBUG [dmsg_client]: Session closed. error=<nil>
[2025-06-07T19:50:31.332951327-05:00] DEBUG [dmsg_client]: Stopped accepting streams. error="session shutdown" session=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-07T19:50:31.332952017-05:00] DEBUG [dmsg_client]: Session closed. error=<nil>
[2025-06-07T19:50:31.333009314-05:00] DEBUG [dmsg_client]: Stopped accepting streams. error="session shutdown" session=0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
[2025-06-07T19:50:31.333019695-05:00] DEBUG [dmsg_client]: Session closed. error=<nil>
[2025-06-07T19:50:31.333120511-05:00] DEBUG [dmsg_client]: Stopped accepting streams. error="session shutdown" session=030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96
[2025-06-07T19:50:31.33315633-05:00] DEBUG [dmsg_client]: Session closed. error=<nil>
[2025-06-07T19:50:31.333247587-05:00] DEBUG [dmsg_client]: Stopped accepting streams. error="session shutdown" session=0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
[2025-06-07T19:50:31.333292558-05:00] DEBUG [dmsg_client]: Session closed. error=<nil>
[2025-06-07T19:50:31.333316485-05:00] DEBUG [dmsg_client]: All sessions closed.
[2025-06-07T19:50:31.527432991-05:00] DEBUG [dmsg_client]: Deleting entry.
 entry=	version: 0.0.1
	sequence: 9
	registered at: 1749343771120791906
	static public key: 02d03b99e74d5a8593683db2a5335e88a1e137106e3c70e8d28250e0caa8395d69
	signature: 289febdc65e09ea18b0614cd5e818a773cfb1425bf066ec05794d3abe427aad814befca3d1dd104dd8c21578a598f52152fd0f0c1a3ada08f10ab29e12270bd301
	entry is registered as client. Related info: 
		delegated servers: 
			0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7
			02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
			02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0
			0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
			03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
			0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
			030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96


[2025-06-07T19:50:31.668132965-05:00] DEBUG [dmsg_client]: Entry Deleted successfully.
[2025-06-07T19:50:31.668179859-05:00] DEBUG [dmsgdial]: Disconnected from dmsg network.
 error=<nil>
2025/06/07 19:50:31 

It took almost the full 5 minutes to connect to all the dmsg servers.

@0pcom
Copy link
Collaborator Author

0pcom commented Jun 8, 2025

When attempting to use the dmsghttp-config (the default for dmsg utilities) there is an indication that the dmsg network is ready after a dmsg direct client attempts to establish a session to a dmsg server. Then, that session gets shut down or stops unexpecetedly, but the http client which is configured for the second dmsg client which attempts to reach the dmsg-discovery server over dmsg is still in use by the second dmsg client. So it just sits there giving i/o deadline reached errors

This is approximately the same situation for skywire visors. There is an indication that the dmsg network is ready, but the visor is only using the dmsg direct client to bootstrap the connection to dmsg or basically to force interaction with the dmsg-discovery over dmsg (dmsghttp)

Here is logging that demonstrates the situation I've attempted to describe:

$ go run cmd/dmsg/dmsg.go server dial -e 1 -w 300
[2025-06-08T11:27:23.24442432-05:00] DEBUG direct.NewClient [dmsgdial]: Created Direct client.
[2025-06-08T11:27:23.244507394-05:00] DEBUG [dmsgdial]: Connecting to dmsg network...
 public_key="03ff8200ce4b97ed8585e28617034c423f182cbb8b3483aef0047ea473f4509a5b"
[2025-06-08T11:27:23.24453466-05:00] DEBUG [dmsgdial]: Discovering dmsg servers...
[2025-06-08T11:27:23.244565069-05:00] DEBUG [dmsgdial]: Dialing session... remote_pk=0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
[2025-06-08T11:27:23.52060047-05:00] DEBUG [dmsgdial]: Updating entry.
 entry=	version: 
	sequence: 0
	registered at: 0
	static public key: 03ff8200ce4b97ed8585e28617034c423f182cbb8b3483aef0047ea473f4509a5b
	signature: 
	entry is registered as client. Related info: 
		delegated servers: 
			0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13


[2025-06-08T11:27:23.52084959-05:00] DEBUG [dmsgdial]: Serving session. remote_pk=0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
[2025-06-08T11:27:23.520849217-05:00] DEBUG [dmsgdial]: Dmsg network ready.
[2025-06-08T11:27:23.520922671-05:00] DEBUG disc.NewHTTP [dmsgdial]: Created HTTP client. addr="dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80"
[2025-06-08T11:27:23.520975079-05:00] DEBUG [dmsgdial]: Created dmsg client.
[2025-06-08T11:27:23.520997594-05:00] DEBUG [dmsgdial]: dmsgclient.Serve(context.Background())
[2025-06-08T11:27:23.521011382-05:00] DEBUG [dmsgdial]: Connecting to dmsg network...
 dmsg_disc="dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80"
[2025-06-08T11:27:23.521028554-05:00] DEBUG [dmsgdial]: 
 client public_key="03ff8200ce4b97ed8585e28617034c423f182cbb8b3483aef0047ea473f4509a5b"
[2025-06-08T11:27:23.521060045-05:00] DEBUG [dmsg_client]: Discovering dmsg servers...
[2025-06-08T11:27:23.651136406-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="EOF" session=0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
[2025-06-08T11:27:23.651141478-05:00] WARN [dmsgdial]: Stopped accepting streams. error="EOF" session=0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13
[2025-06-08T11:27:23.651376462-05:00] DEBUG [dmsgdial]: Updating entry.
 entry=	version: 
	sequence: 0
	registered at: 0
	static public key: 03ff8200ce4b97ed8585e28617034c423f182cbb8b3483aef0047ea473f4509a5b
	signature: 
	entry is registered as client. Related info: 
		delegated servers: 


[2025-06-08T11:27:23.651456964-05:00] DEBUG [dmsgdial]: Session stopped. error="failed to serve dialed session to 0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13: EOF"
[2025-06-08T11:27:23.651484486-05:00] DEBUG [dmsgdial]: Dialing session... remote_pk=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:27:23.948131829-05:00] DEBUG [dmsgdial]: Updating entry.
 entry=	version: 
	sequence: 0
	registered at: 0
	static public key: 03ff8200ce4b97ed8585e28617034c423f182cbb8b3483aef0047ea473f4509a5b
	signature: 
	entry is registered as client. Related info: 
		delegated servers: 
			0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb


[2025-06-08T11:27:23.948226545-05:00] DEBUG [dmsgdial]: Serving session. remote_pk=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:27:24.521957253-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=1.3s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": EOF"
[2025-06-08T11:27:44.532017877-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:27:44.532118707-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=1.69s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:28:04.541954989-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:28:04.542084908-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=2.197s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:28:24.543401522-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:28:24.543536665-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=2.8561s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:28:44.552902559-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:28:44.553001968-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=3.71293s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:29:04.563310885-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:29:04.563417037-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=4.826809s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:29:24.563884096-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:29:24.564030575-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=6.2748517s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:29:44.573378247-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:29:44.573530305-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=8.15730721s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:30:04.577792513-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:30:04.577988537-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=10.604499373s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:30:24.588454054-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:30:24.588562201-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=13.785849184s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:30:44.597228125-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:30:44.597368625-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:31:04.597880219-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:31:04.59799098-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:31:24.599074169-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:31:24.599332263-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:31:44.617899047-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:31:44.618034686-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:32:04.6201299-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:32:04.620261925-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:32:24.630374332-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:32:24.630501804-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:32:44.635018765-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:32:44.63511125-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:33:04.643698574-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:33:04.643835286-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:33:24.644271521-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:33:24.645079196-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:33:44.663902677-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:33:44.664001553-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:34:04.667938101-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:34:04.668183239-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:34:24.669328448-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:34:24.669461925-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"
[2025-06-08T11:34:44.674190715-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
[2025-06-08T11:34:44.674306337-05:00] WARN retrier [dmsg_client]: Retrying... current_backoff=17.921603939s error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/dmsg-discovery/available_servers": i/o deadline reached"

Unfortunately, it's really stuck in that loop. The dial utility is just supposed to start the dmsg client and then stop it, but it's getting stuck. It should time out or re-attempt via a different server, but even when more than 1 session is used / multiple servers are connected to, it still fails to retry via the other dmsg server or other session!

@0pcom
Copy link
Collaborator Author

0pcom commented Jun 8, 2025

Here, finally, is logging that clearly shows that the dmsg-discovery is not equally accessible via all dmsg servers.

$ go run cmd/dmsg/dmsg.go server dial -e 1
[2025-06-08T16:33:34.078351293-05:00] DEBUG direct.NewClient [dmsgdial]: Created Direct client.
[2025-06-08T16:33:34.078421408-05:00] DEBUG [dmsgdial]: Connecting to dmsg network...
 public_key="0251778202164387df5add4caaddbec1f7ce2d177ffbaa6b1fc713c8138e3d6246"
[2025-06-08T16:33:34.078467813-05:00] DEBUG [dmsgdial]: Discovering dmsg servers...
[2025-06-08T16:33:34.078530686-05:00] DEBUG [dmsgdial]: Dialing session... remote_pk=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-08T16:33:34.347716954-05:00] DEBUG [dmsgdial]: Updating entry.
 entry=	version: 
	sequence: 0
	registered at: 0
	static public key: 0251778202164387df5add4caaddbec1f7ce2d177ffbaa6b1fc713c8138e3d6246
	signature: 
	entry is registered as client. Related info: 
		delegated servers: 
			03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4


[2025-06-08T16:33:34.347925619-05:00] DEBUG [dmsgdial]: Serving session. remote_pk=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-08T16:33:34.34797161-05:00] DEBUG [dmsgdial]: Dmsg network ready.
[2025-06-08T16:33:39.34861563-05:00] DEBUG [dmsgdial]: Dmsg network ready.
[2025-06-08T16:33:39.627525665-05:00] INFO [dmsgdial]: Received response from dmsg-discovery /health:
{"build_info":{"version":"v1.3.29-rc7","commit":"1652acdf69f64f2481c260a1790b7780f871464e","date":"2025-03-05T08:22:55Z"},"started_at":"2025-05-18T14:10:21.747405592Z","dmsg_address":"022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80","dmsg_servers":["03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4","02a49bc0aa1b5b78f638e9189be4ed095bac5d6839c828465a8350f80ac07629c0","0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb","0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7","0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13","02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd"]}
[2025-06-08T16:33:39.627578119-05:00] DEBUG disc.NewHTTP [dmsgdial]: Created HTTP client. addr="dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80"
[2025-06-08T16:33:39.627627438-05:00] DEBUG [dmsgdial]: Created dmsg client.
[2025-06-08T16:33:39.627657368-05:00] DEBUG [dmsgdial]: dmsgclient.Serve(context.Background())
[2025-06-08T16:33:39.627694191-05:00] DEBUG [dmsgdial]: Connecting to dmsg network...
 dmsg_disc="dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80"
[2025-06-08T16:33:39.627724947-05:00] DEBUG [dmsgdial]: 
 client public_key="0251778202164387df5add4caaddbec1f7ce2d177ffbaa6b1fc713c8138e3d6246"
[2025-06-08T16:33:39.627725395-05:00] DEBUG [dmsg_client]: Discovering dmsg servers...
[2025-06-08T16:33:39.916491464-05:00] DEBUG [dmsg_client]: Dialing session... remote_pk=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-08T16:33:40.766315539-05:00] DEBUG [dmsg_client]: Serving session. remote_pk=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-08T16:33:40.766318244-05:00] DEBUG [dmsgdial]: Dmsg network ready.
[2025-06-08T16:33:40.766400787-05:00] INFO [dmsgdial]: Disconnecting from dmsg network
[2025-06-08T16:33:40.766417301-05:00] DEBUG [dmsg_client]: Session closed. error=<nil>
[2025-06-08T16:33:40.766426739-05:00] DEBUG [dmsg_client]: Stopped serving client!
[2025-06-08T16:33:40.766401816-05:00] WARN [dmsg_client]: Stopped accepting streams. error="EOF" session=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-08T16:33:40.766428156-05:00] DEBUG [dmsg_client]: All sessions closed.
[2025-06-08T16:33:41.059453266-05:00] DEBUG [dmsg_client]: Deleting entry.
 entry=	version: 0.0.1
	sequence: 0
	registered at: 1749418420473945554
	static public key: 0251778202164387df5add4caaddbec1f7ce2d177ffbaa6b1fc713c8138e3d6246
	signature: 01f00f0cde8788ad9f7a15687062510f586a4ef4ec295eca2e8546571aa76cb40c9803256dc355b21bc40e7e47b968be55b38cd31545ba5f740d891004dfecd300
	entry is registered as client. Related info: 
		delegated servers: 
			03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4


[2025-06-08T16:33:41.34479221-05:00] DEBUG [dmsg_client]: Entry Deleted successfully.
[2025-06-08T16:33:41.344851454-05:00] DEBUG [dmsgdial]: Disconnected from dmsg network.
 error=<nil>
2025/06/08 16:33:41 
[2025-06-08T16:33:41.344960153-05:00] DEBUG [dmsgdial]: Stopped serving client!
[2025-06-08T16:33:41.344992582-05:00] DEBUG [dmsgdial]: Stopped accepting streams. error="session shutdown" session=03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
[2025-06-08T16:33:41.34499426-05:00] DEBUG [dmsgdial]: Session closed. error=<nil>
[2025-06-08T16:33:41.345053037-05:00] DEBUG [dmsgdial]: All sessions closed.
[2025-06-08T16:33:41.345066965-05:00] DEBUG [dmsgdial]: Deleting entry.
 entry=	version: 
	sequence: 0
	registered at: 0
	static public key: 0251778202164387df5add4caaddbec1f7ce2d177ffbaa6b1fc713c8138e3d6246
	signature: 
	entry is registered as client. Related info: 
		delegated servers: 
			03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4


[2025-06-08T16:33:41.345102091-05:00] DEBUG [dmsgdial]: Entry Deleted successfully.
[2025-06-08T16:33:41.345109004-05:00] DEBUG [dmsgdial]: Disconnected from dmsg network.
 error=<nil>

but it didn't work through another dmsg server

[user@linux dmsg]$ go run cmd/dmsg/dmsg.go server dial -e 1
[2025-06-08T16:34:13.421119881-05:00] DEBUG direct.NewClient [dmsgdial]: Created Direct client.
[2025-06-08T16:34:13.421197369-05:00] DEBUG [dmsgdial]: Connecting to dmsg network...
 public_key="03e2aa1414df5dfef8fae6af6e51982cbce91a454f08de7dbd9254fa97783d6770"
[2025-06-08T16:34:13.421244593-05:00] DEBUG [dmsgdial]: Discovering dmsg servers...
[2025-06-08T16:34:13.421299752-05:00] DEBUG [dmsgdial]: Dialing session... remote_pk=02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
[2025-06-08T16:34:13.694939716-05:00] DEBUG [dmsgdial]: Updating entry.
 entry=	version: 
	sequence: 0
	registered at: 0
	static public key: 03e2aa1414df5dfef8fae6af6e51982cbce91a454f08de7dbd9254fa97783d6770
	signature: 
	entry is registered as client. Related info: 
		delegated servers: 
			02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd


[2025-06-08T16:34:13.6951579-05:00] DEBUG [dmsgdial]: Serving session. remote_pk=02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
[2025-06-08T16:34:13.695203024-05:00] DEBUG [dmsgdial]: Dmsg network ready.
[2025-06-08T16:34:18.696237774-05:00] DEBUG [dmsgdial]: Dmsg network ready.
[2025-06-08T16:34:38.705990785-05:00] DEBUG ClientSession.DialStream [dmsgdial]: Stream closed on failure. close_error=<nil> dst_addr=022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 error="i/o deadline reached" session=02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd
[2025-06-08T16:34:38.706140421-05:00] FATAL [dmsgdial]: Error connecting to dmsg-discovery with dmsg direct client via current dmsg server. error="Get "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80/health": i/o deadline reached"
exit status 1

@0pcom
Copy link
Collaborator Author

0pcom commented Jun 11, 2025

$ go run github.com/skycoin/skywire/cmd/skywire@develop svc conf dmsghttp | jq '.prod' | grep "dmsg://"
  "dmsg_discovery": "dmsg://022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80",
  "transport_discovery": "dmsg://02b307aee5c8ce1666c63891f8af25ad2f0a47a243914c963942b3ba35b9d095ae:80",
  "address_resolver": "dmsg://03234b2ee4128d1f78c180d06911102906c80795dfe41bd6253f2619c8b6252a02:80",
  "route_finder": "dmsg://039d89c5eedfda4a28b0c58b0b643eff949f08e4f68c8357278081d26f5a592d74:80",
  "uptime_tracker": "dmsg://022c424caa6239ba7d1d9d8f7dab56cd5ec6ae2ea9ad97bb94ad4b48f62a540d3f:80",
  "service_discovery": "dmsg://0204890f9def4f9a5448c2e824c6a4afc85fd1f877322320898fafdf407cc6fef7:80"

$ go run github.com/skycoin/skywire/cmd/skywire@develop svc conf dmsghttp | jq '.prod' | grep "dmsg://" | cut -d '"' -f4 | sed 's|^dmsg://||' | while read _dmsgaddr ; do go run cmd/dmsg/dmsg.go server dial -s $(tail -n1 dmsghttp.key) -B -e7 ${_dmsgaddr} ; done
[2025-06-11T17:26:51.078138745-05:00] INFO [dmsgdial]: Successfully dialed remote host: 022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 with dmsg server: [03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4]
[2025-06-11T17:27:11.088156214-05:00] WARN [dmsgdial]: Failed to dial remote host: 022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 via dmsg server: [030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96] error="i/o deadline reached"
[2025-06-11T17:27:11.240940055-05:00] INFO [dmsgdial]: Successfully dialed remote host: 022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 with dmsg server: [0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7]
[2025-06-11T17:27:11.398295598-05:00] INFO [dmsgdial]: Successfully dialed remote host: 022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 with dmsg server: [0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb]
[2025-06-11T17:27:11.552786827-05:00] INFO [dmsgdial]: Successfully dialed remote host: 022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 with dmsg server: [02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd]
[2025-06-11T17:27:11.708032164-05:00] INFO [dmsgdial]: Successfully dialed remote host: 022e607e0914d6e7ccda7587f95790c09e126bbd506cc476a1eda852325aadd1aa:80 with dmsg server: [0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13]
[2025-06-11T17:27:13.694880658-05:00] INFO [dmsgdial]: Successfully dialed remote host: 02b307aee5c8ce1666c63891f8af25ad2f0a47a243914c963942b3ba35b9d095ae:80 with dmsg server: [02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd]
[2025-06-11T17:27:13.845981484-05:00] INFO [dmsgdial]: Successfully dialed remote host: 02b307aee5c8ce1666c63891f8af25ad2f0a47a243914c963942b3ba35b9d095ae:80 with dmsg server: [0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13]
[2025-06-11T17:27:14.170575193-05:00] INFO [dmsgdial]: Successfully dialed remote host: 02b307aee5c8ce1666c63891f8af25ad2f0a47a243914c963942b3ba35b9d095ae:80 with dmsg server: [030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96]
[2025-06-11T17:27:14.322863891-05:00] INFO [dmsgdial]: Successfully dialed remote host: 02b307aee5c8ce1666c63891f8af25ad2f0a47a243914c963942b3ba35b9d095ae:80 with dmsg server: [0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb]
[2025-06-11T17:27:14.474566914-05:00] INFO [dmsgdial]: Successfully dialed remote host: 02b307aee5c8ce1666c63891f8af25ad2f0a47a243914c963942b3ba35b9d095ae:80 with dmsg server: [03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4]
[2025-06-11T17:27:14.632727499-05:00] INFO [dmsgdial]: Successfully dialed remote host: 02b307aee5c8ce1666c63891f8af25ad2f0a47a243914c963942b3ba35b9d095ae:80 with dmsg server: [0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7]
[2025-06-11T17:27:16.784066185-05:00] INFO [dmsgdial]: Successfully dialed remote host: 03234b2ee4128d1f78c180d06911102906c80795dfe41bd6253f2619c8b6252a02:80 with dmsg server: [0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb]
[2025-06-11T17:27:16.938878913-05:00] INFO [dmsgdial]: Successfully dialed remote host: 03234b2ee4128d1f78c180d06911102906c80795dfe41bd6253f2619c8b6252a02:80 with dmsg server: [03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4]
[2025-06-11T17:27:17.095115486-05:00] INFO [dmsgdial]: Successfully dialed remote host: 03234b2ee4128d1f78c180d06911102906c80795dfe41bd6253f2619c8b6252a02:80 with dmsg server: [0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13]
[2025-06-11T17:27:17.248677964-05:00] INFO [dmsgdial]: Successfully dialed remote host: 03234b2ee4128d1f78c180d06911102906c80795dfe41bd6253f2619c8b6252a02:80 with dmsg server: [0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7]
[2025-06-11T17:27:17.406186433-05:00] INFO [dmsgdial]: Successfully dialed remote host: 03234b2ee4128d1f78c180d06911102906c80795dfe41bd6253f2619c8b6252a02:80 with dmsg server: [02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd]
[2025-06-11T17:27:17.735190877-05:00] INFO [dmsgdial]: Successfully dialed remote host: 03234b2ee4128d1f78c180d06911102906c80795dfe41bd6253f2619c8b6252a02:80 with dmsg server: [030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96]
[2025-06-11T17:27:19.916955366-05:00] INFO [dmsgdial]: Successfully dialed remote host: 039d89c5eedfda4a28b0c58b0b643eff949f08e4f68c8357278081d26f5a592d74:80 with dmsg server: [030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96]
[2025-06-11T17:27:20.069029267-05:00] INFO [dmsgdial]: Successfully dialed remote host: 039d89c5eedfda4a28b0c58b0b643eff949f08e4f68c8357278081d26f5a592d74:80 with dmsg server: [0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13]
[2025-06-11T17:27:20.22115732-05:00] INFO [dmsgdial]: Successfully dialed remote host: 039d89c5eedfda4a28b0c58b0b643eff949f08e4f68c8357278081d26f5a592d74:80 with dmsg server: [02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd]
[2025-06-11T17:27:20.376458521-05:00] INFO [dmsgdial]: Successfully dialed remote host: 039d89c5eedfda4a28b0c58b0b643eff949f08e4f68c8357278081d26f5a592d74:80 with dmsg server: [0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb]
[2025-06-11T17:27:20.527889224-05:00] INFO [dmsgdial]: Successfully dialed remote host: 039d89c5eedfda4a28b0c58b0b643eff949f08e4f68c8357278081d26f5a592d74:80 with dmsg server: [0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7]
[2025-06-11T17:27:20.684332275-05:00] INFO [dmsgdial]: Successfully dialed remote host: 039d89c5eedfda4a28b0c58b0b643eff949f08e4f68c8357278081d26f5a592d74:80 with dmsg server: [03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4]
[2025-06-11T17:27:22.905014744-05:00] INFO [dmsgdial]: Successfully dialed remote host: 022c424caa6239ba7d1d9d8f7dab56cd5ec6ae2ea9ad97bb94ad4b48f62a540d3f:80 with dmsg server: [0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7]
[2025-06-11T17:27:23.067178126-05:00] INFO [dmsgdial]: Successfully dialed remote host: 022c424caa6239ba7d1d9d8f7dab56cd5ec6ae2ea9ad97bb94ad4b48f62a540d3f:80 with dmsg server: [02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd]
[2025-06-11T17:27:23.218897188-05:00] INFO [dmsgdial]: Successfully dialed remote host: 022c424caa6239ba7d1d9d8f7dab56cd5ec6ae2ea9ad97bb94ad4b48f62a540d3f:80 with dmsg server: [03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4]
[2025-06-11T17:27:23.557630936-05:00] INFO [dmsgdial]: Successfully dialed remote host: 022c424caa6239ba7d1d9d8f7dab56cd5ec6ae2ea9ad97bb94ad4b48f62a540d3f:80 with dmsg server: [030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96]
[2025-06-11T17:27:23.714502791-05:00] INFO [dmsgdial]: Successfully dialed remote host: 022c424caa6239ba7d1d9d8f7dab56cd5ec6ae2ea9ad97bb94ad4b48f62a540d3f:80 with dmsg server: [0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb]
[2025-06-11T17:27:23.865957695-05:00] INFO [dmsgdial]: Successfully dialed remote host: 022c424caa6239ba7d1d9d8f7dab56cd5ec6ae2ea9ad97bb94ad4b48f62a540d3f:80 with dmsg server: [0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13]
[2025-06-11T17:27:25.849972276-05:00] INFO [dmsgdial]: Successfully dialed remote host: 0204890f9def4f9a5448c2e824c6a4afc85fd1f877322320898fafdf407cc6fef7:80 with dmsg server: [0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb]
[2025-06-11T17:27:26.003908779-05:00] INFO [dmsgdial]: Successfully dialed remote host: 0204890f9def4f9a5448c2e824c6a4afc85fd1f877322320898fafdf407cc6fef7:80 with dmsg server: [0326978f5a53aff537dbb47fed58b1f123af3b00132d365f1309a14db4168dcff7]
[2025-06-11T17:27:26.331436772-05:00] INFO [dmsgdial]: Successfully dialed remote host: 0204890f9def4f9a5448c2e824c6a4afc85fd1f877322320898fafdf407cc6fef7:80 with dmsg server: [030c83534af1041aee60c2f124b682a9d60c6421876db7c67fc83a73c5effdbd96]
[2025-06-11T17:27:26.487009361-05:00] INFO [dmsgdial]: Successfully dialed remote host: 0204890f9def4f9a5448c2e824c6a4afc85fd1f877322320898fafdf407cc6fef7:80 with dmsg server: [03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4]
[2025-06-11T17:27:26.644012891-05:00] INFO [dmsgdial]: Successfully dialed remote host: 0204890f9def4f9a5448c2e824c6a4afc85fd1f877322320898fafdf407cc6fef7:80 with dmsg server: [0371ab4bcff7b121f4b91f6856d6740c6f9dc1fe716977850aeb5d84378b300a13]
[2025-06-11T17:27:26.79830296-05:00] INFO [dmsgdial]: Successfully dialed remote host: 0204890f9def4f9a5448c2e824c6a4afc85fd1f877322320898fafdf407cc6fef7:80 with dmsg server: [02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd]

@0pcom 0pcom merged commit ec26153 into skycoin:develop Jun 12, 2025
2 of 3 checks passed
@0pcom 0pcom deleted the network-test-util branch June 12, 2025 00:54
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment

Labels

None yet

Projects

None yet

Development

Successfully merging this pull request may close these issues.

1 participant