search

skycoin / skywire

Skywire Node implementation
72 stars 45 forks source link

route creation attempt loop ` [router]: Established transport exist.` - transport not in discovery but exists locally #1788

Open 0pcom opened 6 months ago

0pcom commented 6 months ago

An attempt was made to start the proxy.

 skywire-cli proxy start -k 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac

In the visor debug logging, I observed a continuous loop of route creation attempts when the 'established transport exists'

I've observed this situation before. If the transport the visor says 'exists' is deleted with skywire-cli visor tp rm then it is immediately re-established and the route creation attempt works.

This may have been due to the fact that the transport existed for the local visor but not for the remote?

this line of logging would seem to indicate that this is the case; when the transport was removed from the visor it was not found in the discovery

[2024-03-23T08:21:26.499044916-05:00] DEBUG [tp:038240]: Error deleting transport error="404 Not Found: {"error":"transport not found"}" tp-id=247984d4-4a1a-0eda-a67c-9e69bf0fb169

Here is the visor debug logging:


[2024-03-22T10:44:50.563276879-05:00] ERROR (STDERR) [proc:skysocks-client:ec838d78042049f2af5d270d10203b91]: Error serving proxy client: accept: accept tcp [::]:1080: use of closed network connection
[2024-03-22T10:44:50.563336722-05:00] INFO [proc:skysocks-client:ec838d78042049f2af5d270d10203b91]: App skysocks-client is Stopped
[2024-03-22T10:44:50.567217546-05:00] INFO [proc:skysocks-client:ec838d78042049f2af5d270d10203b91]: App skysocks-client is Stopped
[2024-03-22T10:44:50.82370147-05:00] DEBUG [RouteGroup rAddr:0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49153, lAddr:03d0c4a4df6fd1db6f9329a8bbfeb6879a171d554afe9bfbdcac5cb9c34f62a2d6:3]: Got close packet with code 0
[2024-03-22T10:44:50.823811018-05:00] DEBUG [RouteGroup rAddr:0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49153, lAddr:03d0c4a4df6fd1db6f9329a8bbfeb6879a171d554afe9bfbdcac5cb9c34f62a2d6:3]: Handling response close packet with code 0
[2024-03-22T10:44:50.823933137-05:00] DEBUG [RouteGroup rAddr:0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49153, lAddr:03d0c4a4df6fd1db6f9329a8bbfeb6879a171d554afe9bfbdcac5cb9c34f62a2d6:3]: Remote got closed, stopping ping loop
[2024-03-22T10:44:50.82397634-05:00] DEBUG [RouteGroup rAddr:0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49153, lAddr:03d0c4a4df6fd1db6f9329a8bbfeb6879a171d554afe9bfbdcac5cb9c34f62a2d6:3]: Remote got closed, stopping keep-alive loop
[2024-03-23T08:20:12.684158211-05:00] INFO [visor]: Changing skysocks-client Settings to map["--addr":":1080" "--srv":"0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac" "app":"skysocks-client"]
[2024-03-23T08:20:12.684202651-05:00] INFO [visor:config]: Flushing config to file. config_version="unknown" filepath="/opt/skywire/skywire.json"
[2024-03-23T08:20:12.68444522-05:00] INFO [visor:config]: Flushing config to file. config_version="unknown" filepath="/opt/skywire/skywire.json"
[2024-03-23T08:20:12.691972336-05:00] INFO [visor]: Updated Settings.
[2024-03-23T08:20:12.692186818-05:00] DEBUG [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: No app discovery associated with app. appName="skysocks-client"
[2024-03-23T08:20:12.830628507-05:00] DEBUG [proc_manager]: Accepting proc conn... remote=127.0.0.1:33182
[2024-03-23T08:20:12.83070353-05:00] DEBUG [proc_manager]: Read hello from proc. hello="{"proc_key":"f40bbfff4dd9439b8cc9381ae716296b"}" remote=127.0.0.1:33182
[2024-03-23T08:20:12.830735866-05:00] DEBUG [proc_manager]: Accepted proc conn. hello="{"proc_key":"f40bbfff4dd9439b8cc9381ae716296b"}" remote=127.0.0.1:33182
[2024-03-23T08:20:12.83074885-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: Version "v1.3.20-rc2" built on "2024-03-21T16:17:12Z" against commit "8e782b1305d75f7052215ad7591726fbd970eaa8"
[2024-03-23T08:20:12.830800835-05:00] DEBUG [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: Associated and serving proc conn.
[2024-03-23T08:20:14.347995395-05:00] DEBUG [transport_manager]: Initializing TP with ID 247984d4-4a1a-0eda-a67c-9e69bf0fb169
[2024-03-23T08:20:14.34814619-05:00] DEBUG [transport_manager]: Dialing transport to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac via sudph
[2024-03-23T08:20:15.795245675-05:00] DEBUG [sudph]: Resolved PK 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac to visor data {104.62.49.99:51817 false {51817 [127.0.0.1 192.168.0.8 ::1]}}
[2024-03-23T08:20:15.795322581-05:00] DEBUG [sudph]: Dialing 104.62.49.99:51817
[2024-03-23T08:20:15.795468755-05:00] DEBUG [sudph]: Dialed 104.62.49.99:51817
[2024-03-23T08:20:15.795511104-05:00] DEBUG [sudph]: Performing handshake with 104.62.49.99:51817
[2024-03-23T08:20:15.899100491-05:00] DEBUG [sudph]: Sent handshake to 104.62.49.99:51817, local addr 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49156, remote addr 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac:45
[2024-03-23T08:20:16.878270331-05:00] DEBUG [tp:038240]: Sent signal to 'mt.transportCh'.
[2024-03-23T08:20:16.878364777-05:00] DEBUG [transport_manager]: saved transport: remote(0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac) type(sudph) tpID(247984d4-4a1a-0eda-a67c-9e69bf0fb169)
[2024-03-23T08:20:16.878417529-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:16.878446049-05:00] DEBUG [tp:038240]: Serving. remote_pk=0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac tp_id=247984d4-4a1a-0eda-a67c-9e69bf0fb169 tp_index=2
[2024-03-23T08:20:17.429359798-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:17.429450776-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:17.429088014-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:18.429583175-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:18.429673495-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:18.429312624-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:19.429728176-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:19.429824484-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:19.429577677-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:20.430703621-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:20.430797034-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:20.430431887-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:21.431602134-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:21.431688469-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:21.431358101-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:22.432036133-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:22.432122553-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:22.431800752-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:23.432599809-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:23.432694236-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:23.432305691-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:24.433733066-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:24.43382513-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:24.433478429-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:25.434613922-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:25.434662173-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:25.434412082-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:26.435420826-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:26.435510657-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:26.435225641-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:27.43645227-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:27.436546162-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:27.436188255-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:28.437602309-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:28.437694463-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:28.437330631-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:29.43857964-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:29.438632022-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:29.438432002-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:30.438986488-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:30.439080438-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:30.438715935-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:31.439711337-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:31.43980972-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:31.439461738-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:32.440513177-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:32.440603253-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:32.440262221-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:33.440633646-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:33.44073223-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:33.440371119-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:34.440749673-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:34.440842977-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:34.44048582-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:35.441521144-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:35.441650958-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:35.441280416-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:36.441837727-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:36.44192746-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:36.441594618-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:37.442815842-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:37.442905435-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:37.442583307-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:38.443159573-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:38.443256336-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:38.442889808-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:39.44404983-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:39.44415135-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:39.44380497-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:40.444371754-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:40.444472432-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:40.444136954-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:41.445108049-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:41.445203902-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:41.444852208-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:42.4459902-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:42.446050257-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:42.445813322-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:43.446898869-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:43.44701855-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:43.446589196-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:44.447842166-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:44.447949338-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:44.447554208-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:45.448733513-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:45.448831475-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:45.448493512-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:46.448954277-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:46.449046543-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:46.448705347-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:47.449468195-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:47.449557871-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:47.449285512-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:48.449995634-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:48.450085688-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:48.449762954-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:49.45033109-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:49.450381238-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:49.4502003-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:50.450611498-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:50.450699367-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:50.450346109-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:51.451724705-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:51.451816172-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:51.451456099-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:52.451812482-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:52.451913122-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:52.451573598-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:53.452878293-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:53.452940597-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:53.452672661-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:54.453879594-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:54.453977075-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:54.453642217-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:55.454769076-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:55.454864222-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:55.454470879-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:56.455439292-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:56.455500942-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:56.455283021-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:57.456353171-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:57.456444093-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:57.45609017-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:58.456918838-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:58.457012265-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:58.456607777-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:20:59.457244896-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:20:59.457337542-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:20:59.457046072-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:00.457908714-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:00.457965219-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:00.457719751-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:01.458366007-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:01.458458743-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:01.45809499-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:02.458611433-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:02.458734116-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:02.458341464-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:03.459108882-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:03.459199039-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:03.458841857-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:04.459289878-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:04.459396958-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:04.459006649-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:05.460053989-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:05.460181157-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:05.459776268-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:06.461062245-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:06.461184021-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:06.460718289-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:07.461718428-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:07.461858631-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:07.461433182-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:08.462383826-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:08.462505151-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:08.462111572-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:09.462944609-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:09.463066665-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:09.462659347-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:10.463900114-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:10.464016377-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:10.463606108-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:11.464049336-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:11.464140364-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:11.463800524-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:12.464631621-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:12.464757486-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:12.464353539-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:13.46533563-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:13.465431073-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:13.465051053-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:14.466312181-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:14.466369018-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:14.46613957-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:15.467475179-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:15.467569455-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:15.46722619-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:16.467826504-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:16.467922677-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:16.467552283-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:17.46849037-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:17.468553944-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:17.468293543-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:18.468585834-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:18.46867531-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:18.468366769-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:19.469644138-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:19.469735184-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:19.469377079-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:20.470537039-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:20.470660341-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:20.47025498-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:21.471253141-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:21.471350848-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:21.470973019-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:22.471969591-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:22.472063013-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:22.471766381-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:23.472960306-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:23.473060597-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:23.472720608-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:24.473321085-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:24.473455367-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:24.472997751-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:25.473901916-05:00] DEBUG [router]: Established transport exist. Type: sudph
[2024-03-23T08:21:25.473958934-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:25.473717538-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:26.017655994-05:00] DEBUG [tp:038240]: Stopped log loop
[2024-03-23T08:21:26.0176912-05:00] DEBUG readPacket [tp:038240]: Failed to read packet header. error="io: read/write on closed pipe"
[2024-03-23T08:21:26.017703777-05:00] DEBUG [tp:038240]: Stopped serving. remaining_tps=1 remote_pk=0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac tp_id=247984d4-4a1a-0eda-a67c-9e69bf0fb169 tp_index=2
[2024-03-23T08:21:26.017748597-05:00] WARN [tp:038240]: Failed to read packet, closing transport error="io: read/write on closed pipe" src="read_loop"
[2024-03-23T08:21:26.474691948-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: func = retrier, current_backoff = 1s Retrying...
[2024-03-23T08:21:26.499044916-05:00] DEBUG [tp:038240]: Error deleting transport error="404 Not Found: {"error":"transport not found"}" tp-id=247984d4-4a1a-0eda-a67c-9e69bf0fb169
[2024-03-23T08:21:28.0307293-05:00] DEBUG [transport_manager]: Initializing TP with ID 247984d4-4a1a-0eda-a67c-9e69bf0fb169
[2024-03-23T08:21:28.030832181-05:00] DEBUG [transport_manager]: Dialing transport to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac via sudph
[2024-03-23T08:21:29.461577925-05:00] DEBUG [sudph]: Resolved PK 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac to visor data {104.62.49.99:51817 false {51817 [127.0.0.1 192.168.0.8 ::1]}}
[2024-03-23T08:21:29.461650609-05:00] DEBUG [sudph]: Dialing 104.62.49.99:51817
[2024-03-23T08:21:29.461787414-05:00] DEBUG [sudph]: Dialed 104.62.49.99:51817
[2024-03-23T08:21:29.461828659-05:00] DEBUG [sudph]: Performing handshake with 104.62.49.99:51817
[2024-03-23T08:21:29.557008152-05:00] DEBUG [sudph]: Sent handshake to 104.62.49.99:51817, local addr 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49157, remote addr 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac:45
[2024-03-23T08:21:30.231229213-05:00] DEBUG [tp:038240]: Sent signal to 'mt.transportCh'.
[2024-03-23T08:21:30.231325072-05:00] DEBUG [transport_manager]: saved transport: remote(0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac) type(sudph) tpID(247984d4-4a1a-0eda-a67c-9e69bf0fb169)
[2024-03-23T08:21:30.231366343-05:00] DEBUG [router]: Requesting new routes from 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:30.231458131-05:00] DEBUG [tp:038240]: Serving. remote_pk=0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac tp_id=247984d4-4a1a-0eda-a67c-9e69bf0fb169 tp_index=2
[2024-03-23T08:21:30.843716204-05:00] DEBUG [router]: Found routes Forward: [[0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c -> 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac @ 247984d4-4a1a-0eda-a67c-9e69bf0fb169]]. Reverse [[0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac -> 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c @ 247984d4-4a1a-0eda-a67c-9e69bf0fb169]]
[2024-03-23T08:21:31.811901398-05:00] DEBUG [dmsgC]: Dialing session... remote_pk=03d5b55d1133b26485c664cf8b95cff6746d1e321c34e48c9fed293eff0d6d49e5
[2024-03-23T08:21:32.767452987-05:00] DEBUG [dmsgC]: Updating entry. entry= version: 0.0.1
    sequence: 2
    registered at: 1711038265028773434
    static public key: 0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c
    signature: dc37920b0cf916f8cc007bc0851a973a9a1e0da1fa2fabba4cc55cbe6850a8ee59bd275c25acb468c0d74751529ba1024fdeeb77828e76415812f18a8ef91af201
    entry is registered as client. Related info: 
        delegated servers: 
            03d5b55d1133b26485c664cf8b95cff6746d1e321c34e48c9fed293eff0d6d49e5
            0281a102c82820e811368c8d028cf11b1a985043b726b1bcdb8fce89b27384b2cb
            03717576ada5b1744e395c66c2bb11cea73b0e23d0dcd54422139b1a7f12e962c4
            02a2d4c346dabd165fd555dfdba4a7f4d18786fe7e055e562397cd5102bdd7f8dd

[2024-03-23T08:21:33.24350547-05:00] DEBUG [dmsgC]: Serving session. remote_pk=03d5b55d1133b26485c664cf8b95cff6746d1e321c34e48c9fed293eff0d6d49e5
[2024-03-23T08:21:33.741674001-05:00] DEBUG [router]: handling setup request: setupPK(0324579f003e6b4048bae2def4365e634d8e0e3054a20fc7af49daf2a179658557)
[2024-03-23T08:21:35.50547349-05:00] DEBUG [router]: ROUTING TABLE CONTENTS: map[3:FWD(keyRtID:3, nxtRtID:3, nxtTpID:247984d4-4a1a-0eda-a67c-9e69bf0fb169, rAddr:0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac:3, lAddr:0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49224)]
[2024-03-23T08:21:35.505555356-05:00] DEBUG [router]: Save new Routing Rule with ID 3 FWD(keyRtID:3, nxtRtID:3, nxtTpID:247984d4-4a1a-0eda-a67c-9e69bf0fb169, rAddr:0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac:3, lAddr:0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49224)
[2024-03-23T08:21:35.505620984-05:00] DEBUG [router]: ROUTING TABLE CONTENTS: map[3:FWD(keyRtID:3, nxtRtID:3, nxtTpID:247984d4-4a1a-0eda-a67c-9e69bf0fb169, rAddr:0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac:3, lAddr:0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49224) 4:REV(keyRtID:4, rAddr:0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49224, lAddr:0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac:3)]
[2024-03-23T08:21:35.505676967-05:00] DEBUG [router]: Save new Routing Rule with ID 4 REV(keyRtID:4, rAddr:0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49224, lAddr:0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac:3)
[2024-03-23T08:21:35.505718881-05:00] DEBUG [router]: Saving route group rules with desc: rAddr:0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49224, lAddr:0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac:3
[2024-03-23T08:21:35.505844396-05:00] DEBUG [RouteGroup rAddr:0323272a60895f56aad82cb767fb5c413807adcf7c9fb0578b1b1c5807c7f29d4c:49224, lAddr:0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac:3]: Sent handshake via transport 247984d4-4a1a-0eda-a67c-9e69bf0fb169
[2024-03-23T08:21:35.621943652-05:00] DEBUG [router]: Created new routes to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac on port 49224
[2024-03-23T08:21:35.622402411-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: Connected to 0382406ebecec832a1c27dece7cf58425a1c98753c7b3be8428d4414eada0986ac
[2024-03-23T08:21:35.631556904-05:00] DEBUG (STDOUT) [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: Serving proxy client :1080
[2024-03-23T08:21:35.622636889-05:00] INFO [proc:skysocks-client:f40bbfff4dd9439b8cc9381ae716296b]: App skysocks-client is Running

image

0pcom commented 6 months ago

1758 is related