Closed jtn7 closed 4 years ago
hmm that error seems to happen when neko tries to send to a connection that has been closed, this might of been solved with the latest commit I made. But the changes I made aren't ready for a docker build. I'll check this out further once I'm done with my refactor.
I have the exact same issue, running on Ubuntu 18.04.
2020-01-19 16:15:36,768 DEBG 'neko' stdout output:
4:15PM INF Attempting to upgrade ws service=webrtc
2020-01-19 16:15:36,768 DEBG 'neko' stdout output:
4:15PM INF Created Session ID=ZMw6W5tIANo7taWozzinIkKxsFdqmFH6 RemoteAddr=x.x.x.x:46327 service=webrtc
2020-01-19 16:15:37,025 DEBG 'neko' stdout output:
4:15PM INF Reading from Websocket ID=ZMw6W5tIANo7taWozzinIkKxsFdqmFH6 Message="{\"event\":\"sdp/provide\",\"sdp\":\"v=0\\r\\no=- 8278890646181630039 2 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1 2\\r\\na=msid-semantic: WMS\\r\\nm=audio 50732 UDP/TLS/RTP/SAVPF 111 103 9 102 0 8 105 13 110 113 126\\r\\nc=IN IP4 0.0.0.0\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=candidate:842163049 1 udp 1677729535 x.x.x.x 50732 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\\r\\na=ice-ufrag:2uQg\\r\\na=ice-pwd:zQ6RI2tgHseQ7DSDHKg1aH+V\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 36:05:2D:0B:1F:1D:0D:F6:60:F2:B2:27:0D:A3:5D:7E:32:86:2B:FC:27:50:40:1E:FA:27:30:D6:A2:B5:C5:47\\r\\na=setup:actpass\\r\\na=mid:0\\r\\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\\r\\na=extmap:9 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=recvonly\\r\\na=rtcp-mux\\r\\na=rtpmap:111 opus/48000/2\\r\\na=rtcp-fb:111 transport-cc\\r\\na=fmtp:111 minptime=10;useinbandfec=1\\r\\na=rtpmap:103 ISAC/16000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:102 ILBC/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\nm=video 10032 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 125 104\\r\\nc=IN IP4 0.0.0.0\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=candidate:842163049 1 udp 1677729535 x.x.x.x 10032 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\\r\\na=ice-ufrag:2uQg\\r\\na=ice-pwd:zQ6RI2tgHseQ7DSDHKg1aH+V\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 36:05:2D:0B:1F:1D:0D:F6:60:F2:B2:27:0D:A3:5D:7E:32:86:2B:FC:27:50:40:1E:FA:27:30:D6:A2:B5:C5:47\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:2 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:4 urn:3gpp:video-orientation\\r\\na=extmap:5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:10 http://tools.ietf.org/html/draft-ietf-avtext-framemarking-07\\r\\na=extmap:9 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=recvonly\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 H264/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=fmtp:96 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640c1f\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 H264/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP8/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 red/90000\\r\\na=rtpmap:125 rtx/90000\\r\\na=fmtp:125 apt=127\\r\\na=rtpmap:104 ulpfec/90000\\r\\nm=application 13576 DTLS/SCTP 5000\\r\\nc=IN IP4 0.0.0.0\\na=candidate:842163049 1 udp 1677729535 x.x.x.x 13576 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\\r\\na=ice-ufrag:2uQg\\r\\na=ice-pwd:zQ6RI2tgHseQ7DSDHKg1aH+V\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 36:05:2D:0B:1F:1D:0D:F6:60:F2:B2:27:0D:A3:5D:7E:32:86:2B:FC:27:50:40:1E:FA:27:30:D6:A2:B5:C5:47\\r\\na=setup:actpass\\r\\na=mid:2\\r\\na=sctpmap:5000 webrtc-datachannel 1024\\r\\n\"}" service=webrtc
2020-01-19 16:15:47,060 DEBG 'neko' stdout output:
4:15PM INF Handle WS ending RemoteAddr=x.x.x.x:46327 service=webrtc
4:15PM ERR session.destroy has failed error="close tcp 172.17.0.2:8080->x.x.x.x:46327: use of closed network connection" service=webrtc
I'm having the same problem. Chrome won't connect and has this error and Firefox isn't working for me with #2 . At least Chrome was fully up to date on windows 10, the vm was a 4 core 4GB RAM on a workstation on my local network running Ubuntu 18.04.
seeing the same problem here running on a Ubuntu 18.04 VM in Vultr's cloud.
I've updated the docker image with some refactored code. I've added a ton more debugging to the client/server. Let me know if this is still an issue and post your logs.
Still unable to connect. Works fine on mobile Chrome but not on Chrome, Firefox, or Opera on PC.
Server:
neko_1 | 2020-01-23 20:03:12,534 DEBG 'neko' stdout output:
neko_1 | 8:03PM DBG attempting to upgrade connection module=websocket
neko_1 |
neko_1 | 2020-01-23 20:03:12,535 DEBG 'neko' stdout output:
neko_1 | 8:03PM DBG session created id=kzpfb9wIUA0Tga2hB_pbB_fVdapFlF6n module=webrtc
neko_1 | 8:03PM DBG session created id=kzpfb9wIUA0Tga2hB_pbB_fVdapFlF6n module=websocket
neko_1 | 8:03PM DBG new connection created address=172.18.0.2:40688 module=websocket session=kzpfb9wIUA0Tga2hB_pbB_fVdapFlF6n
neko_1 |
neko_1 | 2020-01-23 20:03:12,669 DEBG 'neko' stdout output:
neko_1 | 8:03PM DBG recieved message from client module=websocket raw="{\"event\":\"signal/provide\",\"sdp\":\"v=0\\r\\no=- 4307105451807281203 2 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=gro up:BUNDLE 0 1 2\\r\\na=msid-semantic: WMS\\r\\nm=audio 62104 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 136.55.151.6\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=candida te:833690215 1 udp 2113937151 57619794-843e-4526-a36a-a35944b9408f.local 62104 typ host generation 0 network-cost 999\\r\\na=candidate:1761563651 1 udp 2113939711 4521f2c4-0e0a-43b1-a083-8e39695 cfe8a.local 62105 typ host generation 0 network-cost 999\\r\\na=candidate:842163049 1 udp 1677729535 136.55.151.6 62104 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\\r\\na=ice-u frag:YR0C\\r\\na=ice-pwd:FZwigon3KNpOrWlw1JNEwFU3\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 41:7D:2E:E0:C6:70:9B:74:05:29:77:17:A6:FE:D5:CF:B6:FE:39:6E:4D:EF:20:D4:DD:C2:D2:B0:C6:6E: 54:8A\\r\\na=setup:actpass\\r\\na=mid:0\\r\\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:3 htt p://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=ex tmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=recvonly\\r\\na=rtcp-mux\\r\\na=rtpmap:111 opus/48000/2\\r\\na=rtcp-fb:111 transport-cc\\r\\na=fmtp:111 minptime=10;useinband fec=1\\r\\na=rtpmap:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/1600 0\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\nm=v ideo 62106 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 122 127 121 125 107 108 109 124 120 123 119 114 115 116\\r\\nc=IN IP4 136.55.151.6\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=candidate:833690215 1 udp 2113937151 57619794-843e-4526-a36a-a35944b9408f.local 62106 typ host generation 0 network-cost 999\\r\\na=candidate:1761563651 1 udp 2113939711 4521f2c4-0e0a-43b1-a083-8e39695cfe8a.local 621 07 typ host generation 0 network-cost 999\\r\\na=candidate:842163049 1 udp 1677729535 136.55.151.6 62106 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\\r\\na=ice-ufrag:YR0C\\r\\n a=ice-pwd:FZwigon3KNpOrWlw1JNEwFU3\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 41:7D:2E:E0:C6:70:9B:74:05:29:77:17:A6:FE:D5:CF:B6:FE:39:6E:4D:EF:20:D4:DD:C2:D2:B0:C6:6E:54:8A\\r\\na=se tup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientatio n\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:11 http://ww w.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://tools.ietf.org/html/draft-ietf-avtext-fram emarking-07\\r\\na=extmap:9 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-strea m-id\\r\\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=recvonly\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-f b:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-r emb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na =rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\ \na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:102 H264/90000\\r\\na=rtcp-fb:102 goog-remb\\r\\na=rtcp-fb:102 transport-cc\\r\\na=rtcp-fb:102 ccm fir\\r\\na=rtcp-fb:102 nack\\r\\ na=rtcp-fb:102 nack pli\\r\\na=fmtp:102 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:122 rtx/90000\\r\\na=fmtp:122 apt=102\\r\\na=rtpmap:127 H264/90000\\r \\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization- mode=0;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 cc m fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=1 25\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm fir\\r\\na=rtcp-fb:108 nack\\r\\na=rtcp-fb:108 nack pli\\r\\na=fmtp:108 level- asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f\\r\\na=rtpmap:109 rtx/90000\\r\\na=fmtp:109 apt=108\\r\\na=rtpmap:124 H264/90000\\r\\na=rtcp-fb:124 goog-remb\\r\\na=rtcp-fb:124 transport-cc\\r\\na=rtcp-fb:124 ccm fir\\r\\na=rtcp-fb:124 nack\\r\\na=rtcp-fb:124 nack pli\\r\\na=fmtp:124 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0032\\r\\na=rtpmap:1 20 rtx/90000\\r\\na=fmtp:120 apt=124\\r\\na=rtpmap:123 H264/90000\\r\\na=rtcp-fb:123 goog-remb\\r\\na=rtcp-fb:123 transport-cc\\r\\na=rtcp-fb:123 ccm fir\\r\\na=rtcp-fb:123 nack\\r\\na=rtcp-fb:1 23 nack pli\\r\\na=fmtp:123 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640032\\r\\na=rtpmap:119 rtx/90000\\r\\na=fmtp:119 apt=123\\r\\na=rtpmap:114 red/90000\\r\\na=rtpmap:115 rtx/90000\\r\\na=fmtp:115 apt=114\\r\\na=rtpmap:116 ulpfec/90000\\r\\nm=application 62108 UDP/DTLS/SCTP webrtc-datachannel\\r\\nc=IN IP4 136.55.151.6\\r\\na=candidate:833690215 1 udp 2113937151 57619794-843e-4526-a36a-a35944b9408f.local 62108 typ host generation 0 network-cost 999\\r\\na=candidate:1761563651 1 udp 2113939711 4521f2c4-0e0a-43b1-a083-8e39695cfe8a.local 62109 typ host generation 0 network-cost 999\\r\\na=candidate:842163049 1 udp 1677729535 136.55.151.6 62108 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\\r\\na=ice-ufrag:YR0C\\r\\na=ice-pwd:FZwigon3KNpOrWlw1JNEwFU3\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 41:7D:2E:E0:C6:70:9B:74:05:29:77:17:A6:FE:D5:CF:B6:FE:39:6E:4D:EF:20:D4:DD:C2:D2:B0:C6:6E:54:8A\\r\\na=setup:actpass\\r\\na=mid:2\\r\\na=sctp-port:5000\\r\\na=max-message-size:262144\\r\\n\"}" session=kzpfb9wIUA0Tga2hB_pbB_fVdapFlF6n
neko_1 |
neko_1 | 2020-01-23 20:03:12,693 DEBG 'neko' stdout output:
neko_1 | 8:03PM WRN could not get server reflexive address udp6 stun:stun.l.google.com:19302: write udp6 [::]:51515->[2607:f8b0:4002:c07::7f]:19302: sendto: cannot assign requested address
neko_1 | module=webrtc subsystem=ice
neko_1 |
neko_1 | 2020-01-23 20:03:12,694 DEBG 'neko' stdout output:
neko_1 | 8:03PM INF signaling state changed to have-remote-offer module=webrtc subsystem=pc
neko_1 |
neko_1 | 2020-01-23 20:03:12,696 DEBG 'neko' stdout output:
neko_1 | 8:03PM DBG Started agent: isControlling? false, remoteUfrag: "YR0C", remotePwd: "FZwigon3KNpOrWlw1JNEwFU3" module=webrtc subsystem=ice
neko_1 | 8:03PM INF signaling state changed to stable module=webrtc subsystem=pc
neko_1 | 8:03PM INF Setting new connection state: Checking module=webrtc subsystem=ice
neko_1 | 8:03PM INF ICE connection state changed: checking module=webrtc subsystem=pc
neko_1 |
neko_1 | 2020-01-23 20:03:17,369 DEBG 'neko' stdout output:
neko_1 | 8:03PM WRN read message error error="websocket: close 1005 (no status)" module=websocket
neko_1 |
neko_1 | 2020-01-23 20:03:17,370 DEBG 'neko' stdout output:
neko_1 | 8:03PM DBG handle socket ending address=172.18.0.2:40688 module=websocket
neko_1 | 8:03PM DBG session ended address=172.18.0.2:40688 module=websocket session=kzpfb9wIUA0Tga2hB_pbB_fVdapFlF6n
neko_1 | 8:03PM DBG session destroyed id=kzpfb9wIUA0Tga2hB_pbB_fVdapFlF6n module=webrtc
neko_1 | 8:03PM DBG session destroyed id=kzpfb9wIUA0Tga2hB_pbB_fVdapFlF6n module=websocket
neko_1 | 8:03PM DBG request complete (0) module=http req={"agent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/79.0.3945.117 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.18.0.2:40688","scheme":"http","uri":"http://neko.domain.com/ws?password=HelloWorld"} res={"bytes":0,"elapsed":4835.229235,"status":0,"time":"Thu, 23 Jan 2020 20:03:17 UTC"}
neko_1 |
neko_1 | 2020-01-23 20:03:22,696 DEBG 'neko' stdout output:
neko_1 | 8:03PM INF Setting new connection state: Failed module=webrtc subsystem=ice
neko_1 |
neko_1 | 2020-01-23 20:03:22,696 DEBG 'neko' stdout output:
neko_1 | 8:03PM INF ICE connection state changed: failed module=webrtc subsystem=pc
neko_1 | 8:03PM INF peer connection state changed: failed module=webrtc subsystem=pc
neko_1 | 8:03PM INF peer disconnected id=kzpfb9wIUA0Tga2hB_pbB_fVdapFlF6n module=webrtc
neko_1 |
Client:
[NEKO] DBG connecting to wss://neko.domain.com/ws?password=HelloWorld
neko.ts:24 [NEKO] DBG received websocket event identity/provide with payload: {id: "kzpfb9wIUA0Tga2hB_pbB_fVdapFlF6n"}
neko.ts:24 [NEKO] DBG creating peer
neko.ts:24 [NEKO] DBG sending event 'signal/provide' with payload v=0
o=- 4307105451807281203 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0 1 2
a=msid-semantic: WMS
m=audio 62104 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 136.55.151.6
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:833690215 1 udp 2113937151 57619794-843e-4526-a36a-a35944b9408f.local 62104 typ host generation 0 network-cost 999
a=candidate:1761563651 1 udp 2113939711 4521f2c4-0e0a-43b1-a083-8e39695cfe8a.local 62105 typ host generation 0 network-cost 999
a=candidate:842163049 1 udp 1677729535 136.55.151.6 62104 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999
a=ice-ufrag:YR0C
a=ice-pwd:FZwigon3KNpOrWlw1JNEwFU3
a=ice-options:trickle
a=fingerprint:sha-256 41:7D:2E:E0:C6:70:9B:74:05:29:77:17:A6:FE:D5:CF:B6:FE:39:6E:4D:EF:20:D4:DD:C2:D2:B0:C6:6E:54:8A
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
m=video 62106 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 122 127 121 125 107 108 109 124 120 123 119 114 115 116
c=IN IP4 136.55.151.6
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:833690215 1 udp 2113937151 57619794-843e-4526-a36a-a35944b9408f.local 62106 typ host generation 0 network-cost 999
a=candidate:1761563651 1 udp 2113939711 4521f2c4-0e0a-43b1-a083-8e39695cfe8a.local 62107 typ host generation 0 network-cost 999
a=candidate:842163049 1 udp 1677729535 136.55.151.6 62106 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999
a=ice-ufrag:YR0C
a=ice-pwd:FZwigon3KNpOrWlw1JNEwFU3
a=ice-options:trickle
a=fingerprint:sha-256 41:7D:2E:E0:C6:70:9B:74:05:29:77:17:A6:FE:D5:CF:B6:FE:39:6E:4D:EF:20:D4:DD:C2:D2:B0:C6:6E:54:8A
a=setup:actpass
a=mid:1
a=extmap:14 urn:ietf:params:rtp-hdrext:toffset
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:13 urn:3gpp:video-orientation
a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay
a=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type
a=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing
a=extmap:8 http://tools.ietf.org/html/draft-ietf-avtext-framemarking-07
a=extmap:9 http://www.webrtc.org/experiments/rtp-hdrext/color-space
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtcp-rsize
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 goog-remb
a=rtcp-fb:96 transport-cc
a=rtcp-fb:96 ccm fir
a=rtcp-fb:96 nack
a=rtcp-fb:96 nack pli
a=rtpmap:97 rtx/90000
a=fmtp:97 apt=96
a=rtpmap:98 VP9/90000
a=rtcp-fb:98 goog-remb
a=rtcp-fb:98 transport-cc
a=rtcp-fb:98 ccm fir
a=rtcp-fb:98 nack
a=rtcp-fb:98 nack pli
a=fmtp:98 profile-id=0
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=98
a=rtpmap:100 VP9/90000
a=rtcp-fb:100 goog-remb
a=rtcp-fb:100 transport-cc
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=fmtp:100 profile-id=2
a=rtpmap:101 rtx/90000
a=fmtp:101 apt=100
a=rtpmap:102 H264/90000
a=rtcp-fb:102 goog-remb
a=rtcp-fb:102 transport-cc
a=rtcp-fb:102 ccm fir
a=rtcp-fb:102 nack
a=rtcp-fb:102 nack pli
a=fmtp:102 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f
a=rtpmap:122 rtx/90000
a=fmtp:122 apt=102
a=rtpmap:127 H264/90000
a=rtcp-fb:127 goog-remb
a=rtcp-fb:127 transport-cc
a=rtcp-fb:127 ccm fir
a=rtcp-fb:127 nack
a=rtcp-fb:127 nack pli
a=fmtp:127 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f
a=rtpmap:121 rtx/90000
a=fmtp:121 apt=127
a=rtpmap:125 H264/90000
a=rtcp-fb:125 goog-remb
a=rtcp-fb:125 transport-cc
a=rtcp-fb:125 ccm fir
a=rtcp-fb:125 nack
a=rtcp-fb:125 nack pli
a=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
a=rtpmap:107 rtx/90000
a=fmtp:107 apt=125
a=rtpmap:108 H264/90000
a=rtcp-fb:108 goog-remb
a=rtcp-fb:108 transport-cc
a=rtcp-fb:108 ccm fir
a=rtcp-fb:108 nack
a=rtcp-fb:108 nack pli
a=fmtp:108 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f
a=rtpmap:109 rtx/90000
a=fmtp:109 apt=108
a=rtpmap:124 H264/90000
a=rtcp-fb:124 goog-remb
a=rtcp-fb:124 transport-cc
a=rtcp-fb:124 ccm fir
a=rtcp-fb:124 nack
a=rtcp-fb:124 nack pli
a=fmtp:124 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0032
a=rtpmap:120 rtx/90000
a=fmtp:120 apt=124
a=rtpmap:123 H264/90000
a=rtcp-fb:123 goog-remb
a=rtcp-fb:123 transport-cc
a=rtcp-fb:123 ccm fir
a=rtcp-fb:123 nack
a=rtcp-fb:123 nack pli
a=fmtp:123 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640032
a=rtpmap:119 rtx/90000
a=fmtp:119 apt=123
a=rtpmap:114 red/90000
a=rtpmap:115 rtx/90000
a=fmtp:115 apt=114
a=rtpmap:116 ulpfec/90000
m=application 62108 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 136.55.151.6
a=candidate:833690215 1 udp 2113937151 57619794-843e-4526-a36a-a35944b9408f.local 62108 typ host generation 0 network-cost 999
a=candidate:1761563651 1 udp 2113939711 4521f2c4-0e0a-43b1-a083-8e39695cfe8a.local 62109 typ host generation 0 network-cost 999
a=candidate:842163049 1 udp 1677729535 136.55.151.6 62108 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999
a=ice-ufrag:YR0C
a=ice-pwd:FZwigon3KNpOrWlw1JNEwFU3
a=ice-options:trickle
a=fingerprint:sha-256 41:7D:2E:E0:C6:70:9B:74:05:29:77:17:A6:FE:D5:CF:B6:FE:39:6E:4D:EF:20:D4:DD:C2:D2:B0:C6:6E:54:8A
a=setup:actpass
a=mid:2
a=sctp-port:5000
a=max-message-size:262144
neko.ts:24 [NEKO] DBG received websocket event signal/answer with payload: {sdp: "v=0
↵o=- 584825499 1579809792 IN IP4 0.0.0.0
↵s=-
…0 rport 38203 generation 0
↵a=end-of-candidates
↵"}
neko.ts:24 [NEKO] DBG peer connection state chagned: checking
neko.ts:24 [NEKO] DBG received audio track from peer: b7c9f34d-6ea5-480b-b72a-22e8683be48b RTCTrackEvent {isTrusted: true, receiver: RTCRtpReceiver, track: MediaStreamTrack, streams: Array(1), transceiver: RTCRtpTransceiver, …}
neko.ts:24 [NEKO] DBG received video track from peer: 7d0b44a5-56bc-4eb9-bc43-10fd2eefa8b7 RTCTrackEvent {isTrusted: true, receiver: RTCRtpReceiver, track: MediaStreamTrack, streams: Array(1), transceiver: RTCRtpTransceiver, …}
neko.ts:24 [NEKO] DBG connection timedout
neko.ts:24 [NEKO] DBG disconnected: Error: connection timeout
at b.onTimeout (base.ts:272)
neko.ts:24 [NEKO] DBG peer connection state chagned: disconnected
neko.ts:24 [NEKO] DBG disconnected: Error: peer disconnected
at RTCPeerConnection.socketOpen.peerConnected._peer.oniceconnectionstatechange (base.ts:175)
aaahhhh ok I know whats going on now, I can fix that
hey can you guy test something out, run the server with --network host
or -p 59000-65000:59000-65000/udp
flag, I think this issue is due to docker and UDP connections.
I'm getting this from the server when attempting to connect now (with or without --network host
)
5:44AM ERR message handler has failed error="signal/provide failed: remote peer does not support VP8" module=websocket
2020-01-25 05:44:40,901 DEBG 'neko' stdout output:
5:44AM WRN read message error error="websocket: close 1005 (no status)" module=websocket
Which is very strange because html5test.com says I do have VP8 support
If I use the -p option it overwhelms the docker service and it enters a bad state. I haven't tried with the network: host flag.
If I use the -p option it overwhelms the docker service and it enters a bad state. I haven't tried with the network: host flag.
This happens to me too. Would you be able to supply a more refined range of ports to try? @nurdism
With network: host it works fine but isn't ideal to my usage as I use Traefik.
It's also now no longer working on the localhost PC for me, where as it was before.
This is the console log:
neko.ts:24 [NEKO] DBG connecting to ws://localhost:8080/ws?password=neko
neko.ts:24 [NEKO] DBG received websocket event identity/provide with payload: Object
neko.ts:24 [NEKO] DBG creating peer
neko.ts:24 [NEKO] DBG sending event 'signal/provide' with payload v=0
o=- 2705739876783732000 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0 1 2
a=msid-semantic: WMS
m=audio 42976 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 70.76.228.21
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:35009170 1 udp 2113937151 b1ebfb9c-d1b2-4357-ae6d-a817c255d533.local 42976 typ host generation 0 network-cost 999
a=candidate:3637611453 1 udp 2113939711 f7cc7a34-1a52-4bfe-a12d-4085a94f7b67.local 44708 typ host generation 0 network-cost 999
a=candidate:842163049 1 udp 1677729535 70.76.228.21 42976 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999
a=ice-ufrag:YM8+
a=ice-pwd:kJaA8M2NzPHuvquLb6PB+nwh
a=ice-options:trickle
a=fingerprint:sha-256 B1:C0:2B:1D:CB:A7:98:05:3B:83:59:6E:E8:32:7D:14:86:3A:2D:AD:70:FD:A6:06:73:E2:50:C2:1B:05:53:9C
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
m=video 33221 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 122 127 121 125 107 108 109 124 120 123
c=IN IP4 70.76.228.21
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:35009170 1 udp 2113937151 b1ebfb9c-d1b2-4357-ae6d-a817c255d533.local 33221 typ host generation 0 network-cost 999
a=candidate:3637611453 1 udp 2113939711 f7cc7a34-1a52-4bfe-a12d-4085a94f7b67.local 55324 typ host generation 0 network-cost 999
a=candidate:842163049 1 udp 1677729535 70.76.228.21 33221 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999
a=ice-ufrag:YM8+
a=ice-pwd:kJaA8M2NzPHuvquLb6PB+nwh
a=ice-options:trickle
a=fingerprint:sha-256 B1:C0:2B:1D:CB:A7:98:05:3B:83:59:6E:E8:32:7D:14:86:3A:2D:AD:70:FD:A6:06:73:E2:50:C2:1B:05:53:9C
a=setup:actpass
a=mid:1
a=extmap:14 urn:ietf:params:rtp-hdrext:toffset
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:13 urn:3gpp:video-orientation
a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay
a=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type
a=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing
a=extmap:8 http://tools.ietf.org/html/draft-ietf-avtext-framemarking-07
a=extmap:9 http://www.webrtc.org/experiments/rtp-hdrext/color-space
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtcp-rsize
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 goog-remb
a=rtcp-fb:96 transport-cc
a=rtcp-fb:96 ccm fir
a=rtcp-fb:96 nack
a=rtcp-fb:96 nack pli
a=rtpmap:97 rtx/90000
a=fmtp:97 apt=96
a=rtpmap:98 VP9/90000
a=rtcp-fb:98 goog-remb
a=rtcp-fb:98 transport-cc
a=rtcp-fb:98 ccm fir
a=rtcp-fb:98 nack
a=rtcp-fb:98 nack pli
a=fmtp:98 profile-id=0
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=98
a=rtpmap:100 VP9/90000
a=rtcp-fb:100 goog-remb
a=rtcp-fb:100 transport-cc
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=fmtp:100 profile-id=2
a=rtpmap:101 rtx/90000
a=fmtp:101 apt=100
a=rtpmap:102 H264/90000
a=rtcp-fb:102 goog-remb
a=rtcp-fb:102 transport-cc
a=rtcp-fb:102 ccm fir
a=rtcp-fb:102 nack
a=rtcp-fb:102 nack pli
a=fmtp:102 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f
a=rtpmap:122 rtx/90000
a=fmtp:122 apt=102
a=rtpmap:127 H264/90000
a=rtcp-fb:127 goog-remb
a=rtcp-fb:127 transport-cc
a=rtcp-fb:127 ccm fir
a=rtcp-fb:127 nack
a=rtcp-fb:127 nack pli
a=fmtp:127 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f
a=rtpmap:121 rtx/90000
a=fmtp:121 apt=127
a=rtpmap:125 H264/90000
a=rtcp-fb:125 goog-remb
a=rtcp-fb:125 transport-cc
a=rtcp-fb:125 ccm fir
a=rtcp-fb:125 nack
a=rtcp-fb:125 nack pli
a=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
a=rtpmap:107 rtx/90000
a=fmtp:107 apt=125
a=rtpmap:108 H264/90000
a=rtcp-fb:108 goog-remb
a=rtcp-fb:108 transport-cc
a=rtcp-fb:108 ccm fir
a=rtcp-fb:108 nack
a=rtcp-fb:108 nack pli
a=fmtp:108 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f
a=rtpmap:109 rtx/90000
a=fmtp:109 apt=108
a=rtpmap:124 red/90000
a=rtpmap:120 rtx/90000
a=fmtp:120 apt=124
a=rtpmap:123 ulpfec/90000
m=application 59801 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 70.76.228.21
a=candidate:35009170 1 udp 2113937151 b1ebfb9c-d1b2-4357-ae6d-a817c255d533.local 59801 typ host generation 0 network-cost 999
a=candidate:3637611453 1 udp 2113939711 f7cc7a34-1a52-4bfe-a12d-4085a94f7b67.local 34346 typ host generation 0 network-cost 999
a=candidate:842163049 1 udp 1677729535 70.76.228.21 59801 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999
a=ice-ufrag:YM8+
a=ice-pwd:kJaA8M2NzPHuvquLb6PB+nwh
a=ice-options:trickle
a=fingerprint:sha-256 B1:C0:2B:1D:CB:A7:98:05:3B:83:59:6E:E8:32:7D:14:86:3A:2D:AD:70:FD:A6:06:73:E2:50:C2:1B:05:53:9C
a=setup:actpass
a=mid:2
a=sctp-port:5000
a=max-message-size:262144
neko.ts:24 [NEKO] DBG connection timedout
neko.ts:24 [NEKO] DBG disconnected: Error: connection timeout
at b.onTimeout (base.ts:272)
:8080/fonts/whitney-600.be0060da.woff:1 GET http://localhost:8080/fonts/whitney-600.be0060da.woff net::ERR_CONNECTION_RESET
I've updated the container with some more changes, try it with -p 59000-59100:59000-59100/udp
Server is segfaulting now when I attempt to connect
Server log:
steven@steven-UX305CA:~/docker-dev/neko/.docker$ sudo docker run --rm --name neko -p 59000-59100:59000-59100/udp -p 8080:8080 --shm-size=1gb neko-custom
Starting system message bus: dbus.
Starting supervisord
2020-01-26 00:54:43,623 CRIT could not write pidfile /supervisord.pid
2020-01-26 00:54:44,626 INFO spawned: 'xvfb' with pid 19
2020-01-26 00:54:44,631 INFO spawned: 'openbox' with pid 20
2020-01-26 00:54:44,635 INFO spawned: 'pulseaudio' with pid 21
2020-01-26 00:54:44,647 INFO spawned: 'firefox-esr' with pid 22
2020-01-26 00:54:44,652 INFO spawned: 'neko' with pid 23
2020-01-26 00:54:44,695 DEBG 'xvfb' stderr output:
_XSERVTransmkdir: Owner of /tmp/.X11-unix should be set to root
2020-01-26 00:54:44,718 DEBG 'pulseaudio' stderr output:
I: [pulseaudio] main.c: setrlimit(RLIMIT_NICE, (31, 31)) failed: Operation not permitted
I: [pulseaudio] main.c: setrlimit(RLIMIT_RTPRIO, (9, 9)) failed: Operation not permitted
D: [pulseaudio] core-rtclock.c: Timer slack is set to 50 us.
2020-01-26 00:54:44,848 DEBG 'pulseaudio' stderr output:
I: [pulseaudio] core-util.c: Failed to acquire high-priority scheduling: Input/output error
I: [pulseaudio] main.c: This is PulseAudio 10.0
D: [pulseaudio] main.c: Compilation host: x86_64-pc-linux-gnu
D: [pulseaudio] main.c: Compilation CFLAGS: -g -O2 -fdebug-prefix-map=/build/pulseaudio-ZMrhzG/pulseaudio-10.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wall -W -Wextra -pipe -Wno-long-long -Wno-overlength-strings -Wunsafe-loop-optimizations -Wundef -Wformat=2 -Wlogical-op -Wsign-compare -Wformat-security -Wmissing-include-dirs -Wformat-nonliteral -Wpointer-arith -Winit-self -Wdeclaration-after-statement -Wfloat-equal -Wmissing-prototypes -Wredundant-decls -Wmissing-declarations -Wmissing-noreturn -Wshadow -Wendif-labels -Wcast-align -Wstrict-aliasing -Wwrite-strings -Wno-unused-parameter -ffast-math -fno-common -fdiagnostics-show-option -fdiagnostics-color=auto
D: [pulseaudio] main.c: Running on host: Linux x86_64 4.4.0-171-generic #200-Ubuntu SMP Tue Dec 3 11:04:55 UTC 2019
D: [pulseaudio] main.c: Found 4 CPUs.
I: [pulseaudio] main.c: Page size is 4096 bytes
D: [pulseaudio] main.c: Compiled with Valgrind support: no
D: [pulseaudio] main.c: Running in valgrind mode: no
D: [pulseaudio] main.c: Running in VM: no
D: [pulseaudio] main.c: Optimized build: yes
D: [pulseaudio] main.c: FASTPATH defined, only fast path asserts disabled.
2020-01-26 00:54:44,849 DEBG 'pulseaudio' stderr output:
I: [pulseaudio] main.c: Machine ID is a5a85d161208265bec1c6fb020b29456.
I: [pulseaudio] main.c: Using runtime directory /home/neko/.config/pulse/a5a85d161208265bec1c6fb020b29456-runtime.
I: [pulseaudio] main.c: Using state directory /home/neko/.config/pulse.
I: [pulseaudio] main.c: Using modules directory /usr/lib/pulse-10.0/modules.
I: [pulseaudio] main.c: Running in system mode: no
I: [pulseaudio] main.c: System supports high resolution timers
D: [pulseaudio] memblock.c: Using shared memfd memory pool with 1024 slots of size 64.0 KiB each, total size is 64.0 MiB, maximum usable slot size is 65472
I: [pulseaudio] cpu-x86.c: CPU flags: CMOV MMX SSE SSE2 SSE3 SSSE3 SSE4_1 SSE4_2
I: [pulseaudio] svolume_mmx.c: Initialising MMX optimized volume functions.
I: [pulseaudio] remap_mmx.c: Initialising MMX optimized remappers.
I: [pulseaudio] svolume_sse.c: Initialising SSE2 optimized volume functions.
I: [pulseaudio] remap_sse.c: Initialising SSE2 optimized remappers.
I: [pulseaudio] sconv_sse.c: Initialising SSE2 optimized conversions.
I: [pulseaudio] svolume_orc.c: Initialising ORC optimized volume functions.
2020-01-26 00:54:44,854 DEBG 'pulseaudio' stderr output:
W: [pulseaudio] authkey.c: Failed to open cookie file '/home/neko/.config/pulse/cookie': No such file or directory
W: [pulseaudio] authkey.c: Failed to load authentication key '/home/neko/.config/pulse/cookie': No such file or directory
2020-01-26 00:54:44,855 DEBG 'pulseaudio' stderr output:
W: [pulseaudio] authkey.c: Failed to open cookie file '/home/neko/.pulse-cookie': No such file or directory
W: [pulseaudio] authkey.c: Failed to load authentication key '/home/neko/.pulse-cookie': No such file or directory
D: [pulseaudio] authkey.c: Got 0 bytes from cookie file '/home/neko/.config/pulse/cookie', expected 256
2020-01-26 00:54:44,855 DEBG 'pulseaudio' stderr output:
I: [pulseaudio] module.c: Loaded "module-native-protocol-unix" (index: #0; argument: "socket=/tmp/pulseaudio.socket auth-anonymous=1").
2020-01-26 00:54:44,855 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] module-always-sink.c: Autoloading null-sink as no other sinks detected.
2020-01-26 00:54:44,858 DEBG 'pulseaudio' stderr output:
I: [pulseaudio] sink.c: Created sink 0 "auto_null" with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
I: [pulseaudio] sink.c: device.description = "Dummy Output"
I: [pulseaudio] sink.c: device.class = "abstract"
I: [pulseaudio] sink.c: device.icon_name = "audio-card"
2020-01-26 00:54:44,859 DEBG 'pulseaudio' stderr output:
I: [pulseaudio] source.c: Created source 0 "auto_null.monitor" with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
I: [pulseaudio] source.c: device.description = "Monitor of Dummy Output"
I: [pulseaudio] source.c: device.class = "monitor"
I: [pulseaudio] source.c: device.icon_name = "audio-input-microphone"
D: [null-sink] module-null-sink.c: Thread starting up
I: [pulseaudio] module.c: Loaded "module-null-sink" (index: #2; argument: "sink_name=auto_null sink_properties='device.description="Dummy Output"'").
I: [pulseaudio] module.c: Loaded "module-always-sink" (index: #1; argument: "").
2020-01-26 00:54:45,023 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] dbus-util.c: Successfully connected to D-Bus session bus 8322ed55d40672393349c5ff5e2ce355 as :1.0
D: [pulseaudio] main.c: Got org.PulseAudio1!
D: [pulseaudio] main.c: Got org.pulseaudio.Server!
I: [pulseaudio] main.c: Daemon startup complete.
2020-01-26 00:54:45,137 DEBG 'openbox' stdout output:
Openbox-Message: Unable to find a valid menu file "/var/lib/openbox/debian-menu.xml"
2020-01-26 00:54:45,188 DEBG 'neko' stdout output:
_ __ __
/ | / /__ / /______ \ /\
/ |/ / _ \/ //_/ __ \ ) ( ')
/ /| / __/ ,< / /_/ / ( / )
/_/ |_/\___/_/|_|\____/ \(__)|
nurdism/neko server v0.0.0
2020-01-26 00:54:45,189 DEBG 'neko' stdout output:
12:54AM WRN preflight complete without config file config= debug=true logging=false
2020-01-26 00:54:45,189 DEBG 'neko' stdout output:
12:54AM INF starting neko server service=neko
2020-01-26 00:54:45,214 DEBG 'pulseaudio' stderr output:
I: [pulseaudio] client.c: Created 0 "Native client (UNIX socket client)"
I: [pulseaudio] protocol-native.c: Client authenticated anonymously.
2020-01-26 00:54:45,218 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] protocol-native.c: Protocol version: remote 32, local 32
D: [pulseaudio] protocol-native.c: SHM possible: yes
D: [pulseaudio] protocol-native.c: Negotiated SHM: yes
D: [pulseaudio] protocol-native.c: Memfd possible: yes
D: [pulseaudio] protocol-native.c: Negotiated SHM type: shared memfd
2020-01-26 00:54:45,218 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] memblock.c: Using shared memfd memory pool with 1024 slots of size 64.0 KiB each, total size is 64.0 MiB, maximum usable slot size is 65472
D: [pulseaudio] srbchannel.c: SHM block is 65472 bytes, ringbuffer capacity is 2 * 32712 bytes
D: [pulseaudio] protocol-native.c: Enabling srbchannel...
2020-01-26 00:54:45,220 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] protocol-native.c: Client enabled srbchannel.
2020-01-26 00:54:45,221 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] source-output.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
2020-01-26 00:54:45,221 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
I: [pulseaudio] source-output.c: Created output 0 "Record Stream" on auto_null.monitor with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
I: [pulseaudio] source-output.c: media.name = "Record Stream"
I: [pulseaudio] source-output.c: application.name = "neko"
I: [pulseaudio] source-output.c: native-protocol.peer = "UNIX socket client"
I: [pulseaudio] source-output.c: native-protocol.version = "32"
I: [pulseaudio] source-output.c: application.process.id = "23"
I: [pulseaudio] source-output.c: application.process.user = "neko"
I: [pulseaudio] source-output.c: application.process.host = "5f34e5323133"
I: [pulseaudio] source-output.c: application.process.binary = "neko"
I: [pulseaudio] source-output.c: application.language = "C"
I: [pulseaudio] source-output.c: window.x11.display = ":0"
I: [pulseaudio] source-output.c: application.process.machine_id = "a5a85d161208265bec1c6fb020b29456"
2020-01-26 00:54:45,221 DEBG 'neko' stdout output:
12:54AM INF webrtc streaming audio_codec=VP8 audio_device=auto_null.monitor module=webrtc video_codec=VP8 video_display=0
12:54AM WRN http listening on :8080 module=webrtc
12:54AM INF neko ready service=neko
2020-01-26 00:54:45,222 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] memblockq.c: memblockq requested: maxlength=35280, tlength=0, base=4, prebuf=1, minreq=0 maxrewind=0
D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=35280, tlength=35280, base=4, prebuf=4, minreq=4 maxrewind=0
I: [pulseaudio] protocol-native.c: Final latency 20.00 ms = 10.00 ms + 10.00 ms
2020-01-26 00:54:46,223 INFO success: xvfb entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2020-01-26 00:54:46,224 INFO success: openbox entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2020-01-26 00:54:46,224 INFO success: pulseaudio entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2020-01-26 00:54:46,224 INFO success: firefox-esr entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2020-01-26 00:54:46,225 INFO success: neko entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2020-01-26 00:54:52,304 DEBG 'neko' stdout output:
12:54AM DBG request complete (304) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43868","scheme":"http","uri":"http://localhost:8080/"} res={"bytes":0,"elapsed":10.901088,"status":304,"time":"Sun, 26 Jan 2020 00:54:52 UTC"}
2020-01-26 00:54:52,598 DEBG 'neko' stdout output:
12:54AM DBG request complete (200) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43868","scheme":"http","uri":"http://localhost:8080/css/app.cd09e717.css"} res={"bytes":177836,"elapsed":46.852184,"status":200,"time":"Sun, 26 Jan 2020 00:54:52 UTC"}
2020-01-26 00:54:52,731 DEBG 'neko' stdout output:
12:54AM DBG request complete (200) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43868","scheme":"http","uri":"http://localhost:8080/js/app.970dff61.js"} res={"bytes":55049,"elapsed":1.764608,"status":200,"time":"Sun, 26 Jan 2020 00:54:52 UTC"}
2020-01-26 00:54:52,735 DEBG 'neko' stdout output:
12:54AM DBG request complete (200) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43878","scheme":"http","uri":"http://localhost:8080/js/chunk-vendors.e1ce4bf9.js"} res={"bytes":294891,"elapsed":3.710646,"status":200,"time":"Sun, 26 Jan 2020 00:54:52 UTC"}
2020-01-26 00:54:53,178 DEBG 'neko' stdout output:
12:54AM DBG request complete (304) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43878","scheme":"http","uri":"http://localhost:8080/img/sleep.0993adf5.png"} res={"bytes":0,"elapsed":0.466477,"status":304,"time":"Sun, 26 Jan 2020 00:54:53 UTC"}
2020-01-26 00:54:53,413 DEBG 'neko' stdout output:
12:54AM DBG request complete (304) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43878","scheme":"http","uri":"http://localhost:8080/img/logo.adf7e273.svg"} res={"bytes":0,"elapsed":0.135376,"status":304,"time":"Sun, 26 Jan 2020 00:54:53 UTC"}
2020-01-26 00:54:53,461 DEBG 'neko' stdout output:
12:54AM DBG request complete (200) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43878","scheme":"http","uri":"http://localhost:8080/fonts/whitney-700.8e12fb4f.woff"} res={"bytes":80000,"elapsed":5.853343,"status":200,"time":"Sun, 26 Jan 2020 00:54:53 UTC"}
2020-01-26 00:54:53,468 DEBG 'neko' stdout output:
12:54AM DBG request complete (200) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43868","scheme":"http","uri":"http://localhost:8080/fonts/whitney-400.e8acd7d9.woff"} res={"bytes":77784,"elapsed":1.050289,"status":200,"time":"Sun, 26 Jan 2020 00:54:53 UTC"}
2020-01-26 00:54:53,476 DEBG 'neko' stdout output:
12:54AM DBG request complete (200) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43882","scheme":"http","uri":"http://localhost:8080/fonts/fa-solid-900.f6121be5.woff2"} res={"bytes":76084,"elapsed":8.383425,"status":200,"time":"Sun, 26 Jan 2020 00:54:53 UTC"}
2020-01-26 00:54:53,685 DEBG 'neko' stdout output:
12:54AM DBG request complete (304) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43886","scheme":"http","uri":"http://localhost:8080/site.webmanifest"} res={"bytes":0,"elapsed":0.172592,"status":304,"time":"Sun, 26 Jan 2020 00:54:53 UTC"}
2020-01-26 00:54:57,056 DEBG 'neko' stdout output:
12:54AM DBG attempting to upgrade connection module=websocket
2020-01-26 00:54:57,066 DEBG 'neko' stdout output:
12:54AM DBG session created id=UJIUfmPokZIZt0kgQHiNy20QH_D8LR2P module=webrtc
2020-01-26 00:54:57,079 DEBG 'neko' stdout output:
12:54AM DBG session created id=UJIUfmPokZIZt0kgQHiNy20QH_D8LR2P module=websocket
12:54AM DBG new connection created address=172.17.0.1:43894 module=websocket session=UJIUfmPokZIZt0kgQHiNy20QH_D8LR2P
2020-01-26 00:54:57,259 DEBG 'neko' stdout output:
12:54AM DBG recieved message from client module=websocket raw="{\"event\":\"signal/provide\",\"sdp\":\"v=0\\r\\no=- 6607497192133614697 2 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1 2\\r\\na=msid-semantic: WMS\\r\\nm=audio 56460 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 70.76.228.21\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=candidate:35009170 1 udp 2113937151 d157225e-138a-45f2-abfd-f8213d0b8a6c.local 56460 typ host generation 0 network-cost 999\\r\\na=candidate:1814037274 1 udp 2113939711 67553855-7f55-4ac7-b2d4-024fe42d6f79.local 44087 typ host generation 0 network-cost 999\\r\\na=candidate:842163049 1 udp 1677729535 70.76.228.21 56460 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\\r\\na=ice-ufrag:0kaU\\r\\na=ice-pwd:dpvdovU5bkITKGhLtNJ4meFm\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 BF:EE:C4:F2:08:67:E9:00:E7:20:3F:63:50:46:0D:20:0E:2E:CB:31:34:F1:51:52:A3:B4:EC:2C:A9:31:66:53\\r\\na=setup:actpass\\r\\na=mid:0\\r\\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=recvonly\\r\\na=rtcp-mux\\r\\na=rtpmap:111 opus/48000/2\\r\\na=rtcp-fb:111 transport-cc\\r\\na=fmtp:111 minptime=10;useinbandfec=1\\r\\na=rtpmap:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\nm=video 52574 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 122 127 121 125 107 108 109 124 120 123\\r\\nc=IN IP4 70.76.228.21\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=candidate:35009170 1 udp 2113937151 d157225e-138a-45f2-abfd-f8213d0b8a6c.local 52574 typ host generation 0 network-cost 999\\r\\na=candidate:1814037274 1 udp 2113939711 67553855-7f55-4ac7-b2d4-024fe42d6f79.local 47488 typ host generation 0 network-cost 999\\r\\na=candidate:842163049 1 udp 1677729535 70.76.228.21 52574 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\\r\\na=ice-ufrag:0kaU\\r\\na=ice-pwd:dpvdovU5bkITKGhLtNJ4meFm\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 BF:EE:C4:F2:08:67:E9:00:E7:20:3F:63:50:46:0D:20:0E:2E:CB:31:34:F1:51:52:A3:B4:EC:2C:A9:31:66:53\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://tools.ietf.org/html/draft-ietf-avtext-framemarking-07\\r\\na=extmap:9 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=recvonly\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:102 H264/90000\\r\\na=rtcp-fb:102 goog-remb\\r\\na=rtcp-fb:102 transport-cc\\r\\na=rtcp-fb:102 ccm fir\\r\\na=rtcp-fb:102 nack\\r\\na=rtcp-fb:102 nack pli\\r\\na=fmtp:102 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:122 rtx/90000\\r\\na=fmtp:122 apt=102\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm fir\\r\\na=rtcp-fb:108 nack\\r\\na=rtcp-fb:108 nack pli\\r\\na=fmtp:108 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f\\r\\na=rtpmap:109 rtx/90000\\r\\na=fmtp:109 apt=108\\r\\na=rtpmap:124 red/90000\\r\\na=rtpmap:120 rtx/90000\\r\\na=fmtp:120 apt=124\\r\\na=rtpmap:123 ulpfec/90000\\r\\nm=application 58719 UDP/DTLS/SCTP webrtc-datachannel\\r\\nc=IN IP4 70.76.228.21\\r\\na=candidate:35009170 1 udp 2113937151 d157225e-138a-45f2-abfd-f8213d0b8a6c.local 58719 typ host generation 0 network-cost 999\\r\\na=candidate:1814037274 1 udp 2113939711 67553855-7f55-4ac7-b2d4-024fe42d6f79.local 57644 typ host generation 0 network-cost 999\\r\\na=candidate:842163049 1 udp 1677729535 70.76.228.21 58719 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999\\r\\na=ice-ufrag:0kaU\\r\\na=ice-pwd:dpvdovU5bkITKGhLtNJ4meFm\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 BF:EE:C4:F2:08:67:E9:00:E7:20:3F:63:50:46:0D:20:0E:2E:CB:31:34:F1:51:52:A3:B4:EC:2C:A9:31:66:53\\r\\na=setup:actpass\\r\\na=mid:2\\r\\na=sctp-port:5000\\r\\na=max-message-size:262144\\r\\n\"}" session=UJIUfmPokZIZt0kgQHiNy20QH_D8LR2P
2020-01-26 00:54:57,465 DEBG 'neko' stdout output:
12:54AM WRN could not get server reflexive address udp6 stun:stun.l.google.com:19302: write udp6 [::]:35576->[2607:f8b0:4001:c0c::7f]:19302: sendto: cannot assign requested address
module=webrtc subsystem=ice
2020-01-26 00:54:57,467 DEBG 'neko' stdout output:
12:54AM ERR message handler has failed error="signal/provide failed: remote peer does not support VP8" module=websocket
2020-01-26 00:55:04,897 DEBG 'neko' stdout output:
12:55AM DBG request complete (200) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43868","scheme":"http","uri":"http://localhost:8080/js/app.970dff61.js.map"} res={"bytes":191587,"elapsed":2.596701,"status":200,"time":"Sun, 26 Jan 2020 00:55:04 UTC"}
2020-01-26 00:55:04,899 DEBG 'neko' stdout output:
12:55AM DBG request complete (200) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43882","scheme":"http","uri":"http://localhost:8080/js/chunk-vendors.e1ce4bf9.js.map"} res={"bytes":1454067,"elapsed":10.56979,"status":200,"time":"Sun, 26 Jan 2020 00:55:04 UTC"}
2020-01-26 00:55:57,030 DEBG 'neko' stdout output:
12:55AM WRN read message error error="websocket: close 1005 (no status)" module=websocket
2020-01-26 00:55:57,031 DEBG 'neko' stdout output:
12:55AM DBG session ended address=172.17.0.1:43894 module=websocket session=UJIUfmPokZIZt0kgQHiNy20QH_D8LR2P
12:55AM DBG request complete (0) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.97 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"172.17.0.1:43894","scheme":"http","uri":"http://localhost:8080/ws?password=neko"} res={"bytes":0,"elapsed":59978.158764,"status":0,"time":"Sun, 26 Jan 2020 00:55:57 UTC"}
12:55AM DBG handle socket ending address=172.17.0.1:43894 module=websocket
2020-01-26 00:55:57,032 DEBG 'neko' stderr output:
panic: runtime error: invalid memory address or nil pointer dereference
[signal SIGSEGV: segmentation violation code=0x1 addr=0x18 pc=0xa13600]
goroutine 23 [running]:
n.eko.moe/neko/internal/session.(*Session).destroy(0xc00044c000, 0xc000115530, 0xc00013e260)
/home/steven/docker-dev/neko/server/internal/session/session.go:129 +0x60
n.eko.moe/neko/internal/session.(*SessionManager).Destroy(0xc0000f0580, 0xc00013e260, 0x20, 0xc00014c180, 0x10)
/home/steven/docker-dev/neko/server/internal/session/manager.go:103 +0x6f
n.eko.moe/neko/internal/websocket.(*MessageHandler).Disconnected(...)
/home/steven/docker-dev/neko/server/internal/websocket/handler.go:44
n.eko.moe/neko/internal/websocket.(*WebSocketHandler).handle.func1.1(0xc000186230, 0xc000182000, 0xc000448160, 0xc00013e260, 0x20)
/home/steven/docker-dev/neko/server/internal/websocket/websocket.go:203 +0xfb
n.eko.moe/neko/internal/websocket.(*WebSocketHandler).handle.func1(0xc000186230, 0xc000182000, 0xc000448160, 0xc00013e260, 0x20, 0xc0001c21e0, 0xc0001c2180)
/home/steven/docker-dev/neko/server/internal/websocket/websocket.go:219 +0x1f3
created by n.eko.moe/neko/internal/websocket.(*WebSocketHandler).handle
/home/steven/docker-dev/neko/server/internal/websocket/websocket.go:199 +0x109
2020-01-26 00:55:57,052 DEBG fd 25 closed, stopped monitoring <POutputDispatcher at 139965828097232 for <Subprocess at 139965827951864 with name neko in state RUNNING> (stdout)>
2020-01-26 00:55:57,052 DEBG fd 29 closed, stopped monitoring <POutputDispatcher at 139965828097952 for <Subprocess at 139965827951864 with name neko in state RUNNING> (stderr)>
2020-01-26 00:55:57,055 INFO exited: neko (exit status 2; expected)
2020-01-26 00:55:57,060 DEBG received SIGCLD indicating a child quit
2020-01-26 00:55:57,061 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
I: [pulseaudio] source-output.c: Freeing output 0 "Record Stream"
I: [pulseaudio] client.c: Freed 0 "neko"
I: [pulseaudio] protocol-native.c: Connection died.
2020-01-26 00:55:57,078 INFO spawned: 'neko' with pid 317
2020-01-26 00:55:57,147 DEBG 'neko' stdout output:
_ __ __
/ | / /__ / /______ \ /\
/ |/ / _ \/ //_/ __ \ ) ( ')
/ /| / __/ ,< / /_/ / ( / )
/_/ |_/\___/_/|_|\____/ \(__)|
nurdism/neko server v0.0.0
2020-01-26 00:55:57,147 DEBG 'neko' stdout output:
12:55AM WRN preflight complete without config file config= debug=true logging=false
12:55AM INF starting neko server service=neko
2020-01-26 00:55:57,211 DEBG 'pulseaudio' stderr output:
I: [pulseaudio] client.c: Created 1 "Native client (UNIX socket client)"
I: [pulseaudio] protocol-native.c: Client authenticated anonymously.
2020-01-26 00:55:57,212 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] protocol-native.c: Protocol version: remote 32, local 32
D: [pulseaudio] protocol-native.c: SHM possible: yes
D: [pulseaudio] protocol-native.c: Negotiated SHM: yes
D: [pulseaudio] protocol-native.c: Memfd possible: yes
D: [pulseaudio] protocol-native.c: Negotiated SHM type: shared memfd
D: [pulseaudio] memblock.c: Using shared memfd memory pool with 1024 slots of size 64.0 KiB each, total size is 64.0 MiB, maximum usable slot size is 65472
2020-01-26 00:55:57,213 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] srbchannel.c: SHM block is 65472 bytes, ringbuffer capacity is 2 * 32712 bytes
D: [pulseaudio] protocol-native.c: Enabling srbchannel...
2020-01-26 00:55:57,221 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] protocol-native.c: Client enabled srbchannel.
2020-01-26 00:55:57,228 DEBG 'neko' stdout output:
12:55AM INF webrtc streaming audio_codec=VP8 audio_device=auto_null.monitor module=webrtc video_codec=VP8 video_display=0
2020-01-26 00:55:57,229 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] source-output.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
I: [pulseaudio] source-output.c: Created output 1 "Record Stream" on auto_null.monitor with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
I: [pulseaudio] source-output.c: media.name = "Record Stream"
I: [pulseaudio] source-output.c: application.name = "neko"
I: [pulseaudio] source-output.c: native-protocol.peer = "UNIX socket client"
I: [pulseaudio] source-output.c: native-protocol.version = "32"
I: [pulseaudio] source-output.c: application.process.id = "317"
I: [pulseaudio] source-output.c: application.process.user = "neko"
I: [pulseaudio] source-output.c: application.process.host = "5f34e5323133"
I: [pulseaudio] source-output.c: application.process.binary = "neko"
I: [pulseaudio] source-output.c: application.language = "C"
I: [pulseaudio] source-output.c: window.x11.display = ":0"
I: [pulseaudio] source-output.c: application.process.machine_id = "a5a85d161208265bec1c6fb020b29456"
2020-01-26 00:55:57,229 DEBG 'neko' stdout output:
12:55AM WRN http listening on :8080 module=webrtc
12:55AM INF neko ready service=neko
2020-01-26 00:55:57,229 DEBG 'pulseaudio' stderr output:
D: [pulseaudio] memblockq.c: memblockq requested: maxlength=35280, tlength=0, base=4, prebuf=1, minreq=0 maxrewind=0
D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=35280, tlength=35280, base=4, prebuf=4, minreq=4 maxrewind=0
I: [pulseaudio] protocol-native.c: Final latency 20.00 ms = 10.00 ms + 10.00 ms
2020-01-26 00:55:58,231 INFO success: neko entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
Client log:
neko.ts:24 [NEKO] DBG connecting to ws://localhost:8080/ws?password=neko
neko.ts:24 [NEKO] DBG received websocket event identity/provide with payload: Object
neko.ts:24 [NEKO] DBG creating peer
neko.ts:24 [NEKO] DBG sending event 'signal/provide' with payload v=0
o=- 6607497192133614697 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0 1 2
a=msid-semantic: WMS
m=audio 56460 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 70.76.228.21
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:35009170 1 udp 2113937151 d157225e-138a-45f2-abfd-f8213d0b8a6c.local 56460 typ host generation 0 network-cost 999
a=candidate:1814037274 1 udp 2113939711 67553855-7f55-4ac7-b2d4-024fe42d6f79.local 44087 typ host generation 0 network-cost 999
a=candidate:842163049 1 udp 1677729535 70.76.228.21 56460 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999
a=ice-ufrag:0kaU
a=ice-pwd:dpvdovU5bkITKGhLtNJ4meFm
a=ice-options:trickle
a=fingerprint:sha-256 BF:EE:C4:F2:08:67:E9:00:E7:20:3F:63:50:46:0D:20:0E:2E:CB:31:34:F1:51:52:A3:B4:EC:2C:A9:31:66:53
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
m=video 52574 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 122 127 121 125 107 108 109 124 120 123
c=IN IP4 70.76.228.21
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:35009170 1 udp 2113937151 d157225e-138a-45f2-abfd-f8213d0b8a6c.local 52574 typ host generation 0 network-cost 999
a=candidate:1814037274 1 udp 2113939711 67553855-7f55-4ac7-b2d4-024fe42d6f79.local 47488 typ host generation 0 network-cost 999
a=candidate:842163049 1 udp 1677729535 70.76.228.21 52574 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999
a=ice-ufrag:0kaU
a=ice-pwd:dpvdovU5bkITKGhLtNJ4meFm
a=ice-options:trickle
a=fingerprint:sha-256 BF:EE:C4:F2:08:67:E9:00:E7:20:3F:63:50:46:0D:20:0E:2E:CB:31:34:F1:51:52:A3:B4:EC:2C:A9:31:66:53
a=setup:actpass
a=mid:1
a=extmap:14 urn:ietf:params:rtp-hdrext:toffset
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:13 urn:3gpp:video-orientation
a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay
a=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type
a=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing
a=extmap:8 http://tools.ietf.org/html/draft-ietf-avtext-framemarking-07
a=extmap:9 http://www.webrtc.org/experiments/rtp-hdrext/color-space
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtcp-rsize
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 goog-remb
a=rtcp-fb:96 transport-cc
a=rtcp-fb:96 ccm fir
a=rtcp-fb:96 nack
a=rtcp-fb:96 nack pli
a=rtpmap:97 rtx/90000
a=fmtp:97 apt=96
a=rtpmap:98 VP9/90000
a=rtcp-fb:98 goog-remb
a=rtcp-fb:98 transport-cc
a=rtcp-fb:98 ccm fir
a=rtcp-fb:98 nack
a=rtcp-fb:98 nack pli
a=fmtp:98 profile-id=0
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=98
a=rtpmap:100 VP9/90000
a=rtcp-fb:100 goog-remb
a=rtcp-fb:100 transport-cc
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=fmtp:100 profile-id=2
a=rtpmap:101 rtx/90000
a=fmtp:101 apt=100
a=rtpmap:102 H264/90000
a=rtcp-fb:102 goog-remb
a=rtcp-fb:102 transport-cc
a=rtcp-fb:102 ccm fir
a=rtcp-fb:102 nack
a=rtcp-fb:102 nack pli
a=fmtp:102 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f
a=rtpmap:122 rtx/90000
a=fmtp:122 apt=102
a=rtpmap:127 H264/90000
a=rtcp-fb:127 goog-remb
a=rtcp-fb:127 transport-cc
a=rtcp-fb:127 ccm fir
a=rtcp-fb:127 nack
a=rtcp-fb:127 nack pli
a=fmtp:127 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f
a=rtpmap:121 rtx/90000
a=fmtp:121 apt=127
a=rtpmap:125 H264/90000
a=rtcp-fb:125 goog-remb
a=rtcp-fb:125 transport-cc
a=rtcp-fb:125 ccm fir
a=rtcp-fb:125 nack
a=rtcp-fb:125 nack pli
a=fmtp:125 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
a=rtpmap:107 rtx/90000
a=fmtp:107 apt=125
a=rtpmap:108 H264/90000
a=rtcp-fb:108 goog-remb
a=rtcp-fb:108 transport-cc
a=rtcp-fb:108 ccm fir
a=rtcp-fb:108 nack
a=rtcp-fb:108 nack pli
a=fmtp:108 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f
a=rtpmap:109 rtx/90000
a=fmtp:109 apt=108
a=rtpmap:124 red/90000
a=rtpmap:120 rtx/90000
a=fmtp:120 apt=124
a=rtpmap:123 ulpfec/90000
m=application 58719 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 70.76.228.21
a=candidate:35009170 1 udp 2113937151 d157225e-138a-45f2-abfd-f8213d0b8a6c.local 58719 typ host generation 0 network-cost 999
a=candidate:1814037274 1 udp 2113939711 67553855-7f55-4ac7-b2d4-024fe42d6f79.local 57644 typ host generation 0 network-cost 999
a=candidate:842163049 1 udp 1677729535 70.76.228.21 58719 typ srflx raddr 0.0.0.0 rport 0 generation 0 network-cost 999
a=ice-ufrag:0kaU
a=ice-pwd:dpvdovU5bkITKGhLtNJ4meFm
a=ice-options:trickle
a=fingerprint:sha-256 BF:EE:C4:F2:08:67:E9:00:E7:20:3F:63:50:46:0D:20:0E:2E:CB:31:34:F1:51:52:A3:B4:EC:2C:A9:31:66:53
a=setup:actpass
a=mid:2
a=sctp-port:5000
a=max-message-size:262144
neko.ts:24 [NEKO] DBG connection timedout
neko.ts:24 [NEKO] DBG disconnected: Error: connection timeout
at b.onTimeout (base.ts:272)
:8080/fonts/whitney-600.be0060da.woff:1 GET http://localhost:8080/fonts/whitney-600.be0060da.woff net::ERR_CONNECTION_RESET
@Okiesmokie make sure your at the latest commit, I'm pretty sure I've fixed the nil pointer issue a few commits ago.
@Okiesmokie make sure your at the latest commit, I'm pretty sure I've fixed the nil pointer issue a few commits ago.
@nurdism I pulled and rebuilt just before I ran it
steven@steven-UX305CA:~/docker-dev/neko$ git pull
Already up-to-date.
steven@steven-UX305CA:~/docker-dev/neko$ cat .git/refs/heads/master
e7ff0e8b8d657d20c74fd005580578738e691052
I pulled the latest image and added -p 59000-65000:59000-65000/udp
. It now connects in firefox but gets a black screen for me. Chrome still has the same error.
I'll try host mode, maybe that'll help?
this issues have veered off into separate issue from the original, I'm going to close this and if you are still having issues with connecting, please open up a new issue with your server/client logs
Problem
Ran into this issue while running this issue when trying to reach a box on my local network with Chrome. It works fine on my phone but not my desktop. Wondering if anyone could shed some light on the issue.
Error Msg
Error: "close tcp 172.17.0.2:8080->192.168.1.14:53047: use of closed network connection"
Websocket Output