Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Problems making relay connections, invalid peer certificate: UnknownIssuer #2257

Closed
eminence opened this issue May 1, 2024 · 6 comments
Closed

Comments

@eminence
Copy link

eminence commented May 1, 2024

On a RHEL 8.6 system, I am trying to run doctor connect q22mj7s2phuhfgv5uo3egakw6hj4v32owu7mv3tuxsbzqxz2ayha --relay-url https://use1-1.relay.iroh.network./ and I'm getting these errors:

2024-05-01T02:51:57.339294Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: actor msg, current client false
2024-05-01T02:51:57.339384Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.339652Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.358087Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45618
2024-05-01T02:51:57.358151Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.358243Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.358638Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.378385Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.378464Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.378925Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.378981Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.379463Z  WARN magicsock{me=2oupdfbvwlxiykms}:relay-actor:active-relay{url=https://use1-1.relay.iroh.network./}: iroh_net::magicsock::relay_actor: connection error: initial connection

Caused by:
    0: dial error
    1: invalid peer certificate: UnknownIssuer
2024-05-01T02:51:57.379550Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: closing connection: sender-closed url=https://use1-1.relay.iroh.network./
click for full logs (truncated arbitrarily due to github comment lenght limitations)
2024-05-01T02:51:56.959689Z  INFO iroh::commands::doctor: public key: d3a8f19435b2ee8c299210cd68a46ad255ddf3a1c32359537ab1859800bcb0d3
2024-05-01T02:51:56.959896Z  INFO iroh::commands::doctor: relay map Some(
    RelayMap {
        nodes: {
            RelayUrl(
                "https://euw1-1.relay.iroh.network./",
            ): RelayNode {
                url: RelayUrl(
                    "https://euw1-1.relay.iroh.network./",
                ),
                stun_only: false,
                stun_port: 3478,
            },
            RelayUrl(
                "https://use1-1.relay.iroh.network./",
            ): RelayNode {
                url: RelayUrl(
                    "https://use1-1.relay.iroh.network./",
                ),
                stun_only: false,
                stun_port: 3478,
            },
        },
    },
)
2024-05-01T02:51:56.961698Z DEBUG magicsock{me=2oupdfbvwlxiykms}: iroh_net::magicsock::udp_conn: binding network=V4 port=0
2024-05-01T02:51:56.961765Z DEBUG magicsock{me=2oupdfbvwlxiykms}:portmapper.service: iroh_net::portmapper: portmap starting
2024-05-01T02:51:56.961947Z DEBUG magicsock{me=2oupdfbvwlxiykms}: iroh_net::magicsock::udp_conn: candidate ports ports=[0]
2024-05-01T02:51:56.962184Z DEBUG magicsock{me=2oupdfbvwlxiykms}: iroh_net::magicsock::udp_conn: successfully bound network=V4 local_addr=0.0.0.0:44534
2024-05-01T02:51:56.962314Z DEBUG magicsock{me=2oupdfbvwlxiykms}: iroh_net::magicsock::udp_conn: binding network=V6 port=44535
2024-05-01T02:51:56.962418Z DEBUG magicsock{me=2oupdfbvwlxiykms}: iroh_net::magicsock::udp_conn: candidate ports ports=[44535, 0]
2024-05-01T02:51:56.962623Z DEBUG magicsock{me=2oupdfbvwlxiykms}: iroh_net::magicsock::udp_conn: successfully bound network=V6 local_addr=[::]:44535
2024-05-01T02:51:56.963918Z DEBUG netlink_proto::connection: reading incoming messages
2024-05-01T02:51:56.963948Z DEBUG netlink_proto::codecs: NetlinkCodec: decoding next message
2024-05-01T02:51:56.963971Z DEBUG netlink_proto::connection: forwarding unsolicited messages to the connection handle
2024-05-01T02:51:56.963989Z DEBUG netlink_proto::connection: forwarding responses to previous requests to the connection handle
2024-05-01T02:51:56.964006Z DEBUG netlink_proto::connection: handling requests
2024-05-01T02:51:56.964027Z DEBUG netlink_proto::connection: sending messages
2024-05-01T02:51:56.964192Z DEBUG magicsock{me=2oupdfbvwlxiykms}:actor: iroh_net::magicsock: scheduling periodic_stun to run immediately and in 20s
2024-05-01T02:51:56.964398Z DEBUG magicsock{me=2oupdfbvwlxiykms}:portmapper.service: iroh_net::portmapper: getting a port mapping for 172.25.105.202:44534 -> None
2024-05-01T02:51:56.964421Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor: iroh_net::netcheck: netcheck actor starting
2024-05-01T02:51:56.964604Z DEBUG magicsock{me=2oupdfbvwlxiykms}:portmapper.service:upnp: igd_next::aio::tokio: sending broadcast request to: 239.255.255.250:1900 on interface: Ok(0.0.0.0:40921)
2024-05-01T02:51:56.969249Z DEBUG magicsock{me=2oupdfbvwlxiykms}:actor:re_stun{me=2oupdfbvwlxiykms}: iroh_net::magicsock: re_stun: periodic
2024-05-01T02:51:56.969385Z DEBUG magicsock{me=2oupdfbvwlxiykms}:actor:update_endpoints: iroh_net::magicsock: starting endpoint update (periodic)
2024-05-01T02:51:56.969459Z DEBUG magicsock{me=2oupdfbvwlxiykms}:actor:update_endpoints:update_net_info: iroh_net::magicsock: requesting netcheck report
2024-05-01T02:51:56.970132Z DEBUG magicsock{me=2oupdfbvwlxiykms}:portmapper.service: iroh_net::portmapper: getting a port mapping for 172.25.105.202:44534 -> None
2024-05-01T02:51:56.970409Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor: iroh_net::netcheck::reportgen: reportstate actor starting port_mapper=true
2024-05-01T02:51:56.970977Z DEBUG magicsock{me=2oupdfbvwlxiykms}:portmapper.service:upnp: igd_next::aio::tokio: sending broadcast request to: 239.255.255.250:1900 on interface: Ok(0.0.0.0:51492)
2024-05-01T02:51:56.976596Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor: iroh_net::netcheck::reportgen: Local interfaces if_state=1. lo Loopback ipv4=[127.0.0.1/8] ipv6=[]; 2. ens192 Ethernet ipv4=[172.25.105.202/22] ipv6=[] (default);
2024-05-01T02:51:56.977800Z DEBUG magicsock{me=2oupdfbvwlxiykms}:portmapper.service:portmapper.probe: igd_next::aio::tokio: sending broadcast request to: 239.255.255.250:1900 on interface: Ok(0.0.0.0:52142)
2024-05-01T02:51:56.977964Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: iroh_net::netcheck::reportgen: starting probe
2024-05-01T02:51:56.978096Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: iroh_net::netcheck::reportgen: Performing DNS A lookup for relay addr proto=StunIpv4 hostname=euw1-1.relay.iroh.network.
2024-05-01T02:51:56.978310Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: hickory_proto::xfer::dns_handle: querying: euw1-1.relay.iroh.network. A
2024-05-01T02:51:56.978400Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: hickory_resolver::name_server::name_server_pool: sending request: [Query { name: Name("euw1-1.relay.iroh.network."), query_type: A, query_class: IN }]
2024-05-01T02:51:56.978529Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: hickory_resolver::name_server::name_server: reconnecting: NameServerConfig { socket_addr: 10.24.9.11:53, protocol: Udp, tls_dns_name: None, trust_negative_responses: false, tls_config: None, bind_addr: None }
2024-05-01T02:51:56.978643Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: hickory_proto::xfer: enqueueing message:QUERY:[Query { name: Name("euw1-1.relay.iroh.network."), query_type: A, query_class: IN }]
2024-05-01T02:51:56.978709Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: hickory_resolver::name_server::name_server: reconnecting: NameServerConfig { socket_addr: 10.24.9.10:53, protocol: Udp, tls_dns_name: None, trust_negative_responses: false, tls_config: None, bind_addr: None }
2024-05-01T02:51:56.978780Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: hickory_proto::xfer: enqueueing message:QUERY:[Query { name: Name("euw1-1.relay.iroh.network."), query_type: A, query_class: IN }]
2024-05-01T02:51:56.978928Z DEBUG hickory_proto::udp::udp_client_stream: final message: ; header 34666:QUERY:RD:NoError:QUERY:0/0/0
; query
;; euw1-1.relay.iroh.network. IN A

2024-05-01T02:51:56.979038Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: iroh_net::netcheck::reportgen: starting probe
2024-05-01T02:51:56.979143Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: iroh_net::netcheck::reportgen: Performing DNS A lookup for relay addr proto=StunIpv4 hostname=use1-1.relay.iroh.network.
2024-05-01T02:51:56.979268Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: hickory_proto::xfer::dns_handle: querying: use1-1.relay.iroh.network. A
2024-05-01T02:51:56.979338Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: hickory_resolver::name_server::name_server_pool: sending request: [Query { name: Name("use1-1.relay.iroh.network."), query_type: A, query_class: IN }]
2024-05-01T02:51:56.979429Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: hickory_resolver::name_server::name_server: existing connection: NameServerConfig { socket_addr: 10.24.9.11:53, protocol: Udp, tls_dns_name: None, trust_negative_responses: false, tls_config: None, bind_addr: None }
2024-05-01T02:51:56.979488Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: hickory_proto::xfer: enqueueing message:QUERY:[Query { name: Name("use1-1.relay.iroh.network."), query_type: A, query_class: IN }]
2024-05-01T02:51:56.979548Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: hickory_resolver::name_server::name_server: existing connection: NameServerConfig { socket_addr: 10.24.9.10:53, protocol: Udp, tls_dns_name: None, trust_negative_responses: false, tls_config: None, bind_addr: None }
2024-05-01T02:51:56.979599Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: hickory_proto::xfer: enqueueing message:QUERY:[Query { name: Name("use1-1.relay.iroh.network."), query_type: A, query_class: IN }]
2024-05-01T02:51:56.979720Z DEBUG hickory_proto::udp::udp_client_stream: final message: ; header 42245:QUERY:RD:NoError:QUERY:0/0/0
; query
;; use1-1.relay.iroh.network. IN A

2024-05-01T02:51:56.980090Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: hickory_proto::udp::udp_stream: created socket successfully
2024-05-01T02:51:56.980199Z DEBUG hickory_proto::udp::udp_client_stream: final message: ; header 10088:QUERY:RD:NoError:QUERY:0/0/0
; query
;; euw1-1.relay.iroh.network. IN A

2024-05-01T02:51:56.980253Z DEBUG hickory_proto::udp::udp_client_stream: final message: ; header 9946:QUERY:RD:NoError:QUERY:0/0/0
; query
;; use1-1.relay.iroh.network. IN A

2024-05-01T02:51:56.980390Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: hickory_proto::udp::udp_stream: created socket successfully
2024-05-01T02:51:56.980503Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: hickory_proto::udp::udp_stream: created socket successfully
2024-05-01T02:51:56.980581Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: hickory_proto::udp::udp_stream: created socket successfully
2024-05-01T02:51:56.981064Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: hickory_proto::udp::udp_client_stream: received message id: 42245
2024-05-01T02:51:56.981181Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: hickory_resolver::error: Response:; header 42245:RESPONSE:RD,RA:NoError:QUERY:1/0/0
; query
;; use1-1.relay.iroh.network. IN A
; answers 1
use1-1.relay.iroh.network. 235 IN A 5.161.115.11
; nameservers 0
; additionals 0

2024-05-01T02:51:56.981295Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: hickory_resolver::error: Response:; header 42245:RESPONSE:RD,RA:NoError:QUERY:1/0/0
; query
;; use1-1.relay.iroh.network. IN A
; answers 1
use1-1.relay.iroh.network. 235 IN A 5.161.115.11
; nameservers 0
; additionals 0

2024-05-01T02:51:56.981585Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://use1-1.relay.iroh.network./}: iroh_net::netcheck::reportgen: sending StunIpv4 probe relay_addr=5.161.115.11:3478 txid=transaction id (0x8FC6889C62F833F3672B6C38)
2024-05-01T02:51:56.981733Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: hickory_proto::udp::udp_client_stream: received message id: 34666
2024-05-01T02:51:56.981823Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: hickory_resolver::error: Response:; header 34666:RESPONSE:RD,RA:NoError:QUERY:1/0/0
; query
;; euw1-1.relay.iroh.network. IN A
; answers 1
euw1-1.relay.iroh.network. 235 IN A 116.203.71.221
; nameservers 0
; additionals 0

2024-05-01T02:51:56.981932Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: hickory_resolver::error: Response:; header 34666:RESPONSE:RD,RA:NoError:QUERY:1/0/0
; query
;; euw1-1.relay.iroh.network. IN A
; answers 1
euw1-1.relay.iroh.network. 235 IN A 116.203.71.221
; nameservers 0
; additionals 0

2024-05-01T02:51:56.982148Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 0ns to https://euw1-1.relay.iroh.network./}: iroh_net::netcheck::reportgen: sending StunIpv4 probe relay_addr=116.203.71.221:3478 txid=transaction id (0x4199982A8C9A6AC653C459D5)
2024-05-01T02:51:57.000698Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor: iroh_net::netcheck: received known STUN packet src=5.161.115.11:3478 txn=transaction id (0x8FC6889C62F833F3672B6C38)
2024-05-01T02:51:57.000987Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor: iroh_net::netcheck::reportgen: finished probe probe_report=ProbeReport { ipv4_can_send: true, ipv6_can_send: false, icmpv4: None, icmpv6: None, latency: Some(19.298638ms), probe: StunIpv4 { delay: 0ns, node: RelayNode { url: RelayUrl("https://use1-1.relay.iroh.network./"), stun_only: false, stun_port: 3478 } }, addr: Some(160.231.28.180:29487) }
2024-05-01T02:51:57.079726Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 100ms to https://euw1-1.relay.iroh.network./}: iroh_net::netcheck::reportgen: starting probe
2024-05-01T02:51:57.079973Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 100ms to https://euw1-1.relay.iroh.network./}: iroh_net::netcheck::reportgen: Performing DNS A lookup for relay addr proto=StunIpv4 hostname=euw1-1.relay.iroh.network.
2024-05-01T02:51:57.080435Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=STUN Ipv4 after 100ms to https://euw1-1.relay.iroh.network./}: iroh_net::netcheck::reportgen: sending StunIpv4 probe relay_addr=116.203.71.221:3478 txid=transaction id (0x7ADDFBEC01B19CCA54DEC296)
2024-05-01T02:51:57.085874Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor: iroh_net::netcheck: received known STUN packet src=116.203.71.221:3478 txn=transaction id (0x4199982A8C9A6AC653C459D5)
2024-05-01T02:51:57.086153Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor: iroh_net::netcheck::reportgen: finished probe probe_report=ProbeReport { ipv4_can_send: true, ipv6_can_send: false, icmpv4: None, icmpv6: None, latency: Some(103.873137ms), probe: StunIpv4 { delay: 0ns, node: RelayNode { url: RelayUrl("https://euw1-1.relay.iroh.network./"), stun_only: false, stun_port: 3478 } }, addr: Some(160.231.28.180:29488) }
2024-05-01T02:51:57.086237Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor: iroh_net::netcheck::reportgen: Have enough probe reports, aborting further probes soon reports=2 delay=207.746274ms
2024-05-01T02:51:57.102353Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:hairpin.actor: iroh_net::netcheck::reportgen::hairpin: hairpinning done in 101.110341ms, res: false
2024-05-01T02:51:57.178963Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor: iroh_net::netcheck::reportgen: Captive portal check started after 200ms
2024-05-01T02:51:57.179557Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:captive-portal: reqwest::connect: starting new connection: http://use1-1.relay.iroh.network./
2024-05-01T02:51:57.179822Z DEBUG hyper::client::connect::dns: resolving host="use1-1.relay.iroh.network."
2024-05-01T02:51:57.181262Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:captive-portal: hyper::client::connect::http: connecting to 5.161.115.11:80
2024-05-01T02:51:57.183762Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor: iroh_net::netcheck: received known STUN packet src=116.203.71.221:3478 txn=transaction id (0x7ADDFBEC01B19CCA54DEC296)
2024-05-01T02:51:57.199981Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:captive-portal: hyper::client::connect::http: connected to 5.161.115.11:80
2024-05-01T02:51:57.200426Z DEBUG hyper::proto::h1::io: flushed 131 bytes
2024-05-01T02:51:57.281058Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=ICMPv4 after 300ms to https://euw1-1.relay.iroh.network./}: iroh_net::netcheck::reportgen: starting probe
2024-05-01T02:51:57.281104Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor:run_probe{probe=HTTPS after 300ms to https://euw1-1.relay.iroh.network./}: iroh_net::netcheck::reportgen: starting probe
2024-05-01T02:51:57.281375Z DEBUG iroh_net::netcheck::reportgen: probe set aborted: ReportCheck says probe set no longer useful probe=IcmpV4 { delay: 300ms, node: RelayNode { url: RelayUrl("https://euw1-1.relay.iroh.network./"), stun_only: false, stun_port: 3478 } }
2024-05-01T02:51:57.281383Z DEBUG iroh_net::netcheck::reportgen: probe set aborted: ReportCheck says probe set no longer useful probe=Https { delay: 300ms, node: RelayNode { url: RelayUrl("https://euw1-1.relay.iroh.network./"), stun_only: false, stun_port: 3478 } }
2024-05-01T02:51:57.286245Z DEBUG hyper::proto::h1::conn: parse error (invalid HTTP version parsed) with 3010 bytes
2024-05-01T02:51:57.286272Z DEBUG hyper::proto::h1::dispatch: read_head error: invalid HTTP version parsed
2024-05-01T02:51:57.286620Z  WARN magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor: iroh_net::netcheck::reportgen: check_captive_portal error: error sending request for url (http://use1-1.relay.iroh.network./generate_204): invalid HTTP version parsed
2024-05-01T02:51:57.294951Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor: iroh_net::netcheck::reportgen: all tasks done
2024-05-01T02:51:57.295007Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor: iroh_net::netcheck::reportgen: aborting 2 probe sets, already have enough reports
2024-05-01T02:51:57.295074Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor: iroh_net::netcheck::reportgen: Sending report to netcheck actor
2024-05-01T02:51:57.295141Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor:reportgen.actor: iroh_net::netcheck::reportgen: reportgen actor finished
2024-05-01T02:51:57.295287Z DEBUG magicsock{me=2oupdfbvwlxiykms}:netcheck.actor: iroh_net::netcheck: Report { udp: true, ipv6: false, ipv4: true, ipv6_can_send: false, ipv4_can_send: true, os_has_ipv6: false, icmpv4: None, icmpv6: None, mapping_varies_by_dest_ip: Some(true), mapping_varies_by_dest_ipv6: None, hair_pinning: Some(false), portmap_probe: None, preferred_relay: Some(RelayUrl("https://use1-1.relay.iroh.network./")), relay_latency: RelayLatencies({RelayUrl("https://euw1-1.relay.iroh.network./"): 103.873137ms, RelayUrl("https://use1-1.relay.iroh.network./"): 19.298638ms}), relay_v4_latency: RelayLatencies({RelayUrl("https://euw1-1.relay.iroh.network./"): 103.873137ms, RelayUrl("https://use1-1.relay.iroh.network./"): 19.298638ms}), relay_v6_latency: RelayLatencies({}), global_v4: Some(160.231.28.180:29487), global_v6: None, captive_portal: None }
2024-05-01T02:51:57.295531Z  INFO magicsock{me=2oupdfbvwlxiykms}:actor: iroh_net::magicsock: home is now relay https://use1-1.relay.iroh.network./, was None
2024-05-01T02:51:57.295675Z DEBUG pkarr_publish{me=2oupdfbvwlxiykms}: iroh_net::discovery::pkarr_publish: Publish node info to pkarr (info changed)
2024-05-01T02:51:57.295720Z  INFO pkarr_publish{me=2oupdfbvwlxiykms}: iroh_net::discovery::pkarr_publish: Publish node info to pkarr relay_url=Some("https://use1-1.relay.iroh.network./")
2024-05-01T02:51:57.296301Z DEBUG magicsock{me=2oupdfbvwlxiykms}:actor: iroh_net::magicsock: endpoints changed: 160.231.28.180:29487 (stun), 160.231.28.180:44534 (stun4localport), 172.25.105.202:44534 (local)
2024-05-01T02:51:57.296353Z  INFO iroh::commands::doctor: dialing PublicKey(q22mj7s2phuhfgv5)
2024-05-01T02:51:57.296393Z DEBUG magicsock{me=2oupdfbvwlxiykms}:actor: iroh_net::magicsock: scheduling periodic_stun to run in 20s
2024-05-01T02:51:57.296442Z DEBUG magicsock{me=2oupdfbvwlxiykms}:actor: iroh_net::magicsock: endpoint update done (periodic)
2024-05-01T02:51:57.296521Z  INFO add_node_addr{me=2oupdfbvwlxiykms}:add_node_addr{node=q22mj7s2phuhfgv5}: iroh_net::magicsock::node_map: inserting new node in NodeMap node=q22mj7s2phuhfgv5 relay_url=Some(RelayUrl("https://use1-1.relay.iroh.network./"))
2024-05-01T02:51:57.296559Z DEBUG pkarr_publish{me=2oupdfbvwlxiykms}: reqwest::connect: starting new connection: https://dns.iroh.link/
2024-05-01T02:51:57.296584Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: connect relay https://use1-1.relay.iroh.network./ for peer None
2024-05-01T02:51:57.296627Z DEBUG add_node_addr{me=2oupdfbvwlxiykms}:add_node_addr{node=q22mj7s2phuhfgv5}: iroh_net::magicsock::node_map::node_state: added new direct paths for endpoint new={} paths=[]
2024-05-01T02:51:57.296677Z DEBUG hyper::client::connect::dns: resolving host="dns.iroh.link"
2024-05-01T02:51:57.296813Z DEBUG iroh_net::magic_endpoint: connecting to q22mj7s2phuhfgv5uo3egakw6hj4v32owu7mv3tuxsbzqxz2ayha: (via [fd15:70a:510b::1]:12345 - {})
2024-05-01T02:51:57.296630Z  INFO magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: adding connection to relay: https://use1-1.relay.iroh.network./ for home-keep-alive
2024-05-01T02:51:57.297440Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: 1 active relay conns: relay-https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.297470Z DEBUG pkarr_publish{me=2oupdfbvwlxiykms}: hyper::client::connect::http: connecting to 49.13.207.244:443
2024-05-01T02:51:57.297542Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:active-relay{url=https://use1-1.relay.iroh.network./}: iroh_net::magicsock::relay_actor: initial dial https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.297580Z DEBUG rustls::client::hs: No cached session for DnsName("localhost")
2024-05-01T02:51:57.297637Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: initial connect, current client false
2024-05-01T02:51:57.297723Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.297962Z DEBUG rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.297971Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: hickory_proto::xfer::dns_handle: querying: use1-1.relay.iroh.network. AAAA
2024-05-01T02:51:57.298063Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: hickory_resolver::name_server::name_server_pool: sending request: [Query { name: Name("use1-1.relay.iroh.network."), query_type: AAAA, query_class: IN }]
2024-05-01T02:51:57.298169Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: hickory_resolver::name_server::name_server: existing connection: NameServerConfig { socket_addr: 10.24.9.11:53, protocol: Udp, tls_dns_name: None, trust_negative_responses: false, tls_config: None, bind_addr: None }
2024-05-01T02:51:57.298220Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: hickory_proto::xfer: enqueueing message:QUERY:[Query { name: Name("use1-1.relay.iroh.network."), query_type: AAAA, query_class: IN }]
2024-05-01T02:51:57.298283Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: hickory_resolver::name_server::name_server: existing connection: NameServerConfig { socket_addr: 10.24.9.10:53, protocol: Udp, tls_dns_name: None, trust_negative_responses: false, tls_config: None, bind_addr: None }
2024-05-01T02:51:57.298327Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: hickory_proto::xfer: enqueueing message:QUERY:[Query { name: Name("use1-1.relay.iroh.network."), query_type: AAAA, query_class: IN }]
2024-05-01T02:51:57.298495Z DEBUG hickory_proto::udp::udp_client_stream: final message: ; header 61781:QUERY:RD:NoError:QUERY:0/0/0
; query
;; use1-1.relay.iroh.network. IN AAAA

2024-05-01T02:51:57.298569Z DEBUG hickory_proto::udp::udp_client_stream: final message: ; header 64447:QUERY:RD:NoError:QUERY:0/0/0
; query
;; use1-1.relay.iroh.network. IN AAAA

2024-05-01T02:51:57.298721Z DEBUG poll_send{me=2oupdfbvwlxiykms}:get_send_addrs{node=q22mj7s2phuhfgv5}:want_call_me_maybe: iroh_net::magicsock::node_map::node_state: no previous full ping: need full ping
2024-05-01T02:51:57.298733Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: hickory_proto::udp::udp_stream: created socket successfully
2024-05-01T02:51:57.298779Z DEBUG poll_send{me=2oupdfbvwlxiykms}:get_send_addrs{node=q22mj7s2phuhfgv5}: iroh_net::magicsock::node_map::node_state: relay path needs ping url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.298811Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: hickory_proto::udp::udp_stream: created socket successfully
2024-05-01T02:51:57.298824Z DEBUG poll_send{me=2oupdfbvwlxiykms}:get_send_addrs{node=q22mj7s2phuhfgv5}: iroh_net::magicsock::node_map::node_state: prune addresses: 0 pruned paths=[]
2024-05-01T02:51:57.298886Z DEBUG poll_send{me=2oupdfbvwlxiykms}:get_send_addrs{node=q22mj7s2phuhfgv5}: iroh_net::magicsock::node_map::node_state: sending pings to endpoint ping_dsts=[] dst=q22mj7s2phuhfgv5 paths=[]
2024-05-01T02:51:57.298932Z DEBUG poll_send{me=2oupdfbvwlxiykms}:get_send_addrs{node=q22mj7s2phuhfgv5}: iroh_net::magicsock::node_map::node_state: queue call-me-maybe url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.299056Z DEBUG poll_send{me=2oupdfbvwlxiykms}:handle_ping_action: iroh_net::magicsock: send disco message (relay) node=q22mj7s2phuhfgv5 url=https://use1-1.relay.iroh.network./ msg=CallMeMaybe
2024-05-01T02:51:57.299491Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: hickory_proto::udp::udp_client_stream: received message id: 61781
2024-05-01T02:51:57.299591Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: hickory_resolver::error: Response:; header 61781:RESPONSE:RD,RA:NoError:QUERY:1/0/0
; query
;; use1-1.relay.iroh.network. IN AAAA
; answers 1
use1-1.relay.iroh.network. 236 IN AAAA 2a01:4ff:f0:81d7::1
; nameservers 0
; additionals 0

2024-05-01T02:51:57.299687Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: hickory_resolver::error: Response:; header 61781:RESPONSE:RD,RA:NoError:QUERY:1/0/0
; query
;; use1-1.relay.iroh.network. IN AAAA
; answers 1
use1-1.relay.iroh.network. 236 IN AAAA 2a01:4ff:f0:81d7::1
; nameservers 0
; additionals 0

2024-05-01T02:51:57.299836Z DEBUG poll_send{me=2oupdfbvwlxiykms}:handle_ping_action: iroh_net::magicsock: call-me-maybe sent dstkey=q22mj7s2phuhfgv5 relayurl=RelayUrl("https://use1-1.relay.iroh.network./")
2024-05-01T02:51:57.299847Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.299968Z DEBUG poll_send{me=2oupdfbvwlxiykms}:handle_ping_action: iroh_net::magicsock: send disco message (relay) node=q22mj7s2phuhfgv5 url=https://use1-1.relay.iroh.network./ msg=Ping(tx=a4a9a55c89a2ac0a259c1c4e)
2024-05-01T02:51:57.300165Z DEBUG poll_send{me=2oupdfbvwlxiykms}:handle_ping_action: iroh_net::magicsock: ping sent (polled) dst=Relay(https://use1-1.relay.iroh.network./) tx=a4a9a55c89a2ac0a259c1c4e purpose=Discovery
2024-05-01T02:51:57.300333Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: connect relay https://use1-1.relay.iroh.network./ for peer Some(PublicKey(q22mj7s2phuhfgv5))
2024-05-01T02:51:57.318253Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45616
2024-05-01T02:51:57.318320Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.318397Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.318786Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.338269Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.338350Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.338835Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.338905Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.339294Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: actor msg, current client false
2024-05-01T02:51:57.339384Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.339652Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.358087Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45618
2024-05-01T02:51:57.358151Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.358243Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.358638Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.378385Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.378464Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.378925Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.378981Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.379463Z  WARN magicsock{me=2oupdfbvwlxiykms}:relay-actor:active-relay{url=https://use1-1.relay.iroh.network./}: iroh_net::magicsock::relay_actor: connection error: initial connection

Caused by:
    0: dial error
    1: invalid peer certificate: UnknownIssuer
2024-05-01T02:51:57.379550Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: closing connection: sender-closed url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.379675Z  INFO magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: adding connection to relay: https://use1-1.relay.iroh.network./ for PublicKey(q22mj7s2phuhfgv5)
2024-05-01T02:51:57.380071Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: 1 active relay conns: relay-https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.380087Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: initial connect, current client false
2024-05-01T02:51:57.380171Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.380204Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:active-relay{url=https://use1-1.relay.iroh.network./}: iroh_net::magicsock::relay_actor: initial dial https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.380427Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.397484Z DEBUG pkarr_publish{me=2oupdfbvwlxiykms}: hyper::client::connect::http: connected to 49.13.207.244:443
2024-05-01T02:51:57.397582Z DEBUG pkarr_publish{me=2oupdfbvwlxiykms}: rustls::client::hs: No cached session for DnsName("dns.iroh.link")
2024-05-01T02:51:57.397980Z DEBUG pkarr_publish{me=2oupdfbvwlxiykms}: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.398622Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45620
2024-05-01T02:51:57.398682Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.398762Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.399160Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.418905Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.418984Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.419440Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.419501Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.419877Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: send, current client false
2024-05-01T02:51:57.419970Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.420240Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.438574Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45622
2024-05-01T02:51:57.438633Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.438719Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.439122Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.458665Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.458747Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.459231Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.459292Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.459672Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: actor msg, current client false
2024-05-01T02:51:57.459758Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.460046Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.460251Z  WARN magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: send: failed DialIO(Custom { kind: InvalidData, error: InvalidCertificate(UnknownIssuer) }) url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.460378Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: connect relay https://use1-1.relay.iroh.network./ for peer Some(PublicKey(q22mj7s2phuhfgv5))
2024-05-01T02:51:57.478458Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45624
2024-05-01T02:51:57.478513Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.478593Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.478993Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.481413Z DEBUG magicsock{me=2oupdfbvwlxiykms}:portmapper.service:portmapper.probe: iroh_net::portmapper::nat_pmp: probe failed: deadline has elapsed
2024-05-01T02:51:57.481557Z DEBUG magicsock{me=2oupdfbvwlxiykms}:portmapper.service:portmapper.probe: iroh_net::portmapper::pcp: probe failed: deadline has elapsed
2024-05-01T02:51:57.498607Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.498676Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.499130Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.499186Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.499628Z  WARN magicsock{me=2oupdfbvwlxiykms}:relay-actor:active-relay{url=https://use1-1.relay.iroh.network./}: iroh_net::magicsock::relay_actor: connection error: initial connection

Caused by:
    0: dial error
    1: invalid peer certificate: UnknownIssuer
2024-05-01T02:51:57.499714Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: closing connection: sender-closed url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.499825Z  INFO magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: adding connection to relay: https://use1-1.relay.iroh.network./ for PublicKey(q22mj7s2phuhfgv5)
2024-05-01T02:51:57.499983Z DEBUG pkarr_publish{me=2oupdfbvwlxiykms}: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.500034Z DEBUG pkarr_publish{me=2oupdfbvwlxiykms}: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.500226Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: 1 active relay conns: relay-https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.500343Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:active-relay{url=https://use1-1.relay.iroh.network./}: iroh_net::magicsock::relay_actor: initial dial https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.500413Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: initial connect, current client false
2024-05-01T02:51:57.500457Z DEBUG pkarr_publish{me=2oupdfbvwlxiykms}: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.500485Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.500504Z DEBUG pkarr_publish{me=2oupdfbvwlxiykms}: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.500792Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.500848Z  WARN pkarr_publish{me=2oupdfbvwlxiykms}: iroh_net::discovery::pkarr_publish: Failed to publish to pkarr err=error sending request for url (https://dns.iroh.link/pkarr/4qwxdfbismzeakc1ndgstjdk4jk75h7bacti1w54sgn3oyfhsdjo): error trying to connect: invalid peer certificate: UnknownIssuer

Caused by:
    0: error trying to connect: invalid peer certificate: UnknownIssuer
    1: invalid peer certificate: UnknownIssuer url=https://dns.iroh.link/pkarr
2024-05-01T02:51:57.519039Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45626
2024-05-01T02:51:57.519104Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.519185Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.519572Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.539156Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.539236Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.539685Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.539739Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.540126Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: send, current client false
2024-05-01T02:51:57.540214Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.540479Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.558908Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45628
2024-05-01T02:51:57.558963Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.559046Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.559437Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.579149Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.579219Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.579659Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.579713Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.580052Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: actor msg, current client false
2024-05-01T02:51:57.580136Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.580395Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.580599Z  WARN magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: send: failed DialIO(Custom { kind: InvalidData, error: InvalidCertificate(UnknownIssuer) }) url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.580729Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: connect relay https://use1-1.relay.iroh.network./ for peer Some(PublicKey(q22mj7s2phuhfgv5))
2024-05-01T02:51:57.598638Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45630
2024-05-01T02:51:57.598697Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.598774Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.599167Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.618756Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.618851Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.619311Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.619371Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.619822Z  WARN magicsock{me=2oupdfbvwlxiykms}:relay-actor:active-relay{url=https://use1-1.relay.iroh.network./}: iroh_net::magicsock::relay_actor: connection error: initial connection

Caused by:
    0: dial error
    1: invalid peer certificate: UnknownIssuer
2024-05-01T02:51:57.619928Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: closing connection: sender-closed url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.620040Z  INFO magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: adding connection to relay: https://use1-1.relay.iroh.network./ for PublicKey(q22mj7s2phuhfgv5)
2024-05-01T02:51:57.620423Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: 1 active relay conns: relay-https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.620436Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: initial connect, current client false
2024-05-01T02:51:57.620509Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.620533Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:active-relay{url=https://use1-1.relay.iroh.network./}: iroh_net::magicsock::relay_actor: initial dial https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.620754Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.639014Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45632
2024-05-01T02:51:57.639074Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.639148Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.639534Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.659130Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.659206Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.659672Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.659729Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.660129Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: send, current client false
2024-05-01T02:51:57.660223Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.660496Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.678764Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45634
2024-05-01T02:51:57.678875Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.678998Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.679600Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.699308Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.699388Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.699852Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.699917Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.700288Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client: iroh_net::relay::http::client: connect: actor msg, current client false
2024-05-01T02:51:57.700383Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: dial url self.url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.700657Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: connecting to 5.161.115.11:443
2024-05-01T02:51:57.700885Z  WARN magicsock{me=2oupdfbvwlxiykms}:relay-actor: iroh_net::magicsock::relay_actor: send: failed DialIO(Custom { kind: InvalidData, error: InvalidCertificate(UnknownIssuer) }) url=https://use1-1.relay.iroh.network./
2024-05-01T02:51:57.719105Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: TCP stream connected server_addr=Ok(5.161.115.11:443) local_addr=172.25.105.202:45636
2024-05-01T02:51:57.719174Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: iroh_net::relay::http::client: Starting TLS handshake
2024-05-01T02:51:57.719267Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: No cached session for DnsName("use1-1.relay.iroh.network.")
2024-05-01T02:51:57.719667Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Not resuming any session
2024-05-01T02:51:57.741501Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
2024-05-01T02:51:57.741578Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: Not resuming
2024-05-01T02:51:57.742038Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::tls13: TLS1.3 encrypted extensions: [ServerNameAck]
2024-05-01T02:51:57.742095Z DEBUG magicsock{me=2oupdfbvwlxiykms}:relay-actor:client:connect: rustls::client::hs: ALPN protocol is None
2024-05-01T02:51:57.742540Z  WARN magicsock{me=2oupdfbvwlxiykms}:relay-actor:active-relay{url=https://use1-1.relay.iroh.network./}: iroh_net::magicsock::relay_actor: connection error: initial connection

Caused by:
    0: dial error
    1: invalid peer certificate: UnknownIssuer
2024-05-01T02:51:57.799274Z DEBUG discovery{me=2oupdfbvwlxiykms node=q22mj7s2phuhfgv5}: iroh_net::discovery: discovery: start
2024-05-01T02:51:57.799503Z DEBUG discovery{me=2oupdfbvwlxiykms node=q22mj7s2phuhfgv5}: hickory_proto::xfer::dns_handle: querying: _iroh.o44cj914x8w8fgi7wq5rgyks68jhi54qsw9ci5uwz1b3oz34ya8y.dns.iroh.link. TXT
2024-05-01T02:51:57.799584Z DEBUG discovery{me=2oupdfbvwlxiykms node=q22mj7s2phuhfgv5}: hickory_resolver::name_server::name_server_pool: sending request: [Query { name: Name("_iroh.o44cj914x8w8fgi7wq5rgyks68jhi54qsw9ci5uwz1b3oz34ya8y.dns.iroh.link."), query_type: TXT, query_class: IN }]
2024-05-01T02:51:57.799688Z DEBUG discovery{me=2oupdfbvwlxiykms node=q22mj7s2phuhfgv5}: hickory_resolver::name_server::name_server: existing connection: NameServerConfig { socket_addr: 10.24.9.11:53, protocol: Udp, tls_dns_name: None, trust_negative_responses: false, tls_config: None, bind_addr: None }
2024-05-01T02:51:57.799736Z DEBUG discovery{me=2oupdfbvwlxiykms node=q22mj7s2phuhfgv5}: hickory_proto::xfer: enqueueing message:QUERY:[Query { name: Name("_iroh.o44cj914x8w8fgi7wq5rgyks68jhi54qsw9ci5uwz1b3oz34ya8y.dns.iroh.link."), query_type: TXT, query_class: IN }]
2024-05-01T02:51:57.799799Z DEBUG discovery{me=2oupdfbvwlxiykms node=q22mj7s2phuhfgv5}: hickory_resolver::name_server::name_server: existing connection: NameServerConfig { socket_addr: 10.24.9.10:53, protocol: Udp, tls_dns_name: None, trust_negative_responses: false, tls_config: None, bind_addr: None }
2024-05-01T02:51:57.799847Z DEBUG discovery{me=2oupdfbvwlxiykms node=q22mj7s2phuhfgv5}: hickory_proto::xfer: enqueueing message:QUERY:[Query { name: Name("_iroh.o44cj914x8w8fgi7wq5rgyks68jhi54qsw9ci5uwz1b3oz34ya8y.dns.iroh.link."), query_type: TXT, query_class: IN }]
2024-05-01T02:51:57.800019Z DEBUG hickory_proto::udp::udp_client_stream: final message: ; header 39108:QUERY:RD:NoError:QUERY:0/0/0
; query
;; _iroh.o44cj914x8w8fgi7wq5rgyks68jhi54qsw9ci5uwz1b3oz34ya8y.dns.iroh.link. IN TXT

2024-05-01T02:51:57.800051Z DEBUG hickory_proto::udp::udp_client_stream: final message: ; header 2366:QUERY:RD:NoError:QUERY:0/0/0
; query
;; _iroh.o44cj914x8w8fgi7wq5rgyks68jhi54qsw9ci5uwz1b3oz34ya8y.dns.iroh.link. IN TXT

 

I'm running 6fbf4a9 on both sides of the doctor connection.

@flub
Copy link
Contributor

flub commented May 1, 2024

The server uses a Let's Encrypt TLS certificate. This error suggests your system's configuration does not trust Let's Encrypt certificates.

@eminence
Copy link
Author

eminence commented May 1, 2024

Good observation. When trying to debug further, I tried to curl https://euw1-1.relay.iroh.network./ which also showed certificate issues. But then a short time later, this started working, and I can't explain why. I'm assuming you didn't change anything on your infra. (iroh doctor is now working, too). So let me work on reproducing this again on my end

@eminence
Copy link
Author

eminence commented May 1, 2024

I caught it in the act of working then not working:

lxd@lin-lxd01sim in iroh on  main 🦀
❯ curl 'https://euw1-1.relay.iroh.network./'
<html><body>
<h1>RELAY</h1>
<p>
  This is an
  <a href="https://iroh.computer/">Iroh</a> Relay
  server.
</p>

# a few successful iroh-doctor invocations later...

lxd@lin-lxd01sim in iroh on  main 🦀
❯ curl 'https://euw1-1.relay.iroh.network./'
curl: (60) SSL certificate problem: unable to get local issuer certificate
More details here: https://curl.haxx.se/docs/sslcerts.html

curl failed to verify the legitimacy of the server and therefore could not
establish a secure connection to it. To learn more about this situation and
how to fix it, please visit the web page mentioned above.

@Arqu
Copy link
Collaborator

Arqu commented May 1, 2024

I'd assume it's related to https://letsencrypt.org/2024/04/12/changes-to-issuance-chains
Which will probably need updating root certs on a lot of peoples machines (similar to what happened in 2021 iirc).
yum check-update or equivalent might help here. Alternatively we might just need to wait out for the intermediates to settle down.

My best current guess is that depending on request you still get routed to different intermediates and the switch is not finished yet.

@eminence
Copy link
Author

eminence commented May 3, 2024

Ok, after a bunch more testing, I'm still very confused about what's happening, but I feel like the problem must be on my end somehow. Most of the time, things are working, but not 100% of the time.

I'm not sure what you can do about this, so probably the best thing to do is close this issue

@ramfox ramfox moved this to 📋 Backlog in iroh May 21, 2024
@b5
Copy link
Member

b5 commented Oct 7, 2024

Thanks for taking the time to report @eminence! I'm going to close this for now, but we can re-open should you need.

@b5 b5 closed this as completed Oct 7, 2024
@github-project-automation github-project-automation bot moved this from 📋 Backlog to ✅ Done in iroh Oct 7, 2024
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Projects
Archived in project
Development

No branches or pull requests

4 participants