dxos-deprecated / sdk

DXOS SDK and tools.
GNU Affero General Public License v3.0
0 stars 2 forks source link

Party invitation sometimes fails (pin code never shows up) #290

Open rzadp opened 3 years ago

rzadp commented 3 years ago

Migrated from https://github.com/dxos/teamwork/issues/345

dboreham commented 3 years ago

fwiw I re-tested today and could not reproduce now.

alexwykoff commented 3 years ago

I have found a reliable method to reproduce the error.

  1. Install Opera with VPN.
  2. Enable the VPN.
  3. Create a party with another browser.
  4. Generate an invite code on the other browser.
  5. Attempt to redeem the invite in Opera.

Expected Result: The invite should work.

Actual Result: The invite times out.

First Remediations - Observability:

rzadp commented 3 years ago

I was able to reproduce the pin never showing up with Opera+VPN as well.

alexwykoff commented 3 years ago

Further context for the Opera+VPN case: Invite created : http://sentry.kube.dxos.network:9000/organizations/sentry/issues/384/?project=2&query=is%3Aunresolved Invite failed: http://sentry.kube.dxos.network:9000/organizations/sentry/issues/402/?project=2&query=is%3Aunresolved

Inviter console context:

eyJzd2FybUtleSI6IjUxNGRkNTE2NzlmYTQxZDg3MDI1NmE4YzhjNDkwNTI4ZjhlNzBmNzQwYzI0OTYxM2FjYmI0OWM2NTU0ZjIzODgiLCJpbnZpdGF0aW9uIjoiNzRkNGIyZjdjMzcwNmI5YTE3MmVmY2FkNTllMjdiNjFiM2ZmYjVjYjY2MWI0NTgwMDAzYWEwN2RjMDE4Mzk2MyIsInR5cGUiOiIxIiwiaGFzaCI6IjRmOWQyMzkyZjMxN2I2MTFhMzUzYjlmMWEyODJjMDBiNTUyZDdhMGIifQ==
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] new peer Object +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] initial negotiation +29ms
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] _needsNegotiation +0ms
vendor~4134d62c.bundle.js:39599 discovery-swarm-webrtc createConnection +20s Object
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] starting batched negotiation +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] start negotiation +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] signalingStateChange have-local-offer +7ms
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] createOffer success +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] signal +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] iceStateChange (connection: new) (gathering: gathering) +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] started iceComplete timeout +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] iceStateChange (connection: new) (gathering: complete) +159ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] new peer Object +56ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] initial negotiation +2ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] _needsNegotiation +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] non-initiator initial negotiation request discarded +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] signal() +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] signalingStateChange have-remote-offer +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] flushing sender queue +1ms Array(0)
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] negotiated +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] signalingStateChange stable +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] signal +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] iceStateChange (connection: new) (gathering: gathering) +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] started iceComplete timeout +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] iceStateChange (connection: new) (gathering: complete) +181ms
vendor~4134d62c.bundle.js:39599 discovery-swarm-webrtc createConnection +532ms Object
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] destroying (error: connection duplicated: 478a3ce2c9053d2b002446edfb99c739ceb4d13ef394063a639040bd563bfe24 -> 0c6900caa32383335258301cbc2b176eb92bd58940857799550b16e57ffcffc0) +364ms
vendor~4134d62c.bundle.js:39599 simple-peer [97ff434] destroy (error: connection duplicated: 478a3ce2c9053d2b002446edfb99c739ceb4d13ef394063a639040bd563bfe24 -> 0c6900caa32383335258301cbc2b176eb92bd58940857799550b16e57ffcffc0) +1ms
vendor~4134d62c.bundle.js:39599 discovery-swarm-webrtc error +249ms ERR_CONNECTION_DUPLICATED: connection duplicated: 478a3ce2c9053d2b002446edfb99c739ceb4d13ef394063a639040bd563bfe24 -> 0c6900caa32383335258301cbc2b176eb92bd58940857799550b16e57ffcffc0
    at DiscoverySwarmWebrtc._createConnection (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:60658:17)
    at MMSTSignal.createConnection [as _createConnection] (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:60551:38)
    at MMSTSignal._runCreateConnection (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:133836:10)
    at MMSTSignal._onIncomingPeer (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:133817:40)
    at MMSTSignal.[socketsignal.onsignal] (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:74234:20)
    at Peer.onSignal (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:74193:49)
    at https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:47067:31
    at SignalBatch._onSignal (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:49332:51)
    at https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:49362:19
