nurdism / neko

A self hosted virtual browser (rabb.it clone) that runs in docker.
Apache License 2.0
2.03k stars 185 forks source link

[BUG]disconnected peer disconnect #37

Open zhangqijun opened 4 years ago

zhangqijun commented 4 years ago

Describe the bug can not link to server https://pc.zzz9958123.com:99

image

docker-compose.yml

version: "2.0"
services:
  neko:
    image: nurdism/neko
    restart: always
    shm_size: "8gb"
    #network_mode: host
    ports:
      - "99:8080"
      - "59000-59100:59000-59100/udp"
    volumes: 
      - "./certs:/certs"
    environment:
      DISPLAY: :99.0
      NEKO_PASSWORD: neko
      NEKO_ADMIN: admin
      NEKO_BIND: :8080
      NEKO_KEY: /certs/neko.key
      NEKO_CERT: /certs/neko.crt

Desktop (please complete the following information):

Client Log:

[NEKO] DBG connecting to wss://pc.zzz9958123.com:99/ws?password=neko
app.8e3300a0.js:1 [NEKO] DBG received websocket event identity/provide with payload:  {id: "xDqy5gdXfa7k4BKbYraNtVCpGy8XurGl"}
app.8e3300a0.js:1 [NEKO] DBG creating peer
app.8e3300a0.js:1 [NEKO] DBG received websocket event screen/resolution with payload:  {width: 1280, height: 720, rate: 30}
app.8e3300a0.js:1 [NEKO] DBG sending event 'signal/provide' with payload v=0
o=- 8400233447699815317 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0 1 2
a=msid-semantic: WMS
m=audio 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:942481366 1 udp 2113937151 53e2783a-6a17-42b8-99a6-0f32602c36c0.local 36518 typ host generation 0 network-cost 999
a=ice-ufrag:nvuD
a=ice-pwd:z3K5NlIYaHKLG3VXsQGByr1U
a=ice-options:trickle
a=fingerprint:sha-256 AC:0C:BB:2B:1B:CF:04:E6:B6:89:F0:35:20:9E:4B:F8:B9:57:6A:6B:BA:1F:31:CD:C8:A1:E8:6F:2F:38:09:02
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 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 122 127 121 125 107 108 109 124 120 123
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:942481366 1 udp 2113937151 53e2783a-6a17-42b8-99a6-0f32602c36c0.local 35713 typ host generation 0 network-cost 999
a=ice-ufrag:nvuD
a=ice-pwd:z3K5NlIYaHKLG3VXsQGByr1U
a=ice-options:trickle
a=fingerprint:sha-256 AC:0C:BB:2B:1B:CF:04:E6:B6:89:F0:35:20:9E:4B:F8:B9:57:6A:6B:BA:1F:31:CD:C8:A1:E8:6F:2F:38:09:02
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 9 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 0.0.0.0
a=candidate:942481366 1 udp 2113937151 53e2783a-6a17-42b8-99a6-0f32602c36c0.local 38171 typ host generation 0 network-cost 999
a=ice-ufrag:nvuD
a=ice-pwd:z3K5NlIYaHKLG3VXsQGByr1U
a=ice-options:trickle
a=fingerprint:sha-256 AC:0C:BB:2B:1B:CF:04:E6:B6:89:F0:35:20:9E:4B:F8:B9:57:6A:6B:BA:1F:31:CD:C8:A1:E8:6F:2F:38:09:02
a=setup:actpass
a=mid:2
a=sctp-port:5000
a=max-message-size:262144

