lightninglabs / lightning-node-connect Goto Github PK
View Code? Open in Web Editor NEWLicense: MIT License
lightning-node-connect's People
Contributors
![dependabot[bot] avatar](https://avatars.githubusercontent.com/in/29110?v=4 "dependabot[bot]")
Stargazers
Watchers
Forkers
getalby ellemouton quangvinh1305 jenward12003 deregs 22388o kaloudis bhandras icy-tywin baby636 jamaljsr rolledtomato 1crazymoney arealayer viktortigerstrom positiveblue qpc-github kukks starius bitromortaclightning-node-connect's Issues
Client disconnects shortly after connect
I've noticed that after establishing a TC connection from the browser, if you wait up to a minute the connection will drop with a StatusAbnormalClosure error. Once this happens, it's no longer possible to communicate with the LiT nodes. making RPC requests will just hang without returning a response. I've reproduced this with the example app in this repo as well as in the TW React app, using Chrome and Firefox. Below are the related logs.
Firefox (running WASM build from PR #5)
2021-10-14 12:19:23.528 [DBG] WASM: WASM client ready for connecting
Is WASM client ready? Result: true
2021-10-14 12:19:32.715 [DBG] MBOX: New client conn, read_stream=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be, write_stream=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
2021-10-14 12:19:32.716 [DBG] GRPC: [core] parsed scheme: ""
2021-10-14 12:19:32.717 [DBG] GRPC: [core] scheme "" not registered, fallback to default scheme
2021-10-14 12:19:32.718 [DBG] GRPC: [core] ccResolverWrapper: sending update to cc: {[{localhost:11110 <nil> 0 <nil>}] <nil> <nil>}
2021-10-14 12:19:32.718 [DBG] GRPC: [core] ClientConn switching balancer to "pick_first"
2021-10-14 12:19:32.719 [DBG] GRPC: [core] Channel switches to new LB policy "pick_first"
2021-10-14 12:19:32.720 [DBG] GRPC: [core] Subchannel Connectivity change to CONNECTING
2021-10-14 12:19:32.720 [DBG] WASM: WASM client connected to RPC
2021-10-14 12:19:32.721 [DBG] GRPC: [core] Subchannel picks a new address "localhost:11110" to connect
2021-10-14 12:19:32.723 [DBG] GRPC: [core] CPU time info is unavailable on non-linux or appengine environment.
2021-10-14 12:19:32.721 [DBG] GRPC: [core] pickfirstBalancer: UpdateSubConnState: 0x1a69930, {CONNECTING <nil>}
2021-10-14 12:19:32.726 [DBG] GRPC: [core] Channel Connectivity change to CONNECTING
2021-10-14 12:19:32.725 [TRC] MBOX: Starting client handshake
2021-10-14 12:19:32.748 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:19:32.775 [DBG] MBOX: Client: receive mailbox initialized
2021-10-14 12:19:32.780 [DBG] MBOX: Sent client hello with client_key=023b4890bef2978837579883dbe7e8e8c103aae5538b6072ee8bb98fccf15f2218
2021-10-14 12:19:32.787 [DBG] MBOX: Received server hello with server_key=0321891e43caaf90ea3ad52b0d3c502f30ffdccafb0f674ab03eded938f9fef1c4
2021-10-14 12:19:32.789 [TRC] MBOX: Client handshake completed
2021-10-14 12:19:32.792 [DBG] GRPC: [core] Subchannel Connectivity change to READY
2021-10-14 12:19:32.794 [DBG] GRPC: [core] pickfirstBalancer: UpdateSubConnState: 0x1a69930, {READY <nil>}
2021-10-14 12:19:32.795 [DBG] GRPC: [core] Channel Connectivity change to READY
Is WASM client connected? Result: true
2021-10-14 12:20:17.827 [DBG] MBOX: Client: got failure on receive socket, re-trying: failed to read: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:20:19.878 [DBG] MBOX: Client: receive mailbox initialized
2021-10-14 12:20:54.900 [DBG] GRPC: [core] Subchannel Connectivity change to CONNECTING
2021-10-14 12:20:54.901 [DBG] MBOX: Closing client connection
2021-10-14 12:20:54.904 [DBG] MBOX: Client: got failure on receive socket, re-trying: failed to read: context canceled
2021-10-14 12:20:54.902 [DBG] GRPC: [transport] transport: loopyWriter.run returning. connection error: desc = "transport is closing"
2021-10-14 12:20:54.902 [DBG] GRPC: [core] pickfirstBalancer: UpdateSubConnState: 0x1a69930, {CONNECTING <nil>}
2021-10-14 12:20:54.903 [DBG] GRPC: [core] Subchannel picks a new address "localhost:11110" to connect
2021-10-14 12:20:54.906 [DBG] MBOX: sending bye on receive socket
2021-10-14 12:20:54.907 [DBG] GRPC: [core] Channel Connectivity change to CONNECTING
2021-10-14 12:20:54.908 [TRC] MBOX: Starting client handshake
2021-10-14 12:20:54.909 [DBG] MBOX: sending bye on send socket
2021-10-14 12:21:05.795 [INF] WASM: Calling 'lnrpc.Lightning.GetInfo' on RPC with request {}
LiT node (running the mailbox-ui branch)
zane_1 | 2021-10-14 16:19:05.536 [INF] LITD: Handling gRPC web request: /litrpc.Sessions/AddSession
zane_1 | 2021-10-14 16:19:05.539 [INF] SESS: Mailbox RPC server listening on mailbox:dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be@aperture:11110
zane_1 | 2021-10-14 16:19:05.548 [INF] LITD: Handling gRPC web request: /litrpc.Sessions/ListSessions
zane_1 | 2021-10-14 16:20:34.919 [ERR] GRPC: [transport] transport: Got too many pings from the client, closing the connection.
zane_1 | 2021-10-14 16:20:34.920 [ERR] GRPC: [transport] transport: loopyWriter.run returning. Err: transport: Connection closing
zane_1 | 2021-10-14 16:20:34.920 [WRN] GRPC: [transport] transport: http2Server.HandleStreams failed to read frame: error receiving data msg: error reading from go-back-n: EOF
zane_1 | 2021-10-14 16:20:34.921 [WRN] GRPC: [core] grpc: Server.Serve failed to complete security handshake from "mailbox:dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf@aperture:11110": error receiving client hello: error reading from go-back-n: EOF
Aperture (running the mailbox branch commit b26a468)
aperture_1 | 2021-10-14 16:19:32.766 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:19:32.766 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:19:32.766 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:19:32.766 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:19:32.766 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:19:32.766 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:19:32.766 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:19:32.766 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:19:32.766 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:19:32.782 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.782 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:19:32.782 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.782 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.784 [TRC] PRXY: Req path [/hashmailrpc.HashMail/NewCipherBox] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:19:32.784 [TRC] PRXY: Req path [/hashmailrpc.HashMail/NewCipherBox] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:19:32.784 [DBG] PRXY: No backend service matched request [aperture:11110/hashmailrpc.HashMail/NewCipherBox].
aperture_1 | 2021-10-14 16:19:32.784 [DBG] PRXY: 172.18.0.19 Dispatching request /hashmailrpc.HashMail/NewCipherBox to local service.
aperture_1 | 2021-10-14 16:19:32.784 [DBG] APER: New HashMail stream init: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be, auth=&{}
aperture_1 | 2021-10-14 16:19:32.784 [DBG] APER: Creating new HashMail Stream: dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.784 [INF] PRXY: 172.18.0.19 - - "POST /hashmailrpc.HashMail/NewCipherBox HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:19:32.785 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:19:32.785 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:19:32.785 [DBG] PRXY: No backend service matched request [aperture:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:19:32.785 [DBG] PRXY: 172.18.0.19 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:19:32.785 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:19:32.785 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.785 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be): requesting write stream
aperture_1 | 2021-10-14 16:19:32.785 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.793 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/receive] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:19:32.793 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/receive] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:19:32.793 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/receive].
aperture_1 | 2021-10-14 16:19:32.793 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/receive to local service.
aperture_1 | 2021-10-14 16:19:32.806 [TRC] PRXY: Req path [/hashmailrpc.HashMail/RecvStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:19:32.806 [TRC] PRXY: Req path [/hashmailrpc.HashMail/RecvStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:19:32.806 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/RecvStream].
aperture_1 | 2021-10-14 16:19:32.806 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/RecvStream to local service.
aperture_1 | 2021-10-14 16:19:32.806 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be): requesting read stream
aperture_1 | 2021-10-14 16:19:32.806 [DBG] APER: New HashMail read stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.806 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.811 [TRC] APER: Sending msg_len=1 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.811 [TRC] APER: Read 1 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.811 [TRC] APER: Sending msg_len=37 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.811 [TRC] APER: Read 37 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.812 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.812 [TRC] APER: Sending msg_len=106 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.812 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.813 [TRC] APER: Read 106 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.813 [TRC] APER: Sending msg_len=39 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.813 [TRC] APER: Read 39 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.817 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.817 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.822 [TRC] APER: Sending msg_len=48 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.822 [TRC] APER: Read 48 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.822 [TRC] APER: Sending msg_len=33 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.822 [TRC] APER: Read 33 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.822 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.823 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.823 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.823 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.823 [TRC] APER: Sending msg_len=33 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.823 [TRC] APER: Read 33 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.823 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.823 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.825 [TRC] APER: Sending msg_len=33 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.825 [TRC] APER: Read 33 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.826 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.826 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:32.828 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:32.829 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:47.814 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:47.815 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:47.815 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:47.816 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:47.816 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:47.816 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:19:47.821 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:19:47.821 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:02.840 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:02.840 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:02.841 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:02.842 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:02.842 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:02.843 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:02.848 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:02.848 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:06.349 [TRC] APER: Sending msg_len=2 to stream_id=96fcf0f236a7b2e15c2b4941fd1457097fb1913dabc049f74e21602d6f9b1d1e4fa0b90862d0b48fa3752b813318fac2a60f8d8b8c64e0dbd285c7d356b0f503
aperture_1 | 2021-10-14 16:20:06.349 [TRC] APER: Read 2 bytes for HashMail stream_id=96fcf0f236a7b2e15c2b4941fd1457097fb1913dabc049f74e21602d6f9b1d1e4fa0b90862d0b48fa3752b813318fac2a60f8d8b8c64e0dbd285c7d356b0f503
aperture_1 | 2021-10-14 16:20:17.836 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:17.837 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:17.837 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:17.838 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:17.838 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:17.838 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:17.838 [ERR] APER: WS: error writing message: write tcp 172.18.0.17:11110->172.18.0.1:60962: i/o timeout
aperture_1 | 2021-10-14 16:20:17.839 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:20:17.839 [DBG] APER: Got error an read stream read: context canceled
aperture_1 | 2021-10-14 16:20:17.839 [DBG] APER: Returning read stream dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:17.839 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/RecvStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:20:17.839 [TRC] APER: WS: socket closed: read tcp 172.18.0.17:11110->172.18.0.1:60962: use of closed network connection
aperture_1 | 2021-10-14 16:20:17.839 [ERR] APER: WS: error closing upgraded conn: write tcp 172.18.0.17:11110->172.18.0.1:60962: i/o timeout
aperture_1 | 2021-10-14 16:20:17.839 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/receive?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
aperture_1 | 2021-10-14 16:20:18.839 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:18.841 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:18.842 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:18.842 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:19.871 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/receive] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:20:19.871 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/receive] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:20:19.871 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/receive].
aperture_1 | 2021-10-14 16:20:19.871 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/receive to local service.
aperture_1 | 2021-10-14 16:20:19.895 [TRC] PRXY: Req path [/hashmailrpc.HashMail/RecvStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:20:19.895 [TRC] PRXY: Req path [/hashmailrpc.HashMail/RecvStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:20:19.895 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/RecvStream].
aperture_1 | 2021-10-14 16:20:19.895 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/RecvStream to local service.
aperture_1 | 2021-10-14 16:20:19.895 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be): requesting read stream
aperture_1 | 2021-10-14 16:20:19.895 [DBG] APER: New HashMail read stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:19.895 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:19.895 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:19.899 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:19.899 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:20.850 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:20.851 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:20.852 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:20.852 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:22.855 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:22.855 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:22.856 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:22.856 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:24.865 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:24.865 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:24.866 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:24.867 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:26.875 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:26.875 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:26.877 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:26.877 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:28.884 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:28.884 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:28.885 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:28.885 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:30.893 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:30.894 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:30.895 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:30.895 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:32.900 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:32.900 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:32.902 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:32.902 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:34.909 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:34.909 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:34.910 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:34.910 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:34.919 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:34.919 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:34.920 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:34.920 [TRC] APER: Read 2 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:34.920 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:34.920 [TRC] APER: Read 41 bytes for HashMail stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:20:34.920 [DBG] APER: SendStream: Context done, exiting
aperture_1 | 2021-10-14 16:20:34.920 [INF] PRXY: 172.18.0.19 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:20:34.921 [DBG] APER: Got error an read stream read: context canceled
aperture_1 | 2021-10-14 16:20:34.921 [DBG] APER: Returning read stream dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:34.921 [INF] PRXY: 172.18.0.19 - - "POST /hashmailrpc.HashMail/RecvStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:20:34.921 [TRC] PRXY: Req path [/hashmailrpc.HashMail/NewCipherBox] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:20:34.921 [TRC] PRXY: Req path [/hashmailrpc.HashMail/NewCipherBox] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:20:34.922 [DBG] PRXY: No backend service matched request [aperture:11110/hashmailrpc.HashMail/NewCipherBox].
aperture_1 | 2021-10-14 16:20:34.922 [DBG] PRXY: 172.18.0.19 Dispatching request /hashmailrpc.HashMail/NewCipherBox to local service.
aperture_1 | 2021-10-14 16:20:34.923 [INF] PRXY: 172.18.0.19 - - "POST /hashmailrpc.HashMail/NewCipherBox HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:20:34.926 [TRC] APER: Sending msg_len=2 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:49.913 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:20:50.918 [TRC] APER: Sending msg_len=41 to stream_id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:21:06.316 [TRC] APER: Sending msg_len=2 to stream_id=96fcf0f236a7b2e15c2b4941fd1457097fb1913dabc049f74e21602d6f9b1d1e4fa0b90862d0b48fa3752b813318fac2a60f8d8b8c64e0dbd285c7d356b0f503
aperture_1 | 2021-10-14 16:21:06.316 [TRC] APER: Read 2 bytes for HashMail stream_id=96fcf0f236a7b2e15c2b4941fd1457097fb1913dabc049f74e21602d6f9b1d1e4fa0b90862d0b48fa3752b813318fac2a60f8d8b8c64e0dbd285c7d356b0f503
`WebAssembly.instantiateStreaming` fails in example file
I am trying to run the example in this repo with the example-server.go server but am seeing this error on page load:
LinkError: WebAssembly.instantiate(): Import #5 module="go" function="runtime.walltime1" error: function import requires a callable
The error happens at WebAssembly.instantiateStreaming here
https://github.com/lightninglabs/lightning-node-connect/blob/master/example/index.html#L80-L84
I'm think it could be because I changed the fetch() url there ^ to prefix it with http://localhost:3000/. Without that, it tries to fetch from the file system file:///{...}/lightning/lightning-node-connect/example/wasm-client.wasm which gets blocked by cors
specs
mac M1 - 12.3.1 Monteray
happens in all browsers
Fails to reconnect using pairing phrase
This issue somewhat piggy backs on #6. I'm not sure if solving that one will also resolve this, so I'm opening this issue in case it doesn't.
If the connection gets into the inoperable state described in #6, then I reload the page and attempt to connect again using the pairing phrase, the connection will fail. The workaround that I've been using is just to create a new pairing phrase. See logs below.
Firefox (running WASM build from PR #5)
2021-10-14 12:56:22.857 [DBG] WASM: WASM client ready for connecting
Is WASM client ready? Result: true
2021-10-14 12:56:27.949 [DBG] MBOX: New client conn, read_stream=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be, write_stream=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
2021-10-14 12:56:27.950 [DBG] GRPC: [core] parsed scheme: ""
2021-10-14 12:56:27.950 [DBG] GRPC: [core] scheme "" not registered, fallback to default scheme
2021-10-14 12:56:27.951 [DBG] GRPC: [core] ccResolverWrapper: sending update to cc: {[{localhost:11110 <nil> 0 <nil>}] <nil> <nil>}
2021-10-14 12:56:27.952 [DBG] GRPC: [core] ClientConn switching balancer to "pick_first"
2021-10-14 12:56:27.953 [DBG] GRPC: [core] Channel switches to new LB policy "pick_first"
2021-10-14 12:56:27.953 [DBG] GRPC: [core] Subchannel Connectivity change to CONNECTING
2021-10-14 12:56:27.955 [DBG] WASM: WASM client connected to RPC
2021-10-14 12:56:27.955 [DBG] GRPC: [core] Subchannel picks a new address "localhost:11110" to connect
2021-10-14 12:56:27.956 [DBG] GRPC: [core] CPU time info is unavailable on non-linux or appengine environment.
2021-10-14 12:56:27.955 [DBG] GRPC: [core] pickfirstBalancer: UpdateSubConnState: 0x19df950, {CONNECTING <nil>}
2021-10-14 12:56:27.959 [DBG] GRPC: [core] Channel Connectivity change to CONNECTING
2021-10-14 12:56:27.959 [TRC] MBOX: Starting client handshake
2021-10-14 12:56:27.996 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:56:28.024 [DBG] MBOX: Client: receive mailbox initialized
Is WASM client connected? Result: true
2021-10-14 12:56:32.004 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:56:34.033 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:56:38.039 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:56:40.072 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:56:44.079 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:56:46.113 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:56:50.123 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:56:52.157 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:56:56.166 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:56:58.199 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:57:02.203 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:57:04.236 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:57:08.241 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:57:10.274 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:57:14.278 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:57:16.310 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:57:20.320 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:57:22.349 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:57:26.354 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:57:28.384 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:57:32.392 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:57:34.426 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:57:39.130 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:57:41.161 [DBG] MBOX: Client: Send mailbox created
2021-10-14 12:57:45.181 [DBG] MBOX: Client: got failure on send socket, re-trying: failed to write: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
2021-10-14 12:57:47.210 [DBG] MBOX: Client: Send mailbox created
Aperture (running the mailbox branch commit b26a468)
aperture_1 | 2021-10-14 16:56:28.007 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:28.007 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:28.007 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:56:28.008 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:56:28.009 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:28.009 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:28.009 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:56:28.009 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:56:28.010 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:56:28.027 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:56:28.027 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:56:28.028 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:56:28.038 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/receive] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:28.038 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/receive] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:28.038 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/receive].
aperture_1 | 2021-10-14 16:56:28.038 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/receive to local service.
aperture_1 | 2021-10-14 16:56:28.053 [TRC] PRXY: Req path [/hashmailrpc.HashMail/RecvStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:28.054 [TRC] PRXY: Req path [/hashmailrpc.HashMail/RecvStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:28.054 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/RecvStream].
aperture_1 | 2021-10-14 16:56:28.054 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/RecvStream to local service.
aperture_1 | 2021-10-14 16:56:28.054 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be): requesting read stream
aperture_1 | 2021-10-14 16:56:28.054 [DBG] APER: New HashMail read stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227be
aperture_1 | 2021-10-14 16:56:30.032 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:56:30.033 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/send?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
aperture_1 | 2021-10-14 16:56:34.053 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:34.053 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:34.053 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:56:34.053 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:56:34.054 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:34.054 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:34.054 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:56:34.054 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:56:34.055 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:56:34.073 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:56:34.073 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:56:34.073 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:56:36.039 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:56:36.040 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/send?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
aperture_1 | 2021-10-14 16:56:40.065 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:40.065 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:40.065 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:56:40.066 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:56:40.066 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:40.066 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:40.066 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:56:40.067 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:56:40.067 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:56:40.080 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:56:40.080 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:56:40.081 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:56:42.089 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:56:42.090 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/send?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
aperture_1 | 2021-10-14 16:56:46.112 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:46.112 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:46.112 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:56:46.112 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:56:46.112 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:46.113 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:46.113 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:56:46.113 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:56:46.113 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:56:46.129 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:56:46.129 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:56:46.129 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:56:48.137 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:56:48.137 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/send?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
aperture_1 | 2021-10-14 16:56:52.160 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:52.160 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:52.160 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:56:52.160 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:56:52.161 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:52.161 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:52.161 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:56:52.162 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:56:52.162 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:56:52.180 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:56:52.180 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:56:52.180 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:56:54.187 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:56:54.187 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/send?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
aperture_1 | 2021-10-14 16:56:58.212 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:58.212 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:58.212 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:56:58.212 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:56:58.214 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:56:58.214 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:56:58.214 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:56:58.214 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:56:58.214 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:56:58.229 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:56:58.229 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:56:58.229 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:57:00.235 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:57:00.235 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/send?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
aperture_1 | 2021-10-14 16:57:04.222 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:57:04.222 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:57:04.222 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:57:04.222 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:57:04.223 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:57:04.223 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:57:04.223 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:57:04.223 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:57:04.223 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:57:04.238 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:57:04.238 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:57:04.238 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:57:06.244 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:57:06.244 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/send?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
aperture_1 | 2021-10-14 16:57:06.304 [TRC] APER: Sending msg_len=2 to stream_id=96fcf0f236a7b2e15c2b4941fd1457097fb1913dabc049f74e21602d6f9b1d1e4fa0b90862d0b48fa3752b813318fac2a60f8d8b8c64e0dbd285c7d356b0f503
aperture_1 | 2021-10-14 16:57:06.304 [TRC] APER: Read 2 bytes for HashMail stream_id=96fcf0f236a7b2e15c2b4941fd1457097fb1913dabc049f74e21602d6f9b1d1e4fa0b90862d0b48fa3752b813318fac2a60f8d8b8c64e0dbd285c7d356b0f503
aperture_1 | 2021-10-14 16:57:10.266 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:57:10.266 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:57:10.266 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:57:10.266 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:57:10.267 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:57:10.267 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:57:10.267 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:57:10.267 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:57:10.267 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:57:10.283 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:57:10.283 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:57:10.283 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:57:12.289 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:57:12.290 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/send?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
aperture_1 | 2021-10-14 16:57:16.309 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:57:16.309 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:57:16.309 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:57:16.309 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:57:16.311 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:57:16.311 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:57:16.311 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:57:16.311 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:57:16.311 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:57:16.326 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:57:16.326 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:57:16.326 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:57:18.336 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:57:18.337 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/send?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
aperture_1 | 2021-10-14 16:57:22.357 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:57:22.357 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:57:22.357 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:57:22.357 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:57:22.358 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:57:22.358 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:57:22.358 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:57:22.358 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:57:22.358 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:57:22.373 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:57:22.373 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:57:22.373 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:57:24.377 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:57:24.377 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/send?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
aperture_1 | 2021-10-14 16:57:28.398 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:57:28.398 [TRC] PRXY: Req path [/v1/terminal-connect/hashmail/send] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:57:28.398 [DBG] PRXY: No backend service matched request [localhost:11110/v1/terminal-connect/hashmail/send].
aperture_1 | 2021-10-14 16:57:28.398 [DBG] PRXY: 172.18.0.1 Dispatching request /v1/terminal-connect/hashmail/send to local service.
aperture_1 | 2021-10-14 16:57:28.399 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/looprpc.*$].
aperture_1 | 2021-10-14 16:57:28.399 [TRC] PRXY: Req path [/hashmailrpc.HashMail/SendStream] doesn't match [^/poolrpc.*$].
aperture_1 | 2021-10-14 16:57:28.399 [DBG] PRXY: No backend service matched request [0.0.0.0:11110/hashmailrpc.HashMail/SendStream].
aperture_1 | 2021-10-14 16:57:28.400 [DBG] PRXY: 127.0.0.1 Dispatching request /hashmailrpc.HashMail/SendStream to local service.
aperture_1 | 2021-10-14 16:57:28.400 [DBG] APER: New HashMail write stream pending...
aperture_1 | 2021-10-14 16:57:28.415 [DBG] APER: New HashMail write stream: id=dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf
aperture_1 | 2021-10-14 16:57:28.415 [TRC] APER: HashMailStream(dbd2615e8095168624cf407ef3724a18bcaed5514736aac79280634bc258c7b3bf4adc19ed323b0f1dc0e608ac55666f0caf07d40c62475777c84763b55227bf): requesting write stream
aperture_1 | 2021-10-14 16:57:28.415 [INF] PRXY: 127.0.0.1 - - "POST /hashmailrpc.HashMail/SendStream HTTP/2.0" "" "grpc-go/1.39.0"
aperture_1 | 2021-10-14 16:57:30.423 [DBG] APER: WS: ping loop done
aperture_1 | 2021-10-14 16:57:30.423 [INF] PRXY: 172.18.0.1 - - "GET /v1/terminal-connect/hashmail/send?method=POST HTTP/1.1" "" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:91.0) Gecko/20100101 Firefox/91.0"
Unable to connect.
Having an issue connecting to my LND Node via LNC. Getting an error that says "session not found failed to connect to the WASM client try reloading the page or
Obtaining a new phrase"
Any idea how to troubleshoot/fix this?
[Bug] Connection on Mobile Browser Failing
User reports attempting to connect via LNC on a mobile browser. Clean, new pairing phrase. Consistently does not work. Slack chat: https://lightningcommunity.slack.com/archives/C01A2MGARV0/p1698035238721209
Logs:
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.533 [DBG] GRPC: [core] [Channel #1] Channel created
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.539 [DBG] GRPC: [core] [Channel #1] original dial target is: "mailbox.terminal.lightning.today:443"
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.546 [DBG] GRPC: [core] [Channel #1] parsed dial target is: {Scheme:mailbox.terminal.lightning.today Authority: URL:{Scheme:mailbox.terminal.lightning.today Opaque:443 User: Host: Path: RawPath: OmitHost:false ForceQuery:false RawQuery: Fragment: RawFragment:}}
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.550 [DBG] GRPC: [core] [Channel #1] fallback to scheme "passthrough"
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.555 [DBG] GRPC: [core] [Channel #1] parsed dial target is: {Scheme:passthrough Authority: URL:{Scheme:passthrough Opaque: User: Host: Path:/mailbox.terminal.lightning.today:443 RawPath: OmitHost:false ForceQuery:false RawQuery: Fragment: RawFragment:}}
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.560 [DBG] GRPC: [core] [Channel #1] Channel authority set to "lnd"
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.575 [DBG] GRPC: [core] [Channel #1] Resolver state updated: {
"Addresses": [
{
"Addr": "mailbox.terminal.lightning.today:443",
"ServerName": "",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}
],
"ServiceConfig": null,
"Attributes": null
} (resolver returned new addresses)
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.583 [DBG] GRPC: [core] [Channel #1] Channel switches to new LB policy "pick_first"
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.588 [DBG] GRPC: [core] [Channel #1 SubChannel #2] Subchannel created
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.593 [DBG] GRPC: [core] [Channel #1] Channel Connectivity change to CONNECTING
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.600 [DBG] GRPC: [core] [Channel #1 SubChannel #2] Subchannel Connectivity change to CONNECTING
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.604 [DBG] GRPC: [core] [Channel #1 SubChannel #2] Subchannel picks a new address "mailbox.terminal.lightning.today:443" to connect
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.613 [DBG] MBOX: Client: Dialing...
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.610 [DBG] GRPC: [core] pickfirstBalancer: UpdateSubConnState: 0x1c0ae70, {CONNECTING <nil>}
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.623 [DBG] MBOX: New client conn, read_stream=ca177815664cfd499c4f7dacf15d7efb24d76efedd6571ffb99ad5c961a32df6de94fbb2c60b45fa7cc2bb9a9a7b1c5aec8df15996d1d2d9ccf2eff68bbd9fd0, write_stream=ca177815664cfd499c4f7dacf15d7efb24d76efedd6571ffb99ad5c961a32df6de94fbb2c60b45fa7cc2bb9a9a7b1c5aec8df15996d1d2d9ccf2eff68bbd9fd1
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:16.631 [DBG] MBOX: Client: Attempting to create send socket/stream
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:21.656 [DBG] MBOX: Client: Connected to send socket/stream
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:26.705 [DBG] MBOX: Client: receive mailbox initialized
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:26.836 [DBG] MBOX: Starting client handshake
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:38.412 [DBG] GRPC: [transport] newClientTransport: aborting due to connectCtx: context deadline exceeded
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:38.495 [DBG] MBOX: Closing client connection
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:38.493 [DBG] MBOX: Kicking off client handshake with client_key=03a0932dbaadf0ae52ec231582aa3cead13c7964d10c78ffb8ae489c444b9ca9fb
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:38.513 [DBG] MBOX: Client: got failure on receive socket/stream, re-trying: failed to read: context canceled
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:38.539 [DBG] MBOX: closing receive stream/socket
_app-57f2ed93e342eaf0.js:1 [Violation] 'message' handler took 11732ms
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:38.661 [DBG] MBOX: closing send stream/socket
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:38.769 [DBG] GRPC: [core] Creating new client transport to "{\n \"Addr\": \"mailbox.terminal.lightning.today:443\",\n \"ServerName\": \"lnd\",\n \"Attributes\": null,\n \"BalancerAttributes\": null,\n \"Type\": 0,\n \"Metadata\": null\n}": connection error: desc = "transport: authentication handshake failed: EOF"
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:38.774 [WRN] GRPC: [core] [Channel #1 SubChannel #2] grpc: addrConn.createTransport failed to connect to {
"Addr": "mailbox.terminal.lightning.today:443",
"ServerName": "lnd",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: EOF"
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:38.778 [DBG] GRPC: [core] [Channel #1 SubChannel #2] Subchannel Connectivity change to TRANSIENT_FAILURE
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:38.784 [DBG] GRPC: [core] pickfirstBalancer: UpdateSubConnState: 0x1c0ae70, {TRANSIENT_FAILURE connection error: desc = "transport: authentication handshake failed: EOF"}
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:38.788 [DBG] GRPC: [core] [Channel #1] Channel Connectivity change to TRANSIENT_FAILURE
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.790 [DBG] GRPC: [core] [Channel #1 SubChannel #2] Subchannel Connectivity change to IDLE
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.795 [DBG] GRPC: [core] pickfirstBalancer: UpdateSubConnState: 0x1c0ae70, {IDLE connection error: desc = "transport: authentication handshake failed: EOF"}
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.803 [DBG] GRPC: [core] [Channel #1] Channel Connectivity change to IDLE
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.810 [DBG] GRPC: [core] [Channel #1 SubChannel #2] Subchannel Connectivity change to CONNECTING
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.818 [DBG] GRPC: [core] [Channel #1 SubChannel #2] Subchannel picks a new address "mailbox.terminal.lightning.today:443" to connect
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.823 [DBG] MBOX: Dial: have existing mailbox connection, waiting
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.822 [DBG] GRPC: [core] pickfirstBalancer: UpdateSubConnState: 0x1c0ae70, {CONNECTING <nil>}
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.833 [DBG] GRPC: [core] [Channel #1] Channel Connectivity change to CONNECTING
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.831 [DBG] MBOX: Dial: done with existing conn
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.842 [DBG] MBOX: Client: Dialing...
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.846 [DBG] MBOX: Refreshing client conn, read_stream=ca177815664cfd499c4f7dacf15d7efb24d76efedd6571ffb99ad5c961a32df6de94fbb2c60b45fa7cc2bb9a9a7b1c5aec8df15996d1d2d9ccf2eff68bbd9fd0, write_stream=ca177815664cfd499c4f7dacf15d7efb24d76efedd6571ffb99ad5c961a32df6de94fbb2c60b45fa7cc2bb9a9a7b1c5aec8df15996d1d2d9ccf2eff68bbd9fd1
_app-57f2ed93e342eaf0.js:1 2023-10-23 11:00:39.852 [DBG] MBOX: Client: Attempting to create send socket/stream```
crypto: implement encryption/decryption with safe nonce
As can be seen in the following places, the nonce for the encryption is currently hard coded:
- https://github.com/lightninglabs/terminal-connect/blob/master/mailbox/crypto.go#L22
- https://github.com/lightninglabs/terminal-connect/blob/master/mailbox/crypto.go#L140
- https://github.com/lightninglabs/terminal-connect/blob/master/mailbox/crypto.go#L147
We'll need to make sure we use a secure noise like protocol instead.
Generalization of the protocol?
This idea was already considered by others but with one more important feature: being universal for various node applications (electrum server, bitcoind...), not just LND. Here's some discussion BlockchainCommons/Gordian-Developer-Community#33 sadly, that one received little feedback.
I still wonder if we could make this universal because I don't want to require users of my repository to pair every single application manually. It'd be much better to pair once and then just use all apps within same device.
Note that I intend to do something universal anyway - the value of it is just too high. I'm mainly seeking collaboration hoping that together we could do something better than everyone doing their own.
itests: expand end to end test suite to include node.js process with a wasm connection
We should extend our test suite to also cover the browser portion. We leanred earlier this week that Go will actually change the wasm_exec.js from time to time. To increase confidence in the changes we make, we should also extend the test suite to exercise the browser portion of the system.
Steps To Completion
- Within the integration tests, spin a simple
node.jsprocess (or some headless browser system) that's loaded with the sample WASM client. - In addition to the Go client, use the above client within the integration tests (by Go version) to exercise full end to end behavior.
LiT integration: bake and use super macaroon
Depends on lightninglabs/lightning-terminal#278.
Currently LiT uses the UI password in the authData payload of the noise handshake because there is no single macaroon that can be used for all calls (to lnd/loop/pool/faraday).
With the possibility of baking and verifying a super macaroon in LiT we can instead use that super macaroon directly instead of the UI password that gets converted into the correct daemon specific macaroon on the LiT proxy side.
New tag for LNC
LNC needs to be upgraded to get everything ready for 0.15, but we have dependencies on the integration of the NPM package into Terminal.
Cannot reconnect after disconnect
After connecting to a session, then disconnecting using wasmClientDisconnect, you must reload the web page in order to connect again. If I call wasmClientConnectServer without reloading the page, nothing happens.
This was feedback we got from the Alby team in their testing of lnc-web.
build: investigate shrinking WASM blob size using tiny-go
Was brought up in this twitter thread: https://twitter.com/roasbeef/status/1486422025816064000
TinyGo is an alternate Go compiler that is intended for embedded systems, and support compiling to a WASM target: https://tinygo.org/docs/reference/usage/subcommands/#build.
Their overview page demonstrators shrinking a binary size by 99% just by instead compiling using the Tiny Go compiler. Certain Go language features aren't fully supported, so we may need to add some additional build tag layers to make it possible. So far, someone has identified that we'll need to build tag out the pprof import at the very least.
Expose the RPC litrpc.Proxy.GetInfo via LNC wasm
In Terminal Web, we'd like to get able to get the version of litd that the WASM is connected to. This information is available via the litrpc.Proxy.GetInfo. Unfortunately, when I attempt to call this RPC using make example-server, no response is returned. The WASM doesn't even log that the method is called in the browser console.
I have tried to fix this by adding litrpc.RegisterProxyJSONCallbacks to jsoncallbacks.go but this results in the error
rpc error: code = Unimplemented desc = unknown service /litrpc.Proxy/GetInfo
It looks like this sub-server is being blocked by litd in rpc_proxy.go. I'm not sure what code need to change to unblock just this GetInfo RPC.
WebSocket closed: unclean connection close: status = StatusAbnormalClosure
The following error shows up very consistently when the mailbox client is used from within the browser:
It is also only ever the receive socket that has this issue.
[Error] WebSocket connection to 'wss://mailbox.terminal.lightning.today/v1/lightning-node-connect/hashmail/receive?method=POST' failed: The operation couldn’t be completed. Socket is not connected
[DBG] MBOX: Client: got failure on receive socket, re-trying: failed to read: WebSocket closed: unclean connection close: status = StatusAbnormalClosure and reason = ""
The connection logic always ensures that we recover from this error but it would be nice to figure out what is causing this. Could send more data a lot faster if gbn didnt need to reconnect each time after running into this error.
Lightning Node Connect does not work with wasmer
Lightning Node Connect does not work with wasmer (https://wasmer.io/). Here is the output from the standalone wasmer application.
root@44183a01694f:/# wasmer run lnc-v0.2.3-alpha.wasm
error: failed to run `lnc-v0.2.3-alpha.wasm`
╰─▶ 1: Error while importing "go"."debug": unknown import. Expected Function(FunctionType { params: [I32], results: [] })
root@44183a01694f:/#
I'm actually trying to use https://github.com/wasmerio/wasmer-python , and am getting the same error, but I show the error above using the standalone version of wasmer because it's the easiest to reproduce and I expect the same error happens no matter what language interface you are trying to use.
Given the number of programming languages wasmer supports, it seems like it would be ideal for Lightning Node Connect to work in wasmer because it avoids the need to re-implement Lightning Node Connect in every programming language. https://lightning.engineering/posts/2021-11-30-lightning-node-connect-deep-dive/ suggests that a bLIP is coming for Lightning Node Connect, but I have not seen it yet. The existing documentation found at https://docs.lightning.engineering/lightning-network-tools/lightning-terminal/lightning-node-connect , https://docs.lightning.engineering/lightning-network-tools/lightning-terminal/lnc-npm , and https://docs.lightning.engineering/lightning-network-tools/lightning-terminal/mailbox is high level and not in the form of a spec that I feel like I could re-implement it all natively in python. Although a spec would be nice, the next best thing would be some code that we can easily embed in any programming language.
we need a python module
Currently lightning node connect is written in go and compiled to web assembly for use in https://github.com/lightninglabs/lnc-web within a browser using javascript. Initially, I thought that maybe web assembly was the most universal way to use lightning node connect, so I tried to use web assembly from python with wasmer. In #70 I mention that I can't get it to work with wasmer.
Later, I learned that Zeus uses https://github.com/lightninglabs/lnc-rn which has the go code compiled to native binaries for mobile (lightninglabs/lnc-rn#23) and does not use web assembly.
Now, I'm wondering, would it be simpler to make a python module that uses natively compiled go code instead of using web assembly code within python? Here are some relevant resources
- https://github.com/go-python/gopy
- https://words.filippo.io/building-python-modules-with-go-1-5/
- https://github.com/ardanlabs/python-go/tree/master/grpc
With the new LND Accounts feature (lightninglabs/lightning-terminal#363 , https://docs.lightning.engineering/lightning-network-tools/lightning-terminal/accounts) that leverages Lightning Node Connect, it's critical that there are more ways to use Lightning Node Connect in a variety of code bases. The LND Accounts feature can safely and easily allow a wide variety of applications and machine to machine devices to use the lightning network.
noise layer: allow authData payload size to be dynamic
The initial implementation of the noise handshake (#13) set the authData payload size to a fixed length of 500 bytes. This will need to be larger in order to send over a "super macaroon" that contains the permissions for all daemons of LiT.
Unable to reconnect to node via LNC when network connection was down (e. g. airplane mode was on)
I found this one while using Zeus, described it also there (ZeusLN/zeus#1483), but it probably needs to be fixed on LNC side.
Problem
When connected to a node via LNC and the connection breaks during app usage, it cannot be recovered (when you bring network connection down/up while Zeus runs in background, LNC connection is not permanently broken - no idea what this is about...). Not even when restarting the app.
I already tried to debug this and found, that the connectServer() method of the LncModule does not return an error, but the isConnected() method returns false every time.
Reproduce (using Zeus)
- Connect to node via LNC (Lightning Node Connect)
- Bring network connection down, e. g. by enabling airplane mode
- Bring network connection up again
- Refresh balance
-> Error is shown after some time:
Error: rpc error: code = Unavailable desc = error reading from server: error decrypting payload: error receiving from go-back-n connection: cannot receive, gbn exited
- Click restart button
->Error is shown:
Failed to connect the LNC client to the proxy server
Detect expired session
A follow-up issue after implementing lightninglabs/lightning-terminal#300.
Currently there is no way for the client to distinguish between LiT not being online vs. a session having expired.
The client just tries to re-connect infinitely, even if a "mailbox does not exist" error is returned.
Perhaps we should start looking at the exact errors returned by the mailbox proxy and add a counter for some of them and abort after a certain number of retries. Then we could present the user with an error message, something like "server did not create mailbox; session not started or expired".
Connectivity problems after v0.1.6 update
After updating Terminal Web staging to use LNC v0.1.6, i've noticed that I was unable to connect to my testnet (running PR 315) & mainnet (v0.6.1) litd nodes any longer. Even after obtaining a new pairing phrase. The issue was resolved by restarting litd in both cases. Unfortunately, I dont have logs to share. I've been trying to reproduce the problem with no luck so far. I just wanted to make a note of the issue. My concern is that we deploy LNC v0.1.6 to prod, then all users need to obtain a new pairing phrase or restart litd in order to reconnect to Terminal Web.
itest: CI often fails with "predicate not satisfied after time out" error
Currently, the itest workflow for CI often errors with the following error:
Error: Received unexpected error: predicate not satisfied after time out
This usually has the following trace:
Error Trace:
/home/runner/work/lightning-node-connect/lightning-node-connect/itest/connection_test.go:178
/home/runner/work/lightning-node-connect/lightning-node-connect/itest/connection_test.go:116
/home/runner/work/lightning-node-connect/lightning-node-connect/itest/test_harness.go:144
/home/runner/work/lightning-node-connect/lightning-node-connect/itest/integration_test.go:43
This always ahppen for the same test, but not always with the same configuration. The test that fails is:
test_server_reconnect. Importantly, the error appears to only happen at random times, and doesn't always fail.
We have cases in the workflow history where the test has failed with all variants of the configurations:
(stagingMailbox:true,grpcClientConn:false)
(stagingMailbox:false,grpcClientConn:false)
(stagingMailbox:true,grpcClientConn:true)
Here is the log for 2 of the fails:
Case 1:
2023-11-13 17:56:33.632 [TRC] GOBN: Got expected data 7
2023-11-13 17:56:33.632 [TRC] GOBN: Got expected data 10
2023-11-13 17:56:33.632 [TRC] GOBN: Got expected data 11
2023-11-13 17:56:33.632 [TRC] GOBN: Received correct ack 7
2023-11-13 17:56:33.632 [TRC] GOBN: Got expected data 8
2023-11-13 17:56:33.632 [DBG] MBOX: conn being closed
2023-11-13 17:56:33.633 [DBG] MBOX: Server connection is closing
2023-11-13 17:56:33.633 [DBG] GOBN: Closing GoBackNConn, isServer=true
2023-11-13 17:56:33.633 [TRC] GOBN: Try sending FIN, isServer=true
2023-11-13 17:56:33.632 [TRC] GOBN: Sending data 12
2023-11-13 17:56:33.633 [DBG] APER: SendStream: Context done, exiting
2023-11-13 17:56:33.633 [DBG] GOBN: sendPacketsForever stopped (isServer=true)
2023-11-13 17:56:33.633 [TRC] GOBN: Received correct ack 8
2023-11-13 17:56:33.633 [DBG] APER: Got error an read stream read: context canceled
2023-11-13 17:56:33.633 [DBG] APER: Returning read stream
2023-11-13 17:56:33.633 [TRC] GOBN: Sending data 13
2023-11-13 17:56:33.633 [DBG] GOBN: receivePacketsForever stopped (isServer=true)
2023-11-13 17:56:33.633 [DBG] GOBN: GBN is closed, isServer=true
2023-11-13 17:56:33.633 [DBG] MBOX: closing receive stream
2023-11-13 17:56:33.633 [DBG] MBOX: closing send stream
2023-11-13 17:56:33.633 [DBG] MBOX: Server connection closed
2023-11-13 17:56:33.633 [TRC] GOBN: Received correct ack 10
2023-11-13 17:56:33.633 [TRC] GOBN: Received correct ack 11
2023-11-13 17:56:33.633 [TRC] GOBN: Received a FIN packet (isServer=false)
2023-11-13 17:56:33.633 [DBG] GOBN: Error in receivePacketsForever (isServer=false): gbn transport is closing
2023-11-13 17:56:33.633 [DBG] GOBN: receivePacketsForever stopped (isServer=false)
2023-11-13 17:56:33.633 [DBG] GOBN: Closing GoBackNConn, isServer=false
2023-11-13 17:56:33.633 [DBG] MBOX: Closing client connection
2023-11-13 17:56:33.633 [DBG] GOBN: sendPacketsForever stopped (isServer=false)
2023-11-13 17:56:33.633 [DBG] GOBN: GBN is closed, isServer=false
2023-11-13 17:56:33.633 [DBG] MBOX: closing receive stream/socket
2023-11-13 17:56:33.633 [DBG] APER: New HashMail stream deletion:
2023-11-13 17:56:33.633 [DBG] APER: Tearing down HashMail stream:
2023-11-13 17:56:33.633 [INF] APER: WS: incoming payload chan closed
2023-11-13 17:56:33.633 [DBG] MBOX: closing send stream/socket
2023-11-13 17:56:33.634 [DBG] APER: Got error an read stream read: context canceled
2023-11-13 17:56:33.634 [DBG] APER: Returning read stream
2023-11-13 17:56:33.634 [INF] APER: WS: incoming payload chan closed
2023-11-13 17:56:33.634 [DBG] APER: SendStream: Exiting write stream RPC stream read: rpc error: code = Canceled desc = context canceled
2023-11-13 17:56:33.634 [DBG] APER: New HashMail stream deletion:
2023-11-13 17:56:33.634 [DBG] APER: Tearing down HashMail stream:
Case 2:
2023-11-15 09:08:06.702 [TRC] GOBN: Received correct ack 8
2023-11-15 09:08:06.702 [TRC] GOBN: Received correct ack 9
2023-11-15 09:08:06.702 [TRC] GOBN: Got expected data 5
2023-11-15 09:08:06.703 [TRC] GOBN: Got expected data 6
2023-11-15 09:08:06.703 [DBG] MBOX: conn being closed
2023-11-15 09:08:06.703 [DBG] MBOX: Server connection is closing
2023-11-15 09:08:06.703 [DBG] GOBN: Closing GoBackNConn, isServer=true
2023-11-15 09:08:06.704 [TRC] GOBN: Try sending FIN, isServer=true
2023-11-15 09:08:06.704 [DBG] GOBN: sendPacketsForever stopped (isServer=true)
2023-11-15 09:08:06.703 [TRC] GOBN: Sending data 10
2023-11-15 09:08:06.704 [TRC] GOBN: Sending data 11
2023-11-15 09:08:06.704 [DBG] MBOX: Server: got failure on receive socket, re-trying: rpc error: code = Canceled desc = context canceled
2023-11-15 09:08:06.704 [DBG] GOBN: Error in receivePacketsForever (isServer=true): error receiving from recvFromStream: context canceled
2023-11-15 09:08:06.704 [DBG] GOBN: receivePacketsForever stopped (isServer=true)
2023-11-15 09:08:06.704 [DBG] GOBN: GBN is closed, isServer=true
2023-11-15 09:08:06.704 [DBG] MBOX: closing receive stream
2023-11-15 09:08:06.704 [DBG] MBOX: closing send stream
2023-11-15 09:08:06.704 [DBG] MBOX: Server connection closed
2023-11-15 09:08:06.789 [TRC] GOBN: Received a FIN packet (isServer=false)
2023-11-15 09:08:06.790 [DBG] GOBN: Error in receivePacketsForever (isServer=false): gbn transport is closing
2023-11-15 09:08:06.790 [DBG] GOBN: receivePacketsForever stopped (isServer=false)
2023-11-15 09:08:06.790 [DBG] GOBN: Closing GoBackNConn, isServer=false
2023-11-15 09:08:06.790 [DBG] GOBN: sendPacketsForever stopped (isServer=false)
2023-11-15 09:08:06.790 [DBG] GOBN: GBN is closed, isServer=false
2023-11-15 09:08:06.790 [DBG] MBOX: Closing client connection
2023-11-15 09:08:06.790 [DBG] MBOX: closing receive stream/socket
2023-11-15 09:08:06.873 [DBG] MBOX: closing send stream/socket
2023-11-15 09:08:06.873 [ERR] MBOX: Error closing send stream/socket: failed to close WebSocket: failed to read frame header: EOF
Recommend Projects
-
React
A declarative, efficient, and flexible JavaScript library for building user interfaces.
-
Vue.js
🖖 Vue.js is a progressive, incrementally-adoptable JavaScript framework for building UI on the web.
-
Typescript
TypeScript is a superset of JavaScript that compiles to clean JavaScript output.
-
TensorFlow
An Open Source Machine Learning Framework for Everyone
-
Django
The Web framework for perfectionists with deadlines.
-
Laravel
A PHP framework for web artisans
-
D3
Bring data to life with SVG, Canvas and HTML. 📊📈🎉
-
Recommend Topics
-
javascript
JavaScript (JS) is a lightweight interpreted programming language with first-class functions.
-
web
Some thing interesting about web. New door for the world.
-
server
A server is a program made to process requests and deliver data to clients.
-
Machine learning
Machine learning is a way of modeling and interpreting data that allows a piece of software to respond intelligently.
-
Visualization
Some thing interesting about visualization, use data art
-
Game
Some thing interesting about game, make everyone happy.
Recommend Org
-
Facebook
We are working to build community through open source technology. NB: members must have two-factor auth.
-
Microsoft
Open source projects and samples from Microsoft.
-
Google
Google ❤️ Open Source for everyone.
-
Alibaba
Alibaba Open Source for everyone
-
D3
Data-Driven Documents codes.
-
Tencent
China tencent open source team.