vendor~4134d62c.bundle.js:39599 dxos:network-manager:swarm Node 0c6900caa32383335258301cbc2b176eb92bd58940857799550b16e57ffcffc0 swarm error: ERR_CONNECTION_DUPLICATED: connection duplicated: 478a3ce2c9053d2b002446edfb99c739ceb4d13ef394063a639040bd563bfe24 -> 0c6900caa32383335258301cbc2b176eb92bd58940857799550b16e57ffcffc0 +20s
vendor~4134d62c.bundle.js:39599 discovery-swarm-webrtc error +12ms ERR_CONNECTION_DUPLICATED: connection duplicated: 478a3ce2c9053d2b002446edfb99c739ceb4d13ef394063a639040bd563bfe24 -> 0c6900caa32383335258301cbc2b176eb92bd58940857799550b16e57ffcffc0
    at DiscoverySwarmWebrtc._createConnection (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:60658:17)
    at MMSTSignal.createConnection [as _createConnection] (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:60551:38)
    at MMSTSignal._runCreateConnection (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:133836:10)
    at MMSTSignal._onIncomingPeer (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:133817:40)
    at MMSTSignal.[socketsignal.onsignal] (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:74234:20)
    at Peer.onSignal (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:74193:49)
    at https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:47067:31
    at SignalBatch._onSignal (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:49332:51)
    at https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:49362:19
vendor~4134d62c.bundle.js:39599 discovery-swarm-webrtc close +0ms Object
vendor~4134d62c.bundle.js:39599 dxos:network-manager:swarm Node 0c6900caa32383335258301cbc2b176eb92bd58940857799550b16e57ffcffc0 swarm connection closed. +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [80dde41] destroying (error: Timeout trying to establish a connection. SIGNALS: [{"type":"answer","sdp":"v=0\r\no=- 2642266727000490668 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0\r\na=msid-semantic: WMS\r\nm=application 9 UDP/DTLS/SCTP webrtc-datachannel\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:14Fx\r\na=ice-pwd:mcTgYIz/zy6VOqeSm/AE+bCd\r\na=ice-options:trickle\r\na=fingerprint:sha-256 2B:8A:70:9E:60:63:CD:60:63:9B:8F:DD:30:D2:39:17:E7:96:15:85:C7:01:FC:90:54:06:C7:6D:05:1F:6D:4D\r\na=setup:active\r\na=mid:0\r\na=sctp-port:5000\r\na=max-message-size:262144\r\n"},{"type":"candidate","candidate":{"candidate":"candidate:696122497 1 udp 2122260223 192.168.1.27 63083 typ host generation 0 ufrag 14Fx network-id 2","sdpMLineIndex":0,"sdpMid":"0"}},{"type":"candidate","candidate":{"candidate":"candidate:2622663921 1 udp 2122194687 192.168.1.177 63853 typ host generation 0 ufrag 14Fx network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"0"}},{"type":"candidate","candidate":{"candidate":"candidate:3748496725 1 udp 1686052607 76.184.135.136 63083 typ srflx raddr 192.168.1.27 rport 63083 generation 0 ufrag 14Fx network-id 2","sdpMLineIndex":0,"sdpMid":"0"}},{"type":"candidate","candidate":{"candidate":"candidate:488286789 1 udp 1685987071 76.184.135.136 63853 typ srflx raddr 192.168.1.177 rport 63853 generation 0 ufrag 14Fx network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"0"}},{"type":"candidate","candidate":{"candidate":"candidate:1744699505 1 tcp 1518280447 192.168.1.27 9 typ host tcptype active generation 0 ufrag 14Fx network-id 2","sdpMLineIndex":0,"sdpMid":"0"}},{"type":"candidate","candidate":{"candidate":"candidate:3536932865 1 tcp 1518214911 192.168.1.177 9 typ host tcptype active generation 0 ufrag 14Fx network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"0"}},{"type":"candidate","candidate":{"candidate":"candidate:2282240859 1 udp 41885439 165.22.40.75 50975 typ relay raddr 76.184.135.136 rport 63083 generation 0 ufrag 14Fx network-id 2","sdpMLineIndex":0,"sdpMid":"0"}},{"type":"candidate","candidate":{"candidate":"candidate:2282240859 1 udp 41819903 165.22.40.75 58437 typ relay raddr 76.184.135.136 rport 63853 generation 0 ufrag 14Fx network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"0"}}]) +14s

Invitee context:

dxos:network-manager Joined: 514dd51679fa41d870256a8c8c490528f8e70f740c249613acbb49c6554f2388 using swarm: 478a3ce2c9053d2b002446edfb99c739ceb4d13ef394063a639040bd563bfe24 +36s
vendor~4134d62c.bundle.js:39599 simple-websocket [53a0cf8] write before connect +2ms
vendor~4134d62c.bundle.js:39599 socket-signal:websocket-client url provider +36s wss://apollo1.kube.moon.dxos.network/dxos/signal
vendor~4134d62c.bundle.js:39599 simple-websocket [53a0cf8] sent chunk from "write before connect" +312ms
vendor~4134d62c.bundle.js:39599 simple-websocket [53a0cf8] connect +0ms
vendor~4134d62c.bundle.js:39599 discovery-swarm-webrtc:mmst-signal discover +36s {channel: Uint8Array(32)}
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] new peer {allowHalfOpen: false, wrtc: undefined, config: {…}, initiator: true} +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] initial negotiation +37ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] _needsNegotiation +0ms
vendor~4134d62c.bundle.js:39599 discovery-swarm-webrtc createConnection +429ms {info: {…}}
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] starting batched negotiation +2ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] start negotiation +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] signalingStateChange have-local-offer +7ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] createOffer success +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] signal +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] iceStateChange (connection: new) (gathering: gathering) +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] iceStateChange (connection: new) (gathering: complete) +101ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] new peer {allowHalfOpen: false, wrtc: undefined, config: {…}, initiator: false} +416ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] initial negotiation +2ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] _needsNegotiation +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] non-initiator initial negotiation request discarded +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] signal() +1ms
3vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] signal() +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] signal() +1ms
4vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] signal() +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] signalingStateChange have-remote-offer +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] flushing sender queue +4ms []
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] negotiated +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] signalingStateChange stable +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] signal +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] iceStateChange (connection: new) (gathering: gathering) +1ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] iceStateChange (connection: new) (gathering: complete) +100ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] signal() +108ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] signal() +1ms
2vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] signal() +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] signal() +1ms
4vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] signal() +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] flushing sender queue +1ms []
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] negotiated +0ms
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] signalingStateChange stable +0ms
vendor~4134d62c.bundle.js:39599 discovery-swarm-webrtc createConnection +839ms {info: {…}}
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] destroying (error: connection duplicated: 478a3ce2c9053d2b002446edfb99c739ceb4d13ef394063a639040bd563bfe24 -> 0c6900caa32383335258301cbc2b176eb92bd58940857799550b16e57ffcffc0) +96ms
vendor~4134d62c.bundle.js:39599 simple-peer [b97e95a] destroy (error: connection duplicated: 478a3ce2c9053d2b002446edfb99c739ceb4d13ef394063a639040bd563bfe24 -> 0c6900caa32383335258301cbc2b176eb92bd58940857799550b16e57ffcffc0) +1ms
vendor~4134d62c.bundle.js:39599 discovery-swarm-webrtc error +11ms ERR_CONNECTION_DUPLICATED: connection duplicated: 478a3ce2c9053d2b002446edfb99c739ceb4d13ef394063a639040bd563bfe24 -> 0c6900caa32383335258301cbc2b176eb92bd58940857799550b16e57ffcffc0
    at DiscoverySwarmWebrtc._createConnection (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:60658:17)
    at MMSTSignal.createConnection [as _createConnection] (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:60551:38)
    at MMSTSignal._runCreateConnection (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:133836:10)
    at MMSTSignal._onIncomingPeer (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~4134d62c.bundle.js:133817:40)
    at MMSTSignal.[socketsignal.onsignal] (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:74234:20)
    at Peer.onSignal (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:74193:49)
    at https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:47067:31
    at SignalBatch._onSignal (https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:49332:51)
    at https://apollo1.kube.moon.dxos.network/app/wrn%3A%2F%2Fdxos%2Fapplication%2Fteamwork%40alpha/vendor~402f6fec.bundle.js:49362:19
vendor~4134d62c.bundle.js:39599 dxos:network-manager:swarm Node 478a3ce2c9053d2b002446edfb99c739ceb4d13ef394063a639040bd563bfe24 swarm error: ERR_CONNECTION_DUPLICATED: connection duplicated: 478a3ce2c9053d2b002446edfb99c739ceb4d13ef394063a639040bd563bfe24 -> 0c6900caa32383335258301cbc2b176eb92bd58940857799550b16e57ffcffc0 +1s
vendor~4134d62c.bundle.js:39599 simple-peer [2248a39] destroying (error: Timeout trying to establish a connection. SIGNALS: [{"type":"offer","sdp":"v=0\r\no=- 7834714693211030260 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0\r\na=msid-semantic: WMS\r\nm=application 9 UDP/DTLS/SCTP webrtc-datachannel\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:zwHq\r\na=ice-pwd:nKyzlK7baSE93vrB/jpES9xl\r\na=ice-options:trickle\r\na=fingerprint:sha-256 BF:0A:5A:5A:A7:E8:94:3A:F5:63:5A:F5:B1:EB:F6:37:31:1C:AD:50:ED:38:EB:EA:51:D0:51:B3:1C:4B:D3:35\r\na=setup:actpass\r\na=mid:0\r\na=sctp-port:5000\r\na=max-message-size:262144\r\n"}]) +14s

Both console logs seem to indicate that a connection was duplicated. On the invitee side I do see that discovery-swarm-webrtc does call createConnection twice.