app.8e3300a0.js:1 [NEKO] DBG received websocket event signal/answer with payload:  {sdp: "v=0
↵o=- 660321247 1582101685 IN IP4 0.0.0.0
↵s=-
…9070 typ host generation 0
↵a=end-of-candidates
↵"}
app.8e3300a0.js:1 [NEKO] DBG peer ice connection state chagned: checking
app.8e3300a0.js:1 [NEKO] DBG received audio track from peer: 3179fc9f-52ca-4c44-b273-e561d56ff823 RTCTrackEvent {isTrusted: true, receiver: RTCRtpReceiver, track: MediaStreamTrack, streams: Array(1), transceiver: RTCRtpTransceiver, …}
app.8e3300a0.js:1 [NEKO] DBG received video track from peer: 9edbf0ae-538c-4f18-9f6d-9eed4bda8d16 RTCTrackEvent {isTrusted: true, receiver: RTCRtpReceiver, track: MediaStreamTrack, streams: Array(1), transceiver: RTCRtpTransceiver, …}
app.8e3300a0.js:1 [NEKO] DBG peer ice connection state chagned: disconnected
app.8e3300a0.js:1 [NEKO] DBG disconnected: Error: peer disconnected
    at RTCPeerConnection.socketOpen.peerConnected._peer.oniceconnectionstatechange (app.8e3300a0.js:1)

Server Log:

2020-02-19 08:37:17,807 CRIT Supervisor running as root (no user in config file)
2020-02-19 08:37:17,807 WARN For [program:firefox-esr], redirect_stderr=true but stderr_logfile has also been set to a filename, the filename has been ignored
2020-02-19 08:37:17,807 WARN For [program:neko], redirect_stderr=true but stderr_logfile has also been set to a filename, the filename has been ignored
2020-02-19 08:37:17,808 INFO Included extra file "/etc/neko/supervisord/firefox.conf" during parsing
2020-02-19 08:37:17,808 INFO Included extra file "/etc/neko/supervisord/neko.conf" during parsing
2020-02-19 08:37:17,811 INFO supervisord started with pid 1
2020-02-19 08:37:18,813 INFO spawned: 'dbus' with pid 8
2020-02-19 08:37:18,815 INFO spawned: 'openbox' with pid 9
2020-02-19 08:37:18,818 INFO spawned: 'pulseaudio' with pid 10
2020-02-19 08:37:18,820 INFO spawned: 'x-server' with pid 11
2020-02-19 08:37:18,822 INFO spawned: 'firefox-esr' with pid 13
2020-02-19 08:37:18,824 INFO spawned: 'neko' with pid 15
2020-02-19 08:37:18,829 DEBG 'dbus' stdout output:
14

2020-02-19 08:37:18,835 DEBG 'x-server' stdout output:
_XSERVTransmkdir: Owner of /tmp/.X11-unix should be set to root

2020-02-19 08:37:18,836 DEBG 'x-server' stdout output:

X.Org X Server 1.19.2
Release Date: 2017-03-02
X Protocol Version 11, Revision 0
Build Operating System: Linux 4.9.0-8-amd64 x86_64 Debian
Current Operating System: Linux 121dc6966020 4.15.0-74-generic #84-Ubuntu SMP Thu Dec 19 08:06:28 UTC 2019 x86_64
Kernel command line: 
2020-02-19 08:37:18,836 DEBG 'x-server' stdout output:
BOOT_IMAGE=/boot/vmlinuz-4.15.0-74-generic root=UUID=858560ed-cf38-4389-85d8-b0edba5179f2 ro maybe-ubiquity
Build Date: 03 November 2018  03:09:11AM
xorg-server 2:1.19.2-1+deb9u5 (https://www.debian.org/support) 
Current version of pixman: 0.34.0
    Before reporting problems, check http://wiki.x.org
    to make sure that you have the latest version.
Markers: (--) probed, (**) from config file, (==) default setting,
    (++) from command line, (!!) notice, (II) informational,
    (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
(==) Log file: "/home/neko/.local/share/xorg/Xorg.99.0.log", Time: Wed Feb 19 08:37:18 2020
(++) Using config file: "/etc/neko/xorg.conf"
(==) Using system config directory "/usr/share/X11/xorg.conf.d"

2020-02-19 08:37:18,838 DEBG 'pulseaudio' stdout 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-02-19 08:37:18,847 DEBG 'pulseaudio' stdout output:
I: [pulseaudio] core-util.c: Failed to acquire high-priority scheduling: No such file or directory
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.15.0-74-generic #84-Ubuntu SMP Thu Dec 19 08:06:28 UTC 2019
D: [pulseaudio] main.c: Found 24 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

2020-02-19 08:37:18,847 DEBG 'pulseaudio' stdout output:
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.
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

2020-02-19 08:37:18,847 DEBG 'pulseaudio' stdout output:
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

2020-02-19 08:37:18,848 DEBG 'pulseaudio' stdout output:
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-02-19 08:37:18,848 DEBG 'pulseaudio' stdout 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-02-19 08:37:18,848 DEBG 'pulseaudio' stdout 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
I: [pulseaudio] module.c: Loaded "module-native-protocol-unix" (index: #0; argument: "socket=/tmp/pulseaudio.socket auth-anonymous=1").

2020-02-19 08:37:18,849 DEBG 'pulseaudio' stdout output:
D: [pulseaudio] module-always-sink.c: Autoloading null-sink as no other sinks detected.

2020-02-19 08:37:18,849 DEBG 'pulseaudio' stdout 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-02-19 08:37:18,850 DEBG 'pulseaudio' stdout 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"

2020-02-19 08:37:18,850 DEBG 'pulseaudio' stdout output:
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-02-19 08:37:18,912 DEBG 'pulseaudio' stdout output:
D: [pulseaudio] dbus-util.c: Successfully connected to D-Bus session bus b10f9fffd353518b4f528c0f5e4cf3be as :1.0

2020-02-19 08:37:18,912 DEBG 'pulseaudio' stdout output:
D: [pulseaudio] main.c: Got org.PulseAudio1!

2020-02-19 08:37:18,913 DEBG 'pulseaudio' stdout output:
D: [pulseaudio] main.c: Got org.pulseaudio.Server!
I: [pulseaudio] main.c: Daemon startup complete.

2020-02-19 08:37:18,978 DEBG 'neko' stdout output:

    _   __     __
   / | / /__  / /______   \    /\
  /  |/ / _ \/ //_/ __ \   )  ( ')
 / /|  /  __/ ,< / /_/ /  (  /  )
/_/ |_/\___/_/|_|\____/    \(__)|
   nurdism/neko server v1.1.0 605cb27

2020-02-19 08:37:18,979 DEBG 'neko' stdout output:
8:37AM WRN preflight complete without config file config= debug=true logging=false

2020-02-19 08:37:19,570 DEBG 'neko' stdout output:
8:37AM INF starting neko server service=neko

2020-02-19 08:37:19,593 DEBG 'pulseaudio' stdout output:
I: [pulseaudio] client.c: Created 0 "Native client (UNIX socket client)"
I: [pulseaudio] protocol-native.c: Client authenticated anonymously.

2020-02-19 08:37:19,593 DEBG 'pulseaudio' stdout 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-02-19 08:37:19,594 DEBG 'pulseaudio' stdout 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-02-19 08:37:19,594 DEBG 'pulseaudio' stdout output:
D: [pulseaudio] protocol-native.c: Client enabled srbchannel.

2020-02-19 08:37:19,595 DEBG 'neko' stdout output:
8:37AM INF webrtc streaming audio_codec=opus audio_device=auto_null.monitor audio_pipeline_src="pulsesrc device=auto_null.monitor ! audioconvert ! opusenc ! appsink name=appsink" ephemeral_port_range=59000-59100 module=webrtc nat_ips=116.92.208.87 video_codec=VP8 video_display=:99.0 video_pipeline_src="ximagesrc xid=:99.0 show-pointer=true use-damage=false ! video/x-raw ! videoconvert ! queue ! vp8enc cpu-used=8 threads=2 deadline=1 error-resilient=partitions keyframe-max-dist=10 auto-alt-ref=true ! appsink name=appsink"

2020-02-19 08:37:19,595 DEBG 'neko' stdout output:
8:37AM INF https listening on :8080 module=webrtc
8:37AM INF neko ready service=neko

2020-02-19 08:37:19,598 DEBG 'pulseaudio' stdout output:
D: [pulseaudio] source-output.c: Negotiated format: pcm, format.sample_format = "\"s16le\""  format.rate = "48000"  format.channels = "1"  format.channel_map = "\"mono\""
I: [pulseaudio] source-output.c: Trying to change sample rate
D: [pulseaudio] source.c: Suspending source auto_null.monitor due to changing the sample rate.

2020-02-19 08:37:19,598 DEBG 'pulseaudio' stdout output:
D: [pulseaudio] resampler.c: Resampler:
D: [pulseaudio] resampler.c:   rate 44100 -> 48000 (method speex-float-1)
D: [pulseaudio] resampler.c:   format s16le -> s16le (intermediate float32le)
D: [pulseaudio] resampler.c:   channels 2 -> 1 (resampling 1)
D: [pulseaudio] resampler.c: Channel matrix:
D: [pulseaudio] resampler.c:        I00   I01 
D: [pulseaudio] resampler.c:     +------------
D: [pulseaudio] resampler.c: O00 | 0.500 0.500
I: [pulseaudio] remap.c: Using stereo to mono remapping
I: [pulseaudio] speex.c: Choosing speex quality setting 1.
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 1ch 48000Hz and channel map mono
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 = "15"
I: [pulseaudio] source-output.c:     application.process.user = "neko"
I: [pulseaudio] source-output.c:     application.process.host = "121dc6966020"
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 = ":99.0"
I: [pulseaudio] source-output.c:     application.process.machine_id = "a5a85d161208265bec1c6fb020b29456"

2020-02-19 08:37:19,598 DEBG 'pulseaudio' stdout output:
D: [pulseaudio] memblockq.c: memblockq requested: maxlength=19200, tlength=0, base=2, prebuf=1, minreq=0 maxrewind=0
D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=19200, tlength=19200, base=2, prebuf=2, minreq=2 maxrewind=0
I: [pulseaudio] protocol-native.c: Final latency 20.00 ms = 10.00 ms + 10.00 ms

2020-02-19 08:37:19,599 DEBG 'pulseaudio' stdout output:
D: [pulseaudio] source.c: Suspending source auto_null.monitor due to changing the sample rate.

2020-02-19 08:37:20,599 INFO success: dbus entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2020-02-19 08:37:20,599 INFO success: openbox entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2020-02-19 08:37:20,599 INFO success: pulseaudio entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2020-02-19 08:37:20,599 INFO success: x-server entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2020-02-19 08:37:20,599 INFO success: firefox-esr entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2020-02-19 08:37:20,599 INFO success: neko entered RUNNING state, process has stayed up for > than 1 seconds (startsecs)
2020-02-19 08:37:54,079 DEBG 'neko' stdout output:
8:37AM DBG attempting to upgrade connection module=websocket

2020-02-19 08:37:54,079 DEBG 'neko' stdout output:
8:37AM DBG session created id=fySdnXuPyupuI2Lt9mIx7WRQk4KBiaeK module=webrtc

2020-02-19 08:37:54,080 DEBG 'neko' stdout output:
8:37AM DBG session created id=fySdnXuPyupuI2Lt9mIx7WRQk4KBiaeK module=websocket
8:37AM DBG new connection created address=222.128.31.180:13957 module=websocket session=fySdnXuPyupuI2Lt9mIx7WRQk4KBiaeK

2020-02-19 08:37:54,218 DEBG 'neko' stdout output:
8:37AM DBG recieved message from client module=websocket raw="{\"event\":\"signal/provide\",\"sdp\":\"v=0\\r\\no=- 5479272196942338466 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 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=candidate:942481366 1 udp 2113937151 53e2783a-6a17-42b8-99a6-0f32602c36c0.local 46674 typ host generation 0 network-cost 999\\r\\na=ice-ufrag:4dkL\\r\\na=ice-pwd:hNtue0R6mTyzIdgHzPEC6Vq4\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 2A:DC:D2:5D:15:91:36:48:01:55:EE:49:7F:F4:E5:21:E3:3A:C2:58:18:AC:CF:0F:59:37:35:89:5A:08:AA:D0\\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 9 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 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=candidate:942481366 1 udp 2113937151 53e2783a-6a17-42b8-99a6-0f32602c36c0.local 51240 typ host generation 0 network-cost 999\\r\\na=ice-ufrag:4dkL\\r\\na=ice-pwd:hNtue0R6mTyzIdgHzPEC6Vq4\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 2A:DC:D2:5D:15:91:36:48:01:55:EE:49:7F:F4:E5:21:E3:3A:C2:58:18:AC:CF:0F:59:37:35:89:5A:08:AA:D0\\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 9 UDP/DTLS/SCTP webrtc-datachannel\\r\\nc=IN IP4 0.0.0.0\\r\\na=candidate:942481366 1 udp 2113937151 53e2783a-6a17-42b8-99a6-0f32602c36c0.local 58604 typ host generation 0 network-cost 999\\r\\na=ice-ufrag:4dkL\\r\\na=ice-pwd:hNtue0R6mTyzIdgHzPEC6Vq4\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 2A:DC:D2:5D:15:91:36:48:01:55:EE:49:7F:F4:E5:21:E3:3A:C2:58:18:AC:CF:0F:59:37:35:89:5A:08:AA:D0\\r\\na=setup:actpass\\r\\na=mid:2\\r\\na=sctp-port:5000\\r\\na=max-message-size:262144\\r\\n\"}" session=fySdnXuPyupuI2Lt9mIx7WRQk4KBiaeK

2020-02-19 08:37:54,235 DEBG 'neko' stdout output:
8:37AM INF signaling state changed to have-remote-offer module=webrtc subsystem=pc

2020-02-19 08:37:54,237 DEBG 'neko' stdout output:
8:37AM DBG Started agent: isControlling? false, remoteUfrag: "4dkL", remotePwd: "hNtue0R6mTyzIdgHzPEC6Vq4" module=webrtc subsystem=ice

2020-02-19 08:37:54,237 DEBG 'neko' stdout output:
8:37AM INF signaling state changed to stable module=webrtc subsystem=pc

2020-02-19 08:37:54,237 DEBG 'neko' stdout output:
8:37AM INF Setting new connection state: Checking module=webrtc subsystem=ice
8:37AM INF ICE connection state changed: checking module=webrtc subsystem=pc

2020-02-19 08:38:09,287 DEBG 'neko' stdout output:
8:38AM WRN read message error error="websocket: close 1005 (no status)" module=websocket

2020-02-19 08:38:09,288 DEBG 'neko' stdout output:
8:38AM DBG handle socket ending address=222.128.31.180:13957 module=websocket
8:38AM DBG session ended address=222.128.31.180:13957 module=websocket session=fySdnXuPyupuI2Lt9mIx7WRQk4KBiaeK
8:38AM DBG session destroyed id=fySdnXuPyupuI2Lt9mIx7WRQk4KBiaeK module=webrtc
8:38AM DBG session destroyed id=fySdnXuPyupuI2Lt9mIx7WRQk4KBiaeK module=websocket

2020-02-19 08:38:09,288 DEBG 'neko' stdout output:
8:38AM DBG request complete (0) module=http req={"agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/80.0.3987.87 Safari/537.36","method":"GET","proto":"HTTP/1.1","remote":"222.128.31.180:13957","scheme":"https","uri":"https://pc.zzz9958123.com:99/ws?password=neko"} res={"bytes":0,"elapsed":15208.814361,"status":0,"time":"Wed, 19 Feb 2020 08:38:09 UTC"}